Bug 1190488 - misbehaves on `init 3`
Summary: misbehaves on `init 3`
Keywords:
Status: CLOSED DUPLICATE of bug 708537
Alias: None
Product: Fedora
Classification: Fedora
Component: systemd
Version: 20
Hardware: Unspecified
OS: Unspecified
unspecified
medium
Target Milestone: ---
Assignee: systemd-maint
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2015-02-08 16:07 UTC by udo
Modified: 2015-02-09 14:15 UTC (History)
8 users (show)

Fixed In Version:
Doc Type: Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed: 2015-02-09 14:15:10 UTC
Type: Bug
Embargoed:


Attachments (Terms of Use)

Description udo 2015-02-08 16:07:55 UTC
Description of problem:
systemd does whatever when I do an `init 3` around 16:56:59.
I cannot explain why it should stop all the stuff it does.
SystemV scripts did not do that.

Version-Release number of selected component (if applicable):
systemd-208-29.fc20.x86_64

How reproducible:
init 3


Actual results:
Feb  6 18:01:01 recorder systemd: Starting Session 915 of user root.
Feb  6 18:01:02 recorder systemd: Started Session 915 of user root.
Feb  6 19:01:02 recorder systemd: Starting Session 916 of user root.
Feb  6 19:01:02 recorder systemd: Started Session 916 of user root.
Feb  6 19:05:01 recorder systemd: Starting Session 917 of user mythtv.
Feb  6 19:05:01 recorder systemd: Started Session 917 of user mythtv.
Feb  6 20:01:01 recorder systemd: Starting Session 918 of user root.
Feb  6 20:01:02 recorder systemd: Started Session 918 of user root.
Feb  6 21:01:02 recorder systemd: Starting Session 919 of user root.
Feb  6 21:01:03 recorder systemd: Started Session 919 of user root.
Feb  6 22:01:01 recorder systemd: Starting Session 920 of user root.
Feb  6 22:01:01 recorder systemd: Started Session 920 of user root.
Feb  6 23:01:02 recorder systemd: Starting Session 921 of user root.
Feb  6 23:01:02 recorder systemd: Started Session 921 of user root.
Feb  6 23:05:01 recorder systemd: Starting Session 922 of user mythtv.
Feb  6 23:05:01 recorder systemd: Started Session 922 of user mythtv.
Feb  7 00:01:02 recorder systemd: Starting Session 923 of user root.
Feb  7 00:01:03 recorder systemd: Started Session 923 of user root.
Feb  7 00:04:01 recorder systemd: Starting Session 924 of user mythtv.
Feb  7 00:04:01 recorder systemd: Started Session 924 of user mythtv.
Feb  7 01:01:01 recorder systemd: Starting Session 925 of user root.
Feb  7 01:01:02 recorder systemd: Started Session 925 of user root.
Feb  7 02:01:02 recorder systemd: Starting Session 926 of user root.
Feb  7 02:01:03 recorder systemd: Started Session 926 of user root.
Feb  7 03:01:01 recorder systemd: Starting Session 927 of user root.
Feb  7 03:01:02 recorder systemd: Started Session 927 of user root.
Feb  7 04:01:01 recorder systemd: Starting Session 928 of user root.
Feb  7 04:01:02 recorder systemd: Started Session 928 of user root.
Feb  7 04:41:01 recorder systemd: Starting Session 929 of user mythtv.
Feb  7 04:41:01 recorder systemd: Started Session 929 of user mythtv.
Feb  7 05:01:01 recorder systemd: Starting Session 930 of user root.
Feb  7 05:01:01 recorder systemd: Started Session 930 of user root.
Feb  7 05:04:01 recorder systemd: Starting Session 931 of user mythtv.
Feb  7 05:04:01 recorder systemd: Started Session 931 of user mythtv.
Feb  7 06:01:02 recorder systemd: Starting Session 932 of user root.
Feb  7 06:01:02 recorder systemd: Started Session 932 of user root.
Feb  7 07:01:01 recorder systemd: Starting Session 933 of user root.
Feb  7 07:01:01 recorder systemd: Started Session 933 of user root.
Feb  7 07:05:01 recorder systemd: Starting Session 934 of user mythtv.
Feb  7 07:05:01 recorder systemd: Started Session 934 of user mythtv.
Feb  7 08:01:01 recorder systemd: Starting Session 935 of user root.
Feb  7 08:01:01 recorder systemd: Started Session 935 of user root.
Feb  7 09:01:01 recorder systemd: Starting Session 936 of user root.
Feb  7 09:01:02 recorder systemd: Started Session 936 of user root.
Feb  7 10:01:01 recorder systemd: Starting Session 937 of user root.
Feb  7 10:01:01 recorder systemd: Started Session 937 of user root.
Feb  7 11:01:02 recorder systemd: Starting Session 938 of user root.
Feb  7 11:01:02 recorder systemd: Started Session 938 of user root.
Feb  7 11:05:01 recorder systemd: Starting Session 939 of user mythtv.
Feb  7 11:05:01 recorder systemd: Started Session 939 of user mythtv.
Feb  7 12:01:01 recorder systemd: Starting Session 940 of user root.
Feb  7 12:01:02 recorder systemd: Started Session 940 of user root.
Feb  7 13:01:01 recorder systemd: Starting Session 941 of user root.
Feb  7 13:01:02 recorder systemd: Started Session 941 of user root.
Feb  7 14:01:01 recorder systemd: Starting Session 942 of user root.
Feb  7 14:01:02 recorder systemd: Started Session 942 of user root.
Feb  7 15:01:01 recorder systemd: Starting Session 943 of user root.
Feb  7 15:01:02 recorder systemd: Started Session 943 of user root.
Feb  7 15:05:01 recorder systemd: Starting Session 944 of user mythtv.
Feb  7 15:05:01 recorder systemd: Started Session 944 of user mythtv.
Feb  7 15:44:59 recorder systemd: Starting Cleanup of Temporary Directories...
Feb  7 15:45:03 recorder systemd: Started Cleanup of Temporary Directories.
Feb  7 16:01:01 recorder systemd: Starting Session 945 of user root.
Feb  7 16:01:01 recorder systemd: Started Session 945 of user root.
Feb  7 17:01:01 recorder systemd: Starting Session 946 of user root.
Feb  7 17:01:01 recorder systemd: Started Session 946 of user root.
Feb  7 18:01:01 recorder systemd: Starting Session 947 of user root.
Feb  7 18:01:01 recorder systemd: Started Session 947 of user root.
Feb  7 19:01:01 recorder systemd: Starting Session 948 of user root.
Feb  7 19:01:01 recorder systemd: Started Session 948 of user root.
Feb  7 19:05:01 recorder systemd: Starting Session 949 of user mythtv.
Feb  7 19:05:02 recorder systemd: Started Session 949 of user mythtv.
Feb  7 20:01:01 recorder systemd: Starting Session 950 of user root.
Feb  7 20:01:01 recorder systemd: Started Session 950 of user root.
Feb  7 21:01:01 recorder systemd: Starting Session 951 of user root.
Feb  7 21:01:01 recorder systemd: Started Session 951 of user root.
Feb  7 22:01:01 recorder systemd: Starting Session 952 of user root.
Feb  7 22:01:02 recorder systemd: Started Session 952 of user root.
Feb  7 23:01:01 recorder systemd: Starting Session 953 of user root.
Feb  7 23:01:01 recorder systemd: Started Session 953 of user root.
Feb  7 23:05:01 recorder systemd: Starting Session 954 of user mythtv.
Feb  7 23:05:01 recorder systemd: Started Session 954 of user mythtv.
Feb  8 00:01:01 recorder systemd: Starting Session 955 of user root.
Feb  8 00:01:02 recorder systemd: Started Session 955 of user root.
Feb  8 00:04:01 recorder systemd: Starting Session 956 of user mythtv.
Feb  8 00:04:01 recorder systemd: Started Session 956 of user mythtv.
Feb  8 01:00:01 recorder systemd: Starting Session 957 of user root.
Feb  8 01:00:02 recorder systemd: Started Session 957 of user root.
Feb  8 01:01:01 recorder systemd: Starting Session 958 of user root.
Feb  8 01:01:01 recorder systemd: Started Session 958 of user root.
Feb  8 02:01:01 recorder systemd: Starting Session 959 of user root.
Feb  8 02:01:02 recorder systemd: Started Session 959 of user root.
Feb  8 03:01:01 recorder systemd: Starting Session 960 of user root.
Feb  8 03:01:01 recorder systemd: Started Session 960 of user root.
Feb  8 04:01:01 recorder systemd: Starting Session 961 of user root.
Feb  8 04:01:01 recorder systemd: Started Session 961 of user root.
Feb  8 04:41:01 recorder systemd: Starting Session 962 of user mythtv.
Feb  8 04:41:02 recorder systemd: Started Session 962 of user mythtv.
Feb  8 05:01:01 recorder systemd: Starting Session 963 of user root.
Feb  8 05:01:01 recorder systemd: Started Session 963 of user root.
Feb  8 05:04:01 recorder systemd: Starting Session 964 of user mythtv.
Feb  8 05:04:01 recorder systemd: Started Session 964 of user mythtv.
Feb  8 06:01:01 recorder systemd: Starting Session 965 of user root.
Feb  8 06:01:01 recorder systemd: Started Session 965 of user root.
Feb  8 07:01:01 recorder systemd: Starting Session 966 of user root.
Feb  8 07:01:02 recorder systemd: Started Session 966 of user root.
Feb  8 07:05:01 recorder systemd: Starting Session 967 of user mythtv.
Feb  8 07:05:02 recorder systemd: Started Session 967 of user mythtv.
Feb  8 08:01:01 recorder systemd: Starting Session 968 of user root.
Feb  8 08:01:02 recorder systemd: Started Session 968 of user root.
Feb  8 09:01:01 recorder systemd: Starting Session 969 of user root.
Feb  8 09:01:02 recorder systemd: Started Session 969 of user root.
Feb  8 10:01:01 recorder systemd: Starting Session 970 of user root.
Feb  8 10:01:02 recorder systemd: Started Session 970 of user root.
Feb  8 11:01:01 recorder systemd: Starting Session 971 of user root.
Feb  8 11:01:01 recorder systemd: Started Session 971 of user root.
Feb  8 11:05:01 recorder systemd: Starting Session 972 of user mythtv.
Feb  8 11:05:01 recorder systemd: Started Session 972 of user mythtv.
Feb  8 12:01:01 recorder systemd: Starting Session 973 of user root.
Feb  8 12:01:02 recorder systemd: Started Session 973 of user root.
Feb  8 13:01:01 recorder systemd: Starting Session 974 of user root.
Feb  8 13:01:02 recorder systemd: Started Session 974 of user root.
Feb  8 14:01:01 recorder systemd: Starting Session 975 of user root.
Feb  8 14:01:02 recorder systemd: Started Session 975 of user root.
Feb  8 15:01:01 recorder systemd: Starting Session 976 of user root.
Feb  8 15:01:02 recorder systemd: Started Session 976 of user root.
Feb  8 15:05:01 recorder systemd: Starting Session 977 of user mythtv.
Feb  8 15:05:01 recorder systemd: Started Session 977 of user mythtv.
Feb  8 15:44:59 recorder systemd: Starting Cleanup of Temporary Directories...
Feb  8 15:45:01 recorder systemd: Started Cleanup of Temporary Directories.
Feb  8 16:01:01 recorder systemd: Starting Session 978 of user root.
Feb  8 16:01:01 recorder systemd: Started Session 978 of user root.
Feb  8 16:56:59 recorder systemd: Stopping User Manager for 499...
Feb  8 16:57:00 recorder systemd: Stopping User Manager for 488...
Feb  8 16:57:00 recorder systemd: Stopping User Manager for 500...
Feb  8 16:57:00 recorder systemd: Stopping User Manager for 0...
Feb  8 16:57:00 recorder systemd: Stopping RealtimeKit Scheduling Policy Service...
Feb  8 16:57:00 recorder systemd: Stopping Manage, Install and Generate Color Profiles...
Feb  8 16:57:00 recorder systemd: Stopping Daemon for power management...
Feb  8 16:57:00 recorder systemd: Stopping User Manager for 42...
Feb  8 16:57:00 recorder systemd: Stopping MythTV backend service...
Feb  8 16:57:00 recorder systemd: Stopping Authorization Manager...
Feb  8 16:57:00 recorder systemd: Stopping Accounts Service...
Feb  8 16:57:00 recorder systemd: Stopping LVM2 PV scan on device 8:3...
Feb  8 16:57:00 recorder systemd: Started Load Kernel Modules.
Feb  8 16:57:00 recorder systemd: Mounted Configuration File System.
Feb  8 16:57:01 recorder gnome-session: PolicyKit daemon disconnected from the bus.
Feb  8 16:57:03 recorder gnome-session: We are no longer a registered authentication agent.
Feb  8 16:57:03 recorder gdm: GLib-GObject: g_object_ref: assertion 'object->ref_count > 0' failed
Feb  8 16:57:03 recorder systemd: Started Set Up Additional Binary Formats.
Feb  8 16:57:03 recorder systemd: Reached target Multi-User System.
Feb  8 16:57:03 recorder systemd: Starting Update UTMP about System Runlevel Changes...
Feb  8 16:57:03 recorder systemd: Stopped LVM2 metadata daemon.
Feb  8 16:57:03 recorder systemd: Stopped Accounts Service.
Feb  8 16:57:03 recorder systemd: Stopped Authorization Manager.
Feb  8 16:57:03 recorder systemd: Stopped Daemon for power management.
Feb  8 16:57:03 recorder systemd: Stopped Manage, Install and Generate Color Profiles.
Feb  8 16:57:03 recorder systemd: Stopped RealtimeKit Scheduling Policy Service.
Feb  8 16:57:03 recorder systemd: Stopping Default.
Feb  8 16:57:05 recorder systemd: Stopped target Default.
Feb  8 16:57:05 recorder systemd: Starting Shutdown.
Feb  8 16:57:05 recorder systemd: Stopping Default.
Feb  8 16:57:07 recorder systemd: Stopping Default.
Feb  8 16:57:07 recorder systemd: Stopping Default.
Feb  8 16:57:07 recorder systemd: Stopping Default.
Feb  8 16:57:09 recorder systemd: Reached target Shutdown.
Feb  8 16:57:09 recorder systemd: Stopped target Default.
Feb  8 16:57:09 recorder systemd: Stopped target Default.
Feb  8 16:57:09 recorder systemd: Stopped target Default.
Feb  8 16:57:09 recorder systemd: Stopped target Default.
Feb  8 16:57:09 recorder systemd: Starting Exit the Session...
Feb  8 16:57:09 recorder systemd: Starting Shutdown.
Feb  8 16:57:09 recorder systemd: Starting Shutdown.
Feb  8 16:57:09 recorder systemd: Starting Shutdown.
Feb  8 16:57:09 recorder systemd: Starting Shutdown.
Feb  8 16:57:09 recorder systemd: Received SIGRTMIN+24 from PID 19892 (kill).
Feb  8 16:57:09 recorder systemd: Reached target Shutdown.
Feb  8 16:57:09 recorder systemd: Starting Exit the Session...
Feb  8 16:57:09 recorder systemd: Reached target Shutdown.
Feb  8 16:57:09 recorder systemd: Reached target Shutdown.
Feb  8 16:57:09 recorder systemd: Reached target Shutdown.
Feb  8 16:57:09 recorder systemd: Starting Exit the Session...
Feb  8 16:57:09 recorder systemd: Received SIGRTMIN+24 from PID 19905 (kill).
Feb  8 16:57:09 recorder systemd: Starting Exit the Session...
Feb  8 16:57:09 recorder systemd: Received SIGRTMIN+24 from PID 19907 (kill).
Feb  8 16:57:09 recorder systemd: Starting Exit the Session...
Feb  8 16:57:09 recorder systemd: Received SIGRTMIN+24 from PID 19909 (kill).
Feb  8 16:57:09 recorder systemd: Received SIGRTMIN+24 from PID 19911 (kill).
Feb  8 16:57:09 recorder systemd: Stopped User Manager for 42.
Feb  8 16:57:09 recorder systemd: Stopping user-42.slice.
Feb  8 16:57:09 recorder systemd: Removed slice user-42.slice.
Feb  8 16:57:09 recorder gnome-session: g_dbus_connection_real_closed: Remote peer vanished with error: Underlying GIOStream returned 0 bytes on an async read (g-io-error-quark, 0). Exiting.
Feb  8 16:57:10 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:10 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:10 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:10 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:11 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:11 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:11 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:11 recorder gdm: GLib-GObject: g_object_unref: assertion 'object->ref_count > 0' failed
Feb  8 16:57:12 recorder gnome-session: (gnome-settings-daemon:1618): Gdk-WARNING **: gnome-settings-daemon: Fatal IO error 11 (Resource temporarily unavailable) on X server :0.
Feb  8 16:57:12 recorder gnome-session: Window manager warning: Log level 16: gnome-shell: Fatal IO error 4 (Interrupted system call) on X server :0.
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder sysctl: fs.nfs.nlm_tcpport = 0
Feb  8 16:57:12 recorder sysctl: fs.nfs.nlm_udpport = 0
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:12 recorder kernel: sound hdaudioC1D0: HDMI ATI/AMD: no speaker allocation for ELD
Feb  8 16:57:13 recorder systemd: Stopped MythTV backend service.
Feb  8 16:57:13 recorder systemd: Stopping Network.
Feb  8 16:57:13 recorder systemd: Stopped target Network.
Feb  8 16:57:21 recorder systemd: Starting MythTV backend service...
Feb  8 16:57:22 recorder systemd: Started MythTV backend service.
Feb  8 16:57:22 recorder kernel: tda1004x: setting up plls for 53MHz sampling clock
Feb  8 16:57:22 recorder kernel: tda1004x: setting up plls for 53MHz sampling clock
Feb  8 16:57:22 recorder kernel: tda1004x: found firmware revision 20 -- ok
Feb  8 16:57:22 recorder kernel: tda1004x: found firmware revision 20 -- ok
Feb  8 16:57:22 recorder kernel: tda1004x: setting up plls for 53MHz sampling clock
Feb  8 16:57:22 recorder kernel: tda1004x: setting up plls for 53MHz sampling clock
Feb  8 16:57:22 recorder kernel: tda1004x: found firmware revision 20 -- ok
Feb  8 16:57:22 recorder kernel: tda1004x: found firmware revision 20 -- ok
Feb  8 16:57:22 recorder kernel: tda1004x: setting up plls for 53MHz sampling clock
Feb  8 16:57:22 recorder kernel: tda1004x: setting up plls for 53MHz sampling clock
Feb  8 16:57:23 recorder kernel: tda1004x: found firmware revision 20 -- ok
Feb  8 16:57:23 recorder kernel: tda1004x: found firmware revision 20 -- ok
Feb  8 16:57:30 recorder pulseaudio[1692]: [pulseaudio] pid.c: Failed to open PID file '/run/user/42/pulse/pid': No such file or directory
Feb  8 16:57:30 recorder pulseaudio[1692]: [pulseaudio] pid.c: Failed to open PID file '/run/user/42/pulse/pid': No such file or directory


