Hide Forgot
Description of problem: cronie does not execute /var/spool/cron/<user> Version-Release number of selected component (if applicable): cronie-1.4.7-3 How reproducible: upgrade cronie to cronie-1.4.7-3. Then schedule a job as a regular user. Steps to Reproduce: 1. upgrade cronie to cronie-1.4.7-3 2. schedule a job as a regular user. 3. tail /var/log/cron Actual results: job not executed Expected results: job executed Additional info: Downgraded to cronie-1.4.7-2. Cron works as expected. No cron.allow on the system, only an empty cron.deny. Anacron jobs are executed without problems in version 1.4.7-3
Do you see something in /var/log/secure at the times when the regular user jobs should have been run by the cronie-1.4.7-3? There was no real change between 1.4.7-2 and -3 that could affect this. So this problem must come from elsewhere. Can you try to upgrade back to 1.4.7-3 and see whether you can still reproduce the problem?
Weird stuff now. I upgraded back to 1.4.7-3. Jobs are executed. However, the backup job scheduled in the cron of root (03:05) did not start last night. /var/log/cron at that time: Jun 8 03:00:01 lptfrwi /USR/SBIN/CROND[2169]: (root) CMD (/usr/lib64/sa/sa1 1 1) Jun 8 03:01:01 lptfrwi /USR/SBIN/CROND[2183]: (root) CMD (run-parts /etc/cron.hourly) Jun 8 03:01:01 lptfrwi run-parts(/etc/cron.hourly)[2183]: starting 0anacron Jun 8 03:01:01 lptfrwi anacron[2193]: Anacron started on 2011-06-08 Jun 8 03:01:01 lptfrwi run-parts(/etc/cron.hourly)[2195]: finished 0anacron Jun 8 03:01:01 lptfrwi anacron[2193]: Will run job `cron.daily' in 32 min. Jun 8 03:01:01 lptfrwi anacron[2193]: Will run job `cron.weekly' in 52 min. Jun 8 03:01:01 lptfrwi anacron[2193]: Jobs will be executed sequentially Jun 8 03:10:01 lptfrwi /USR/SBIN/CROND[2202]: (root) CMD (/usr/lib64/sa/sa1 1 1) /var/log/secure at that time: Jun 8 03:00:01 lptfrwi /usr/sbin/crond[2168]: pam_systemd(crond:session): Moving new user session for root into control group /user/root/3. Jun 8 03:00:01 lptfrwi /USR/SBIN/CROND[2168]: pam_systemd(crond:session): Moving remaining processes of user session 3 of root into control group /user/root/master. Jun 8 03:01:01 lptfrwi /usr/sbin/crond[2182]: pam_systemd(crond:session): Moving new user session for root into control group /user/root/4. Jun 8 03:01:01 lptfrwi /USR/SBIN/CROND[2182]: pam_systemd(crond:session): Moving remaining processes of user session 4 of root into control group /user/root/master. Jun 8 03:10:01 lptfrwi /usr/sbin/crond[2201]: pam_systemd(crond:session): Moving new user session for root into control group /user/root/5. Jun 8 03:10:01 lptfrwi /USR/SBIN/CROND[2201]: pam_systemd(crond:session): Moving remaining processes of user session 5 of root into control group /user/root/master. /var/log/messages at that time: Jun 8 03:01:17 lptfrwi ntpd[959]: 0.0.0.0 c612 02 freq_set kernel 17.782 PPM Jun 8 03:01:17 lptfrwi ntpd[959]: 0.0.0.0 c615 05 clock_sync Jun 8 03:15:14 lptfrwi smartd[997]: System clock time adjusted to the past. Resetting next wakeup time. Almost as if the downgrade to 1.4.7-2 triggered something? Anyways, I am curious to see what happens tonight.
Are you sure that the clock sync from the ntpd isn't the source of the problem? Perhaps the clock jumped over the time of the backup job?
The thought had occured to me. However, the time sync is at 03:01. The backup job is scheduled for 03:05. And no visual gap between the time sync and the next entry in /var/log/messages. So I can only conclude that the scheduled job did not run. Or am I wrong in assuming /var/log/messages is written sequentially? Jun 8 03:01:17 lptfrwi ntpd[959]: 0.0.0.0 c615 05 clock_sync Jun 8 03:15:14 lptfrwi smartd[997]: System clock time adjusted to the past. Anyways, when I first noticed the backup job not running I tried to execute jobs manually in cron (last monday). That did not work. It does work now after downgrading to 1.4.7-2 and upgrading to 1.4.7-3. So I got good hoops for tonight. Let's see what happens.
The good news: cron jobs are working again now. Backup logs show me that it stopped working on the 31 May. -rw-rw-r-- 1 root root 7168 31 mei 03:05 backup.31 -rw-rw-r-- 1 root root 5761 9 jun 03:07 backup.09 If I look at the yum log, it shows quite a lot of updates around the 1st of June. The one that stands out (for me) is systemd. I recompiled the latest F16 version cause I had some other issues I had hoped it would solve. Anyways, somehow the downgrade/upgrade worked wonders. Wonder if a yum reinstall would have had the same effect? May 30 15:28:15 Updated: shared-mime-info-0.90-8.fc15.x86_64 May 30 15:28:16 Updated: pcsc-lite-libs-1.7.2-2.fc15.x86_64 May 30 15:28:16 Updated: lirc-libs-0.9.0-3.fc15.x86_64 May 31 08:36:46 Installed: gnome-shell-extensions-alternate-tab-3.0.2-1.g63dd27cgit.fc15.noarch May 31 12:15:10 Installed: VirtualBox-4.0-4.0.8_71778_fedora15-1.x86_64 May 31 19:47:37 Installed: acpid-2.0.9-4.fc15.x86_64 Jun 01 11:41:11 Installed: glib2-devel-2.28.6-2.fc15.x86_64 Jun 01 11:41:11 Installed: gdk-pixbuf2-devel-2.23.3-1.fc15.x86_64 Jun 01 11:41:11 Installed: autoconf-2.68-2.fc15.noarch Jun 01 11:41:11 Installed: automake-1.11.1-5.fc14.noarch Jun 01 11:41:11 Installed: 1:dbus-devel-1.4.6-4.fc15.x86_64 Jun 01 11:41:11 Installed: dbus-glib-devel-0.92-2.fc15.x86_64 Jun 01 11:41:12 Installed: atk-devel-2.0.0-1.fc15.x86_64 Jun 01 11:41:12 Installed: device-mapper-devel-1.02.63-1.fc15.x86_64 Jun 01 11:41:12 Installed: libXcomposite-devel-0.4.3-2.fc15.x86_64 Jun 01 11:41:12 Installed: sgml-common-0.6.3-34.fc15.noarch Jun 01 11:41:12 Installed: docbook-dtds-1.0-54.fc15.noarch Jun 01 11:41:12 Installed: libgpg-error-devel-1.9-2.fc15.x86_64 Jun 01 11:41:12 Installed: libgcrypt-devel-1.4.6-1.fc15.x86_64 Jun 01 11:41:12 Installed: pixman-devel-0.20.2-2.fc15.x86_64 Jun 01 11:41:13 Installed: cairo-devel-1.10.2-3.fc15.x86_64 Jun 01 11:41:13 Installed: pango-devel-1.28.4-1.fc15.x86_64 Jun 01 11:41:13 Installed: libuuid-devel-2.19.1-1.fc15.x86_64 Jun 01 11:41:13 Installed: libsepol-devel-2.0.42-2.fc15.x86_64 Jun 01 11:41:13 Installed: libXi-devel-1.4.2-1.fc15.x86_64 Jun 01 11:41:14 Installed: gtk2-devel-2.24.4-1.fc15.x86_64 Jun 01 11:41:14 Installed: libselinux-devel-2.0.99-4.fc15.x86_64 Jun 01 11:41:14 Installed: cryptsetup-luks-devel-1.2.0-2.fc15.x86_64 Jun 01 11:41:15 Installed: docbook-style-xsl-1.76.1-2.fc15.noarch Jun 01 11:41:15 Installed: libnotify-devel-0.7.2-1.fc15.x86_64 Jun 01 11:41:15 Installed: libtool-2.4-4.fc15.x86_64 Jun 01 11:41:16 Installed: pam-devel-1.1.3-8.fc15.x86_64 Jun 01 11:41:16 Installed: audit-libs-devel-2.1.1-1.fc15.x86_64 Jun 01 11:41:16 Installed: libudev-devel-167-4.fc15.x86_64 Jun 01 11:41:16 Installed: tcp_wrappers-devel-7.6-60.fc15.x86_64 Jun 01 11:41:16 Installed: libcap-devel-2.17-2.fc15.x86_64 Jun 01 11:41:16 Installed: vala-0.12.0-2.fc15.x86_64 Jun 01 12:35:40 Installed: nss-myhostname-0.2-4.fc15.x86_64 Jun 01 12:35:40 Updated: systemd-units-28-2.fc15.x86_64 Jun 01 12:35:40 Updated: systemd-28-2.fc15.x86_64 Jun 01 12:35:40 Updated: systemd-sysv-28-2.fc15.x86_64 Jun 01 16:00:30 Installed: python-devel-2.7.1-7.fc15.x86_64 Jun 01 16:31:16 Installed: keepnote-0.7.2-1.noarch Jun 01 18:43:25 Installed: elfutils-libelf-devel-0.152-1.fc15.x86_64 Jun 01 18:43:25 Installed: w3m-0.5.2-20.fc15.x86_64 Jun 01 18:43:25 Installed: flex-2.5.35-13.fc15.x86_64 Jun 01 18:43:25 Installed: slang-devel-2.2.3-2.fc15.x86_64 Jun 01 18:43:25 Installed: newt-devel-0.52.12-3.fc15.x86_64 Jun 01 18:43:25 Installed: xmlto-0.0.23-4.fc15.x86_64 Jun 01 18:43:25 Installed: elfutils-devel-0.152-1.fc15.x86_64 Jun 01 18:43:25 Installed: redhat-rpm-config-9.1.0-5.fc14.noarch Jun 01 18:43:25 Installed: binutils-devel-2.21.51.0.6-2.fc15.x86_64 Jun 01 18:43:25 Installed: asciidoc-8.4.5-6.fc15.noarch Jun 01 18:43:54 Installed: perl-ExtUtils-Embed-1.28-157.fc15.noarch Let's close this one.