I've attached the syslog. All times are local (MST) 083500: Pi powered on 083525: the syslog starts getting written to. 083525 (row 406): systemd starts weewx 083529 (row 521): Initializing weewx version 3.5.0 083529 (row 544): weewx can't find wired VantagePro on 192.168.1.45 083529 (row 547): weewx exits because it can't find a network (but there was a network already set up?) 083709 (row 645): I log in from SSH. I check top and ls aux | grep weewx and python and find neither. 083903 (row 648): I start weewx from CLI, nothing happens. 083952 (row 651): from CLI, I start weewx again. Nothing happens on top or ps aux 084352 (row 656): from CLI, i stop weewx. 084357 (row 659): from CLI, i start weewx. This time it takes.
On Friday, November 25, 2016 at 8:18:07 AM UTC-7, Andrew Milner wrote: > > what does the log say during this boot / stop / start procedure?? > > > > > On Friday, 25 November 2016 17:01:55 UTC+2, Jon Adams wrote: > >> I know this thread has been dormant for some time, and I don't see that a >> solution has been determined, but I've got the same problem with my weewx >> install on an RPi3, and it's been a bit frustrating. >> >> The RPi is on battery backup, so glitches in AC don't impact it, but >> still, when for some reason I have to reboot it, I have to start the weewx >> service, then stop it, then restart it before it will actually launch >> successfully. My other programs queued to autostart seem to behave alright, >> the webserver and ftp server come up fine. >> >> Setup is RPi3 running Debian 8.0, uname shows: Linux raspberrypi >> 4.4.21-v7+ #911 SMP Thu Sep 15 14:22:38 BST 2016 armv7l GNU/Linux >> Uses a Pi drive (rotating) to prevent early demise of the NVRAM. >> Davis VantagePro2 wired with IP connection. >> Running weewx 3.5.0 >> >> At least on my build, there is no modemmanager, >> >> Similar to W7JBG's situation, after boot up, there's no python or weewx >> in top or ps aux | grep --- >> >> Again, after boot up, I can issue a >> sudo /etc/init.d/weewx start >> and there's no record of it in the running processes. >> if I then issue a >> sudo /etc/init.d/weewx stop >> >> there's no delay in the prompt returning. >> Then, i issue >> sudo /etc/init.d/weewx start >> >> and this time both python and weewx are found as one of the running >> processes. >> >> Has this been resolved? >> >> Cheers and 73 - Jon N7UV >> >> >> On Saturday, February 13, 2016 at 2:40:34 PM UTC-7, Tom Keffer wrote: >>> >>> Yes, that's true, but it's easier to teach a user how to nuke >>> modemmanager than to mess with UDEV rules. >>> >>> But, hey, do you know anything about upstart? >>> >>> -tk >>> >>> On Sat, Feb 13, 2016 at 1:20 PM, P Simmons <mbat...@gmail.com> wrote: >>> >>>> >>>> >>>> On Saturday, February 13, 2016 at 1:14:51 PM UTC-6, Tom Keffer wrote: >>>>> >>>>> There is very definitely something of interest in the log files, >>>>> namely the line, >>>>> >>>>> Feb 13 16:07:02 trimslice weewx[1872]: engine: Unable to load driver: >>>>> [Errno 11] Resource temporarily unavailable >>>>> >>>>> Unless you actually have a modem, try removing modemmanager >>>>> >>>>> sudo apt-get remove modemmanager >>>>> >>>>> >>>>> It's looking for a modem at /dev/ttyUSB0 and competing with weewx. >>>>> Eventually it gives up and relinquishes the port, but not until after >>>>> weewx >>>>> exits. >>>>> >>>>> >>>>> >>>> Hey there, Tom... if there's a udev rule for the USB device, one can >>>> add *ENV{ID_MM_DEVICE_IGNORE}="1"* to the rule, and modemmanager will >>>> leave it alone. >>>> >>>> Best, >>>> Paul >>>> >>>> -- >>>> You received this message because you are subscribed to the Google >>>> Groups "weewx-user" group. >>>> To unsubscribe from this group and stop receiving emails from it, send >>>> an email to weewx-user+...@googlegroups.com. >>>> For more options, visit https://groups.google.com/d/optout. >>>> >>> >>> -- You received this message because you are subscribed to the Google Groups "weewx-user" group. To unsubscribe from this group and stop receiving emails from it, send an email to weewx-user+unsubscr...@googlegroups.com. For more options, visit https://groups.google.com/d/optout.
Nov 25 08:35:25 raspberrypi rsyslogd: [origin software="rsyslogd" swVersion="8.4.2" x-pid="612" x-info="http://www.rsyslog.com"] start Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Booting Linux on physical CPU 0x0 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Initializing cgroup subsys cpuset Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Initializing cgroup subsys cpu Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Initializing cgroup subsys cpuacct Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Linux version 4.4.21-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611) ) #911 SMP Thu Sep 15 14:22:38 BST 2016 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Machine model: Raspberry Pi 3 Model B Rev 1.2 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] cma: Reserved 8 MiB at 0x3a800000 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Memory policy: Data cache writealloc Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] On node 0 totalpages: 241664 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] free_area_init_node: node 0, pgdat 808c2f40, node_mem_map b9fa6000 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Normal zone: 2124 pages used for memmap Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Normal zone: 0 pages reserved Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Normal zone: 241664 pages, LIFO batch:31 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] [bcm2709_smp_init_cpus] enter (9520->f3003010) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] [bcm2709_smp_init_cpus] ncores=4 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] PERCPU: Embedded 13 pages/cpu @b9f61000 s22592 r8192 d22464 u53248 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] pcpu-alloc: s22592 r8192 d22464 u53248 alloc=13*4096 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 239540 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Kernel command line: 8250.nr_uarts=0 dma.dmachans=0x7f35 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2709.boardrev=0xa22082 bcm2709.serial=0x4746c5df smsc95xx.macaddr=B8:27:EB:46:C5:DF bcm2708_fb.fbswap=1 bcm2709.uart_clock=48000000 vc_mem.mem_base=0x3dc00000 vc_mem.mem_size=0x3f000000 dwc_otg.lpm_enable=0 console=ttyS0,115200 console=tty1 root=/dev/sda2 rootfstype=ext3 elevator=deadline fsck.repair=yes rootwait Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Memory: 939068K/966656K available (6348K kernel code, 432K rwdata, 1716K rodata, 476K init, 764K bss, 19396K reserved, 8192K cma-reserved) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Virtual kernel memory layout: Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] vmalloc : 0xbb800000 - 0xff800000 (1088 MB) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] lowmem : 0x80000000 - 0xbb000000 ( 944 MB) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] modules : 0x7f000000 - 0x80000000 ( 16 MB) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] .text : 0x80008000 - 0x807e854c (8066 kB) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] .init : 0x807e9000 - 0x80860000 ( 476 kB) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] .data : 0x80860000 - 0x808cc250 ( 433 kB) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] .bss : 0x808cf000 - 0x8098e1ec ( 765 kB) Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Hierarchical RCU implementation. Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Build-time adjustment of leaf fanout to 32. Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] NR_IRQS:16 nr_irqs:16 16 Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] Architected cp15 timer(s) running at 19.20MHz (phys). Nov 25 08:35:25 raspberrypi kernel: [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns Nov 25 08:35:25 raspberrypi kernel: [ 0.000009] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns Nov 25 08:35:25 raspberrypi kernel: [ 0.000026] Switching to timer-based delay loop, resolution 52ns Nov 25 08:35:25 raspberrypi kernel: [ 0.000281] Console: colour dummy device 80x30 Nov 25 08:35:25 raspberrypi kernel: [ 0.001330] console [tty1] enabled Nov 25 08:35:25 raspberrypi kernel: [ 0.001376] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000) Nov 25 08:35:25 raspberrypi kernel: [ 0.001445] pid_max: default: 32768 minimum: 301 Nov 25 08:35:25 raspberrypi kernel: [ 0.001772] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.001815] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.002764] Disabling cpuset control group subsystem Nov 25 08:35:25 raspberrypi kernel: [ 0.002818] Initializing cgroup subsys io Nov 25 08:35:25 raspberrypi kernel: [ 0.002869] Initializing cgroup subsys memory Nov 25 08:35:25 raspberrypi kernel: [ 0.002936] Initializing cgroup subsys devices Nov 25 08:35:25 raspberrypi kernel: [ 0.002979] Initializing cgroup subsys freezer Nov 25 08:35:25 raspberrypi kernel: [ 0.003020] Initializing cgroup subsys net_cls Nov 25 08:35:25 raspberrypi kernel: [ 0.003090] CPU: Testing write buffer coherency: ok Nov 25 08:35:25 raspberrypi kernel: [ 0.003177] ftrace: allocating 21220 entries in 63 pages Nov 25 08:35:25 raspberrypi kernel: [ 0.052476] CPU0: update cpu_capacity 1024 Nov 25 08:35:25 raspberrypi kernel: [ 0.052543] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Nov 25 08:35:25 raspberrypi kernel: [ 0.052576] [bcm2709_smp_prepare_cpus] enter Nov 25 08:35:25 raspberrypi kernel: [ 0.052736] Setting up static identity map for 0x8240 - 0x8274 Nov 25 08:35:25 raspberrypi kernel: [ 0.054379] [bcm2709_boot_secondary] cpu:1 started (0) 18 Nov 25 08:35:25 raspberrypi kernel: [ 0.054569] [bcm2709_secondary_init] enter cpu:1 Nov 25 08:35:25 raspberrypi kernel: [ 0.054612] CPU1: update cpu_capacity 1024 Nov 25 08:35:25 raspberrypi kernel: [ 0.054618] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Nov 25 08:35:25 raspberrypi kernel: [ 0.054992] [bcm2709_boot_secondary] cpu:2 started (0) 18 Nov 25 08:35:25 raspberrypi kernel: [ 0.055156] [bcm2709_secondary_init] enter cpu:2 Nov 25 08:35:25 raspberrypi kernel: [ 0.055176] CPU2: update cpu_capacity 1024 Nov 25 08:35:25 raspberrypi kernel: [ 0.055183] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Nov 25 08:35:25 raspberrypi kernel: [ 0.055540] [bcm2709_boot_secondary] cpu:3 started (0) 16 Nov 25 08:35:25 raspberrypi kernel: [ 0.055670] [bcm2709_secondary_init] enter cpu:3 Nov 25 08:35:25 raspberrypi kernel: [ 0.055690] CPU3: update cpu_capacity 1024 Nov 25 08:35:25 raspberrypi kernel: [ 0.055696] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Nov 25 08:35:25 raspberrypi kernel: [ 0.055757] Brought up 4 CPUs Nov 25 08:35:25 raspberrypi kernel: [ 0.055855] SMP: Total of 4 processors activated (153.60 BogoMIPS). Nov 25 08:35:25 raspberrypi kernel: [ 0.055884] CPU: All CPU(s) started in HYP mode. Nov 25 08:35:25 raspberrypi kernel: [ 0.055910] CPU: Virtualization extensions available. Nov 25 08:35:25 raspberrypi kernel: [ 0.056542] devtmpfs: initialized Nov 25 08:35:25 raspberrypi kernel: [ 0.067860] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4 Nov 25 08:35:25 raspberrypi kernel: [ 0.068229] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Nov 25 08:35:25 raspberrypi kernel: [ 0.068976] pinctrl core: initialized pinctrl subsystem Nov 25 08:35:25 raspberrypi kernel: [ 0.069508] NET: Registered protocol family 16 Nov 25 08:35:25 raspberrypi kernel: [ 0.074678] DMA: preallocated 4096 KiB pool for atomic coherent allocations Nov 25 08:35:25 raspberrypi kernel: [ 0.081998] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Nov 25 08:35:25 raspberrypi kernel: [ 0.082047] hw-breakpoint: maximum watchpoint size is 8 bytes. Nov 25 08:35:25 raspberrypi kernel: [ 0.082229] Serial: AMBA PL011 UART driver Nov 25 08:35:25 raspberrypi kernel: [ 0.082390] uart-pl011 3f201000.uart: could not find pctldev for node /soc/gpio@7e200000/uart0_pins, deferring probe Nov 25 08:35:25 raspberrypi kernel: [ 0.082594] bcm2835-mbox 3f00b880.mailbox: mailbox enabled Nov 25 08:35:25 raspberrypi kernel: [ 0.154641] bcm2835-dma 3f007000.dma: DMA legacy API manager at f3007000, dmachans=0x1 Nov 25 08:35:25 raspberrypi kernel: [ 0.155234] SCSI subsystem initialized Nov 25 08:35:25 raspberrypi kernel: [ 0.155413] usbcore: registered new interface driver usbfs Nov 25 08:35:25 raspberrypi kernel: [ 0.155511] usbcore: registered new interface driver hub Nov 25 08:35:25 raspberrypi kernel: [ 0.155626] usbcore: registered new device driver usb Nov 25 08:35:25 raspberrypi kernel: [ 0.162036] raspberrypi-firmware soc:firmware: Attached to firmware from 2016-09-21 13:13 Nov 25 08:35:25 raspberrypi kernel: [ 0.189155] clocksource: Switched to clocksource arch_sys_counter Nov 25 08:35:25 raspberrypi kernel: [ 0.233785] FS-Cache: Loaded Nov 25 08:35:25 raspberrypi kernel: [ 0.234089] CacheFiles: Loaded Nov 25 08:35:25 raspberrypi kernel: [ 0.246304] NET: Registered protocol family 2 Nov 25 08:35:25 raspberrypi kernel: [ 0.247174] TCP established hash table entries: 8192 (order: 3, 32768 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.247312] TCP bind hash table entries: 8192 (order: 4, 65536 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.247522] TCP: Hash tables configured (established 8192 bind 8192) Nov 25 08:35:25 raspberrypi kernel: [ 0.247638] UDP hash table entries: 512 (order: 2, 16384 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.247705] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.247954] NET: Registered protocol family 1 Nov 25 08:35:25 raspberrypi kernel: [ 0.248303] RPC: Registered named UNIX socket transport module. Nov 25 08:35:25 raspberrypi kernel: [ 0.248335] RPC: Registered udp transport module. Nov 25 08:35:25 raspberrypi kernel: [ 0.248362] RPC: Registered tcp transport module. Nov 25 08:35:25 raspberrypi kernel: [ 0.248390] RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 25 08:35:25 raspberrypi kernel: [ 0.249490] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available Nov 25 08:35:25 raspberrypi kernel: [ 0.250838] futex hash table entries: 1024 (order: 4, 65536 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.264175] VFS: Disk quotas dquot_6.6.0 Nov 25 08:35:25 raspberrypi kernel: [ 0.264498] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 0.266684] FS-Cache: Netfs 'nfs' registered for caching Nov 25 08:35:25 raspberrypi kernel: [ 0.267601] NFS: Registering the id_resolver key type Nov 25 08:35:25 raspberrypi kernel: [ 0.267678] Key type id_resolver registered Nov 25 08:35:25 raspberrypi kernel: [ 0.267706] Key type id_legacy registered Nov 25 08:35:25 raspberrypi kernel: [ 0.270076] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Nov 25 08:35:25 raspberrypi kernel: [ 0.270271] io scheduler noop registered Nov 25 08:35:25 raspberrypi kernel: [ 0.270313] io scheduler deadline registered (default) Nov 25 08:35:25 raspberrypi kernel: [ 0.270400] io scheduler cfq registered Nov 25 08:35:25 raspberrypi kernel: [ 0.272994] BCM2708FB: allocated DMA memory fac00000 Nov 25 08:35:25 raspberrypi kernel: [ 0.273041] BCM2708FB: allocated DMA channel 0 @ f3007000 Nov 25 08:35:25 raspberrypi kernel: [ 0.281793] Console: switching to colour frame buffer device 82x26 Nov 25 08:35:25 raspberrypi kernel: [ 1.300188] bcm2835-rng 3f104000.rng: hwrng registered Nov 25 08:35:25 raspberrypi kernel: [ 1.302669] vc-cma: Videocore CMA driver Nov 25 08:35:25 raspberrypi systemd-modules-load[125]: Inserted module 'fuse' Nov 25 08:35:25 raspberrypi kernel: [ 1.305051] vc-cma: vc_cma_base = 0x00000000 Nov 25 08:35:25 raspberrypi kernel: [ 1.307430] vc-cma: vc_cma_size = 0x00000000 (0 MiB) Nov 25 08:35:25 raspberrypi kernel: [ 1.309742] vc-cma: vc_cma_initial = 0x00000000 (0 MiB) Nov 25 08:35:25 raspberrypi kernel: [ 1.312148] vc-mem: phys_addr:0x00000000 mem_base=0x3dc00000 mem_size:0x3f000000(1008 MiB) Nov 25 08:35:25 raspberrypi systemd-modules-load[125]: Inserted module 'i2c_dev' Nov 25 08:35:25 raspberrypi kernel: [ 1.331193] brd: module loaded Nov 25 08:35:25 raspberrypi systemd[1]: Mounted FUSE Control File System. Nov 25 08:35:25 raspberrypi kernel: [ 1.341830] loop: module loaded Nov 25 08:35:25 raspberrypi systemd[1]: Mounted Configuration File System. Nov 25 08:35:25 raspberrypi kernel: [ 1.344791] vchiq: vchiq_init_state: slot_zero = 0xbac80000, is_master = 0 Nov 25 08:35:25 raspberrypi systemd[1]: Started Apply Kernel Variables. Nov 25 08:35:25 raspberrypi kernel: [ 1.348357] Loading iSCSI transport class v2.0-870. Nov 25 08:35:25 raspberrypi systemd[1]: Started Create Static Device Nodes in /dev. Nov 25 08:35:25 raspberrypi kernel: [ 1.351173] usbcore: registered new interface driver smsc95xx Nov 25 08:35:25 raspberrypi kernel: [ 1.353445] dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Nov 25 08:35:25 raspberrypi systemd[1]: Starting udev Kernel Device Manager... Nov 25 08:35:25 raspberrypi kernel: [ 1.555889] Core Release: 2.80a Nov 25 08:35:25 raspberrypi systemd[1]: Started udev Kernel Device Manager. Nov 25 08:35:25 raspberrypi kernel: [ 1.557987] Setting default values for core params Nov 25 08:35:25 raspberrypi systemd[1]: Starting Copy rules generated while the root was ro... Nov 25 08:35:25 raspberrypi kernel: [ 1.560166] Finished setting default values for core params Nov 25 08:35:25 raspberrypi systemd[1]: Starting LSB: Set preliminary keymap... Nov 25 08:35:25 raspberrypi kernel: [ 1.762711] Using Buffer DMA mode Nov 25 08:35:25 raspberrypi systemd[1]: Starting LSB: Tune IDE hard disks... Nov 25 08:35:25 raspberrypi kernel: [ 1.764887] Periodic Transfer Interrupt Enhancement - disabled Nov 25 08:35:25 raspberrypi kernel: [ 1.767138] Multiprocessor Interrupt Enhancement - disabled Nov 25 08:35:25 raspberrypi systemd-fsck[110]: e2fsck 1.42.12 (29-Aug-2014) Nov 25 08:35:25 raspberrypi kernel: [ 1.769463] OTG VER PARAM: 0, OTG VER FLAG: 0 Nov 25 08:35:25 raspberrypi kernel: [ 1.771729] Dedicated Tx FIFOs mode Nov 25 08:35:25 raspberrypi kernel: [ 1.774207] WARN::dwc_otg_hcd_init:1047: FIQ DMA bounce buffers: virt = 0xbac14000 dma = 0xfac14000 len=9024 Nov 25 08:35:25 raspberrypi kernel: [ 1.778857] FIQ FSM acceleration enabled for : Nov 25 08:35:25 raspberrypi kernel: [ 1.778857] Non-periodic Split Transactions Nov 25 08:35:25 raspberrypi kernel: [ 1.778857] Periodic Split Transactions Nov 25 08:35:25 raspberrypi kernel: [ 1.778857] High-Speed Isochronous Endpoints Nov 25 08:35:25 raspberrypi kernel: [ 1.778857] Interrupt/Control Split Transaction hack enabled Nov 25 08:35:25 raspberrypi kernel: [ 1.790718] dwc_otg: Microframe scheduler enabled Nov 25 08:35:25 raspberrypi kernel: [ 1.790772] WARN::hcd_init_fiq:413: FIQ on core 1 at 0x80447364 Nov 25 08:35:25 raspberrypi kernel: [ 1.793215] WARN::hcd_init_fiq:414: FIQ ASM at 0x804476d4 length 36 Nov 25 08:35:25 raspberrypi systemd[1]: Started Copy rules generated while the root was ro. Nov 25 08:35:25 raspberrypi kernel: [ 1.795591] WARN::hcd_init_fiq:439: MPHI regs_base at 0xbb9a8000 Nov 25 08:35:25 raspberrypi systemd-fsck[110]: /dev/sda2: clean, 133937/1048576 files, 1083080/4194304 blocks Nov 25 08:35:25 raspberrypi kernel: [ 1.797951] dwc_otg 3f980000.usb: DWC OTG Controller Nov 25 08:35:25 raspberrypi systemd[1]: Started File System Check on Root Device. Nov 25 08:35:25 raspberrypi kernel: [ 1.800285] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 Nov 25 08:35:25 raspberrypi kernel: [ 1.802651] dwc_otg 3f980000.usb: irq 62, io mem 0x00000000 Nov 25 08:35:25 raspberrypi kernel: [ 1.804972] Init: Port Power? op_state=1 Nov 25 08:35:25 raspberrypi kernel: [ 1.807230] Init: Power Port (0) Nov 25 08:35:25 raspberrypi kernel: [ 1.809626] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Nov 25 08:35:25 raspberrypi hdparm[160]: Setting parameters of disc: (none). Nov 25 08:35:25 raspberrypi kernel: [ 1.811938] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 25 08:35:25 raspberrypi kernel: [ 1.814241] usb usb1: Product: DWC OTG Controller Nov 25 08:35:25 raspberrypi kernel: [ 1.816492] usb usb1: Manufacturer: Linux 4.4.21-v7+ dwc_otg_hcd Nov 25 08:35:25 raspberrypi systemd[1]: Started LSB: Tune IDE hard disks. Nov 25 08:35:25 raspberrypi kernel: [ 1.818767] usb usb1: SerialNumber: 3f980000.usb Nov 25 08:35:25 raspberrypi kernel: [ 1.821837] hub 1-0:1.0: USB hub found Nov 25 08:35:25 raspberrypi kernel: [ 1.824039] hub 1-0:1.0: 1 port detected Nov 25 08:35:25 raspberrypi kernel: [ 1.826676] dwc_otg: FIQ enabled Nov 25 08:35:25 raspberrypi kernel: [ 1.826685] dwc_otg: NAK holdoff enabled Nov 25 08:35:25 raspberrypi kernel: [ 1.826693] dwc_otg: FIQ split-transaction FSM enabled Nov 25 08:35:25 raspberrypi kernel: [ 1.826732] Module dwc_common_port init Nov 25 08:35:25 raspberrypi kernel: [ 1.826997] usbcore: registered new interface driver usb-storage Nov 25 08:35:25 raspberrypi kernel: [ 1.829414] mousedev: PS/2 mouse device common for all mice Nov 25 08:35:25 raspberrypi kernel: [ 1.832276] bcm2835-cpufreq: min=600000 max=1200000 Nov 25 08:35:25 raspberrypi kernel: [ 1.834710] sdhci: Secure Digital Host Controller Interface driver Nov 25 08:35:25 raspberrypi kernel: [ 1.836975] sdhci: Copyright(c) Pierre Ossman Nov 25 08:35:25 raspberrypi kernel: [ 1.839520] sdhost: log_buf @ bac13000 (fac13000) Nov 25 08:35:25 raspberrypi kernel: [ 1.899184] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) Nov 25 08:35:25 raspberrypi kernel: [ 1.903689] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0 Nov 25 08:35:25 raspberrypi kernel: [ 1.905987] mmc-bcm2835 3f300000.mmc: DMA channel allocated Nov 25 08:35:25 raspberrypi kernel: [ 1.959268] sdhci-pltfm: SDHCI platform and OF driver helper Nov 25 08:35:25 raspberrypi kernel: [ 1.961901] ledtrig-cpu: registered to indicate activity on CPUs Nov 25 08:35:25 raspberrypi kernel: [ 1.964282] hidraw: raw HID events driver (C) Jiri Kosina Nov 25 08:35:25 raspberrypi kernel: [ 1.966725] usbcore: registered new interface driver usbhid Nov 25 08:35:25 raspberrypi kernel: [ 1.969044] usbhid: USB HID core driver Nov 25 08:35:25 raspberrypi kernel: [ 1.971823] Initializing XFRM netlink socket Nov 25 08:35:25 raspberrypi kernel: [ 1.974088] NET: Registered protocol family 17 Nov 25 08:35:25 raspberrypi kernel: [ 1.976404] Key type dns_resolver registered Nov 25 08:35:25 raspberrypi kernel: [ 1.979064] Registering SWP/SWPB emulation handler Nov 25 08:35:25 raspberrypi kernel: [ 1.982071] registered taskstats version 1 Nov 25 08:35:25 raspberrypi kernel: [ 1.984395] vc-sm: Videocore shared memory driver Nov 25 08:35:25 raspberrypi kernel: [ 1.986619] [vc_sm_connected_init]: start Nov 25 08:35:25 raspberrypi kernel: [ 1.989276] [vc_sm_connected_init]: end - returning 0 Nov 25 08:35:25 raspberrypi kernel: [ 1.992785] 3f201000.uart: ttyAMA0 at MMIO 0x3f201000 (irq = 87, base_baud = 0) is a PL011 rev2 Nov 25 08:35:25 raspberrypi kernel: [ 1.997489] of_cfs_init Nov 25 08:35:25 raspberrypi kernel: [ 1.998007] mmc0: host does not support reading read-only switch, assuming write-enable Nov 25 08:35:25 raspberrypi kernel: [ 2.001548] mmc0: new high speed SDHC card at address aaaa Nov 25 08:35:25 raspberrypi kernel: [ 2.002111] mmcblk0: mmc0:aaaa SL16G 14.8 GiB Nov 25 08:35:25 raspberrypi kernel: [ 2.004875] mmcblk0: p1 p2 Nov 25 08:35:25 raspberrypi kernel: [ 2.010980] of_cfs_init: OK Nov 25 08:35:25 raspberrypi kernel: [ 2.013996] Waiting for root device /dev/sda2... Nov 25 08:35:25 raspberrypi kernel: [ 2.019310] Indeed it is in host mode hprt0 = 00021501 Nov 25 08:35:25 raspberrypi kernel: [ 2.022733] mmc1: queuing unknown CIS tuple 0x80 (2 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 2.026477] mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 2.030151] mmc1: queuing unknown CIS tuple 0x80 (3 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 2.034978] mmc1: queuing unknown CIS tuple 0x80 (7 bytes) Nov 25 08:35:25 raspberrypi kernel: [ 2.127031] mmc1: new high speed SDIO card at address 0001 Nov 25 08:35:25 raspberrypi kernel: [ 2.199188] usb 1-1: new high-speed USB device number 2 using dwc_otg Nov 25 08:35:25 raspberrypi kernel: [ 2.201382] Indeed it is in host mode hprt0 = 00001101 Nov 25 08:35:25 raspberrypi kernel: [ 2.399430] usb 1-1: New USB device found, idVendor=0424, idProduct=9514 Nov 25 08:35:25 raspberrypi kernel: [ 2.401612] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Nov 25 08:35:25 raspberrypi kernel: [ 2.404544] hub 1-1:1.0: USB hub found Nov 25 08:35:25 raspberrypi kernel: [ 2.406767] hub 1-1:1.0: 5 ports detected Nov 25 08:35:25 raspberrypi kernel: [ 2.689182] usb 1-1.1: new high-speed USB device number 3 using dwc_otg Nov 25 08:35:25 raspberrypi kernel: [ 2.789414] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00 Nov 25 08:35:25 raspberrypi kernel: [ 2.791550] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Nov 25 08:35:25 raspberrypi kernel: [ 2.796316] smsc95xx v1.0.4 Nov 25 08:35:25 raspberrypi kernel: [ 2.862434] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:46:c5:df Nov 25 08:35:25 raspberrypi kernel: [ 2.959181] usb 1-1.5: new high-speed USB device number 4 using dwc_otg Nov 25 08:35:25 raspberrypi kernel: [ 3.140079] usb 1-1.5: New USB device found, idVendor=1058, idProduct=259c Nov 25 08:35:25 raspberrypi kernel: [ 3.142430] usb 1-1.5: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Nov 25 08:35:25 raspberrypi kernel: [ 3.144784] usb 1-1.5: Product: My Passport 259C Nov 25 08:35:25 raspberrypi kernel: [ 3.147090] usb 1-1.5: Manufacturer: Western Digital Nov 25 08:35:25 raspberrypi kernel: [ 3.149484] usb 1-1.5: SerialNumber: 575831314132363350444A37 Nov 25 08:35:25 raspberrypi kernel: [ 3.152745] usb-storage 1-1.5:1.0: USB Mass Storage device detected Nov 25 08:35:25 raspberrypi kernel: [ 3.155729] scsi host0: usb-storage 1-1.5:1.0 Nov 25 08:35:25 raspberrypi kernel: [ 4.149821] scsi 0:0:0:0: Direct-Access WD My Passport 259C 1005 PQ: 0 ANSI: 6 Nov 25 08:35:25 raspberrypi kernel: [ 4.156646] scsi 0:0:0:1: Enclosure WD SES Device 1005 PQ: 0 ANSI: 6 Nov 25 08:35:25 raspberrypi kernel: [ 4.156961] sd 0:0:0:0: [sda] Spinning up disk... Nov 25 08:35:25 raspberrypi kernel: [ 5.159173] .ready Nov 25 08:35:25 raspberrypi kernel: [ 5.162122] sd 0:0:0:0: [sda] 613355520 512-byte logical blocks: (314 GB/292 GiB) Nov 25 08:35:25 raspberrypi kernel: [ 5.167696] sd 0:0:0:0: [sda] Write Protect is off Nov 25 08:35:25 raspberrypi kernel: [ 5.170409] sd 0:0:0:0: [sda] Mode Sense: 47 00 10 08 Nov 25 08:35:25 raspberrypi kernel: [ 5.170742] sd 0:0:0:0: [sda] No Caching mode page found Nov 25 08:35:25 raspberrypi kernel: [ 5.173374] sd 0:0:0:0: [sda] Assuming drive cache: write through Nov 25 08:35:25 raspberrypi kernel: [ 5.232231] sda: sda1 sda2 sda3 Nov 25 08:35:25 raspberrypi kernel: [ 5.236977] sd 0:0:0:0: [sda] Attached SCSI disk Nov 25 08:35:25 raspberrypi kernel: [ 5.250724] EXT4-fs (sda2): mounting ext3 file system using the ext4 subsystem Nov 25 08:35:25 raspberrypi kernel: [ 5.275833] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null) Nov 25 08:35:25 raspberrypi kernel: [ 5.280845] VFS: Mounted root (ext3 filesystem) readonly on device 8:2. Nov 25 08:35:25 raspberrypi kernel: [ 5.305086] devtmpfs: mounted Nov 25 08:35:25 raspberrypi kernel: [ 5.308420] Freeing unused kernel memory: 476K (807e9000 - 80860000) Nov 25 08:35:25 raspberrypi kernel: [ 6.061992] random: systemd: uninitialized urandom read (16 bytes read, 101 bits of entropy available) Nov 25 08:35:25 raspberrypi kernel: [ 6.313746] NET: Registered protocol family 10 Nov 25 08:35:25 raspberrypi kernel: [ 6.601684] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 116 bits of entropy available) Nov 25 08:35:25 raspberrypi kernel: [ 6.991656] random: nonblocking pool is initialized Nov 25 08:35:25 raspberrypi kernel: [ 8.022117] fuse init (API version 7.23) Nov 25 08:35:25 raspberrypi kernel: [ 8.144547] i2c /dev entries driver Nov 25 08:35:25 raspberrypi kernel: [ 10.014257] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer Nov 25 08:35:25 raspberrypi kernel: [ 10.064856] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000 Nov 25 08:35:25 raspberrypi kernel: [ 10.066281] bcm2708_i2c 3f804000.i2c: BSC1 Controller at 0x3f804000 (irq 83) (baudrate 100000) Nov 25 08:35:25 raspberrypi kernel: [ 10.383037] EXT4-fs (sda2): re-mounted. Opts: (null) Nov 25 08:35:25 raspberrypi kernel: [ 10.579312] rtc-ds1307 1-0068: rtc core: registered ds3231 as rtc0 Nov 25 08:35:25 raspberrypi kernel: [ 10.610357] sd 0:0:0:0: Attached scsi generic sg0 type 0 Nov 25 08:35:25 raspberrypi kernel: [ 10.610598] scsi 0:0:0:1: Attached scsi generic sg1 type 13 Nov 25 08:35:25 raspberrypi kernel: [ 11.049859] usbcore: registered new interface driver brcmfmac Nov 25 08:35:25 raspberrypi kernel: [ 11.369675] brcmfmac: brcmf_c_preinit_dcmds: Firmware version = wl0: May 27 2016 00:13:38 version 7.45.41.26 (r640327) FWID 01-df77e4a7 Nov 25 08:35:25 raspberrypi kernel: [ 11.390490] brcmfmac: brcmf_cfg80211_reg_notifier: not a ISO3166 code Nov 25 08:35:25 raspberrypi kernel: [ 12.229627] brcmfmac: brcmf_cfg80211_reg_notifier: not a ISO3166 code Nov 25 08:35:25 raspberrypi kernel: [ 12.229654] cfg80211: World regulatory domain updated: Nov 25 08:35:25 raspberrypi kernel: [ 12.229664] cfg80211: DFS Master region: unset Nov 25 08:35:25 raspberrypi kernel: [ 12.229673] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Nov 25 08:35:25 raspberrypi kernel: [ 12.229687] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 12.229700] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 12.229712] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 12.229727] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 12.229741] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Nov 25 08:35:25 raspberrypi kernel: [ 12.229754] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Nov 25 08:35:25 raspberrypi kernel: [ 12.229766] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 12.229778] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 13.046838] Adding 3145724k swap on /dev/sda1. Priority:-1 extents:1 across:3145724k FS Nov 25 08:35:25 raspberrypi kernel: [ 14.559078] EXT4-fs (sda3): mounting ext3 file system using the ext4 subsystem Nov 25 08:35:25 raspberrypi kernel: [ 14.638133] EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null) Nov 25 08:35:25 raspberrypi kernel: [ 15.453213] brcmfmac: brcmf_add_if: ERROR: netdev:wlan0 already exists Nov 25 08:35:25 raspberrypi kernel: [ 15.453248] brcmfmac: brcmf_add_if: ignore IF event Nov 25 08:35:25 raspberrypi kernel: [ 15.460072] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready Nov 25 08:35:25 raspberrypi kernel: [ 15.460103] brcmfmac: power management disabled Nov 25 08:35:25 raspberrypi kernel: [ 16.015966] uart-pl011 3f201000.uart: no DMA platform data Nov 25 08:35:25 raspberrypi kernel: [ 16.066193] cfg80211: Regulatory domain changed to country: US Nov 25 08:35:25 raspberrypi kernel: [ 16.066215] cfg80211: DFS Master region: FCC Nov 25 08:35:25 raspberrypi kernel: [ 16.066225] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Nov 25 08:35:25 raspberrypi kernel: [ 16.066240] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 16.066255] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 1700 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 16.066269] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (0 s) Nov 25 08:35:25 raspberrypi kernel: [ 16.066282] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 16.066294] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A) Nov 25 08:35:25 raspberrypi kernel: [ 16.786164] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready Nov 25 08:35:25 raspberrypi keyboard-setup[158]: Setting preliminary keymap...done. Nov 25 08:35:25 raspberrypi systemd[1]: Started LSB: Set preliminary keymap. Nov 25 08:35:25 raspberrypi systemd[1]: Started Show Plymouth Boot Screen. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Dispatch Password Requests to Console Directory Watch. Nov 25 08:35:25 raspberrypi systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Paths. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Paths. Nov 25 08:35:25 raspberrypi systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Remount Root and Kernel File Systems... Nov 25 08:35:25 raspberrypi systemd-udevd[245]: failed to execute '/lib/udev/mtp-probe' 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1 1 3': No such file or directory Nov 25 08:35:25 raspberrypi systemd[1]: Started Remount Root and Kernel File Systems. Nov 25 08:35:25 raspberrypi systemd[1]: Started Various fixups to make systemd work better on Debian. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Load/Save Random Seed... Nov 25 08:35:25 raspberrypi systemd-udevd[250]: failed to execute '/lib/udev/mtp-probe' 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.5 1 4': No such file or directory Nov 25 08:35:25 raspberrypi systemd[1]: Starting Local File Systems (Pre). Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Local File Systems (Pre). Nov 25 08:35:25 raspberrypi systemd[1]: Starting Sound Card. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Sound Card. Nov 25 08:35:25 raspberrypi systemd[1]: Started Load/Save Random Seed. Nov 25 08:35:25 raspberrypi systemd[1]: Found device /dev/mmcblk0p1. Nov 25 08:35:25 raspberrypi systemd[1]: Starting File System Check on /dev/mmcblk0p1... Nov 25 08:35:25 raspberrypi systemd[1]: Starting system-systemd\x2drfkill.slice. Nov 25 08:35:25 raspberrypi systemd[1]: Created slice system-systemd\x2drfkill.slice. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill0... Nov 25 08:35:25 raspberrypi systemd-fsck[271]: fsck.fat 3.0.27 (2014-11-12) Nov 25 08:35:25 raspberrypi systemd-fsck[271]: /dev/mmcblk0p1: 116 files, 2647/8057 clusters Nov 25 08:35:25 raspberrypi systemd[1]: Started File System Check on /dev/mmcblk0p1. Nov 25 08:35:25 raspberrypi systemd[1]: Mounting /boot... Nov 25 08:35:25 raspberrypi systemd[1]: Time has been changed Nov 25 08:35:25 raspberrypi systemd[1]: Mounted /boot. Nov 25 08:35:25 raspberrypi systemd[1]: Started Load/Save RF Kill Switch Status of rfkill0. Nov 25 08:35:25 raspberrypi systemd[1]: Starting system-ifup.slice. Nov 25 08:35:25 raspberrypi systemd[1]: Created slice system-ifup.slice. Nov 25 08:35:25 raspberrypi systemd[1]: Found device My_Passport_259C 3. Nov 25 08:35:25 raspberrypi systemd[1]: Starting File System Check on /dev/sda3... Nov 25 08:35:25 raspberrypi systemd[1]: Found device My_Passport_259C 1. Nov 25 08:35:25 raspberrypi systemd[1]: Activating swap /dev/sda1... Nov 25 08:35:25 raspberrypi systemd-fsck[333]: e2fsck 1.42.12 (29-Aug-2014) Nov 25 08:35:25 raspberrypi systemd[1]: Activated swap /dev/sda1. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Swap. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Swap. Nov 25 08:35:25 raspberrypi systemd-fsck[333]: /dev/sda3: clean, 11/17924096 files, 1173839/71688448 blocks Nov 25 08:35:25 raspberrypi systemd[1]: Started File System Check on /dev/sda3. Nov 25 08:35:25 raspberrypi systemd[1]: Mounting /data... Nov 25 08:35:25 raspberrypi systemd[1]: Mounted /data. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Local File Systems. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Local File Systems. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Create Volatile Files and Directories... Nov 25 08:35:25 raspberrypi systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Nov 25 08:35:25 raspberrypi systemd[1]: Starting LSB: Raise network interfaces.... Nov 25 08:35:25 raspberrypi systemd[1]: Starting Remote File Systems. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Remote File Systems. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Nov 25 08:35:25 raspberrypi systemd[1]: Starting LSB: Switch to ondemand cpu governor (unless shift key is pressed)... Nov 25 08:35:25 raspberrypi systemd[1]: Starting LSB: Prepare console... Nov 25 08:35:25 raspberrypi systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Nov 25 08:35:25 raspberrypi raspi-config[356]: Checking if shift key is held down:Error opening '/dev/input/event*': No such file or directory Nov 25 08:35:25 raspberrypi raspi-config[356]: No. Switching to ondemand scaling governor. Nov 25 08:35:25 raspberrypi systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Nov 25 08:35:25 raspberrypi systemd[1]: Started Create Volatile Files and Directories. Nov 25 08:35:25 raspberrypi systemd[1]: Started LSB: Switch to ondemand cpu governor (unless shift key is pressed). Nov 25 08:35:25 raspberrypi kbd[360]: Setting console screen modes. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Network Time Synchronization... Nov 25 08:35:25 raspberrypi systemd[1]: Starting Update UTMP about System Boot/Shutdown... Nov 25 08:35:25 raspberrypi kbd[360]: setterm: $TERM is not defined. Nov 25 08:35:25 raspberrypi systemd[1]: Started LSB: Prepare console. Nov 25 08:35:25 raspberrypi systemd[1]: Started Network Time Synchronization. Nov 25 08:35:25 raspberrypi systemd[1]: Started Update UTMP about System Boot/Shutdown. Nov 25 08:35:25 raspberrypi systemd[1]: Starting System Time Synchronized. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target System Time Synchronized. Nov 25 08:35:25 raspberrypi systemd[1]: Starting LSB: Set console font and keymap... Nov 25 08:35:25 raspberrypi networking[351]: Configuring network interfaces...done. Nov 25 08:35:25 raspberrypi systemd[1]: Started LSB: Raise network interfaces.. Nov 25 08:35:25 raspberrypi systemd[1]: Starting ifup for wlan0... Nov 25 08:35:25 raspberrypi systemd[1]: Started ifup for wlan0. Nov 25 08:35:25 raspberrypi console-setup[436]: Setting up console font and keymap...done. Nov 25 08:35:25 raspberrypi systemd[1]: Started LSB: Set console font and keymap. Nov 25 08:35:25 raspberrypi systemd[1]: Starting System Initialization. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target System Initialization. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. Nov 25 08:35:25 raspberrypi systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Nov 25 08:35:25 raspberrypi systemd[1]: Starting D-Bus System Message Bus Socket. Nov 25 08:35:25 raspberrypi systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Sockets. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Sockets. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Daily Cleanup of Temporary Directories. Nov 25 08:35:25 raspberrypi systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Timers. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Timers. Nov 25 08:35:25 raspberrypi systemd[1]: Started Manage Sound Card State (restore and store). Nov 25 08:35:25 raspberrypi systemd[1]: Starting Restore Sound Card State... Nov 25 08:35:25 raspberrypi wpa_supplicant[504]: Successfully initialized wpa_supplicant Nov 25 08:35:25 raspberrypi systemd[1]: Starting Basic System. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Basic System. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Regular background program processing daemon... Nov 25 08:35:25 raspberrypi systemd[1]: Started Regular background program processing daemon. Nov 25 08:35:25 raspberrypi systemd[1]: Starting dhcpcd on all interfaces... Nov 25 08:35:25 raspberrypi systemd[1]: Starting Configure Bluetooth Modems connected by UART... Nov 25 08:35:25 raspberrypi systemd[1]: Starting Login Service... Nov 25 08:35:25 raspberrypi systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. Nov 25 08:35:25 raspberrypi systemd[1]: Starting LSB: triggerhappy hotkey daemon... Nov 25 08:35:25 raspberrypi systemd[1]: Starting LSB: weewx weather system... Nov 25 08:35:25 raspberrypi cron[509]: (CRON) INFO (pidfile fd = 3) Nov 25 08:35:25 raspberrypi systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Nov 25 08:35:25 raspberrypi systemd[1]: Starting D-Bus System Message Bus... Nov 25 08:35:25 raspberrypi systemd[1]: Started D-Bus System Message Bus. Nov 25 08:35:25 raspberrypi wpa_supplicant[542]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Nov 25 08:35:25 raspberrypi triggerhappy[518]: Error opening '/dev/input/event*': No such file or directory Nov 25 08:35:25 raspberrypi dhcpcd[511]: version 6.7.1 starting Nov 25 08:35:25 raspberrypi cron[509]: (CRON) INFO (Running @reboot jobs) Nov 25 08:35:25 raspberrypi dhcpcd[511]: dev: loaded udev Nov 25 08:35:25 raspberrypi dhcpcd[511]: eth0: adding address fe80::147e:5d1f:a6bf:154d Nov 25 08:35:25 raspberrypi dhcpcd[511]: wlan0: adding address fe80::6ef3:cb51:ca07:7ea8 Nov 25 08:35:25 raspberrypi dhcpcd[511]: forked to background, child pid 555 Nov 25 08:35:25 raspberrypi avahi-daemon[523]: Found user 'avahi' (UID 105) and group 'avahi' (GID 110). Nov 25 08:35:25 raspberrypi avahi-daemon[523]: Successfully dropped root privileges. Nov 25 08:35:25 raspberrypi avahi-daemon[523]: avahi-daemon 0.6.31 starting up. Nov 25 08:35:25 raspberrypi wpa_supplicant[542]: wlan0: Trying to associate with 2c:b0:5d:87:42:53 (SSID='cryptic24' freq=2462 MHz) Nov 25 08:35:25 raspberrypi wpa_supplicant[542]: wlan0: Associated with 2c:b0:5d:87:42:53 Nov 25 08:35:25 raspberrypi wpa_supplicant[542]: wlan0: WPA: Key negotiation completed with 2c:b0:5d:87:42:53 [PTK=CCMP GTK=TKIP] Nov 25 08:35:25 raspberrypi wpa_supplicant[542]: wlan0: CTRL-EVENT-CONNECTED - Connection to 2c:b0:5d:87:42:53 completed [id=0 id_str=] Nov 25 08:35:25 raspberrypi avahi-daemon[523]: Successfully called chroot(). Nov 25 08:35:25 raspberrypi avahi-daemon[523]: Successfully dropped remaining capabilities. Nov 25 08:35:25 raspberrypi dbus[525]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 25 08:35:25 raspberrypi systemd[1]: Started Avahi mDNS/DNS-SD Stack. Nov 25 08:35:25 raspberrypi systemd[1]: Starting System Logging Service... Nov 25 08:35:25 raspberrypi avahi-daemon[523]: Loading service file /services/udisks.service. Nov 25 08:35:25 raspberrypi avahi-daemon[523]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::6ef3:cb51:ca07:7ea8. Nov 25 08:35:25 raspberrypi avahi-daemon[523]: New relevant interface wlan0.IPv6 for mDNS. Nov 25 08:35:25 raspberrypi avahi-daemon[523]: Network interface enumeration completed. Nov 25 08:35:25 raspberrypi avahi-daemon[523]: Registering new address record for fe80::6ef3:cb51:ca07:7ea8 on wlan0.*. Nov 25 08:35:25 raspberrypi avahi-daemon[523]: Registering HINFO record with values 'ARMV7L'/'LINUX'. Nov 25 08:35:25 raspberrypi systemd[1]: Started Restore Sound Card State. Nov 25 08:35:25 raspberrypi systemd[1]: Started dhcpcd on all interfaces. Nov 25 08:35:25 raspberrypi systemd[1]: Started LSB: triggerhappy hotkey daemon. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Network. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Network. Nov 25 08:35:25 raspberrypi systemd[1]: Starting OpenBSD Secure Shell server... Nov 25 08:35:25 raspberrypi systemd[1]: Started OpenBSD Secure Shell server. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Lighttpd Daemon... Nov 25 08:35:25 raspberrypi systemd[1]: Starting /etc/rc.local Compatibility... Nov 25 08:35:25 raspberrypi systemd[1]: Starting Network is Online. Nov 25 08:35:25 raspberrypi systemd[1]: Reached target Network is Online. Nov 25 08:35:25 raspberrypi systemd[1]: Starting LSB: Start NTP daemon... Nov 25 08:35:25 raspberrypi systemd[1]: Starting Permit User Sessions... Nov 25 08:35:25 raspberrypi systemd[1]: Started System Logging Service. Nov 25 08:35:25 raspberrypi systemd[1]: Started Login Service. Nov 25 08:35:25 raspberrypi systemd[1]: Started /etc/rc.local Compatibility. Nov 25 08:35:25 raspberrypi systemd[1]: Started Permit User Sessions. Nov 25 08:35:25 raspberrypi systemd[1]: Starting Light Display Manager... Nov 25 08:35:25 raspberrypi systemd[1]: Starting Wait for Plymouth Boot Screen to Quit... Nov 25 08:35:25 raspberrypi systemd[1]: Starting Terminate Plymouth Boot Screen... Nov 25 08:35:25 raspberrypi systemd[1]: Started Wait for Plymouth Boot Screen to Quit. Nov 25 08:35:25 raspberrypi systemd[1]: Started Terminate Plymouth Boot Screen. Nov 25 08:35:26 raspberrypi systemd[1]: Starting Getty on tty1... Nov 25 08:35:26 raspberrypi systemd[1]: Started Getty on tty1. Nov 25 08:35:26 raspberrypi systemd[1]: Starting Login Prompts. Nov 25 08:35:26 raspberrypi systemd[1]: Reached target Login Prompts. Nov 25 08:35:26 raspberrypi avahi-daemon[523]: Server startup complete. Host name is raspberrypi.local. Local service cookie is 3181353816. Nov 25 08:35:26 raspberrypi avahi-daemon[523]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::147e:5d1f:a6bf:154d. Nov 25 08:35:26 raspberrypi avahi-daemon[523]: New relevant interface eth0.IPv6 for mDNS. Nov 25 08:35:26 raspberrypi dhcpcd[555]: eth0: waiting for carrier Nov 25 08:35:26 raspberrypi avahi-daemon[523]: Registering new address record for fe80::147e:5d1f:a6bf:154d on eth0.*. Nov 25 08:35:26 raspberrypi dhcpcd[555]: wlan0: waiting for carrier Nov 25 08:35:26 raspberrypi kernel: [ 18.112451] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Nov 25 08:35:26 raspberrypi kernel: [ 18.112813] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Nov 25 08:35:26 raspberrypi dhcpcd[555]: wlan0: carrier acquired Nov 25 08:35:26 raspberrypi dhcpcd[555]: DUID 00:01:00:01:1e:da:f1:06:b8:27:eb:46:c5:df Nov 25 08:35:26 raspberrypi dhcpcd[555]: wlan0: IAID eb:13:90:8a Nov 25 08:35:26 raspberrypi ntpd[686]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Nov 25 08:35:26 raspberrypi ntp[641]: Starting NTP server: ntpd. Nov 25 08:35:26 raspberrypi ntpd[727]: proto: precision = 1.041 usec Nov 25 08:35:26 raspberrypi ntpd[727]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Nov 25 08:35:26 raspberrypi systemd[1]: Started LSB: Start NTP daemon. Nov 25 08:35:26 raspberrypi ntpd[727]: Listen and drop on 1 v6wildcard :: UDP 123 Nov 25 08:35:26 raspberrypi ntpd[727]: Listen normally on 2 lo 127.0.0.1 UDP 123 Nov 25 08:35:26 raspberrypi ntpd[727]: Listen normally on 3 lo ::1 UDP 123 Nov 25 08:35:26 raspberrypi ntpd[727]: peers refreshed Nov 25 08:35:26 raspberrypi ntpd[727]: Listening on routing socket on fd #20 for interface updates Nov 25 08:35:26 raspberrypi ntpd[727]: Deferring DNS for 0.debian.pool.ntp.org 1 Nov 25 08:35:26 raspberrypi ntpd[727]: Deferring DNS for 1.debian.pool.ntp.org 1 Nov 25 08:35:26 raspberrypi ntpd[727]: Deferring DNS for 2.debian.pool.ntp.org 1 Nov 25 08:35:26 raspberrypi ntpd[727]: Deferring DNS for 3.debian.pool.ntp.org 1 Nov 25 08:35:26 raspberrypi ntpd[728]: signal_no_reset: signal 17 had flags 4000000 Nov 25 08:35:26 raspberrypi dhcpcd[555]: wlan0: soliciting an IPv6 router Nov 25 08:35:27 raspberrypi dhcpcd[555]: wlan0: rebinding lease of 192.168.1.242 Nov 25 08:35:27 raspberrypi avahi-daemon[523]: Service "raspberrypi" (/services/udisks.service) successfully established. Nov 25 08:35:27 raspberrypi dhcpcd[555]: wlan0: NAK: static lease available from 192.168.1.1 Nov 25 08:35:27 raspberrypi dhcpcd[555]: wlan0: message: static lease available Nov 25 08:35:27 raspberrypi dhcpcd[555]: wlan0: soliciting a DHCP lease Nov 25 08:35:27 raspberrypi dhcpcd[555]: wlan0: offered 192.168.1.46 from 192.168.1.1 Nov 25 08:35:27 raspberrypi dhcpcd[555]: wlan0: hardware address 00:01:4a:0c:b3:09 claims 192.168.1.46 Nov 25 08:35:28 raspberrypi ntpd[727]: Listen normally on 4 wlan0 fe80::6ef3:cb51:ca07:7ea8 UDP 123 Nov 25 08:35:28 raspberrypi ntpd[727]: peers refreshed Nov 25 08:35:28 raspberrypi dhcpcd[555]: wlan0: soliciting a DHCP lease Nov 25 08:35:28 raspberrypi lighttpd[635]: Syntax OK Nov 25 08:35:28 raspberrypi systemd[1]: Started Lighttpd Daemon. Nov 25 08:35:28 raspberrypi ntpd_intres[728]: host name not found: 0.debian.pool.ntp.org Nov 25 08:35:28 raspberrypi ntpd_intres[728]: host name not found: 1.debian.pool.ntp.org Nov 25 08:35:28 raspberrypi ntpd_intres[728]: host name not found: 2.debian.pool.ntp.org Nov 25 08:35:28 raspberrypi ntpd_intres[728]: host name not found: 3.debian.pool.ntp.org Nov 25 08:35:29 raspberrypi kernel: [ 20.804183] Bluetooth: Core ver 2.21 Nov 25 08:35:29 raspberrypi kernel: [ 20.804266] NET: Registered protocol family 31 Nov 25 08:35:29 raspberrypi kernel: [ 20.804277] Bluetooth: HCI device and connection manager initialized Nov 25 08:35:29 raspberrypi kernel: [ 20.804299] Bluetooth: HCI socket layer initialized Nov 25 08:35:29 raspberrypi kernel: [ 20.804317] Bluetooth: L2CAP socket layer initialized Nov 25 08:35:29 raspberrypi kernel: [ 20.804350] Bluetooth: SCO socket layer initialized Nov 25 08:35:29 raspberrypi hciattach[512]: bcm43xx_init Nov 25 08:35:29 raspberrypi hciattach[512]: Flash firmware /lib/firmware/BCM43430A1.hcd Nov 25 08:35:29 raspberrypi hciattach[512]: Set Controller UART speed to 921600 bit/s Nov 25 08:35:29 raspberrypi hciattach[512]: Device setup complete Nov 25 08:35:29 raspberrypi kernel: [ 20.880679] Bluetooth: HCI UART driver ver 2.3 Nov 25 08:35:29 raspberrypi kernel: [ 20.880699] Bluetooth: HCI UART protocol H4 registered Nov 25 08:35:29 raspberrypi kernel: [ 20.880710] Bluetooth: HCI UART protocol Three-wire (H5) registered Nov 25 08:35:29 raspberrypi kernel: [ 20.880897] Bluetooth: HCI UART protocol BCM registered Nov 25 08:35:29 raspberrypi systemd[1]: Started Configure Bluetooth Modems connected by UART. Nov 25 08:35:29 raspberrypi weewx[562]: engine: Initializing weewx version 3.5.0 Nov 25 08:35:29 raspberrypi weewx[562]: engine: Using Python 2.7.9 (default, Sep 17 2016, 20:26:04) #012[GCC 4.9.2] Nov 25 08:35:29 raspberrypi dhcpcd[555]: wlan0: hardware address 00:01:4a:0c:b3:09 claims 192.168.1.46 Nov 25 08:35:29 raspberrypi systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill1... Nov 25 08:35:29 raspberrypi weewx[562]: engine: Platform Linux-4.4.21-v7+-armv7l-with-debian-8.0 Nov 25 08:35:29 raspberrypi weewx[562]: engine: pid file is /var/run/weewx.pid Nov 25 08:35:29 raspberrypi systemd[1]: Starting Bluetooth service... Nov 25 08:35:29 raspberrypi weewx[521]: Starting weewx weather system: weewx. Nov 25 08:35:29 raspberrypi systemd[1]: Started LSB: weewx weather system. Nov 25 08:35:29 raspberrypi systemd[1]: Started Load/Save RF Kill Switch Status of rfkill1. Nov 25 08:35:29 raspberrypi weewx[798]: engine: Using configuration file /etc/weewx/weewx.conf Nov 25 08:35:29 raspberrypi weewx[798]: engine: Initializing engine Nov 25 08:35:29 raspberrypi lightdm[681]: ** (lightdm:681): WARNING **: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.Accounts was not provided by any .service files Nov 25 08:35:29 raspberrypi weewx[798]: engine: Loading station type Vantage (weewx.drivers.vantage) Nov 25 08:35:29 raspberrypi systemd[1]: Starting Multi-User System. Nov 25 08:35:29 raspberrypi systemd[1]: Reached target Multi-User System. Nov 25 08:35:29 raspberrypi bluetoothd[799]: Bluetooth daemon 5.23 Nov 25 08:35:29 raspberrypi systemd[1]: Started Light Display Manager. Nov 25 08:35:29 raspberrypi systemd[1]: Starting Graphical Interface. Nov 25 08:35:29 raspberrypi systemd[1]: Reached target Graphical Interface. Nov 25 08:35:29 raspberrypi systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 25 08:35:29 raspberrypi weewx[798]: vantage: driver version is 3.0.7 Nov 25 08:35:29 raspberrypi systemd[1]: Started Bluetooth service. Nov 25 08:35:29 raspberrypi weewx[798]: vantage: Socket error while opening port 22222 to ethernet host 192.168.1.45. Nov 25 08:35:29 raspberrypi bluetoothd[799]: Starting SDP server Nov 25 08:35:29 raspberrypi weewx[798]: engine: Unable to load driver: [Errno 101] Network is unreachable Nov 25 08:35:29 raspberrypi weewx[798]: **** Exiting... Nov 25 08:35:29 raspberrypi systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 25 08:35:29 raspberrypi systemd[1]: Starting Bluetooth. Nov 25 08:35:29 raspberrypi systemd[1]: Reached target Bluetooth. Nov 25 08:35:29 raspberrypi systemd[1]: Startup finished in 5.924s (kernel) + 15.528s (userspace) = 21.452s. Nov 25 08:35:29 raspberrypi kernel: [ 21.613721] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Nov 25 08:35:29 raspberrypi kernel: [ 21.613739] Bluetooth: BNEP filters: protocol multicast Nov 25 08:35:29 raspberrypi kernel: [ 21.613760] Bluetooth: BNEP socket layer initialized Nov 25 08:35:29 raspberrypi bluetoothd[799]: Bluetooth management interface 1.10 initialized Nov 25 08:35:29 raspberrypi dbus[525]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Nov 25 08:35:29 raspberrypi systemd[1]: Starting Hostname Service... Nov 25 08:35:29 raspberrypi bluetoothd[799]: Sap driver initialization failed. Nov 25 08:35:29 raspberrypi bluetoothd[799]: sap-server: Operation not permitted (1) Nov 25 08:35:30 raspberrypi systemd-hostnamed[814]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! Nov 25 08:35:30 raspberrypi dbus[525]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 25 08:35:30 raspberrypi systemd[1]: Started Hostname Service. Nov 25 08:35:30 raspberrypi dhcpcd[555]: wlan0: soliciting a DHCP lease Nov 25 08:35:30 raspberrypi dhcpcd[555]: wlan0: hardware address 00:01:4a:0c:b3:09 claims 192.168.1.46 Nov 25 08:35:30 raspberrypi ntpd_intres[728]: host name not found: 0.debian.pool.ntp.org Nov 25 08:35:30 raspberrypi ntpd_intres[728]: host name not found: 1.debian.pool.ntp.org Nov 25 08:35:30 raspberrypi ntpd_intres[728]: host name not found: 2.debian.pool.ntp.org Nov 25 08:35:30 raspberrypi ntpd_intres[728]: host name not found: 3.debian.pool.ntp.org Nov 25 08:35:30 raspberrypi systemd[1]: Starting user-1000.slice. Nov 25 08:35:30 raspberrypi systemd[1]: Created slice user-1000.slice. Nov 25 08:35:30 raspberrypi systemd[1]: Starting User Manager for UID 1000... Nov 25 08:35:30 raspberrypi systemd[1]: Starting Session c1 of user pi. Nov 25 08:35:30 raspberrypi systemd[1]: Started Session c1 of user pi. Nov 25 08:35:31 raspberrypi systemd[818]: Starting Paths. Nov 25 08:35:31 raspberrypi systemd[818]: Reached target Paths. Nov 25 08:35:31 raspberrypi systemd[818]: Starting Timers. Nov 25 08:35:31 raspberrypi systemd[818]: Reached target Timers. Nov 25 08:35:31 raspberrypi systemd[818]: Starting Sockets. Nov 25 08:35:31 raspberrypi systemd[818]: Reached target Sockets. Nov 25 08:35:31 raspberrypi systemd[818]: Starting Basic System. Nov 25 08:35:31 raspberrypi systemd[818]: Reached target Basic System. Nov 25 08:35:31 raspberrypi systemd[818]: Starting Default. Nov 25 08:35:31 raspberrypi systemd[818]: Reached target Default. Nov 25 08:35:31 raspberrypi systemd[818]: Startup finished in 262ms. Nov 25 08:35:31 raspberrypi systemd[1]: Started User Manager for UID 1000. Nov 25 08:35:31 raspberrypi dhcpcd[555]: wlan0: soliciting a DHCP lease Nov 25 08:35:31 raspberrypi dhcpcd[555]: wlan0: offered 192.168.1.242 from 192.168.1.1 Nov 25 08:35:32 raspberrypi dhcpcd[555]: wlan0: leased 192.168.1.242 for 604800 seconds Nov 25 08:35:32 raspberrypi dhcpcd[555]: wlan0: adding route to 192.168.1.0/24 Nov 25 08:35:32 raspberrypi avahi-daemon[523]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.242. Nov 25 08:35:32 raspberrypi dhcpcd[555]: wlan0: adding default route via 192.168.1.1 Nov 25 08:35:32 raspberrypi avahi-daemon[523]: New relevant interface wlan0.IPv4 for mDNS. Nov 25 08:35:32 raspberrypi avahi-daemon[523]: Registering new address record for 192.168.1.242 on wlan0.IPv4. Nov 25 08:35:33 raspberrypi ntpd[727]: Listen normally on 5 wlan0 192.168.1.242 UDP 123 Nov 25 08:35:33 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Nov 25 08:36:03 2016 [try http://www.rsyslog.com/e/2007 ] Nov 25 08:35:33 raspberrypi ntpd[727]: peers refreshed Nov 25 08:35:33 raspberrypi lightdm[681]: ** (process:928): WARNING **: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.Accounts was not provided by any .service files Nov 25 08:35:33 raspberrypi systemd[1]: Starting Session c2 of user pi. Nov 25 08:35:33 raspberrypi systemd[1]: Started Session c2 of user pi. Nov 25 08:35:35 raspberrypi ntpd_intres[728]: DNS 0.debian.pool.ntp.org -> 129.250.35.251 Nov 25 08:35:35 raspberrypi ntpd_intres[728]: DNS 1.debian.pool.ntp.org -> 74.82.59.142 Nov 25 08:35:35 raspberrypi ntpd_intres[728]: DNS 2.debian.pool.ntp.org -> 208.75.89.4 Nov 25 08:35:35 raspberrypi ntpd_intres[728]: DNS 3.debian.pool.ntp.org -> 209.208.79.69 Nov 25 08:35:36 raspberrypi dbus[525]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Nov 25 08:35:36 raspberrypi systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Nov 25 08:35:37 raspberrypi polkitd[999]: started daemon version 0.105 using authority implementation `local' version `0.105' Nov 25 08:35:37 raspberrypi dbus[525]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 25 08:35:37 raspberrypi systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Nov 25 08:35:38 raspberrypi dbus[525]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Nov 25 08:35:38 raspberrypi systemd[1]: Starting RealtimeKit Scheduling Policy Service... Nov 25 08:35:38 raspberrypi dbus[525]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Nov 25 08:35:38 raspberrypi systemd[1]: Started RealtimeKit Scheduling Policy Service. Nov 25 08:35:38 raspberrypi rtkit-daemon[1016]: Successfully called chroot. Nov 25 08:35:38 raspberrypi rtkit-daemon[1016]: Successfully dropped privileges. Nov 25 08:35:38 raspberrypi rtkit-daemon[1016]: Successfully limited resources. Nov 25 08:35:38 raspberrypi rtkit-daemon[1016]: Running. Nov 25 08:35:38 raspberrypi rtkit-daemon[1016]: Canary thread running. Nov 25 08:35:38 raspberrypi rtkit-daemon[1016]: Watchdog thread running. Nov 25 08:35:38 raspberrypi dbus[525]: [system] Activating via systemd: service name='org.freedesktop.UDisks2' unit='udisks2.service' Nov 25 08:35:38 raspberrypi systemd[1]: Starting Disk Manager... Nov 25 08:35:38 raspberrypi udisksd[1026]: udisks daemon version 2.1.3 starting Nov 25 08:35:38 raspberrypi rtkit-daemon[1016]: Successfully made thread 1015 of process 1015 (/usr/bin/pulseaudio) owned by '1000' high priority at nice level -11. Nov 25 08:35:38 raspberrypi rtkit-daemon[1016]: Supervising 1 threads of 1 processes of 1 users. Nov 25 08:35:38 raspberrypi dhcpcd[555]: wlan0: no IPv6 Routers available Nov 25 08:35:38 raspberrypi dbus[525]: [system] Successfully activated service 'org.freedesktop.UDisks2' Nov 25 08:35:38 raspberrypi udisksd[1026]: Acquired the name org.freedesktop.UDisks2 on the system message bus Nov 25 08:35:38 raspberrypi systemd[1]: Started Disk Manager. Nov 25 08:35:38 raspberrypi udisksd[1026]: Cleaning up mount point /media/pi/2f840c69-cecb-4b10-87e4-01b9d28c231c (device 179:2 is not mounted) Nov 25 08:35:39 raspberrypi org.gtk.Private.AfcVolumeMonitor[965]: Volume monitor alive Nov 25 08:35:39 raspberrypi pulseaudio[1015]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Nov 25 08:35:39 raspberrypi bluetoothd[799]: Endpoint registered: sender=:1.15 path=/MediaEndpoint/A2DPSource Nov 25 08:35:39 raspberrypi bluetoothd[799]: Endpoint registered: sender=:1.15 path=/MediaEndpoint/A2DPSink Nov 25 08:35:41 raspberrypi udisksd[1026]: Mounted /dev/mmcblk0p2 at /media/pi/2f840c69-cecb-4b10-87e4-01b9d28c231c on behalf of uid 1000 Nov 25 08:35:41 raspberrypi kernel: [ 32.881792] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Nov 25 08:35:41 raspberrypi org.gtk.Private.UDisks2VolumeMonitor[965]: index_parse.c:191: indx_parse(): error opening /media/pi/2f840c69-cecb-4b10-87e4-01b9d28c231c/BDMV/index.bdmv Nov 25 08:35:41 raspberrypi org.gtk.Private.UDisks2VolumeMonitor[965]: index_parse.c:191: indx_parse(): error opening /media/pi/2f840c69-cecb-4b10-87e4-01b9d28c231c/BDMV/BACKUP/index.bdmv Nov 25 08:35:41 raspberrypi bluetoothd[799]: Endpoint unregistered: sender=:1.15 path=/MediaEndpoint/A2DPSource Nov 25 08:35:41 raspberrypi bluetoothd[799]: Endpoint unregistered: sender=:1.15 path=/MediaEndpoint/A2DPSink Nov 25 08:35:42 raspberrypi systemd[1]: Time has been changed Nov 25 08:35:42 raspberrypi systemd[818]: Time has been changed Nov 25 08:35:53 raspberrypi systemd-timesyncd[409]: Using NTP server 66.79.136.235:123 (2.debian.pool.ntp.org). Nov 25 08:35:53 raspberrypi systemd-timesyncd[409]: interval/delta/delay/jitter/drift 64s/-0.006s/0.047s/0.000s/-44ppm Nov 25 08:36:58 raspberrypi systemd-timesyncd[409]: interval/delta/delay/jitter/drift 128s/+0.010s/0.055s/0.004s/-5ppm Nov 25 08:36:58 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Nov 25 08:37:28 2016 [try http://www.rsyslog.com/e/2007 ] Nov 25 08:37:09 raspberrypi systemd[1]: Starting Session c3 of user pi. Nov 25 08:37:09 raspberrypi systemd[1]: Started Session c3 of user pi. Nov 25 08:38:54 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Nov 25 08:39:24 2016 [try http://www.rsyslog.com/e/2007 ] Nov 25 08:39:03 raspberrypi systemd[1]: Started LSB: weewx weather system. Nov 25 08:39:06 raspberrypi systemd-timesyncd[409]: interval/delta/delay/jitter/drift 256s/-0.006s/0.044s/0.008s/-16ppm Nov 25 08:39:52 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Nov 25 08:40:22 2016 [try http://www.rsyslog.com/e/2007 ] Nov 25 08:39:52 raspberrypi systemd[1]: Started LSB: weewx weather system. Nov 25 08:43:22 raspberrypi systemd-timesyncd[409]: interval/delta/delay/jitter/drift 512s/+0.002s/0.044s/0.004s/-14ppm Nov 25 08:43:22 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Nov 25 08:43:52 2016 [try http://www.rsyslog.com/e/2007 ] Nov 25 08:43:45 raspberrypi systemd[1]: Started LSB: weather system. Nov 25 08:43:52 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Nov 25 08:44:22 2016 [try http://www.rsyslog.com/e/2007 ] Nov 25 08:43:52 raspberrypi systemd[1]: Stopping LSB: weewx weather system... Nov 25 08:43:52 raspberrypi weewx[1269]: Stopping weewx weather system: weewx not running.... Nov 25 08:43:52 raspberrypi systemd[1]: Stopped LSB: weewx weather system. Nov 25 08:43:57 raspberrypi systemd[1]: Starting LSB: weewx weather system... Nov 25 08:43:57 raspberrypi weewx[1329]: engine: Initializing weewx version 3.5.0 Nov 25 08:43:57 raspberrypi weewx[1329]: engine: Using Python 2.7.9 (default, Sep 17 2016, 20:26:04) #012[GCC 4.9.2] Nov 25 08:43:57 raspberrypi weewx[1329]: engine: Platform Linux-4.4.21-v7+-armv7l-with-debian-8.0 Nov 25 08:43:57 raspberrypi weewx[1329]: engine: pid file is /var/run/weewx.pid Nov 25 08:43:57 raspberrypi weewx[1333]: engine: Using configuration file /etc/weewx/weewx.conf Nov 25 08:43:57 raspberrypi weewx[1333]: engine: Initializing engine Nov 25 08:43:57 raspberrypi weewx[1333]: engine: Loading station type Vantage (weewx.drivers.vantage) Nov 25 08:43:58 raspberrypi weewx[1333]: vantage: driver version is 3.0.7 Nov 25 08:43:58 raspberrypi weewx[1318]: Starting weewx weather system: weewx. Nov 25 08:43:58 raspberrypi systemd[1]: Started LSB: weewx weather system. Nov 25 08:43:58 raspberrypi weewx[1333]: vantage: Opened up ethernet host 192.168.1.45 on port 22222. timeout=4.0, tcp_send_delay=0.5 Nov 25 08:43:58 raspberrypi weewx[1333]: vantage: gentle wake up of console successful Nov 25 08:43:59 raspberrypi weewx[1333]: vantage: _setup; hardware type is 16 Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.engine.StdTimeSynch Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.engine.StdTimeSynch Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.engine.StdConvert Nov 25 08:44:03 raspberrypi weewx[1333]: engine: StdConvert target unit is 0x1 Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.engine.StdConvert Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.engine.StdCalibrate Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.engine.StdCalibrate Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.engine.StdQC Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.engine.StdQC Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.wxservices.StdWXCalculate Nov 25 08:44:03 raspberrypi weewx[1333]: wxcalculate: The following values will be calculated: barometer=prefer_hardware,windchill=prefer_hardware,dewpoint=prefer_hardware,appTemp=prefer_hardware,rainRate=prefer_hardware,windrun=prefer_hardware,heatindex=prefer_hardware,maxSolarRad=prefer_hardware,humidex=prefer_hardware,pressure=prefer_hardware,inDewpoint=prefer_hardware,ET=prefer_hardware,altimeter=prefer_hardware,cloudbase=prefer_hardware Nov 25 08:44:03 raspberrypi weewx[1333]: wxcalculate: The following algorithms will be used for calculations: altimeter=aaNOAA,maxSolarRad=RS Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.wxservices.StdWXCalculate Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.engine.StdArchive Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Archive will use data binding wx_binding Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Record generation will be attempted in 'hardware' Nov 25 08:44:03 raspberrypi weewx[1333]: engine: The archive interval in the configuration file (300) does not match the station hardware interval (60). Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Using archive interval of 60 seconds Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Use LOOP data in hi/low calculations: 1 Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Using binding 'wx_binding' to database 'weewx.sdb' Nov 25 08:44:03 raspberrypi weewx[1333]: manager: Starting backfill of daily summaries Nov 25 08:44:03 raspberrypi weewx[1333]: manager: Daily summaries up to date Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.engine.StdArchive Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.restx.StdStationRegistry Nov 25 08:44:03 raspberrypi weewx[1333]: restx: StationRegistry: Registration not requested. Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.restx.StdStationRegistry Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.restx.StdWunderground Nov 25 08:44:03 raspberrypi weewx[1333]: restx: Wunderground-RF: Data for station KAZSCOTT39 will be posted Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.restx.StdWunderground Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.restx.StdPWSweather Nov 25 08:44:03 raspberrypi weewx[1333]: restx: PWSweather: Posting not enabled. Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.restx.StdPWSweather Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.restx.StdCWOP Nov 25 08:44:03 raspberrypi weewx[1333]: restx: CWOP: Posting not enabled. Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.restx.StdCWOP Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.restx.StdWOW Nov 25 08:44:03 raspberrypi weewx[1333]: restx: WOW: Posting not enabled. Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.restx.StdWOW Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.restx.StdAWEKAS Nov 25 08:44:03 raspberrypi weewx[1333]: restx: AWEKAS: Posting not enabled. Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.restx.StdAWEKAS Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.engine.StdPrint Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.engine.StdPrint Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Loading service weewx.engine.StdReport Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Finished loading service weewx.engine.StdReport Nov 25 08:44:03 raspberrypi weewx[1333]: engine: Starting up weewx version 3.5.0 Nov 25 08:44:04 raspberrypi weewx[1333]: vantage: gentle wake up of console successful Nov 25 08:44:04 raspberrypi weewx[1333]: engine: Clock error is -0.80 seconds (positive is fast) Nov 25 08:44:04 raspberrypi weewx[1333]: vantage: Getting archive packets since 2016-11-25 08:22:00 MST (1480087320) Nov 25 08:44:05 raspberrypi weewx[1333]: vantage: gentle wake up of console successful Nov 25 08:44:06 raspberrypi weewx[1333]: vantage: Retrieving 5 page(s); starting index= 3 Nov 25 08:44:07 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:23:00 MST (1480087380) to database 'weewx.sdb' Nov 25 08:44:07 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:23:00 MST (1480087380) to daily summary in 'weewx.sdb' Nov 25 08:44:07 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:24:00 MST (1480087440) to database 'weewx.sdb' Nov 25 08:44:07 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:24:00 MST (1480087440) to daily summary in 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:25:00 MST (1480087500) to database 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:25:00 MST (1480087500) to daily summary in 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:26:00 MST (1480087560) to database 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:26:00 MST (1480087560) to daily summary in 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:27:00 MST (1480087620) to database 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:27:00 MST (1480087620) to daily summary in 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:28:00 MST (1480087680) to database 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:28:00 MST (1480087680) to daily summary in 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:29:00 MST (1480087740) to database 'weewx.sdb' Nov 25 08:44:08 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:29:00 MST (1480087740) to daily summary in 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:30:00 MST (1480087800) to database 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:30:00 MST (1480087800) to daily summary in 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:31:00 MST (1480087860) to database 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:31:00 MST (1480087860) to daily summary in 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:32:00 MST (1480087920) to database 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:32:00 MST (1480087920) to daily summary in 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:33:00 MST (1480087980) to database 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:33:00 MST (1480087980) to daily summary in 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:34:00 MST (1480088040) to database 'weewx.sdb' Nov 25 08:44:09 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:34:00 MST (1480088040) to daily summary in 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:35:00 MST (1480088100) to database 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:35:00 MST (1480088100) to daily summary in 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:36:00 MST (1480088160) to database 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:36:00 MST (1480088160) to daily summary in 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:37:00 MST (1480088220) to database 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:37:00 MST (1480088220) to daily summary in 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:38:00 MST (1480088280) to database 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:38:00 MST (1480088280) to daily summary in 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:39:00 MST (1480088340) to database 'weewx.sdb' Nov 25 08:44:10 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:39:00 MST (1480088340) to daily summary in 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:40:00 MST (1480088400) to database 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:40:00 MST (1480088400) to daily summary in 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:41:00 MST (1480088460) to database 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:41:00 MST (1480088460) to daily summary in 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:42:00 MST (1480088520) to database 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:42:00 MST (1480088520) to daily summary in 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:43:00 MST (1480088580) to database 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:43:00 MST (1480088580) to daily summary in 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:44:00 MST (1480088640) to database 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:44:00 MST (1480088640) to daily summary in 'weewx.sdb' Nov 25 08:44:11 raspberrypi weewx[1333]: engine: Starting main packet loop. Nov 25 08:44:12 raspberrypi weewx[1333]: vantage: gentle wake up of console successful Nov 25 08:44:12 raspberrypi weewx[1333]: vantage: Requesting 200 LOOP packets. Nov 25 08:44:13 raspberrypi weewx[1333]: vantage: gentle wake up of console successful Nov 25 08:45:15 raspberrypi weewx[1333]: vantage: Getting archive packets since 2016-11-25 08:44:00 MST (1480088640) Nov 25 08:45:15 raspberrypi rsyslogd-2007: action 'action 17' suspended, next retry is Fri Nov 25 08:45:45 2016 [try http://www.rsyslog.com/e/2007 ] Nov 25 08:45:15 raspberrypi weewx[1333]: vantage: gentle wake up of console successful Nov 25 08:45:17 raspberrypi weewx[1333]: vantage: Retrieving 1 page(s); starting index= 0 Nov 25 08:45:17 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:45:00 MST (1480088700) to database 'weewx.sdb' Nov 25 08:45:17 raspberrypi weewx[1333]: manager: added record 2016-11-25 08:45:00 MST (1480088700) to daily summary in 'weewx.sdb' Nov 25 08:45:17 raspberrypi weewx[1333]: vantage: DMPAFT complete: page timestamp 2016-11-23 14:01:00 MST (1479934860) less than final timestamp 2016-11-25 08:45:00 MST (1480088700) Nov 25 08:45:17 raspberrypi weewx[1333]: vantage: Catch up complete. Nov 25 08:45:17 raspberrypi weewx[1333]: reportengine: Running reports for latest time in the database. Nov 25 08:45:17 raspberrypi weewx[1333]: vantage: Requesting 200 LOOP packets. Nov 25 08:45:17 raspberrypi weewx[1333]: reportengine: Running report StandardReport Nov 25 08:45:17 raspberrypi weewx[1333]: reportengine: Found configuration file /etc/weewx/skins/Standard/skin.conf for report StandardReport Nov 25 08:45:18 raspberrypi weewx[1333]: vantage: gentle wake up of console successful Nov 25 08:45:26 raspberrypi weewx[1333]: cheetahgenerator: Generated 14 files for report StandardReport in 8.00 seconds Nov 25 08:45:28 raspberrypi weewx[1333]: genimages: Generated 12 images for StandardReport in 1.96 seconds Nov 25 08:45:28 raspberrypi weewx[1333]: reportengine: copied 9 files to /var/www/html/weewx Nov 25 08:45:28 raspberrypi weewx[1333]: reportengine: Running report FTP Nov 25 08:45:28 raspberrypi weewx[1333]: reportengine: Found configuration file /etc/weewx/skins/Ftp/skin.conf for report FTP Nov 25 08:45:28 raspberrypi weewx[1333]: ftpupload: Attempting secure connection to jonadams.com Nov 25 08:45:29 raspberrypi weewx[1333]: ftpupload: Secure connection to jonadams.com Nov 25 08:45:29 raspberrypi weewx[1333]: ftpupload: Uploaded file /jonadams/pages/weewx/month.html Nov 25 08:45:30 raspberrypi weewx[1333]: ftpupload: Uploaded file /jonadams/pages/weewx/weewx.css Nov 25 08:45:30 raspberrypi weewx[1333]: ftpupload: Uploaded file /jonadams/pages/weewx/index.html Nov 25 08:45:31 raspberrypi weewx[1333]: ftpupload: Uploaded file /jonadams/pages/weewx/daytempchill.png Nov 25 08:45:31 raspberrypi weewx[1333]: ftpupload: Uploaded file /jonadams/pages/weewx/dayuv.png