May 11 09:08:51 syslogd exiting May 11 09:09:00 syslogd started: BusyBox v1.11.2 May 11 09:09:00 kernel: klogd started: BusyBox v1.11.2 (mbari-1) May 11 09:09:00 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 May 11 09:09:00 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 May 11 09:09:00 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache May 11 09:09:00 kernel: [ 0.00] Machine: NXP EA313X May 11 09:09:00 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback May 11 09:09:00 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 May 11 09:09:00 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait May 11 09:09:00 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) May 11 09:09:00 kernel: [ 0.24] Mount-cache hash table entries: 512 May 11 09:09:00 kernel: [ 0.26] cgu_init pll set at 270000000 May 11 09:09:00 kernel: [ 0.29] PC/104 Carrier May 11 09:09:00 kernel: [ 0.39] bio: create slab at 0 May 11 09:09:00 kernel: [ 0.40] SCSI subsystem initialized May 11 09:09:00 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) May 11 09:09:00 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. May 11 09:09:00 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": May 11 09:09:00 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" May 11 09:09:00 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." May 11 09:09:00 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" May 11 09:09:00 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash May 11 09:09:00 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 14:38:10 IridiumLocation: -2696,-4344,3796,76fb5d4b Jan 21 14:38:10 su: + /dev/console root:esp Jan 21 14:38:26 pppd[484]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 14:38:31 callBack[447]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 14:38:36 pppd[484]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 14:38:44 pppd[484]: CHAP authentication succeeded Jan 21 14:38:49 pppd[484]: local IP address 192.168.11.207 Jan 21 14:38:49 pppd[484]: remote IP address 192.168.11.254 Jan 21 14:38:49 pppd[484]: primary DNS address 12.127.17.72 Jan 21 14:38:49 pppd[484]: secondary DNS address 204.97.212.10 Jan 21 14:38:50 pppd[520]: Compression disabled by peer. Jan 21 14:39:08 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 14:40:35 pppd[520]: Modem hangup Jan 21 14:40:35 pppd[520]: Connection terminated. Jan 21 14:40:42 syslogd exiting Jan 21 14:49:12 syslogd started: BusyBox v1.11.2 Jan 21 14:49:12 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 14:49:12 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 14:49:12 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 14:49:12 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 14:49:12 kernel: [ 0.00] Machine: NXP EA313X Jan 21 14:49:12 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 14:49:12 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 14:49:12 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 14:49:12 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 14:49:12 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 14:49:12 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 14:49:12 kernel: [ 0.29] PC/104 Carrier Jan 21 14:49:12 kernel: [ 0.39] bio: create slab at 0 Jan 21 14:49:12 kernel: [ 0.40] SCSI subsystem initialized Jan 21 14:49:12 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 14:49:12 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 14:49:12 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 14:49:12 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 14:49:12 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 14:49:12 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 14:49:12 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 14:49:12 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 14:49:14 IridiumLocation: -2692,-4344,3800,77186e27 Jan 21 14:49:14 su: + /dev/console root:esp Jan 21 14:49:34 callBack[446]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 14:51:04 pppd[748]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 14:51:14 pppd[748]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 14:51:18 pppd[748]: CHAP authentication succeeded Jan 21 14:51:28 pppd[748]: local IP address 192.168.11.209 Jan 21 14:51:28 pppd[748]: remote IP address 192.168.11.254 Jan 21 14:51:28 pppd[748]: primary DNS address 12.127.17.72 Jan 21 14:51:28 pppd[748]: secondary DNS address 204.97.212.10 Jan 21 14:51:37 pppd[775]: local IP address 192.168.11.209 Jan 21 14:51:37 pppd[775]: remote IP address 192.168.11.254 Jan 21 14:51:37 pppd[775]: primary DNS address 12.127.17.72 Jan 21 14:51:37 pppd[775]: secondary DNS address 204.97.212.10 Jan 21 14:51:45 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 14:54:20 pppd[775]: Connection terminated. Jan 21 14:56:05 pppd[1072]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 14:56:18 pppd[1072]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 14:56:22 pppd[1072]: CHAP authentication succeeded Jan 21 14:56:30 pppd[1072]: local IP address 192.168.11.211 Jan 21 14:56:30 pppd[1072]: remote IP address 192.168.11.254 Jan 21 14:56:30 pppd[1072]: primary DNS address 12.127.17.72 Jan 21 14:56:30 pppd[1072]: secondary DNS address 204.97.212.10 Jan 21 14:56:32 pppd[1089]: Compression disabled by peer. Jan 21 14:56:34 pppd[1089]: local IP address 192.168.11.211 Jan 21 14:56:34 pppd[1089]: remote IP address 192.168.11.254 Jan 21 14:56:34 pppd[1089]: primary DNS address 12.127.17.72 Jan 21 14:56:34 pppd[1089]: secondary DNS address 204.97.212.10 Jan 21 14:56:42 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 14:58:15 pppd[1089]: Connection terminated. Jan 21 14:58:21 syslogd exiting Jan 21 15:02:15 syslogd started: BusyBox v1.11.2 Jan 21 15:02:15 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 15:02:15 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 15:02:15 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 15:02:15 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 15:02:15 kernel: [ 0.00] Machine: NXP EA313X Jan 21 15:02:15 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 15:02:15 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 15:02:15 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 15:02:15 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 15:02:15 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 15:02:15 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 15:02:15 kernel: [ 0.29] PC/104 Carrier Jan 21 15:02:15 kernel: [ 0.39] bio: create slab at 0 Jan 21 15:02:15 kernel: [ 0.40] SCSI subsystem initialized Jan 21 15:02:15 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 15:02:15 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 15:02:15 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 15:02:15 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 15:02:15 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 15:02:15 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 15:02:15 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 15:02:15 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 15:02:19 reset-modem: No espclient -- resetting via /dev/I2Cgate Jan 21 15:02:19 su: + none root:esp Jan 21 15:02:25 su: + /dev/console root:esp Jan 21 15:02:41 pppd[504]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 15:02:45 callBack[462]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 15:03:31 pppd[504]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 15:03:33 pppd[504]: CHAP authentication succeeded Jan 21 15:03:42 pppd[504]: local IP address 192.168.10.14 Jan 21 15:03:42 pppd[504]: remote IP address 192.168.10.254 Jan 21 15:03:42 pppd[504]: primary DNS address 12.127.17.72 Jan 21 15:03:42 pppd[504]: secondary DNS address 204.97.212.10 Jan 21 15:03:48 pppd[813]: Compression disabled by peer. Jan 21 15:03:50 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 15:05:24 pppd[813]: Modem hangup Jan 21 15:05:24 pppd[813]: Connection terminated. Jan 21 15:10:41 pppd[999]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 15:10:52 pppd[999]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 15:10:57 pppd[999]: CHAP authentication succeeded Jan 21 15:11:02 pppd[999]: local IP address 192.168.11.213 Jan 21 15:11:02 pppd[999]: remote IP address 192.168.11.254 Jan 21 15:11:02 pppd[999]: primary DNS address 12.127.17.72 Jan 21 15:11:02 pppd[999]: secondary DNS address 204.97.212.10 Jan 21 15:11:03 pppd[1012]: Compression disabled by peer. Jan 21 15:11:10 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 15:11:41 pppd[1012]: Connection terminated. Jan 21 15:11:47 syslogd exiting Jan 21 15:19:11 syslogd started: BusyBox v1.11.2 Jan 21 15:19:11 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 15:19:11 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 15:19:11 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 15:19:11 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 15:19:11 kernel: [ 0.00] Machine: NXP EA313X Jan 21 15:19:11 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 15:19:11 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 15:19:11 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 15:19:11 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 15:19:11 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 15:19:11 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 15:19:11 kernel: [ 0.29] PC/104 Carrier Jan 21 15:19:11 kernel: [ 0.39] bio: create slab at 0 Jan 21 15:19:11 kernel: [ 0.40] SCSI subsystem initialized Jan 21 15:19:11 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 15:19:11 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 15:19:11 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 15:19:11 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 15:19:11 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 15:19:11 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 15:19:11 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 15:19:11 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 15:19:12 reset-modem: No espclient -- resetting via /dev/I2Cgate Jan 21 15:19:12 su: + none root:esp Jan 21 15:19:12 kernel: [ 6.06] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:12 kernel: [ 6.09] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.14] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.17] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.21] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.22] hub 1-1:1.0: Cannot enable port 3. Maybe the USB cable is bad? Jan 21 15:19:13 kernel: [ 6.26] hub 1-1:1.0: cannot disable port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.30] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.34] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.37] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.41] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.45] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.46] hub 1-1:1.0: Cannot enable port 3. Maybe the USB cable is bad? Jan 21 15:19:13 kernel: [ 6.50] hub 1-1:1.0: cannot disable port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.54] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.57] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.61] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.65] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.69] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.69] hub 1-1:1.0: Cannot enable port 3. Maybe the USB cable is bad? Jan 21 15:19:13 kernel: [ 6.74] hub 1-1:1.0: cannot disable port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.77] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.81] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.85] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.89] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.93] hub 1-1:1.0: cannot reset port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.93] hub 1-1:1.0: Cannot enable port 3. Maybe the USB cable is bad? Jan 21 15:19:13 kernel: [ 6.98] hub 1-1:1.0: cannot disable port 3 (err = -71) Jan 21 15:19:13 kernel: [ 6.98] hub 1-1:1.0: unable to enumerate USB device on port 3 Jan 21 15:19:13 kernel: [ 7.02] hub 1-1:1.0: cannot disable port 3 (err = -71) Jan 21 15:19:13 kernel: [ 7.06] hub 1-1:1.0: hub_port_status failed (err = -71) Jan 21 15:19:18 su: + /dev/console root:esp Jan 21 15:19:19 kernel: [ 12.24] usb 1-1.3: device descriptor read/64, error -71 Jan 21 15:19:19 kernel: [ 12.54] usb 1-1.3: device descriptor read/64, error -71 Jan 21 15:19:19 kernel: [ 12.94] usb 1-1.3: device descriptor read/64, error -71 Jan 21 15:19:20 kernel: [ 13.24] usb 1-1.3: device descriptor read/64, error -71 Jan 21 15:19:20 kernel: [ 13.93] usb 1-1.3: device not accepting address 13, error -71 Jan 21 15:19:21 kernel: [ 14.51] usb 1-1.3: device not accepting address 14, error -71 Jan 21 15:19:21 kernel: [ 14.51] hub 1-1:1.0: unable to enumerate USB device on port 3 Jan 21 15:19:38 callBack[462]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 15:21:19 pppd[769]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 15:22:07 pppd[769]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 15:22:38 pppd[769]: LCP: timeout sending Config-Requests Jan 21 15:22:38 pppd[769]: Connection terminated. Jan 21 15:22:40 pppd[769]: Modem hangup Jan 21 15:27:28 su: + /dev/ttyS0 esp:root Jan 21 15:27:37 su: + /dev/ttyS0 esp:root Jan 21 15:28:42 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 15:28:58 dropbear[1313]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53370 Jan 21 15:29:20 dropbear[1316]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53372 Jan 21 16:00:48 reset-modem: No espclient -- resetting via /dev/I2Cgate Jan 21 16:00:48 su: + none root:esp Jan 21 16:00:56 ttyLogin[1420]: Accepting login on ttyUSB0.login @115200 baud for 30 seconds Jan 21 16:03:46 su: + /dev/pts/0 root:esp Jan 21 16:07:56 syslogd exiting Jan 21 16:08:06 syslogd started: BusyBox v1.11.2 Jan 21 16:08:06 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 16:08:06 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 16:08:06 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 16:08:06 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 16:08:06 kernel: [ 0.00] Machine: NXP EA313X Jan 21 16:08:06 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 16:08:06 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 16:08:06 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 16:08:06 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 16:08:06 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 16:08:06 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 16:08:06 kernel: [ 0.29] PC/104 Carrier Jan 21 16:08:06 kernel: [ 0.39] bio: create slab at 0 Jan 21 16:08:06 kernel: [ 0.40] SCSI subsystem initialized Jan 21 16:08:06 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 16:08:06 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 16:08:06 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 16:08:06 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 16:08:06 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 16:08:06 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 16:08:06 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 16:08:06 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 16:08:09 IridiumLocation: -2684,-4352,3792,7718c227 Jan 21 16:08:09 su: + /dev/console root:esp Jan 21 16:08:30 callBack[446]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 16:08:42 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 16:09:13 syslogd exiting Jan 21 16:10:27 syslogd started: BusyBox v1.11.2 Jan 21 16:10:27 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 16:10:27 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 16:10:27 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 16:10:27 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 16:10:27 kernel: [ 0.00] Machine: NXP EA313X Jan 21 16:10:27 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 16:10:27 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 16:10:27 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 16:10:27 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 16:10:27 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 16:10:27 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 16:10:27 kernel: [ 0.29] PC/104 Carrier Jan 21 16:10:27 kernel: [ 0.39] bio: create slab at 0 Jan 21 16:10:27 kernel: [ 0.40] SCSI subsystem initialized Jan 21 16:10:27 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 16:10:27 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 16:10:27 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 16:10:27 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 16:10:27 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 16:10:27 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 16:10:27 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 16:10:27 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 16:10:30 IridiumLocation: -2692,-4344,3796,77195ce2 Jan 21 16:10:30 su: + /dev/console root:esp Jan 21 16:10:51 callBack[446]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 16:10:57 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 16:14:06 su: + /dev/ttyS0 root:esp Jan 21 16:18:54 syslogd exiting Jan 21 16:20:46 syslogd started: BusyBox v1.11.2 Jan 21 16:20:46 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 16:20:46 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 16:20:46 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 16:20:46 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 16:20:46 kernel: [ 0.00] Machine: NXP EA313X Jan 21 16:20:46 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 16:20:46 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 16:20:46 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 16:20:46 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 16:20:46 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 16:20:46 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 16:20:46 kernel: [ 0.29] PC/104 Carrier Jan 21 16:20:46 kernel: [ 0.39] bio: create slab at 0 Jan 21 16:20:46 kernel: [ 0.40] SCSI subsystem initialized Jan 21 16:20:46 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 16:20:46 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 16:20:46 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 16:20:46 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 16:20:46 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 16:20:46 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 16:20:46 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 16:20:46 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 16:20:48 IridiumLocation: -2688,-4344,3796,771977b3 Jan 21 16:20:48 su: + /dev/console root:esp Jan 21 16:21:09 callBack[446]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 16:21:09 callBack[446]: Got RING on /dev/modem Jan 21 16:21:16 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 16:22:10 pppd[910]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 16:22:32 pppd[910]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 16:23:03 pppd[910]: LCP: timeout sending Config-Requests Jan 21 16:23:03 pppd[910]: Connection terminated. Jan 21 16:23:05 pppd[910]: Modem hangup Jan 21 16:23:25 callBack[949]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 16:25:05 su: + /dev/ttyS0 root:esp Jan 21 16:30:25 su: + /dev/ttyS0 root:esp Jan 21 16:39:29 syslogd exiting Jan 21 16:43:02 syslogd started: BusyBox v1.11.2 Jan 21 16:43:02 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 16:43:02 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 16:43:02 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 16:43:02 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 16:43:02 kernel: [ 0.00] Machine: NXP EA313X Jan 21 16:43:02 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 16:43:02 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 16:43:02 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 16:43:02 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 16:43:02 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 16:43:02 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 16:43:02 kernel: [ 0.29] PC/104 Carrier Jan 21 16:43:02 kernel: [ 0.39] bio: create slab at 0 Jan 21 16:43:02 kernel: [ 0.40] SCSI subsystem initialized Jan 21 16:43:02 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 16:43:02 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 16:43:02 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 16:43:02 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 16:43:02 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 16:43:02 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 16:43:02 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 16:43:02 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 16:43:04 IridiumLocation: -2688,-4348,3796,7719b1ca Jan 21 16:43:04 su: + /dev/console root:esp Jan 21 16:43:24 callBack[446]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 16:43:32 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 16:48:21 su: + /dev/ttyS0 esp:esp Jan 21 16:48:59 su: + /dev/ttyS0 esp:esp Jan 21 17:10:25 dropbear[958]: Pubkey auth succeeded for 'esp' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53568 Jan 21 17:11:00 dropbear[968]: Pubkey auth succeeded for 'esp' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53572 Jan 21 17:19:03 su: + /dev/ttyS0 esp:esp Jan 21 17:19:37 su: + /dev/ttyS0 esp:esp Jan 21 17:24:34 syslogd exiting Jan 21 17:24:43 syslogd started: BusyBox v1.11.2 Jan 21 17:24:43 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 17:24:43 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 17:24:43 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 17:24:43 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 17:24:43 kernel: [ 0.00] Machine: NXP EA313X Jan 21 17:24:43 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 17:24:43 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 17:24:43 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 17:24:43 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 17:24:43 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 17:24:43 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 17:24:43 kernel: [ 0.29] PC/104 Carrier Jan 21 17:24:43 kernel: [ 0.39] bio: create slab at 0 Jan 21 17:24:43 kernel: [ 0.40] SCSI subsystem initialized Jan 21 17:24:43 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 17:24:43 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 17:24:43 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 17:24:43 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 17:24:43 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 17:24:43 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 17:24:43 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 17:24:43 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 17:24:45 IridiumLocation: -2688,-4348,3796,7719b1ca Jan 21 17:24:45 su: + /dev/console root:esp Jan 21 17:25:06 callBack[446]: Awaiting RING on /dev/modem to sleep 60; ifup iridium Jan 21 17:25:13 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 17:27:35 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 17:28:55 su: + /dev/ttyS0 root:esp Jan 21 17:29:21 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 17:31:37 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 17:33:38 callBack[446]: Got RING on /dev/modem Jan 21 17:34:39 pppd[1606]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 17:34:53 pppd[1606]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 17:34:57 pppd[1606]: CHAP authentication succeeded Jan 21 17:35:02 pppd[1606]: local IP address 192.168.20.41 Jan 21 17:35:02 pppd[1606]: remote IP address 192.168.20.254 Jan 21 17:35:02 pppd[1606]: primary DNS address 199.2.252.10 Jan 21 17:35:02 pppd[1606]: secondary DNS address 204.97.212.10 Jan 21 17:35:03 pppd[1635]: Compression disabled by peer. Jan 21 17:35:09 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 17:35:23 callBack[1637]: Awaiting RING on /dev/modem to sleep 60; ifup wired Jan 21 17:37:55 pppd[1635]: Connection terminated. Jan 21 17:38:56 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 17:42:58 dropbear[2034]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53842 Jan 21 17:43:00 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 17:45:45 dropbear[2056]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53848 Jan 21 17:46:47 dropbear[2060]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53850 Jan 21 17:47:27 dropbear[2063]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53854 Jan 21 17:48:26 dropbear[2070]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53862 Jan 21 17:50:11 dropbear[2075]: Pubkey auth succeeded for 'esp' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:53868 Jan 21 17:53:39 syslogd exiting Jan 21 17:53:49 syslogd started: BusyBox v1.11.2 Jan 21 17:53:49 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 17:53:49 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 17:53:49 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 17:53:49 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 17:53:49 kernel: [ 0.00] Machine: NXP EA313X Jan 21 17:53:49 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 17:53:49 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 17:53:49 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 17:53:49 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 17:53:49 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 17:53:49 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 17:53:49 kernel: [ 0.29] PC/104 Carrier Jan 21 17:53:49 kernel: [ 0.39] bio: create slab at 0 Jan 21 17:53:49 kernel: [ 0.40] SCSI subsystem initialized Jan 21 17:53:49 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 17:53:49 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 17:53:49 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 17:53:49 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 17:53:49 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 17:53:49 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 17:53:49 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 17:53:49 kernel: [ 1.20] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 17:53:51 IridiumLocation: -2692,-4344,3800,771a3932 Jan 21 17:53:51 su: + /dev/console root:esp Jan 21 17:54:08 pppd[486]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 17:54:11 ringBack[445]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 21 17:54:20 pppd[486]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 17:54:25 pppd[486]: CHAP authentication succeeded Jan 21 17:54:30 pppd[486]: local IP address 192.168.11.116 Jan 21 17:54:30 pppd[486]: remote IP address 192.168.11.254 Jan 21 17:54:30 pppd[486]: primary DNS address 12.127.17.72 Jan 21 17:54:30 pppd[486]: secondary DNS address 204.97.212.10 Jan 21 17:54:30 pppd[522]: Compression disabled by peer. Jan 21 17:54:47 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 17:57:04 pppd[522]: Connection terminated. Jan 21 17:57:09 syslogd exiting Jan 21 18:04:11 syslogd started: BusyBox v1.11.2 Jan 21 18:04:11 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 18:04:11 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 18:04:11 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 18:04:11 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 18:04:11 kernel: [ 0.00] Machine: NXP EA313X Jan 21 18:04:11 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 18:04:11 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 18:04:11 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 18:04:11 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 18:04:11 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 18:04:11 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 18:04:11 kernel: [ 0.29] PC/104 Carrier Jan 21 18:04:11 kernel: [ 0.39] bio: create slab at 0 Jan 21 18:04:11 kernel: [ 0.40] SCSI subsystem initialized Jan 21 18:04:11 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 18:04:11 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 18:04:11 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 18:04:11 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 18:04:11 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 18:04:11 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 18:04:11 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 18:04:11 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 18:04:13 IridiumLocation: -2692,-4344,3800,771a6bd1 Jan 21 18:04:13 su: + /dev/console root:esp Jan 21 18:04:33 ringBack[445]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 21 18:05:59 pppd[749]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 18:06:10 pppd[749]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 18:06:15 pppd[749]: CHAP authentication succeeded Jan 21 18:06:20 pppd[749]: local IP address 192.168.11.122 Jan 21 18:06:20 pppd[749]: remote IP address 192.168.11.254 Jan 21 18:06:20 pppd[749]: primary DNS address 12.127.17.72 Jan 21 18:06:20 pppd[749]: secondary DNS address 204.97.212.10 Jan 21 18:06:21 pppd[778]: Compression disabled by peer. Jan 21 18:06:28 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 18:08:34 pppd[778]: Connection terminated. Jan 21 18:10:59 pppd[984]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 18:11:09 pppd[984]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 18:11:18 pppd[984]: Deflate (15) compression enabled Jan 21 18:11:19 pppd[984]: local IP address 192.168.112.176 Jan 21 18:11:19 pppd[984]: remote IP address 192.168.112.1 Jan 21 18:11:19 pppd[984]: primary DNS address 199.2.252.10 Jan 21 18:11:19 pppd[984]: secondary DNS address 204.97.212.10 Jan 21 18:11:27 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 18:12:33 pppd[995]: Connection terminated. Jan 21 18:12:39 syslogd exiting Jan 21 18:14:26 syslogd started: BusyBox v1.11.2 Jan 21 18:14:26 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 18:14:26 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 18:14:26 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 18:14:26 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 18:14:26 kernel: [ 0.00] Machine: NXP EA313X Jan 21 18:14:26 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 18:14:26 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 18:14:26 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 18:14:26 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 18:14:26 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 18:14:26 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 18:14:26 kernel: [ 0.29] PC/104 Carrier Jan 21 18:14:26 kernel: [ 0.39] bio: create slab at 0 Jan 21 18:14:26 kernel: [ 0.40] SCSI subsystem initialized Jan 21 18:14:26 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 18:14:26 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 18:14:26 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 18:14:26 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 18:14:26 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 18:14:26 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 18:14:26 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 18:14:26 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 18:14:28 IridiumLocation: -2688,-4348,3800,771a9fbd Jan 21 18:14:28 su: + /dev/console root:esp Jan 21 18:14:44 pppd[480]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 18:14:48 ringBack[445]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 21 18:14:54 pppd[480]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 18:14:58 pppd[480]: CHAP authentication succeeded Jan 21 18:15:04 pppd[480]: local IP address 192.168.10.67 Jan 21 18:15:04 pppd[480]: remote IP address 192.168.10.254 Jan 21 18:15:04 pppd[480]: primary DNS address 12.127.17.72 Jan 21 18:15:04 pppd[480]: secondary DNS address 204.97.212.10 Jan 21 18:15:04 pppd[516]: Compression disabled by peer. Jan 21 18:15:13 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 18:19:07 su: + /dev/ttyS0 root:esp Jan 21 18:22:11 pppd[516]: Connection terminated. Jan 21 18:23:02 pppd[975]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 18:23:34 pppd[975]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 18:23:38 pppd[975]: CHAP authentication succeeded Jan 21 18:23:43 pppd[975]: local IP address 192.168.11.128 Jan 21 18:23:43 pppd[975]: remote IP address 192.168.11.254 Jan 21 18:23:43 pppd[975]: primary DNS address 12.127.17.72 Jan 21 18:23:43 pppd[975]: secondary DNS address 204.97.212.10 Jan 21 18:23:44 pppd[991]: Compression disabled by peer. Jan 21 18:23:51 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 18:25:10 pppd[991]: Connection terminated. Jan 21 18:33:02 pppd[1206]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 18:33:13 pppd[1206]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 18:33:18 pppd[1206]: CHAP authentication succeeded Jan 21 18:33:23 pppd[1206]: local IP address 192.168.11.132 Jan 21 18:33:23 pppd[1206]: remote IP address 192.168.11.254 Jan 21 18:33:23 pppd[1206]: primary DNS address 12.127.17.72 Jan 21 18:33:23 pppd[1206]: secondary DNS address 204.97.212.10 Jan 21 18:33:24 pppd[1219]: Compression disabled by peer. Jan 21 18:33:31 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 18:35:11 pppd[1219]: Connection terminated. Jan 21 19:07:07 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 19:07:47 su: + /dev/ttyS0 root:esp Jan 21 19:08:35 dropbear[1547]: Pubkey auth succeeded for 'esp' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:54096 Jan 21 19:36:14 dropbear[1572]: Pubkey auth succeeded for 'esp' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:54148 Jan 21 19:41:51 dropbear[1586]: Pubkey auth succeeded for 'esp' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:54152 Jan 21 19:48:57 syslogd exiting Jan 21 19:49:06 syslogd started: BusyBox v1.11.2 Jan 21 19:49:06 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 19:49:06 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 19:49:06 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 19:49:06 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 19:49:06 kernel: [ 0.00] Machine: NXP EA313X Jan 21 19:49:06 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 19:49:06 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 19:49:06 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 19:49:06 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 19:49:06 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 19:49:06 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 19:49:06 kernel: [ 0.29] PC/104 Carrier Jan 21 19:49:06 kernel: [ 0.39] bio: create slab at 0 Jan 21 19:49:06 kernel: [ 0.40] SCSI subsystem initialized Jan 21 19:49:06 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 19:49:06 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 19:49:06 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 19:49:06 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 19:49:06 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 19:49:06 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 19:49:06 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 19:49:06 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 19:49:09 IridiumLocation: -2672,-4356,3796,771ad11d Jan 21 19:49:09 su: + /dev/console root:esp Jan 21 19:49:30 ringBack[445]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 21 19:49:30 pppd[487]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 19:49:40 pppd[487]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 19:49:44 pppd[487]: CHAP authentication succeeded Jan 21 19:49:50 pppd[487]: local IP address 192.168.10.74 Jan 21 19:49:50 pppd[487]: remote IP address 192.168.10.254 Jan 21 19:49:50 pppd[487]: primary DNS address 12.127.17.72 Jan 21 19:49:50 pppd[487]: secondary DNS address 204.97.212.10 Jan 21 19:50:12 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 19:51:36 pppd[525]: Connection terminated. Jan 21 19:51:38 pppd[525]: Modem hangup Jan 21 19:52:42 su: + /dev/ttyS0 esp:esp Jan 21 19:55:38 syslogd exiting Jan 21 19:55:47 syslogd started: BusyBox v1.11.2 Jan 21 19:55:47 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 19:55:47 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 19:55:47 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 19:55:47 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 19:55:47 kernel: [ 0.00] Machine: NXP EA313X Jan 21 19:55:47 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 19:55:47 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 19:55:47 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 19:55:47 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 19:55:47 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 19:55:47 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 19:55:47 kernel: [ 0.29] PC/104 Carrier Jan 21 19:55:47 kernel: [ 0.39] bio: create slab at 0 Jan 21 19:55:47 kernel: [ 0.40] SCSI subsystem initialized Jan 21 19:55:47 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 19:55:47 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 19:55:47 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 19:55:47 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 19:55:47 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 19:55:47 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 19:55:47 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 19:55:47 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 19:55:49 IridiumLocation: -2692,-4344,3800,771b9833 Jan 21 19:55:49 su: + /dev/console root:esp Jan 21 19:56:09 ringBack[445]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 21 19:57:25 su: - /dev/ttyS0 esp:esp Jan 21 19:57:30 su: + /dev/ttyS0 esp:esp Jan 21 20:01:48 su: + /dev/ttyS0 esp:esp Jan 21 20:02:43 syslogd exiting Jan 21 20:02:52 syslogd started: BusyBox v1.11.2 Jan 21 20:02:52 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 20:02:52 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 20:02:52 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 20:02:52 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 20:02:52 kernel: [ 0.00] Machine: NXP EA313X Jan 21 20:02:52 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 20:02:52 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 20:02:52 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 20:02:52 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 20:02:52 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 20:02:52 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 20:02:52 kernel: [ 0.29] PC/104 Carrier Jan 21 20:02:52 kernel: [ 0.39] bio: create slab at 0 Jan 21 20:02:52 kernel: [ 0.40] SCSI subsystem initialized Jan 21 20:02:52 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 20:02:52 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 20:02:52 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 20:02:52 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 20:02:52 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 20:02:52 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 20:02:52 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 20:02:52 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 20:02:54 IridiumLocation: -2692,-4344,3800,771b9833 Jan 21 20:02:54 su: + /dev/console root:esp Jan 21 20:03:15 ringBack[445]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 21 20:03:16 pppd[493]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 20:03:27 pppd[493]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 20:03:31 pppd[493]: CHAP authentication succeeded Jan 21 20:03:42 pppd[493]: local IP address 192.168.11.154 Jan 21 20:03:42 pppd[493]: remote IP address 192.168.11.254 Jan 21 20:03:42 pppd[493]: primary DNS address 12.127.17.72 Jan 21 20:03:42 pppd[493]: secondary DNS address 204.97.212.10 Jan 21 20:03:56 pppd[711]: local IP address 192.168.11.154 Jan 21 20:03:56 pppd[711]: remote IP address 192.168.11.254 Jan 21 20:03:56 pppd[711]: primary DNS address 12.127.17.72 Jan 21 20:03:56 pppd[711]: secondary DNS address 204.97.212.10 Jan 21 20:04:01 pppd[711]: Compression disabled by peer. Jan 21 20:04:03 tunnel2shore[444]: Opening tunnel to ESPshore Jan 21 20:06:12 pppd[711]: Connection terminated. Jan 21 20:06:18 syslogd exiting Jan 21 20:06:32 syslogd started: BusyBox v1.11.2 Jan 21 20:06:32 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 20:06:32 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 20:06:32 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 20:06:32 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 20:06:32 kernel: [ 0.00] Machine: NXP EA313X Jan 21 20:06:32 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 20:06:32 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 20:06:32 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 20:06:32 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 20:06:32 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 20:06:32 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 20:06:32 kernel: [ 0.29] PC/104 Carrier Jan 21 20:06:32 kernel: [ 0.39] bio: create slab at 0 Jan 21 20:06:32 kernel: [ 0.40] SCSI subsystem initialized Jan 21 20:06:32 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 20:06:32 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 20:06:32 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 20:06:32 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 20:06:32 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 20:06:32 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 20:06:32 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 20:06:32 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 20:06:36 reset-modem: No espclient -- resetting via /dev/I2Cgate Jan 21 20:06:36 su: + none root:esp Jan 21 20:06:42 su: + /dev/console root:esp Jan 21 20:07:02 ringBack[461]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 21 20:09:07 pppd[788]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 20:09:19 pppd[788]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 20:09:24 pppd[788]: CHAP authentication succeeded Jan 21 20:09:29 pppd[788]: local IP address 192.168.11.156 Jan 21 20:09:29 pppd[788]: remote IP address 192.168.11.254 Jan 21 20:09:29 pppd[788]: primary DNS address 12.127.17.72 Jan 21 20:09:29 pppd[788]: secondary DNS address 204.97.212.10 Jan 21 20:09:30 pppd[817]: Compression disabled by peer. Jan 21 20:09:37 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 20:11:16 pppd[817]: Connection terminated. Jan 21 20:13:04 pppd[1013]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 20:13:19 pppd[1013]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 20:13:23 pppd[1013]: CHAP authentication succeeded Jan 21 20:13:27 pppd[1013]: local IP address 192.168.11.158 Jan 21 20:13:27 pppd[1013]: remote IP address 192.168.11.254 Jan 21 20:13:27 pppd[1013]: primary DNS address 12.127.17.72 Jan 21 20:13:27 pppd[1013]: secondary DNS address 204.97.212.10 Jan 21 20:13:28 pppd[1026]: Compression disabled by peer. Jan 21 20:13:35 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 20:14:55 pppd[1026]: Connection terminated. Jan 21 20:42:40 pppd[1220]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 20:42:51 pppd[1220]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 20:42:57 pppd[1220]: Deflate (15) compression enabled Jan 21 20:42:58 pppd[1220]: local IP address 192.168.110.141 Jan 21 20:42:58 pppd[1220]: remote IP address 192.168.110.1 Jan 21 20:42:58 pppd[1220]: primary DNS address 199.2.252.10 Jan 21 20:42:58 pppd[1220]: secondary DNS address 204.97.212.10 Jan 21 20:43:05 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 20:45:12 pppd[1231]: Connection terminated. Jan 21 20:45:19 syslogd exiting Jan 21 20:52:45 syslogd started: BusyBox v1.11.2 Jan 21 20:52:45 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 20:52:45 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 20:52:45 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 20:52:45 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 20:52:45 kernel: [ 0.00] Machine: NXP EA313X Jan 21 20:52:45 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 20:52:45 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 20:52:45 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 20:52:45 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 20:52:45 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 20:52:45 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 20:52:45 kernel: [ 0.29] PC/104 Carrier Jan 21 20:52:45 kernel: [ 0.39] bio: create slab at 0 Jan 21 20:52:45 kernel: [ 0.40] SCSI subsystem initialized Jan 21 20:52:45 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 20:52:45 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 20:52:45 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 20:52:45 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 20:52:45 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 20:52:45 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 20:52:45 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 20:52:45 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 20:52:52 reset-modem: No espclient -- resetting via /dev/I2Cgate Jan 21 20:52:52 su: + none root:esp Jan 21 20:52:57 su: + /dev/console root:esp Jan 21 20:53:14 pppd[506]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 20:53:18 ringBack[461]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 21 20:53:25 pppd[506]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 20:53:34 pppd[506]: CHAP authentication succeeded Jan 21 20:53:46 pppd[506]: local IP address 192.168.20.83 Jan 21 20:53:46 pppd[506]: remote IP address 192.168.20.254 Jan 21 20:53:46 pppd[506]: primary DNS address 199.2.252.10 Jan 21 20:53:46 pppd[506]: secondary DNS address 204.97.212.10 Jan 21 20:53:59 pppd[752]: local IP address 192.168.20.83 Jan 21 20:53:59 pppd[752]: remote IP address 192.168.20.254 Jan 21 20:53:59 pppd[752]: primary DNS address 199.2.252.10 Jan 21 20:53:59 pppd[752]: secondary DNS address 204.97.212.10 Jan 21 20:54:04 pppd[752]: Compression disabled by peer. Jan 21 20:54:08 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 20:55:50 pppd[752]: Connection terminated. Jan 21 20:55:54 pppd[1066]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 20:56:07 pppd[1066]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 20:56:28 pppd[1066]: Modem hangup Jan 21 20:56:28 pppd[1066]: Connection terminated. Jan 21 21:01:47 pppd[1451]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 21:01:58 pppd[1451]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 21:02:02 pppd[1451]: CHAP authentication succeeded Jan 21 21:02:07 pppd[1451]: local IP address 192.168.11.169 Jan 21 21:02:07 pppd[1451]: remote IP address 192.168.11.254 Jan 21 21:02:07 pppd[1451]: primary DNS address 12.127.17.72 Jan 21 21:02:07 pppd[1451]: secondary DNS address 204.97.212.10 Jan 21 21:02:07 pppd[1464]: Compression disabled by peer. Jan 21 21:02:15 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 21:03:50 pppd[1464]: Connection terminated. Jan 21 21:07:23 pppd[1666]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 21:07:23 pppd[1666]: Failed to open /dev/AT/iridium: Input/output error Jan 21 21:12:42 pppd[2049]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 21:12:53 pppd[2049]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 21:12:57 pppd[2049]: CHAP authentication succeeded Jan 21 21:13:02 pppd[2049]: local IP address 192.168.11.174 Jan 21 21:13:02 pppd[2049]: remote IP address 192.168.11.254 Jan 21 21:13:02 pppd[2049]: primary DNS address 12.127.17.72 Jan 21 21:13:02 pppd[2049]: secondary DNS address 204.97.212.10 Jan 21 21:13:02 pppd[2062]: Compression disabled by peer. Jan 21 21:13:10 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 21:13:58 pppd[2062]: Modem hangup Jan 21 21:13:58 pppd[2062]: Connection terminated. Jan 21 21:22:47 su: + /dev/ttyS0 esp:esp Jan 21 21:37:24 pppd[2293]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 21:37:35 pppd[2293]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 21:37:40 pppd[2293]: CHAP authentication succeeded Jan 21 21:37:45 pppd[2293]: local IP address 192.168.11.185 Jan 21 21:37:45 pppd[2293]: remote IP address 192.168.11.254 Jan 21 21:37:45 pppd[2293]: primary DNS address 12.127.17.72 Jan 21 21:37:45 pppd[2293]: secondary DNS address 204.97.212.10 Jan 21 21:37:46 pppd[2306]: Compression disabled by peer. Jan 21 21:37:53 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 21:40:30 pppd[2306]: Connection terminated. Jan 21 21:40:37 syslogd exiting Jan 21 22:53:57 syslogd started: BusyBox v1.11.2 Jan 21 22:53:57 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 21 22:53:57 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 21 22:53:57 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 21 22:53:57 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 21 22:53:57 kernel: [ 0.00] Machine: NXP EA313X Jan 21 22:53:57 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 21 22:53:57 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 21 22:53:57 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 21 22:53:57 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 21 22:53:57 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 21 22:53:57 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 21 22:53:57 kernel: [ 0.29] PC/104 Carrier Jan 21 22:53:57 kernel: [ 0.39] bio: create slab at 0 Jan 21 22:53:57 kernel: [ 0.40] SCSI subsystem initialized Jan 21 22:53:57 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 21 22:53:57 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 21 22:53:57 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 21 22:53:57 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 21 22:53:57 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 21 22:53:57 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 21 22:53:57 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 21 22:53:57 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 21 22:54:01 reset-modem: No espclient -- resetting via /dev/I2Cgate Jan 21 22:54:01 su: + none root:esp Jan 21 22:54:07 su: + /dev/console root:esp Jan 21 22:54:23 pppd[506]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 21 22:54:27 ringBack[461]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 21 22:54:34 pppd[506]: Connect: ppp5 <--> /dev/AT/iridium Jan 21 22:54:39 pppd[506]: CHAP authentication succeeded Jan 21 22:54:44 pppd[506]: local IP address 192.168.20.106 Jan 21 22:54:44 pppd[506]: remote IP address 192.168.20.254 Jan 21 22:54:44 pppd[506]: primary DNS address 199.2.252.10 Jan 21 22:54:44 pppd[506]: secondary DNS address 204.97.212.10 Jan 21 22:54:44 pppd[542]: Compression disabled by peer. Jan 21 22:54:53 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 22:59:49 su: + /dev/ttyS0 root:esp Jan 21 23:00:38 pppd[542]: Connection terminated. Jan 21 23:05:24 tunnel2shore[460]: Opening tunnel to ESPshore Jan 21 23:05:36 dropbear[1104]: Pubkey auth succeeded for 'root' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56336 Jan 21 23:16:00 dropbear[1165]: Pubkey auth succeeded for 'esp' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56350 Jan 21 23:16:36 dropbear[1174]: Pubkey auth succeeded for 'esp' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56352 Jan 21 23:19:27 dropbear[1181]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:54502 Jan 21 23:19:30 dropbear[1184]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:54504 Jan 22 00:15:14 dropbear[1393]: Pubkey auth succeeded for 'esp' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:54546 Jan 22 00:17:13 dropbear[1406]: Pubkey auth succeeded for 'esp' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:54548 Jan 22 00:19:29 dropbear[1415]: Pubkey auth succeeded for 'esp' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56494 Jan 22 00:20:20 dropbear[1424]: Pubkey auth succeeded for 'esp' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56496 Jan 22 00:21:33 dropbear[1437]: Pubkey auth succeeded for 'esp' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56498 Jan 22 00:22:47 dropbear[1446]: Pubkey auth succeeded for 'esp' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56502 Jan 22 00:22:51 dropbear[1451]: Pubkey auth succeeded for 'esp' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56504 Jan 22 00:26:15 dropbear[1459]: Pubkey auth succeeded for 'esp' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56512 Jan 22 00:28:16 syslogd exiting Jan 22 00:28:25 syslogd started: BusyBox v1.11.2 Jan 22 00:28:25 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 22 00:28:25 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 22 00:28:25 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 00:28:25 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 00:28:25 kernel: [ 0.00] Machine: NXP EA313X Jan 22 00:28:25 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 00:28:25 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 00:28:25 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 22 00:28:25 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 22 00:28:25 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 00:28:25 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 00:28:25 kernel: [ 0.29] PC/104 Carrier Jan 22 00:28:25 kernel: [ 0.39] bio: create slab at 0 Jan 22 00:28:25 kernel: [ 0.40] SCSI subsystem initialized Jan 22 00:28:25 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 00:28:25 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 00:28:25 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 22 00:28:25 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 22 00:28:25 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 22 00:28:25 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 22 00:28:25 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 00:28:25 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 00:28:28 IridiumLocation: -2688,-4348,3800,771d79c1 Jan 22 00:28:28 su: + /dev/console root:esp Jan 22 00:28:45 pppd[486]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 00:28:48 ringBack[445]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 22 00:28:57 pppd[486]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 00:29:02 pppd[486]: Deflate (15) compression enabled Jan 22 00:29:04 pppd[486]: local IP address 192.168.110.147 Jan 22 00:29:04 pppd[486]: remote IP address 192.168.110.1 Jan 22 00:29:04 pppd[486]: primary DNS address 199.2.252.10 Jan 22 00:29:04 pppd[486]: secondary DNS address 204.97.212.10 Jan 22 00:29:13 tunnel2shore[444]: Opening tunnel to ESPshore Jan 22 00:31:17 pppd[520]: Connection terminated. Jan 22 00:31:23 syslogd exiting Jan 22 00:35:10 syslogd started: BusyBox v1.11.2 Jan 22 00:35:10 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 22 00:35:10 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 22 00:35:10 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 00:35:10 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 00:35:10 kernel: [ 0.00] Machine: NXP EA313X Jan 22 00:35:10 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 00:35:10 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 00:35:10 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 22 00:35:10 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 22 00:35:10 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 00:35:10 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 00:35:10 kernel: [ 0.29] PC/104 Carrier Jan 22 00:35:10 kernel: [ 0.39] bio: create slab at 0 Jan 22 00:35:10 kernel: [ 0.40] SCSI subsystem initialized Jan 22 00:35:10 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 00:35:10 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 00:35:10 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 22 00:35:10 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 22 00:35:10 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 22 00:35:10 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 22 00:35:10 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 00:35:10 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 00:35:13 IridiumLocation: -2696,-4344,3796,771e6f6d Jan 22 00:35:13 su: + /dev/console root:esp Jan 22 00:35:33 ringBack[445]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 22 00:37:35 pppd[758]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 00:37:46 pppd[758]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 00:37:50 pppd[758]: CHAP authentication succeeded Jan 22 00:37:55 pppd[758]: local IP address 192.168.11.228 Jan 22 00:37:55 pppd[758]: remote IP address 192.168.11.254 Jan 22 00:37:55 pppd[758]: primary DNS address 12.127.17.72 Jan 22 00:37:55 pppd[758]: secondary DNS address 204.97.212.10 Jan 22 00:37:56 pppd[787]: Compression disabled by peer. Jan 22 00:38:03 tunnel2shore[444]: Opening tunnel to ESPshore Jan 22 00:39:25 pppd[787]: Connection terminated. Jan 22 00:42:41 su: + /dev/ttyS0 esp:esp Jan 22 00:42:41 tunnel2shore[444]: Opening tunnel to ESPshore Jan 22 00:43:28 dropbear[1093]: Pubkey auth succeeded for 'esp' with key sha1!! 56:0d:64:d2:6e:2a:95:93:44:87:05:20:b7:d7:3d:31:c2:1d:ab:3f from 134.89.18.158:56532 Jan 22 00:45:12 su: + /dev/ttyS0 esp:esp Jan 22 00:58:45 su: + /dev/ttyS0 esp:esp Jan 22 01:00:09 su: + /dev/ttyS0 esp:root Jan 22 01:02:31 su: + /dev/ttyS0 esp:esp Jan 22 01:10:50 pppd[1198]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 01:11:10 pppd[1198]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 01:11:14 pppd[1198]: CHAP authentication succeeded Jan 22 01:11:19 pppd[1198]: local IP address 192.168.20.126 Jan 22 01:11:19 pppd[1198]: remote IP address 192.168.20.254 Jan 22 01:11:19 pppd[1198]: primary DNS address 199.2.252.10 Jan 22 01:11:19 pppd[1198]: secondary DNS address 204.97.212.10 Jan 22 01:11:20 pppd[1211]: Compression disabled by peer. Jan 22 01:11:27 tunnel2shore[444]: Opening tunnel to ESPshore Jan 22 01:12:14 pppd[1211]: Modem hangup Jan 22 01:12:14 pppd[1211]: Connection terminated. Jan 22 01:12:17 pppd[1384]: In file /etc/ppp/peers/iridium: unrecognized option 'AT/iridium' Jan 22 01:16:23 syslogd exiting Jan 22 07:55:11 syslogd started: BusyBox v1.11.2 Jan 22 07:55:11 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 07:55:11 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 07:55:11 kernel: [ 0.00] Machine: NXP EA313X Jan 22 07:55:11 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 07:55:11 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 07:55:11 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 07:55:11 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 07:55:11 kernel: [ 0.29] PC/104 Carrier Jan 22 07:55:11 kernel: [ 0.39] bio: create slab at 0 Jan 22 07:55:11 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 07:55:11 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 07:55:11 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 07:55:11 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 07:55:13 IridiumLocation: -2696,-4344,3800,771edd61 Jan 22 08:32:50 syslogd exiting Jan 22 08:45:20 syslogd started: BusyBox v1.11.2 Jan 22 08:45:20 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 08:45:20 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 08:45:20 kernel: [ 0.00] Machine: NXP EA313X Jan 22 08:45:20 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 08:45:20 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 08:45:20 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 08:45:20 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 08:45:20 kernel: [ 0.29] PC/104 Carrier Jan 22 08:45:20 kernel: [ 0.39] bio: create slab at 0 Jan 22 08:45:20 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 08:45:20 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 08:45:20 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 08:45:20 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 08:45:22 IridiumLocation: -2696,-4344,3796,77237bc5 Jan 22 09:03:45 syslogd exiting Jan 22 09:03:54 syslogd started: BusyBox v1.11.2 Jan 22 09:03:54 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 09:03:54 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 09:03:54 kernel: [ 0.00] Machine: NXP EA313X Jan 22 09:03:54 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 09:03:54 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 09:03:54 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 09:03:54 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 09:03:54 kernel: [ 0.29] PC/104 Carrier Jan 22 09:03:54 kernel: [ 0.39] bio: create slab at 0 Jan 22 09:03:54 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 09:03:54 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 09:03:54 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 09:03:54 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 09:03:56 IridiumLocation: -2684,-4352,3796,77237dd8 Jan 22 09:13:59 syslogd exiting Jan 22 09:58:41 syslogd started: BusyBox v1.11.2 Jan 22 09:58:41 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 09:58:41 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 09:58:41 kernel: [ 0.00] Machine: NXP EA313X Jan 22 09:58:41 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 09:58:41 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 09:58:41 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 09:58:41 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 09:58:41 kernel: [ 0.29] PC/104 Carrier Jan 22 09:58:41 kernel: [ 0.39] bio: create slab at 0 Jan 22 09:58:41 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 09:58:41 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 09:58:41 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 09:58:41 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 09:58:43 IridiumLocation: -2696,-4344,3796,7723c2ab Jan 22 10:31:03 syslogd exiting Jan 22 11:48:47 syslogd started: BusyBox v1.11.2 Jan 22 11:48:47 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 11:48:47 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 11:48:47 kernel: [ 0.00] Machine: NXP EA313X Jan 22 11:48:47 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 11:48:47 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 11:48:47 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 11:48:47 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 11:48:47 kernel: [ 0.29] PC/104 Carrier Jan 22 11:48:47 kernel: [ 0.39] bio: create slab at 0 Jan 22 11:48:47 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 11:48:47 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 11:48:47 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 11:48:47 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 11:48:49 IridiumLocation: -2688,-4344,3796,7725592a Jan 22 13:34:30 pppd[1281]: LCP: timeout sending Config-Requests Jan 22 13:37:11 pppd[1303]: not replacing existing default route via 134.89.12.1 Jan 22 13:44:26 syslogd exiting Jan 22 13:44:26 syslogd started: BusyBox v1.11.2 Jan 22 13:44:26 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 22 13:45:10 su: + /dev/ttyS0 esp:esp Jan 22 13:46:38 pppd[1501]: pppd 2.4.5-mbari3 started by esp, uid 0 Jan 22 13:46:38 pppd[1501]: Using interface ppp5 Jan 22 13:46:39 chat[1506]: abort on (NO CARRIER) Jan 22 13:46:39 chat[1506]: abort on (NO DIALTONE) Jan 22 13:46:39 chat[1506]: abort on (ERROR) Jan 22 13:46:39 chat[1506]: abort on (NO ANSWER) Jan 22 13:46:39 chat[1506]: abort on (BUSY) Jan 22 13:46:39 chat[1506]: abort on (Username/Password Incorrect) Jan 22 13:46:39 chat[1506]: timeout set to 10 seconds Jan 22 13:46:39 chat[1506]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 13:46:41 chat[1506]: expect (OK^M) Jan 22 13:46:41 chat[1506]: ^M Jan 22 13:46:41 chat[1506]: OK^M Jan 22 13:46:41 chat[1506]: -- got it Jan 22 13:46:41 chat[1506]: send (AT+CBST=71,0,1^M) Jan 22 13:46:42 chat[1506]: expect (OK^M) Jan 22 13:46:42 chat[1506]: Jan 22 13:46:42 chat[1506]: ^M Jan 22 13:46:42 chat[1506]: OK^M Jan 22 13:46:42 chat[1506]: -- got it Jan 22 13:46:42 chat[1506]: send (AT+CSQF^M) Jan 22 13:46:42 chat[1506]: expect (OK^M) Jan 22 13:46:42 chat[1506]: Jan 22 13:46:42 chat[1506]: ^M Jan 22 13:46:42 chat[1506]: +CSQF:5^M Jan 22 13:46:42 chat[1506]: ^M Jan 22 13:46:42 chat[1506]: OK^M Jan 22 13:46:42 chat[1506]: -- got it Jan 22 13:46:42 chat[1506]: send () Jan 22 13:46:42 chat[1506]: timeout set to 150 seconds Jan 22 13:46:42 chat[1506]: send (ATD008816000025^M) Jan 22 13:46:42 chat[1506]: expect (CONNECT) Jan 22 13:46:42 chat[1506]: Jan 22 13:46:50 chat[1506]: ^M Jan 22 13:46:50 chat[1506]: CONNECT Jan 22 13:46:50 chat[1506]: -- got it Jan 22 13:46:50 chat[1506]: send () Jan 22 13:46:50 pppd[1501]: Serial connection established. Jan 22 13:46:51 pppd[1501]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 13:46:57 pppd[1501]: Deflate (15) compression enabled Jan 22 13:46:58 pppd[1501]: local IP address 192.168.112.248 Jan 22 13:46:58 pppd[1501]: remote IP address 192.168.112.1 Jan 22 13:46:58 pppd[1501]: primary DNS address 199.2.252.10 Jan 22 13:46:58 pppd[1501]: secondary DNS address 204.97.212.10 Jan 22 13:47:05 tunnel2shore[707]: Opening tunnel to ESPshore Jan 22 13:47:17 su: + /dev/ttyS0 esp:esp Jan 22 13:49:03 pppd[1508]: Modem hangup Jan 22 13:49:03 pppd[1508]: Connect time 2.1 minutes. Jan 22 13:49:03 pppd[1508]: Sent 26350 bytes, received 9322 bytes. Jan 22 13:49:03 pppd[1508]: Connection terminated. Jan 22 13:49:03 pppd[1508]: Exit. Jan 22 13:52:21 init: Switching to runlevel: 6 Jan 22 13:52:29 syslogd exiting Jan 22 13:52:38 syslogd started: BusyBox v1.11.2 Jan 22 13:52:38 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 22 13:52:38 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 22 13:52:38 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 13:52:38 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 13:52:38 kernel: [ 0.00] Machine: NXP EA313X Jan 22 13:52:38 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 13:52:38 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 13:52:38 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 22 13:52:38 kernel: [ 0.00] PID hash table entries: 256 (order: -2, 1024 bytes) Jan 22 13:52:38 kernel: [ 0.00] Dentry cache hash table entries: 8192 (order: 3, 32768 bytes) Jan 22 13:52:38 kernel: [ 0.00] Inode-cache hash table entries: 4096 (order: 2, 16384 bytes) Jan 22 13:52:38 kernel: [ 0.00] Memory: 64MB = 64MB total Jan 22 13:52:38 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 22 13:52:38 kernel: [ 0.00] Hierarchical RCU implementation. Jan 22 13:52:38 kernel: [ 0.00] NR_IRQS:38 Jan 22 13:52:38 kernel: [ 0.00] irq=30 Event=0x67 bank:3 bit:7 type:4 Jan 22 13:52:38 kernel: [ 0.00] irq=31 Event=0x7a bank:3 bit:26 type:3 Jan 22 13:52:38 kernel: [ 0.00] irq=32 Event=0x77 bank:3 bit:23 type:3 Jan 22 13:52:38 kernel: [ 0.00] irq=33 Event=0x7b bank:3 bit:27 type:1 Jan 22 13:52:38 kernel: [ 0.00] irq=34 Event=0x32 bank:1 bit:18 type:1 Jan 22 13:52:38 kernel: [ 0.00] irq=35 Event=0x50 bank:2 bit:16 type:1 Jan 22 13:52:38 kernel: [ 0.00] irq=36 Event=0x44 bank:2 bit:4 type:1 Jan 22 13:52:38 kernel: [ 0.00] irq=37 Event=0x18 bank:0 bit:24 type:4 Jan 22 13:52:38 kernel: [ 0.00] console [ttyS0] enabled Jan 22 13:52:38 kernel: [ 0.01] Calibrating delay loop... 134.75 BogoMIPS (lpj=673792) Jan 22 13:52:38 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 13:52:38 kernel: [ 0.24] CPU: Testing write buffer coherency: ok Jan 22 13:52:38 kernel: [ 0.25] NET: Registered protocol family 16 Jan 22 13:52:38 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 13:52:38 kernel: [ 0.29] PC/104 Carrier Jan 22 13:52:38 kernel: [ 0.31] enabling USB host vbus_power Jan 22 13:52:38 kernel: [ 0.33] Registering USB host 0x00212d00 0x0ec0000a (3) Jan 22 13:52:38 kernel: [ 0.33] LPC31: Power Management init. Jan 22 13:52:38 kernel: [ 0.39] bio: create slab at 0 Jan 22 13:52:38 kernel: [ 0.40] SCSI subsystem initialized Jan 22 13:52:38 kernel: [ 0.40] usbcore: registered new interface driver usbfs Jan 22 13:52:38 kernel: [ 0.41] usbcore: registered new interface driver hub Jan 22 13:52:38 kernel: [ 0.41] usbcore: registered new device driver usb Jan 22 13:52:38 kernel: [ 0.42] Switching to clocksource clksource Jan 22 13:52:38 kernel: [ 0.43] Switched to NOHz mode on CPU #0 Jan 22 13:52:38 kernel: [ 0.43] NET: Registered protocol family 2 Jan 22 13:52:38 kernel: [ 0.43] IP route cache hash table entries: 1024 (order: 0, 4096 bytes) Jan 22 13:52:38 kernel: [ 0.43] TCP established hash table entries: 2048 (order: 2, 16384 bytes) Jan 22 13:52:38 kernel: [ 0.43] TCP bind hash table entries: 2048 (order: 1, 8192 bytes) Jan 22 13:52:38 kernel: [ 0.43] TCP: Hash tables configured (established 2048 bind 2048) Jan 22 13:52:38 kernel: [ 0.43] TCP reno registered Jan 22 13:52:38 kernel: [ 0.43] UDP hash table entries: 256 (order: 0, 4096 bytes) Jan 22 13:52:38 kernel: [ 0.43] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) Jan 22 13:52:38 kernel: [ 0.43] NET: Registered protocol family 1 Jan 22 13:52:38 kernel: [ 0.43] RPC: Registered udp transport module. Jan 22 13:52:38 kernel: [ 0.43] RPC: Registered tcp transport module. Jan 22 13:52:38 kernel: [ 0.43] RPC: Registered tcp NFSv4.1 backchannel transport module. Jan 22 13:52:38 kernel: [ 0.44] pca9532 0-0060: setting platform data Jan 22 13:52:38 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 13:52:38 kernel: [ 0.46] squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 22 13:52:38 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 13:52:38 kernel: [ 0.46] msgmni has been set to 120 Jan 22 13:52:38 kernel: [ 0.47] alg: No test for stdrng (krng) Jan 22 13:52:38 kernel: [ 0.47] io scheduler noop registered (default) Jan 22 13:52:38 kernel: [ 0.53] brd: module loaded Jan 22 13:52:38 kernel: [ 0.56] loop: module loaded Jan 22 13:52:38 kernel: [ 0.57] NAND device: Manufacturer ID: 0x2c, Chip ID: 0xaa (Micron NAND 256MiB 1,8V 8-bit) Jan 22 13:52:38 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 22 13:52:38 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 22 13:52:38 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 22 13:52:38 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 22 13:52:38 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 13:52:38 kernel: [ 0.60] m25p80 spi0.3: s25sl032a (4096 Kbytes) Jan 22 13:52:38 kernel: [ 0.61] spi_lpc313x spi_lpc313x.0: LPC313x SPI driver Jan 22 13:52:38 kernel: [ 0.61] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Jan 22 13:52:38 kernel: [ 0.61] lpc-ehci lpc-ehci.0: LPC EHCI Host Controller Jan 22 13:52:38 kernel: [ 0.61] lpc-ehci lpc-ehci.0: new USB bus registered, assigned bus number 1 Jan 22 13:52:38 kernel: [ 0.64] lpc-ehci lpc-ehci.0: irq 27, io mem 0x19000000 Jan 22 13:52:38 kernel: [ 0.66] lpc-ehci lpc-ehci.0: USB 2.0 started, EHCI 1.00 Jan 22 13:52:38 kernel: [ 0.66] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Jan 22 13:52:38 kernel: [ 0.66] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 22 13:52:38 kernel: [ 0.66] usb usb1: Product: LPC EHCI Host Controller Jan 22 13:52:38 kernel: [ 0.66] usb usb1: Manufacturer: Linux 2.6.33-ea3131-mbari6 ehci_hcd Jan 22 13:52:38 kernel: [ 0.66] usb usb1: SerialNumber: lpc-ehci.0 Jan 22 13:52:38 kernel: [ 0.66] hub 1-0:1.0: USB hub found Jan 22 13:52:38 kernel: [ 0.66] hub 1-0:1.0: 1 port detected Jan 22 13:52:38 kernel: [ 0.66] i2c /dev entries driver Jan 22 13:52:38 kernel: [ 0.67] lpc313x-wdt lpc313x-wdt: Watchdog device driver initialized. Jan 22 13:52:38 kernel: [ 0.67] cpuidle: using governor ladder Jan 22 13:52:38 kernel: [ 0.67] cpuidle: using governor menu Jan 22 13:52:38 kernel: [ 0.68] lpc313x_mmc lpc313x_mmc.0: LPC313x MMC controller at irq 26 Jan 22 13:52:38 kernel: [ 0.68] Serial: 8250/16550 driver, 9 ports, IRQ sharing enabled Jan 22 13:52:38 kernel: [ 0.68] serial8250: ttyS0 at MMIO 0x15001000 (irq = 10) is a NXP16750 Jan 22 13:52:38 kernel: [ 0.69] serial8250.0: ttyS0 at MMIO 0x15001000 (irq = 10) is a NXP16750 Jan 22 13:52:38 kernel: [ 0.69] serial8250.1: ttyS1 at MMIO 0x20000400 (irq = 37) is a XR16788 Jan 22 13:52:38 kernel: [ 0.70] mmc_host mmc0: card inserted Jan 22 13:52:38 kernel: [ 0.70] serial8250.1: ttyS2 at MMIO 0x20000410 (irq = 37) is a XR16788 Jan 22 13:52:38 kernel: [ 0.70] serial8250.1: ttyS3 at MMIO 0x20000420 (irq = 37) is a XR16788 Jan 22 13:52:38 kernel: [ 0.70] serial8250.1: ttyS4 at MMIO 0x20000430 (irq = 37) is a XR16788 Jan 22 13:52:38 kernel: [ 0.71] serial8250.1: ttyS5 at MMIO 0x20000440 (irq = 37) is a XR16788 Jan 22 13:52:38 kernel: [ 0.71] serial8250.1: ttyS6 at MMIO 0x20000450 (irq = 37) is a XR16788 Jan 22 13:52:38 kernel: [ 0.71] serial8250.1: ttyS7 at MMIO 0x20000460 (irq = 37) is a XR16788 Jan 22 13:52:38 kernel: [ 0.71] serial8250.1: ttyS8 at MMIO 0x20000470 (irq = 37) is a XR16788 Jan 22 13:52:38 kernel: [ 0.72] TCP cubic registered Jan 22 13:52:38 kernel: [ 0.72] NET: Registered protocol family 17 Jan 22 13:52:38 kernel: [ 0.72] Waiting for root device /dev/mmcblk0p2... Jan 22 13:52:38 kernel: [ 0.77] mmc0: no r/o switch -- assuming write-enabled Jan 22 13:52:38 kernel: [ 0.77] mmc0: new SDHC card at address aaaa Jan 22 13:52:38 kernel: [ 0.78] mmcblk0: mmc0:aaaa SS08G 7.40 GiB Jan 22 13:52:38 kernel: [ 0.78] mmcblk0: p1 p2 p3 Jan 22 13:52:38 kernel: [ 0.87] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode Jan 22 13:52:38 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 13:52:38 kernel: [ 0.88] Freeing init memory: 100K Jan 22 13:52:38 kernel: [ 0.98] usb 1-1: new full speed USB device using lpc-ehci and address 2 Jan 22 13:52:38 kernel: [ 1.13] usb 1-1: not running at top speed; connect to a high speed hub Jan 22 13:52:38 kernel: [ 1.13] usb 1-1: New USB device found, idVendor=1a40, idProduct=0101 Jan 22 13:52:38 kernel: [ 1.13] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Jan 22 13:52:38 kernel: [ 1.13] usb 1-1: Product: USB 2.0 Hub Jan 22 13:52:38 kernel: [ 1.18] hub 1-1:1.0: USB hub found Jan 22 13:52:38 kernel: [ 1.18] hub 1-1:1.0: 4 ports detected Jan 22 13:52:38 kernel: [ 1.49] usb 1-1.2: new full speed USB device using lpc-ehci and address 3 Jan 22 13:52:38 kernel: [ 1.63] usb 1-1.2: New USB device found, idVendor=0403, idProduct=6015 Jan 22 13:52:38 kernel: [ 1.63] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 22 13:52:38 kernel: [ 1.63] usb 1-1.2: Product: Chipi-X Jan 22 13:52:38 kernel: [ 1.63] usb 1-1.2: Manufacturer: FTDI Jan 22 13:52:38 kernel: [ 1.63] usb 1-1.2: SerialNumber: FTYSL64Y Jan 22 13:52:38 kernel: [ 1.75] usb 1-1.3: new full speed USB device using lpc-ehci and address 4 Jan 22 13:52:38 kernel: [ 1.90] usb 1-1.3: New USB device found, idVendor=1edd, idProduct=a555 Jan 22 13:52:38 kernel: [ 1.90] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jan 22 13:52:38 kernel: [ 1.90] usb 1-1.3: Product: Iridium 9555 Handset Jan 22 13:52:38 kernel: [ 1.90] usb 1-1.3: Manufacturer: Iridium Jan 22 13:52:38 kernel: [ 2.15] ks8851_mll ks8851_mll.0: message enable is 0 Jan 22 13:52:38 kernel: [ 2.15] ks8851_mll ks8851_mll.0: Found chip, family: 0x88, id: 0x7, rev: 0x1 Jan 22 13:52:38 kernel: [ 2.15] ks8851_mll ks8851_mll.0: passed selftest Jan 22 13:52:38 kernel: [ 2.37] ds323 Jan 22 13:52:38 kernel: 4 spi0.1: Control Reg: 0x1c Jan 22 13:52:38 kernel: [ 2.37] ds3234 spi0.1: Ctrl/Stat Reg: 0x88 Jan 22 13:52:38 kernel: [ 2.39] ds3234 spi0.1: rtc core: registered ds3234 as rtc0 Jan 22 13:52:38 kernel: [ 2.56] cdc_acm 1-1.3:1.0: ttyACM0: USB ACM device Jan 22 13:52:38 kernel: [ 2.58] usbcore: registered new interface driver cdc_acm Jan 22 13:52:38 kernel: [ 2.58] cdc_acm: v0.26:USB Abstract Control Model driver for USB modems and ISDN adapters Jan 22 13:52:38 kernel: [ 2.80] usbcore: registered new interface driver usbserial Jan 22 13:52:38 kernel: [ 2.82] USB Serial support registered for generic Jan 22 13:52:38 kernel: [ 2.83] usbcore: registered new interface driver usbserial_generic Jan 22 13:52:38 kernel: [ 2.83] usbserial: USB Serial Driver core Jan 22 13:52:38 kernel: [ 2.93] USB Serial support registered for FTDI USB Serial Device Jan 22 13:52:38 kernel: [ 2.93] ftdi_sio 1-1.2:1.0: FTDI USB Serial Device converter detected Jan 22 13:52:38 kernel: [ 2.93] usb 1-1.2: Detected FT232RL Jan 22 13:52:38 kernel: [ 2.93] usb 1-1.2: Number of endpoints 2 Jan 22 13:52:38 kernel: [ 2.93] usb 1-1.2: Endpoint 1 MaxPacketSize 64 Jan 22 13:52:38 kernel: [ 2.93] usb 1-1.2: Endpoint 2 MaxPacketSize 64 Jan 22 13:52:38 kernel: [ 2.93] usb 1-1.2: Setting MaxPacketSize 64 Jan 22 13:52:38 kernel: [ 2.95] usb 1-1.2: FTDI USB Serial Device converter now attached to ttyUSB0 Jan 22 13:52:38 kernel: [ 2.96] usbcore: registered new interface driver ftdi_sio Jan 22 13:52:38 kernel: [ 2.96] ftdi_sio: v1.5.0:USB FTDI Serial Converters Driver Jan 22 13:52:38 kernel: [ 3.27] Adding 102392k swap on /.SWAP. Priority:-1 extents:1 across:102392k SS Jan 22 13:52:40 IridiumLocation: -2692,-4348,3796,77268d4c Jan 22 13:52:40 su: + /dev/console root:esp Jan 22 13:52:59 kernel: [ 25.33] PPP generic driver version 2.4.2 Jan 22 13:52:59 pppd[479]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 13:52:59 pppd[479]: Using interface ppp5 Jan 22 13:53:00 ringBack[437]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 22 13:53:00 chat[493]: abort on (NO CARRIER) Jan 22 13:53:00 chat[493]: abort on (NO DIALTONE) Jan 22 13:53:00 chat[493]: abort on (ERROR) Jan 22 13:53:00 chat[493]: abort on (NO ANSWER) Jan 22 13:53:00 chat[493]: abort on (BUSY) Jan 22 13:53:00 chat[493]: abort on (Username/Password Incorrect) Jan 22 13:53:00 chat[493]: timeout set to 10 seconds Jan 22 13:53:00 chat[493]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 13:53:03 chat[493]: expect (OK^M) Jan 22 13:53:03 chat[493]: ^M Jan 22 13:53:03 chat[493]: OK^M Jan 22 13:53:03 chat[493]: -- got it Jan 22 13:53:03 chat[493]: send (AT+CBST=71,0,1^M) Jan 22 13:53:03 chat[493]: expect (OK^M) Jan 22 13:53:03 chat[493]: Jan 22 13:53:03 chat[493]: ^M Jan 22 13:53:03 chat[493]: OK^M Jan 22 13:53:03 chat[493]: -- got it Jan 22 13:53:03 chat[493]: send (AT+CSQF^M) Jan 22 13:53:03 chat[493]: expect (OK^M) Jan 22 13:53:03 chat[493]: Jan 22 13:53:03 chat[493]: ^M Jan 22 13:53:03 chat[493]: +CSQF:5^M Jan 22 13:53:03 chat[493]: ^M Jan 22 13:53:03 chat[493]: OK^M Jan 22 13:53:03 chat[493]: -- got it Jan 22 13:53:03 chat[493]: send () Jan 22 13:53:03 chat[493]: timeout set to 150 seconds Jan 22 13:53:03 chat[493]: send (ATD008816000025^M) Jan 22 13:53:04 chat[493]: expect (CONNECT) Jan 22 13:53:04 chat[493]: Jan 22 13:53:10 chat[493]: ^M Jan 22 13:53:10 chat[493]: CONNECT Jan 22 13:53:10 chat[493]: -- got it Jan 22 13:53:10 chat[493]: send () Jan 22 13:53:10 pppd[479]: Serial connection established. Jan 22 13:53:10 pppd[479]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 13:53:21 pppd[479]: CHAP authentication succeeded Jan 22 13:53:21 pppd[479]: CHAP authentication succeeded Jan 22 13:53:21 kernel: [ 47.15] PPP BSD Compression module registered Jan 22 13:53:21 kernel: [ 47.30] PPP Deflate Compression module registered Jan 22 13:53:31 pppd[479]: local IP address 192.168.10.231 Jan 22 13:53:31 pppd[479]: remote IP address 192.168.10.254 Jan 22 13:53:31 pppd[479]: primary DNS address 12.127.17.72 Jan 22 13:53:31 pppd[479]: secondary DNS address 204.97.212.10 Jan 22 13:53:31 pppd[782]: Connect time 0.0 minutes. Jan 22 13:53:31 pppd[782]: Sent 0 bytes, received 0 bytes. Jan 22 13:53:34 pppd[782]: local IP address 192.168.10.231 Jan 22 13:53:34 pppd[782]: remote IP address 192.168.10.254 Jan 22 13:53:34 pppd[782]: primary DNS address 12.127.17.72 Jan 22 13:53:34 pppd[782]: secondary DNS address 204.97.212.10 Jan 22 13:53:35 pppd[782]: CCP terminated by peer Jan 22 13:53:35 pppd[782]: Compression disabled by peer. Jan 22 13:53:41 tunnel2shore[436]: Opening tunnel to ESPshore Jan 22 13:55:19 pppd[782]: Modem hangup Jan 22 13:55:19 pppd[782]: Connect time 1.8 minutes. Jan 22 13:55:19 pppd[782]: Sent 11231 bytes, received 9154 bytes. Jan 22 13:55:19 kernel: [ 164.74] usb 1-1.3: USB disconnect, address 4 Jan 22 13:55:19 pppd[782]: Connection terminated. Jan 22 13:55:19 kernel: [ 165.04] usb 1-1.3: new full speed USB device using lpc-ehci and address 5 Jan 22 13:55:19 pppd[782]: Exit. Jan 22 13:55:20 pppd[1191]: In file /etc/ppp/peers/iridium: unrecognized option 'AT/iridium' Jan 22 13:55:21 kernel: [ 167.60] usb 1-1.3: New USB device found, idVendor=1edd, idProduct=a555 Jan 22 13:55:21 kernel: [ 167.60] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jan 22 13:55:21 kernel: [ 167.60] usb 1-1.3: Product: Iridium 9555 Handset Jan 22 13:55:21 kernel: [ 167.60] usb 1-1.3: Manufacturer: Iridium Jan 22 13:55:21 kernel: [ 167.61] cdc_acm 1-1.3:1.0: ttyACM0: USB ACM device Jan 22 13:55:47 login[1275]: root login on 'ttyS0' Jan 22 13:56:09 syslogd exiting Jan 22 13:56:09 syslogd started: BusyBox v1.11.2 Jan 22 14:01:51 pppd[1607]: LCP: timeout sending Config-Requests Jan 22 14:08:27 pppd[2006]: LCP: timeout sending Config-Requests Jan 22 14:09:59 syslogd exiting Jan 22 14:09:59 syslogd started: BusyBox v1.11.2 Jan 22 14:10:00 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 22 14:10:36 pppd[2416]: pppd 2.4.5-mbari3 started by esp, uid 0 Jan 22 14:10:36 pppd[2416]: Using interface ppp5 Jan 22 14:10:37 chat[2425]: abort on (NO CARRIER) Jan 22 14:10:37 chat[2425]: abort on (NO DIALTONE) Jan 22 14:10:37 chat[2425]: abort on (ERROR) Jan 22 14:10:37 chat[2425]: abort on (NO ANSWER) Jan 22 14:10:37 chat[2425]: abort on (BUSY) Jan 22 14:10:37 chat[2425]: abort on (Username/Password Incorrect) Jan 22 14:10:37 chat[2425]: timeout set to 10 seconds Jan 22 14:10:37 chat[2425]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 14:10:39 chat[2425]: expect (OK^M) Jan 22 14:10:49 chat[2425]: alarm Jan 22 14:10:49 chat[2425]: Failed Jan 22 14:10:55 chat[2432]: abort on (NO CARRIER) Jan 22 14:10:55 chat[2432]: abort on (NO DIALTONE) Jan 22 14:10:55 chat[2432]: abort on (ERROR) Jan 22 14:10:55 chat[2432]: abort on (NO ANSWER) Jan 22 14:10:55 chat[2432]: abort on (BUSY) Jan 22 14:10:55 chat[2432]: abort on (Username/Password Incorrect) Jan 22 14:10:55 chat[2432]: timeout set to 10 seconds Jan 22 14:10:55 chat[2432]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 14:10:57 chat[2432]: expect (OK^M) Jan 22 14:11:07 chat[2432]: alarm Jan 22 14:11:07 chat[2432]: Failed Jan 22 14:11:12 chat[2435]: abort on (NO CARRIER) Jan 22 14:11:12 chat[2435]: abort on (NO DIALTONE) Jan 22 14:11:12 chat[2435]: abort on (ERROR) Jan 22 14:11:12 chat[2435]: abort on (NO ANSWER) Jan 22 14:11:12 chat[2435]: abort on (BUSY) Jan 22 14:11:12 chat[2435]: abort on (Username/Password Incorrect) Jan 22 14:11:12 chat[2435]: timeout set to 10 seconds Jan 22 14:11:12 chat[2435]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 14:11:14 chat[2435]: expect (OK^M) Jan 22 14:11:24 chat[2435]: alarm Jan 22 14:11:24 chat[2435]: Failed Jan 22 14:11:24 pppd[2416]: Serial connection established. Jan 22 14:11:24 pppd[2416]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 14:11:49 pppd[2416]: Terminating on signal 15 Jan 22 14:11:55 pppd[2416]: Connection terminated. Jan 22 14:11:56 pppd[2416]: Modem hangup Jan 22 14:11:56 pppd[2416]: Exit. Jan 22 14:13:39 pppd[2451]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 14:13:39 pppd[2451]: Using interface ppp5 Jan 22 14:13:40 chat[2456]: abort on (NO CARRIER) Jan 22 14:13:40 chat[2456]: abort on (NO DIALTONE) Jan 22 14:13:40 chat[2456]: abort on (ERROR) Jan 22 14:13:40 chat[2456]: abort on (NO ANSWER) Jan 22 14:13:40 chat[2456]: abort on (BUSY) Jan 22 14:13:40 chat[2456]: abort on (Username/Password Incorrect) Jan 22 14:13:40 chat[2456]: timeout set to 10 seconds Jan 22 14:13:40 chat[2456]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 14:13:43 chat[2456]: expect (OK^M) Jan 22 14:13:49 kernel: [ 1274.91] usb 1-1: USB disconnect, address 2 Jan 22 14:13:49 kernel: [ 1274.91] usb 1-1.2: USB disconnect, address 3 Jan 22 14:13:49 kernel: [ 1274.91] ftdi_sio ttyUSB0: FTDI USB Serial Device converter now disconnected from ttyUSB0 Jan 22 14:13:49 kernel: [ 1274.91] usb 1-1.3: acm_ctrl_irq - usb_submit_urb failed with result -19 Jan 22 14:13:49 kernel: Jan 22 14:13:49 kernel: [ 1274.97] ftdi_sio 1-1.2:1.0: device disconnected Jan 22 14:13:49 kernel: [ 1274.97] usb 1-1.3: USB disconnect, address 5 Jan 22 14:13:49 chat[2456]: warning: read() on stdin returned 0 Jan 22 14:13:49 chat[2456]: Failed Jan 22 14:13:49 chat[2456]: Can't restore terminal parameters: Input/output error Jan 22 14:13:49 reset-modem: Cycling power via esp's espclient Jan 22 14:13:49 su: + /dev/ttyS0 root:esp Jan 22 14:13:54 chat[2492]: Can't get terminal parameters: Input/output error Jan 22 14:13:54 kernel: [ 1280.36] usb 1-1: new full speed USB device using lpc-ehci and address 6 Jan 22 14:13:54 kernel: [ 1280.51] usb 1-1: not running at top speed; connect to a high speed hub Jan 22 14:13:54 kernel: [ 1280.51] usb 1-1: New USB device found, idVendor=1a40, idProduct=0101 Jan 22 14:13:54 kernel: [ 1280.51] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Jan 22 14:13:54 kernel: [ 1280.51] usb 1-1: Product: USB 2.0 Hub Jan 22 14:13:54 kernel: [ 1280.52] hub 1-1:1.0: USB hub found Jan 22 14:13:54 kernel: [ 1280.52] hub 1-1:1.0: 4 ports detected Jan 22 14:13:55 kernel: [ 1280.83] usb 1-1.2: new full speed USB device using lpc-ehci and address 7 Jan 22 14:13:55 kernel: [ 1280.97] usb 1-1.2: New USB device found, idVendor=0403, idProduct=6015 Jan 22 14:13:55 kernel: [ 1280.97] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 22 14:13:55 kernel: [ 1280.97] usb 1-1.2: Product: Chipi-X Jan 22 14:13:55 kernel: [ 1280.97] usb 1-1.2: Manufacturer: FTDI Jan 22 14:13:55 kernel: [ 1280.97] usb 1-1.2: SerialNumber: FTYSL64Y Jan 22 14:13:55 kernel: [ 1280.98] ftdi_sio 1-1.2:1.0: FTDI USB Serial Device converter detected Jan 22 14:13:55 kernel: [ 1280.98] usb 1-1.2: Detected FT232RL Jan 22 14:13:55 kernel: [ 1280.98] usb 1-1.2: Number of endpoints 2 Jan 22 14:13:55 kernel: [ 1280.98] usb 1-1.2: Endpoint 1 MaxPacketSize 64 Jan 22 14:13:55 kernel: [ 1280.98] usb 1-1.2: Endpoint 2 MaxPacketSize 64 Jan 22 14:13:55 kernel: [ 1280.98] usb 1-1.2: Setting MaxPacketSize 64 Jan 22 14:13:55 kernel: [ 1280.99] usb 1-1.2: FTDI USB Serial Device converter now attached to ttyUSB0 Jan 22 14:13:55 kernel: [ 1281.13] usb 1-1.3: new full speed USB device using lpc-ehci and address 8 Jan 22 14:13:55 kernel: [ 1281.34] usb 1-1.3: New USB device found, idVendor=1edd, idProduct=a555 Jan 22 14:13:55 kernel: [ 1281.34] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jan 22 14:13:55 kernel: [ 1281.34] usb 1-1.3: Product: Iridium 9555 Handset Jan 22 14:13:55 kernel: [ 1281.34] usb 1-1.3: Manufacturer: Iridium Jan 22 14:13:55 kernel: [ 1281.36] cdc_acm 1-1.3:1.0: ttyACM1: USB ACM device Jan 22 14:13:59 ttyLogin[2528]: Accepting login on ttyUSB0.login @115200 baud for 30 seconds Jan 22 14:13:59 chat[2536]: Can't get terminal parameters: Input/output error Jan 22 14:13:59 pppd[2451]: Serial connection established. Jan 22 14:13:59 pppd[2451]: Couldn't get channel number: Input/output error Jan 22 14:14:00 pppd[2451]: Exit. Jan 22 14:15:38 su: + /dev/ttyS0 esp:esp Jan 22 14:19:13 pppd[2926]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 14:19:13 pppd[2926]: Using interface ppp5 Jan 22 14:19:14 chat[2931]: abort on (NO CARRIER) Jan 22 14:19:14 chat[2931]: abort on (NO DIALTONE) Jan 22 14:19:14 chat[2931]: abort on (ERROR) Jan 22 14:19:14 chat[2931]: abort on (NO ANSWER) Jan 22 14:19:14 chat[2931]: abort on (BUSY) Jan 22 14:19:14 chat[2931]: abort on (Username/Password Incorrect) Jan 22 14:19:14 chat[2931]: timeout set to 10 seconds Jan 22 14:19:14 chat[2931]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 14:19:16 chat[2931]: expect (OK^M) Jan 22 14:19:16 chat[2931]: ^M^M Jan 22 14:19:16 chat[2931]: OK^M Jan 22 14:19:16 chat[2931]: -- got it Jan 22 14:19:16 chat[2931]: send (AT+CBST=71,0,1^M) Jan 22 14:19:17 chat[2931]: expect (OK^M) Jan 22 14:19:17 chat[2931]: Jan 22 14:19:17 chat[2931]: ^M Jan 22 14:19:17 chat[2931]: OK^M Jan 22 14:19:17 chat[2931]: -- got it Jan 22 14:19:17 chat[2931]: send (AT+CSQF^M) Jan 22 14:19:17 chat[2931]: expect (OK^M) Jan 22 14:19:17 chat[2931]: Jan 22 14:19:17 chat[2931]: ^M Jan 22 14:19:17 chat[2931]: +CSQF:5^M Jan 22 14:19:17 chat[2931]: ^M Jan 22 14:19:17 chat[2931]: OK^M Jan 22 14:19:17 chat[2931]: -- got it Jan 22 14:19:17 chat[2931]: send () Jan 22 14:19:17 chat[2931]: timeout set to 150 seconds Jan 22 14:19:17 chat[2931]: send (ATD008816000025^M) Jan 22 14:19:17 chat[2931]: expect (CONNECT) Jan 22 14:19:17 chat[2931]: Jan 22 14:19:24 chat[2931]: ^M Jan 22 14:19:24 chat[2931]: CONNECT Jan 22 14:19:24 chat[2931]: -- got it Jan 22 14:19:24 chat[2931]: send () Jan 22 14:19:24 pppd[2926]: Serial connection established. Jan 22 14:19:24 pppd[2926]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 14:19:39 pppd[2926]: CHAP authentication succeeded Jan 22 14:19:39 pppd[2926]: CHAP authentication succeeded Jan 22 14:19:46 pppd[2926]: local IP address 192.168.10.233 Jan 22 14:19:46 pppd[2926]: remote IP address 192.168.10.254 Jan 22 14:19:46 pppd[2926]: primary DNS address 12.127.17.72 Jan 22 14:19:46 pppd[2926]: secondary DNS address 204.97.212.10 Jan 22 14:19:50 pppd[2935]: CCP terminated by peer Jan 22 14:19:50 pppd[2935]: Compression disabled by peer. Jan 22 14:19:53 tunnel2shore[436]: Opening tunnel to ESPshore Jan 22 14:28:30 login[3124]: root login on 'ttyS0' Jan 22 14:28:35 pppd[2935]: Terminating on signal 15 Jan 22 14:28:35 pppd[2935]: Connect time 8.9 minutes. Jan 22 14:28:35 pppd[2935]: Sent 49985 bytes, received 18168 bytes. Jan 22 14:28:36 pppd[2935]: Connection terminated. Jan 22 14:28:37 pppd[2935]: Exit. Jan 22 14:29:13 su: + /dev/ttyS0 esp:esp Jan 22 14:31:58 pppd[3185]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 14:31:58 pppd[3185]: Using interface ppp5 Jan 22 14:31:59 chat[3190]: abort on (NO CARRIER) Jan 22 14:31:59 chat[3190]: abort on (NO DIALTONE) Jan 22 14:31:59 chat[3190]: abort on (ERROR) Jan 22 14:31:59 chat[3190]: abort on (NO ANSWER) Jan 22 14:31:59 chat[3190]: abort on (BUSY) Jan 22 14:31:59 chat[3190]: abort on (Username/Password Incorrect) Jan 22 14:31:59 chat[3190]: timeout set to 10 seconds Jan 22 14:31:59 chat[3190]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 14:32:01 chat[3190]: expect (OK^M) Jan 22 14:32:01 chat[3190]: ^M Jan 22 14:32:01 chat[3190]: OK^M Jan 22 14:32:01 chat[3190]: -- got it Jan 22 14:32:01 chat[3190]: send (AT+CBST=71,0,1^M) Jan 22 14:32:01 chat[3190]: expect (OK^M) Jan 22 14:32:01 chat[3190]: Jan 22 14:32:01 chat[3190]: ^M Jan 22 14:32:01 chat[3190]: OK^M Jan 22 14:32:01 chat[3190]: -- got it Jan 22 14:32:01 chat[3190]: send (AT+CSQF^M) Jan 22 14:32:02 chat[3190]: expect (OK^M) Jan 22 14:32:02 chat[3190]: Jan 22 14:32:02 chat[3190]: ^M Jan 22 14:32:02 chat[3190]: +CSQF:3^M Jan 22 14:32:02 chat[3190]: ^M Jan 22 14:32:02 chat[3190]: OK^M Jan 22 14:32:02 chat[3190]: -- got it Jan 22 14:32:02 chat[3190]: send () Jan 22 14:32:02 chat[3190]: timeout set to 150 seconds Jan 22 14:32:02 chat[3190]: send (ATD008816000025^M) Jan 22 14:32:02 chat[3190]: expect (CONNECT) Jan 22 14:32:02 chat[3190]: Jan 22 14:32:11 chat[3190]: ^M Jan 22 14:32:11 chat[3190]: CONNECT Jan 22 14:32:11 chat[3190]: -- got it Jan 22 14:32:11 chat[3190]: send () Jan 22 14:32:11 pppd[3185]: Serial connection established. Jan 22 14:32:11 pppd[3185]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 14:32:15 pppd[3185]: CHAP authentication succeeded Jan 22 14:32:15 pppd[3185]: CHAP authentication succeeded Jan 22 14:32:23 pppd[3185]: local IP address 192.168.20.91 Jan 22 14:32:23 pppd[3185]: remote IP address 192.168.20.254 Jan 22 14:32:23 pppd[3185]: primary DNS address 199.2.252.10 Jan 22 14:32:23 pppd[3185]: secondary DNS address 204.97.212.10 Jan 22 14:32:23 pppd[3194]: CCP terminated by peer Jan 22 14:32:23 pppd[3194]: Compression disabled by peer. Jan 22 14:32:23 pppd[3194]: Connect time 0.0 minutes. Jan 22 14:32:23 pppd[3194]: Sent 8 bytes, received 40 bytes. Jan 22 14:32:30 pppd[3194]: local IP address 192.168.20.91 Jan 22 14:32:30 pppd[3194]: remote IP address 192.168.20.254 Jan 22 14:32:30 pppd[3194]: primary DNS address 199.2.252.10 Jan 22 14:32:30 pppd[3194]: secondary DNS address 204.97.212.10 Jan 22 14:32:30 pppd[3194]: Connect time 0.0 minutes. Jan 22 14:32:30 pppd[3194]: Sent 0 bytes, received 0 bytes. Jan 22 14:32:31 tunnel2shore[436]: Opening tunnel to ESPshore Jan 22 14:32:37 pppd[3194]: local IP address 192.168.20.91 Jan 22 14:32:37 pppd[3194]: remote IP address 192.168.20.254 Jan 22 14:32:37 pppd[3194]: primary DNS address 199.2.252.10 Jan 22 14:32:37 pppd[3194]: secondary DNS address 204.97.212.10 Jan 22 14:32:44 tunnel2shore[436]: Opening tunnel to ESPshore Jan 22 14:34:05 pppd[3194]: Terminating on signal 15 Jan 22 14:34:05 pppd[3194]: Connect time 1.5 minutes. Jan 22 14:34:05 pppd[3194]: Sent 11997 bytes, received 6806 bytes. Jan 22 14:34:08 pppd[3194]: Connection terminated. Jan 22 14:34:09 pppd[3194]: Exit. Jan 22 14:34:12 syslogd exiting Jan 22 15:06:26 syslogd started: BusyBox v1.11.2 Jan 22 15:06:26 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 22 15:06:26 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 22 15:06:26 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 15:06:26 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 15:06:26 kernel: [ 0.00] Machine: NXP EA313X Jan 22 15:06:26 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 15:06:26 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 15:06:26 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 22 15:06:26 kernel: [ 0.00] PID hash table entries: 256 (order: -2, 1024 bytes) Jan 22 15:06:26 kernel: [ 0.00] Dentry cache hash table entries: 8192 (order: 3, 32768 bytes) Jan 22 15:06:26 kernel: [ 0.00] Inode-cache hash table entries: 4096 (order: 2, 16384 bytes) Jan 22 15:06:26 kernel: [ 0.00] Memory: 64MB = 64MB total Jan 22 15:06:26 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 22 15:06:26 kernel: [ 0.00] Hierarchical RCU implementation. Jan 22 15:06:26 kernel: [ 0.00] NR_IRQS:38 Jan 22 15:06:26 kernel: [ 0.00] irq=30 Event=0x67 bank:3 bit:7 type:4 Jan 22 15:06:26 kernel: [ 0.00] irq=31 Event=0x7a bank:3 bit:26 type:3 Jan 22 15:06:26 kernel: [ 0.00] irq=32 Event=0x77 bank:3 bit:23 type:3 Jan 22 15:06:26 kernel: [ 0.00] irq=33 Event=0x7b bank:3 bit:27 type:1 Jan 22 15:06:26 kernel: [ 0.00] irq=34 Event=0x32 bank:1 bit:18 type:1 Jan 22 15:06:26 kernel: [ 0.00] irq=35 Event=0x50 bank:2 bit:16 type:1 Jan 22 15:06:26 kernel: [ 0.00] irq=36 Event=0x44 bank:2 bit:4 type:1 Jan 22 15:06:26 kernel: [ 0.00] irq=37 Event=0x18 bank:0 bit:24 type:4 Jan 22 15:06:26 kernel: [ 0.00] console [ttyS0] enabled Jan 22 15:06:26 kernel: [ 0.01] Calibrating delay loop... 134.75 BogoMIPS (lpj=673792) Jan 22 15:06:26 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 15:06:26 kernel: [ 0.24] CPU: Testing write buffer coherency: ok Jan 22 15:06:26 kernel: [ 0.25] NET: Registered protocol family 16 Jan 22 15:06:26 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 15:06:26 kernel: [ 0.29] PC/104 Carrier Jan 22 15:06:26 kernel: [ 0.31] enabling USB host vbus_power Jan 22 15:06:26 kernel: [ 0.33] Registering USB host 0x00212d00 0x0ec0000a (3) Jan 22 15:06:26 kernel: [ 0.33] LPC31: Power Management init. Jan 22 15:06:26 kernel: [ 0.39] bio: create slab at 0 Jan 22 15:06:26 kernel: [ 0.40] SCSI subsystem initialized Jan 22 15:06:26 kernel: [ 0.40] usbcore: registered new interface driver usbfs Jan 22 15:06:26 kernel: [ 0.41] usbcore: registered new interface driver hub Jan 22 15:06:26 kernel: [ 0.41] usbcore: registered new device driver usb Jan 22 15:06:26 kernel: [ 0.42] Switching to clocksource clksource Jan 22 15:06:26 kernel: [ 0.43] Switched to NOHz mode on CPU #0 Jan 22 15:06:26 kernel: [ 0.43] NET: Registered protocol family 2 Jan 22 15:06:26 kernel: [ 0.43] IP route cache hash table entries: 1024 (order: 0, 4096 bytes) Jan 22 15:06:26 kernel: [ 0.43] TCP established hash table entries: 2048 (order: 2, 16384 bytes) Jan 22 15:06:26 kernel: [ 0.43] TCP bind hash table entries: 2048 (order: 1, 8192 bytes) Jan 22 15:06:26 kernel: [ 0.43] TCP: Hash tables configured (established 2048 bind 2048) Jan 22 15:06:26 kernel: [ 0.43] TCP reno registered Jan 22 15:06:26 kernel: [ 0.43] UDP hash table entries: 256 (order: 0, 4096 bytes) Jan 22 15:06:26 kernel: [ 0.43] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) Jan 22 15:06:26 kernel: [ 0.43] NET: Registered protocol family 1 Jan 22 15:06:26 kernel: [ 0.43] RPC: Registered udp transport module. Jan 22 15:06:26 kernel: [ 0.43] RPC: Registered tcp transport module. Jan 22 15:06:26 kernel: [ 0.43] RPC: Registered tcp NFSv4.1 backchannel transport module. Jan 22 15:06:26 kernel: [ 0.44] pca9532 0-0060: setting platform data Jan 22 15:06:26 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 15:06:26 kernel: [ 0.46] squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 22 15:06:26 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 15:06:26 kernel: [ 0.46] msgmni has been set to 120 Jan 22 15:06:26 kernel: [ 0.47] alg: No test for stdrng (krng) Jan 22 15:06:26 kernel: [ 0.47] io scheduler noop registered (default) Jan 22 15:06:26 kernel: [ 0.53] brd: module loaded Jan 22 15:06:26 kernel: [ 0.56] loop: module loaded Jan 22 15:06:26 kernel: [ 0.57] NAND device: Manufacturer ID: 0x2c, Chip ID: 0xaa (Micron NAND 256MiB 1,8V 8-bit) Jan 22 15:06:26 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 22 15:06:26 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 22 15:06:26 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 22 15:06:26 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 22 15:06:26 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 15:06:26 kernel: [ 0.60] m25p80 spi0.3: s25sl032a (4096 Kbytes) Jan 22 15:06:26 kernel: [ 0.61] spi_lpc313x spi_lpc313x.0: LPC313x SPI driver Jan 22 15:06:26 kernel: [ 0.61] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Jan 22 15:06:26 kernel: [ 0.61] lpc-ehci lpc-ehci.0: LPC EHCI Host Controller Jan 22 15:06:26 kernel: [ 0.61] lpc-ehci lpc-ehci.0: new USB bus registered, assigned bus number 1 Jan 22 15:06:26 kernel: [ 0.64] lpc-ehci lpc-ehci.0: irq 27, io mem 0x19000000 Jan 22 15:06:26 kernel: [ 0.66] lpc-ehci lpc-ehci.0: USB 2.0 started, EHCI 1.00 Jan 22 15:06:26 kernel: [ 0.66] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Jan 22 15:06:26 kernel: [ 0.66] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 22 15:06:26 kernel: [ 0.66] usb usb1: Product: LPC EHCI Host Controller Jan 22 15:06:26 kernel: [ 0.66] usb usb1: Manufacturer: Linux 2.6.33-ea3131-mbari6 ehci_hcd Jan 22 15:06:26 kernel: [ 0.66] usb usb1: SerialNumber: lpc-ehci.0 Jan 22 15:06:26 kernel: [ 0.66] hub 1-0:1.0: USB hub found Jan 22 15:06:26 kernel: [ 0.66] hub 1-0:1.0: 1 port detected Jan 22 15:06:26 kernel: [ 0.66] i2c /dev entries driver Jan 22 15:06:26 kernel: [ 0.67] lpc313x-wdt lpc313x-wdt: Watchdog device driver initialized. Jan 22 15:06:26 kernel: [ 0.67] cpuidle: using governor ladder Jan 22 15:06:26 kernel: [ 0.67] cpuidle: using governor menu Jan 22 15:06:26 kernel: [ 0.68] lpc313x_mmc lpc313x_mmc.0: LPC313x MMC controller at irq 26 Jan 22 15:06:26 kernel: [ 0.68] Serial: 8250/16550 driver, 9 ports, IRQ sharing enabled Jan 22 15:06:26 kernel: [ 0.68] serial8250: ttyS0 at MMIO 0x15001000 (irq = 10) is a NXP16750 Jan 22 15:06:26 kernel: [ 0.69] serial8250.0: ttyS0 at MMIO 0x15001000 (irq = 10) is a NXP16750 Jan 22 15:06:26 kernel: [ 0.69] serial8250.1: ttyS1 at MMIO 0x20000400 (irq = 37) is a XR16788 Jan 22 15:06:26 kernel: [ 0.70] mmc_host mmc0: card inserted Jan 22 15:06:26 kernel: [ 0.70] serial8250.1: ttyS2 at MMIO 0x20000410 (irq = 37) is a XR16788 Jan 22 15:06:26 kernel: [ 0.70] serial8250.1: ttyS3 at MMIO 0x20000420 (irq = 37) is a XR16788 Jan 22 15:06:26 kernel: [ 0.70] serial8250.1: ttyS4 at MMIO 0x20000430 (irq = 37) is a XR16788 Jan 22 15:06:26 kernel: [ 0.71] serial8250.1: ttyS5 at MMIO 0x20000440 (irq = 37) is a XR16788 Jan 22 15:06:26 kernel: [ 0.71] serial8250.1: ttyS6 at MMIO 0x20000450 (irq = 37) is a XR16788 Jan 22 15:06:26 kernel: [ 0.71] serial8250.1: ttyS7 at MMIO 0x20000460 (irq = 37) is a XR16788 Jan 22 15:06:26 kernel: [ 0.71] serial8250.1: ttyS8 at MMIO 0x20000470 (irq = 37) is a XR16788 Jan 22 15:06:26 kernel: [ 0.72] TCP cubic registered Jan 22 15:06:26 kernel: [ 0.72] NET: Registered protocol family 17 Jan 22 15:06:26 kernel: [ 0.72] Waiting for root device /dev/mmcblk0p2... Jan 22 15:06:26 kernel: [ 0.77] mmc0: no r/o switch -- assuming write-enabled Jan 22 15:06:26 kernel: [ 0.77] mmc0: new SDHC card at address aaaa Jan 22 15:06:26 kernel: [ 0.78] mmcblk0: mmc0:aaaa SS08G 7.40 GiB Jan 22 15:06:26 kernel: [ 0.78] mmcblk0: p1 p2 p3 Jan 22 15:06:26 kernel: [ 0.87] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode Jan 22 15:06:26 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 15:06:26 kernel: [ 0.88] Freeing init memory: 100K Jan 22 15:06:26 kernel: [ 0.98] usb 1-1: new full speed USB device using lpc-ehci and address 2 Jan 22 15:06:26 kernel: [ 1.13] usb 1-1: not running at top speed; connect to a high speed hub Jan 22 15:06:26 kernel: [ 1.13] usb 1-1: New USB device found, idVendor=1a40, idProduct=0101 Jan 22 15:06:26 kernel: [ 1.13] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Jan 22 15:06:26 kernel: [ 1.13] usb 1-1: Product: USB 2.0 Hub Jan 22 15:06:26 kernel: [ 1.18] hub 1-1:1.0: USB hub found Jan 22 15:06:26 kernel: [ 1.18] hub 1-1:1.0: 4 ports detected Jan 22 15:06:26 kernel: [ 1.49] usb 1-1.2: new full speed USB device using lpc-ehci and address 3 Jan 22 15:06:26 kernel: [ 1.63] usb 1-1.2: New USB device found, idVendor=0403, idProduct=6015 Jan 22 15:06:26 kernel: [ 1.63] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 22 15:06:26 kernel: [ 1.63] usb 1-1.2: Product: Chipi-X Jan 22 15:06:26 kernel: [ 1.63] usb 1-1.2: Manufacturer: FTDI Jan 22 15:06:26 kernel: [ 1.63] usb 1-1.2: SerialNumber: FTYSL64Y Jan 22 15:06:26 kernel: [ 1.75] usb 1-1.3: new full speed USB device using lpc-ehci and address 4 Jan 22 15:06:26 kernel: [ 1.90] usb 1-1.3: New USB device found, idVendor=1edd, idProduct=a555 Jan 22 15:06:26 kernel: [ 1.90] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jan 22 15:06:26 kernel: [ 1.90] usb 1-1.3: Product: Iridium 9555 Handset Jan 22 15:06:26 kernel: [ 1.90] usb 1-1.3: Manufacturer: Iridium Jan 22 15:06:26 kernel: [ 2.14] ks8851_mll ks8851_mll.0: message enable is 0 Jan 22 15:06:26 kernel: [ 2.15] ks8851_mll ks8851_mll.0: Found chip, family: 0x88, id: 0x7, rev: 0x1 Jan 22 15:06:26 kernel: [ 2.15] ks8851_mll ks8851_mll.0: passed selftest Jan 22 15:06:26 kernel: [ 2.40] ds323 Jan 22 15:06:26 kernel: 4 spi0.1: Control Reg: 0x1c Jan 22 15:06:26 kernel: [ 2.40] ds3234 spi0.1: Ctrl/Stat Reg: 0x88 Jan 22 15:06:26 kernel: [ 2.40] ds3234 spi0.1: rtc core: registered ds3234 as rtc0 Jan 22 15:06:26 kernel: [ 2.57] cdc_acm 1-1.3:1.0: ttyACM0: USB ACM device Jan 22 15:06:26 kernel: [ 2.60] usbcore: registered new interface driver cdc_acm Jan 22 15:06:26 kernel: [ 2.60] cdc_acm: v0.26:USB Abstract Control Model driver for USB modems and ISDN adapters Jan 22 15:06:26 kernel: [ 2.77] usbcore: registered new interface driver usbserial Jan 22 15:06:26 kernel: [ 2.79] USB Serial support registered for generic Jan 22 15:06:26 kernel: [ 2.81] usbcore: registered new interface driver usbserial_generic Jan 22 15:06:26 kernel: [ 2.81] usbserial: USB Serial Driver core Jan 22 15:06:26 kernel: [ 2.93] USB Serial support registered for FTDI USB Serial Device Jan 22 15:06:26 kernel: [ 2.93] ftdi_sio 1-1.2:1.0: FTDI USB Serial Device converter detected Jan 22 15:06:26 kernel: [ 2.93] usb 1-1.2: Detected FT232RL Jan 22 15:06:26 kernel: [ 2.93] usb 1-1.2: Number of endpoints 2 Jan 22 15:06:26 kernel: [ 2.93] usb 1-1.2: Endpoint 1 MaxPacketSize 64 Jan 22 15:06:26 kernel: [ 2.93] usb 1-1.2: Endpoint 2 MaxPacketSize 64 Jan 22 15:06:26 kernel: [ 2.93] usb 1-1.2: Setting MaxPacketSize 64 Jan 22 15:06:26 kernel: [ 2.95] usb 1-1.2: FTDI USB Serial Device converter now attached to ttyUSB0 Jan 22 15:06:26 kernel: [ 2.96] usbcore: registered new interface driver ftdi_sio Jan 22 15:06:26 kernel: [ 2.96] ftdi_sio: v1.5.0:USB FTDI Serial Converters Driver Jan 22 15:06:26 kernel: [ 3.27] Adding 102392k swap on /.SWAP. Priority:-1 extents:1 across:102392k SS Jan 22 15:06:29 IridiumLocation: -2692,-4348,3796,77275c2c Jan 22 15:06:29 su: + /dev/console root:esp Jan 22 15:06:34 login[432]: root login on 'ttyS0' Jan 22 15:06:49 ringBack[437]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 22 15:06:50 ringBack[437]: Got RING on /dev/modem --> {sleep 60; ifup iridium} Jan 22 15:06:53 tunnel2shore[436]: Opening tunnel to ESPshore Jan 22 15:06:55 su: + /dev/ttyS0 root:esp Jan 22 15:07:51 kernel: [ 88.64] PPP generic driver version 2.4.2 Jan 22 15:07:51 pppd[861]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 15:07:51 pppd[861]: Using interface ppp5 Jan 22 15:07:52 chat[872]: abort on (NO CARRIER) Jan 22 15:07:52 chat[872]: abort on (NO DIALTONE) Jan 22 15:07:52 chat[872]: abort on (ERROR) Jan 22 15:07:52 chat[872]: abort on (NO ANSWER) Jan 22 15:07:52 chat[872]: abort on (BUSY) Jan 22 15:07:52 chat[872]: abort on (Username/Password Incorrect) Jan 22 15:07:52 chat[872]: timeout set to 10 seconds Jan 22 15:07:52 chat[872]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 15:07:55 chat[872]: expect (OK^M) Jan 22 15:07:55 chat[872]: ^M Jan 22 15:07:55 chat[872]: OK^M Jan 22 15:07:55 chat[872]: -- got it Jan 22 15:07:55 chat[872]: send (AT+CBST=71,0,1^M) Jan 22 15:07:55 chat[872]: expect (OK^M) Jan 22 15:07:55 chat[872]: Jan 22 15:07:55 chat[872]: ^M Jan 22 15:07:55 chat[872]: OK^M Jan 22 15:07:55 chat[872]: -- got it Jan 22 15:07:55 chat[872]: send (AT+CSQF^M) Jan 22 15:07:55 chat[872]: expect (OK^M) Jan 22 15:07:55 chat[872]: Jan 22 15:07:55 chat[872]: ^M Jan 22 15:07:55 chat[872]: +CSQF:5^M Jan 22 15:07:55 chat[872]: ^M Jan 22 15:07:55 chat[872]: OK^M Jan 22 15:07:55 chat[872]: -- got it Jan 22 15:07:55 chat[872]: send () Jan 22 15:07:55 chat[872]: timeout set to 150 seconds Jan 22 15:07:55 chat[872]: send (ATD008816000025^M) Jan 22 15:07:55 chat[872]: expect (CONNECT) Jan 22 15:07:55 chat[872]: Jan 22 15:08:02 chat[872]: ^M Jan 22 15:08:02 chat[872]: CONNECT Jan 22 15:08:02 chat[872]: -- got it Jan 22 15:08:02 chat[872]: send () Jan 22 15:08:02 pppd[861]: Serial connection established. Jan 22 15:08:02 pppd[861]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 15:08:15 pppd[861]: CHAP authentication succeeded Jan 22 15:08:15 pppd[861]: CHAP authentication succeeded Jan 22 15:08:15 kernel: [ 112.30] PPP BSD Compression module registered Jan 22 15:08:15 kernel: [ 112.39] PPP Deflate Compression module registered Jan 22 15:08:20 pppd[861]: not replacing existing default route via 134.89.12.1 Jan 22 15:08:20 pppd[861]: local IP address 192.168.10.242 Jan 22 15:08:20 pppd[861]: remote IP address 192.168.10.254 Jan 22 15:08:20 pppd[861]: primary DNS address 12.127.17.72 Jan 22 15:08:20 pppd[861]: secondary DNS address 204.97.212.10 Jan 22 15:08:21 pppd[888]: CCP terminated by peer Jan 22 15:08:21 pppd[888]: Compression disabled by peer. Jan 22 15:08:39 pppd[888]: Terminating on signal 15 Jan 22 15:08:39 pppd[888]: Connect time 0.4 minutes. Jan 22 15:08:39 pppd[888]: Sent 8 bytes, received 8 bytes. Jan 22 15:08:40 pppd[888]: Connection terminated. Jan 22 15:08:40 ringBack[890]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 22 15:08:41 pppd[888]: Exit. Jan 22 15:10:53 dropbear[972]: Child connection from 134.89.10.221:47510 Jan 22 15:10:54 dropbear[972]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:47510 Jan 22 15:10:54 dropbear[972]: Exit (root): Disconnect received Jan 22 15:11:34 dropbear[975]: Child connection from 134.89.10.221:47512 Jan 22 15:11:35 dropbear[975]: Pubkey auth succeeded for 'root' with key sha1!! 85:fb:60:45:3b:f0:52:33:7f:d8:e3:8a:77:41:9d:de:83:54:f3:41 from 134.89.10.221:47512 Jan 22 15:11:35 dropbear[975]: Exit (root): Disconnect received Jan 22 15:12:17 login[981]: root login on 'ttyS0' Jan 22 15:12:57 pppd[1007]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 15:12:57 pppd[1007]: Using interface ppp5 Jan 22 15:12:58 chat[1013]: timeout set to 8 seconds Jan 22 15:12:58 chat[1013]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 15:13:01 chat[1013]: expect (OK^M) Jan 22 15:13:01 chat[1013]: ^M Jan 22 15:13:01 chat[1013]: OK^M Jan 22 15:13:01 chat[1013]: -- got it Jan 22 15:13:01 chat[1013]: send () Jan 22 15:13:01 chat[1008]: abort on (NO CARRIER) Jan 22 15:13:01 chat[1008]: abort on (NO DIALTONE) Jan 22 15:13:01 chat[1008]: abort on (ERROR) Jan 22 15:13:01 chat[1008]: abort on (NO ANSWER) Jan 22 15:13:01 chat[1008]: abort on (BUSY) Jan 22 15:13:01 chat[1008]: abort on (Username/Password Incorrect) Jan 22 15:13:01 chat[1008]: timeout set to 10 seconds Jan 22 15:13:01 chat[1008]: send (AT+CBST=71,0,1^M) Jan 22 15:13:01 chat[1008]: expect (OK^M) Jan 22 15:13:01 chat[1008]: Jan 22 15:13:01 chat[1008]: ^M Jan 22 15:13:01 chat[1008]: OK^M Jan 22 15:13:01 chat[1008]: -- got it Jan 22 15:13:01 chat[1008]: send (AT+CSQF^M) Jan 22 15:13:01 chat[1008]: expect (OK^M) Jan 22 15:13:01 chat[1008]: Jan 22 15:13:01 chat[1008]: ^M Jan 22 15:13:01 chat[1008]: +CSQF:5^M Jan 22 15:13:01 chat[1008]: ^M Jan 22 15:13:01 chat[1008]: OK^M Jan 22 15:13:01 chat[1008]: -- got it Jan 22 15:13:01 chat[1008]: send () Jan 22 15:13:01 chat[1008]: timeout set to 150 seconds Jan 22 15:13:01 chat[1008]: send (ATD008816000025^M) Jan 22 15:13:02 chat[1008]: expect (CONNECT) Jan 22 15:13:02 chat[1008]: Jan 22 15:13:24 chat[1008]: ^M Jan 22 15:13:24 chat[1008]: CONNECT Jan 22 15:13:24 chat[1008]: -- got it Jan 22 15:13:24 chat[1008]: send () Jan 22 15:13:24 pppd[1007]: Serial connection established. Jan 22 15:13:24 pppd[1007]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 15:13:28 pppd[1007]: CHAP authentication succeeded Jan 22 15:13:28 pppd[1007]: CHAP authentication succeeded Jan 22 15:13:34 pppd[1007]: not replacing existing default route via 134.89.12.1 Jan 22 15:13:34 pppd[1007]: local IP address 192.168.10.243 Jan 22 15:13:34 pppd[1007]: remote IP address 192.168.10.254 Jan 22 15:13:34 pppd[1007]: primary DNS address 12.127.17.72 Jan 22 15:13:34 pppd[1007]: secondary DNS address 204.97.212.10 Jan 22 15:13:35 pppd[1019]: CCP terminated by peer Jan 22 15:13:35 pppd[1019]: Compression disabled by peer. Jan 22 15:14:05 pppd[1019]: Terminating on signal 15 Jan 22 15:14:05 pppd[1019]: Connect time 0.6 minutes. Jan 22 15:14:05 pppd[1019]: Sent 8 bytes, received 8 bytes. Jan 22 15:14:06 pppd[1019]: Connection terminated. Jan 22 15:14:07 pppd[1019]: Exit. Jan 22 15:15:04 init: Switching to runlevel: 6 Jan 22 15:15:15 syslogd exiting Jan 22 15:20:52 syslogd started: BusyBox v1.11.2 Jan 22 15:20:52 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 22 15:20:52 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 22 15:20:52 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 15:20:52 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 15:20:52 kernel: [ 0.00] Machine: NXP EA313X Jan 22 15:20:52 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 15:20:52 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 15:20:52 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 22 15:20:52 kernel: [ 0.00] PID hash table entries: 256 (order: -2, 1024 bytes) Jan 22 15:20:52 kernel: [ 0.00] Dentry cache hash table entries: 8192 (order: 3, 32768 bytes) Jan 22 15:20:52 kernel: [ 0.00] Inode-cache hash table entries: 4096 (order: 2, 16384 bytes) Jan 22 15:20:52 kernel: [ 0.00] Memory: 64MB = 64MB total Jan 22 15:20:52 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 22 15:20:52 kernel: [ 0.00] Hierarchical RCU implementation. Jan 22 15:20:52 kernel: [ 0.00] NR_IRQS:38 Jan 22 15:20:52 kernel: [ 0.00] irq=30 Event=0x67 bank:3 bit:7 type:4 Jan 22 15:20:52 kernel: [ 0.00] irq=31 Event=0x7a bank:3 bit:26 type:3 Jan 22 15:20:52 kernel: [ 0.00] irq=32 Event=0x77 bank:3 bit:23 type:3 Jan 22 15:20:52 kernel: [ 0.00] irq=33 Event=0x7b bank:3 bit:27 type:1 Jan 22 15:20:52 kernel: [ 0.00] irq=34 Event=0x32 bank:1 bit:18 type:1 Jan 22 15:20:52 kernel: [ 0.00] irq=35 Event=0x50 bank:2 bit:16 type:1 Jan 22 15:20:52 kernel: [ 0.00] irq=36 Event=0x44 bank:2 bit:4 type:1 Jan 22 15:20:52 kernel: [ 0.00] irq=37 Event=0x18 bank:0 bit:24 type:4 Jan 22 15:20:52 kernel: [ 0.00] console [ttyS0] enabled Jan 22 15:20:52 kernel: [ 0.01] Calibrating delay loop... 134.75 BogoMIPS (lpj=673792) Jan 22 15:20:52 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 15:20:52 kernel: [ 0.24] CPU: Testing write buffer coherency: ok Jan 22 15:20:52 kernel: [ 0.25] NET: Registered protocol family 16 Jan 22 15:20:52 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 15:20:52 kernel: [ 0.29] PC/104 Carrier Jan 22 15:20:52 kernel: [ 0.31] enabling USB host vbus_power Jan 22 15:20:52 kernel: [ 0.33] Registering USB host 0x00212d00 0x0ec0000a (3) Jan 22 15:20:52 kernel: [ 0.33] LPC31: Power Management init. Jan 22 15:20:52 kernel: [ 0.39] bio: create slab at 0 Jan 22 15:20:52 kernel: [ 0.40] SCSI subsystem initialized Jan 22 15:20:52 kernel: [ 0.40] usbcore: registered new interface driver usbfs Jan 22 15:20:52 kernel: [ 0.41] usbcore: registered new interface driver hub Jan 22 15:20:52 kernel: [ 0.41] usbcore: registered new device driver usb Jan 22 15:20:52 kernel: [ 0.42] Switching to clocksource clksource Jan 22 15:20:52 kernel: [ 0.43] Switched to NOHz mode on CPU #0 Jan 22 15:20:52 kernel: [ 0.43] NET: Registered protocol family 2 Jan 22 15:20:52 kernel: [ 0.43] IP route cache hash table entries: 1024 (order: 0, 4096 bytes) Jan 22 15:20:52 kernel: [ 0.43] TCP established hash table entries: 2048 (order: 2, 16384 bytes) Jan 22 15:20:52 kernel: [ 0.43] TCP bind hash table entries: 2048 (order: 1, 8192 bytes) Jan 22 15:20:52 kernel: [ 0.43] TCP: Hash tables configured (established 2048 bind 2048) Jan 22 15:20:52 kernel: [ 0.43] TCP reno registered Jan 22 15:20:52 kernel: [ 0.43] UDP hash table entries: 256 (order: 0, 4096 bytes) Jan 22 15:20:52 kernel: [ 0.43] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) Jan 22 15:20:52 kernel: [ 0.43] NET: Registered protocol family 1 Jan 22 15:20:52 kernel: [ 0.43] RPC: Registered udp transport module. Jan 22 15:20:52 kernel: [ 0.43] RPC: Registered tcp transport module. Jan 22 15:20:52 kernel: [ 0.43] RPC: Registered tcp NFSv4.1 backchannel transport module. Jan 22 15:20:52 kernel: [ 0.44] pca9532 0-0060: setting platform data Jan 22 15:20:52 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 15:20:52 kernel: [ 0.46] squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 22 15:20:52 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 15:20:52 kernel: [ 0.46] msgmni has been set to 120 Jan 22 15:20:52 kernel: [ 0.47] alg: No test for stdrng (krng) Jan 22 15:20:52 kernel: [ 0.47] io scheduler noop registered (default) Jan 22 15:20:52 kernel: [ 0.53] brd: module loaded Jan 22 15:20:52 kernel: [ 0.56] loop: module loaded Jan 22 15:20:52 kernel: [ 0.57] NAND device: Manufacturer ID: 0x2c, Chip ID: 0xaa (Micron NAND 256MiB 1,8V 8-bit) Jan 22 15:20:52 kernel: [ 0.57] Creating 3 MTD partitions on "lpc313x_nand": Jan 22 15:20:52 kernel: [ 0.57] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 22 15:20:52 kernel: [ 0.58] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 22 15:20:52 kernel: [ 0.58] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 22 15:20:52 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 15:20:52 kernel: [ 0.60] m25p80 spi0.3: s25sl032a (4096 Kbytes) Jan 22 15:20:52 kernel: [ 0.61] spi_lpc313x spi_lpc313x.0: LPC313x SPI driver Jan 22 15:20:52 kernel: [ 0.61] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Jan 22 15:20:52 kernel: [ 0.61] lpc-ehci lpc-ehci.0: LPC EHCI Host Controller Jan 22 15:20:52 kernel: [ 0.61] lpc-ehci lpc-ehci.0: new USB bus registered, assigned bus number 1 Jan 22 15:20:52 kernel: [ 0.64] lpc-ehci lpc-ehci.0: irq 27, io mem 0x19000000 Jan 22 15:20:52 kernel: [ 0.66] lpc-ehci lpc-ehci.0: USB 2.0 started, EHCI 1.00 Jan 22 15:20:52 kernel: [ 0.66] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Jan 22 15:20:52 kernel: [ 0.66] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 22 15:20:52 kernel: [ 0.66] usb usb1: Product: LPC EHCI Host Controller Jan 22 15:20:52 kernel: [ 0.66] usb usb1: Manufacturer: Linux 2.6.33-ea3131-mbari6 ehci_hcd Jan 22 15:20:52 kernel: [ 0.66] usb usb1: SerialNumber: lpc-ehci.0 Jan 22 15:20:52 kernel: [ 0.66] hub 1-0:1.0: USB hub found Jan 22 15:20:52 kernel: [ 0.66] hub 1-0:1.0: 1 port detected Jan 22 15:20:52 kernel: [ 0.66] i2c /dev entries driver Jan 22 15:20:52 kernel: [ 0.67] lpc313x-wdt lpc313x-wdt: Watchdog device driver initialized. Jan 22 15:20:52 kernel: [ 0.67] cpuidle: using governor ladder Jan 22 15:20:52 kernel: [ 0.67] cpuidle: using governor menu Jan 22 15:20:52 kernel: [ 0.68] lpc313x_mmc lpc313x_mmc.0: LPC313x MMC controller at irq 26 Jan 22 15:20:52 kernel: [ 0.68] Serial: 8250/16550 driver, 9 ports, IRQ sharing enabled Jan 22 15:20:52 kernel: [ 0.68] serial8250: ttyS0 at MMIO 0x15001000 (irq = 10) is a NXP16750 Jan 22 15:20:52 kernel: [ 0.69] serial8250.0: ttyS0 at MMIO 0x15001000 (irq = 10) is a NXP16750 Jan 22 15:20:52 kernel: [ 0.69] serial8250.1: ttyS1 at MMIO 0x20000400 (irq = 37) is a XR16788 Jan 22 15:20:52 kernel: [ 0.70] mmc_host mmc0: card inserted Jan 22 15:20:52 kernel: [ 0.70] serial8250.1: ttyS2 at MMIO 0x20000410 (irq = 37) is a XR16788 Jan 22 15:20:52 kernel: [ 0.70] serial8250.1: ttyS3 at MMIO 0x20000420 (irq = 37) is a XR16788 Jan 22 15:20:52 kernel: [ 0.70] serial8250.1: ttyS4 at MMIO 0x20000430 (irq = 37) is a XR16788 Jan 22 15:20:52 kernel: [ 0.71] serial8250.1: ttyS5 at MMIO 0x20000440 (irq = 37) is a XR16788 Jan 22 15:20:52 kernel: [ 0.71] serial8250.1: ttyS6 at MMIO 0x20000450 (irq = 37) is a XR16788 Jan 22 15:20:52 kernel: [ 0.71] serial8250.1: ttyS7 at MMIO 0x20000460 (irq = 37) is a XR16788 Jan 22 15:20:52 kernel: [ 0.71] serial8250.1: ttyS8 at MMIO 0x20000470 (irq = 37) is a XR16788 Jan 22 15:20:52 kernel: [ 0.72] TCP cubic registered Jan 22 15:20:52 kernel: [ 0.72] NET: Registered protocol family 17 Jan 22 15:20:52 kernel: [ 0.72] Waiting for root device /dev/mmcblk0p2... Jan 22 15:20:52 kernel: [ 0.77] mmc0: no r/o switch -- assuming write-enabled Jan 22 15:20:52 kernel: [ 0.77] mmc0: new SDHC card at address aaaa Jan 22 15:20:52 kernel: [ 0.78] mmcblk0: mmc0:aaaa SS08G 7.40 GiB Jan 22 15:20:52 kernel: [ 0.78] mmcblk0: p1 p2 p3 Jan 22 15:20:52 kernel: [ 0.87] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode Jan 22 15:20:52 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 15:20:52 kernel: [ 0.88] Freeing init memory: 100K Jan 22 15:20:52 kernel: [ 0.98] usb 1-1: new full speed USB device using lpc-ehci and address 2 Jan 22 15:20:52 kernel: [ 1.13] usb 1-1: not running at top speed; connect to a high speed hub Jan 22 15:20:52 kernel: [ 1.13] usb 1-1: New USB device found, idVendor=1a40, idProduct=0101 Jan 22 15:20:52 kernel: [ 1.13] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Jan 22 15:20:52 kernel: [ 1.13] usb 1-1: Product: USB 2.0 Hub Jan 22 15:20:52 kernel: [ 1.18] hub 1-1:1.0: USB hub found Jan 22 15:20:52 kernel: [ 1.18] hub 1-1:1.0: 4 ports detected Jan 22 15:20:52 kernel: [ 1.49] usb 1-1.2: new full speed USB device using lpc-ehci and address 3 Jan 22 15:20:52 kernel: [ 1.63] usb 1-1.2: New USB device found, idVendor=0403, idProduct=6015 Jan 22 15:20:52 kernel: [ 1.63] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 22 15:20:52 kernel: [ 1.63] usb 1-1.2: Product: Chipi-X Jan 22 15:20:52 kernel: [ 1.63] usb 1-1.2: Manufacturer: FTDI Jan 22 15:20:52 kernel: [ 1.63] usb 1-1.2: SerialNumber: FTYSL64Y Jan 22 15:20:52 kernel: [ 1.75] usb 1-1.3: new full speed USB device using lpc-ehci and address 4 Jan 22 15:20:52 kernel: [ 1.89] usb 1-1.3: New USB device found, idVendor=1edd, idProduct=a555 Jan 22 15:20:52 kernel: [ 1.89] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jan 22 15:20:52 kernel: [ 1.89] usb 1-1.3: Product: Iridium 9555 Handset Jan 22 15:20:52 kernel: [ 1.89] usb 1-1.3: Manufacturer: Iridium Jan 22 15:20:52 kernel: [ 2.14] ks8851_mll ks8851_mll.0: message enable is 0 Jan 22 15:20:52 kernel: [ 2.14] ks8851_mll ks8851_mll.0: Found chip, family: 0x88, id: 0x7, rev: 0x1 Jan 22 15:20:52 kernel: [ 2.14] ks8851_mll ks8851_mll.0: passed selftest Jan 22 15:20:52 kernel: [ 2.38] ds323 Jan 22 15:20:52 kernel: 4 spi0.1: Control Reg: 0x1c Jan 22 15:20:52 kernel: [ 2.38] ds3234 spi0.1: Ctrl/Stat Reg: 0x88 Jan 22 15:20:52 kernel: [ 2.39] ds3234 spi0.1: rtc core: registered ds3234 as rtc0 Jan 22 15:20:52 kernel: [ 2.55] cdc_acm 1-1.3:1.0: ttyACM0: USB ACM device Jan 22 15:20:52 kernel: [ 2.58] usbcore: registered new interface driver cdc_acm Jan 22 15:20:52 kernel: [ 2.58] cdc_acm: v0.26:USB Abstract Control Model driver for USB modems and ISDN adapters Jan 22 15:20:52 kernel: [ 2.78] usbcore: registered new interface driver usbserial Jan 22 15:20:52 kernel: [ 2.80] USB Serial support registered for generic Jan 22 15:20:52 kernel: [ 2.81] usbcore: registered new interface driver usbserial_generic Jan 22 15:20:52 kernel: [ 2.81] usbserial: USB Serial Driver core Jan 22 15:20:52 kernel: [ 2.93] USB Serial support registered for FTDI USB Serial Device Jan 22 15:20:52 kernel: [ 2.93] ftdi_sio 1-1.2:1.0: FTDI USB Serial Device converter detected Jan 22 15:20:52 kernel: [ 2.93] usb 1-1.2: Detected FT232RL Jan 22 15:20:52 kernel: [ 2.93] usb 1-1.2: Number of endpoints 2 Jan 22 15:20:52 kernel: [ 2.93] usb 1-1.2: Endpoint 1 MaxPacketSize 64 Jan 22 15:20:52 kernel: [ 2.93] usb 1-1.2: Endpoint 2 MaxPacketSize 64 Jan 22 15:20:52 kernel: [ 2.93] usb 1-1.2: Setting MaxPacketSize 64 Jan 22 15:20:52 kernel: [ 2.95] usb 1-1.2: FTDI USB Serial Device converter now attached to ttyUSB0 Jan 22 15:20:52 kernel: [ 2.96] usbcore: registered new interface driver ftdi_sio Jan 22 15:20:52 kernel: [ 2.96] ftdi_sio: v1.5.0:USB FTDI Serial Converters Driver Jan 22 15:20:52 kernel: [ 3.27] Adding 102392k swap on /.SWAP. Priority:-1 extents:1 across:102392k SS Jan 22 15:20:55 IridiumLocation: -2680,-4352,3796,77276eab Jan 22 15:20:55 su: + /dev/console root:esp Jan 22 15:21:15 kernel: [ 27.10] PPP generic driver version 2.4.2 Jan 22 15:21:15 pppd[478]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 15:21:15 pppd[478]: Using interface ppp5 Jan 22 15:21:15 ringBack[437]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 22 15:21:16 chat[493]: timeout set to 8 seconds Jan 22 15:21:16 chat[493]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 15:21:19 chat[493]: expect (OK^M) Jan 22 15:21:19 chat[493]: ^M Jan 22 15:21:19 chat[493]: OK^M Jan 22 15:21:19 chat[493]: -- got it Jan 22 15:21:19 chat[493]: send () Jan 22 15:21:19 chat[488]: abort on (NO CARRIER) Jan 22 15:21:19 chat[488]: abort on (NO DIALTONE) Jan 22 15:21:19 chat[488]: abort on (ERROR) Jan 22 15:21:19 chat[488]: abort on (NO ANSWER) Jan 22 15:21:19 chat[488]: abort on (BUSY) Jan 22 15:21:19 chat[488]: abort on (Username/Password Incorrect) Jan 22 15:21:19 chat[488]: timeout set to 10 seconds Jan 22 15:21:19 chat[488]: send (AT+CBST=71,0,1^M) Jan 22 15:21:19 chat[488]: expect (OK^M) Jan 22 15:21:19 chat[488]: Jan 22 15:21:19 chat[488]: ^M Jan 22 15:21:19 chat[488]: OK^M Jan 22 15:21:19 chat[488]: -- got it Jan 22 15:21:19 chat[488]: send (AT+CSQF^M) Jan 22 15:21:19 chat[488]: expect (OK^M) Jan 22 15:21:19 chat[488]: Jan 22 15:21:19 chat[488]: ^M Jan 22 15:21:19 chat[488]: +CSQF:5^M Jan 22 15:21:19 chat[488]: ^M Jan 22 15:21:19 chat[488]: OK^M Jan 22 15:21:19 chat[488]: -- got it Jan 22 15:21:19 chat[488]: send () Jan 22 15:21:19 chat[488]: timeout set to 150 seconds Jan 22 15:21:19 chat[488]: send (ATD008816000025^M) Jan 22 15:21:20 chat[488]: expect (CONNECT) Jan 22 15:21:20 chat[488]: Jan 22 15:21:27 chat[488]: ^M Jan 22 15:21:27 chat[488]: CONNECT Jan 22 15:21:27 chat[488]: -- got it Jan 22 15:21:27 chat[488]: send () Jan 22 15:21:27 pppd[478]: Serial connection established. Jan 22 15:21:27 pppd[478]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 15:21:32 pppd[478]: CHAP authentication succeeded Jan 22 15:21:32 pppd[478]: CHAP authentication succeeded Jan 22 15:21:32 kernel: [ 44.21] PPP BSD Compression module registered Jan 22 15:21:32 kernel: [ 44.30] PPP Deflate Compression module registered Jan 22 15:21:41 pppd[478]: local IP address 192.168.20.103 Jan 22 15:21:41 pppd[478]: remote IP address 192.168.20.254 Jan 22 15:21:41 pppd[478]: primary DNS address 199.2.252.10 Jan 22 15:21:41 pppd[478]: secondary DNS address 204.97.212.10 Jan 22 15:21:44 su: - /dev/ttyS0 esp:root Jan 22 15:21:46 pppd[723]: Connect time 0.1 minutes. Jan 22 15:21:46 pppd[723]: Sent 16 bytes, received 58 bytes. Jan 22 15:21:52 pppd[723]: local IP address 192.168.20.103 Jan 22 15:21:52 pppd[723]: remote IP address 192.168.20.254 Jan 22 15:21:52 pppd[723]: primary DNS address 199.2.252.10 Jan 22 15:21:52 pppd[723]: secondary DNS address 204.97.212.10 Jan 22 15:21:55 login[790]: root login on 'ttyS0' Jan 22 15:21:57 pppd[723]: Terminating on signal 15 Jan 22 15:21:57 pppd[723]: Connect time 0.1 minutes. Jan 22 15:21:57 pppd[723]: Sent 12 bytes, received 30 bytes. Jan 22 15:21:58 pppd[723]: Connection terminated. Jan 22 15:21:59 pppd[723]: Exit. Jan 22 15:22:32 su: + /dev/ttyS0 esp:esp Jan 22 15:23:21 su: + /dev/ttyS0 esp:esp Jan 22 15:32:24 init: Switching to runlevel: 6 Jan 22 15:32:33 syslogd exiting Jan 22 15:32:42 syslogd started: BusyBox v1.11.2 Jan 22 15:32:42 kernel: klogd started: BusyBox v1.11.2 (mbari-1) Jan 22 15:32:42 kernel: [ 0.00] Linux version 2.6.33-ea3131-mbari6 (brent@raven) (gcc version 4.1.2) #1 Mon Oct 28 17:55:28 PDT 2019 Jan 22 15:32:42 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 15:32:42 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 15:32:42 kernel: [ 0.00] Machine: NXP EA313X Jan 22 15:32:42 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 15:32:42 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 15:32:42 kernel: [ 0.00] Kernel command line: console=ttyS0,115200n8 loglevel=5 board= ks8851_mll.mac=00:1a:f1:01:90:b7 root=/dev/mmcblk0p2 ro rootwait Jan 22 15:32:42 kernel: [ 0.00] PID hash table entries: 256 (order: -2, 1024 bytes) Jan 22 15:32:42 kernel: [ 0.00] Dentry cache hash table entries: 8192 (order: 3, 32768 bytes) Jan 22 15:32:42 kernel: [ 0.00] Inode-cache hash table entries: 4096 (order: 2, 16384 bytes) Jan 22 15:32:42 kernel: [ 0.00] Memory: 64MB = 64MB total Jan 22 15:32:42 kernel: [ 0.00] Memory: 61516KB available (2928K code, 192K data, 100K init, 0K highmem) Jan 22 15:32:42 kernel: [ 0.00] Hierarchical RCU implementation. Jan 22 15:32:42 kernel: [ 0.00] NR_IRQS:38 Jan 22 15:32:42 kernel: [ 0.00] irq=30 Event=0x67 bank:3 bit:7 type:4 Jan 22 15:32:42 kernel: [ 0.00] irq=31 Event=0x7a bank:3 bit:26 type:3 Jan 22 15:32:42 kernel: [ 0.00] irq=32 Event=0x77 bank:3 bit:23 type:3 Jan 22 15:32:42 kernel: [ 0.00] irq=33 Event=0x7b bank:3 bit:27 type:1 Jan 22 15:32:42 kernel: [ 0.00] irq=34 Event=0x32 bank:1 bit:18 type:1 Jan 22 15:32:42 kernel: [ 0.00] irq=35 Event=0x50 bank:2 bit:16 type:1 Jan 22 15:32:42 kernel: [ 0.00] irq=36 Event=0x44 bank:2 bit:4 type:1 Jan 22 15:32:42 kernel: [ 0.00] irq=37 Event=0x18 bank:0 bit:24 type:4 Jan 22 15:32:42 kernel: [ 0.00] console [ttyS0] enabled Jan 22 15:32:42 kernel: [ 0.01] Calibrating delay loop... 134.75 BogoMIPS (lpj=673792) Jan 22 15:32:42 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 15:32:42 kernel: [ 0.24] CPU: Testing write buffer coherency: ok Jan 22 15:32:42 kernel: [ 0.25] NET: Registered protocol family 16 Jan 22 15:32:42 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 15:32:42 kernel: [ 0.30] PC/104 Carrier Jan 22 15:32:42 kernel: [ 0.32] enabling USB host vbus_power Jan 22 15:32:42 kernel: [ 0.34] Registering USB host 0x00212d00 0x0ec0000a (3) Jan 22 15:32:42 kernel: [ 0.34] LPC31: Power Management init. Jan 22 15:32:42 kernel: [ 0.40] bio: create slab at 0 Jan 22 15:32:42 kernel: [ 0.41] SCSI subsystem initialized Jan 22 15:32:42 kernel: [ 0.41] usbcore: registered new interface driver usbfs Jan 22 15:32:42 kernel: [ 0.42] usbcore: registered new interface driver hub Jan 22 15:32:42 kernel: [ 0.42] usbcore: registered new device driver usb Jan 22 15:32:42 kernel: [ 0.43] Switching to clocksource clksource Jan 22 15:32:42 kernel: [ 0.44] Switched to NOHz mode on CPU #0 Jan 22 15:32:42 kernel: [ 0.44] NET: Registered protocol family 2 Jan 22 15:32:42 kernel: [ 0.44] IP route cache hash table entries: 1024 (order: 0, 4096 bytes) Jan 22 15:32:42 kernel: [ 0.44] TCP established hash table entries: 2048 (order: 2, 16384 bytes) Jan 22 15:32:42 kernel: [ 0.44] TCP bind hash table entries: 2048 (order: 1, 8192 bytes) Jan 22 15:32:42 kernel: [ 0.44] TCP: Hash tables configured (established 2048 bind 2048) Jan 22 15:32:42 kernel: [ 0.44] TCP reno registered Jan 22 15:32:42 kernel: [ 0.44] UDP hash table entries: 256 (order: 0, 4096 bytes) Jan 22 15:32:42 kernel: [ 0.44] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) Jan 22 15:32:42 kernel: [ 0.44] NET: Registered protocol family 1 Jan 22 15:32:42 kernel: [ 0.44] RPC: Registered udp transport module. Jan 22 15:32:42 kernel: [ 0.44] RPC: Registered tcp transport module. Jan 22 15:32:42 kernel: [ 0.44] RPC: Registered tcp NFSv4.1 backchannel transport module. Jan 22 15:32:42 kernel: [ 0.45] pca9532 0-0060: setting platform data Jan 22 15:32:42 kernel: [ 0.45] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 15:32:42 kernel: [ 0.47] squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 22 15:32:42 kernel: [ 0.47] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 15:32:42 kernel: [ 0.47] msgmni has been set to 120 Jan 22 15:32:42 kernel: [ 0.48] alg: No test for stdrng (krng) Jan 22 15:32:42 kernel: [ 0.48] io scheduler noop registered (default) Jan 22 15:32:42 kernel: [ 0.54] brd: module loaded Jan 22 15:32:42 kernel: [ 0.57] loop: module loaded Jan 22 15:32:42 kernel: [ 0.58] NAND device: Manufacturer ID: 0x2c, Chip ID: 0xaa (Micron NAND 256MiB 1,8V 8-bit) Jan 22 15:32:42 kernel: [ 0.58] Creating 3 MTD partitions on "lpc313x_nand": Jan 22 15:32:42 kernel: [ 0.58] 0x0000014c0000-0x000010000000 : "lpc313x-std.rootfs" Jan 22 15:32:42 kernel: [ 0.59] 0x0000004c0000-0x000010000000 : "lpc313x-big.rootfs." Jan 22 15:32:42 kernel: [ 0.59] 0x000000020000-0x000010000000 : "lpc313x-max.rootfs" Jan 22 15:32:42 kernel: [ 0.61] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 15:32:42 kernel: [ 0.61] m25p80 spi0.3: s25sl032a (4096 Kbytes) Jan 22 15:32:42 kernel: [ 0.62] spi_lpc313x spi_lpc313x.0: LPC313x SPI driver Jan 22 15:32:42 kernel: [ 0.62] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Jan 22 15:32:42 kernel: [ 0.62] lpc-ehci lpc-ehci.0: LPC EHCI Host Controller Jan 22 15:32:42 kernel: [ 0.62] lpc-ehci lpc-ehci.0: new USB bus registered, assigned bus number 1 Jan 22 15:32:42 kernel: [ 0.65] lpc-ehci lpc-ehci.0: irq 27, io mem 0x19000000 Jan 22 15:32:42 kernel: [ 0.67] lpc-ehci lpc-ehci.0: USB 2.0 started, EHCI 1.00 Jan 22 15:32:42 kernel: [ 0.67] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Jan 22 15:32:42 kernel: [ 0.67] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 22 15:32:42 kernel: [ 0.67] usb usb1: Product: LPC EHCI Host Controller Jan 22 15:32:42 kernel: [ 0.67] usb usb1: Manufacturer: Linux 2.6.33-ea3131-mbari6 ehci_hcd Jan 22 15:32:42 kernel: [ 0.67] usb usb1: SerialNumber: lpc-ehci.0 Jan 22 15:32:42 kernel: [ 0.67] hub 1-0:1.0: USB hub found Jan 22 15:32:42 kernel: [ 0.67] hub 1-0:1.0: 1 port detected Jan 22 15:32:42 kernel: [ 0.67] i2c /dev entries driver Jan 22 15:32:42 kernel: [ 0.68] lpc313x-wdt lpc313x-wdt: Watchdog device driver initialized. Jan 22 15:32:42 kernel: [ 0.68] cpuidle: using governor ladder Jan 22 15:32:42 kernel: [ 0.68] cpuidle: using governor menu Jan 22 15:32:42 kernel: [ 0.69] lpc313x_mmc lpc313x_mmc.0: LPC313x MMC controller at irq 26 Jan 22 15:32:42 kernel: [ 0.69] Serial: 8250/16550 driver, 9 ports, IRQ sharing enabled Jan 22 15:32:42 kernel: [ 0.69] serial8250: ttyS0 at MMIO 0x15001000 (irq = 10) is a NXP16750 Jan 22 15:32:42 kernel: [ 0.70] serial8250.0: ttyS0 at MMIO 0x15001000 (irq = 10) is a NXP16750 Jan 22 15:32:42 kernel: [ 0.70] serial8250.1: ttyS1 at MMIO 0x20000400 (irq = 37) is a XR16788 Jan 22 15:32:42 kernel: [ 0.71] mmc_host mmc0: card inserted Jan 22 15:32:42 kernel: [ 0.71] serial8250.1: ttyS2 at MMIO 0x20000410 (irq = 37) is a XR16788 Jan 22 15:32:42 kernel: [ 0.71] serial8250.1: ttyS3 at MMIO 0x20000420 (irq = 37) is a XR16788 Jan 22 15:32:42 kernel: [ 0.71] serial8250.1: ttyS4 at MMIO 0x20000430 (irq = 37) is a XR16788 Jan 22 15:32:42 kernel: [ 0.72] serial8250.1: ttyS5 at MMIO 0x20000440 (irq = 37) is a XR16788 Jan 22 15:32:42 kernel: [ 0.72] serial8250.1: ttyS6 at MMIO 0x20000450 (irq = 37) is a XR16788 Jan 22 15:32:42 kernel: [ 0.72] serial8250.1: ttyS7 at MMIO 0x20000460 (irq = 37) is a XR16788 Jan 22 15:32:42 kernel: [ 0.72] serial8250.1: ttyS8 at MMIO 0x20000470 (irq = 37) is a XR16788 Jan 22 15:32:42 kernel: [ 0.73] TCP cubic registered Jan 22 15:32:42 kernel: [ 0.73] NET: Registered protocol family 17 Jan 22 15:32:42 kernel: [ 0.73] Waiting for root device /dev/mmcblk0p2... Jan 22 15:32:42 kernel: [ 0.78] mmc0: no r/o switch -- assuming write-enabled Jan 22 15:32:42 kernel: [ 0.78] mmc0: new SDHC card at address aaaa Jan 22 15:32:42 kernel: [ 0.79] mmcblk0: mmc0:aaaa SS08G 7.40 GiB Jan 22 15:32:42 kernel: [ 0.79] mmcblk0: p1 p2 p3 Jan 22 15:32:42 kernel: [ 0.88] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode Jan 22 15:32:42 kernel: [ 0.88] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 15:32:42 kernel: [ 0.89] Freeing init memory: 100K Jan 22 15:32:42 kernel: [ 0.99] usb 1-1: new full speed USB device using lpc-ehci and address 2 Jan 22 15:32:42 kernel: [ 1.14] usb 1-1: not running at top speed; connect to a high speed hub Jan 22 15:32:42 kernel: [ 1.14] usb 1-1: New USB device found, idVendor=1a40, idProduct=0101 Jan 22 15:32:42 kernel: [ 1.14] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Jan 22 15:32:42 kernel: [ 1.14] usb 1-1: Product: USB 2.0 Hub Jan 22 15:32:42 kernel: [ 1.19] hub 1-1:1.0: USB hub found Jan 22 15:32:42 kernel: [ 1.19] hub 1-1:1.0: 4 ports detected Jan 22 15:32:42 kernel: [ 1.50] usb 1-1.2: new full speed USB device using lpc-ehci and address 3 Jan 22 15:32:42 kernel: [ 1.64] usb 1-1.2: New USB device found, idVendor=0403, idProduct=6015 Jan 22 15:32:42 kernel: [ 1.64] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 22 15:32:42 kernel: [ 1.64] usb 1-1.2: Product: Chipi-X Jan 22 15:32:42 kernel: [ 1.64] usb 1-1.2: Manufacturer: FTDI Jan 22 15:32:42 kernel: [ 1.64] usb 1-1.2: SerialNumber: FTYSL64Y Jan 22 15:32:42 kernel: [ 1.76] usb 1-1.3: new full speed USB device using lpc-ehci and address 4 Jan 22 15:32:42 kernel: [ 1.90] usb 1-1.3: New USB device found, idVendor=1edd, idProduct=a555 Jan 22 15:32:42 kernel: [ 1.90] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jan 22 15:32:42 kernel: [ 1.90] usb 1-1.3: Product: Iridium 9555 Handset Jan 22 15:32:42 kernel: [ 1.90] usb 1-1.3: Manufacturer: Iridium Jan 22 15:32:42 kernel: [ 2.15] ks8851_mll ks8851_mll.0: message enable is 0 Jan 22 15:32:42 kernel: [ 2.15] ks8851_mll ks8851_mll.0: Found chip, family: 0x88, id: 0x7, rev: 0x1 Jan 22 15:32:42 kernel: [ 2.15] ks8851_mll ks8851_mll.0: passed selftest Jan 22 15:32:42 kernel: [ 2.40] ds323 Jan 22 15:32:42 kernel: 4 spi0.1: Control Reg: 0x1c Jan 22 15:32:42 kernel: [ 2.40] ds3234 spi0.1: Ctrl/Stat Reg: 0x88 Jan 22 15:32:42 kernel: [ 2.41] ds3234 spi0.1: rtc core: registered ds3234 as rtc0 Jan 22 15:32:42 kernel: [ 2.58] cdc_acm 1-1.3:1.0: ttyACM0: USB ACM device Jan 22 15:32:42 kernel: [ 2.59] usbcore: registered new interface driver cdc_acm Jan 22 15:32:42 kernel: [ 2.59] cdc_acm: v0.26:USB Abstract Control Model driver for USB modems and ISDN adapters Jan 22 15:32:42 kernel: [ 2.81] usbcore: registered new interface driver usbserial Jan 22 15:32:42 kernel: [ 2.83] USB Serial support registered for generic Jan 22 15:32:42 kernel: [ 2.84] usbcore: registered new interface driver usbserial_generic Jan 22 15:32:42 kernel: [ 2.84] usbserial: USB Serial Driver core Jan 22 15:32:42 kernel: [ 2.93] USB Serial support registered for FTDI USB Serial Device Jan 22 15:32:42 kernel: [ 2.93] ftdi_sio 1-1.2:1.0: FTDI USB Serial Device converter detected Jan 22 15:32:42 kernel: [ 2.93] usb 1-1.2: Detected FT232RL Jan 22 15:32:42 kernel: [ 2.93] usb 1-1.2: Number of endpoints 2 Jan 22 15:32:42 kernel: [ 2.93] usb 1-1.2: Endpoint 1 MaxPacketSize 64 Jan 22 15:32:42 kernel: [ 2.93] usb 1-1.2: Endpoint 2 MaxPacketSize 64 Jan 22 15:32:42 kernel: [ 2.93] usb 1-1.2: Setting MaxPacketSize 64 Jan 22 15:32:42 kernel: [ 2.96] usb 1-1.2: FTDI USB Serial Device converter now attached to ttyUSB0 Jan 22 15:32:42 kernel: [ 2.97] usbcore: registered new interface driver ftdi_sio Jan 22 15:32:42 kernel: [ 2.97] ftdi_sio: v1.5.0:USB FTDI Serial Converters Driver Jan 22 15:32:42 kernel: [ 3.28] Adding 102392k swap on /.SWAP. Priority:-1 extents:1 across:102392k SS Jan 22 15:32:44 IridiumLocation: -2692,-4344,3796,772783bf Jan 22 15:33:04 ringBack[437]: Awaiting RING on /dev/modem to {sleep 60; ifup iridium} Jan 22 15:39:10 login[432]: root login on 'ttyS0' Jan 22 15:39:44 kernel: [ 426.00] PPP generic driver version 2.4.2 Jan 22 15:39:44 pppd[717]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 15:39:44 pppd[717]: Using interface ppp5 Jan 22 15:39:45 chat[729]: timeout set to 8 seconds Jan 22 15:39:45 chat[729]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 15:39:47 chat[729]: expect (OK^M) Jan 22 15:39:47 chat[729]: ^M Jan 22 15:39:47 chat[729]: OK^M Jan 22 15:39:47 chat[729]: -- got it Jan 22 15:39:47 chat[729]: send () Jan 22 15:39:48 chat[724]: abort on (NO CARRIER) Jan 22 15:39:48 chat[724]: abort on (NO DIALTONE) Jan 22 15:39:48 chat[724]: abort on (ERROR) Jan 22 15:39:48 chat[724]: abort on (NO ANSWER) Jan 22 15:39:48 chat[724]: abort on (BUSY) Jan 22 15:39:48 chat[724]: abort on (Username/Password Incorrect) Jan 22 15:39:48 chat[724]: timeout set to 10 seconds Jan 22 15:39:48 chat[724]: send (AT+CBST=71,0,1^M) Jan 22 15:39:48 chat[724]: expect (OK^M) Jan 22 15:39:48 chat[724]: Jan 22 15:39:48 chat[724]: ^M Jan 22 15:39:48 chat[724]: OK^M Jan 22 15:39:48 chat[724]: -- got it Jan 22 15:39:48 chat[724]: send (AT+CSQF^M) Jan 22 15:39:48 chat[724]: expect (OK^M) Jan 22 15:39:48 chat[724]: Jan 22 15:39:48 chat[724]: ^M Jan 22 15:39:48 chat[724]: +CSQF:5^M Jan 22 15:39:48 chat[724]: ^M Jan 22 15:39:48 chat[724]: OK^M Jan 22 15:39:48 chat[724]: -- got it Jan 22 15:39:48 chat[724]: send () Jan 22 15:39:48 chat[724]: timeout set to 150 seconds Jan 22 15:39:48 chat[724]: send (ATD008816000025^M) Jan 22 15:39:48 chat[724]: expect (CONNECT) Jan 22 15:39:48 chat[724]: Jan 22 15:40:02 chat[724]: ^M Jan 22 15:40:02 chat[724]: CONNECT Jan 22 15:40:02 chat[724]: -- got it Jan 22 15:40:02 chat[724]: send () Jan 22 15:40:02 pppd[717]: Serial connection established. Jan 22 15:40:02 pppd[717]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 15:40:06 pppd[717]: CHAP authentication succeeded Jan 22 15:40:06 pppd[717]: CHAP authentication succeeded Jan 22 15:40:06 kernel: [ 448.54] PPP BSD Compression module registered Jan 22 15:40:07 kernel: [ 448.63] PPP Deflate Compression module registered Jan 22 15:40:12 pppd[717]: local IP address 192.168.11.56 Jan 22 15:40:12 pppd[717]: remote IP address 192.168.11.254 Jan 22 15:40:12 pppd[717]: primary DNS address 12.127.17.72 Jan 22 15:40:12 pppd[717]: secondary DNS address 204.97.212.10 Jan 22 15:40:13 pppd[745]: CCP terminated by peer Jan 22 15:40:13 pppd[745]: Compression disabled by peer. Jan 22 15:40:18 tunnel2shore[436]: Opening tunnel to ESPshore Jan 22 15:40:24 su: + /dev/ttyS0 root:esp Jan 22 15:45:01 pppd[745]: Modem hangup Jan 22 15:45:01 pppd[745]: Connect time 4.9 minutes. Jan 22 15:45:01 pppd[745]: Sent 69873 bytes, received 9670 bytes. Jan 22 15:45:01 pppd[745]: Connection terminated. Jan 22 15:45:03 pppd[745]: Exit. Jan 22 15:49:59 pppd[850]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 15:49:59 pppd[850]: Using interface ppp5 Jan 22 15:50:00 chat[856]: timeout set to 8 seconds Jan 22 15:50:00 chat[856]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 15:50:03 chat[856]: expect (OK^M) Jan 22 15:50:03 chat[856]: ^M^M Jan 22 15:50:03 chat[856]: OK^M Jan 22 15:50:03 chat[856]: -- got it Jan 22 15:50:03 chat[856]: send () Jan 22 15:50:03 chat[851]: abort on (NO CARRIER) Jan 22 15:50:03 chat[851]: abort on (NO DIALTONE) Jan 22 15:50:03 chat[851]: abort on (ERROR) Jan 22 15:50:03 chat[851]: abort on (NO ANSWER) Jan 22 15:50:03 chat[851]: abort on (BUSY) Jan 22 15:50:03 chat[851]: abort on (Username/Password Incorrect) Jan 22 15:50:03 chat[851]: timeout set to 10 seconds Jan 22 15:50:03 chat[851]: send (AT+CBST=71,0,1^M) Jan 22 15:50:03 chat[851]: expect (OK^M) Jan 22 15:50:03 chat[851]: Jan 22 15:50:03 chat[851]: ^M Jan 22 15:50:03 chat[851]: OK^M Jan 22 15:50:03 chat[851]: -- got it Jan 22 15:50:03 chat[851]: send (AT+CSQF^M) Jan 22 15:50:03 chat[851]: expect (OK^M) Jan 22 15:50:03 chat[851]: Jan 22 15:50:03 chat[851]: ^M Jan 22 15:50:03 chat[851]: +CSQF:5^M Jan 22 15:50:03 chat[851]: ^M Jan 22 15:50:03 chat[851]: OK^M Jan 22 15:50:03 chat[851]: -- got it Jan 22 15:50:03 chat[851]: send () Jan 22 15:50:03 chat[851]: timeout set to 150 seconds Jan 22 15:50:03 chat[851]: send (ATD008816000025^M) Jan 22 15:50:04 chat[851]: expect (CONNECT) Jan 22 15:50:04 chat[851]: Jan 22 15:50:10 chat[851]: ^M Jan 22 15:50:10 chat[851]: CONNECT Jan 22 15:50:10 chat[851]: -- got it Jan 22 15:50:10 chat[851]: send () Jan 22 15:50:10 pppd[850]: Serial connection established. Jan 22 15:50:10 pppd[850]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 15:50:16 pppd[850]: Terminating on signal 2 Jan 22 15:50:17 pppd[850]: Connection terminated. Jan 22 15:50:18 pppd[850]: Exit. Jan 22 15:51:38 pppd[867]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 15:51:38 pppd[867]: Using interface ppp5 Jan 22 15:51:40 chat[873]: timeout set to 8 seconds Jan 22 15:51:40 chat[873]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 15:51:42 chat[873]: expect (OK^M) Jan 22 15:51:42 chat[873]: ^M Jan 22 15:51:42 chat[873]: OK^M Jan 22 15:51:42 chat[873]: -- got it Jan 22 15:51:42 chat[873]: send () Jan 22 15:51:42 chat[868]: abort on (NO CARRIER) Jan 22 15:51:42 chat[868]: abort on (NO DIALTONE) Jan 22 15:51:42 chat[868]: abort on (ERROR) Jan 22 15:51:42 chat[868]: abort on (NO ANSWER) Jan 22 15:51:42 chat[868]: abort on (BUSY) Jan 22 15:51:42 chat[868]: abort on (Username/Password Incorrect) Jan 22 15:51:42 chat[868]: timeout set to 10 seconds Jan 22 15:51:42 chat[868]: send (AT+CBST=71,0,1^M) Jan 22 15:51:42 chat[868]: expect (OK^M) Jan 22 15:51:42 chat[868]: Jan 22 15:51:42 chat[868]: ^M Jan 22 15:51:42 chat[868]: OK^M Jan 22 15:51:42 chat[868]: -- got it Jan 22 15:51:42 chat[868]: send (AT+CSQF^M) Jan 22 15:51:42 chat[868]: expect (OK^M) Jan 22 15:51:42 chat[868]: Jan 22 15:51:42 chat[868]: ^M Jan 22 15:51:42 chat[868]: +CSQF:4^M Jan 22 15:51:42 chat[868]: ^M Jan 22 15:51:42 chat[868]: OK^M Jan 22 15:51:42 chat[868]: -- got it Jan 22 15:51:42 chat[868]: send () Jan 22 15:51:42 chat[868]: timeout set to 150 seconds Jan 22 15:51:42 chat[868]: send (ATD008816000025^M) Jan 22 15:51:43 chat[868]: expect (CONNECT) Jan 22 15:51:43 chat[868]: Jan 22 15:51:51 chat[868]: ^M Jan 22 15:51:51 chat[868]: CONNECT Jan 22 15:51:51 chat[868]: -- got it Jan 22 15:51:51 chat[868]: send () Jan 22 15:51:51 pppd[867]: Serial connection established. Jan 22 15:51:51 pppd[867]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 15:51:55 pppd[867]: CHAP authentication succeeded Jan 22 15:51:55 pppd[867]: CHAP authentication succeeded Jan 22 15:52:01 pppd[867]: local IP address 192.168.11.57 Jan 22 15:52:01 pppd[867]: remote IP address 192.168.11.254 Jan 22 15:52:01 pppd[867]: primary DNS address 12.127.17.72 Jan 22 15:52:01 pppd[867]: secondary DNS address 204.97.212.10 Jan 22 15:52:01 su: + /dev/ttyS0 root:esp Jan 22 15:52:02 pppd[879]: CCP terminated by peer Jan 22 15:52:02 pppd[879]: Compression disabled by peer. Jan 22 15:52:07 tunnel2shore[436]: Opening tunnel to ESPshore Jan 22 15:54:35 pppd[879]: Modem hangup Jan 22 15:54:35 pppd[879]: Connect time 2.6 minutes. Jan 22 15:54:35 pppd[879]: Sent 34095 bytes, received 9554 bytes. Jan 22 15:54:35 pppd[879]: Connection terminated. Jan 22 15:54:35 pppd[879]: Exit. Jan 22 15:56:32 pppd[1030]: pppd 2.4.5-mbari3 started by root, uid 0 Jan 22 15:56:32 pppd[1030]: Using interface ppp5 Jan 22 15:56:33 chat[1036]: timeout set to 8 seconds Jan 22 15:56:33 chat[1036]: send (\d\p\p+++\d\p\pATE0H0^M^M) Jan 22 15:56:35 chat[1036]: expect (OK^M) Jan 22 15:56:35 chat[1036]: ^M Jan 22 15:56:35 chat[1036]: OK^M Jan 22 15:56:35 chat[1036]: -- got it Jan 22 15:56:35 chat[1036]: send () Jan 22 15:56:35 chat[1031]: abort on (NO CARRIER) Jan 22 15:56:35 chat[1031]: abort on (NO DIALTONE) Jan 22 15:56:35 chat[1031]: abort on (ERROR) Jan 22 15:56:35 chat[1031]: abort on (NO ANSWER) Jan 22 15:56:35 chat[1031]: abort on (BUSY) Jan 22 15:56:35 chat[1031]: abort on (Username/Password Incorrect) Jan 22 15:56:35 chat[1031]: timeout set to 10 seconds Jan 22 15:56:36 chat[1031]: send (AT+CBST=71,0,1^M) Jan 22 15:56:36 chat[1031]: expect (OK^M) Jan 22 15:56:36 chat[1031]: Jan 22 15:56:36 chat[1031]: ^M Jan 22 15:56:36 chat[1031]: OK^M Jan 22 15:56:36 chat[1031]: -- got it Jan 22 15:56:36 chat[1031]: send (AT+CSQF^M) Jan 22 15:56:36 chat[1031]: expect (OK^M) Jan 22 15:56:36 chat[1031]: Jan 22 15:56:36 chat[1031]: ^M Jan 22 15:56:36 chat[1031]: +CSQF:5^M Jan 22 15:56:36 chat[1031]: ^M Jan 22 15:56:36 chat[1031]: OK^M Jan 22 15:56:36 chat[1031]: -- got it Jan 22 15:56:36 chat[1031]: send () Jan 22 15:56:36 chat[1031]: timeout set to 150 seconds Jan 22 15:56:36 chat[1031]: send (ATD008816000025^M) Jan 22 15:56:36 chat[1031]: expect (CONNECT) Jan 22 15:56:36 chat[1031]: Jan 22 15:56:44 chat[1031]: ^M Jan 22 15:56:44 chat[1031]: CONNECT Jan 22 15:56:44 chat[1031]: -- got it Jan 22 15:56:44 chat[1031]: send () Jan 22 15:56:44 pppd[1030]: Serial connection established. Jan 22 15:56:44 pppd[1030]: Connect: ppp5 <--> /dev/AT/iridium Jan 22 15:56:49 pppd[1030]: CHAP authentication succeeded Jan 22 15:56:49 pppd[1030]: CHAP authentication succeeded Jan 22 15:56:54 pppd[1030]: local IP address 192.168.20.110 Jan 22 15:56:54 pppd[1030]: remote IP address 192.168.20.254 Jan 22 15:56:54 pppd[1030]: primary DNS address 199.2.252.10 Jan 22 15:56:54 pppd[1030]: secondary DNS address 204.97.212.10 Jan 22 15:56:55 pppd[1042]: CCP terminated by peer Jan 22 15:56:55 pppd[1042]: Compression disabled by peer. Jan 22 15:57:00 tunnel2shore[436]: Opening tunnel to ESPshore Jan 22 15:57:10 pppd[1042]: Terminating on signal 15 Jan 22 15:57:10 pppd[1042]: Connect time 0.3 minutes. Jan 22 15:57:10 pppd[1042]: Sent 1457 bytes, received 726 bytes. Jan 22 15:57:11 pppd[1042]: Connection terminated. Jan 22 15:57:12 pppd[1042]: Exit. Jan 22 16:01:25 login[1129]: root login on 'ttyS0' Jan 22 16:02:32 su: + /dev/ttyS0 root:esp Jan 22 16:05:00 init: Switching to runlevel: 6 Jan 22 16:05:09 syslogd exiting Jan 22 16:05:18 syslogd started: BusyBox v1.11.2 Jan 22 16:05:18 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 16:05:18 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 16:05:18 kernel: [ 0.00] Machine: NXP EA313X Jan 22 16:05:18 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 16:05:18 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 16:05:18 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 16:05:18 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 16:05:18 kernel: [ 0.29] PC/104 Carrier Jan 22 16:05:18 kernel: [ 0.39] bio: create slab at 0 Jan 22 16:05:18 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 16:05:18 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 16:05:18 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 16:05:18 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 16:05:20 IridiumLocation: -2692,-4348,3796,7727df99 Jan 22 16:38:26 syslogd exiting Jan 22 16:57:19 syslogd started: BusyBox v1.11.2 Jan 22 16:57:19 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 16:57:19 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 16:57:19 kernel: [ 0.00] Machine: NXP EA313X Jan 22 16:57:19 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 16:57:19 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 16:57:19 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 16:57:19 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 16:57:19 kernel: [ 0.29] PC/104 Carrier Jan 22 16:57:19 kernel: [ 0.39] bio: create slab at 0 Jan 22 16:57:19 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 16:57:19 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 16:57:19 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 16:57:19 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 16:57:22 IridiumLocation: -2688,-4344,3800,77287cf1 Jan 22 16:58:48 pppd[876]: Connect script failed Jan 22 17:16:02 syslogd exiting Jan 22 19:58:41 syslogd started: BusyBox v1.11.2 Jan 22 19:58:41 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 19:58:41 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 19:58:41 kernel: [ 0.00] Machine: NXP EA313X Jan 22 19:58:41 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 19:58:41 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 19:58:41 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 19:58:41 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 19:58:41 kernel: [ 0.29] PC/104 Carrier Jan 22 19:58:41 kernel: [ 0.39] bio: create slab at 0 Jan 22 19:58:41 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 19:58:41 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 19:58:41 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 19:58:41 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 19:58:43 IridiumLocation: -2688,-4344,3800,77287fa1 Jan 22 20:24:07 syslogd exiting Jan 22 20:24:16 syslogd started: BusyBox v1.11.2 Jan 22 20:24:16 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 20:24:16 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 20:24:16 kernel: [ 0.00] Machine: NXP EA313X Jan 22 20:24:16 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 20:24:16 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 20:24:16 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 20:24:16 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 20:24:16 kernel: [ 0.29] PC/104 Carrier Jan 22 20:24:16 kernel: [ 0.39] bio: create slab at 0 Jan 22 20:24:16 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 20:24:16 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 20:24:16 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 20:24:16 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 20:24:18 IridiumLocation: -2688,-4344,3800,77287fa1 Jan 22 20:26:03 syslogd exiting Jan 22 20:26:12 syslogd started: BusyBox v1.11.2 Jan 22 20:26:12 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 20:26:12 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 20:26:12 kernel: [ 0.00] Machine: NXP EA313X Jan 22 20:26:12 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 20:26:12 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 20:26:12 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 20:26:12 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 20:26:12 kernel: [ 0.29] PC/104 Carrier Jan 22 20:26:12 kernel: [ 0.39] bio: create slab at 0 Jan 22 20:26:12 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 20:26:12 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 20:26:12 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 20:26:12 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 20:26:14 IridiumLocation: -2688,-4344,3800,77287fa1 Jan 22 20:59:17 syslogd exiting Jan 22 22:58:41 syslogd started: BusyBox v1.11.2 Jan 22 22:58:41 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 22 22:58:41 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 22 22:58:41 kernel: [ 0.00] Machine: NXP EA313X Jan 22 22:58:41 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 22 22:58:41 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 22 22:58:41 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 22 22:58:41 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 22 22:58:41 kernel: [ 0.29] PC/104 Carrier Jan 22 22:58:41 kernel: [ 0.39] bio: create slab at 0 Jan 22 22:58:41 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 22 22:58:41 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 22 22:58:41 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 22 22:58:41 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 22 22:58:43 IridiumLocation: -2692,-4344,3800,772aef49 Jan 22 23:33:47 syslogd exiting Jan 23 02:58:41 syslogd started: BusyBox v1.11.2 Jan 23 02:58:41 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 23 02:58:41 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 23 02:58:41 kernel: [ 0.00] Machine: NXP EA313X Jan 23 02:58:41 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 23 02:58:41 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 23 02:58:41 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 23 02:58:41 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 23 02:58:41 kernel: [ 0.29] PC/104 Carrier Jan 23 02:58:41 kernel: [ 0.39] bio: create slab at 0 Jan 23 02:58:41 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 23 02:58:41 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 23 02:58:41 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 23 02:58:41 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 23 02:58:43 IridiumLocation: -2688,-4348,3796,772c8168 Jan 23 03:32:35 syslogd exiting Jan 23 04:58:41 syslogd started: BusyBox v1.11.2 Jan 23 04:58:41 kernel: [ 0.00] CPU: ARM926EJ-S [41069265] revision 5 (ARMv5TEJ), cr=00053177 Jan 23 04:58:41 kernel: [ 0.00] CPU: VIVT data cache, VIVT instruction cache Jan 23 04:58:41 kernel: [ 0.00] Machine: NXP EA313X Jan 23 04:58:41 kernel: [ 0.00] Memory policy: ECC disabled, Data cache writeback Jan 23 04:58:41 kernel: [ 0.00] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 16256 Jan 23 04:58:41 kernel: [ 0.24] Mount-cache hash table entries: 512 Jan 23 04:58:41 kernel: [ 0.26] cgu_init pll set at 270000000 Jan 23 04:58:41 kernel: [ 0.29] PC/104 Carrier Jan 23 04:58:41 kernel: [ 0.39] bio: create slab at 0 Jan 23 04:58:41 kernel: [ 0.44] NetWinder Floating Point Emulator V0.97 (double precision) Jan 23 04:58:41 kernel: [ 0.46] yaffs Oct 28 2019 17:55:26 Installing. Jan 23 04:58:41 kernel: [ 0.60] m25p80 spi0.3: m25p80 found s25sl032a flash Jan 23 04:58:41 kernel: [ 0.87] VFS: Mounted root (ext2 filesystem) readonly on device 179:2. Jan 23 04:58:43 IridiumLocation: -2692,-4344,3800,772eef0d