Wine tries to access internet

[gfurst]

I've come through one weird issue: every application I try to start with wine takes a long time to start.
There's almost nothing like this as I've searched the webs, only one similar thread, the issue turned out to be trying to access the internet before actually starting up the application.
Disconnecting eth interface and the delay is no longer, by the way, a delay of about a minute or two.

I currently have only one game test this out but it happens on any executable, including winecfg. Either through gui or terminal, the command is give and its just sits there for a minute before actually starting up the application.
I'm using Q4wine to manage prefix, even started out a fresh prefix to check if had anything to do with it.
The weirdest part, this started out of nowhere, I don't know why.

My specs:
wine version 1.7.33
debian Jessie

Thanks

[dimesio]

Q4Wine is not supported here. Please retest in a clean wineprefix using plain Wine, preferably the current development release. If the problem is still present, post terminal output.

[gfurst]

Q4Wine is not supported here. Please retest in a clean wineprefix using plain Wine, preferably the current development release. If the problem is still present, post terminal output.

Sure, without Q4wine, just regular terminal going winecfg, there's no output at all, its just sits there for a whole minute before any activity.
Just in case I went ahead and updated wine from 1.7.33 to 1.7.37
Any clues or anything else I should try?

[dimesio]

Do you have a network printer? If so, it could be https://bugs.winehq.org/show_bug.cgi?id=10358.

[gfurst]

Okey it seems very similar indeed. I wonder why a bug like this was left untouched for so long. Anyway I do not have a network printer, I do have a printer connected to a windows machine on the network, that may be shared (though I don't know).
Cups is not installed on my system as it ran into some dependency issues a while back, so I've removed it. But that's a long while back, long before the issue appeared.
As I've said before, this started happening pretty much without reason, the one other issue I've found related https://bbs.archlinux.org/viewtopic.php?id=59767 which led me to try disconnected.

So doing a test run with "strace wine winecfg"

Code: Select all

open("/home/guiu/.cups/client.conf", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory)
open("/etc/cups/client.conf", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory)
rt_sigaction(SIGPIPE, {SIG_IGN, [], 0}, NULL, 8) = 0
fstat64(11, {st_mode=S_IFCHR|0666, st_rdev=makedev(1, 9), ...}) = 0
time(NULL)                              = 1428591580
socket(PF_INET6, SOCK_STREAM, IPPROTO_IP) = 12
setsockopt(12, SOL_SOCKET, SO_REUSEADDR, [1], 4) = 0
setsockopt(12, SOL_SOCKET, SO_REUSEPORT, [1], 4) = 0
setsockopt(12, SOL_TCP, TCP_NODELAY, [1], 4) = 0
fcntl64(12, F_SETFD, FD_CLOEXEC)        = 0
fcntl64(12, F_GETFL)                    = 0x2 (flags O_RDWR)
fcntl64(12, F_SETFL, O_RDWR|O_NONBLOCK) = 0
connect(12, {sa_family=AF_INET6, sin6_port=htons(631), inet_pton(AF_INET6, "::1", &sin6_addr), sin6_flowinfo=0, sin6_scope_id=0}, 28) = -1 EINPROGRESS (Operation now in progress)
fcntl64(12, F_SETFL, O_RDWR)            = 0
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)
close(12)                               = 0
socket(PF_INET, SOCK_STREAM, IPPROTO_IP) = 12
setsockopt(12, SOL_SOCKET, SO_REUSEADDR, [1], 4) = 0
setsockopt(12, SOL_SOCKET, SO_REUSEPORT, [1], 4) = 0
setsockopt(12, SOL_TCP, TCP_NODELAY, [1], 4) = 0
fcntl64(12, F_SETFD, FD_CLOEXEC)        = 0
fcntl64(12, F_GETFL)                    = 0x2 (flags O_RDWR)
fcntl64(12, F_SETFL, O_RDWR|O_NONBLOCK) = 0
connect(12, {sa_family=AF_INET, sin_port=htons(631), sin_addr=inet_addr("127.0.0.1")}, 16) = -1 EINPROGRESS (Operation now in progress)
fcntl64(12, F_SETFL, O_RDWR)            = 0
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 1 ([{fd=12, revents=POLLIN|POLLOUT|POLLERR|POLLHUP}])
getpeername(12, 0x325bbc, [256])        = -1 ENOTCONN (Transport endpoint is not connected)
close(12)                               = 0