Expected results:
A smooth and quiet log with not too much noise nor actions when going to runlevel 3.

Additional info:
The box was up for 30 days and nicely humming along.
I do not think that `init 3` is an abnormal command.
I do think the correlated effects are abnormal.
I do think this is one of the core things that init should do.
init handled this perfectly as far as I know.
What alternatives does Fedora offer to avoid happenings like these?

Comment 1 Zbigniew Jędrzejewski-Szmek 2015-02-08 16:56:29 UTC
It's a known problem. systemd effectively does 'systemctl isolate runlevel-3.target', which kills stuff not in that target. In a sense it *is* what sysvinit did, where it would stop daemons not declared to start in the new runlevel, and start daemons declared to start in the new runlevel. The difference with systemd is that it knows about more stuff, so more stuff gets killed. There were some discussions to change the behaviour to e.g. only kill stuff that is declared as a dependency for the old runlevel, but not for the new one, but I don't anyone ever tried to figure out all the details of what it should do, or tried to work on it. My only recommendation is not to do that.

Comment 2 udo 2015-02-08 17:38:43 UTC
From what I recall SysV init just killed what needed to be killed.
This 'systemd' behaviour is unacceptable.
What if my enterprise database goes down when I do an init 3?
This is a grave fail. Please fix.
(My Linux is now more broken than it ever was: logging, runlevels, bloatware, etc. The list grows and grows.)

