Bug#670421: marked as done (popularity-contest: prints "...terminated." under systemd)

Debian Bug Tracking System Sun, 18 Nov 2012 03:03:23 -0800

Your message dated Sun, 18 Nov 2012 11:59:52 +0100
with message-id <[email protected]>
and subject line Re: Bug#670421: Happens when the session is closed
has caused the Debian Bug report #670421,
regarding popularity-contest: prints "...terminated." under systemd
to be marked as done.


This means that you claim that the problem has been dealt with.
If this is not the case it is now your responsibility to reopen the
Bug report if necessary, and/or fix the problem forthwith.

(NB: If you are a system administrator and have no idea what this
message is talking about, this may indicate a serious mail system
misconfiguration somewhere. Please contact [email protected]
immediately.)


-- 
670421: http://bugs.debian.org/cgi-bin/bugreport.cgi?bug=670421
Debian Bug Tracking System
Contact [email protected] with problems

--- Begin Message ---

Package: popularity-contest
Version: 1.53
Severity: normal

When I installed popularity-contest I started getting daily emails
from the cronjob with just

/etc/cron.daily/popularity-contest:
 ...terminated.

as a body. I tried to debug this and noticed that it does not occur if
I use sysvinit, only if I use systemd. (I have not tested upstart). I
set

X-Debbugs-CC: Tollef Fog Heen <[email protected]>

to the systemd maintainer just in case he has some clues on what
popularity-contest might be doing wrong.

Steps to reproduce:
1) apt-get install systemd
2) boot with "init=/bin/systemd"
3) sudo /etc/cron.daily/popularity-contest

Expected results:
3) /etc/cron.daily/popularity-contest does not print anything

Actual results:
3) /etc/cron.daily/popularity-contest prints " ...terimnated.":

lindi2:~$ sudo /etc/cron.daily/popularity-contest 
 ...terminated.
lindi2:~$ echo $?
0
lindi2:~$

More info:
1) strace under systemd shows that this is just before the setsid
command is executed:

...
1023  close(5)                          = 0
1023  getuid()                          = 0
1023  time([1335357656])                = 1335357656
1023  sendto(3, "<86>Apr 25 15:40:56 su[1023]: pam_unix(su:session): session 
closed for user nobody", 82, MSG_NOSIGNAL, NULL, 0) = 82
1023  close(6)                          = 0
1023  close(4)                          = 0
1023  munmap(0x7f5060d94000, 2101312)   = 0
1023  munmap(0x7f5060970000, 2109656)   = 0
1023  munmap(0x7f506076d000, 2105504)   = 0
1023  munmap(0x7f5060553000, 2200480)   = 0
1023  munmap(0x7f506031c000, 2318784)   = 0
1023  munmap(0x7f506011a000, 2101280)   = 0
1023  munmap(0x7f505ff18000, 2101296)   = 0
1023  munmap(0x7f505fd0d000, 2141576)   = 0
1023  munmap(0x7f5060b74000, 2226128)   = 0
1023  munmap(0x7f505fb09000, 2112168)   = 0
1023  munmap(0x7f505f906000, 2106112)   = 0
1023  munmap(0x7f505f098000, 2112864)   = 0
1023  munmap(0x7f505ee95000, 2105568)   = 0
1023  --- SIGTERM (Terminated) @ 0 (0) ---
1023  rt_sigreturn(0xf)                 = 0
1023  munmap(0x7f505ec91000, 2109648)   = 0
1023  munmap(0x7f505f6c0000, 2382240)   = 0
1023  rt_sigaction(SIGALRM, {0x7f50626aa170, [ALRM], SA_RESTORER|SA_RESTART, 
0x7f5061d1d4f0}, {SIG_DFL, [], SA_RESTORER, 0x7f5061d1d4f0}, 8) = 0
1023  alarm(2)                          = 0
1023  wait4(-1, 0x7ffff9cba87c, 0, NULL) = -1 ECHILD (No child processes)
1023  write(2, " ...terminated.\n", 16) = 16
1023  exit_group(0)                     = ?
1005  <... wait4 resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0, NULL) = 
1023
1005  --- SIGCHLD (Child exited) @ 0 (0) ---
1005  rt_sigreturn(0x11)                = 1023
1005  dup2(11, 1)                       = 1
1005  close(11)                         = 0
1005  open("/dev/null", O_WRONLY|O_CREAT|O_TRUNC, 0666) = 3
1005  fcntl(2, F_DUPFD, 10)             = 11
1005  close(2)                          = 0
1005  fcntl(11, F_SETFD, FD_CLOEXEC)    = 0
1005  dup2(3, 2)                        = 2
1005  close(3)                          = 0
1005  stat("/usr/local/sbin/setsid", 0x7fff40dcdf50) = -1 ENOENT (No such file 
or directory)
1005  stat("/usr/local/bin/setsid", 0x7fff40dcdf50) = -1 ENOENT (No such file 
or directory)
1005  stat("/usr/sbin/setsid", 0x7fff40dcdf50) = -1 ENOENT (No such file or 
directory)
1005  stat("/usr/bin/setsid", {st_mode=S_IFREG|0755, st_size=6240, ...}) = 0
1005  clone(child_stack=0, 
flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, 
child_tidptr=0x7f1668ba19d0) = 1149
1005  wait4(-1,  <unfinished ...>
1149  close(10)                         = 0
1149  execve("/usr/bin/setsid", ["setsid", 
"/usr/share/popularity-contest/popcon-upload", "-u", 
"http://popcon.debian.org/cgi-bin/popcon.cgi";, "-f", 
"/var/log/popularity-contest"], [/* 16 vars */]) = 0
1149  brk(0)                            = 0xc77000
...

2) strace under sysvinit shows:

