You are not logged in.

Pages: 1

#1 2020-05-03 17:19:05

honestSalami
Member
Registered: 2020-05-03
Posts: 4

[SOLVED] wifi profile service, once stopped, does not start again

If my netctl wifi profile is stopped with systemctl (manually, but also on suspend) it cannot start back up. It fails on authentication. The only way to restore wifi is to poweroff the machine.

the commands I use are:
to stop it

 systemctl stop netctl@wlp0s29u1u4\x2dtembleke.service

to start it back up.

 systemctl start netctl@wlp0s29u1u4\x2dtembleke.service

What can I do to start wifi profile at will?

Here's the relevant journalctl -x output. The netctl profile was running before, I stopped it, and then when I started it up again it failed on authentication.
The top is the stop messages, the middle are things I don't understand but might be relevant, the bottom is the authentication failure.

May 03 11:42:45 Peter systemd[1]: Stopping Automatically generated profile by wifi-menu...
-- Subject: A stop job for unit netctl@wlp0s29u1u4\x2dtembleke.service has begun execution
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A stop job for unit netctl@wlp0s29u1u4\x2dtembleke.service has begun execution.
-- 
-- The job identifier is 362.
May 03 11:42:45 Peter network[2241]: Stopping network profile 'wlp0s29u1u4-tembleke'...
May 03 11:42:45 Peter dhcpcd[485]: wlp0s29u1u4: pid 2246 deleted default route via 192.168.1.1
May 03 11:42:45 Peter dhcpcd[485]: wlp0s29u1u4: pid 2246 deleted route to 192.168.1.0/24
May 03 11:42:45 Peter dhcpcd[485]: wlp0s29u1u4: pid 2250 deleted IP address 192.168.1.147/24
May 03 11:42:45 Peter kernel: wlp0s29u1u4: deauthenticating from 30:23:03:5d:3a:36 by local choice (Reason: 3=DEAUTH_LEAVING)
May 03 11:42:45 Peter dhcpcd[485]: wlp0s29u1u4: rebinding lease of 192.168.1.147
May 03 11:42:45 Peter dhcpcd[485]: wlp0s29u1u4: carrier lost
May 03 11:42:45 Peter dhcpcd[2292]: ps_bpf_recvbpf: Network is down
May 03 11:42:45 Peter network[2241]: Stopped network profile 'wlp0s29u1u4-tembleke'
May 03 11:42:45 Peter dhcpcd[486]: process 486 unexpectedly terminating on signal 15
May 03 11:42:45 Peter dhcpcd[485]: received SIGTERM, stopping
May 03 11:42:45 Peter dhcpcd[485]: wlp0s29u1u4: removing interface
May 03 11:42:45 Peter dhcpcd[485]: script_runreason: Connection refused
May 03 11:42:45 Peter dhcpcd[485]: main: control_stop: Transport endpoint is not connected
May 03 11:42:45 Peter dhcpcd[485]: ps_dostop: Transport endpoint is not connected
May 03 11:42:46 Peter dhcpcd[485]: dhcpcd exited
May 03 11:42:46 Peter systemd[1]: netctl@wlp0s29u1u4\x2dtembleke.service: Succeeded.
-- Subject: Unit succeeded
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- The unit netctl@wlp0s29u1u4\x2dtembleke.service has successfully entered the 'dead' state.
May 03 11:42:46 Peter systemd[1]: Stopped Automatically generated profile by wifi-menu.
-- Subject: A stop job for unit netctl@wlp0s29u1u4\x2dtembleke.service has finished
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A stop job for unit netctl@wlp0s29u1u4\x2dtembleke.service has finished.
-- 
-- The job identifier is 362 and the job result is done.
May 03 11:42:46 Peter audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=netctl@wlp0s29u1u4\x2dtembleke comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
May 03 11:42:46 Peter kernel: audit: type=1131 audit(1588524166.005:47): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=netctl@wlp0s29u1u4\x2dtembleke comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
May 03 11:42:46 Peter polkitd[2227]: Unregistered Authentication Agent for unix-process:2222:672805 (system bus name :1.269, object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale en_US.UTF-8) (disconnected from bus)
May 03 11:42:52 Peter polkitd[2227]: Registered Authentication Agent for unix-process:2336:674194 (system bus name :1.280 [/usr/bin/pkttyagent --notify-fd 5 --fallback], object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale en_US.UTF-8)
May 03 11:42:56 Peter audit[2342]: USER_AUTH pid=2342 uid=1000 auid=1000 ses=1 msg='op=PAM:authentication grantors=pam_unix,pam_permit acct="bfs" exe="/usr/lib/polkit-1/polkit-agent-helper-1" hostname=Peter addr=? terminal=pts/1 res=success'
May 03 11:42:56 Peter audit[2342]: USER_ACCT pid=2342 uid=1000 auid=1000 ses=1 msg='op=PAM:accounting grantors=pam_unix,pam_permit,pam_time acct="bfs" exe="/usr/lib/polkit-1/polkit-agent-helper-1" hostname=? addr=? terminal=? res=success'
May 03 11:42:56 Peter kernel: audit: type=1100 audit(1588524176.319:48): pid=2342 uid=1000 auid=1000 ses=1 msg='op=PAM:authentication grantors=pam_unix,pam_permit acct="bfs" exe="/usr/lib/polkit-1/polkit-agent-helper-1" hostname=Peter addr=? terminal=pts/1 res=success'
May 03 11:42:56 Peter kernel: audit: type=1101 audit(1588524176.319:49): pid=2342 uid=1000 auid=1000 ses=1 msg='op=PAM:accounting grantors=pam_unix,pam_permit,pam_time acct="bfs" exe="/usr/lib/polkit-1/polkit-agent-helper-1" hostname=? addr=? terminal=? res=success'
May 03 11:42:56 Peter polkitd[2227]: Operator of unix-process:2336:674194 successfully authenticated as unix-user:bfs to gain TEMPORARY authorization for action org.freedesktop.systemd1.manage-units for system-bus-name::1.281 [systemctl start netctl@wlp0s29u1u4\x2dtembleke.service] (owned by unix-user:bfs)
May 03 11:42:56 Peter systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped.
-- Subject: A start job for unit ldconfig.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit ldconfig.service has finished successfully.
-- 
-- The job identifier is 377.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
-- Subject: A start job for unit systemd-binfmt.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit systemd-binfmt.service has finished successfully.
-- 
-- The job identifier is 399.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped.
-- Subject: A start job for unit systemd-boot-system-token.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit systemd-boot-system-token.service has finished successfully.
-- 
-- The job identifier is 419.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in First Boot Wizard being skipped.
-- Subject: A start job for unit systemd-firstboot.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit systemd-firstboot.service has finished successfully.
-- 
-- The job identifier is 406.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
-- Subject: A start job for unit systemd-hwdb-update.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit systemd-hwdb-update.service has finished successfully.
-- 
-- The job identifier is 371.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped.
-- Subject: A start job for unit systemd-journal-catalog-update.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit systemd-journal-catalog-update.service has finished successfully.
-- 
-- The job identifier is 397.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
-- Subject: A start job for unit systemd-machine-id-commit.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit systemd-machine-id-commit.service has finished successfully.
-- 
-- The job identifier is 365.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in Load Kernel Modules being skipped.
-- Subject: A start job for unit systemd-modules-load.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit systemd-modules-load.service has finished successfully.
-- 
-- The job identifier is 372.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in FUSE Control File System being skipped.
-- Subject: A start job for unit sys-fs-fuse-connections.mount has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit sys-fs-fuse-connections.mount has finished successfully.
-- 
-- The job identifier is 400.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in Create System Users being skipped.
-- Subject: A start job for unit systemd-sysusers.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit systemd-sysusers.service has finished successfully.
-- 
-- The job identifier is 401.
May 03 11:42:56 Peter systemd[1]: Condition check resulted in Update is Completed being skipped.
-- Subject: A start job for unit systemd-update-done.service has finished successfully
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit systemd-update-done.service has finished successfully.
-- 
-- The job identifier is 418.
May 03 11:42:56 Peter systemd[1]: Starting Automatically generated profile by wifi-menu...
-- Subject: A start job for unit netctl@wlp0s29u1u4\x2dtembleke.service has begun execution
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit netctl@wlp0s29u1u4\x2dtembleke.service has begun execution.
-- 
-- The job identifier is 363.
May 03 11:42:56 Peter network[2345]: Starting network profile 'wlp0s29u1u4-tembleke'...
May 03 11:42:57 Peter kernel: wlp0s29u1u4: authenticate with 30:23:03:5d:3a:36
May 03 11:42:57 Peter kernel: wlp0s29u1u4: send auth to 30:23:03:5d:3a:36 (try 1/3)
May 03 11:42:57 Peter kernel: wlp0s29u1u4: send auth to 30:23:03:5d:3a:36 (try 2/3)
May 03 11:42:58 Peter kernel: wlp0s29u1u4: send auth to 30:23:03:5d:3a:36 (try 3/3)
May 03 11:42:58 Peter kernel: wlp0s29u1u4: authentication with 30:23:03:5d:3a:36 timed out
May 03 11:42:58 Peter kernel: wlp0s29u1u4: authenticate with 24:f5:a2:ef:dd:d9
May 03 11:42:58 Peter kernel: wlp0s29u1u4: send auth to 24:f5:a2:ef:dd:d9 (try 1/3)
May 03 11:42:58 Peter kernel: wlp0s29u1u4: send auth to 24:f5:a2:ef:dd:d9 (try 2/3)
May 03 11:42:58 Peter kernel: wlp0s29u1u4: send auth to 24:f5:a2:ef:dd:d9 (try 3/3)
May 03 11:42:59 Peter kernel: wlp0s29u1u4: authentication with 24:f5:a2:ef:dd:d9 timed out
May 03 11:43:00 Peter kernel: wlp0s29u1u4: authenticate with 30:23:03:5d:3a:36
May 03 11:43:00 Peter kernel: wlp0s29u1u4: send auth to 30:23:03:5d:3a:36 (try 1/3)
May 03 11:43:00 Peter kernel: wlp0s29u1u4: send auth to 30:23:03:5d:3a:36 (try 2/3)
May 03 11:43:00 Peter kernel: wlp0s29u1u4: send auth to 30:23:03:5d:3a:36 (try 3/3)
May 03 11:43:01 Peter kernel: wlp0s29u1u4: authentication with 30:23:03:5d:3a:36 timed out
May 03 11:43:08 Peter kernel: wlp0s29u1u4: authenticate with 30:23:03:5d:3a:36
May 03 11:43:08 Peter kernel: wlp0s29u1u4: send auth to 30:23:03:5d:3a:36 (try 1/3)
May 03 11:43:08 Peter kernel: wlp0s29u1u4: send auth to 30:23:03:5d:3a:36 (try 2/3)
May 03 11:43:08 Peter kernel: wlp0s29u1u4: send auth to 30:23:03:5d:3a:36 (try 3/3)
May 03 11:43:09 Peter kernel: wlp0s29u1u4: authentication with 30:23:03:5d:3a:36 timed out
May 03 11:43:11 Peter network[2345]: WPA association/authentication failed for interface 'wlp0s29u1u4'
May 03 11:43:12 Peter network[2345]: Failed to bring the network up for profile 'wlp0s29u1u4-tembleke'
May 03 11:43:12 Peter systemd[1]: netctl@wlp0s29u1u4\x2dtembleke.service: Main process exited, code=exited, status=1/FAILURE
-- Subject: Unit process exited
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- An ExecStart= process belonging to unit netctl@wlp0s29u1u4\x2dtembleke.service has exited.
-- 
-- The process' exit code is 'exited' and its exit status is 1.
May 03 11:43:12 Peter systemd[1]: netctl@wlp0s29u1u4\x2dtembleke.service: Failed with result 'exit-code'.
-- Subject: Unit failed
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- The unit netctl@wlp0s29u1u4\x2dtembleke.service has entered the 'failed' state with result 'exit-code'.
May 03 11:43:12 Peter systemd[1]: Failed to start Automatically generated profile by wifi-menu.
-- Subject: A start job for unit netctl@wlp0s29u1u4\x2dtembleke.service has failed
-- Defined-By: systemd
-- Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- A start job for unit netctl@wlp0s29u1u4\x2dtembleke.service has finished with a failure.
-- 
-- The job identifier is 363 and the job result is failed.
May 03 11:43:12 Peter audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=netctl@wlp0s29u1u4\x2dtembleke comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'
May 03 11:43:12 Peter kernel: audit: type=1130 audit(1588524192.142:50): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=netctl@wlp0s29u1u4\x2dtembleke comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'
May 03 11:43:12 Peter polkitd[2227]: Unregistered Authentication Agent for unix-process:2336:674194 (system bus name :1.280, object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale en_US.UTF-8) (disconnected from bus)

