Oct 15 04:32:59 almursi kernel: [ 4757.764781] usb 1-3: USB disconnect, address 47 Oct 15 04:32:59 almursi kernel: [ 4757.764938] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Oct 15 04:32:59 almursi kernel: [ 4757.764957] option 1-3:1.0: device disconnected Oct 15 04:32:59 almursi kernel: [ 4757.765059] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Oct 15 04:32:59 almursi kernel: [ 4757.765077] option 1-3:1.1: device disconnected Oct 15 04:32:59 almursi kernel: [ 4757.765177] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 Oct 15 04:32:59 almursi kernel: [ 4757.765193] option 1-3:1.2: device disconnected Oct 15 04:32:59 almursi kernel: [ 4757.765297] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 Oct 15 04:32:59 almursi kernel: [ 4757.765314] option 1-3:1.3: device disconnected Oct 15 04:32:59 almursi kernel: [ 4757.765439] option: option_instat_callback: error -108 Oct 15 04:32:59 almursi kernel: [ 4757.765494] option1 ttyUSB4: GSM modem (1-port) converter now disconnected from ttyUSB4 Oct 15 04:32:59 almursi kernel: [ 4757.765511] option 1-3:1.4: device disconnected Oct 15 04:32:59 almursi kernel: [ 4757.765634] option: option_instat_callback: error -108 Oct 15 04:32:59 almursi kernel: [ 4757.765687] option1 ttyUSB5: GSM modem (1-port) converter now disconnected from ttyUSB5 Oct 15 04:32:59 almursi kernel: [ 4757.765704] option 1-3:1.5: device disconnected Oct 15 04:32:59 almursi modem-manager[20043]: (tty/ttyUSB2): released by modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 Oct 15 04:32:59 almursi NetworkManager[1073]: (ttyUSB2): now unmanaged Oct 15 04:32:59 almursi NetworkManager[1073]: (ttyUSB2): device state change: 3 -> 1 (reason 36) Oct 15 04:32:59 almursi NetworkManager[1073]: (ttyUSB2): cleaning up... Oct 15 04:32:59 almursi NetworkManager[1073]: (ttyUSB2): taking down device. Oct 15 04:32:59 almursi NetworkManager[1073]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Oct 15 04:32:59 almursi NetworkManager[1073]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Oct 15 04:33:07 almursi kernel: [ 4766.024013] usb 1-3: new high speed USB device using ehci_hcd and address 48 Oct 15 04:33:08 almursi kernel: [ 4766.172029] scsi16 : usb-storage 1-3:1.0 Oct 15 04:33:09 almursi kernel: [ 4767.181228] scsi 16:0:0:0: CD-ROM ZTE USB SCSI CD-ROM 2.31 PQ: 0 ANSI: 2 Oct 15 04:33:09 almursi kernel: [ 4767.191077] sr1: scsi-1 drive Oct 15 04:33:09 almursi kernel: [ 4767.192881] sr 16:0:0:0: Attached scsi CD-ROM sr1 Oct 15 04:33:09 almursi kernel: [ 4767.194091] sr 16:0:0:0: Attached scsi generic sg4 type 5 Oct 15 04:33:26 almursi kernel: [ 4784.333701] ISO 9660 Extensions: Microsoft Joliet Level 3 Oct 15 04:33:26 almursi kernel: [ 4784.335326] ISOFS: changing to secondary root Oct 15 04:33:51 almursi kernel: [ 4810.001476] usb 1-3: USB disconnect, address 48 Oct 15 04:33:56 almursi kernel: [ 4815.032027] usb 1-3: new high speed USB device using ehci_hcd and address 49 Oct 15 04:33:57 almursi kernel: [ 4815.171349] option 1-3:1.0: GSM modem (1-port) converter detected Oct 15 04:33:57 almursi kernel: [ 4815.171441] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB0 Oct 15 04:33:57 almursi kernel: [ 4815.171541] option 1-3:1.1: GSM modem (1-port) converter detected Oct 15 04:33:57 almursi kernel: [ 4815.171615] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB1 Oct 15 04:33:57 almursi kernel: [ 4815.171703] option 1-3:1.2: GSM modem (1-port) converter detected Oct 15 04:33:57 almursi kernel: [ 4815.171773] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB2 Oct 15 04:33:57 almursi kernel: [ 4815.171863] option 1-3:1.3: GSM modem (1-port) converter detected Oct 15 04:33:57 almursi kernel: [ 4815.171931] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB3 Oct 15 04:33:57 almursi kernel: [ 4815.172040] option 1-3:1.4: GSM modem (1-port) converter detected Oct 15 04:33:57 almursi kernel: [ 4815.172133] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB4 Oct 15 04:33:57 almursi kernel: [ 4815.172238] option 1-3:1.5: GSM modem (1-port) converter detected Oct 15 04:33:57 almursi kernel: [ 4815.172323] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB5 Oct 15 04:33:57 almursi kernel: [ 4815.189265] scsi17 : usb-storage 1-3:1.6 Oct 15 04:33:57 almursi modem-manager[20043]: (ttyUSB1) opening serial port... Oct 15 04:33:57 almursi modem-manager[20043]: (ttyUSB0) opening serial port... Oct 15 04:33:57 almursi modem-manager[20043]: (ttyUSB2) opening serial port... Oct 15 04:33:57 almursi modem-manager[20043]: (ttyUSB4) opening serial port... Oct 15 04:33:57 almursi modem-manager[20043]: (ttyUSB3) opening serial port... Oct 15 04:33:57 almursi modem-manager[20043]: (ttyUSB5) opening serial port... Oct 15 04:33:58 almursi kernel: [ 4816.189960] scsi 17:0:0:0: Direct-Access ZTE MMC Storage 2.31 PQ: 0 ANSI: 2 Oct 15 04:33:58 almursi kernel: [ 4816.190579] sd 17:0:0:0: Attached scsi generic sg4 type 0 Oct 15 04:33:58 almursi kernel: [ 4816.194293] sd 17:0:0:0: [sdd] Attached SCSI removable disk Oct 15 04:34:34 almursi modem-manager[20043]: (ttyUSB1) closing serial port... Oct 15 04:34:34 almursi modem-manager[20043]: (ttyUSB1) serial port closed Oct 15 04:34:34 almursi modem-manager[20043]: (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 claimed port ttyUSB1 Oct 15 04:34:34 almursi modem-manager[20043]: (ttyUSB2) closing serial port... Oct 15 04:34:34 almursi modem-manager[20043]: (ttyUSB2) serial port closed Oct 15 04:34:34 almursi modem-manager[20043]: (ttyUSB4) closing serial port... Oct 15 04:34:34 almursi modem-manager[20043]: (ttyUSB4) serial port closed Oct 15 04:34:34 almursi modem-manager[20043]: (ttyUSB2) opening serial port... Oct 15 04:34:34 almursi modem-manager[20043]: (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 claimed port ttyUSB2 Oct 15 04:34:34 almursi modem-manager[20043]: mm_modem_base_add_port: assertion `port == NULL' failed Oct 15 04:34:34 almursi modem-manager[20043]: (mm-generic-gsm.c:794):mm_generic_gsm_grab_port: runtime check failed: (port != NULL) Oct 15 04:34:34 almursi modem-manager[20043]: plugin 'ZTE' claimed to support tty/ttyUSB4 but couldn't: (-1) (unknown) Oct 15 04:34:34 almursi modem-manager[20043]: (ttyUSB2) closing serial port... Oct 15 04:34:34 almursi modem-manager[20043]: (ttyUSB2) serial port closed Oct 15 04:34:43 almursi modem-manager[20043]: (ttyUSB0) closing serial port... Oct 15 04:34:43 almursi modem-manager[20043]: (ttyUSB0) serial port closed Oct 15 04:34:43 almursi modem-manager[20043]: (ttyUSB0) opening serial port... Oct 15 04:34:45 almursi modem-manager[20043]: (ttyUSB3) closing serial port... Oct 15 04:34:45 almursi modem-manager[20043]: (ttyUSB3) serial port closed Oct 15 04:34:45 almursi modem-manager[20043]: (ttyUSB3) opening serial port... Oct 15 04:34:46 almursi modem-manager[20043]: (ttyUSB5) closing serial port... Oct 15 04:34:46 almursi modem-manager[20043]: (ttyUSB5) serial port closed Oct 15 04:34:46 almursi modem-manager[20043]: (ttyUSB5) opening serial port... Oct 15 04:34:46 almursi modem-manager[20043]: (ttyUSB0) closing serial port... Oct 15 04:34:46 almursi modem-manager[20043]: (ttyUSB0) serial port closed Oct 15 04:34:46 almursi modem-manager[20043]: (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 claimed port ttyUSB0 Oct 15 04:34:51 almursi modem-manager[20043]: (ttyUSB3) closing serial port... Oct 15 04:34:51 almursi modem-manager[20043]: (ttyUSB3) serial port closed Oct 15 04:34:52 almursi modem-manager[20043]: (ttyUSB5) closing serial port... Oct 15 04:34:52 almursi modem-manager[20043]: (ttyUSB5) serial port closed Oct 15 04:34:52 almursi NetworkManager[1073]: (ttyUSB2): failed to look up interface index Oct 15 04:34:52 almursi NetworkManager[1073]: (ttyUSB2): new GSM device (driver: 'option1' ifindex: -1) Oct 15 04:34:52 almursi NetworkManager[1073]: (ttyUSB2): exported as /org/freedesktop/NetworkManager/Devices/5 Oct 15 04:34:52 almursi NetworkManager[1073]: (ttyUSB2): now managed Oct 15 04:34:52 almursi NetworkManager[1073]: (ttyUSB2): device state change: 1 -> 2 (reason 2) Oct 15 04:34:52 almursi NetworkManager[1073]: (ttyUSB2): deactivating device (reason: 2). Oct 15 04:34:52 almursi NetworkManager[1073]: (ttyUSB2): device state change: 2 -> 3 (reason 0) Oct 15 04:35:00 almursi NetworkManager[1073]: Activation (ttyUSB2) starting connection 'Auto Movistar (Telefónica) solo CHAP' Oct 15 04:35:00 almursi NetworkManager[1073]: (ttyUSB2): device state change: 3 -> 4 (reason 0) Oct 15 04:35:00 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) scheduled... Oct 15 04:35:00 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) started... Oct 15 04:35:00 almursi NetworkManager[1073]: (ttyUSB2): device state change: 4 -> 6 (reason 0) Oct 15 04:35:00 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) complete. Oct 15 04:35:00 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) scheduled... Oct 15 04:35:00 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) started... Oct 15 04:35:00 almursi NetworkManager[1073]: (ttyUSB2): device state change: 6 -> 4 (reason 0) Oct 15 04:35:00 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) complete. Oct 15 04:35:00 almursi NetworkManager[1073]: GSM modem enable failed: (32) SIM PIN required Oct 15 04:35:00 almursi modem-manager[20043]: (ttyUSB2) opening serial port... Oct 15 04:35:01 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: unlock no longer required Oct 15 04:35:01 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: # unlock retries is 0 Oct 15 04:35:02 almursi modem-manager[20043]: (ttyUSB2) closing serial port... Oct 15 04:35:02 almursi modem-manager[20043]: (ttyUSB2) serial port closed Oct 15 04:35:02 almursi modem-manager[20043]: (ttyUSB2) opening serial port... Oct 15 04:35:02 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabled -> enabling) Oct 15 04:35:04 almursi modem-manager[20043]: (ttyUSB1) opening serial port... Oct 15 04:35:04 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabling -> enabled) Oct 15 04:35:04 almursi NetworkManager[1073]: WWAN now enabled by management service Oct 15 04:35:04 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabled -> registered) Oct 15 04:35:05 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (registered -> connecting) Oct 15 04:35:05 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (connecting -> connected) Oct 15 04:35:05 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 2 of 5 (Device Configure) scheduled... Oct 15 04:35:05 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 2 of 5 (Device Configure) starting... Oct 15 04:35:05 almursi NetworkManager[1073]: (ttyUSB2): device state change: 4 -> 5 (reason 0) Oct 15 04:35:05 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 2 of 5 (Device Configure) successful. Oct 15 04:35:05 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 3 of 5 (IP Configure Start) scheduled. Oct 15 04:35:05 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 2 of 5 (Device Configure) complete. Oct 15 04:35:05 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 3 of 5 (IP Configure Start) started... Oct 15 04:35:05 almursi NetworkManager[1073]: (ttyUSB2): device state change: 5 -> 7 (reason 0) Oct 15 04:35:05 almursi NetworkManager[1073]: starting PPP connection Oct 15 04:35:05 almursi NetworkManager[1073]: pppd started with pid 30243 Oct 15 04:35:05 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 3 of 5 (IP Configure Start) complete. Oct 15 04:35:05 almursi pppd[30243]: Plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so loaded. Oct 15 04:35:05 almursi pppd[30243]: pppd 2.4.5 started by root, uid 0 Oct 15 04:35:05 almursi pppd[30243]: Removed stale lock on ttyUSB2 (pid 25860) Oct 15 04:35:05 almursi pppd[30243]: Using interface ppp0 Oct 15 04:35:05 almursi pppd[30243]: Connect: ppp0 <--> /dev/ttyUSB2 Oct 15 04:35:05 almursi NetworkManager[1073]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Oct 15 04:35:05 almursi NetworkManager[1073]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Oct 15 04:35:25 almursi NetworkManager[1073]: pppd timed out or didn't initialize our dbus module Oct 15 04:35:25 almursi NetworkManager[1073]: (ttyUSB2): device state change: 7 -> 9 (reason 5) Oct 15 04:35:25 almursi pppd[30243]: Terminating on signal 15 Oct 15 04:35:25 almursi NetworkManager[1073]: Marking connection 'Auto Movistar (Telefónica) solo CHAP' invalid. Oct 15 04:35:25 almursi NetworkManager[1073]: Activation (ttyUSB2) failed. Oct 15 04:35:25 almursi NetworkManager[1073]: (ttyUSB2): device state change: 9 -> 3 (reason 0) Oct 15 04:35:25 almursi NetworkManager[1073]: (ttyUSB2): deactivating device (reason: 0). Oct 15 04:35:25 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (connected -> disconnecting) Oct 15 04:35:26 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (disconnecting -> registered) Oct 15 04:35:27 almursi avahi-daemon[1009]: Withdrawing workstation service for ppp0. Oct 15 04:35:27 almursi NetworkManager[1073]: SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Oct 15 04:35:41 almursi NetworkManager[1073]: Activation (ttyUSB2) starting connection 'Auto Movistar (Telefónica) solo CHAP' Oct 15 04:35:41 almursi NetworkManager[1073]: (ttyUSB2): device state change: 3 -> 4 (reason 0) Oct 15 04:35:41 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) scheduled... Oct 15 04:35:41 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) started... Oct 15 04:35:41 almursi NetworkManager[1073]: (ttyUSB2): device state change: 4 -> 6 (reason 0) Oct 15 04:35:41 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) complete. Oct 15 04:35:41 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) scheduled... Oct 15 04:35:41 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) started... Oct 15 04:35:41 almursi NetworkManager[1073]: (ttyUSB2): device state change: 6 -> 4 (reason 0) Oct 15 04:35:41 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) complete. Oct 15 04:35:47 almursi NetworkManager[1073]: GSM connection failed: (32) Sending command failed: 'Resource temporarily unavailable' Oct 15 04:35:47 almursi NetworkManager[1073]: (ttyUSB2): device state change: 4 -> 9 (reason 1) Oct 15 04:35:47 almursi NetworkManager[1073]: Marking connection 'Auto Movistar (Telefónica) solo CHAP' invalid. Oct 15 04:35:47 almursi NetworkManager[1073]: Activation (ttyUSB2) failed. Oct 15 04:35:47 almursi NetworkManager[1073]: (ttyUSB2): device state change: 9 -> 3 (reason 0) Oct 15 04:35:47 almursi NetworkManager[1073]: (ttyUSB2): deactivating device (reason: 0). Oct 15 04:36:07 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (registered -> disabling) Oct 15 04:36:07 almursi modem-manager[20043]: (ttyUSB2) closing serial port... Oct 15 04:36:07 almursi modem-manager[20043]: (ttyUSB2) serial port closed Oct 15 04:36:07 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabling -> disabled) Oct 15 04:36:07 almursi NetworkManager[1073]: WWAN now disabled by management service Oct 15 04:36:07 almursi modem-manager[20043]: (ttyUSB1) closing serial port... Oct 15 04:36:07 almursi modem-manager[20043]: (ttyUSB1) serial port closed Oct 15 04:36:27 almursi modem-manager[20043]: (ttyUSB2) opening serial port... Oct 15 04:36:27 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabled -> enabling) Oct 15 04:36:31 almursi NetworkManager[1073]: Activation (ttyUSB2) starting connection 'Auto Movistar (Telefónica) solo CHAP' Oct 15 04:36:31 almursi NetworkManager[1073]: (ttyUSB2): device state change: 3 -> 4 (reason 0) Oct 15 04:36:31 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) scheduled... Oct 15 04:36:31 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) started... Oct 15 04:36:31 almursi NetworkManager[1073]: (ttyUSB2): device state change: 4 -> 6 (reason 0) Oct 15 04:36:31 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) complete. Oct 15 04:36:31 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) scheduled... Oct 15 04:36:31 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) started... Oct 15 04:36:31 almursi NetworkManager[1073]: (ttyUSB2): device state change: 6 -> 4 (reason 0) Oct 15 04:36:31 almursi NetworkManager[1073]: Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) complete. Oct 15 04:36:36 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabling -> disabled) Oct 15 04:36:36 almursi modem-manager[20043]: (ttyUSB2) closing serial port... Oct 15 04:36:36 almursi modem-manager[20043]: (ttyUSB2) serial port closed Oct 15 04:36:36 almursi NetworkManager[1073]: failed to enable/disable modem: (32) Serial port is now closed Oct 15 04:36:36 almursi NetworkManager[1073]: GSM modem enable failed: (32) Serial command timed out Oct 15 04:36:36 almursi NetworkManager[1073]: (ttyUSB2): device state change: 4 -> 9 (reason 28) Oct 15 04:36:36 almursi NetworkManager[1073]: Marking connection 'Auto Movistar (Telefónica) solo CHAP' invalid. Oct 15 04:36:36 almursi NetworkManager[1073]: Activation (ttyUSB2) failed. Oct 15 04:36:36 almursi NetworkManager[1073]: (ttyUSB2): device state change: 9 -> 3 (reason 0) Oct 15 04:36:36 almursi NetworkManager[1073]: (ttyUSB2): deactivating device (reason: 0). Oct 15 04:36:41 almursi modem-manager[20043]: (ttyUSB2) opening serial port... Oct 15 04:36:41 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabled -> enabling) Oct 15 04:36:47 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabling -> disabled) Oct 15 04:36:47 almursi modem-manager[20043]: (ttyUSB2) closing serial port... Oct 15 04:36:47 almursi modem-manager[20043]: (ttyUSB2) serial port closed Oct 15 04:36:47 almursi NetworkManager[1073]: failed to enable/disable modem: (32) Serial command timed out Oct 15 04:36:50 almursi kernel: [ 4988.739108] usb 1-3: USB disconnect, address 49 Oct 15 04:36:50 almursi kernel: [ 4988.739262] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Oct 15 04:36:50 almursi kernel: [ 4988.739283] option 1-3:1.0: device disconnected Oct 15 04:36:50 almursi kernel: [ 4988.739396] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Oct 15 04:36:50 almursi kernel: [ 4988.739414] option 1-3:1.1: device disconnected Oct 15 04:36:50 almursi kernel: [ 4988.739516] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 Oct 15 04:36:50 almursi kernel: [ 4988.739533] option 1-3:1.2: device disconnected Oct 15 04:36:50 almursi kernel: [ 4988.739636] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 Oct 15 04:36:50 almursi kernel: [ 4988.739652] option 1-3:1.3: device disconnected Oct 15 04:36:50 almursi kernel: [ 4988.739774] option: option_instat_callback: error -108 Oct 15 04:36:50 almursi kernel: [ 4988.739830] option1 ttyUSB4: GSM modem (1-port) converter now disconnected from ttyUSB4 Oct 15 04:36:50 almursi kernel: [ 4988.739847] option 1-3:1.4: device disconnected Oct 15 04:36:50 almursi kernel: [ 4988.739972] option: option_instat_callback: error -108 Oct 15 04:36:50 almursi kernel: [ 4988.740042] option1 ttyUSB5: GSM modem (1-port) converter now disconnected from ttyUSB5 Oct 15 04:36:50 almursi kernel: [ 4988.740059] option 1-3:1.5: device disconnected Oct 15 04:36:50 almursi modem-manager[20043]: (tty/ttyUSB1): released by modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 Oct 15 04:36:50 almursi modem-manager[20043]: (tty/ttyUSB0): released by modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 Oct 15 04:36:50 almursi modem-manager[20043]: (tty/ttyUSB2): released by modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 Oct 15 04:36:50 almursi modem-manager[20043]: mm_port_set_connected: assertion `self != NULL' failed Oct 15 04:36:50 almursi NetworkManager[1073]: (ttyUSB2): now unmanaged Oct 15 04:36:50 almursi NetworkManager[1073]: (ttyUSB2): device state change: 3 -> 1 (reason 36) Oct 15 04:36:50 almursi NetworkManager[1073]: (ttyUSB2): cleaning up... Oct 15 04:36:50 almursi NetworkManager[1073]: (ttyUSB2): taking down device. Oct 15 04:36:50 almursi modem-manager[20043]: Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabled -> connected) Oct 15 04:36:50 almursi modem-manager[20043]: mm_callback_info_schedule: assertion `info->pending_id == 0' failed Oct 15 04:36:50 almursi init: modemmanager main process (20043) killed by SEGV signal Oct 15 04:36:50 almursi init: modemmanager main process ended, respawning Oct 15 04:36:50 almursi kernel: [ 4988.754159] modem-manager[20043]: segfault at 1d ip b75363e1 sp bfa4d328 error 4 in libc-2.13.so[b74c6000+15a000] Oct 15 04:36:50 almursi modem-manager[1865]: ModemManager (version 0.4) starting... Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin SimTech Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Generic Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Huawei Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Option Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin ZTE Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Ericsson MBM Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Gobi Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Nokia Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Option High-Speed Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin X22X Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Novatel Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin AnyData Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Longcheer Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin MotoC Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Sierra Oct 15 04:36:50 almursi modem-manager[1865]: Loaded plugin Linktop Oct 15 04:36:50 almursi NetworkManager[1073]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Oct 15 04:36:50 almursi NetworkManager[1073]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Oct 15 04:36:50 almursi NetworkManager[1073]: the modem manager disappeared Oct 15 04:36:50 almursi NetworkManager[1073]: trying to start the modem manager... Oct 15 04:36:50 almursi NetworkManager[1073]: modem-manager is now available Oct 15 04:37:03 almursi kernel: [ 5001.956018] usb 1-3: new high speed USB device using ehci_hcd and address 50 Oct 15 04:37:03 almursi kernel: [ 5002.092669] scsi18 : usb-storage 1-3:1.0 Oct 15 04:37:04 almursi kernel: [ 5003.093548] scsi 18:0:0:0: CD-ROM ZTE USB SCSI CD-ROM 2.31 PQ: 0 ANSI: 2 Oct 15 04:37:04 almursi kernel: [ 5003.097030] sr1: scsi-1 drive Oct 15 04:37:04 almursi kernel: [ 5003.097193] sr 18:0:0:0: Attached scsi CD-ROM sr1 Oct 15 04:37:04 almursi kernel: [ 5003.098482] sr 18:0:0:0: Attached scsi generic sg4 type 5 Oct 15 04:37:21 almursi kernel: [ 5019.493031] ISO 9660 Extensions: Microsoft Joliet Level 3 Oct 15 04:37:21 almursi kernel: [ 5019.494403] ISOFS: changing to secondary root Oct 15 04:37:26 almursi sudo: pam_sm_authenticate: Called Oct 15 04:37:26 almursi sudo: pam_sm_authenticate: username = [xxxx] Oct 15 04:38:05 almursi kernel: [ 5063.202423] usb 1-3: USB disconnect, address 50 Oct 15 04:38:10 almursi kernel: [ 5068.960013] usb 1-3: new high speed USB device using ehci_hcd and address 51 Oct 15 04:38:10 almursi kernel: [ 5069.098054] option 1-3:1.0: GSM modem (1-port) converter detected Oct 15 04:38:10 almursi kernel: [ 5069.098143] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB0 Oct 15 04:38:10 almursi kernel: [ 5069.098240] option 1-3:1.1: GSM modem (1-port) converter detected Oct 15 04:38:10 almursi kernel: [ 5069.098310] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB1 Oct 15 04:38:10 almursi kernel: [ 5069.098398] option 1-3:1.2: GSM modem (1-port) converter detected Oct 15 04:38:10 almursi kernel: [ 5069.098470] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB2 Oct 15 04:38:10 almursi kernel: [ 5069.098559] option 1-3:1.3: GSM modem (1-port) converter detected Oct 15 04:38:10 almursi kernel: [ 5069.098629] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB3 Oct 15 04:38:10 almursi kernel: [ 5069.098716] option 1-3:1.4: GSM modem (1-port) converter detected Oct 15 04:38:10 almursi kernel: [ 5069.098805] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB4 Oct 15 04:38:10 almursi kernel: [ 5069.098910] option 1-3:1.5: GSM modem (1-port) converter detected Oct 15 04:38:10 almursi kernel: [ 5069.098998] usb 1-3: GSM modem (1-port) converter now attached to ttyUSB5 Oct 15 04:38:10 almursi kernel: [ 5069.100923] scsi19 : usb-storage 1-3:1.6 Oct 15 04:38:10 almursi modem-manager[1865]: (ttyUSB4) opening serial port... Oct 15 04:38:10 almursi modem-manager[1865]: (ttyUSB5) opening serial port... Oct 15 04:38:10 almursi modem-manager[1865]: (ttyUSB3) opening serial port... Oct 15 04:38:10 almursi modem-manager[1865]: (ttyUSB1) opening serial port... Oct 15 04:38:10 almursi modem-manager[1865]: (ttyUSB2) opening serial port... Oct 15 04:38:10 almursi modem-manager[1865]: (ttyUSB0) opening serial port... Oct 15 04:38:11 almursi kernel: [ 5070.101926] scsi 19:0:0:0: Direct-Access ZTE MMC Storage 2.31 PQ: 0 ANSI: 2 Oct 15 04:38:11 almursi kernel: [ 5070.102543] sd 19:0:0:0: Attached scsi generic sg4 type 0 Oct 15 04:38:11 almursi kernel: [ 5070.106788] sd 19:0:0:0: [sdd] Attached SCSI removable disk Oct 15 04:38:48 almursi modem-manager[1865]: (ttyUSB4) closing serial port... Oct 15 04:38:48 almursi modem-manager[1865]: (ttyUSB4) serial port closed Oct 15 04:38:48 almursi modem-manager[1865]: (ttyUSB4) opening serial port... Oct 15 04:38:48 almursi modem-manager[1865]: (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 claimed port ttyUSB4 Oct 15 04:38:48 almursi modem-manager[1865]: (ttyUSB1) closing serial port... Oct 15 04:38:48 almursi modem-manager[1865]: (ttyUSB1) serial port closed Oct 15 04:38:48 almursi modem-manager[1865]: (ttyUSB2) closing serial port... Oct 15 04:38:48 almursi modem-manager[1865]: (ttyUSB2) serial port closed Oct 15 04:38:48 almursi modem-manager[1865]: (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 claimed port ttyUSB1 Oct 15 04:38:48 almursi modem-manager[1865]: mm_modem_base_add_port: assertion `port == NULL' failed Oct 15 04:38:48 almursi modem-manager[1865]: (mm-generic-gsm.c:794):mm_generic_gsm_grab_port: runtime check failed: (port != NULL) Oct 15 04:38:48 almursi modem-manager[1865]: plugin 'ZTE' claimed to support tty/ttyUSB2 but couldn't: (-1) (unknown) Oct 15 04:38:49 almursi modem-manager[1865]: (ttyUSB4) closing serial port... Oct 15 04:38:49 almursi modem-manager[1865]: (ttyUSB4) serial port closed Oct 15 04:38:57 almursi modem-manager[1865]: (ttyUSB5) closing serial port... Oct 15 04:38:57 almursi modem-manager[1865]: (ttyUSB5) serial port closed Oct 15 04:38:57 almursi modem-manager[1865]: (ttyUSB5) opening serial port... Oct 15 04:38:58 almursi modem-manager[1865]: (ttyUSB3) closing serial port... Oct 15 04:38:58 almursi modem-manager[1865]: (ttyUSB3) serial port closed Oct 15 04:38:58 almursi modem-manager[1865]: (ttyUSB3) opening serial port... Oct 15 04:38:59 almursi modem-manager[1865]: (ttyUSB0) closing serial port... Oct 15 04:38:59 almursi modem-manager[1865]: (ttyUSB0) serial port closed Oct 15 04:38:59 almursi modem-manager[1865]: (ttyUSB0) opening serial port... Oct 15 04:39:02 almursi modem-manager[1865]: (ttyUSB0) closing serial port... Oct 15 04:39:02 almursi modem-manager[1865]: (ttyUSB0) serial port closed Oct 15 04:39:02 almursi modem-manager[1865]: (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1a.7/usb1/1-3 claimed port ttyUSB0 Oct 15 04:39:03 almursi modem-manager[1865]: (ttyUSB5) closing serial port... Oct 15 04:39:03 almursi modem-manager[1865]: (ttyUSB5) serial port closed Oct 15 04:39:04 almursi modem-manager[1865]: (ttyUSB3) closing serial port... Oct 15 04:39:04 almursi modem-manager[1865]: (ttyUSB3) serial port closed Oct 15 04:39:04 almursi NetworkManager[1073]: (ttyUSB4): failed to look up interface index Oct 15 04:39:04 almursi NetworkManager[1073]: (ttyUSB4): new GSM device (driver: 'option1' ifindex: -1) Oct 15 04:39:04 almursi NetworkManager[1073]: (ttyUSB4): exported as /org/freedesktop/NetworkManager/Devices/6 Oct 15 04:39:04 almursi NetworkManager[1073]: (ttyUSB4): now managed Oct 15 04:39:04 almursi NetworkManager[1073]: (ttyUSB4): device state change: 1 -> 2 (reason 2) Oct 15 04:39:04 almursi NetworkManager[1073]: (ttyUSB4): deactivating device (reason: 2). Oct 15 04:39:04 almursi NetworkManager[1073]: (ttyUSB4): device state change: 2 -> 3 (reason 0) Oct 15 04:39:13 almursi NetworkManager[1073]: failed to enable/disable modem: (32) SIM PIN required Oct 15 04:39:15 almursi NetworkManager[1073]: Activation (ttyUSB4) starting connection 'Auto Movistar (Telefónica) solo CHAP' Oct 15 04:39:15 almursi NetworkManager[1073]: (ttyUSB4): device state change: 3 -> 4 (reason 0) Oct 15 04:39:15 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 1 of 5 (Device Prepare) scheduled... Oct 15 04:39:15 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 1 of 5 (Device Prepare) started... Oct 15 04:39:15 almursi NetworkManager[1073]: (ttyUSB4): device state change: 4 -> 6 (reason 0) Oct 15 04:39:15 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 1 of 5 (Device Prepare) complete. Oct 15 04:39:15 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 1 of 5 (Device Prepare) scheduled... Oct 15 04:39:15 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 1 of 5 (Device Prepare) started... Oct 15 04:39:15 almursi NetworkManager[1073]: (ttyUSB4): device state change: 6 -> 4 (reason 0) Oct 15 04:39:15 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 1 of 5 (Device Prepare) complete. Oct 15 04:39:15 almursi NetworkManager[1073]: GSM modem enable failed: (32) SIM PIN required Oct 15 04:39:15 almursi modem-manager[1865]: (ttyUSB4) opening serial port... Oct 15 04:39:15 almursi modem-manager[1865]: Modem /org/freedesktop/ModemManager/Modems/0: unlock no longer required Oct 15 04:39:15 almursi modem-manager[1865]: Modem /org/freedesktop/ModemManager/Modems/0: # unlock retries is 0 Oct 15 04:39:17 almursi modem-manager[1865]: (ttyUSB4) closing serial port... Oct 15 04:39:17 almursi modem-manager[1865]: (ttyUSB4) serial port closed Oct 15 04:39:17 almursi modem-manager[1865]: (ttyUSB4) opening serial port... Oct 15 04:39:17 almursi modem-manager[1865]: Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling) Oct 15 04:39:19 almursi modem-manager[1865]: (ttyUSB1) opening serial port... Oct 15 04:39:20 almursi modem-manager[1865]: Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled) Oct 15 04:39:20 almursi NetworkManager[1073]: WWAN now enabled by management service Oct 15 04:39:20 almursi modem-manager[1865]: Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> registered) Oct 15 04:39:20 almursi modem-manager[1865]: Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting) Oct 15 04:39:20 almursi modem-manager[1865]: Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected) Oct 15 04:39:20 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 2 of 5 (Device Configure) scheduled... Oct 15 04:39:20 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 2 of 5 (Device Configure) starting... Oct 15 04:39:20 almursi NetworkManager[1073]: (ttyUSB4): device state change: 4 -> 5 (reason 0) Oct 15 04:39:20 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 2 of 5 (Device Configure) successful. Oct 15 04:39:20 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 3 of 5 (IP Configure Start) scheduled. Oct 15 04:39:20 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 2 of 5 (Device Configure) complete. Oct 15 04:39:20 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 3 of 5 (IP Configure Start) started... Oct 15 04:39:20 almursi NetworkManager[1073]: (ttyUSB4): device state change: 5 -> 7 (reason 0) Oct 15 04:39:20 almursi NetworkManager[1073]: starting PPP connection Oct 15 04:39:20 almursi NetworkManager[1073]: pppd started with pid 2385 Oct 15 04:39:20 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 3 of 5 (IP Configure Start) complete. Oct 15 04:39:20 almursi pppd[2385]: Plugin /usr/lib/pppd/2.4.5/nm-pppd-plugin.so loaded. Oct 15 04:39:20 almursi pppd[2385]: pppd 2.4.5 started by root, uid 0 Oct 15 04:39:20 almursi NetworkManager[1073]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Oct 15 04:39:20 almursi NetworkManager[1073]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Oct 15 04:39:20 almursi pppd[2385]: Using interface ppp0 Oct 15 04:39:20 almursi pppd[2385]: Connect: ppp0 <--> /dev/ttyUSB4 Oct 15 04:39:20 almursi pppd[2385]: CHAP authentication succeeded Oct 15 04:39:20 almursi pppd[2385]: CHAP authentication succeeded Oct 15 04:39:22 almursi pppd[2385]: Could not determine remote IP address: defaulting to 10.64.64.64 Oct 15 04:39:22 almursi pppd[2385]: local IP address 213.xx.xx.xx Oct 15 04:39:22 almursi pppd[2385]: remote IP address 10.64.64.64 Oct 15 04:39:22 almursi pppd[2385]: primary DNS address 80.58.61.250 Oct 15 04:39:22 almursi pppd[2385]: secondary DNS address 80.58.61.254 Oct 15 04:39:22 almursi NetworkManager[1073]: PPP manager(IP Config Get) reply received. Oct 15 04:39:22 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 4 of 5 (IP4 Configure Get) scheduled... Oct 15 04:39:22 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 4 of 5 (IP4 Configure Get) started... Oct 15 04:39:22 almursi NetworkManager[1073]: Scheduling stage 5 Oct 15 04:39:22 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 5 of 5 (IP Configure Commit) scheduled... Oct 15 04:39:22 almursi NetworkManager[1073]: Done scheduling stage 5 Oct 15 04:39:22 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 4 of 5 (IP4 Configure Get) complete. Oct 15 04:39:22 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 5 of 5 (IP Configure Commit) started... Oct 15 04:39:23 almursi NetworkManager[1073]: (ttyUSB4): device state change: 7 -> 8 (reason 0) Oct 15 04:39:23 almursi NetworkManager[1073]: Policy set 'Auto Movistar (Telefónica) solo CHAP' (ppp0) as default for IPv4 routing and DNS. Oct 15 04:39:23 almursi NetworkManager[1073]: Activation (ttyUSB4) successful, device activated. Oct 15 04:39:23 almursi NetworkManager[1073]: Activation (ttyUSB4) Stage 5 of 5 (IP Configure Commit) complete.