1662  time([1335357485])                = 1335357485
1662  sendto(3, "<86>Apr 25 15:38:05 su[1662]: pam_unix(su:session): session 
closed for user nobody", 82, MSG_NOSIGNAL, NULL, 0) = 82
1662  close(4)                          = 0
1662  munmap(0x7f17cdffb000, 2101312)   = 0
1662  munmap(0x7f17cdbd7000, 2109656)   = 0
1662  munmap(0x7f17cd9d4000, 2105504)   = 0
1662  munmap(0x7f17cd7ba000, 2200480)   = 0
1662  munmap(0x7f17cd583000, 2318784)   = 0
1662  munmap(0x7f17cd381000, 2101280)   = 0
1662  munmap(0x7f17cd17f000, 2101296)   = 0
1662  munmap(0x7f17ccf74000, 2141576)   = 0
1662  munmap(0x7f17cdddb000, 2226128)   = 0
1662  munmap(0x7f17ccd70000, 2112168)   = 0
1662  munmap(0x7f17ccb6d000, 2106112)   = 0
1662  munmap(0x7f17cc2ff000, 2112864)   = 0
1662  munmap(0x7f17cc0fc000, 2105568)   = 0
1662  munmap(0x7f17cbef8000, 2109648)   = 0
1662  munmap(0x7f17cc927000, 2382240)   = 0
1662  exit_group(0)                     = ?
1644  <... wait4 resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], 0, NULL) = 
1662
1644  --- SIGCHLD (Child exited) @ 0 (0) ---
1644  rt_sigreturn(0x11)                = 1662
1644  dup2(11, 1)                       = 1
1644  close(11)                         = 0
1644  open("/dev/null", O_WRONLY|O_CREAT|O_TRUNC, 0666) = 3
1644  fcntl(2, F_DUPFD, 10)             = 11
1644  close(2)                          = 0
1644  fcntl(11, F_SETFD, FD_CLOEXEC)    = 0
1644  dup2(3, 2)                        = 2
1644  close(3)                          = 0
1644  stat("/usr/local/sbin/setsid", 0x7fff43ae95c0) = -1 ENOENT (No such file 
or directory)
1644  stat("/usr/local/bin/setsid", 0x7fff43ae95c0) = -1 ENOENT (No such file 
or directory)
1644  stat("/usr/sbin/setsid", 0x7fff43ae95c0) = -1 ENOENT (No such file or 
directory)
1644  stat("/usr/bin/setsid", {st_mode=S_IFREG|0755, st_size=6240, ...}) = 0
1644  clone(child_stack=0, 
flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, 
child_tidptr=0x7fe13346a9d0) = 1709
1644  wait4(-1,  <unfinished ...>
1709  close(10)                         = 0
1709  execve("/usr/bin/setsid", ["setsid", 
"/usr/share/popularity-contest/popcon-upload", "-u", 
"http://popcon.debian.org/cgi-bin/popcon.cgi";, "-f", 
"/var/log/popularity-contest"], [/* 16 vars */]) = 0

3) I also ran

