[SOLVED] /var/run/nologin created but not removed-cant logon

This forum is for topics dealing with problems with software specifically in the ARMv5 repo.

[SOLVED] /var/run/nologin created but not removed-cant logon

Postby gregbert » Wed Oct 21, 2015 1:23 am

After a recent update, i found that i could no longer ssh into my pogoplug w/archlinuxarm on it. I found that /var/run/nologin was the culprit - removing it allowed logins again.

But the file is re-created at every boot... so it needs to be manually removed

I found this in the journal:

$this->bbcode_second_pass_quote('', 's')ystemd[1]: systemd-tmpfiles-setup.service: Job systemd-tmpfiles-setup.service/stop deleted to break ordering cycle starting with var-lib-nfs-rpc_pipefs.mount/stop


given that systemd-tmpfiles is the likely creator of the /var/run/nologin file - i suspect this message is important - but it did not appear in my most recent boot long, but nonetheless /var/run/nologin was still created and not deleted.

everything else appears to be working correctly. the only other recent change i made was to change the hostname

Here is my journal log. nothing done to protect the identity of random hacker. looking forward to your thoughts.

$this->bbcode_second_pass_code('', '-- Logs begin at Wed 1969-12-31 19:00:06 EST, end at Tue 2015-10-20 21:13:38 EDT. --
Dec 31 19:00:07 Pogoplug2.masked.com systemd-journald[106]: Runtime journal (/run/log/journal/) is currently using 4.0M.
Maximum allowed usage is set to 12.3M.
Leaving at least 18.4M free (of currently available 119.0M of space).
Enforced usage limit is thus 12.3M, of which 8.3M are still available.
Dec 31 19:00:07 Pogoplug2.masked.com systemd-journald[106]: Journal started
Dec 31 19:00:07 Pogoplug2.masked.com systemd-modules-load[104]: Module 'netconsole' is builtin
Dec 31 19:00:07 Pogoplug2.masked.com systemd-modules-load[104]: Inserted module 'nfs'
Dec 31 19:00:07 Pogoplug2.masked.com systemd-fsck[111]: ROOTFS: clean, 111866/254976 files, 720168/1019196 blocks
Dec 31 19:00:07 Pogoplug2.masked.com systemd[1]: Started Setup Virtual Console.
Dec 31 19:00:07 Pogoplug2.masked.com systemd[1]: Started Create list of required static device nodes for the current kernel.
Dec 31 19:00:07 Pogoplug2.masked.com systemd[1]: Started Load Kernel Modules.
Dec 31 19:00:07 Pogoplug2.masked.com systemd[1]: Started File System Check on Root Device.
Dec 31 19:00:07 Pogoplug2.masked.com systemd[1]: Starting Remount Root and Kernel File Systems...
Dec 31 19:00:08 Pogoplug2.masked.com systemd[1]: Starting Apply Kernel Variables...
Dec 31 19:00:08 Pogoplug2.masked.com systemd-sysctl[122]: Couldn't write 'fq_codel' to 'net/core/default_qdisc', ignoring: No such file or directory
Dec 31 19:00:08 Pogoplug2.masked.com systemd-sysctl[122]: Couldn't write '1' to 'fs/protected_symlinks', ignoring: No such file or directory
Dec 31 19:00:08 Pogoplug2.masked.com systemd-sysctl[122]: Couldn't write '1' to 'fs/protected_hardlinks', ignoring: No such file or directory
Dec 31 19:00:08 Pogoplug2.masked.com systemd[1]: Started Remount Root and Kernel File Systems.
Dec 31 19:00:08 Pogoplug2.masked.com systemd[1]: Started Apply Kernel Variables.
Dec 31 19:00:08 Pogoplug2.masked.com systemd[1]: Starting udev Coldplug all Devices...
Dec 31 19:00:08 Pogoplug2.masked.com systemd[1]: Starting Flush Journal to Persistent Storage...
Dec 31 19:00:08 Pogoplug2.masked.com systemd[1]: Starting Create Static Device Nodes in /dev...
Dec 31 19:00:08 Pogoplug2.masked.com systemd[1]: Starting Load/Save Random Seed...
Dec 31 19:00:09 Pogoplug2.masked.com systemd[1]: Started Create Static Device Nodes in /dev.
Dec 31 19:00:09 Pogoplug2.masked.com systemd[1]: Started Load/Save Random Seed.
Dec 31 19:00:10 Pogoplug2.masked.com systemd-journald[106]: System journal (/var/log/journal/) is currently using 128.1M.
Maximum allowed usage is set to 391.8M.
Leaving at least 587.8M free (of currently available 969.0M of space).
Enforced usage limit is thus 391.8M, of which 263.6M are still available.
Dec 31 19:00:10 Pogoplug2.masked.com systemd-journald[106]: Time spent on flushing to /var is 338.544ms for 23 entries.
Dec 31 19:00:09 Pogoplug2.masked.com systemd[1]: Starting udev Kernel Device Manager...
Dec 31 19:00:09 Pogoplug2.masked.com systemd[1]: Reached target Local File Systems (Pre).
Dec 31 19:00:09 Pogoplug2.masked.com systemd[1]: Reached target Local File Systems.
Dec 31 19:00:09 Pogoplug2.masked.com systemd[1]: Starting Preprocess NFS configuration...
Dec 31 19:00:09 Pogoplug2.masked.com systemd[1]: Started udev Coldplug all Devices.
Dec 31 19:00:11 Pogoplug2.masked.com systemd[1]: Started Preprocess NFS configuration.
Dec 31 19:00:17 Pogoplug2.masked.com systemd[1]: Started udev Kernel Device Manager.
Dec 31 19:00:17 Pogoplug2.masked.com systemd[1]: Started Flush Journal to Persistent Storage.
Dec 31 19:00:17 Pogoplug2.masked.com systemd[1]: Starting Create Volatile Files and Directories...
Dec 31 19:00:18 Pogoplug2.masked.com systemd[1]: Found device /dev/ttyS0.
Dec 31 19:00:18 Pogoplug2.masked.com mtp-probe[150]: checking bus 1, device 3: "/sys/devices/platform/orion-ehci.0/usb1/1-1/1-1.1"
Dec 31 19:00:18 Pogoplug2.masked.com mtp-probe[151]: checking bus 1, device 4: "/sys/devices/platform/orion-ehci.0/usb1/1-1/1-1.2"
Dec 31 19:00:18 Pogoplug2.masked.com mtp-probe[153]: checking bus 1, device 5: "/sys/devices/platform/orion-ehci.0/usb1/1-1/1-1.3"
Dec 31 19:00:18 Pogoplug2.masked.com mtp-probe[154]: checking bus 1, device 6: "/sys/devices/platform/orion-ehci.0/usb1/1-1/1-1.4"
Dec 31 19:00:18 Pogoplug2.masked.com mtp-probe[154]: bus: 1, device: 6 was not an MTP device
Dec 31 19:00:18 Pogoplug2.masked.com mtp-probe[153]: bus: 1, device: 5 was not an MTP device
Dec 31 19:00:18 Pogoplug2.masked.com mtp-probe[151]: bus: 1, device: 4 was not an MTP device
Dec 31 19:00:18 Pogoplug2.masked.com mtp-probe[150]: bus: 1, device: 3 was not an MTP device
Dec 31 19:00:18 Pogoplug2.masked.com systemd[1]: Found device /sys/subsystem/net/devices/eth0.
Dec 31 19:00:18 Pogoplug2.masked.com systemd[1]: Started Create Volatile Files and Directories.
Dec 31 19:00:18 Pogoplug2.masked.com systemd[1]: Found device /dev/disk/by-uuid/a41c382f-b4b6-422a-9137-d5b2fa35d718.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Found device /dev/disk/by-uuid/844a0d9c-1f2b-46ec-8183-5aa46a36b3e3.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Activating swap /dev/disk/by-uuid/844a0d9c-1f2b-46ec-8183-5aa46a36b3e3...
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Starting File System Check on /dev/disk/by-uuid/a41c382f-b4b6-422a-9137-d5b2fa35d718...
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Mounting RPC Pipe File System...
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Activated swap /dev/disk/by-uuid/844a0d9c-1f2b-46ec-8183-5aa46a36b3e3.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Mounted RPC Pipe File System.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Found device /dev/disk/by-uuid/6690f764-86f2-4337-8538-afc36b98858a.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Started Update UTMP about System Boot/Shutdown.
Dec 31 19:00:19 Pogoplug2.masked.com systemd-fsck[168]: MAIN_STORAGE: clean, 503060/111476736 files, 304652713/445906944 blocks
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Starting File System Check on /dev/disk/by-uuid/6690f764-86f2-4337-8538-afc36b98858a...
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Starting NFSv4 ID-name mapping service...
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Reached target Swap.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Reached target System Initialization.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Started Daily Cleanup of Temporary Directories.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Listening on Socket for identd (NullidentdMod).
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Listening on RPCbind Server Activation Socket.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Started Daily man-db cache update.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Started Daily rotation of log files.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Listening on D-Bus System Message Bus Socket.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Reached target Sockets.
Dec 31 19:00:19 Pogoplug2.masked.com systemd[1]: Reached target Basic System.
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Starting dhcpcd on eth0...
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Started Periodic Command Scheduler.
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Started Serial Getty on ttyS0.
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Starting Network UPS Tools - script written by Greg to change ownership of usbdev1.6...
Dec 31 19:00:20 Pogoplug2.masked.com rpc.idmapd[178]: rpc.idmapd: Skipping configuration file "/etc/idmapd.conf": No such file or directory
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Started Getty on tty1.
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Reached target Login Prompts.
Dec 31 19:00:20 Pogoplug2.masked.com dhcpcd[181]: eth0: adding address fe80::e9a0:125a:a79a:a7d
Dec 31 19:00:20 Pogoplug2.masked.com crond[182]: (CRON) INFO (RANDOM_DELAY will be scaled with factor 86% if used.)
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Starting RPC bind service...
Dec 31 19:00:20 Pogoplug2.masked.com crond[182]: (CRON) INFO (running with inotify support)
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Starting OpenLDAP server daemon...
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Started Entropy Harvesting Daemon.
Dec 31 19:00:20 Pogoplug2.masked.com systemd[1]: Starting Packet Filtering Framework...
Dec 31 19:00:21 Pogoplug2.masked.com systemd-fsck[177]: BACKUP_STORAGE: clean, 371045/113795072 files, 297760861/455168512 blocks
Dec 31 19:00:21 Pogoplug2.masked.com systemd[1]: Starting GSSAPI Proxy Daemon...
Dec 31 19:00:21 Pogoplug2.masked.com dhcpcd[181]: eth0: waiting for carrier
Dec 31 19:00:21 Pogoplug2.masked.com dhcpcd[181]: eth0: carrier acquired
Dec 31 19:00:21 Pogoplug2.masked.com systemd[1]: Starting MariaDB database server...
Dec 31 19:00:21 Pogoplug2.masked.com slapd[192]: @(#) $OpenLDAP: slapd 2.4.42 (Sep 12 2015 08:56:09) $
builduser@leming:/build/openldap/src/openldap-2.4.42/servers/slapd
Dec 31 19:00:21 Pogoplug2.masked.com systemd[1]: Starting Login Service...
Dec 31 19:00:21 Pogoplug2.masked.com systemd[1]: Started Daily verification of password and group files.
Dec 31 19:00:21 Pogoplug2.masked.com dhcpcd[181]: DUID 00:01:00:01:c7:92:bc:95:00:25:31:04:7f:a4
Dec 31 19:00:21 Pogoplug2.masked.com systemd[1]: Reached target Timers.
Dec 31 19:00:21 Pogoplug2.masked.com dhcpcd[181]: eth0: IAID 31:04:7f:a4
Dec 31 19:00:22 Pogoplug2.masked.com dhcpcd[181]: eth0: soliciting an IPv6 router
Dec 31 19:00:22 Pogoplug2.masked.com systemd[1]: Started File System Check on /dev/disk/by-uuid/a41c382f-b4b6-422a-9137-d5b2fa35d718.
Dec 31 19:00:22 Pogoplug2.masked.com systemd[1]: Started File System Check on /dev/disk/by-uuid/6690f764-86f2-4337-8538-afc36b98858a.
Dec 31 19:00:22 Pogoplug2.masked.com systemd[1]: Started NFSv4 ID-name mapping service.
Dec 31 19:00:22 Pogoplug2.masked.com systemd[1]: Started Network UPS Tools - script written by Greg to change ownership of usbdev1.6.
Dec 31 19:00:22 Pogoplug2.masked.com systemd[1]: Started RPC bind service.
Dec 31 19:00:22 Pogoplug2.masked.com systemd[1]: Started Packet Filtering Framework.
Dec 31 19:00:22 Pogoplug2.masked.com systemd[1]: Started GSSAPI Proxy Daemon.
Dec 31 19:00:22 Pogoplug2.masked.com dhcpcd[181]: eth0: rebinding lease of 192.168.0.24
Dec 31 19:00:22 Pogoplug2.masked.com systemd[1]: Started D-Bus System Message Bus.
Dec 31 19:00:23 Pogoplug2.masked.com slapd[226]: bdb_monitor_db_open: monitoring disabled; configure monitor database to enable
Dec 31 19:00:23 Pogoplug2.masked.com slapd[226]: slapd starting
Dec 31 19:00:23 Pogoplug2.masked.com mysqld[204]: 691231 19:00:23 [Note] /usr/bin/mysqld (mysqld 10.0.21-MariaDB-log) starting as process 204 ...
Dec 31 19:00:24 Pogoplug2.masked.com mysqld[204]: 691231 19:00:24 [Warning] Can't create test file /mnt/HDD/arch/var/lib/mysql/Pogoplug2.lower-test
Dec 31 19:00:24 Pogoplug2.masked.com mysqld[204]: [109B blob data]
Dec 31 19:00:24 Pogoplug2.masked.com mysqld[204]: 691231 19:00:24 [ERROR] Aborting
Dec 31 19:00:24 Pogoplug2.masked.com mysqld[204]: 691231 19:00:24 [Note] /usr/bin/mysqld: Shutdown complete
Dec 31 19:00:24 Pogoplug2.masked.com dbus[224]: [system] Successfully activated service 'org.freedesktop.systemd1'
Dec 31 19:00:24 Pogoplug2.masked.com systemd[1]: Mounting /mnt/MIRRORHD...
Dec 31 19:00:24 Pogoplug2.masked.com systemd[1]: Mounting /mnt/HDD...
Dec 31 19:00:24 Pogoplug2.masked.com systemd[1]: Started OpenLDAP server daemon.
Dec 31 19:00:24 Pogoplug2.masked.com systemd[1]: mysqld.service: Main process exited, code=exited, status=1/FAILURE
Dec 31 19:00:24 Pogoplug2.masked.com systemd-logind[209]: New seat seat0.
Dec 31 19:00:24 Pogoplug2.masked.com systemd[1]: Started Login Service.
Dec 31 19:00:24 Pogoplug2.masked.com systemd[1]: Mounted /mnt/MIRRORHD.
Dec 31 19:00:24 Pogoplug2.masked.com systemd[1]: Mounted /mnt/HDD.
Dec 31 19:00:26 Pogoplug2.masked.com dhcpcd[181]: eth0: probing static address 192.168.0.24/24
Dec 31 19:00:27 Pogoplug2.masked.com haveged[193]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.9.2 CTV); collect: 128K
Dec 31 19:00:27 Pogoplug2.masked.com haveged[193]: haveged: cpu: (); data: 16K (D); inst: 16K (D); idx: 9/40; sz: 16012/69556
Dec 31 19:00:27 Pogoplug2.masked.com haveged[193]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99469
Dec 31 19:00:27 Pogoplug2.masked.com haveged[193]: haveged: fills: 0, generated: 0
Dec 31 19:00:31 Pogoplug2.masked.com dhcpcd[181]: eth0: leased 192.168.0.24 for infinity
Dec 31 19:00:31 Pogoplug2.masked.com dhcpcd[181]: eth0: adding route to 192.168.0.0/24
Dec 31 19:00:31 Pogoplug2.masked.com dhcpcd[181]: eth0: adding default route via 192.168.0.1
Dec 31 19:00:31 Pogoplug2.masked.com dhcpcd[181]: forked to background, child pid 326
Dec 31 19:00:31 Pogoplug2.masked.com systemd[1]: Started dhcpcd on eth0.
Dec 31 19:00:31 Pogoplug2.masked.com systemd[1]: Reached target Network.
Dec 31 19:00:31 Pogoplug2.masked.com systemd[1]: Starting NFS status monitor for NFSv2/3 locking....
Dec 31 19:00:31 Pogoplug2.masked.com systemd[1]: Started pyTivo HMO Server.
Dec 31 19:00:32 Pogoplug2.masked.com systemd[1]: Starting OpenNTP Daemon...
Dec 31 19:00:32 Pogoplug2.masked.com systemd[1]: Starting Pure-FTPd FTP server...
Dec 31 19:00:32 Pogoplug2.masked.com rpc.statd[338]: Version 1.3.3 starting
Dec 31 19:00:32 Pogoplug2.masked.com rpc.statd[338]: Flags: TI-RPC
Dec 31 19:00:32 Pogoplug2.masked.com rpc.statd[338]: Running as root. chown /var/lib/nfs to choose different user
Oct 20 20:42:41 Pogoplug2.masked.com ntpd[336]: constraint certificate verification turned off
Dec 31 19:00:32 Pogoplug2.masked.com ntpd[339]: ntp engine ready
Oct 20 20:42:41 Pogoplug2.masked.com ntpd[336]: set local clock to Tue Oct 20 20:42:41 EDT 2015 (offset 1445388128.928552s)
Oct 20 20:42:41 Pogoplug2.masked.com systemd[1]: Starting Transmission BitTorrent Daemon...
Oct 20 20:42:41 Pogoplug2.masked.com systemd[1]: Started Dovecot IMAP/POP3 email server.
Oct 20 20:42:41 Pogoplug2.masked.com pure-config.pl[337]: Running: /usr/sbin/pure-ftpd -c50 -B -C8 -D -E -fftp -I15 -L10000:8 -m4 -s -U113:022 -u100 -g/run/pure-ftpd.pid -k99 -Z
Oct 20 20:42:41 Pogoplug2.masked.com systemd[1]: Started minidlna server.
Oct 20 20:42:41 Pogoplug2.masked.com systemd[1]: Starting Apache Web Server...
Oct 20 20:42:41 Pogoplug2.masked.com systemd[1]: Starting Webmin...
Oct 20 20:42:41 Pogoplug2.masked.com systemd[1]: Started OpenSSH Daemon.
Oct 20 20:42:42 Pogoplug2.masked.com systemd[1]: Starting NFS Mount Daemon...
Oct 20 20:42:42 Pogoplug2.masked.com systemd[1]: Starting Samba SMB/CIFS server...
Oct 20 20:42:42 Pogoplug2.masked.com systemd[1]: Starting Network UPS Tools - power device driver controller...
Oct 20 20:42:42 Pogoplug2.masked.com systemd[1]: Starting Dynamic DNS Update Client...
Oct 20 20:42:42 Pogoplug2.masked.com systemd[1]: Started netconsole.
Oct 20 20:42:43 Pogoplug2.masked.com start[348]: Starting Webmin server in /opt/webmin
Oct 20 20:42:43 Pogoplug2.masked.com systemd[1]: Starting Postfix Mail Transport Agent...
Oct 20 20:42:43 Pogoplug2.masked.com systemd[1]: Started NFS status monitor for NFSv2/3 locking..
Oct 20 20:42:43 Pogoplug2.masked.com systemd[1]: Started OpenNTP Daemon.
Oct 20 20:42:43 Pogoplug2.masked.com systemd[1]: Started Pure-FTPd FTP server.
Oct 20 20:42:43 Pogoplug2.masked.com systemd[1]: Time has been changed
Oct 20 20:42:44 Pogoplug2.masked.com systemd[1]: Started NFS Mount Daemon.
Oct 20 20:42:44 Pogoplug2.masked.com rpc.mountd[379]: Version 1.3.3 starting
Oct 20 20:42:44 Pogoplug2.masked.com systemd[1]: Starting NFS server and services...
Oct 20 20:42:44 Pogoplug2.masked.com sshd[349]: Server listening on 0.0.0.0 port 22.
Oct 20 20:42:44 Pogoplug2.masked.com sshd[349]: Server listening on :: port 22.
Oct 20 20:42:45 Pogoplug2.masked.com upsdrvctl[359]: Using subdriver: TrippLite HID 0.82
Oct 20 20:42:45 Pogoplug2.masked.com upsdrvctl[359]: Network UPS Tools - Generic HID driver 0.40 (2.7.3.1)
Oct 20 20:42:45 Pogoplug2.masked.com upsdrvctl[359]: USB communication driver 0.32
Oct 20 20:42:45 Pogoplug2.masked.com upsdrvctl[359]: Network UPS Tools - UPS driver controller 2.7.3.1
Oct 20 20:42:45 Pogoplug2.masked.com systemd[1]: Started Network UPS Tools - power device driver controller.
Oct 20 20:42:45 Pogoplug2.masked.com usbhid-ups[393]: Startup successful
Oct 20 20:42:45 Pogoplug2.masked.com systemd[1]: Starting Network UPS Tools - power devices information server...
Oct 20 20:42:45 Pogoplug2.masked.com systemd[1]: Started Transmission BitTorrent Daemon.
Oct 20 20:42:45 Pogoplug2.masked.com systemd[1]: Started NFS server and services.
Oct 20 20:42:45 Pogoplug2.masked.com systemd[1]: Starting Notify NFS peers of a restart...
Oct 20 20:42:45 Pogoplug2.masked.com upsd[394]: fopen /var/state/ups/upsd.pid: No such file or directory
Oct 20 20:42:45 Pogoplug2.masked.com upsd[394]: listening on ::1 port 3493
Oct 20 20:42:45 Pogoplug2.masked.com upsd[394]: listening on 192.168.0.24 port 3493
Oct 20 20:42:45 Pogoplug2.masked.com upsd[394]: listening on 127.0.0.1 port 3493
Oct 20 20:42:45 Pogoplug2.masked.com upsd[394]: Connected to UPS [tripplite]: usbhid-ups-tripplite
Oct 20 20:42:45 Pogoplug2.masked.com upsd[394]: listening on ::1 port 3493
Oct 20 20:42:45 Pogoplug2.masked.com upsd[394]: listening on 192.168.0.24 port 3493
Oct 20 20:42:45 Pogoplug2.masked.com upsd[394]: listening on 127.0.0.1 port 3493
Oct 20 20:42:45 Pogoplug2.masked.com upsd[394]: Connected to UPS [tripplite]: usbhid-ups-tripplite
Oct 20 20:42:46 Pogoplug2.masked.com sm-notify[405]: Version 1.3.3 starting
Oct 20 20:42:46 Pogoplug2.masked.com systemd[1]: Started Network UPS Tools - power devices information server.
Oct 20 20:42:46 Pogoplug2.masked.com upsd[413]: Startup successful
Oct 20 20:42:46 Pogoplug2.masked.com systemd[1]: Starting Network UPS Tools - power device monitor and shutdown controller...
Oct 20 20:42:46 Pogoplug2.masked.com postfix[365]: Postfix is running with backwards-compatible default settings
Oct 20 20:42:46 Pogoplug2.masked.com postfix[365]: See http://www.postfix.org/COMPATIBILITY_README.html for details
Oct 20 20:42:46 Pogoplug2.masked.com postfix[365]: To disable backwards compatibility use "postconf compatibility_level=2" and "postfix reload"
Oct 20 20:42:46 Pogoplug2.masked.com systemd[1]: Started Notify NFS peers of a restart.
Oct 20 20:42:47 Pogoplug2.masked.com upsmon[414]: fopen /var/run/upsmon.pid: No such file or directory
Oct 20 20:42:47 Pogoplug2.masked.com upsmon[414]: UPS: tripplite@localhost (master) (power value 1)
Oct 20 20:42:47 Pogoplug2.masked.com upsmon[414]: Using power down flag file /etc/killpower
Oct 20 20:42:47 Pogoplug2.masked.com systemd[1]: nut-monitor.service: PID file /var/run/upsmon.pid not readable (yet?) after start: No such file or directory
Oct 20 20:42:47 Pogoplug2.masked.com upsmon[416]: Startup successful
Oct 20 20:42:47 Pogoplug2.masked.com systemd[1]: nut-monitor.service: Supervising process 418 which is not our child. We'll most likely not notice when it exits.
Oct 20 20:42:47 Pogoplug2.masked.com systemd[1]: Started Network UPS Tools - power device monitor and shutdown controller.
Oct 20 20:42:47 Pogoplug2.masked.com upsd[413]: User monuser@::1 logged into UPS [tripplite]
Oct 20 20:42:47 Pogoplug2.masked.com dhcpcd[326]: eth0: no IPv6 Routers available
Oct 20 20:42:50 Pogoplug2.masked.com upsd[413]: User monuser@192.168.0.31 logged into UPS [tripplite]
Oct 20 20:42:51 Pogoplug2.masked.com systemd[1]: Started Dynamic DNS Update Client.
Oct 20 20:42:52 Pogoplug2.masked.com systemd[1]: httpd.service: PID file /run/httpd/httpd.pid not readable (yet?) after start: No such file or directory
Oct 20 20:43:00 Pogoplug2.masked.com systemd[1]: Started Postfix Mail Transport Agent.
Oct 20 20:42:54 Pogoplug2.masked.com webmin[348]: Webmin starting
Oct 20 20:43:05 Pogoplug2.masked.com systemd[1]: Started Webmin.
Oct 20 20:42:58 Pogoplug2.masked.com ntpd[339]: peer 38.229.71.1 now valid
Oct 20 20:43:06 Pogoplug2.masked.com systemd[1]: smbd.service: PID file /var/run/smbd.pid not readable (yet?) after start: No such file or directory
Oct 20 20:42:59 Pogoplug2.masked.com postfix/postfix-script[554]: starting the Postfix mail system
Oct 20 20:43:06 Pogoplug2.masked.com systemd[1]: Started Samba SMB/CIFS server.
Oct 20 20:43:00 Pogoplug2.masked.com postfix/master[558]: daemon started -- version 3.0.3, configuration /etc/postfix
Oct 20 20:43:23 Pogoplug2.masked.com systemd[1]: Started Apache Web Server.
Oct 20 20:43:02 Pogoplug2.masked.com ntpd[339]: peer 198.60.22.240 now valid
Oct 20 20:43:04 Pogoplug2.masked.com ntpd[339]: peer 198.110.48.12 now valid
Oct 20 20:43:05 Pogoplug2.masked.com ntpd[339]: peer 66.228.42.59 now valid
Oct 20 20:43:10 Pogoplug2.masked.com smbd[604]: [2015/10/20 20:43:09.765361, 0] ../lib/util/become_daemon.c:124(daemon_ready)
Oct 20 20:43:10 Pogoplug2.masked.com smbd[604]: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Oct 20 20:43:10 Pogoplug2.masked.com smbd[604]: [2015/10/20 20:43:10.190416, 0] ../source3/lib/util_sock.c:357(open_socket_in)
Oct 20 20:43:10 Pogoplug2.masked.com smbd[604]: open_socket_in(): setsockopt: SO_REUSEPORT = true on port 445 failed with error = Protocol not available
Oct 20 20:43:25 Pogoplug2.masked.com dbus[224]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service'
Oct 20 20:43:26 Pogoplug2.masked.com dbus[224]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.Avahi.service': Unit dbus-org.freedesktop.Avahi.service failed to load: No such file or directory.
Oct 20 20:43:26 Pogoplug2.masked.com start[348]: Pre-loaded WebminCore
Oct 20 20:43:26 Pogoplug2.masked.com minidlnad[345]: minidlna.c:1030: warn: Starting MiniDLNA version 1.1.5.
Oct 20 20:43:26 Pogoplug2.masked.com minidlnad[345]: sql.c:41: error: SQL ERROR 8 [attempt to write a readonly database]
Oct 20 20:43:26 Pogoplug2.masked.com minidlnad[345]: pragma default_cache_size = 8192;
Oct 20 20:43:26 Pogoplug2.masked.com minidlnad[345]: minidlna.c:1070: warn: HTTP listening on port 8200
Oct 20 20:43:26 Pogoplug2.masked.com minidlnad[345]: inotify.c:92: error: inotify_add_watch(/mnt/HDD/Archive/Music/Alison_Krauss_&_Union_Station_CD_1-Live_) [Permission denied]
Oct 20 20:43:26 Pogoplug2.masked.com minidlnad[345]: inotify.c:92: error: inotify_add_watch(/mnt/HDD/Archive/Music/Alison_Krauss_&_Union_Station_CD_2-Live_) [Permission denied]
Oct 20 20:43:26 Pogoplug2.masked.com minidlnad[345]: inotify.c:92: error: inotify_add_watch(/mnt/HDD/Archive/Music/LeAnn_Rimes-Blue) [Permission denied]
Oct 20 20:43:26 Pogoplug2.masked.com pyTivo.py[328]: INFO:pyTivo:Last modified: Mon Oct 19 08:57:55 2015
Oct 20 20:43:27 Pogoplug2.masked.com pyTivo.py[328]: INFO:pyTivo:Python: 2.7.10
Oct 20 20:43:27 Pogoplug2.masked.com pyTivo.py[328]: INFO:pyTivo:System: Linux-3.1.10-35-ARCH-armv5tel-with-glibc2.4
Oct 20 20:43:27 Pogoplug2.masked.com pyTivo.py[328]: INFO:pyTivo:NOTE: httpserver.py modified so as to remove logging of GET mesages from Tivo
Oct 20 20:43:27 Pogoplug2.masked.com pyTivo.py[328]: INFO:pyTivo.beacon:Scanning for TiVos...
Oct 20 20:43:27 Pogoplug2.masked.com pyTivo.py[328]: INFO:pyTivo.beacon:Fred
Oct 20 20:43:27 Pogoplug2.masked.com pyTivo.py[328]: INFO:pyTivo.beacon:Announcing shares...
Oct 20 20:43:27 Pogoplug2.masked.com pyTivo.py[328]: INFO:pyTivo:pyTivo is ready.
Oct 20 20:43:29 Pogoplug2.masked.com sshd[725]: fatal: Access denied for user gregbert by PAM account configuration [preauth]
Oct 20 20:44:00 Pogoplug2.masked.com sshd[971]: fatal: Access denied for user gregbert by PAM account configuration [preauth]
Oct 20 20:44:00 Pogoplug2.masked.com systemd[1]: mysqld.service: Start-post operation timed out. Stopping.
Oct 20 20:44:00 Pogoplug2.masked.com systemd[1]: Failed to start MariaDB database server.
Oct 20 20:44:00 Pogoplug2.masked.com systemd[1]: mysqld.service: Unit entered failed state.
Oct 20 20:44:00 Pogoplug2.masked.com systemd[1]: mysqld.service: Failed with result 'timeout'.
Oct 20 20:44:00 Pogoplug2.masked.com systemd[1]: Reached target Multi-User System.
Oct 20 20:44:00 Pogoplug2.masked.com systemd[1]: Reached target Graphical Interface.
Oct 20 20:44:00 Pogoplug2.masked.com systemd[1]: Startup finished in 4.360s (kernel) + 1min 47.499s (userspace) = 1min 51.860s.
Oct 20 20:44:00 Pogoplug2.masked.com systemd[1]: mysqld.service: Service hold-off time over, scheduling restart.
Oct 20 20:44:00 Pogoplug2.masked.com systemd[1]: Stopped MariaDB database server.
Oct 20 20:44:01 Pogoplug2.masked.com systemd[1]: Starting MariaDB database server...
Oct 20 20:44:01 Pogoplug2.masked.com mysqld[998]: 151020 20:44:01 [Note] /usr/bin/mysqld (mysqld 10.0.21-MariaDB-log) starting as process 998 ...
Oct 20 20:44:02 Pogoplug2.masked.com mysqld[998]: 151020 20:44:02 [Note] InnoDB: Using mutexes to ref count buffer pool pages
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:02 [Note] InnoDB: The InnoDB memory heap is disabled
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:02 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:02 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:02 [Note] InnoDB: Compressed tables use zlib 1.2.8
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:02 [Note] InnoDB: Using Linux native AIO
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:02 [Note] InnoDB: Not using CPU crc32 instructions
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:02 [Note] InnoDB: Initializing buffer pool, size = 128.0M
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:02 [Note] InnoDB: Completed initialization of buffer pool
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:03 [Note] InnoDB: Highest supported file format is Barracuda.
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:06 [Note] InnoDB: 128 rollback segment(s) are active.
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:06 [Note] InnoDB: Waiting for purge to start
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:06 [Note] InnoDB: Percona XtraDB (http://www.percona.com) 5.6.25-73.1 started; log sequence number 229982848
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:06 [Note] Plugin 'FEEDBACK' is disabled.
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:09 [Note] Server socket created on IP: '::'.
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:10 [Warning] 'proxies_priv' entry '@% root@pogoplug2' ignored in --skip-name-resolve mode.
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:11 [Note] Event Scheduler: Loaded 0 events
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: 151020 20:44:11 [Note] /usr/bin/mysqld: ready for connections.
Oct 20 20:44:13 Pogoplug2.masked.com mysqld[998]: Version: '10.0.21-MariaDB-log' socket: '/run/mysqld/mysqld.sock' port: 3306 MariaDB Server
Oct 20 20:44:13 Pogoplug2.masked.com systemd[1]: Started MariaDB database server.
Oct 20 20:44:16 Pogoplug2.masked.com postfix/smtpd[1064]: connect from unknown[123.45.678.98]
Oct 20 20:44:28 Pogoplug2.masked.com sshd[1073]: Invalid user pi from 192.168.0.31
Oct 20 20:44:28 Pogoplug2.masked.com sshd[1073]: input_userauth_request: invalid user pi [preauth]
Oct 20 20:44:28 Pogoplug2.masked.com sshd[1073]: Connection closed by 192.168.0.31 [preauth]
Oct 20 20:44:28 Pogoplug2.masked.com postfix/smtpd[1064]: lost connection after EHLO from unknown[123.45.678.98]
Oct 20 20:44:28 Pogoplug2.masked.com postfix/smtpd[1064]: disconnect from unknown[123.45.678.98] ehlo=0/1 commands=0/1
Oct 20 20:44:28 Pogoplug2.masked.com postfix/smtpd[1064]: connect from unknown[123.45.678.98]
Oct 20 20:44:29 Pogoplug2.masked.com postfix/smtpd[1064]: lost connection after UNKNOWN from unknown[123.45.678.98]
Oct 20 20:44:29 Pogoplug2.masked.com postfix/smtpd[1064]: disconnect from unknown[123.45.678.98] unknown=0/1 commands=0/1
Oct 20 20:44:37 Pogoplug2.masked.com sshd[1075]: fatal: Access denied for user gregbert by PAM account configuration [preauth]
Oct 20 20:44:58 Pogoplug2.masked.com ntpd[339]: clock is now synced
Oct 20 20:45:07 Pogoplug2.masked.com ntpd[339]: peer 38.229.71.1 now invalid
Oct 20 20:45:16 Pogoplug2.masked.com webmin[1089]: Successful login as root from 192.168.0.178
Oct 20 20:46:16 Pogoplug2.masked.com ntpd[339]: peer 198.60.22.240 now invalid
Oct 20 20:46:17 Pogoplug2.masked.com ntpd[339]: peer 66.228.42.59 now invalid
Oct 20 20:46:18 Pogoplug2.masked.com ntpd[339]: peer 198.110.48.12 now invalid
Oct 20 20:46:44 Pogoplug2.masked.com webmin[1150]: Successful login as root from 192.168.0.178
Oct 20 20:47:10 Pogoplug2.masked.com sshd[1193]: Accepted publickey for gregbert from 192.168.0.1 port 51676 ssh2: RSA SHA256:bKUKjN8jeEf2T/WIe6x3BUVwDLtPbe8ZgmWSpjj8/AI
Oct 20 20:47:10 Pogoplug2.masked.com sshd[1193]: pam_unix(sshd:session): session opened for user gregbert by (uid=0)
Oct 20 20:47:10 Pogoplug2.masked.com systemd[1]: Created slice user-1000.slice.
Oct 20 20:47:10 Pogoplug2.masked.com systemd-logind[209]: New session c1 of user gregbert.
Oct 20 20:47:10 Pogoplug2.masked.com systemd[1]: Started Session c1 of user gregbert.
Oct 20 20:47:10 Pogoplug2.masked.com systemd[1]: Starting User Manager for UID 1000...
Oct 20 20:47:10 Pogoplug2.masked.com systemd[1195]: pam_unix(systemd-user:session): session opened for user gregbert by (uid=0)
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Failed to make us a subreaper: Invalid argument
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Reached target Paths.
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Starting Set Environment DBUS_SESSION_BUS_ADDRESS...
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Reached target Timers.
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Started Set Environment DBUS_SESSION_BUS_ADDRESS.
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Listening on D-Bus User Message Bus Socket.
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Reached target Sockets.
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Reached target Basic System.
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Reached target Default.
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1195]: Startup finished in 844ms.
Oct 20 20:47:11 Pogoplug2.masked.com systemd[1]: Started User Manager for UID 1000.
Oct 20 20:47:34 Pogoplug2.masked.com sudo[1288]: gregbert : TTY=pts/0 ; PWD=/home/gregbert ; USER=root ; COMMAND=/usr/bin/encfs /mnt/HDD/.Backups_enc /mnt/HDD/Backups --public -o kernel_cache
Oct 20 20:47:34 Pogoplug2.masked.com sudo[1288]: pam_unix(sudo:session): session opened for user root by gregbert(uid=0)
Oct 20 20:47:37 Pogoplug2.masked.com sudo[1288]: pam_unix(sudo:session): session closed for user root
Oct 20 20:47:37 Pogoplug2.masked.com systemd[1]: Mounting FUSE Control File System...
Oct 20 20:47:37 Pogoplug2.masked.com systemd[1]: Mounted FUSE Control File System.
Oct 20 20:47:41 Pogoplug2.masked.com systemd[1]: Created slice system-nullidentdmod.slice.
Oct 20 20:47:42 Pogoplug2.masked.com systemd[1]: Started NullidentdMod service (67.218.118.62:20599).
Oct 20 20:47:42 Pogoplug2.masked.com systemd[1]: Started NullidentdMod service (82.96.64.4:46684).
Oct 20 20:47:49 Pogoplug2.masked.com postfix/anvil[1066]: statistics: max connection rate 2/60s for (smtp:123.45.678.98) at Oct 20 20:44:28
Oct 20 20:47:49 Pogoplug2.masked.com postfix/anvil[1066]: statistics: max connection count 1 for (smtp:123.45.678.98) at Oct 20 20:44:16
Oct 20 20:47:49 Pogoplug2.masked.com postfix/anvil[1066]: statistics: max cache size 1 at Oct 20 20:44:16
Oct 20 20:50:07 Pogoplug2.masked.com ntpd[339]: 0 out of 4 peers valid
Oct 20 20:50:07 Pogoplug2.masked.com ntpd[339]: bad peer from pool pool.ntp.org (198.60.22.240)
Oct 20 20:50:07 Pogoplug2.masked.com ntpd[339]: bad peer from pool pool.ntp.org (66.228.42.59)
Oct 20 20:50:07 Pogoplug2.masked.com ntpd[339]: bad peer from pool pool.ntp.org (198.110.48.12)
Oct 20 20:50:07 Pogoplug2.masked.com ntpd[339]: bad peer from pool pool.ntp.org (38.229.71.1)
Oct 20 20:50:26 Pogoplug2.masked.com ntpd[339]: peer 38.229.71.1 now valid
Oct 20 20:50:35 Pogoplug2.masked.com ntpd[339]: clock is now unsynced
Oct 20 20:51:36 Pogoplug2.masked.com ntpd[339]: peer 66.228.42.59 now valid
Oct 20 20:51:38 Pogoplug2.masked.com ntpd[339]: peer 198.60.22.240 now valid
Oct 20 20:51:41 Pogoplug2.masked.com ntpd[339]: peer 198.110.48.12 now valid
Oct 20 20:52:56 Pogoplug2.masked.com ntpd[339]: clock is now synced
Oct 20 20:57:10 Pogoplug2.masked.com systemd[1]: Starting Cleanup of Temporary Directories...
Oct 20 20:57:12 Pogoplug2.masked.com postfix/smtpd[1627]: connect from unknown[123.45.678.98]
Oct 20 20:57:15 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest@nmap.scanme.org>: Relay access denied; from=<> to=<relaytest@nmap.scanme.org> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:15 Pogoplug2.masked.com systemd[1]: Started Cleanup of Temporary Directories.
Oct 20 20:57:16 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest@nmap.scanme.org>: Relay access denied; from=<antispam@nmap.scanme.org> to=<relaytest@nmap.scanme.org> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:17 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest@nmap.scanme.org>: Relay access denied; from=<antispam@masked.com> to=<relaytest@nmap.scanme.org> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:19 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest@nmap.scanme.org>: Relay access denied; from=<antispam@[100.0.197.110]> to=<relaytest@nmap.scanme.org> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:23 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest%nmap.scanme.org@[100.0.197.110]>: Relay access denied; from=<antispam@[100.0.197.110]> to=<relaytest%nmap.scanme.org@[100.0.197.110]> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:27 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest%nmap.scanme.org@masked.com>: Relay access denied; from=<antispam@[100.0.197.110]> to=<relaytest%nmap.scanme.org@masked.com> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:31 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest@nmap.scanme.org>: Relay access denied; from=<antispam@[100.0.197.110]> to=<relaytest@nmap.scanme.org> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:35 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest%nmap.scanme.org>: Relay access denied; from=<antispam@[100.0.197.110]> to=<relaytest%nmap.scanme.org> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:39 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest@nmap.scanme.org@[100.0.197.110]>: Relay access denied; from=<antispam@[100.0.197.110]> to=<relaytest@nmap.scanme.org@[100.0.197.110]> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:43 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest@nmap.scanme.org@[100.0.197.110]>: Relay access denied; from=<antispam@[100.0.197.110]> to=<relaytest@nmap.scanme.org@[100.0.197.110]> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:44 Pogoplug2.masked.com sudo[1625]: pam_unix(sudo:session): session closed for user root
Oct 20 20:57:47 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest@nmap.scanme.org@masked.com>: Relay access denied; from=<antispam@[100.0.197.110]> to=<relaytest@nmap.scanme.org@masked.com> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:51 Pogoplug2.masked.com postfix/smtpd[1627]: NOQUEUE: reject: RCPT from unknown[123.45.678.98]: 554 5.7.1 <relaytest@nmap.scanme.org>: Relay access denied; from=<antispam@[100.0.197.110]> to=<relaytest@nmap.scanme.org> proto=ESMTP helo=<nmap.scanme.org>
Oct 20 20:57:53 Pogoplug2.masked.com postfix/smtpd[1627]: too many errors after RCPT from unknown[123.45.678.98]
Oct 20 20:57:53 Pogoplug2.masked.com postfix/smtpd[1627]: disconnect from unknown[123.45.678.98] ehlo=1 mail=12 rcpt=0/12 rset=12 commands=25/37
')
Last edited by gregbert on Wed Jan 20, 2016 3:48 pm, edited 1 time in total.
gregbert
 
Posts: 37
Joined: Sat Mar 17, 2012 4:03 pm

Re: /var/run/nologin created but not removed - users cant lo

Postby WarheadsSE » Wed Oct 21, 2015 12:03 pm

We have noticed this on a few installations. What I am seeing is that systemd-tmpfiles makes this when the --boot is used (during boot), and it is expected that systemd-user-sessions.service will be tripped, removing this file. However, for some reason, multi-user.target is not tripping systemd-user-sessions.service. I am still looking into this myself.

$this->bbcode_second_pass_code('', '
[root@nsa320 boot] # systemctl list-dependencies systemd-user-sessions --reverse
systemd-user-sessions.service

[whse@arch-x64 ~]$ systemctl list-dependencies systemd-user-sessions --reverse
systemd-user-sessions.service
● └─multi-user.target
● └─graphical.target
')
Core Developer
Remember: Arch Linux ARM is entirely community donation supported!
WarheadsSE
Developer
 
Posts: 6807
Joined: Mon Oct 18, 2010 2:12 pm

Re: /var/run/nologin created but not removed - users cant lo

Postby planeteater » Wed Oct 21, 2015 6:02 pm

I too got hit by this, and also got these "Cannot add dependency..." messages in the log described in this topic:
http://archlinuxarm.org/forum/viewtopic.php?f=58&t=9411
Another symptom I noticed that there was no /dev/disk directory, despite all udev related services being in green (active) status.
After downgrading to systemd-226-3, everything went back to normal.
planeteater
 
Posts: 26
Joined: Sat Dec 29, 2012 2:44 pm

Re: /var/run/nologin created but not removed - users cant lo

Postby WarheadsSE » Wed Oct 21, 2015 6:36 pm

That (/dev/disk) is a particular system I had not noticed yet. But you're correct.
Core Developer
Remember: Arch Linux ARM is entirely community donation supported!
WarheadsSE
Developer
 
Posts: 6807
Joined: Mon Oct 18, 2010 2:12 pm

Re: /var/run/nologin created but not removed - users cant lo

Postby gregbert » Mon Oct 26, 2015 10:30 pm

my /dev/disk directory continues to exist... for the moment :-)
gregbert
 
Posts: 37
Joined: Sat Mar 17, 2012 4:03 pm

Re: /var/run/nologin created but not removed - users cant lo

Postby gregbert » Mon Oct 26, 2015 10:37 pm

and this was fascinating warning on my next pacman -Syu.. did we revert to 226-3.2 systemd from 227-1?

-------------------------------------------

gregbert@Pogoplug2 /mnt/HDD/Downloads % sudo pacman -Syu
:: Synchronizing package databases...
core is up to date
extra is up to date
community is up to date
alarm is up to date
aur is up to date
:: Starting full system upgrade...
warning: libsystemd: local (227-1) is newer than core (226-3.2)
warning: systemd: local (227-1) is newer than core (226-3.2)
warning: systemd-sysvcompat: local (227-1) is newer than core (226-3.2)
resolving dependencies...
looking for conflicting packages...
gregbert
 
Posts: 37
Joined: Sat Mar 17, 2012 4:03 pm

Re: /var/run/nologin created but not removed - users cant lo

Postby Kabbone » Tue Oct 27, 2015 9:27 am

Yes, because there were some problems with 227-1. See this Thread http://archlinuxarm.org/forum/viewtopic.php?f=57&t=9394&start=30 for further information.
Kabbone
 
Posts: 153
Joined: Thu Jul 25, 2013 9:20 am

Re: /var/run/nologin created but not removed - users cant lo

Postby gregbert » Tue Oct 27, 2015 1:38 pm

thanks for pointing that thread out. Its a similar issue (can't ssh in), but i gather for different reasons b/c at least one person reports not ipv4 address being assigned. though tempting to think these two issues might be connected. Guess i'll just have to wait this out with everyone else.
gregbert
 
Posts: 37
Joined: Sat Mar 17, 2012 4:03 pm

Re: /var/run/nologin created but not removed - users cant lo

Postby Kabbone » Tue Oct 27, 2015 5:59 pm

I don't konw if it's connected. I just wanted to point to the probably reason for reverting from 227
Kabbone
 
Posts: 153
Joined: Thu Jul 25, 2013 9:20 am

Re: /var/run/nologin created but not removed - users cant lo

Postby gregbert » Sun Dec 06, 2015 5:21 pm

the latest upgrade, which included systemd 228-3, has resolved this issue for me.
gregbert
 
Posts: 37
Joined: Sat Mar 17, 2012 4:03 pm

Next

Return to ARMv5

Who is online

Users browsing this forum: No registered users and 7 guests