· 6 years ago · Nov 18, 2019, 06:04 PM
1reading config from /root/teslausb_setup_variables.conf
2====== summary ======
3hardware: Raspberry Pi Zero W Rev 1.1
4OS: Raspbian GNU/Linux 9 (stretch)
5headless setup config in /root
6archive method: rsync
7lun0 connected, from file /backingfiles/music_disk.bin
8lun1 connected, from file /backingfiles/cam_disk.bin
91 snapshots mounted
10====== disk / images ======
11Model: SD SC200 (sd/mmc)
12Disk /dev/mmcblk0: 197GB
13Sector size (logical/physical): 512B/512B
14Partition Table: msdos
15Disk Flags:
16Number Start End Size Type File system Flags
17 1 4194kB 50.7MB 46.5MB primary fat32 lba
18 2 54.5MB 1825MB 1770MB primary ext4
19 3 1825MB 197GB 195GB primary xfs
20 4 197GB 197GB 105MB primary ext4
21cam disk image has 13 extents
22Model: (file)
23Disk /backingfiles/cam_disk.bin: 74.8GB
24Sector size (logical/physical): 512B/512B
25Partition Table: msdos
26Disk Flags:
27Number Start End Size Type File system Flags
28 1 1049kB 74.8GB 74.8GB primary fat32 lba
29music disk image has 17 extents
30Model: (file)
31Disk /backingfiles/music_disk.bin: 112GB
32Sector size (logical/physical): 512B/512B
33Partition Table: msdos
34Disk Flags:
35Number Start End Size Type File system Flags
36 1 1049kB 112GB 112GB primary fat32 lba
37====== network ======
38lo: flags=73<UP,LOOPBACK,RUNNING> mtu 65536
39 inet 127.0.0.1 netmask 255.0.0.0
40 inet6 ::1 prefixlen 128 scopeid 0x10<host>
41 loop txqueuelen 1000 (Local Loopback)
42 RX packets 24 bytes 5248 (5.1 KiB)
43 RX errors 0 dropped 0 overruns 0 frame 0
44 TX packets 24 bytes 5248 (5.1 KiB)
45 TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
46wlan0: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1500
47 inet 192.168.0.81 netmask 255.255.255.0 broadcast 192.168.0.255
48 inet6 fe80::485a:e3ae:8a1c:ebc7 prefixlen 64 scopeid 0x20<link>
49 ether b8:27:eb:57:09:6c txqueuelen 1000 (Ethernet)
50 RX packets 1614 bytes 190849 (186.3 KiB)
51 RX errors 0 dropped 0 overruns 0 frame 0
52 TX packets 1405 bytes 163777 (159.9 KiB)
53 TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
54 Link Quality=63/70 Signal level=-47 dBm
55====== fstab ======
56proc /proc proc defaults 0 0
57PARTUUID=22eddddb-01 /boot vfat defaults,ro 0 2
58PARTUUID=22eddddb-02 / ext4 defaults,noatime,ro 0 1
59# a swapfile is not a swap partition, no line here
60# use dphys-swapfile swap[on|off] for that
61LABEL=backingfiles /backingfiles xfs auto,rw,noatime 0 2
62LABEL=mutable /mutable ext4 auto,rw 0 2
63/backingfiles/cam_disk.bin /mnt/cam vfat utf8,noauto,users,umask=000,offset=1048576 0 0
64/backingfiles/music_disk.bin /mnt/music vfat utf8,noauto,users,umask=000,offset=1048576 0 0
65tmpfs /var/run/samba tmpfs nodev,nosuid 0 0
66tmpfs /var/cache/samba tmpfs nodev,nosuid 0 0
67tmpfs /mnt/smbexport tmpfs nodev,nosuid 0 0
68tmpfs /var/log tmpfs nodev,nosuid 0 0
69tmpfs /var/tmp tmpfs nodev,nosuid 0 0
70tmpfs /tmp tmpfs nodev,nosuid 0 0
71====== initial setup boot log ======
72[ OK ] Started Show Plymouth Boot Screen.
73[ OK ] Started Forward Password Requests to Plymouth Directory Watch.
74[ OK ] Reached target Encrypted Volumes.
75[ OK ] Reached target Paths.
76[ OK ] Found device /dev/serial1.
77[ OK ] Found device /dev/disk/by-partuuid/22eddddb-01.
78 Starting File System Check on /dev/disk/by-partuuid/22eddddb-01...
79[ OK ] Started File System Check on /dev/disk/by-partuuid/22eddddb-01.
80 Mounting /boot...
81[ OK ] Mounted /boot.
82[ OK ] Reached target Local File Systems.
83 Starting Preprocess NFS configuration...
84 Starting Tell Plymouth To Write Out Runtime Data...
85 Starting Raise network interfaces...
86 Starting Set console font and keymap...
87 Starting Create Volatile Files and Directories...
88[ OK ] Started Preprocess NFS configuration.
89[ OK ] Started Tell Plymouth To Write Out Runtime Data.
90[ OK ] Started Set console font and keymap.
91[ OK ] Reached target NFS client services.
92[ OK ] Reached target Remote File Systems (Pre).
93[ OK ] Reached target Remote File Systems.
94[ OK ] Started Create Volatile Files and Directories.
95 Starting Network Time Synchronization...
96 Starting Update UTMP about System Boot/Shutdown...
97[ OK ] Started Update UTMP about System Boot/Shutdown.
98[ OK ] Started Network Time Synchronization.
99[ OK ] Reached target System Time Synchronized.
100[ OK ] Reached target System Initialization.
101[ OK ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
102[ OK ] Listening on D-Bus System Message Bus Socket.
103[ OK ] Started Daily Cleanup of Temporary Directories.
104[ OK ] Listening on triggerhappy.socket.
105[ OK ] Reached target Sockets.
106[ OK ] Reached target Basic System.
107 Starting LSB: Autogenerate and use a swap file...
108 Starting Disable WiFi if country not set...
109 Starting Avahi mDNS/DNS-SD Stack...
110 Starting Login Service...
111 Starting Save/Restore Sound Card State...
112[ OK ] Started Regular background program processing daemon.
113[ OK ] Started D-Bus System Message Bus.
114[ OK ] Started Avahi mDNS/DNS-SD Stack.
115 Starting WPA supplicant...
116 Starting Configure Bluetooth Modems connected by UART...
117 Starting System Logging Service...
118 Starting dhcpcd on all interfaces...
119 Starting LSB: Switch to ondemand cpu…or (unless shift key is pressed)...
120 Starting triggerhappy global hotkey daemon...
121[ OK ] Started Daily apt download activities.
122[ OK ] Started Daily apt upgrade and clean activities.
123[ OK ] Reached target Timers.
124 Starting rng-tools.service...
125[ OK ] Started triggerhappy global hotkey daemon.
126[ OK ] Started System Logging Service.
127[ OK ] Started Disable WiFi if country not set.
128[ OK ] Started Save/Restore Sound Card State.
129[ OK ] Started rng-tools.service.
130[ OK ] Started WPA supplicant.
131[ OK ] Started Login Service.
132[ OK ] Started LSB: Switch to ondemand cpu …rnor (unless shift key is pressed).
133[ OK ] Started LSB: Autogenerate and use a swap file.
134[ OK ] Started Raise network interfaces.
135[ OK ] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
136 Starting Load/Save RF Kill Switch Status...
137[ OK ] Reached target Sound Card.
138[ OK ] Started Load/Save RF Kill Switch Status.
139[ OK ] Started Configure Bluetooth Modems connected by UART.
140 Starting Bluetooth service...
141[ OK ] Created slice system-bthelper.slice.
142[ OK ] Started Bluetooth service.
143[ OK ] Reached target Bluetooth.
144[ OK ] Started Raspberry Pi bluetooth helper.
145 Starting Hostname Service...
146[ OK ] Started Hostname Service.
147[ OK ] Started dhcpcd on all interfaces.
148[ OK ] Reached target Network.
149 Starting OpenBSD Secure Shell server...
150 Starting /etc/rc.local Compatibility...
151 Starting Permit User Sessions...
152My IP address is 192.168.0.81
153[ OK ] Started Permit User Sessions.
154Detecting whether to update wpa_supplicant.conf
155Starting setup.
156reading config from /root/teslausb_setup_variables.conf
157[ OK ] Started OpenBSD Secure Shell server.
158[ OK ] Reached target Network is Online.
159 Starting Daily apt download activities...
160/root/bin/setup-teslausb is up to date
161Updating package index files...
1620% [Working]
163Get:1 http://archive.raspberrypi.org/debian stretch InRelease [25.4 kB]
1640% [Connecting to raspbian.raspberrypi.org] [1 InRelease 0 B/25.4 kB 0%]
1650% [Connecting to raspbian.raspberrypi.org]
166Get:2 http://raspbian.raspberrypi.org/raspbian stretch InRelease [15.0 kB]
1670% [Working]
1680% [1 InRelease gpgv 25.4 kB]
1690% [1 InRelease gpgv 25.4 kB]
1700% [1 InRelease gpgv 25.4 kB]
1710% [1 InRelease gpgv 25.4 kB]
1720% [1 InRelease gpgv 25.4 kB]
1730% [Working]
1740% [2 InRelease gpgv 15.0 kB] [Connecting to archive.raspberrypi.org (93.93.130.1
175Get:3 http://archive.raspberrypi.org/debian stretch/main armhf Packages [220 kB]
1760% [2 InRelease gpgv 15.0 kB] [3 Packages 0 B/220 kB 0%]
1770% [2 InRelease gpgv 15.0 kB]
1780% [3 Packages store 0 B] [2 InRelease gpgv 15.0 kB]
1790% [3 Packages store 0 B] [2 InRelease gpgv 15.0 kB]
1800% [2 InRelease gpgv 15.0 kB]
1810% [2 InRelease gpgv 15.0 kB]
1820% [2 InRelease gpgv 15.0 kB]
1830% [2 InRelease gpgv 15.0 kB]
18420% [Working]
185Get:4 http://raspbian.raspberrypi.org/raspbian stretch/main armhf Packages [11.7 MB]
18620% [4 Packages 0 B/11.7 MB 0%]
18725% [4 Packages 683 kB/11.7 MB 6%] 148 kB/s 1min 14s
18830% [4 Packages 1,442 kB/11.7 MB 12%] 148 kB/s 1min 9s
18935% [4 Packages 2,162 kB/11.7 MB 19%] 148 kB/s 1min 4s
19041% [4 Packages 3,145 kB/11.7 MB 27%] 148 kB/s 57s
19148% [4 Packages 4,194 kB/11.7 MB 36%] 148 kB/s 50s
19254% [4 Packages 5,112 kB/11.7 MB 44%] 148 kB/s 44s
19360% [4 Packages 5,898 kB/11.7 MB 51%] 148 kB/s 39s
19464% [4 Packages 6,619 kB/11.7 MB 57%] 148 kB/s 34s
19571% [4 Packages 7,610 kB/11.7 MB 65%] 148 kB/s 27s
19676% [4 Packages 8,388 kB/11.7 MB 72%] 148 kB/s 22s
19781% [4 Packages 9,109 kB/11.7 MB 78%] 148 kB/s 17s[ OK ] Created slice User Slice of pi.
198 Starting User Manager for UID 1000...
199[ OK ] Started Session c1 of user pi.
20085% [4 Packages 9,699 kB/11.7 MB 83%] 148 kB/s 13s
20193% [4 Packages 10.9 MB/11.7 MB 93%] 1,654 kB/s 0s[ OK ] Started User Manager for UID 1000.
20298% [Working] 1,654 kB/s 0s
20398% [4 Packages store 0 B] 1,654 kB/s 0s
204Get:5 http://raspbian.raspberrypi.org/raspbian stretch/contrib armhf Packages [56.9 kB]
20598% [4 Packages store 0 B] [5 Packages 0 B/56.9 kB 0%] 1,654 kB/s 0s
20698% [4 Packages store 0 B] 1,654 kB/s 0s
20798% [4 Packages store 0 B] 1,654 kB/s 0s
20898% [4 Packages store 0 B] 1,654 kB/s 0s
20998% [4 Packages store 0 B] 1,654 kB/s 0s
21098% [4 Packages store 0 B] 1,654 kB/s 0s
21198% [4 Packages store 0 B] 1,654 kB/s 0s
21298% [4 Packages store 0 B] 1,654 kB/s 0s
21398% [4 Packages store 0 B] 1,654 kB/s 0s
21498% [4 Packages store 0 B] 1,654 kB/s 0s
21598% [4 Packages store 0 B] 1,654 kB/s 0s
21698% [4 Packages store 0 B] 1,654 kB/s 0s
21798% [4 Packages store 0 B] 136 kB/s 0s
21898% [4 Packages store 0 B] 136 kB/s 0s
21998% [4 Packages store 0 B] 136 kB/s 0s
22098% [4 Packages store 0 B] 136 kB/s 0s
22198% [4 Packages store 0 B] 136 kB/s 0s
22298% [4 Packages store 0 B] 136 kB/s 0s
22398% [4 Packages store 0 B] 136 kB/s 0s
22498% [4 Packages store 0 B] 136 kB/s 0s
22598% [4 Packages store 0 B] 136 kB/s 0s
22698% [4 Packages store 0 B] 136 kB/s 0s
22798% [4 Packages store 0 B] 136 kB/s 0s
22898% [4 Packages store 0 B] 136 kB/s 0s
22998% [4 Packages store 0 B]
23098% [4 Packages store 0 B]
23198% [4 Packages store 0 B]
23298% [4 Packages store 0 B]
23398% [4 Packages store 0 B]
23498% [4 Packages store 0 B]
23598% [4 Packages store 0 B]
23698% [4 Packages store 0 B]
23798% [4 Packages store 0 B]
23898% [4 Packages store 0 B]
23998% [4 Packages store 0 B]
24098% [4 Packages store 0 B]
24198% [4 Packages store 0 B]
24298% [4 Packages store 0 B]
24398% [4 Packages store 0 B]
24498% [4 Packages store 0 B]
24598% [4 Packages store 0 B]
24698% [4 Packages store 0 B]
24798% [4 Packages store 0 B]
24898% [4 Packages store 0 B]
24998% [4 Packages store 0 B]
25098% [4 Packages store 0 B]
25198% [4 Packages store 0 B]
25298% [4 Packages store 0 B]
25398% [4 Packages store 0 B]
25498% [4 Packages store 0 B]
25598% [4 Packages store 0 B]
25698% [4 Packages store 0 B]
25798% [4 Packages store 0 B]
25898% [4 Packages store 0 B]
25998% [4 Packages store 0 B]
26098% [4 Packages store 0 B]
26198% [4 Packages store 0 B]
26298% [4 Packages store 0 B]
26398% [4 Packages store 0 B]
26498% [4 Packages store 0 B]
26598% [4 Packages store 0 B]
26698% [4 Packages store 0 B]
26798% [4 Packages store 0 B]
26898% [4 Packages store 0 B]
26998% [4 Packages store 0 B]
27099% [Working]
27199% [5 Packages store 0 B]
272100% [Working]
273Fetched 12.0 MB in 45s (264 kB/s)
274[ OK ] Started Daily apt download activities.
275 Starting Daily apt upgrade and clean activities...
276[ OK ] Started Daily apt upgrade and clean activities.
277Verifying that the requested configuration is valid...
278curl -o /tmp/verify-configuration.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/verify-configuration.sh
279[ 140.545576] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
280[ 140.559636] rc.local[459]: Dload Upload Total Spent Left Speed
281[ 141.282599] rc.local[459]:
282 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
283 53 3563 53 1896 0 0 2576 0 0:00:01 --:--:-- 0:00:01 2576
284100 3563 100 3563 0 0 4808 0 --:--:-- --:--:-- --:--:-- 4808
285Downloaded /tmp/verify-configuration.sh ...
286usb_drive is not set. SD card will be used.
287Verifying that there is sufficient space available on the MicroSD card...
288There is sufficient space available.
289Downloading additional setup scripts.
290curl -o /root/bin/remountfs_rw https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/remountfs_rw
291[ 150.159331] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
292[ 150.173339] rc.local[459]: Dload Upload Total Spent Left Speed
293[ 150.605111] rc.local[459]:
294 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
295100 276 100 276 0 0 616 0 --:--:-- --:--:-- --:--:-- 617
296Downloaded /root/bin/remountfs_rw ...
297curl -o /root/bin/make_snapshot.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/make_snapshot.sh
298[ 150.789058] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
299[ 150.802831] rc.local[459]: Dload Upload Total Spent Left Speed
300[ 151.258047] rc.local[459]:
301 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
302 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
303100 4484 100 4484 0 0 9515 0 --:--:-- --:--:-- --:--:-- 9520
304Downloaded /root/bin/make_snapshot.sh ...
305curl -o /root/bin/mount_snapshot.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/mount_snapshot.sh
306[ 151.443907] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
307[ 151.457790] rc.local[459]: Dload Upload Total Spent Left Speed
308[ 151.910623] rc.local[459]:
309 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
310100 805 100 805 0 0 1718 0 --:--:-- --:--:-- --:--:-- 1723
311Downloaded /root/bin/mount_snapshot.sh ...
312curl -o /root/bin/mount_image.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/mount_image.sh
313[ 152.097999] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
314[ 152.110216] rc.local[459]: Dload Upload Total Spent Left Speed
315[ 152.562872] rc.local[459]:
316 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
317100 513 100 513 0 0 1098 0 --:--:-- --:--:-- --:--:-- 1100
318Downloaded /root/bin/mount_image.sh ...
319curl -o /root/bin/release_snapshot.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/release_snapshot.sh
320[ 152.748550] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
321[ 152.760181] rc.local[459]: Dload Upload Total Spent Left Speed
322[ 153.232560] rc.local[459]:
323 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
324 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
325100 661 100 661 0 0 1359 0 --:--:-- --:--:-- --:--:-- 1360
326Downloaded /root/bin/release_snapshot.sh ...
327curl -o /root/bin/force_sync.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/force_sync.sh
328[ 153.418974] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
329[ 153.433013] rc.local[459]: Dload Upload Total Spent Left Speed
330[ 153.856637] rc.local[459]:
331 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
332100 517 100 517 0 0 1175 0 --:--:-- --:--:-- --:--:-- 1177
333Downloaded /root/bin/force_sync.sh ...
334curl -o /tmp/create-backingfiles-partition.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/create-backingfiles-partition.sh
335[ 154.044714] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
336[ 154.058815] rc.local[459]: Dload Upload Total Spent Left Speed
337[ 154.489253] rc.local[459]:
338 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
339100 5891 100 5891 0 0 13191 0 --:--:-- --:--:-- --:--:-- 13208
340Downloaded /tmp/create-backingfiles-partition.sh ...
341curl -o /tmp/create-backingfiles.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/create-backingfiles.sh
342[ 154.674444] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
343[ 154.688482] rc.local[459]: Dload Upload Total Spent Left Speed
344[ 155.133370] rc.local[459]:
345 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
346 0 4636 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
347100 4636 100 4636 0 0 10068 0 --:--:-- --:--:-- --:--:-- 10078
348Downloaded /tmp/create-backingfiles.sh ...
349curl -o /tmp/make-root-fs-readonly.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/make-root-fs-readonly.sh
350[ 155.319651] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
351[ 155.333647] rc.local[459]: Dload Upload Total Spent Left Speed
352[ 155.800318] rc.local[459]:
353 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
354100 2985 100 2985 0 0 6183 0 --:--:-- --:--:-- --:--:-- 6192
355Downloaded /tmp/make-root-fs-readonly.sh ...
356curl -o /tmp/configure.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/configure.sh
357[ 155.986485] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
358[ 156.000342] rc.local[459]: Dload Upload Total Spent Left Speed
359[ 156.467867] rc.local[459]:
360 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
361 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
362100 11517 100 11517 0 0 23813 0 --:--:-- --:--:-- --:--:-- 23844
363Downloaded /tmp/configure.sh ...
364/root /
365Fixing the modules-load parameter in /boot/cmdline.txt...
366Fixed cmdline.txt.
367usb_drive not set. Proceeding to SD card setup
368Checking existing partitions...
369Modifying partition table for backing files partition...
370[ 165.799545] rc.local[459]: [31mwarning: /dev/mmcblk0: partition 3 is not defined yet
371Checking that no-one is using this disk right now ... FAILED
372[1mDisk /dev/mmcblk0: 183.4 GiB, 196865949696 bytes, 384503808 sectors
373[ 165.809397] Units: sectors of 1 * 512 = 512 bytes
374rc.local[459]: [31mThis disk is currently in use - repartitioning is probably a bad idea.Sector size (logical/physical): 512 bytes / 512 bytes
375I/O size (minimum/optimal): 512 bytes / 512 bytes
376Disklabel type: dos
377Disk identifier: 0x22eddddb
378Old situation:
379[1mDevice [1mBoot[0m [1m Start[0m [1m End[0m [1mSectors[0m [1m Size[0m [1mId[0m [1mType[0m
380/dev/mmcblk0p1 8192 98966 90775 44.3M c W95 FAT32 (LBA)
381/dev/mmcblk0p2 106496 3563519 3457024 1.7G 83 Linux
382/dev/mmcblk0p3: Created a new partition 3 of type 'Linux' and of size 181.6 GiB.
383New situation:
384[1mDevice [1mBoot[0m [1m Start[0m [1m End[0m [1m Sectors[0m [1m Size[0m [1mId[0m [1mType[0m
385/dev/mmcblk0p1 8192 98966 90775 44.3M c W95 FAT32 (LBA)
386/dev/mmcblk0p2 106496 3563519 3457024 1.7G 83 Linux
387/dev/mmcblk0p3 3563520 384299007 380735488 181.6G 83 Linux
388The partition table has been altered.
389[ 165.821283] rc.local[459]: Umount all file systems, and swapoff all swap partitions on this disk.
390[ 165.834538] rc.local[459]: Use the --no-reread flag to suppress this check.
391[ 165.842821] rc.local[459]:
392Calling ioctl() to re-read partition table.
393The kernel still uses the old table. The new table will be used at the next reboot or after you run partprobe(8) or kpartx(8).
394Syncing disks.
395[ 165.892294] rc.local[459]: [31mRe-reading the partition table failed.: Device or resource busy
396Modifying partition table for mutable (writable) partition for script usage...
397[ 165.974840] rc.local[459]: [31mwarning: /dev/mmcblk0: partition 4 is not defined yet[0m
398Checking that no-one is using this disk right now ... FAILED
399[1mDisk /dev/mmcblk0: 183.4 GiB, 196865949696 bytes, 384503808 sectors
400[ 165.989516] rc.local[459]: [31mThis disk is currently in use - repartitioning is probably a bad idea.
401Units: sectors of 1 * 512 = 512 bytes
402Sector size (logical/physical): 512 bytes / 512 bytes
403I/O size (minimum/optimal): 512 bytes / 512 bytes
404Disklabel type: dos
405Disk identifier: 0x22eddddb
406Old situation:
407[1mDevice [1mBoot[0m [1m Start[0m [1m End[0m [1m Sectors[0m [1m Size[0m [1mId[0m [1mType[0m
408[ 165.996053] rc.local[459]: Umount all file systems, and swapoff all swap partitions on this disk.
409/dev/mmcblk0p1 8192 98966 90775 44.3M c W95 FAT32 (LBA)
410/dev/mmcblk0p2 106496 3563519 3457024 1.7G 83 Linux
411/dev/mmcblk0p3 3563520 384299007 380735488 181.6G 83 Linux
412/dev/mmcblk0p4: Created a new partition 4 of type 'Linux' and of size 100 MiB.
413New situation:
414[1mDevice [1mBoot[0m [1m Start[0m [1m End[0m [1m Sectors[0m [1m Size[0m [1mId[0m [1mType[0m
415[ 166.002313] rc.local[459]: Use the --no-reread flag to suppress this check.
416/dev/mmcblk0p1 8192 98966 90775 44.3M c W95 FAT32 (LBA)
417/dev/mmcblk0p2 106496 3563519 3457024 1.7G 83 Linux
418/dev/mmcblk0p3 3563520 384299007 380735488 181.6G 83 Linux
419/dev/mmcblk0p4 384299008 384503807 204800 100M 83 Linux
420The partition table has been altered.
421[ 166.007606] rc.local[459]:
422Calling ioctl() to re-read partition table.
423The kernel still uses the old table. The new table will be used at the next reboot or after you run partprobe(8) or kpartx(8).
424Syncing disks.
425[ 166.026818] rc.local[459]: [31mRe-reading the partition table failed.: Device or resource busy
426Writing updated partitions to fstab and /boot/cmdline.txt
427Formatting new partitions...
428meta-data=/dev/mmcblk0p3 isize=512 agcount=4, agsize=11897984 blks
429 = sectsz=512 attr=2, projid32bit=1
430 = crc=1 finobt=1, sparse=0, rmapbt=0, reflink=1
431data = bsize=4096 blocks=47591936, imaxpct=25
432 = sunit=0 swidth=0 blks
433naming =version 2 bsize=4096 ascii-ci=0 ftype=1
434log =internal log bsize=4096 blocks=23238, version=2
435 = sectsz=512 sunit=0 blks, lazy-count=1
436realtime =none extsz=4096 blocks=0, rtextents=0
437[ 182.248314] rc.local[459]: mke2fs 1.43.4 (31-Jan-2017)
438Discarding device blocks: 1024/102400 done
439Creating filesystem with 102400 1k blocks and 25688 inodes
440Filesystem UUID: 4f0abbb4-4585-429a-be68-40a9a42f047b
441Superblock backups stored on blocks:
442 8193, 24577, 40961, 57345, 73729
443Allocating group tables: 0/13 done
444Writing inode tables: 0/13 done
445Creating journal (4096 blocks): done
446Writing superblocks and filesystem accounting information: 0/13 done
447Mounting the partition for the backing files...
448Mounted the partition for the backing files.
449Creating backing disk files.
450create-backingfiles: starting
451create-backingfiles: starting
452create-backingfiles: cam: 40%, music: 100%, mountpoint: /backingfiles
453create-backingfiles: cam: 40%, music: 100%, mountpoint: /backingfiles
454[ 183.263750] rc.local[459]: archiveloop: no process found
455[ 183.315034] rc.local[459]: umount: /mnt/cam: mountpoint not found
456[ 183.340486] rc.local[459]: umount: /mnt/music: mountpoint not found
457[ 183.366015] rc.local[459]: umount: /backingfiles/snapshots/snap*/mnt: mountpoint not found
458create-backingfiles: Allocating 73049200K for /backingfiles/cam_disk.bin...
459create-backingfiles: Allocating 73049200K for /backingfiles/cam_disk.bin...
460create-backingfiles: Creating filesystem with label 'CAM'
461create-backingfiles: Creating filesystem with label 'CAM'
462mkfs.fat 4.1 (2017-01-24)
463create-backingfiles: updated /etc/fstab for /mnt/cam
464create-backingfiles: updated /etc/fstab for /mnt/cam
465create-backingfiles: created camera backing file
466create-backingfiles: created camera backing file
467create-backingfiles: Allocating 109573800K for /backingfiles/music_disk.bin...
468create-backingfiles: Allocating 109573800K for /backingfiles/music_disk.bin...
469create-backingfiles: Creating filesystem with label 'MUSIC'
470create-backingfiles: Creating filesystem with label 'MUSIC'
471mkfs.fat 4.1 (2017-01-24)
472create-backingfiles: updated /etc/fstab for /mnt/music
473create-backingfiles: updated /etc/fstab for /mnt/music
474create-backingfiles: created music backing file
475create-backingfiles: created music backing file
476create-backingfiles: done
477create-backingfiles: done
478Main setup completed.
479calling configure.sh
480configure: /tmp/configure.sh starting with REPO=marcone, BRANCH=main-dev, ARCHIVE_SYSTEM=rsync
481configure: /tmp/configure.sh starting with REPO=marcone, BRANCH=main-dev, ARCHIVE_SYSTEM=rsync
482configure: Getting files from marcone:main-dev
483configure: Getting files from marcone:main-dev
484configure: Pushover not configured.
485configure: Pushover not configured.
486configure: Gotify not configured.
487configure: Gotify not configured.
488configure: Gotify not configured.
489configure: Gotify not configured.
490SNS not configured.
491configure: Starting download for /root/bin/send-push-message
492configure: Starting download for /root/bin/send-push-message
493[ 202.101768] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
494[ 202.113341] rc.local[459]: Dload Upload Total Spent Left Speed
495[ 202.667234] rc.local[459]:
496 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
497100 1336 100 1336 0 0 2353 0 --:--:-- --:--:-- --:--:-- 2360
498configure: Done
499configure: Done
500configure: Starting download for /root/bin/send_sns.py
501configure: Starting download for /root/bin/send_sns.py
502[ 202.849708] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
503[ 202.860188] rc.local[459]: Dload Upload Total Spent Left Speed
504[ 203.305461] rc.local[459]:
505 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
506 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
507100 602 100 602 0 0 1315 0 --:--:-- --:--:-- --:--:-- 1314
508configure: Done
509configure: Done
510configure: Checking archive configs:
511configure: Checking archive configs:
512configure: done
513configure: done
514configure: Using archive module: run/rsync_archive
515configure: Using archive module: run/rsync_archive
516configure: Installing base archive scripts into /root/bin
517configure: Installing base archive scripts into /root/bin
518configure: Starting download for /root/bin/archiveloop
519configure: Starting download for /root/bin/archiveloop
520[ 203.575854] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
521[ 203.587545] rc.local[459]: Dload Upload Total Spent Left Speed
522[ 204.014914] rc.local[459]:
523 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
524 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
525100 11931 100 11931 0 0 26854 0 --:--:-- --:--:-- --:--:-- 26871
526configure: Done
527configure: Done
528configure: Starting download for /root/bin/remountfs_rw
529configure: Starting download for /root/bin/remountfs_rw
530[ 204.195915] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
531[ 204.207778] rc.local[459]: Dload Upload Total Spent Left Speed
532[ 204.644429] rc.local[459]:
533 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
534100 276 100 276 0 0 612 0 --:--:-- --:--:-- --:--:-- 613
535configure: Done
536configure: Done
537configure: Skipping tesla_api.py install
538configure: Skipping tesla_api.py install
539configure: Installing archive module scripts
540configure: Installing archive module scripts
541configure: Starting download for /tmp/verify-and-configure-archive.sh
542configure: Starting download for /tmp/verify-and-configure-archive.sh
543[ 204.866158] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
544[ 204.878392] rc.local[459]: Dload Upload Total Spent Left Speed
545[ 205.318549] rc.local[459]:
546 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
547 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
548100 227 100 227 0 0 499 0 --:--:-- --:--:-- --:--:-- 500
549configure: Done
550configure: Done
551configure: Starting download for /root/bin/archive-clips.sh
552configure: Starting download for /root/bin/archive-clips.sh
553[ 205.505119] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
554[ 205.517003] rc.local[459]: Dload Upload Total Spent Left Speed
555[ 205.963584] rc.local[459]:
556 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
557100 650 100 650 0 0 1410 0 --:--:-- --:--:-- --:--:-- 1413
558configure: Done
559configure: Done
560configure: Starting download for /root/bin/connect-archive.sh
561configure: Starting download for /root/bin/connect-archive.sh
562[ 206.146844] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
563[ 206.159195] rc.local[459]: Dload Upload Total Spent Left Speed
564[ 206.887772] rc.local[459]:
565 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
566100 33 100 33 0 0 44 0 --:--:-- --:--:-- --:--:-- 44
567configure: Done
568configure: Done
569configure: Starting download for /root/bin/disconnect-archive.sh
570configure: Starting download for /root/bin/disconnect-archive.sh
571[ 207.101601] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
572[ 207.114368] rc.local[459]: Dload Upload Total Spent Left Speed
573[ 207.544981] rc.local[459]:
574 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
575100 33 100 33 0 0 74 0 --:--:-- --:--:-- --:--:-- 74
576configure: Done
577configure: Done
578configure: Starting download for /root/bin/write-archive-configs-to.sh
579configure: Starting download for /root/bin/write-archive-configs-to.sh
580[ 207.728218] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
581[ 207.740164] rc.local[459]: Dload Upload Total Spent Left Speed
582[ 208.419687] rc.local[459]:
583 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
584 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
585100 156 100 156 0 0 225 0 --:--:-- --:--:-- --:--:-- 225
586configure: Done
587configure: Done
588configure: Starting download for /root/bin/archive-is-reachable.sh
589configure: Starting download for /root/bin/archive-is-reachable.sh
590[ 208.633823] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
591[ 208.646443] rc.local[459]: Dload Upload Total Spent Left Speed
592[ 209.063175] rc.local[459]:
593 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
594100 97 100 97 0 0 225 0 --:--:-- --:--:-- --:--:-- 225
595100 97 100 97 0 0 223 0 --:--:-- --:--:-- --:--:-- 223
596configure: Done
597configure: Done
598Configuring the rsync archive...
599configure: Skipping rc.local installation
600configure: Skipping rc.local installation
601curl -o /tmp/configure-samba.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/configure-samba.sh
602[ 209.331252] rc.local[459]: % Total % Received % Xferd Average Speed Time Time Time Current
603[ 209.343634] rc.local[459]: Dload Upload Total Spent Left Speed
604[ 209.768387] rc.local[459]:
605 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
606100 2466 100 2466 0 0 5612 0 --:--:-- --:--:-- --:--:-- 5630
607Downloaded /tmp/configure-samba.sh ...
608configure-samba: Installing samba and dependencies...
609configure-samba: Installing samba and dependencies...
610Building dependency tree... 0%
611Building dependency tree... 0%
612Building dependency tree... 50%
613Building dependency tree... 50%
614Building dependency tree... 68%
615Building dependency tree... 92%
616Building dependency tree
617Reading state information... 0%
618Reading state information... 0%
619Reading state information... Done
620The following additional packages will be installed:
621 attr libaio1 libavahi-client3 libcups2 libfile-copy-recursive-perl libgpgme11
622 libldb1 libpython2.7 libtdb1 libtevent0 libwbclient0 python-crypto
623 python-dnspython python-ldb python-samba python-talloc python-tdb samba-common
624 samba-common-bin samba-dsdb-modules samba-libs samba-vfs-modules tdb-tools
625 update-inetd
626Suggested packages:
627 cups-common gpgsm python-crypto-dbg python-crypto-doc python-gpgme bind9
628 bind9utils ctdb ldb-tools ntp | chrony smbldap-tools winbind ufw
629 heimdal-clients
630The following NEW packages will be installed:
631 attr libaio1 libavahi-client3 libcups2 libfile-copy-recursive-perl libgpgme11
632 libldb1 libpython2.7 libtdb1 libtevent0 python-crypto python-dnspython
633 python-ldb python-samba python-talloc python-tdb samba samba-common-bin
634 samba-dsdb-modules samba-libs samba-vfs-modules tdb-tools update-inetd
635The following packages will be upgraded:
636 libwbclient0 samba-common
6372 upgraded, 23 newly installed, 0 to remove and 41 not upgraded.
638Need to get 9,962 kB of archives.
639After this operation, 49.2 MB of additional disk space will be used.
6400% [Working]
6410% [Working]
642Get:1 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libwbclient0 armhf 2:4.5.16+dfsg-1+deb9u2 [121 kB]
6430% [1 libwbclient0 0 B/121 kB 0%] [Waiting for headers]
6440% [1 libwbclient0 14.2 kB/121 kB 12%]
6452% [Waiting for headers]
646Get:2 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf python-dnspython all 1.15.0-1+deb9u1 [102 kB]
6472% [2 python-dnspython 0 B/102 kB 0%] [Waiting for headers]
6483% [2 python-dnspython 98.3 kB/102 kB 96%] [Connecting to raspbian.raspberrypi.or
6493% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
650Get:3 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf python-crypto armhf 2.6.1-7 [253 kB]
6513% [3 python-crypto 0 B/253 kB 0%] [Waiting for headers]
6525% [3 python-crypto 235 kB/253 kB 93%] [Connecting to raspbian.raspberrypi.org (9
6536% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
654Get:4 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libtdb1 armhf 1.3.11-2 [38.0 kB]
6556% [4 libtdb1 0 B/38.0 kB 0%] [Waiting for headers]
6567% [Waiting for headers]
6577% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
658Get:5 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libtevent0 armhf 0.9.31-1 [24.7 kB]
6597% [5 libtevent0 0 B/24.7 kB 0%] [Waiting for headers]
6608% [Waiting for headers]
6618% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
662Get:6 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libldb1 armhf 2:1.1.27-1+deb9u1 [92.4 kB]
6638% [6 libldb1 0 B/92.4 kB 0%] [Connecting to raspbian.raspberrypi.org (93.93.128.
66410% [Waiting for headers]
66510% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
666Get:7 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libpython2.7 armhf 2.7.13-2+deb9u3 [914 kB]
66710% [7 libpython2.7 0 B/914 kB 0%] [Connecting to raspbian.raspberrypi.org (93.93
66816% [7 libpython2.7 780 kB/914 kB 85%]
66918% [Waiting for headers]
670Get:8 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf python-ldb armhf 2:1.1.27-1+deb9u1 [29.9 kB]
67118% [8 python-ldb 0 B/29.9 kB 0%] [Waiting for headers]
67219% [Waiting for headers]
67319% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
674Get:9 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf python-tdb armhf 1.3.11-2 [15.3 kB]
67519% [9 python-tdb 0 B/15.3 kB 0%] [Connecting to raspbian.raspberrypi.org (93.93.
67620% [Waiting for headers]
67720% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
678Get:10 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf python-talloc armhf 2.1.8-1 [11.3 kB]
67920% [10 python-talloc 0 B/11.3 kB 0%] [Connecting to raspbian.raspberrypi.org (93
68021% [Waiting for headers]
68121% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
682Get:11 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libavahi-client3 armhf 0.6.32-2 [51.3 kB]
68321% [11 libavahi-client3 0 B/51.3 kB 0%] [Connecting to raspbian.raspberrypi.org
68422% [Waiting for headers]
68522% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
686Get:12 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libcups2 armhf 2.2.1-8+deb9u4 [273 kB]
68722% [12 libcups2 0 B/273 kB 0%] [Connecting to raspbian.raspberrypi.org (93.93.12
68824% [12 libcups2 262 kB/273 kB 96%]
68925% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
690Get:13 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf samba-libs armhf 2:4.5.16+dfsg-1+deb9u2 [4,394 kB]
69125% [13 samba-libs 0 B/4,394 kB 0%] [Connecting to raspbian.raspberrypi.org (93.9
69229% [13 samba-libs 549 kB/4,394 kB 12%]
69335% [13 samba-libs 1,245 kB/4,394 kB 28%]
69442% [13 samba-libs 2,068 kB/4,394 kB 47%] [Connecting to raspbian.raspberrypi.org
69547% [13 samba-libs 2,687 kB/4,394 kB 61%]
69660% [13 samba-libs 4,394 kB/4,394 kB 100%] [Connecting to raspbian.raspberrypi.or
69761% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
698Get:14 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf python-samba armhf 2:4.5.16+dfsg-1+deb9u2 [1,145 kB]
69961% [14 python-samba 0 B/1,145 kB 0%] [Waiting for headers]
70064% [14 python-samba 336 kB/1,145 kB 29%]
70169% [14 python-samba 951 kB/1,145 kB 83%] [Connecting to raspbian.raspberrypi.org
70271% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
703Get:15 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf samba-common all 2:4.5.16+dfsg-1+deb9u2 [174 kB]
70471% [15 samba-common 0 B/174 kB 0%] [Connecting to raspbian.raspberrypi.org (93.9
70573% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
706Get:16 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf samba-common-bin armhf 2:4.5.16+dfsg-1+deb9u2 [554 kB]
70773% [16 samba-common-bin 0 B/554 kB 0%] [Connecting to raspbian.raspberrypi.org (
70879% [Waiting for headers]
709Get:17 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf tdb-tools armhf 1.3.11-2 [25.7 kB]
71079% [17 tdb-tools 0 B/25.7 kB 0%] [Waiting for headers]
71180% [Waiting for headers]
712Get:18 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libfile-copy-recursive-perl all 0.38-1 [20.6 kB]
71380% [18 libfile-copy-recursive-perl 0 B/20.6 kB 0%] [Waiting for headers]
71481% [Waiting for headers]
71581% [Waiting for headers] [Connecting to raspbian.raspberrypi.org (93.93.128.193)
716Get:19 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf update-inetd all 4.44 [20.8 kB]
71781% [19 update-inetd 12.8 kB/20.8 kB 62%] [Connecting to raspbian.raspberrypi.org
71882% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
719Get:20 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf samba armhf 2:4.5.16+dfsg-1+deb9u2 [871 kB]
72082% [20 samba 0 B/871 kB 0%] [Connecting to raspbian.raspberrypi.org (93.93.128.1
72189% [Waiting for headers]
722Get:21 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf attr armhf 1:2.4.47-2 [41.3 kB]
72389% [21 attr 0 B/41.3 kB 0%] [Waiting for headers]
72490% [21 attr 38.3 kB/41.3 kB 93%] [Connecting to raspbian.raspberrypi.org (93.93.
72590% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
726Get:22 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libaio1 armhf 0.3.110-3 [9,366 B]
72790% [22 libaio1 0 B/9,366 B 0%] [Waiting for headers]
72891% [Waiting for headers]
72991% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
730Get:23 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libgpgme11 armhf 1.8.0-3 [141 kB]
73191% [23 libgpgme11 0 B/141 kB 0%] [Connecting to raspbian.raspberrypi.org (93.93.
73293% [Waiting for headers]
73393% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
734Get:24 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf samba-dsdb-modules armhf 2:4.5.16+dfsg-1+deb9u2 [305 kB]
73593% [24 samba-dsdb-modules 0 B/305 kB 0%] [Connecting to raspbian.raspberrypi.org
73697% [Waiting for headers]
73797% [Working]
738Get:25 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf samba-vfs-modules armhf 2:4.5.16+dfsg-1+deb9u2 [335 kB]
73997% [25 samba-vfs-modules 0 B/335 kB 0%]
740100% [Working]
741Fetched 9,962 kB in 5s (1,806 kB/s)
742apt-listchanges: Reading changelogs...
743Preconfiguring packages ...
744Preparing to unpack .../00-libwbclient0_2%3a4.5.16+dfsg-1+deb9u2_armhf.deb ...
745Unpacking libwbclient0:armhf (2:4.5.16+dfsg-1+deb9u2) over (2:4.5.16+dfsg-1+deb9u1) ...
746Selecting previously unselected package python-dnspython.
747Preparing to unpack .../01-python-dnspython_1.15.0-1+deb9u1_all.deb ...
748Unpacking python-dnspython (1.15.0-1+deb9u1) ...
749Selecting previously unselected package python-crypto.
750Preparing to unpack .../02-python-crypto_2.6.1-7_armhf.deb ...
751Unpacking python-crypto (2.6.1-7) ...
752Selecting previously unselected package libtdb1:armhf.
753Preparing to unpack .../03-libtdb1_1.3.11-2_armhf.deb ...
754Unpacking libtdb1:armhf (1.3.11-2) ...
755Selecting previously unselected package libtevent0:armhf.
756Preparing to unpack .../04-libtevent0_0.9.31-1_armhf.deb ...
757Unpacking libtevent0:armhf (0.9.31-1) ...
758Selecting previously unselected package libldb1:armhf.
759Preparing to unpack .../05-libldb1_2%3a1.1.27-1+deb9u1_armhf.deb ...
760Unpacking libldb1:armhf (2:1.1.27-1+deb9u1) ...
761Selecting previously unselected package libpython2.7:armhf.
762Preparing to unpack .../06-libpython2.7_2.7.13-2+deb9u3_armhf.deb ...
763Unpacking libpython2.7:armhf (2.7.13-2+deb9u3) ...
764Selecting previously unselected package python-ldb.
765Preparing to unpack .../07-python-ldb_2%3a1.1.27-1+deb9u1_armhf.deb ...
766Unpacking python-ldb (2:1.1.27-1+deb9u1) ...
767Selecting previously unselected package python-tdb.
768Preparing to unpack .../08-python-tdb_1.3.11-2_armhf.deb ...
769Unpacking python-tdb (1.3.11-2) ...
770Selecting previously unselected package python-talloc.
771Preparing to unpack .../09-python-talloc_2.1.8-1_armhf.deb ...
772Unpacking python-talloc (2.1.8-1) ...
773Selecting previously unselected package libavahi-client3:armhf.
774Preparing to unpack .../10-libavahi-client3_0.6.32-2_armhf.deb ...
775Unpacking libavahi-client3:armhf (0.6.32-2) ...
776Selecting previously unselected package libcups2:armhf.
777Preparing to unpack .../11-libcups2_2.2.1-8+deb9u4_armhf.deb ...
778Unpacking libcups2:armhf (2.2.1-8+deb9u4) ...
779Selecting previously unselected package samba-libs:armhf.
780Preparing to unpack .../12-samba-libs_2%3a4.5.16+dfsg-1+deb9u2_armhf.deb ...
781Unpacking samba-libs:armhf (2:4.5.16+dfsg-1+deb9u2) ...
782Selecting previously unselected package python-samba.
783Preparing to unpack .../13-python-samba_2%3a4.5.16+dfsg-1+deb9u2_armhf.deb ...
784Unpacking python-samba (2:4.5.16+dfsg-1+deb9u2) ...
785Preparing to unpack .../14-samba-common_2%3a4.5.16+dfsg-1+deb9u2_all.deb ...
786Unpacking samba-common (2:4.5.16+dfsg-1+deb9u2) over (2:4.5.16+dfsg-1+deb9u1) ...
787Selecting previously unselected package samba-common-bin.
788Preparing to unpack .../15-samba-common-bin_2%3a4.5.16+dfsg-1+deb9u2_armhf.deb ...
789Unpacking samba-common-bin (2:4.5.16+dfsg-1+deb9u2) ...
790Selecting previously unselected package tdb-tools.
791Preparing to unpack .../16-tdb-tools_1.3.11-2_armhf.deb ...
792Unpacking tdb-tools (1.3.11-2) ...
793Selecting previously unselected package libfile-copy-recursive-perl.
794Preparing to unpack .../17-libfile-copy-recursive-perl_0.38-1_all.deb ...
795Unpacking libfile-copy-recursive-perl (0.38-1) ...
796Selecting previously unselected package update-inetd.
797Preparing to unpack .../18-update-inetd_4.44_all.deb ...
798Unpacking update-inetd (4.44) ...
799Selecting previously unselected package samba.
800Preparing to unpack .../19-samba_2%3a4.5.16+dfsg-1+deb9u2_armhf.deb ...
801Unpacking samba (2:4.5.16+dfsg-1+deb9u2) ...
802Selecting previously unselected package attr.
803Preparing to unpack .../20-attr_1%3a2.4.47-2_armhf.deb ...
804Unpacking attr (1:2.4.47-2) ...
805Selecting previously unselected package libaio1:armhf.
806Preparing to unpack .../21-libaio1_0.3.110-3_armhf.deb ...
807Unpacking libaio1:armhf (0.3.110-3) ...
808Selecting previously unselected package libgpgme11:armhf.
809Preparing to unpack .../22-libgpgme11_1.8.0-3_armhf.deb ...
810Unpacking libgpgme11:armhf (1.8.0-3) ...
811Selecting previously unselected package samba-dsdb-modules.
812Preparing to unpack .../23-samba-dsdb-modules_2%3a4.5.16+dfsg-1+deb9u2_armhf.deb ...
813Unpacking samba-dsdb-modules (2:4.5.16+dfsg-1+deb9u2) ...
814Selecting previously unselected package samba-vfs-modules.
815Preparing to unpack .../24-samba-vfs-modules_2%3a4.5.16+dfsg-1+deb9u2_armhf.deb ...
816Unpacking samba-vfs-modules (2:4.5.16+dfsg-1+deb9u2) ...
817Setting up python-dnspython (1.15.0-1+deb9u1) ...
818Setting up libtdb1:armhf (1.3.11-2) ...
819Setting up libwbclient0:armhf (2:4.5.16+dfsg-1+deb9u2) ...
820Setting up python-crypto (2.6.1-7) ...
821Setting up samba-common (2:4.5.16+dfsg-1+deb9u2) ...
822Setting up libgpgme11:armhf (1.8.0-3) ...
823Setting up libtevent0:armhf (0.9.31-1) ...
824Processing triggers for libc-bin (2.24-11+deb9u4) ...
825Setting up libaio1:armhf (0.3.110-3) ...
826Processing triggers for systemd (232-25+deb9u11) ...
827Setting up libpython2.7:armhf (2.7.13-2+deb9u3) ...
828Setting up tdb-tools (1.3.11-2) ...
829update-alternatives: using /usr/bin/tdbbackup.tdbtools to provide /usr/bin/tdbbackup (tdbbackup) in auto mode
830Processing triggers for man-db (2.7.6.1-2) ...
831Setting up libavahi-client3:armhf (0.6.32-2) ...
832Setting up attr (1:2.4.47-2) ...
833Setting up libfile-copy-recursive-perl (0.38-1) ...
834Setting up libcups2:armhf (2.2.1-8+deb9u4) ...
835Setting up python-talloc (2.1.8-1) ...
836Setting up update-inetd (4.44) ...
837Setting up python-tdb (1.3.11-2) ...
838Setting up libldb1:armhf (2:1.1.27-1+deb9u1) ...
839Setting up python-ldb (2:1.1.27-1+deb9u1) ...
840Setting up samba-libs:armhf (2:4.5.16+dfsg-1+deb9u2) ...
841Setting up samba-vfs-modules (2:4.5.16+dfsg-1+deb9u2) ...
842Setting up python-samba (2:4.5.16+dfsg-1+deb9u2) ...
843Setting up samba-common-bin (2:4.5.16+dfsg-1+deb9u2) ...
844Setting up samba-dsdb-modules (2:4.5.16+dfsg-1+deb9u2) ...
845Setting up samba (2:4.5.16+dfsg-1+deb9u2) ...
846Adding group `sambashare' (GID 113) ...
847Done.
848Samba is not being run as an AD Domain Controller, masking samba-ad-dc-service.
849Please ignore the following error about deb-systemd-helper not finding samba-ad-dc-service.
850Created symlink /etc/systemd/system/multi-user.target.wants/nmbd.service → /lib/systemd/system/nmbd.service.
851Failed to preset unit: Unit file /etc/systemd/system/samba-ad-dc.service is masked.
852/usr/bin/deb-systemd-helper: error: systemctl preset failed on samba-ad-dc.service: No such file or directory
853Created symlink /etc/systemd/system/multi-user.target.wants/smbd.service → /lib/systemd/system/smbd.service.
854 Starting Samba SMB Daemon...
855[ OK ] Started Samba SMB Daemon.
856 Starting Samba NMB Daemon...
857[ OK ] Started Samba NMB Daemon.
858Processing triggers for libc-bin (2.24-11+deb9u4) ...
859Processing triggers for systemd (232-25+deb9u11) ...
860[ 321.343039] rc.local[459]: W: --force-yes is deprecated, use one of the options starting with --allow instead.
861Added user pi.
862 Stopping Samba SMB Daemon...
863[ OK ] Stopped Samba SMB Daemon.
864configure-samba: Done.
865configure-samba: Done.
866make-root-fs-readonly: start
867make-root-fs-readonly: start
868make-root-fs-readonly: Removing unwanted packages...
869make-root-fs-readonly: Removing unwanted packages...
870Building dependency tree... 0%
871Building dependency tree... 0%
872Building dependency tree... 50%
873Building dependency tree... 50%
874Building dependency tree... 68%
875Building dependency tree... 92%
876Building dependency tree
877Reading state information... 0%
878Reading state information... 0%
879Reading state information... Done
880The following package was automatically installed and is no longer required:
881 dc
882Use 'apt autoremove' to remove it.
883The following packages will be REMOVED:
884 dphys-swapfile* logrotate* triggerhappy*
8850 upgraded, 0 newly installed, 3 to remove and 41 not upgraded.
886After this operation, 281 kB disk space will be freed.
887Removing dphys-swapfile (20100506-3) ...
888 Stopping LSB: Autogenerate and use a swap file...
889[ OK ] Stopped LSB: Autogenerate and use a swap file.
890Removing logrotate (3.11.0-0.1) ...
891Removing triggerhappy (0.5.0-1) ...
892 Stopping triggerhappy global hotkey daemon...
893[ OK ] Stopped triggerhappy global hotkey daemon.
894Warning: Stopping triggerhappy.service, but it can still be activated by:
895 triggerhappy.socket
896Processing triggers for man-db (2.7.6.1-2) ...
897Purging configuration files for dphys-swapfile (20100506-3) ...
898Purging configuration files for triggerhappy (0.5.0-1) ...
899Purging configuration files for logrotate (3.11.0-0.1) ...
900Processing triggers for systemd (232-25+deb9u11) ...
901[ 367.387429] rc.local[459]: W: --force-yes is deprecated, use one of the options starting with --allow instead.
902Building dependency tree... 0%
903Building dependency tree... 0%
904Building dependency tree... 50%
905Building dependency tree... 50%
906Building dependency tree... 67%
907Building dependency tree... 89%
908Building dependency tree
909Reading state information... 0%
910Reading state information... 0%
911Reading state information... Done
912The following packages will be REMOVED:
913 dc*
9140 upgraded, 0 newly installed, 1 to remove and 41 not upgraded.
915After this operation, 111 kB disk space will be freed.
916Removing dc (1.06.95-9) ...
917Processing triggers for install-info (6.3.0.dfsg.1-1+b1) ...
918Processing triggers for man-db (2.7.6.1-2) ...
919Purging configuration files for dc (1.06.95-9) ...
920[ 383.999214] rc.local[459]: W: --force-yes is deprecated, use one of the options starting with --allow instead.
921make-root-fs-readonly: Installing ntp and busybox-syslogd...
922make-root-fs-readonly: Installing ntp and busybox-syslogd...
923Building dependency tree... 0%
924Building dependency tree... 0%
925Building dependency tree... 50%
926Building dependency tree... 50%
927Building dependency tree... 67%
928Building dependency tree... 90%
929Building dependency tree
930Reading state information... 0%
931Reading state information... 0%
932Reading state information... Done
933The following additional packages will be installed:
934 busybox libopts25
935Suggested packages:
936 ntp-doc
937The following packages will be REMOVED:
938 rsyslog
939The following NEW packages will be installed:
940 busybox busybox-syslogd libopts25 ntp
9410 upgraded, 4 newly installed, 1 to remove and 41 not upgraded.
942Need to get 1,007 kB of archives.
943After this operation, 1,283 kB of additional disk space will be used.
9440% [Working]
9450% [Working]
9460% [Waiting for headers]
947Get:1 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf libopts25 armhf 1:5.18.12-3 [61.4 kB]
9480% [1 libopts25 0 B/61.4 kB 0%] [Connecting to raspbian.raspberrypi.org (93.93.12
94910% [Waiting for headers]
950Get:2 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf ntp armhf 1:4.2.8p10+dfsg-3+deb9u2 [548 kB]
95110% [2 ntp 0 B/548 kB 0%] [Waiting for headers]
95240% [2 ntp 381 kB/548 kB 70%] [Connecting to raspbian.raspberrypi.org (93.93.128.
95358% [Connecting to raspbian.raspberrypi.org (93.93.128.193)]
954Get:3 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf busybox armhf 1:1.22.0-19 [374 kB]
95558% [3 busybox 0 B/374 kB 0%] [Waiting for headers]
95693% [Waiting for headers]
95793% [Working]
958Get:4 http://mirror.serverius.net/raspbian/raspbian stretch/main armhf busybox-syslogd all 1:1.22.0-19 [24.2 kB]
95993% [4 busybox-syslogd 0 B/24.2 kB 0%]
960100% [Working]
961Fetched 1,007 kB in 0s (1,025 kB/s)
962[ 395.381126] rc.local[459]: dpkg-preconfigure: unable to re-open stdin: No such file or directory
963Removing rsyslog (8.24.0-1) ...
964 Stopping System Logging Service...
965[ OK ] Stopped System Logging Service.
966[ OK ] Closed Syslog Socket.
967Selecting previously unselected package libopts25:armhf.
968Preparing to unpack .../libopts25_1%3a5.18.12-3_armhf.deb ...
969Unpacking libopts25:armhf (1:5.18.12-3) ...
970Selecting previously unselected package ntp.
971Preparing to unpack .../ntp_1%3a4.2.8p10+dfsg-3+deb9u2_armhf.deb ...
972Unpacking ntp (1:4.2.8p10+dfsg-3+deb9u2) ...
973Selecting previously unselected package busybox.
974Preparing to unpack .../busybox_1%3a1.22.0-19_armhf.deb ...
975Unpacking busybox (1:1.22.0-19) ...
976Selecting previously unselected package busybox-syslogd.
977Preparing to unpack .../busybox-syslogd_1%3a1.22.0-19_all.deb ...
978Unpacking busybox-syslogd (1:1.22.0-19) ...
979Setting up busybox (1:1.22.0-19) ...
980Processing triggers for libc-bin (2.24-11+deb9u4) ...
981Setting up busybox-syslogd (1:1.22.0-19) ...
982 Starting LSB: Starts syslogd...
983[ OK ] Started LSB: Starts syslogd.
984 Starting LSB: Starts klogd...
985[ OK ] Started LSB: Starts klogd.
986Processing triggers for systemd (232-25+deb9u11) ...
987Setting up libopts25:armhf (1:5.18.12-3) ...
988Processing triggers for man-db (2.7.6.1-2) ...
989Setting up ntp (1:4.2.8p10+dfsg-3+deb9u2) ...
990 Starting LSB: Start NTP daemon...
991[ OK ] Started LSB: Start NTP daemon.
992Processing triggers for libc-bin (2.24-11+deb9u4) ...
993Processing triggers for systemd (232-25+deb9u11) ...
994[ 427.646785] rc.local[459]: W: --force-yes is deprecated, use one of the options starting with --allow instead.
995Purging configuration files for rsyslog (8.24.0-1) ...
996Processing triggers for systemd (232-25+deb9u11) ...
997make-root-fs-readonly: Configuring system...
998make-root-fs-readonly: Configuring system...
999TARGET SOURCE FSTYPE OPTIONS
1000/mutable /dev/mmcblk0p4 ext4 rw,relatime
1001make-root-fs-readonly: Moving fake-hwclock data
1002make-root-fs-readonly: Moving fake-hwclock data
1003make-root-fs-readonly: done
1004make-root-fs-readonly: done
1005Skipping package upgrade.
1006All done.
1007 Unmounting RPC Pipe File System...
1008[ OK ] Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
1009[ OK ] Stopped target Bluetooth.
1010[ OK ] Removed slice system-bthelper.slice.
1011[ OK ] Stopped target Timers.
1012[ OK ] Stopped Daily Cleanup of Temporary Directories.
1013[ OK ] Stopped Daily apt upgrade and clean activities.
1014 Stopping Bluetooth service...
1015[ OK ] Stopped target Sound Card.
1016[ OK ] Stopped Daily apt download activities.
1017[ OK ] Stopped target System Time Synchronized.
1018 Stopping Session c1 of user pi.
1019 Stopping Save/Restore Sound Card State...
1020 Stopping LSB: Starts klogd...
1021 Stopping rng-tools.service...
1022 Stopping OpenBSD Secure Shell server...
1023 Stopping Configure Bluetooth Modems connected by UART...
1024 Stopping Regular background program processing daemon...
1025 Stopping LSB: Start NTP daemon...
1026 Stopping Samba NMB Daemon...
1027 Stopping Avahi mDNS/DNS-SD Stack...
1028 Stopping LSB: Switch to ondemand cpu…or (unless shift key is pressed)...
1029 Starting Show Plymouth Reboot Screen...
1030[ OK ] Removed slice system-getty.slice.
1031 Stopping User Manager for UID 1000...
1032[ OK ] Stopped Avahi mDNS/DNS-SD Stack.
1033[ OK ] Stopped Regular background program processing daemon.
1034[ OK ] Stopped Configure Bluetooth Modems connected by UART.
1035[ OK ] Stopped Bluetooth service.
1036[ OK ] Stopped /etc/rc.local Compatibility.
1037[ OK ] Stopped OpenBSD Secure Shell server.
1038[ OK ] Stopped User Manager for UID 1000.
1039[ OK ] Stopped Samba NMB Daemon.
1040[ OK ] Unmounted RPC Pipe File System.
1041[ OK ] Stopped Save/Restore Sound Card State.
1042[ OK ] Stopped LSB: Starts klogd.
1043[ OK ] Stopped rng-tools.service.
1044[ OK ] Stopped Session c1 of user pi.
1045[ OK ] Started Show Plymouth Reboot Screen.
1046 Stopping LSB: Starts syslogd...
1047[ OK ] Removed slice User Slice of pi.
1048 Stopping Login Service...
1049 Stopping Permit User Sessions...
1050[ OK ] Stopped Login Service.
1051[ OK ] Stopped LSB: Switch to ondemand cpu …rnor (unless shift key is pressed).
1052[ OK ] Stopped Permit User Sessions.
1053[ OK ] Stopped LSB: Start NTP daemon.
1054[ OK ] Stopped target Network is Online.
1055[ OK ] Stopped target Network.
1056 Stopping dhcpcd on all interfaces...
1057 Stopping WPA supplicant...
1058 Stopping Raise network interfaces...
1059[ OK ] Stopped WPA supplicant.
1060 Stopping D-Bus System Message Bus...
1061[ OK ] Stopped D-Bus System Message Bus.
1062[ OK ] Stopped LSB: Starts syslogd.
1063[ OK ] Stopped target Remote File Systems.
1064[ OK ] Stopped target Remote File Systems (Pre).
1065[ OK ] Stopped target NFS client services.
1066[ OK ] Stopped dhcpcd on all interfaces.
1067[ OK ] Stopped target Basic System.
1068[ OK ] Stopped Forward Password Requests to Plymouth Directory Watch.
1069[ OK ] Stopped target Sockets.
1070[ OK ] Closed Avahi mDNS/DNS-SD Stack Activation Socket.
1071[ OK ] Closed D-Bus System Message Bus Socket.
1072[ OK ] Stopped target Slices.
1073[ OK ] Removed slice User and Session Slice.
1074[ OK ] Stopped target Paths.
1075[ OK ] Stopped target System Initialization.
1076[ OK ] Stopped target Swap.
1077 Stopping Network Time Synchronization...
1078 Stopping Update UTMP about System Boot/Shutdown...
1079[ OK ] Stopped target Encrypted Volumes.
1080[ OK ] Stopped Forward Password Requests to Wall Directory Watch.
1081 Stopping Load/Save Random Seed...
1082 Stopping Restore / save the current clock...
1083[ OK ] Stopped Network Time Synchronization.
1084[ OK ] Stopped Raise network interfaces.
1085[ OK ] Stopped Load/Save Random Seed.
1086[ OK ] Stopped Restore / save the current clock.
1087[ OK ] Stopped Update UTMP about System Boot/Shutdown.
1088[ OK ] Stopped Apply Kernel Variables.
1089[ OK ] Stopped Load Kernel Modules.
1090[ OK ] Stopped Create Volatile Files and Directories.
1091[ OK ] Stopped target Local File Systems.
1092 Unmounting /mutable...
1093 Unmounting /run/samba...
1094 Unmounting /var/cache/samba...
1095 Unmounting /backingfiles...
1096 Unmounting /boot...
1097 Unmounting /run/user/1000...
1098[ OK ] Unmounted /mutable.
1099[ OK ] Unmounted /run/samba.
1100[ OK ] Unmounted /var/cache/samba.
1101[ OK ] Unmounted /backingfiles.
1102[ OK ] Unmounted /boot.
1103[ OK ] Unmounted /run/user/1000.
1104[ OK ] Stopped File System Check on /dev/disk/by-partuuid/22eddddb-01.
1105[ OK ] Removed slice system-systemd\x2dfsck.slice.
1106[ OK ] Reached target Unmount All Filesystems.
1107[ OK ] Stopped target Local File Systems (Pre).
1108[ OK ] Stopped Create Static Device Nodes in /dev.
1109[ OK ] Stopped Remount Root and Kernel File Systems.
1110[ OK ] Reached target Shutdown.
1111[ OK ] Reached target Final Step.
1112 Starting Reboot...
1113====== setup log ======
1114Sat 15 Jun 22:27:32 BST 2019 : Detecting whether to update wpa_supplicant.conf
1115Sat 15 Jun 22:27:32 BST 2019 : Wifi variables specified, and no /boot/WIFI_ENABLED. Building wpa_supplicant.conf.
1116Sat 15 Jun 22:27:32 BST 2019 : Rebooting...
1117Sat 15 Jun 22:27:57 BST 2019 : Detecting whether to update wpa_supplicant.conf
1118Sat 15 Jun 22:27:57 BST 2019 : Grabbing main setup file.
1119Sat 15 Jun 22:27:58 BST 2019 : Starting setup.
1120Sat 15 Jun 22:27:58 BST 2019 : adding country code to wpa_supplicant.conf
1121Sat 15 Jun 22:27:58 BST 2019 : rebooting for changes to take effect
1122Sat 15 Jun 22:28:24 BST 2019 : Detecting whether to update wpa_supplicant.conf
1123Sat 15 Jun 22:28:24 BST 2019 : Starting setup.
1124Sat 15 Jun 22:28:24 BST 2019 : reading config from /root/teslausb_setup_variables.conf
1125Sat 15 Jun 22:28:24 BST 2019 : curl -s https://api.github.com/repos/marcone/teslausb/git/refs/heads/main-dev
1126Sat 15 Jun 22:28:25 BST 2019 : 'curl -s https://api.github.com/repos/marcone/teslausb/git/refs/heads/main-dev' failed, retrying
1127Sat 15 Jun 22:28:29 BST 2019 : 'curl -s https://api.github.com/repos/marcone/teslausb/git/refs/heads/main-dev' failed, retrying
1128Sat 15 Jun 22:28:32 BST 2019 : 'curl -s https://api.github.com/repos/marcone/teslausb/git/refs/heads/main-dev' failed, retrying
1129Sat 15 Jun 22:28:35 BST 2019 : 'curl -s https://api.github.com/repos/marcone/teslausb/git/refs/heads/main-dev' failed, retrying
1130Sat 15 Jun 22:28:39 BST 2019 : 'curl -s https://api.github.com/repos/marcone/teslausb/git/refs/heads/main-dev' failed, retrying
1131Sun 17 Nov 17:21:17 GMT 2019 : curl -o /tmp/setup-teslausb https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/setup-teslausb
1132Sun 17 Nov 17:21:18 GMT 2019 : Downloaded /tmp/setup-teslausb ...
1133Sun 17 Nov 17:21:18 GMT 2019 : /root/bin/setup-teslausb is up to date
1134Sun 17 Nov 17:21:18 GMT 2019 : Updating package index files...
1135Sun 17 Nov 18:22:52 CET 2019 : Verifying that the requested configuration is valid...
1136Sun 17 Nov 18:22:53 CET 2019 : curl -o /tmp/verify-configuration.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/verify-configuration.sh
1137Sun 17 Nov 18:22:53 CET 2019 : Downloaded /tmp/verify-configuration.sh ...
1138Sun 17 Nov 18:22:54 CET 2019 : usb_drive is not set. SD card will be used.
1139Sun 17 Nov 18:22:54 CET 2019 : Verifying that there is sufficient space available on the MicroSD card...
1140Sun 17 Nov 18:22:54 CET 2019 : There is sufficient space available.
1141Sun 17 Nov 18:23:02 CET 2019 : Downloading additional setup scripts.
1142Sun 17 Nov 18:23:02 CET 2019 : curl -o /root/bin/remountfs_rw https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/remountfs_rw
1143Sun 17 Nov 18:23:03 CET 2019 : Downloaded /root/bin/remountfs_rw ...
1144Sun 17 Nov 18:23:03 CET 2019 : curl -o /root/bin/make_snapshot.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/make_snapshot.sh
1145Sun 17 Nov 18:23:03 CET 2019 : Downloaded /root/bin/make_snapshot.sh ...
1146Sun 17 Nov 18:23:03 CET 2019 : curl -o /root/bin/mount_snapshot.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/mount_snapshot.sh
1147Sun 17 Nov 18:23:04 CET 2019 : Downloaded /root/bin/mount_snapshot.sh ...
1148Sun 17 Nov 18:23:04 CET 2019 : curl -o /root/bin/mount_image.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/mount_image.sh
1149Sun 17 Nov 18:23:05 CET 2019 : Downloaded /root/bin/mount_image.sh ...
1150Sun 17 Nov 18:23:05 CET 2019 : curl -o /root/bin/release_snapshot.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/release_snapshot.sh
1151Sun 17 Nov 18:23:05 CET 2019 : Downloaded /root/bin/release_snapshot.sh ...
1152Sun 17 Nov 18:23:05 CET 2019 : curl -o /root/bin/force_sync.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/run/force_sync.sh
1153Sun 17 Nov 18:23:06 CET 2019 : Downloaded /root/bin/force_sync.sh ...
1154Sun 17 Nov 18:23:06 CET 2019 : curl -o /tmp/create-backingfiles-partition.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/create-backingfiles-partition.sh
1155Sun 17 Nov 18:23:07 CET 2019 : Downloaded /tmp/create-backingfiles-partition.sh ...
1156Sun 17 Nov 18:23:07 CET 2019 : curl -o /tmp/create-backingfiles.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/create-backingfiles.sh
1157Sun 17 Nov 18:23:07 CET 2019 : Downloaded /tmp/create-backingfiles.sh ...
1158Sun 17 Nov 18:23:07 CET 2019 : curl -o /tmp/make-root-fs-readonly.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/make-root-fs-readonly.sh
1159Sun 17 Nov 18:23:08 CET 2019 : Downloaded /tmp/make-root-fs-readonly.sh ...
1160Sun 17 Nov 18:23:08 CET 2019 : curl -o /tmp/configure.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/configure.sh
1161Sun 17 Nov 18:23:09 CET 2019 : Downloaded /tmp/configure.sh ...
1162Sun 17 Nov 18:23:09 CET 2019 : Fixing the modules-load parameter in /boot/cmdline.txt...
1163Sun 17 Nov 18:23:09 CET 2019 : Fixed cmdline.txt.
1164Sun 17 Nov 18:23:18 CET 2019 : Checking existing partitions...
1165Sun 17 Nov 18:23:18 CET 2019 : Modifying partition table for backing files partition...
1166Sun 17 Nov 18:23:18 CET 2019 : Modifying partition table for mutable (writable) partition for script usage...
1167Sun 17 Nov 18:23:18 CET 2019 : Writing updated partitions to fstab and /boot/cmdline.txt
1168Sun 17 Nov 18:23:18 CET 2019 : Formatting new partitions...
1169Sun 17 Nov 18:23:35 CET 2019 : Mounting the partition for the backing files...
1170Sun 17 Nov 18:23:35 CET 2019 : Mounted the partition for the backing files.
1171Sun 17 Nov 18:23:35 CET 2019 : Creating backing disk files.
1172Sun 17 Nov 18:23:35 CET 2019 : create-backingfiles: starting
1173Sun 17 Nov 18:23:35 CET 2019 : create-backingfiles: cam: 40%, music: 100%, mountpoint: /backingfiles
1174Sun 17 Nov 18:23:36 CET 2019 : create-backingfiles: Allocating 73049200K for /backingfiles/cam_disk.bin...
1175Sun 17 Nov 18:23:36 CET 2019 : create-backingfiles: Creating filesystem with label 'CAM'
1176Sun 17 Nov 18:23:38 CET 2019 : create-backingfiles: updated /etc/fstab for /mnt/cam
1177Sun 17 Nov 18:23:38 CET 2019 : create-backingfiles: created camera backing file
1178Sun 17 Nov 18:23:38 CET 2019 : create-backingfiles: Allocating 109573800K for /backingfiles/music_disk.bin...
1179Sun 17 Nov 18:23:39 CET 2019 : create-backingfiles: Creating filesystem with label 'MUSIC'
1180Sun 17 Nov 18:23:42 CET 2019 : create-backingfiles: updated /etc/fstab for /mnt/music
1181Sun 17 Nov 18:23:42 CET 2019 : create-backingfiles: created music backing file
1182Sun 17 Nov 18:23:44 CET 2019 : create-backingfiles: done
1183Sun 17 Nov 18:23:54 CET 2019 : Main setup completed.
1184Sun 17 Nov 18:23:54 CET 2019 : calling configure.sh
1185Sun 17 Nov 18:23:54 CET 2019 : configure: /tmp/configure.sh starting with REPO=marcone, BRANCH=main-dev, ARCHIVE_SYSTEM=rsync
1186Sun 17 Nov 18:23:54 CET 2019 : configure: Getting files from marcone:main-dev
1187Sun 17 Nov 18:23:54 CET 2019 : configure: Pushover not configured.
1188Sun 17 Nov 18:23:54 CET 2019 : configure: Gotify not configured.
1189Sun 17 Nov 18:23:54 CET 2019 : configure: Gotify not configured.
1190Sun 17 Nov 18:23:54 CET 2019 : configure: Starting download for /root/bin/send-push-message
1191Sun 17 Nov 18:23:55 CET 2019 : configure: Done
1192Sun 17 Nov 18:23:55 CET 2019 : configure: Starting download for /root/bin/send_sns.py
1193Sun 17 Nov 18:23:55 CET 2019 : configure: Done
1194Sun 17 Nov 18:23:55 CET 2019 : configure: Checking archive configs:
1195Sun 17 Nov 18:23:55 CET 2019 : configure: done
1196Sun 17 Nov 18:23:56 CET 2019 : configure: Using archive module: run/rsync_archive
1197Sun 17 Nov 18:23:56 CET 2019 : configure: Installing base archive scripts into /root/bin
1198Sun 17 Nov 18:23:56 CET 2019 : configure: Starting download for /root/bin/archiveloop
1199Sun 17 Nov 18:23:56 CET 2019 : configure: Done
1200Sun 17 Nov 18:23:56 CET 2019 : configure: Starting download for /root/bin/remountfs_rw
1201Sun 17 Nov 18:23:57 CET 2019 : configure: Done
1202Sun 17 Nov 18:23:57 CET 2019 : configure: Skipping tesla_api.py install
1203Sun 17 Nov 18:23:57 CET 2019 : configure: Installing archive module scripts
1204Sun 17 Nov 18:23:57 CET 2019 : configure: Starting download for /tmp/verify-and-configure-archive.sh
1205Sun 17 Nov 18:23:57 CET 2019 : configure: Done
1206Sun 17 Nov 18:23:57 CET 2019 : configure: Starting download for /root/bin/archive-clips.sh
1207Sun 17 Nov 18:23:58 CET 2019 : configure: Done
1208Sun 17 Nov 18:23:58 CET 2019 : configure: Starting download for /root/bin/connect-archive.sh
1209Sun 17 Nov 18:23:59 CET 2019 : configure: Done
1210Sun 17 Nov 18:23:59 CET 2019 : configure: Starting download for /root/bin/disconnect-archive.sh
1211Sun 17 Nov 18:24:00 CET 2019 : configure: Done
1212Sun 17 Nov 18:24:00 CET 2019 : configure: Starting download for /root/bin/write-archive-configs-to.sh
1213Sun 17 Nov 18:24:01 CET 2019 : configure: Done
1214Sun 17 Nov 18:24:01 CET 2019 : configure: Starting download for /root/bin/archive-is-reachable.sh
1215Sun 17 Nov 18:24:01 CET 2019 : configure: Done
1216Sun 17 Nov 18:24:01 CET 2019 : configure: Skipping rc.local installation
1217Sun 17 Nov 18:24:01 CET 2019 : curl -o /tmp/configure-samba.sh https://raw.githubusercontent.com/marcone/teslausb/d3b96ef8c10ba42435ff8f1dedbc02e125ed4bac/setup/pi/configure-samba.sh
1218Sun 17 Nov 18:24:02 CET 2019 : Downloaded /tmp/configure-samba.sh ...
1219Sun 17 Nov 18:24:02 CET 2019 : configure-samba: Installing samba and dependencies...
1220Sun 17 Nov 18:25:59 CET 2019 : configure-samba: Done.
1221Sun 17 Nov 18:25:59 CET 2019 : make-root-fs-readonly: start
1222Sun 17 Nov 18:25:59 CET 2019 : make-root-fs-readonly: Removing unwanted packages...
1223Sun 17 Nov 18:26:56 CET 2019 : make-root-fs-readonly: Installing ntp and busybox-syslogd...
1224Sun 17 Nov 18:27:52 CET 2019 : make-root-fs-readonly: Configuring system...
1225Sun 17 Nov 18:27:52 CET 2019 : make-root-fs-readonly: Moving fake-hwclock data
1226Sun 17 Nov 18:27:52 CET 2019 : make-root-fs-readonly: done
1227Sun 17 Nov 18:27:52 CET 2019 : Skipping package upgrade.
1228Sun 17 Nov 18:27:52 CET 2019 : All done.
1229====== archiveloop log ======
1230==============================================
1231Thu 3 Nov 18:17:07 CET 2016: Starting archiveloop...
1232Thu 3 Nov 18:17:07 CET 2016: no snapshots
1233Thu 3 Nov 18:17:08 CET 2016: warning: low space for snapshots
1234Thu 3 Nov 18:17:08 CET 2016: taking snapshot of cam disk: /backingfiles/snapshots/snap-000000/snap.bin
1235Thu 3 Nov 18:17:12 CET 2016: took snapshot
1236Thu 3 Nov 18:17:12 CET 2016: comparing /backingfiles/snapshots/snap--00001/snap.bin.toc and /backingfiles/snapshots/newsnap/snap.bin.toc
1237Thu 3 Nov 18:17:12 CET 2016: making links for /backingfiles/snapshots/newsnap/mnt, retargeted to /backingfiles/snapshots/snap-000000/mnt
1238Thu 3 Nov 18:17:12 CET 2016: made all links for /backingfiles/snapshots/newsnap/mnt
1239Thu 3 Nov 18:17:12 CET 2016: Waiting for time to be set by ntpd...
1240Sun 17 Nov 18:29:02 CET 2019: Time still not set, attempting to force it
1241Sun 17 Nov 18:29:12 CET 2019: Ensuring music backing file is mounted...
1242Sun 17 Nov 18:29:12 CET 2019: Mounting /mnt/music...
1243Sun 17 Nov 18:29:12 CET 2019: Mounted /mnt/music.
1244Sun 17 Nov 18:29:12 CET 2019: Ensured music drive is mounted.
1245Sun 17 Nov 18:29:12 CET 2019: Running fsck on /mnt/music...
1246Sun 17 Nov 18:29:13 CET 2019: | fsck from util-linux 2.29.2
1247Sun 17 Nov 18:29:15 CET 2019: | fsck.fat 4.1 (2017-01-24)
1248Sun 17 Nov 18:29:15 CET 2019: | 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
1249Sun 17 Nov 18:29:15 CET 2019: | Automatically removing dirty bit.
1250Sun 17 Nov 18:29:15 CET 2019: | Performing changes.
1251Sun 17 Nov 18:29:15 CET 2019: | /dev/loop1: 1 files, 1/3423312 clusters
1252Sun 17 Nov 18:29:16 CET 2019: Finished fsck on /mnt/music.
1253Sun 17 Nov 18:29:16 CET 2019: Unmounting /mnt/music...
1254Sun 17 Nov 18:29:16 CET 2019: Unmounted /mnt/music.
1255Sun 17 Nov 18:29:16 CET 2019: Archiving...
1256Sun 17 Nov 18:29:16 CET 2019: Disconnecting usb from host...
1257Sun 17 Nov 18:29:16 CET 2019: Disconnected usb from host.
1258Sun 17 Nov 18:29:16 CET 2019: Checking saved folder count...
1259Sun 17 Nov 18:29:16 CET 2019: Ensuring cam file is mounted...
1260Sun 17 Nov 18:29:16 CET 2019: Mounting /mnt/cam...
1261Sun 17 Nov 18:29:16 CET 2019: Mounted /mnt/cam.
1262Sun 17 Nov 18:29:16 CET 2019: Ensured cam file is mounted.
1263Sun 17 Nov 18:29:17 CET 2019: Running fsck on /mnt/cam...
1264Sun 17 Nov 18:29:17 CET 2019: | fsck from util-linux 2.29.2
1265Sun 17 Nov 18:29:20 CET 2019: | fsck.fat 4.1 (2017-01-24)
1266Sun 17 Nov 18:29:20 CET 2019: | 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
1267Sun 17 Nov 18:29:20 CET 2019: | Automatically removing dirty bit.
1268Sun 17 Nov 18:29:20 CET 2019: | Performing changes.
1269Sun 17 Nov 18:29:20 CET 2019: | /dev/loop1: 2 files, 2/2282196 clusters
1270Sun 17 Nov 18:29:20 CET 2019: Finished fsck on /mnt/cam.
1271Sun 17 Nov 18:29:20 CET 2019: There are 0 event folder(s) with 0 file(s) to move.
1272Sun 17 Nov 18:29:20 CET 2019: Unmounting /mnt/cam...
1273Sun 17 Nov 18:29:21 CET 2019: Unmounted /mnt/cam.
1274Sun 17 Nov 18:29:21 CET 2019: Finished archiving.
1275Sun 17 Nov 18:29:21 CET 2019: Music archive not configured or unreachable
1276Sun 17 Nov 18:29:21 CET 2019: Connecting usb to host...
1277Sun 17 Nov 18:29:21 CET 2019: Connected usb to host.
1278Sun 17 Nov 18:29:21 CET 2019: Waiting for archive to be unreachable...
1279==============================================
1280Thu 3 Nov 18:17:26 CET 2016: Starting archiveloop...
1281Thu 3 Nov 18:17:26 CET 2016: mounting snapshot /backingfiles/snapshots/snap-000000/snap.bin
1282Thu 3 Nov 18:17:27 CET 2016: mounted all snapshots
1283Thu 3 Nov 18:17:27 CET 2016: low space, deleting /backingfiles/snapshots/snap-000000
1284Thu 3 Nov 18:17:30 CET 2016: warning: low space for snapshots
1285Thu 3 Nov 18:17:30 CET 2016: taking snapshot of cam disk: /backingfiles/snapshots/snap-000000/snap.bin
1286Thu 3 Nov 18:17:32 CET 2016: took snapshot
1287Thu 3 Nov 18:17:32 CET 2016: comparing /backingfiles/snapshots/snap--00001/snap.bin.toc and /backingfiles/snapshots/newsnap/snap.bin.toc
1288Thu 3 Nov 18:17:32 CET 2016: making links for /backingfiles/snapshots/newsnap/mnt, retargeted to /backingfiles/snapshots/snap-000000/mnt
1289Thu 3 Nov 18:17:32 CET 2016: made all links for /backingfiles/snapshots/newsnap/mnt
1290Thu 3 Nov 18:17:32 CET 2016: Ensuring cam file is mounted...
1291Thu 3 Nov 18:17:32 CET 2016: Mounting /mnt/cam...
1292Thu 3 Nov 18:17:33 CET 2016: Mounted /mnt/cam.
1293Thu 3 Nov 18:17:33 CET 2016: Ensured cam file is mounted.
1294Thu 3 Nov 18:17:33 CET 2016: Running fsck on /mnt/cam...
1295Thu 3 Nov 18:17:33 CET 2016: | fsck from util-linux 2.29.2
1296Thu 3 Nov 18:17:35 CET 2016: | fsck.fat 4.1 (2017-01-24)
1297Thu 3 Nov 18:17:35 CET 2016: | 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
1298Thu 3 Nov 18:17:35 CET 2016: | Automatically removing dirty bit.
1299Thu 3 Nov 18:17:35 CET 2016: | Performing changes.
1300Thu 3 Nov 18:17:35 CET 2016: | /dev/loop1: 2 files, 2/2282196 clusters
1301Thu 3 Nov 18:17:35 CET 2016: Finished fsck on /mnt/cam.
1302Thu 3 Nov 18:17:35 CET 2016: Unmounting /mnt/cam...
1303Thu 3 Nov 18:17:35 CET 2016: Unmounted /mnt/cam.
1304Thu 3 Nov 18:17:35 CET 2016: Ensuring music backing file is mounted...
1305Thu 3 Nov 18:17:35 CET 2016: Mounting /mnt/music...
1306Thu 3 Nov 18:17:35 CET 2016: Mounted /mnt/music.
1307Thu 3 Nov 18:17:35 CET 2016: Ensured music drive is mounted.
1308Thu 3 Nov 18:17:35 CET 2016: Running fsck on /mnt/music...
1309Thu 3 Nov 18:17:36 CET 2016: | fsck from util-linux 2.29.2
1310Thu 3 Nov 18:17:38 CET 2016: | fsck.fat 4.1 (2017-01-24)
1311Thu 3 Nov 18:17:38 CET 2016: | 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
1312Thu 3 Nov 18:17:38 CET 2016: | Automatically removing dirty bit.
1313Thu 3 Nov 18:17:38 CET 2016: | Performing changes.
1314Thu 3 Nov 18:17:38 CET 2016: | /dev/loop1: 1 files, 1/3423312 clusters
1315Thu 3 Nov 18:17:38 CET 2016: Finished fsck on /mnt/music.
1316Thu 3 Nov 18:17:38 CET 2016: Unmounting /mnt/music...
1317Thu 3 Nov 18:17:39 CET 2016: Unmounted /mnt/music.
1318Thu 3 Nov 18:17:39 CET 2016: Connecting usb to host...
1319Thu 3 Nov 18:17:39 CET 2016: Connected usb to host.
1320Thu 3 Nov 18:17:39 CET 2016: Waiting for archive to be reachable...
1321Thu 3 Nov 19:15:53 CET 2016: low space, deleting /backingfiles/snapshots/snap-000000
1322Thu 3 Nov 19:15:55 CET 2016: warning: low space for snapshots
1323Thu 3 Nov 19:15:55 CET 2016: taking snapshot of cam disk: /backingfiles/snapshots/snap-000000/snap.bin
1324Thu 3 Nov 19:15:58 CET 2016: took snapshot
1325Thu 3 Nov 19:15:58 CET 2016: comparing /backingfiles/snapshots/snap--00001/snap.bin.toc and /backingfiles/snapshots/newsnap/snap.bin.toc
1326Thu 3 Nov 19:15:58 CET 2016: making links for /backingfiles/snapshots/newsnap/mnt, retargeted to /backingfiles/snapshots/snap-000000/mnt
1327Thu 3 Nov 19:15:58 CET 2016: made all links for /backingfiles/snapshots/newsnap/mnt
1328Thu 3 Nov 20:14:18 CET 2016: low space, deleting /backingfiles/snapshots/snap-000000
1329Thu 3 Nov 20:14:21 CET 2016: warning: low space for snapshots
1330Thu 3 Nov 20:14:21 CET 2016: taking snapshot of cam disk: /backingfiles/snapshots/snap-000000/snap.bin
1331Thu 3 Nov 20:14:23 CET 2016: took snapshot
1332Thu 3 Nov 20:14:23 CET 2016: comparing /backingfiles/snapshots/snap--00001/snap.bin.toc and /backingfiles/snapshots/newsnap/snap.bin.toc
1333Thu 3 Nov 20:14:23 CET 2016: making links for /backingfiles/snapshots/newsnap/mnt, retargeted to /backingfiles/snapshots/snap-000000/mnt
1334Thu 3 Nov 20:14:24 CET 2016: made all links for /backingfiles/snapshots/newsnap/mnt
1335==============================================
1336Thu 3 Nov 18:17:26 CET 2016: Starting archiveloop...
1337Thu 3 Nov 18:17:27 CET 2016: mounting snapshot /backingfiles/snapshots/snap-000000/snap.bin
1338Thu 3 Nov 18:17:27 CET 2016: mounted all snapshots
1339Thu 3 Nov 18:17:28 CET 2016: low space, deleting /backingfiles/snapshots/snap-000000
1340Thu 3 Nov 18:17:31 CET 2016: warning: low space for snapshots
1341Thu 3 Nov 18:17:31 CET 2016: taking snapshot of cam disk: /backingfiles/snapshots/snap-000000/snap.bin
1342Thu 3 Nov 18:17:33 CET 2016: took snapshot
1343Thu 3 Nov 18:17:33 CET 2016: comparing /backingfiles/snapshots/snap--00001/snap.bin.toc and /backingfiles/snapshots/newsnap/snap.bin.toc
1344Thu 3 Nov 18:17:33 CET 2016: making links for /backingfiles/snapshots/newsnap/mnt, retargeted to /backingfiles/snapshots/snap-000000/mnt
1345Thu 3 Nov 18:17:33 CET 2016: made all links for /backingfiles/snapshots/newsnap/mnt
1346Thu 3 Nov 18:17:33 CET 2016: Ensuring cam file is mounted...
1347Thu 3 Nov 18:17:33 CET 2016: Mounting /mnt/cam...
1348Thu 3 Nov 18:17:33 CET 2016: Mounted /mnt/cam.
1349Thu 3 Nov 18:17:33 CET 2016: Ensured cam file is mounted.
1350Thu 3 Nov 18:17:33 CET 2016: Running fsck on /mnt/cam...
1351Thu 3 Nov 18:17:33 CET 2016: | fsck from util-linux 2.29.2
1352Thu 3 Nov 18:17:35 CET 2016: | fsck.fat 4.1 (2017-01-24)
1353Thu 3 Nov 18:17:35 CET 2016: | 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
1354Thu 3 Nov 18:17:35 CET 2016: | Automatically removing dirty bit.
1355Thu 3 Nov 18:17:35 CET 2016: | Performing changes.
1356Thu 3 Nov 18:17:35 CET 2016: | /dev/loop1: 2 files, 2/2282196 clusters
1357Thu 3 Nov 18:17:35 CET 2016: Finished fsck on /mnt/cam.
1358Thu 3 Nov 18:17:35 CET 2016: Unmounting /mnt/cam...
1359Thu 3 Nov 18:17:36 CET 2016: Unmounted /mnt/cam.
1360Thu 3 Nov 18:17:36 CET 2016: Ensuring music backing file is mounted...
1361Thu 3 Nov 18:17:36 CET 2016: Mounting /mnt/music...
1362Thu 3 Nov 18:17:36 CET 2016: Mounted /mnt/music.
1363Thu 3 Nov 18:17:36 CET 2016: Ensured music drive is mounted.
1364Thu 3 Nov 18:17:36 CET 2016: Running fsck on /mnt/music...
1365Thu 3 Nov 18:17:36 CET 2016: | fsck from util-linux 2.29.2
1366Thu 3 Nov 18:17:39 CET 2016: | fsck.fat 4.1 (2017-01-24)
1367Thu 3 Nov 18:17:39 CET 2016: | 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
1368Thu 3 Nov 18:17:39 CET 2016: | Automatically removing dirty bit.
1369Thu 3 Nov 18:17:39 CET 2016: | Performing changes.
1370Thu 3 Nov 18:17:39 CET 2016: | /dev/loop1: 1 files, 1/3423312 clusters
1371Thu 3 Nov 18:17:39 CET 2016: Finished fsck on /mnt/music.
1372Thu 3 Nov 18:17:39 CET 2016: Unmounting /mnt/music...
1373Thu 3 Nov 18:17:40 CET 2016: Unmounted /mnt/music.
1374Thu 3 Nov 18:17:40 CET 2016: Connecting usb to host...
1375Thu 3 Nov 18:17:40 CET 2016: Connected usb to host.
1376Thu 3 Nov 18:17:40 CET 2016: Waiting for archive to be reachable...
1377==============================================
1378Thu 3 Nov 18:17:06 CET 2016: Starting archiveloop...
1379Thu 3 Nov 18:17:06 CET 2016: mounting snapshot /backingfiles/snapshots/snap-000000/snap.bin
1380Thu 3 Nov 18:17:07 CET 2016: mounted all snapshots
1381Thu 3 Nov 18:17:07 CET 2016: low space, deleting /backingfiles/snapshots/snap-000000
1382Thu 3 Nov 18:17:12 CET 2016: warning: low space for snapshots
1383Thu 3 Nov 18:17:12 CET 2016: taking snapshot of cam disk: /backingfiles/snapshots/snap-000000/snap.bin
1384Mon 18 Nov 18:51:00 CET 2019: took snapshot
1385Mon 18 Nov 18:51:00 CET 2019: comparing /backingfiles/snapshots/snap--00001/snap.bin.toc and /backingfiles/snapshots/newsnap/snap.bin.toc
1386Mon 18 Nov 18:51:00 CET 2019: making links for /backingfiles/snapshots/newsnap/mnt, retargeted to /backingfiles/snapshots/snap-000000/mnt
1387Mon 18 Nov 18:51:00 CET 2019: made all links for /backingfiles/snapshots/newsnap/mnt
1388Mon 18 Nov 18:51:00 CET 2019: Waiting for time to be set by ntpd...
1389Mon 18 Nov 18:51:27 CET 2019: Time still not set, attempting to force it
1390Mon 18 Nov 18:51:38 CET 2019: Ensuring music backing file is mounted...
1391Mon 18 Nov 18:51:38 CET 2019: Mounting /mnt/music...
1392Mon 18 Nov 18:51:38 CET 2019: Mounted /mnt/music.
1393Mon 18 Nov 18:51:38 CET 2019: Ensured music drive is mounted.
1394Mon 18 Nov 18:51:38 CET 2019: Running fsck on /mnt/music...
1395Mon 18 Nov 18:51:38 CET 2019: | fsck from util-linux 2.29.2
1396Mon 18 Nov 18:51:41 CET 2019: | fsck.fat 4.1 (2017-01-24)
1397Mon 18 Nov 18:51:41 CET 2019: | 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
1398Mon 18 Nov 18:51:41 CET 2019: | Automatically removing dirty bit.
1399Mon 18 Nov 18:51:41 CET 2019: | Performing changes.
1400Mon 18 Nov 18:51:41 CET 2019: | /dev/loop1: 1 files, 1/3423312 clusters
1401Mon 18 Nov 18:51:41 CET 2019: Finished fsck on /mnt/music.
1402Mon 18 Nov 18:51:41 CET 2019: Unmounting /mnt/music...
1403Mon 18 Nov 18:51:42 CET 2019: Unmounted /mnt/music.
1404Mon 18 Nov 18:51:42 CET 2019: Archiving...
1405Mon 18 Nov 18:51:42 CET 2019: Disconnecting usb from host...
1406Mon 18 Nov 18:51:42 CET 2019: Disconnected usb from host.
1407Mon 18 Nov 18:51:42 CET 2019: Checking saved folder count...
1408Mon 18 Nov 18:51:42 CET 2019: Ensuring cam file is mounted...
1409Mon 18 Nov 18:51:42 CET 2019: Mounting /mnt/cam...
1410Mon 18 Nov 18:51:42 CET 2019: Mounted /mnt/cam.
1411Mon 18 Nov 18:51:42 CET 2019: Ensured cam file is mounted.
1412Mon 18 Nov 18:51:42 CET 2019: Running fsck on /mnt/cam...
1413Mon 18 Nov 18:51:43 CET 2019: | fsck from util-linux 2.29.2
1414Mon 18 Nov 18:51:44 CET 2019: | fsck.fat 4.1 (2017-01-24)
1415Mon 18 Nov 18:51:45 CET 2019: | 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
1416Mon 18 Nov 18:51:45 CET 2019: | Automatically removing dirty bit.
1417Mon 18 Nov 18:51:45 CET 2019: | Performing changes.
1418Mon 18 Nov 18:51:45 CET 2019: | /dev/loop1: 2 files, 2/2282196 clusters
1419Mon 18 Nov 18:51:45 CET 2019: Finished fsck on /mnt/cam.
1420Mon 18 Nov 18:51:45 CET 2019: There are 0 event folder(s) with 0 file(s) to move.
1421Mon 18 Nov 18:51:45 CET 2019: Unmounting /mnt/cam...
1422Mon 18 Nov 18:51:45 CET 2019: Unmounted /mnt/cam.
1423Mon 18 Nov 18:51:45 CET 2019: Finished archiving.
1424Mon 18 Nov 18:51:45 CET 2019: Music archive not configured or unreachable
1425Mon 18 Nov 18:51:45 CET 2019: Connecting usb to host...
1426Mon 18 Nov 18:51:45 CET 2019: Connected usb to host.
1427Mon 18 Nov 18:51:45 CET 2019: Waiting for archive to be unreachable...
1428====== system log ======
1429Nov 3 18:16:56 teslausb syslog.info syslogd started: BusyBox v1.22.1
1430Nov 3 18:16:57 teslausb daemon.info dhcpcd-run-hooks[356]: wlan0: starting wpa_supplicant
1431Nov 3 18:17:00 teslausb daemon.info bluetoothd[394]: Bluetooth daemon 5.43
1432Nov 3 18:17:00 teslausb daemon.info bluetoothd[394]: Starting SDP server
1433Nov 3 18:17:00 teslausb daemon.info bluetoothd[394]: Bluetooth management interface 1.14 initialized
1434Nov 3 18:17:00 teslausb daemon.notice dbus[246]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service'
1435Nov 3 18:17:00 teslausb daemon.err bluetoothd[394]: Failed to obtain handles for "Service Changed" characteristic
1436Nov 3 18:17:00 teslausb daemon.err bluetoothd[394]: Sap driver initialization failed.
1437Nov 3 18:17:00 teslausb daemon.err bluetoothd[394]: sap-server: Operation not permitted (1)
1438Nov 3 18:17:00 teslausb daemon.err bluetoothd[394]: Failed to set privacy: Rejected (0x0b)
1439Nov 3 18:17:00 teslausb daemon.notice dbus[246]: [system] Successfully activated service 'org.freedesktop.hostname1'
1440Nov 3 18:17:01 teslausb authpriv.debug CRON[405]: pam_unix(cron:account): account root has password changed in future
1441Nov 3 18:17:01 teslausb authpriv.info CRON[405]: pam_unix(cron:session): session opened for user root by (uid=0)
1442Nov 3 18:17:01 teslausb cron.info CRON[409]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
1443Nov 3 18:17:01 teslausb authpriv.info CRON[405]: pam_unix(cron:session): session closed for user root
1444Nov 3 18:17:06 teslausb daemon.notice ntpd[498]: ntpd 4.2.8p10@1.3728-o Sat Mar 10 18:03:33 UTC 2018 (1): Starting
1445Nov 3 18:17:06 teslausb daemon.info ntpd[498]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 109:114
1446Nov 3 18:17:06 teslausb daemon.info ntpd[504]: proto: precision = 2.000 usec (-19)
1447Nov 3 18:17:06 teslausb daemon.info ntpd[504]: Listen and drop on 0 v6wildcard [::]:123
1448Nov 3 18:17:06 teslausb daemon.info ntpd[504]: Listen and drop on 1 v4wildcard 0.0.0.0:123
1449Nov 3 18:17:06 teslausb daemon.info ntpd[504]: Listen normally on 2 lo 127.0.0.1:123
1450Nov 3 18:17:06 teslausb daemon.info ntpd[504]: Listen normally on 3 wlan0 192.168.0.81:123
1451Nov 3 18:17:06 teslausb daemon.info ntpd[504]: Listen normally on 4 lo [::1]:123
1452Nov 3 18:17:06 teslausb daemon.info ntpd[504]: Listen normally on 5 wlan0 [fe80::485a:e3ae:8a1c:ebc7%2]:123
1453Nov 3 18:17:06 teslausb daemon.info ntpd[504]: Listening on routing socket on fd #22 for interface updates
1454Nov 3 18:17:06 teslausb auth.info sshd[496]: Server listening on 0.0.0.0 port 22.
1455Nov 3 18:17:06 teslausb auth.info sshd[496]: Server listening on :: port 22.
1456Nov 3 18:17:07 teslausb daemon.info ntpd[504]: Soliciting pool server 80.127.152.30
1457Nov 3 18:17:08 teslausb daemon.info ntpd[504]: Soliciting pool server 94.228.220.14
1458Nov 3 18:17:08 teslausb daemon.info ntpd[504]: Soliciting pool server 213.239.154.12
1459Nov 3 18:17:09 teslausb daemon.info ntpd[504]: Soliciting pool server 129.250.35.250
1460Nov 3 18:17:09 teslausb daemon.info ntpd[504]: Soliciting pool server 109.201.133.100
1461Nov 3 18:17:09 teslausb daemon.info ntpd[504]: Soliciting pool server 80.127.119.186
1462Nov 3 18:17:10 teslausb daemon.info ntpd[504]: Soliciting pool server 162.159.200.1
1463Nov 3 18:17:10 teslausb daemon.info ntpd[504]: Soliciting pool server 84.245.9.254
1464Nov 3 18:17:10 teslausb daemon.info ntpd[504]: Soliciting pool server 93.94.224.67
1465Nov 3 18:17:10 teslausb daemon.info ntpd[504]: Soliciting pool server 83.98.201.134
1466Nov 3 18:17:11 teslausb daemon.info ntpd[504]: Soliciting pool server 109.201.133.2
1467Nov 3 18:17:11 teslausb daemon.info ntpd[504]: Soliciting pool server 162.159.200.123
1468Nov 3 18:17:11 teslausb daemon.info ntpd[504]: Soliciting pool server 91.198.87.118
1469Nov 3 18:17:13 teslausb daemon.info ntpd[504]: Soliciting pool server 46.243.26.34
1470Nov 3 18:17:13 teslausb daemon.info ntpd[504]: Soliciting pool server 213.136.0.252
1471Nov 3 18:17:13 teslausb daemon.info ntpd[504]: Soliciting pool server 129.250.35.251
1472Nov 3 18:17:13 teslausb daemon.info ntpd[504]: Soliciting pool server 213.154.236.182
1473Nov 3 18:17:13 teslausb daemon.info ntpd[504]: Soliciting pool server 2a06:1480:5ec:900::123:1
1474Nov 3 18:17:13 teslausb daemon.info ntpd[504]: Soliciting pool server 45.32.4.67
1475Nov 18 18:50:59 teslausb daemon.info ntpd[504]: receive: Unexpected origin timestamp 0xdbc5ef9a.c0cca72f does not match aorg 0000000000.00000000 from server@109.201.133.2 xmt 0xe17d5883.223e95fb
1476Nov 18 18:50:59 teslausb daemon.info ntpd[504]: receive: Unexpected origin timestamp 0xdbc5ef9a.c0d0ae4f does not match aorg 0000000000.00000000 from server@83.98.201.134 xmt 0xe17d5883.224135e0
1477Nov 18 18:50:59 teslausb daemon.info ntpd[504]: receive: Unexpected origin timestamp 0xdbc5ef9a.c0d49416 does not match aorg 0000000000.00000000 from server@84.245.9.254 xmt 0xe17d5883.22aeff43
1478Nov 18 18:50:59 teslausb daemon.info ntpd[504]: receive: Unexpected origin timestamp 0xdbc5ef9a.c0d82ffc does not match aorg 0000000000.00000000 from server@80.127.119.186 xmt 0xe17d5883.22b34b6d
1479Nov 18 18:50:59 teslausb daemon.info ntpd[504]: Soliciting pool server 213.109.127.82
1480Nov 18 18:51:27 teslausb daemon.notice ntpd[504]: ntpd exiting on signal 15 (Terminated)
1481Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 80.127.152.30 local addr 192.168.0.81 -> <null>
1482Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 94.228.220.14 local addr 192.168.0.81 -> <null>
1483Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 213.239.154.12 local addr 192.168.0.81 -> <null>
1484Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 129.250.35.250 local addr 192.168.0.81 -> <null>
1485Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 109.201.133.100 local addr 192.168.0.81 -> <null>
1486Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 80.127.119.186 local addr 192.168.0.81 -> <null>
1487Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 162.159.200.1 local addr 192.168.0.81 -> <null>
1488Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 84.245.9.254 local addr 192.168.0.81 -> <null>
1489Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 83.98.201.134 local addr 192.168.0.81 -> <null>
1490Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 109.201.133.2 local addr 192.168.0.81 -> <null>
1491Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 91.198.87.118 local addr 192.168.0.81 -> <null>
1492Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 162.159.200.123 local addr 192.168.0.81 -> <null>
1493Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 46.243.26.34 local addr 192.168.0.81 -> <null>
1494Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 213.136.0.252 local addr 192.168.0.81 -> <null>
1495Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 129.250.35.251 local addr 192.168.0.81 -> <null>
1496Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 213.154.236.182 local addr 192.168.0.81 -> <null>
1497Nov 18 18:51:27 teslausb daemon.info ntpd[504]: 213.109.127.82 local addr 192.168.0.81 -> <null>
1498Nov 18 18:51:27 teslausb daemon.notice ntpd[1255]: ntpd 4.2.8p10@1.3728-o Sat Mar 10 18:03:33 UTC 2018 (1): Starting
1499Nov 18 18:51:27 teslausb daemon.info ntpd[1255]: Command line: ntpd -q -x -g
1500Nov 18 18:51:28 teslausb daemon.info ntpd[1255]: proto: precision = 2.000 usec (-19)
1501Nov 18 18:51:28 teslausb daemon.info ntpd[1255]: Listen and drop on 0 v6wildcard [::]:123
1502Nov 18 18:51:28 teslausb daemon.info ntpd[1255]: Listen and drop on 1 v4wildcard 0.0.0.0:123
1503Nov 18 18:51:28 teslausb daemon.info ntpd[1255]: Listen normally on 2 lo 127.0.0.1:123
1504Nov 18 18:51:28 teslausb daemon.info ntpd[1255]: Listen normally on 3 wlan0 192.168.0.81:123
1505Nov 18 18:51:28 teslausb daemon.info ntpd[1255]: Listen normally on 4 lo [::1]:123
1506Nov 18 18:51:28 teslausb daemon.info ntpd[1255]: Listen normally on 5 wlan0 [fe80::485a:e3ae:8a1c:ebc7%2]:123
1507Nov 18 18:51:28 teslausb daemon.info ntpd[1255]: Listening on routing socket on fd #22 for interface updates
1508Nov 18 18:51:29 teslausb daemon.info ntpd[1255]: Soliciting pool server 83.98.155.30
1509Nov 18 18:51:29 teslausb daemon.info ntpd[1255]: Soliciting pool server 213.136.0.252
1510Nov 18 18:51:30 teslausb daemon.info ntpd[1255]: Soliciting pool server 62.251.108.41
1511Nov 18 18:51:30 teslausb daemon.info ntpd[1255]: Soliciting pool server 129.250.35.251
1512Nov 18 18:51:31 teslausb daemon.info ntpd[1255]: Soliciting pool server 129.250.35.251
1513Nov 18 18:51:31 teslausb daemon.info ntpd[1255]: Soliciting pool server 171.33.132.5
1514Nov 18 18:51:32 teslausb daemon.info ntpd[1255]: Soliciting pool server 149.210.142.45
1515Nov 18 18:51:32 teslausb daemon.info ntpd[1255]: Soliciting pool server 82.161.247.86
1516Nov 18 18:51:32 teslausb daemon.info ntpd[1255]: Soliciting pool server 83.163.190.85
1517Nov 18 18:51:33 teslausb daemon.info ntpd[1255]: Soliciting pool server 213.239.154.12
1518Nov 18 18:51:33 teslausb daemon.info ntpd[1255]: Soliciting pool server 31.3.104.60
1519Nov 18 18:51:33 teslausb daemon.info ntpd[1255]: Soliciting pool server 188.226.159.244
1520Nov 18 18:51:34 teslausb daemon.info ntpd[1255]: Soliciting pool server 149.210.230.59
1521Nov 18 18:51:34 teslausb daemon.info ntpd[1255]: Soliciting pool server 5.79.108.34
1522Nov 18 18:51:34 teslausb daemon.info ntpd[1255]: Soliciting pool server 93.94.224.67
1523Nov 18 18:51:35 teslausb daemon.info ntpd[1255]: Soliciting pool server 109.201.133.100
1524Nov 18 18:51:38 teslausb daemon.notice ntpd[1255]: ntpd: time slew -0.000620 s
1525Nov 18 18:51:38 teslausb daemon.notice ntpd[1415]: ntpd 4.2.8p10@1.3728-o Sat Mar 10 18:03:33 UTC 2018 (1): Starting
1526Nov 18 18:51:38 teslausb daemon.info ntpd[1415]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 109:114
1527Nov 18 18:51:38 teslausb daemon.info ntpd[1418]: proto: precision = 2.000 usec (-19)
1528Nov 18 18:51:38 teslausb daemon.info ntpd[1418]: Listen and drop on 0 v6wildcard [::]:123
1529Nov 18 18:51:38 teslausb daemon.info ntpd[1418]: Listen and drop on 1 v4wildcard 0.0.0.0:123
1530Nov 18 18:51:38 teslausb daemon.info ntpd[1418]: Listen normally on 2 lo 127.0.0.1:123
1531Nov 18 18:51:38 teslausb daemon.info ntpd[1418]: Listen normally on 3 wlan0 192.168.0.81:123
1532Nov 18 18:51:38 teslausb daemon.info ntpd[1418]: Listen normally on 4 lo [::1]:123
1533Nov 18 18:51:38 teslausb daemon.info ntpd[1418]: Listen normally on 5 wlan0 [fe80::485a:e3ae:8a1c:ebc7%2]:123
1534Nov 18 18:51:38 teslausb daemon.info ntpd[1418]: Listening on routing socket on fd #22 for interface updates
1535Nov 18 18:51:39 teslausb daemon.info ntpd[1418]: Soliciting pool server 162.159.200.1
1536Nov 18 18:51:40 teslausb daemon.info ntpd[1418]: Soliciting pool server 162.159.200.123
1537Nov 18 18:51:40 teslausb daemon.info ntpd[1418]: Soliciting pool server 77.72.144.59
1538Nov 18 18:51:41 teslausb daemon.info ntpd[1418]: Soliciting pool server 213.154.236.182
1539Nov 18 18:51:41 teslausb daemon.info ntpd[1418]: Soliciting pool server 174.138.9.187
1540Nov 18 18:51:41 teslausb daemon.info ntpd[1418]: Soliciting pool server 83.98.201.134
1541Nov 18 18:51:42 teslausb daemon.info ntpd[1418]: Soliciting pool server 109.201.133.100
1542Nov 18 18:51:42 teslausb daemon.info ntpd[1418]: Soliciting pool server 131.211.8.244
1543Nov 18 18:51:42 teslausb daemon.info ntpd[1418]: Soliciting pool server 62.251.106.138
1544Nov 18 18:51:43 teslausb daemon.info ntpd[1418]: Soliciting pool server 37.97.195.195
1545Nov 18 18:51:43 teslausb daemon.info ntpd[1418]: Soliciting pool server 83.162.149.224
1546Nov 18 18:51:43 teslausb daemon.info ntpd[1418]: Soliciting pool server 5.79.108.34
1547Nov 18 18:51:44 teslausb daemon.info ntpd[1418]: Soliciting pool server 82.161.139.11
1548Nov 18 18:51:44 teslausb daemon.info ntpd[1418]: Soliciting pool server 82.161.139.11
1549Nov 18 18:51:44 teslausb daemon.info ntpd[1418]: Soliciting pool server 94.228.143.152
1550Nov 18 18:51:45 teslausb daemon.info ntpd[1418]: Soliciting pool server 94.228.220.14
1551Nov 18 18:51:45 teslausb daemon.info ntpd[1418]: Soliciting pool server 146.185.170.220
1552Nov 18 18:51:46 teslausb daemon.info ntpd[1418]: Soliciting pool server 45.32.4.67
1553Nov 18 18:55:26 teslausb auth.info sshd[2440]: Accepted password for pi from 192.168.0.54 port 58195 ssh2
1554Nov 18 18:55:26 teslausb authpriv.info sshd[2440]: pam_unix(sshd:session): session opened for user pi by (uid=0)
1555Nov 18 18:55:27 teslausb authpriv.info systemd: pam_unix(systemd-user:session): session opened for user pi by (uid=0)
1556Nov 18 18:55:27 teslausb auth.info sshd[2440]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory
1557Nov 18 18:55:27 teslausb auth.info sshd[2440]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory
1558Nov 18 18:55:41 teslausb authpriv.notice sudo: pi : TTY=pts/0 ; PWD=/mnt ; USER=root ; COMMAND=/bin/bash
1559Nov 18 18:55:41 teslausb authpriv.info sudo: pam_unix(sudo:session): session opened for user root by pi(uid=0)
1560====== dmesg ======
1561[Mon Nov 18 18:50:25 2019] Booting Linux on physical CPU 0x0
1562[Mon Nov 18 18:50:25 2019] Linux version 4.19.50+ (dom@dom-XPS-13-9370) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1234 Thu Jun 13 10:47:38 BST 2019
1563[Mon Nov 18 18:50:25 2019] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
1564[Mon Nov 18 18:50:25 2019] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
1565[Mon Nov 18 18:50:25 2019] OF: fdt: Machine model: Raspberry Pi Zero W Rev 1.1
1566[Mon Nov 18 18:50:25 2019] Memory policy: Data cache writeback
1567[Mon Nov 18 18:50:25 2019] cma: Reserved 8 MiB at 0x1b400000
1568[Mon Nov 18 18:50:25 2019] On node 0 totalpages: 114688
1569[Mon Nov 18 18:50:25 2019] Normal zone: 1008 pages used for memmap
1570[Mon Nov 18 18:50:25 2019] Normal zone: 0 pages reserved
1571[Mon Nov 18 18:50:25 2019] Normal zone: 114688 pages, LIFO batch:31
1572[Mon Nov 18 18:50:25 2019] random: get_random_bytes called from start_kernel+0x8c/0x49c with crng_init=0
1573[Mon Nov 18 18:50:25 2019] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
1574[Mon Nov 18 18:50:25 2019] pcpu-alloc: [0] 0
1575[Mon Nov 18 18:50:25 2019] Built 1 zonelists, mobility grouping on. Total pages: 113680
1576[Mon Nov 18 18:50:25 2019] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:02:5C:39 vc_mem.mem_base=0x1ec00000 vc_mem.mem_size=0x20000000 dwc_otg.lpm_enable=0 console=ttyS0,115200 console=tty1 root=PARTUUID=22eddddb-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait modules-load=dwc2 quiet fastboot noswap ro
1577[Mon Nov 18 18:50:25 2019] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
1578[Mon Nov 18 18:50:25 2019] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
1579[Mon Nov 18 18:50:25 2019] Memory: 434484K/458752K available (6935K kernel code, 633K rwdata, 2068K rodata, 460K init, 797K bss, 16076K reserved, 8192K cma-reserved)
1580[Mon Nov 18 18:50:25 2019] Virtual kernel memory layout:
1581 vector : 0xffff0000 - 0xffff1000 ( 4 kB)
1582 fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
1583 vmalloc : 0xdc800000 - 0xff800000 ( 560 MB)
1584 lowmem : 0xc0000000 - 0xdc000000 ( 448 MB)
1585 modules : 0xbf000000 - 0xc0000000 ( 16 MB)
1586 .text : 0x(ptrval) - 0x(ptrval) (6936 kB)
1587 .init : 0x(ptrval) - 0x(ptrval) ( 460 kB)
1588 .data : 0x(ptrval) - 0x(ptrval) ( 634 kB)
1589 .bss : 0x(ptrval) - 0x(ptrval) ( 798 kB)
1590[Mon Nov 18 18:50:25 2019] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
1591[Mon Nov 18 18:50:25 2019] ftrace: allocating 25054 entries in 74 pages
1592[Mon Nov 18 18:50:25 2019] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
1593[Mon Nov 18 18:50:25 2019] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
1594[Mon Nov 18 18:50:25 2019] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
1595[Mon Nov 18 18:50:25 2019] bcm2835: system timer (irq = 27)
1596[Mon Nov 18 18:50:25 2019] Console: colour dummy device 80x30
1597[Mon Nov 18 18:50:25 2019] console [tty1] enabled
1598[Mon Nov 18 18:50:25 2019] Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792)
1599[Mon Nov 18 18:50:25 2019] pid_max: default: 32768 minimum: 301
1600[Mon Nov 18 18:50:25 2019] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
1601[Mon Nov 18 18:50:25 2019] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
1602[Mon Nov 18 18:50:25 2019] CPU: Testing write buffer coherency: ok
1603[Mon Nov 18 18:50:25 2019] Setting up static identity map for 0x8200 - 0x8238
1604[Mon Nov 18 18:50:25 2019] devtmpfs: initialized
1605[Mon Nov 18 18:50:25 2019] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
1606[Mon Nov 18 18:50:25 2019] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
1607[Mon Nov 18 18:50:25 2019] futex hash table entries: 256 (order: -1, 3072 bytes)
1608[Mon Nov 18 18:50:25 2019] pinctrl core: initialized pinctrl subsystem
1609[Mon Nov 18 18:50:25 2019] NET: Registered protocol family 16
1610[Mon Nov 18 18:50:25 2019] DMA: preallocated 1024 KiB pool for atomic coherent allocations
1611[Mon Nov 18 18:50:25 2019] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
1612[Mon Nov 18 18:50:25 2019] hw-breakpoint: maximum watchpoint size is 4 bytes.
1613[Mon Nov 18 18:50:25 2019] Serial: AMBA PL011 UART driver
1614[Mon Nov 18 18:50:25 2019] bcm2835-mbox 2000b880.mailbox: mailbox enabled
1615[Mon Nov 18 18:50:25 2019] bcm2835-dma 20007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
1616[Mon Nov 18 18:50:25 2019] SCSI subsystem initialized
1617[Mon Nov 18 18:50:25 2019] usbcore: registered new interface driver usbfs
1618[Mon Nov 18 18:50:25 2019] usbcore: registered new interface driver hub
1619[Mon Nov 18 18:50:25 2019] usbcore: registered new device driver usb
1620[Mon Nov 18 18:50:25 2019] raspberrypi-firmware soc:firmware: Attached to firmware from 2019-06-10 15:12, variant start
1621[Mon Nov 18 18:50:25 2019] raspberrypi-firmware soc:firmware: Firmware hash is e57a7ab1847d26251175e99d158a29ed46eb9ca4
1622[Mon Nov 18 18:50:25 2019] clocksource: Switched to clocksource timer
1623[Mon Nov 18 18:50:25 2019] VFS: Disk quotas dquot_6.6.0
1624[Mon Nov 18 18:50:25 2019] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
1625[Mon Nov 18 18:50:25 2019] FS-Cache: Loaded
1626[Mon Nov 18 18:50:25 2019] CacheFiles: Loaded
1627[Mon Nov 18 18:50:25 2019] NET: Registered protocol family 2
1628[Mon Nov 18 18:50:25 2019] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes)
1629[Mon Nov 18 18:50:25 2019] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
1630[Mon Nov 18 18:50:25 2019] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
1631[Mon Nov 18 18:50:25 2019] TCP: Hash tables configured (established 4096 bind 4096)
1632[Mon Nov 18 18:50:25 2019] UDP hash table entries: 256 (order: 0, 4096 bytes)
1633[Mon Nov 18 18:50:25 2019] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
1634[Mon Nov 18 18:50:25 2019] NET: Registered protocol family 1
1635[Mon Nov 18 18:50:25 2019] RPC: Registered named UNIX socket transport module.
1636[Mon Nov 18 18:50:25 2019] RPC: Registered udp transport module.
1637[Mon Nov 18 18:50:25 2019] RPC: Registered tcp transport module.
1638[Mon Nov 18 18:50:25 2019] RPC: Registered tcp NFSv4.1 backchannel transport module.
1639[Mon Nov 18 18:50:25 2019] hw perfevents: no irqs for PMU, sampling events not supported
1640[Mon Nov 18 18:50:25 2019] hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
1641[Mon Nov 18 18:50:25 2019] Initialise system trusted keyrings
1642[Mon Nov 18 18:50:25 2019] workingset: timestamp_bits=14 max_order=17 bucket_order=3
1643[Mon Nov 18 18:50:25 2019] FS-Cache: Netfs 'nfs' registered for caching
1644[Mon Nov 18 18:50:25 2019] NFS: Registering the id_resolver key type
1645[Mon Nov 18 18:50:25 2019] Key type id_resolver registered
1646[Mon Nov 18 18:50:25 2019] Key type id_legacy registered
1647[Mon Nov 18 18:50:25 2019] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
1648[Mon Nov 18 18:50:25 2019] Key type asymmetric registered
1649[Mon Nov 18 18:50:25 2019] Asymmetric key parser 'x509' registered
1650[Mon Nov 18 18:50:25 2019] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
1651[Mon Nov 18 18:50:25 2019] io scheduler noop registered
1652[Mon Nov 18 18:50:25 2019] io scheduler deadline registered (default)
1653[Mon Nov 18 18:50:25 2019] io scheduler cfq registered
1654[Mon Nov 18 18:50:25 2019] io scheduler mq-deadline registered (default)
1655[Mon Nov 18 18:50:25 2019] io scheduler kyber registered
1656[Mon Nov 18 18:50:25 2019] BCM2708FB: allocated DMA memory 0x5b500000
1657[Mon Nov 18 18:50:25 2019] BCM2708FB: allocated DMA channel 0
1658[Mon Nov 18 18:50:25 2019] Console: switching to colour frame buffer device 82x26
1659[Mon Nov 18 18:50:25 2019] bcm2835-rng 20104000.rng: hwrng registered
1660[Mon Nov 18 18:50:25 2019] vc-mem: phys_addr:0x00000000 mem_base=0x1ec00000 mem_size:0x20000000(512 MiB)
1661[Mon Nov 18 18:50:25 2019] vc-sm: Videocore shared memory driver
1662[Mon Nov 18 18:50:25 2019] gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
1663[Mon Nov 18 18:50:25 2019] brd: module loaded
1664[Mon Nov 18 18:50:25 2019] loop: module loaded
1665[Mon Nov 18 18:50:25 2019] Loading iSCSI transport class v2.0-870.
1666[Mon Nov 18 18:50:25 2019] usbcore: registered new interface driver smsc95xx
1667[Mon Nov 18 18:50:25 2019] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
1668[Mon Nov 18 18:50:25 2019] dwc_otg: FIQ enabled
1669[Mon Nov 18 18:50:25 2019] dwc_otg: NAK holdoff enabled
1670[Mon Nov 18 18:50:25 2019] dwc_otg: FIQ split-transaction FSM enabled
1671[Mon Nov 18 18:50:25 2019] Module dwc_common_port init
1672[Mon Nov 18 18:50:25 2019] usbcore: registered new interface driver usb-storage
1673[Mon Nov 18 18:50:25 2019] mousedev: PS/2 mouse device common for all mice
1674[Mon Nov 18 18:50:25 2019] bcm2835-wdt 20100000.watchdog: Broadcom BCM2835 watchdog timer
1675[Mon Nov 18 18:50:25 2019] bcm2835-cpufreq: min=700000 max=1000000
1676[Mon Nov 18 18:50:25 2019] sdhci: Secure Digital Host Controller Interface driver
1677[Mon Nov 18 18:50:25 2019] sdhci: Copyright(c) Pierre Ossman
1678[Mon Nov 18 18:50:25 2019] mmc-bcm2835 20300000.mmcnr: could not get clk, deferring probe
1679[Mon Nov 18 18:50:25 2019] sdhost-bcm2835 20202000.mmc: could not get clk, deferring probe
1680[Mon Nov 18 18:50:25 2019] sdhci-pltfm: SDHCI platform and OF driver helper
1681[Mon Nov 18 18:50:25 2019] ledtrig-cpu: registered to indicate activity on CPUs
1682[Mon Nov 18 18:50:25 2019] hidraw: raw HID events driver (C) Jiri Kosina
1683[Mon Nov 18 18:50:25 2019] usbcore: registered new interface driver usbhid
1684[Mon Nov 18 18:50:25 2019] usbhid: USB HID core driver
1685[Mon Nov 18 18:50:25 2019] vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
1686[Mon Nov 18 18:50:25 2019] [vc_sm_connected_init]: start
1687[Mon Nov 18 18:50:25 2019] [vc_sm_connected_init]: end - returning 0
1688[Mon Nov 18 18:50:25 2019] Initializing XFRM netlink socket
1689[Mon Nov 18 18:50:25 2019] NET: Registered protocol family 17
1690[Mon Nov 18 18:50:25 2019] Key type dns_resolver registered
1691[Mon Nov 18 18:50:25 2019] registered taskstats version 1
1692[Mon Nov 18 18:50:25 2019] Loading compiled-in X.509 certificates
1693[Mon Nov 18 18:50:25 2019] uart-pl011 20201000.serial: cts_event_workaround enabled
1694[Mon Nov 18 18:50:25 2019] 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2
1695[Mon Nov 18 18:50:25 2019] mmc-bcm2835 20300000.mmcnr: mmc_debug:0 mmc_debug2:0
1696[Mon Nov 18 18:50:25 2019] mmc-bcm2835 20300000.mmcnr: DMA channel allocated
1697[Mon Nov 18 18:50:25 2019] sdhost: log_buf @ (ptrval) (5b510000)
1698[Mon Nov 18 18:50:25 2019] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
1699[Mon Nov 18 18:50:25 2019] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
1700[Mon Nov 18 18:50:25 2019] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
1701[Mon Nov 18 18:50:25 2019] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
1702[Mon Nov 18 18:50:25 2019] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
1703[Mon Nov 18 18:50:25 2019] of_cfs_init
1704[Mon Nov 18 18:50:25 2019] of_cfs_init: OK
1705[Mon Nov 18 18:50:25 2019] Waiting for root device PARTUUID=22eddddb-02...
1706[Mon Nov 18 18:50:25 2019] random: fast init done
1707[Mon Nov 18 18:50:25 2019] mmc0: host does not support reading read-only switch, assuming write-enable
1708[Mon Nov 18 18:50:25 2019] mmc0: new high speed SDXC card at address aaaa
1709[Mon Nov 18 18:50:25 2019] mmcblk0: mmc0:aaaa SC200 183 GiB
1710[Mon Nov 18 18:50:25 2019] mmcblk0: p1 p2 p3 p4
1711[Mon Nov 18 18:50:25 2019] mmc1: new high speed SDIO card at address 0001
1712[Mon Nov 18 18:50:25 2019] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
1713[Mon Nov 18 18:50:25 2019] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
1714[Mon Nov 18 18:50:25 2019] devtmpfs: mounted
1715[Mon Nov 18 18:50:25 2019] Freeing unused kernel memory: 460K
1716[Mon Nov 18 18:50:25 2019] This architecture does not have kernel memory protection.
1717[Mon Nov 18 18:50:25 2019] Run /sbin/init as init process
1718[Mon Nov 18 18:50:26 2019] systemd[1]: System time before build time, advancing clock.
1719[Mon Nov 18 18:50:26 2019] NET: Registered protocol family 10
1720[Mon Nov 18 18:50:26 2019] Segment Routing with IPv6
1721[Mon Nov 18 18:50:26 2019] random: systemd: uninitialized urandom read (16 bytes read)
1722[Mon Nov 18 18:50:26 2019] systemd[1]: systemd 232 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN)
1723[Mon Nov 18 18:50:26 2019] systemd[1]: Detected architecture arm.
1724[Mon Nov 18 18:50:26 2019] systemd[1]: Set hostname to <teslausb>.
1725[Mon Nov 18 18:50:26 2019] random: systemd: uninitialized urandom read (16 bytes read)
1726[Mon Nov 18 18:50:26 2019] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read)
1727[Mon Nov 18 18:50:27 2019] systemd[1]: Listening on fsck to fsckd communication Socket.
1728[Mon Nov 18 18:50:27 2019] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
1729[Mon Nov 18 18:50:27 2019] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
1730[Mon Nov 18 18:50:27 2019] systemd[1]: Created slice User and Session Slice.
1731[Mon Nov 18 18:50:27 2019] systemd[1]: Listening on udev Kernel Socket.
1732[Mon Nov 18 18:50:27 2019] systemd[1]: Listening on udev Control Socket.
1733[Mon Nov 18 18:50:27 2019] systemd[1]: Listening on Journal Socket (/dev/log).
1734[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: 20980000.usb supply vusb_d not found, using dummy regulator
1735[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: Linked as a consumer to regulator.0
1736[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: 20980000.usb supply vusb_a not found, using dummy regulator
1737[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: dwc2_check_params: Invalid parameter lpm=1
1738[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: dwc2_check_params: Invalid parameter lpm_clock_gating=1
1739[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: dwc2_check_params: Invalid parameter besl=1
1740[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: dwc2_check_params: Invalid parameter hird_threshold_en=1
1741[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: EPs: 8, dedicated fifos, 4080 entries in SPRAM
1742[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: DWC OTG Controller
1743[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: new USB bus registered, assigned bus number 1
1744[Mon Nov 18 18:50:28 2019] dwc2 20980000.usb: irq 33, io mem 0x20980000
1745[Mon Nov 18 18:50:28 2019] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
1746[Mon Nov 18 18:50:28 2019] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
1747[Mon Nov 18 18:50:28 2019] usb usb1: Product: DWC OTG Controller
1748[Mon Nov 18 18:50:28 2019] usb usb1: Manufacturer: Linux 4.19.50+ dwc2_hsotg
1749[Mon Nov 18 18:50:28 2019] usb usb1: SerialNumber: 20980000.usb
1750[Mon Nov 18 18:50:28 2019] hub 1-0:1.0: USB hub found
1751[Mon Nov 18 18:50:28 2019] hub 1-0:1.0: 1 port detected
1752[Mon Nov 18 18:50:30 2019] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
1753[Mon Nov 18 18:50:31 2019] systemd-journald[63]: Received request to flush runtime journal from PID 1
1754[Mon Nov 18 18:50:33 2019] media: Linux media interface: v0.10
1755[Mon Nov 18 18:50:33 2019] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
1756[Mon Nov 18 18:50:33 2019] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
1757[Mon Nov 18 18:50:33 2019] [vc_sm_connected_init]: start
1758[Mon Nov 18 18:50:33 2019] [vc_sm_connected_init]: installed successfully
1759[Mon Nov 18 18:50:33 2019] videodev: Linux video capture interface: v2.00
1760[Mon Nov 18 18:50:33 2019] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
1761[Mon Nov 18 18:50:33 2019] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
1762[Mon Nov 18 18:50:33 2019] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
1763[Mon Nov 18 18:50:33 2019] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
1764[Mon Nov 18 18:50:33 2019] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
1765[Mon Nov 18 18:50:33 2019] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
1766[Mon Nov 18 18:50:33 2019] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
1767[Mon Nov 18 18:50:33 2019] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
1768[Mon Nov 18 18:50:33 2019] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
1769[Mon Nov 18 18:50:33 2019] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
1770[Mon Nov 18 18:50:34 2019] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
1771[Mon Nov 18 18:50:34 2019] bcm2835_audio soc:audio: card created with 8 channels
1772[Mon Nov 18 18:50:35 2019] cfg80211: Loading compiled-in X.509 certificates for regulatory database
1773[Mon Nov 18 18:50:35 2019] EXT4-fs (mmcblk0p4): recovery complete
1774[Mon Nov 18 18:50:35 2019] EXT4-fs (mmcblk0p4): mounted filesystem with ordered data mode. Opts: (null)
1775[Mon Nov 18 18:50:35 2019] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
1776[Mon Nov 18 18:50:35 2019] SGI XFS with ACLs, security attributes, realtime, no debug enabled
1777[Mon Nov 18 18:50:35 2019] XFS (mmcblk0p3): Mounting V5 Filesystem
1778[Mon Nov 18 18:50:35 2019] brcmfmac: F1 signature read @0x18000000=0x1541a9a6
1779[Mon Nov 18 18:50:35 2019] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
1780[Mon Nov 18 18:50:35 2019] usbcore: registered new interface driver brcmfmac
1781[Mon Nov 18 18:50:35 2019] XFS (mmcblk0p3): Starting recovery (logdev: internal)
1782[Mon Nov 18 18:50:35 2019] XFS (mmcblk0p3): Ending recovery (logdev: internal)
1783[Mon Nov 18 18:50:36 2019] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1
1784[Mon Nov 18 18:50:36 2019] brcmfmac: brcmf_c_process_clm_blob: no clm_blob available (err=-2), device may have limited channels available
1785[Mon Nov 18 18:50:36 2019] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Oct 23 2017 03:55:53 version 7.45.98.38 (r674442 CY) FWID 01-e58d219f
1786[Mon Nov 18 18:50:39 2019] random: crng init done
1787[Mon Nov 18 18:50:39 2019] random: 7 urandom warning(s) missed due to ratelimiting
1788[Mon Nov 18 18:50:39 2019] uart-pl011 20201000.serial: no DMA platform data
1789[Mon Nov 18 18:50:42 2019] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
1790[Mon Nov 18 18:50:42 2019] brcmfmac: power management disabled
1791[Mon Nov 18 18:50:43 2019] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
1792[Mon Nov 18 18:50:44 2019] Bluetooth: Core ver 2.22
1793[Mon Nov 18 18:50:44 2019] NET: Registered protocol family 31
1794[Mon Nov 18 18:50:44 2019] Bluetooth: HCI device and connection manager initialized
1795[Mon Nov 18 18:50:44 2019] Bluetooth: HCI socket layer initialized
1796[Mon Nov 18 18:50:44 2019] Bluetooth: L2CAP socket layer initialized
1797[Mon Nov 18 18:50:44 2019] Bluetooth: SCO socket layer initialized
1798[Mon Nov 18 18:50:44 2019] Bluetooth: HCI UART driver ver 2.3
1799[Mon Nov 18 18:50:44 2019] Bluetooth: HCI UART protocol H4 registered
1800[Mon Nov 18 18:50:44 2019] Bluetooth: HCI UART protocol Three-wire (H5) registered
1801[Mon Nov 18 18:50:44 2019] Bluetooth: HCI UART protocol Broadcom registered
1802[Mon Nov 18 18:50:44 2019] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
1803[Mon Nov 18 18:50:44 2019] Bluetooth: BNEP filters: protocol multicast
1804[Mon Nov 18 18:50:44 2019] Bluetooth: BNEP socket layer initialized
1805[Mon Nov 18 18:50:51 2019] loop0: p1
1806[Mon Nov 18 18:50:56 2019] loop0: p1
1807[Mon Nov 18 18:50:56 2019] loop0: p1
1808[Mon Nov 18 18:51:45 2019] Mass Storage Function, version: 2009/09/11
1809[Mon Nov 18 18:51:45 2019] LUN: removable file: (no medium)
1810[Mon Nov 18 18:51:45 2019] LUN: removable file: /backingfiles/music_disk.bin
1811[Mon Nov 18 18:51:45 2019] LUN: removable file: /backingfiles/cam_disk.bin
1812[Mon Nov 18 18:51:45 2019] Number of LUNs=2
1813[Mon Nov 18 18:51:45 2019] g_mass_storage gadget: Mass Storage Gadget, version: 2009/09/11
1814[Mon Nov 18 18:51:45 2019] g_mass_storage gadget: g_mass_storage ready
1815[Mon Nov 18 18:51:45 2019] dwc2 20980000.usb: bound driver g_mass_storage
1816====== process list and uptime ======
1817UID PID PPID C STIME TTY TIME CMD
1818root 1 0 1 18:50 ? 00:00:03 /sbin/init fastboot noswap
1819root 2 0 0 18:50 ? 00:00:00 [kthreadd]
1820root 3 2 0 18:50 ? 00:00:00 [kworker/0:0-eve]
1821root 6 2 0 18:50 ? 00:00:00 [mm_percpu_wq]
1822root 7 2 0 18:50 ? 00:00:00 [ksoftirqd/0]
1823root 8 2 0 18:50 ? 00:00:00 [kdevtmpfs]
1824root 9 2 0 18:50 ? 00:00:00 [netns]
1825root 10 2 0 18:50 ? 00:00:00 [kworker/0:1-cgr]
1826root 11 2 0 18:50 ? 00:00:00 [khungtaskd]
1827root 12 2 0 18:50 ? 00:00:00 [oom_reaper]
1828root 13 2 0 18:50 ? 00:00:00 [writeback]
1829root 14 2 0 18:50 ? 00:00:00 [kcompactd0]
1830root 15 2 0 18:50 ? 00:00:00 [crypto]
1831root 16 2 0 18:50 ? 00:00:00 [kblockd]
1832root 17 2 0 18:50 ? 00:00:00 [watchdogd]
1833root 18 2 0 18:50 ? 00:00:00 [rpciod]
1834root 19 2 0 18:50 ? 00:00:00 [kworker/u3:0-hc]
1835root 20 2 0 18:50 ? 00:00:00 [xprtiod]
1836root 21 2 0 18:50 ? 00:00:00 [kworker/u2:1-ev]
1837root 23 2 0 18:50 ? 00:00:00 [kswapd0]
1838root 24 2 0 18:50 ? 00:00:00 [nfsiod]
1839root 35 2 0 18:50 ? 00:00:00 [kthrotld]
1840root 36 2 0 18:50 ? 00:00:00 [iscsi_eh]
1841root 37 2 0 18:50 ? 00:00:00 [DWC Notificatio]
1842root 38 2 0 18:50 ? 00:00:00 [vchiq-slot/0]
1843root 39 2 0 18:50 ? 00:00:00 [vchiq-recy/0]
1844root 40 2 0 18:50 ? 00:00:00 [vchiq-sync/0]
1845root 41 2 0 18:50 ? 00:00:00 [vchiq-keep/0]
1846root 42 2 0 18:50 ? 00:00:00 [SMIO]
1847root 43 2 0 18:50 ? 00:00:00 [irq/86-mmc1]
1848root 44 2 0 18:50 ? 00:00:00 [kworker/0:2-eve]
1849root 45 2 0 18:50 ? 00:00:00 [kworker/0:3-cgr]
1850root 46 2 0 18:50 ? 00:00:00 [mmc_complete]
1851root 47 2 0 18:50 ? 00:00:01 [kworker/0:1H-mm]
1852root 48 2 0 18:50 ? 00:00:00 [kworker/0:2H-kb]
1853root 49 2 0 18:50 ? 00:00:00 [jbd2/mmcblk0p2-]
1854root 50 2 0 18:50 ? 00:00:00 [ext4-rsv-conver]
1855root 51 2 0 18:50 ? 00:00:00 [ipv6_addrconf]
1856root 63 1 0 18:50 ? 00:00:01 /lib/systemd/systemd-journald
1857root 95 1 0 18:50 ? 00:00:01 /lib/systemd/systemd-udevd
1858root 128 2 0 18:50 ? 00:00:00 [kworker/u2:2-ev]
1859root 137 2 0 18:50 ? 00:00:00 [SMIO]
1860root 142 2 0 18:50 ? 00:00:00 [mmal-vchiq]
1861root 144 2 0 18:50 ? 00:00:00 [mmal-vchiq]
1862root 145 2 0 18:50 ? 00:00:00 [mmal-vchiq]
1863root 171 2 0 18:50 ? 00:00:00 [jbd2/mmcblk0p4-]
1864root 172 2 0 18:50 ? 00:00:00 [ext4-rsv-conver]
1865root 177 2 0 18:50 ? 00:00:00 [kworker/u2:3-br]
1866root 181 2 0 18:50 ? 00:00:00 [cfg80211]
1867root 182 2 0 18:50 ? 00:00:00 [xfsalloc]
1868root 183 2 0 18:50 ? 00:00:00 [xfs_mru_cache]
1869root 184 2 0 18:50 ? 00:00:00 [xfs-buf/mmcblk0]
1870root 185 2 0 18:50 ? 00:00:00 [xfs-data/mmcblk]
1871root 186 2 0 18:50 ? 00:00:00 [xfs-conv/mmcblk]
1872root 187 2 0 18:50 ? 00:00:00 [xfs-cil/mmcblk0]
1873root 188 2 0 18:50 ? 00:00:00 [xfs-reclaim/mmc]
1874root 189 2 0 18:50 ? 00:00:00 [xfs-log/mmcblk0]
1875root 190 2 0 18:50 ? 00:00:00 [xfs-eofblocks/m]
1876root 191 2 0 18:50 ? 00:00:00 [xfsaild/mmcblk0]
1877root 192 2 0 18:50 ? 00:00:00 [brcmf_wq/mmc1:0]
1878root 193 2 0 18:50 ? 00:00:00 [brcmf_wdog/mmc1]
1879root 235 1 0 18:50 ? 00:00:00 /usr/sbin/cron -f
1880root 242 1 0 18:50 ? 00:00:00 /lib/systemd/systemd-logind
1881message+ 246 1 0 18:50 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation
1882root 258 1 0 18:50 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant
1883root 259 1 0 18:50 ? 00:00:00 /usr/sbin/rngd -r /dev/hwrng
1884avahi 268 1 0 18:50 ? 00:00:00 avahi-daemon: running [teslausb.local]
1885avahi 283 268 0 18:50 ? 00:00:00 avahi-daemon: chroot helper
1886root 309 1 0 18:50 ? 00:00:00 /sbin/syslogd -C128
1887root 360 1 0 18:50 ? 00:00:00 wpa_supplicant -B -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 -Dnl80211,wext
1888root 387 2 0 18:50 ? 00:00:00 [kworker/u3:1-hc]
1889root 388 1 0 18:50 ? 00:00:00 /usr/bin/hciattach /dev/serial1 bcm43xx 3000000 flow - b8:27:eb:a8:f6:93
1890root 394 1 0 18:50 ? 00:00:00 /usr/lib/bluetooth/bluetoothd
1891root 466 1 0 18:50 ? 00:00:00 /sbin/dhcpcd -q -w
1892root 479 1 0 18:50 ? 00:00:00 /bin/bash -eu /root/bin/archiveloop
1893root 486 479 0 18:50 ? 00:00:00 flock -en -E 99 /root/bin/archiveloop /root/bin/archiveloop
1894root 489 486 0 18:50 ? 00:00:01 /bin/bash -eu /root/bin/archiveloop
1895root 496 1 0 18:50 ? 00:00:00 /usr/sbin/sshd -D
1896root 502 1 0 18:50 tty1 00:00:00 /sbin/agetty --noclear tty1 linux
1897root 557 1 0 18:50 ? 00:00:00 /usr/sbin/nmbd
1898root 613 1 0 18:50 ? 00:00:00 /usr/sbin/smbd
1899root 617 613 0 18:50 ? 00:00:00 /usr/sbin/smbd
1900root 618 613 0 18:50 ? 00:00:00 /usr/sbin/smbd
1901root 628 2 0 18:50 ? 00:00:00 [loop0]
1902root 636 613 0 18:50 ? 00:00:00 /usr/sbin/smbd
1903root 774 489 0 18:51 ? 00:00:00 /bin/bash -eu /root/bin/archiveloop
1904root 777 774 0 18:51 ? 00:00:00 sleep 3500
1905root 1253 2 0 18:51 ? 00:00:00 [kworker/0:4-eve]
1906ntp 1418 1 0 18:51 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 109:114
1907root 1598 2 0 18:51 ? 00:00:00 [file-storage]
1908root 2440 496 1 18:55 ? 00:00:00 sshd: pi [priv]
1909pi 2465 1 0 18:55 ? 00:00:00 /lib/systemd/systemd --user
1910pi 2468 2465 0 18:55 ? 00:00:00 (sd-pam)
1911pi 2476 2440 0 18:55 ? 00:00:00 sshd: pi@pts/0
1912pi 2479 2476 1 18:55 pts/0 00:00:00 -bash
1913root 2537 2479 0 18:55 pts/0 00:00:00 sudo -i
1914root 2541 2537 1 18:55 pts/0 00:00:00 -bash
1915root 2589 2 0 18:55 ? 00:00:00 [kworker/0:0H]
1916root 2623 2541 0 18:56 pts/0 00:00:00 /bin/bash -eu /root/bin/setup-teslausb diagnose
1917root 2624 2623 0 18:56 pts/0 00:00:00 flock -en -E 99 /root/bin/setup-teslausb /root/bin/setup-teslausb diagnose
1918root 2625 2624 2 18:56 pts/0 00:00:00 /bin/bash -eu /root/bin/setup-teslausb diagnose
1919root 2638 2625 5 18:56 pts/0 00:00:00 /bin/bash -eu /root/bin/setup-teslausb diagnose
1920root 2639 2625 1 18:56 pts/0 00:00:00 tr \r \n
1921root 2640 2625 3 18:56 pts/0 00:00:00 sed /^ *$/d
1922root 2641 2625 1 18:56 pts/0 00:00:00 grep -a -v ^Reading package lists
1923root 2642 2625 1 18:56 pts/0 00:00:00 grep -a -v ^(Reading database
1924root 2643 2625 1 18:56 pts/0 00:00:00 grep -a -v ^Adding 'diversion of
1925root 2644 2625 1 18:56 pts/0 00:00:00 grep -a -v ^Removing 'diversion of
1926root 2648 2625 2 18:56 pts/0 00:00:00 sed -E s/\o033\[0;32m//
1927root 2649 2625 1 18:56 pts/0 00:00:00 sed -E s/\o033\[0m//
1928root 2687 489 0 18:56 ? 00:00:00 sleep 1
1929root 2697 2638 0 18:56 pts/0 00:00:00 ps -eaf
1930teslausb has been up 5 minutes. System time is Mon 18 Nov 18:56:04 CET 2019
1931====== end of diagnostics ======