$ sudo bash -x /etc/cron.daily/popularity-contest 
+ '[' '!' -f /usr/sbin/popularity-contest ']'
+ unset MAILFROM
+ unset MAILTO
+ unset MY_HOSTID
+ unset PARTICIPATE
+ unset SUBMITURLS
+ unset USEHTTP
+ unset MTAOPS
+ . /usr/share/popularity-contest/default.conf
++ PARTICIPATE=no
++ [email protected]
++ SUBMITURLS=http://popcon.debian.org/cgi-bin/popcon.cgi
++ USEHTTP=yes
+ . /etc/popularity-contest.conf
++ MY_HOSTID=<REMOVED>
++ PARTICIPATE=yes
++ USEHTTP=yes
++ DAY=3
+ '[' -z [email protected] ']'
+ '[' yes = no ']'
+ '[' -z yes ']'
+ '[' -n '' ']'
+ POPCON=/var/log/popularity-contest
+ '[' 3 ']'
++ date +%w
+ '[' 3 '!=' 3 ']'
+ cd /var/log
+ umask 022
+ savelog -c 7 popularity-contest
+ run_popcon
+ su -s /bin/sh -c /usr/sbin/popularity-contest nobody
 ...terminated.
+ SUBMITTED=no
+ '[' http://popcon.debian.org/cgi-bin/popcon.cgi ']'
+ '[' yes = yes ']'
+ for URL in '$SUBMITURLS'
+ setsid /usr/share/popularity-contest/popcon-upload -u 
http://popcon.debian.org/cgi-bin/popcon.cgi -f /var/log/popularity-contest
+ SUBMITTED=yes
+ '[' yes '!=' yes ']'
+ '[' yes '!=' yes ']'





-- System Information:
Debian Release: wheezy/sid
  APT prefers testing
  APT policy: (500, 'testing')
Architecture: amd64 (x86_64)

Kernel: Linux 3.2.0-1-amd64 (SMP w/4 CPU cores)
Locale: LANG=C, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash

Versions of packages popularity-contest depends on:
ii  debconf [debconf-2.0]  1.5.42
ii  dpkg                   1.16.2

Versions of packages popularity-contest recommends:
ii  cron                                       3.0pl1-121
ii  exim4                                      4.77-1
ii  exim4-daemon-light [mail-transport-agent]  4.77-1+b1

Versions of packages popularity-contest suggests:
pn  anacron  <none>

-- debconf information:
  popularity-contest/submiturls:
* popularity-contest/participate: true

--- End Message ---

--- Begin Message ---

Am 17.11.2012 22:42, schrieb Timo Juhani Lindfors:
> Hi,
> 
> Michael Biebl <[email protected]> writes:
>> Timo, do you still have this problem?
> 
> I re-enabled popularity-contest and don't see the problem anymore.

Let's close this bug then. If it pops up again, we can alway reopen.

Cheers,
Michael


-- 
Why is it that all of the instruments seeking intelligent life in the
universe are pointed away from Earth?

signature.asc
Description: OpenPGP digital signature

--- End Message ---

Bug#670421: marked as done (popularity-contest: prints "...terminated." under systemd)

Reply via email to