Comment 3 Zbigniew Jędrzejewski-Szmek 2015-02-08 17:45:24 UTC
Not every concept can be translated from sysvinit to systemd. If 'systemctl isolate runlevel-3.target' or 'init 3' does not do what you want it to do, use something else. There's no way that it is ever going to do exactly the same thing as in sysvinit, especially since its impossible to say what it did in sysvinit in various corner cases with any certainty.

Comment 4 udo 2015-02-09 03:29:42 UTC
I did `init 3` so I'd like to see `init 3 ` behaviour.

Comment 5 udo 2015-02-09 06:35:25 UTC
From the manual page:

       2, 3, 4, 5
           Boot into the specified legacy SysV runlevel. These are equivalent
           to systemd.unit=runlevel2.target, systemd.unit=runlevel3.target,
           systemd.unit=runlevel4.target, and systemd.unit=runlevel5.target,
           respectively, and provided for compatibility reasons and to be
           easier to type.

Please note the word 'compatibility'.

Comment 6 Zbigniew Jędrzejewski-Szmek 2015-02-09 14:15:10 UTC
Feel free to comment on the other bug if you have specific ideas for what "systemctl isolate" aka "init <n>" should do.

*** This bug has been marked as a duplicate of bug 708537 ***


Note You need to log in before you can comment on or make changes to this bug.