(edited to add the start and stop commands)

Last edited by honestSalami (2020-05-04 02:10:47)

Offline

#2 2020-05-03 19:13:31

Head_on_a_Stick
Member
From: The Wirral
Registered: 2014-02-20
Posts: 9,003
Website

Re: [SOLVED] wifi profile service, once stopped, does not start again

honestSalami wrote:

when I started it up again

You should post the exact command(s) used rather than a vague description.

honestSalami wrote:
May 03 11:43:09 Peter kernel: wlp0s29u1u4: authentication with 30:23:03:5d:3a:36 timed out
May 03 11:43:11 Peter network[2345]: WPA association/authentication failed for interface 'wlp0s29u1u4'
May 03 11:43:12 Peter network[2345]: Failed to bring the network up for profile 'wlp0s29u1u4-tembleke'

Do you have any other networking services enabled that might be conflicting with netctl?

systemctl list-unit-files --state=enabled

See also https://wiki.archlinux.org/index.php/Ne … ice_failed (point 2 may be relevant here).

Jin, Jîyan, Azadî

Offline

#3 2020-05-03 22:06:12

honestSalami
Member
Registered: 2020-05-03
Posts: 4

Re: [SOLVED] wifi profile service, once stopped, does not start again

"Do you have any other networking services enabled that might be conflicting with netctl?"