This is what happens pretty much around the waiting time. Note there's a call for cups files right before it, don't know if its related. But the real deal is the timing out right after a inet6 call. Come to think of it, the issue start appearing around a change from ISP equipment, they installed a newer modem/router thingy that has support for ipv6, which is currently tested and working.

Question is, what is it trying to access??Its clearly a bug if its trying access internet (ping) without any need, before the actual applications needs to.
I did a small research and couldn't conclude whether wine supports ipv6 at all. Any more hints to the issue?
And indeed setting ipv6 to ignored in my network manager, solved the issue.

[dimesio]

Do you have any mounted network shares?

[gfurst]

Do you have any mounted network shares?

nope

[winspool]

I've come through one weird issue: every application I try to start with wine takes a long time to start.

That might be a bug or a broken configuration

There's almost nothing like this as I've searched the webs, only one similar thread, the issue turned out to be trying to access the internet before actually starting up the application.

That thread is broken. There is no connection to the internet.
CUPS is talking to CUPS on your machine

The weirdest part, this started out of nowhere, I don't know why.

Someone removed the configuration files for CUPS.
That was the user or the Distro is using a broken CUPS package.
The main issue is the appearance of IPv6 and the CUPS Client side (called by applications)
defaults to use IPv6, while the CUPS server side does not respond on IPv6.

Possible fix for such failures: Reinstall and Configure CUPS or Configure IPv6

########################

Okey it seems very similar indeed. I wonder why a bug like this was left untouched for so long.

A lot of development for wine is done by volunteers.
I did a lot of work for printing, but was busy with other things.

Code: Select all

open("/home/guiu/.cups/client.conf", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory)
open("/etc/cups/client.conf", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or directory)
....
connect(12, {sa_family=AF_INET6, sin6_port=htons(631), inet_pton(AF_INET6, "::1", &sin6_addr), sin6_flowinfo=0, sin6_scope_id=0}, 28) = -1 EINPROGRESS (Operation now in progress)
fcntl64(12, F_SETFL, O_RDWR)            = 0
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 0 (Timeout)

The CUPS client side (used by wine) failed to find the CUPS configuration files.
Then the CUPS client side is trying to connect the CUPS IPv6 server side on your computer.
The timeout occured, because the CUPS server side is not configured for IPv6.

Code: Select all

connect(12, {sa_family=AF_INET, sin_port=htons(631), sin_addr=inet_addr("127.0.0.1")}, 16) = -1 EINPROGRESS (Operation now in progress)
fcntl64(12, F_SETFL, O_RDWR)            = 0
poll([{fd=12, events=POLLIN|POLLOUT}], 1, 250) = 1 ([{fd=12, revents=POLLIN|POLLOUT|POLLERR|POLLHUP}])
getpeername(12, 0x325bbc, [256])        = -1 ENOTCONN (Transport endpoint is not connected)
close(12)                               = 0

The CUPS client side is trying to connect the CUPS IPv4 server side on your computer.
CUPS is alive (the connect() succeeded), but the configuration interface is disabled.

Code: Select all

When CUPS is installed, point your Browser to the CUPS web interface:

[url]http://localhost:631[/url]

Question is, what is it trying to access??Its clearly a bug if its trying access internet (ping) without any need, before the actual applications needs to.
[/code]
See above.

And indeed setting ipv6 to ignored in my network manager, solved the issue.

I created my reply before reading all of yout Text.
It's great, that you found the fix yourself
(configuring IPv6 by disabling it)

..
bye bye Detlef