I don't think so

systemctl list-unit-files --state enabled 

UNIT FILE                              STATE   VENDOR PRESET
autovt@.service                        enabled disabled     
dbus-org.freedesktop.timesync1.service enabled disabled     
getty@.service                         enabled enabled      
systemd-timesyncd.service              enabled enabled      
remote-fs.target                       enabled enabled      

5 unit files listed.

but it seems that netctl calls dhcpcd as part of its operation:

systemctl status

             ├─system-netctl.slice 
             │ └─netctl@wlp0s29u1u4\x2dtembleke.service 
             │   ├─[0;38;5;245m385 wpa_supplicant -q -B -P /run/wpa_supplicant-wlp0s29u1u4.pid -i wlp0s29u1u4 -D nl80211,wext -c/run/netctl/wpa_supplicant-wlp0s29u1u4.conf[0m
             │   ├─[0;38;5;245m484 dhcpcd: wlp0s29u1u4 [ip4][0m
             │   ├─[0;38;5;245m485 dhcpcd: [privileged actioneer][0m
             │   ├─[0;38;5;245m495 dhcpcd: [BPF ARP] wlp0s29u1u4[0m
             │   └─[0;38;5;245m575 dhcpcd: [network proxy] 192.168.1.147[0m

Offline

#4 2020-05-03 22:20:53

honestSalami
Member
Registered: 2020-05-03
Posts: 4

Re: [SOLVED] wifi profile service, once stopped, does not start again

"See also https://wiki.archlinux.org/index.php/Ne … ice_failed (point 2 may be relevant here)."

I tried that, adding ForceConnect=yes to the /etc/netctl/wlp0 profile file. But the problem persisted.

Offline

#5 2020-05-04 02:10:11

honestSalami
Member
Registered: 2020-05-03
Posts: 4

Re: [SOLVED] wifi profile service, once stopped, does not start again

ok, so I gave up and switched to NetworkManager. It does not have the "not reconnecting on suspend" problem, so I think I'll stay with it.

Offline

Pages: 1

Board footer

Powered by FluxBB