Dear experts, I have question about memory allocation failure on kernel 3.1. (simply it seems there is available free memory, however “page allocation failure” happened) While big data transfer, there is page allocation failure (please check attached log) It happens on __alloc_skb(). Inside function, it allocates memory from “skbuff_head_cache” and “size-xxxxxxx” caches. Here is my understanding, please correct me and advise. From the kernel log, it failed when it tried to get 2^3*4K(=32KB) memory. (e.g. swapper: page allocation failure: order:3, mode:0x20) From slabinfo, upper size-32768 does not have available slab, however buddy still has available memory. so when 32KB(order:3) was required, slab(size-32768) should request memory from buddy. e.g. “2” will be decreased to “1” on buddyinfo and “size-32768” cache will get 32K memory from buddy. So I can not understand why page alloc failure happened even if there are many available memory on buddy. Please advise on it. Here is dump info(page_allocation_failure_last_dump.txt), right after issue happens. (FYI at alloc failure, order:3)
Thanks, Seongho(Shawn) This email message is for the sole use of the intended recipient(s) and may
contain confidential information. Any unauthorized review, use, disclosure
or distribution is prohibited. If you are not the intended recipient,
please contact the sender by reply email and destroy all copies of the original
message.
|
/* OK at this moment */ root@android:/sdcard/modem_CoreDump # cat /proc/buddyinfo cat /proc/buddyinfo Node 0, zone Normal 300 57 16 25 5 1 1 1 1 1 0 root@android:/sdcard/modem_CoreDump # cat /proc/slabinfo cat /proc/slabinfo slabinfo - version: 2.1 # name <active_objs> <num_objs> <objsize> <objperslab> <pagesperslab> : tunables <limit> <batchcount> <sharedfactor> : slabdata <active_slabs> <num_slabs> <sharedavail> ext4_groupinfo_4k 33 35 112 35 1 : tunables 120 60 8 : slabdata 1 1 0 MHI-RAW 0 0 448 9 1 : tunables 54 27 8 : slabdata 0 0 0 MHI-DGRAM 2 18 448 9 1 : tunables 54 27 8 : slabdata 2 2 0 PNPIPE 0 0 480 8 1 : tunables 54 27 8 : slabdata 0 0 0 PHONET 19 36 448 9 1 : tunables 54 27 8 : slabdata 4 4 0 xfrm6_tunnel_spi 0 0 64 59 1 : tunables 120 60 8 : slabdata 0 0 0 fib6_nodes 17 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 ip6_dst_cache 17 17 224 17 1 : tunables 120 60 8 : slabdata 1 1 0 ndisc_cache 12 12 320 12 1 : tunables 54 27 8 : slabdata 1 1 0 RAWv6 7 10 736 5 1 : tunables 54 27 8 : slabdata 2 2 0 UDPLITEv6 0 0 736 5 1 : tunables 54 27 8 : slabdata 0 0 0 UDPv6 1 5 736 5 1 : tunables 54 27 8 : slabdata 1 1 0 tw_sock_TCPv6 0 0 160 24 1 : tunables 120 60 8 : slabdata 0 0 0 request_sock_TCPv6 0 0 128 30 1 : tunables 120 60 8 : slabdata 0 0 0 TCPv6 0 0 1408 5 2 : tunables 24 12 8 : slabdata 0 0 0 xt_hashlimit 0 0 80 48 1 : tunables 120 60 8 : slabdata 0 0 0 nf_conntrack_expect 0 0 176 22 1 : tunables 120 60 8 : slabdata 0 0 0 nf_conntrack_c0b56b00 0 0 240 16 1 : tunables 120 60 8 : slabdata 0 0 0 flow_cache 0 0 88 44 1 : tunables 120 60 8 : slabdata 0 0 0 dm_crypt_io 0 0 112 35 1 : tunables 120 60 8 : slabdata 0 0 0 kcopyd_job 0 0 2808 2 2 : tunables 24 12 8 : slabdata 0 0 0 io 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 dm_uevent 0 0 2464 3 2 : tunables 24 12 8 : slabdata 0 0 0 dm_rq_clone_bio_info 0 0 8 339 1 : tunables 120 60 8 : slabdata 0 0 0 dm_rq_target_io 0 0 248 16 1 : tunables 120 60 8 : slabdata 0 0 0 dm_target_io 0 0 16 203 1 : tunables 120 60 8 : slabdata 0 0 0 dm_io 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 sd_ext_cdb 2 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 fuse_request 0 0 384 10 1 : tunables 54 27 8 : slabdata 0 0 0 fuse_inode 36 54 448 9 1 : tunables 54 27 8 : slabdata 6 6 0 ntfs_big_inode_cache 0 0 544 7 1 : tunables 54 27 8 : slabdata 0 0 0 ntfs_inode_cache 0 0 192 20 1 : tunables 120 60 8 : slabdata 0 0 0 ntfs_name_cache 0 0 512 8 1 : tunables 54 27 8 : slabdata 0 0 0 ntfs_attr_ctx_cache 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 ntfs_index_ctx_cache 0 0 64 59 1 : tunables 120 60 8 : slabdata 0 0 0 nfs_direct_cache 0 0 88 44 1 : tunables 120 60 8 : slabdata 0 0 0 nfs_write_data 36 40 480 8 1 : tunables 54 27 8 : slabdata 5 5 0 nfs_read_data 32 32 480 8 1 : tunables 54 27 8 : slabdata 4 4 0 nfs_inode_cache 0 0 608 6 1 : tunables 54 27 8 : slabdata 0 0 0 nfs_page 0 0 64 59 1 : tunables 120 60 8 : slabdata 0 0 0 fat_inode_cache 0 0 440 9 1 : tunables 54 27 8 : slabdata 0 0 0 fat_cache 0 0 24 145 1 : tunables 120 60 8 : slabdata 0 0 0 jbd2_inode 141 290 24 145 1 : tunables 120 60 8 : slabdata 2 2 0 jbd2_journal_handle 1 145 24 145 1 : tunables 120 60 8 : slabdata 1 1 0 jbd2_journal_head 86 118 64 59 1 : tunables 120 60 8 : slabdata 2 2 0 jbd2_revoke_table 14 203 16 203 1 : tunables 120 60 8 : slabdata 1 1 0 jbd2_revoke_record 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 journal_handle 0 0 24 145 1 : tunables 120 60 8 : slabdata 0 0 0 journal_head 0 0 64 59 1 : tunables 120 60 8 : slabdata 0 0 0 revoke_table 0 0 16 203 1 : tunables 120 60 8 : slabdata 0 0 0 revoke_record 0 0 16 203 1 : tunables 120 60 8 : slabdata 0 0 0 ext4_inode_cache 1032 1050 624 6 1 : tunables 54 27 8 : slabdata 175 175 0 ext4_xattr 0 0 56 67 1 : tunables 120 60 8 : slabdata 0 0 0 ext4_free_data 16 92 40 92 1 : tunables 120 60 8 : slabdata 1 1 0 ext4_allocation_context 1 35 112 35 1 : tunables 120 60 8 : slabdata 1 1 0 ext4_prealloc_space 8 53 72 53 1 : tunables 120 60 8 : slabdata 1 1 0 ext4_system_zone 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 ext4_io_end 7 7 576 7 1 : tunables 54 27 8 : slabdata 1 1 0 ext4_io_page 16 339 8 339 1 : tunables 120 60 8 : slabdata 1 1 0 ext2_inode_cache 0 0 512 8 1 : tunables 54 27 8 : slabdata 0 0 0 ext2_xattr 0 0 56 67 1 : tunables 120 60 8 : slabdata 0 0 0 ext3_inode_cache 0 0 520 7 1 : tunables 54 27 8 : slabdata 0 0 0 ext3_xattr 0 0 56 67 1 : tunables 120 60 8 : slabdata 0 0 0 kioctx 0 0 224 17 1 : tunables 120 60 8 : slabdata 0 0 0 kiocb 0 0 128 30 1 : tunables 120 60 8 : slabdata 0 0 0 inotify_event_private_data 0 0 16 203 1 : tunables 120 60 8 : slabdata 0 0 0 inotify_inode_mark 11 48 80 48 1 : tunables 120 60 8 : slabdata 1 1 0 fasync_cache 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 ashmem_range_cache 7 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 ashmem_area_cache 36 65 288 13 1 : tunables 54 27 8 : slabdata 5 5 0 posix_timers_cache 1 29 136 29 1 : tunables 120 60 8 : slabdata 1 1 0 uid_cache 23 59 64 59 1 : tunables 120 60 8 : slabdata 1 1 0 rpc_buffers 8 8 2048 2 1 : tunables 24 12 8 : slabdata 4 4 0 rpc_tasks 8 30 128 30 1 : tunables 120 60 8 : slabdata 1 1 0 rpc_inode_cache 12 14 512 7 1 : tunables 54 27 8 : slabdata 2 2 0 UNIX 96 98 544 7 1 : tunables 54 27 8 : slabdata 14 14 0 UDP-Lite 0 0 608 6 1 : tunables 54 27 8 : slabdata 0 0 0 tcp_bind_bucket 1 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 inet_peer_cache 4 24 160 24 1 : tunables 120 60 8 : slabdata 1 1 0 secpath_cache 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 xfrm_dst_cache 0 0 288 13 1 : tunables 54 27 8 : slabdata 0 0 0 ip_fib_trie 3 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 ip_fib_alias 4 145 24 145 1 : tunables 120 60 8 : slabdata 1 1 0 ip_dst_cache 0 0 160 24 1 : tunables 120 60 8 : slabdata 0 0 0 arp_cache 0 0 320 12 1 : tunables 54 27 8 : slabdata 0 0 0 PING 0 0 576 7 1 : tunables 54 27 8 : slabdata 0 0 0 RAW 5 7 576 7 1 : tunables 54 27 8 : slabdata 1 1 0 UDP 2 6 608 6 1 : tunables 54 27 8 : slabdata 1 1 0 tw_sock_TCP 0 0 128 30 1 : tunables 120 60 8 : slabdata 0 0 0 request_sock_TCP 0 0 96 40 1 : tunables 120 60 8 : slabdata 0 0 0 TCP 1 3 1280 3 1 : tunables 24 12 8 : slabdata 1 1 0 combo_block 1 78 48 78 1 : tunables 120 60 8 : slabdata 1 1 0 buddy_heap 0 0 528 7 1 : tunables 54 27 8 : slabdata 0 0 0 eventpoll_pwq 103 184 40 92 1 : tunables 120 60 8 : slabdata 2 2 0 eventpoll_epi 103 120 96 40 1 : tunables 120 60 8 : slabdata 3 3 0 trpc_msg 0 0 272 14 1 : tunables 54 27 8 : slabdata 0 0 0 sgpool-128 2 2 2048 2 1 : tunables 24 12 8 : slabdata 1 1 0 sgpool-64 2 4 1024 4 1 : tunables 54 27 8 : slabdata 1 1 0 sgpool-32 2 8 512 8 1 : tunables 54 27 8 : slabdata 1 1 0 sgpool-16 2 15 256 15 1 : tunables 120 60 8 : slabdata 1 1 0 sgpool-8 2 30 128 30 1 : tunables 120 60 8 : slabdata 1 1 0 scsi_data_buffer 0 0 24 145 1 : tunables 120 60 8 : slabdata 0 0 0 blkdev_queue 11 14 1112 7 2 : tunables 24 12 8 : slabdata 2 2 0 blkdev_requests 62 108 216 18 1 : tunables 120 60 8 : slabdata 6 6 0 blkdev_ioc 34 156 48 78 1 : tunables 120 60 8 : slabdata 2 2 0 fsnotify_event_holder 0 0 16 203 1 : tunables 120 60 8 : slabdata 0 0 0 fsnotify_event 1 53 72 53 1 : tunables 120 60 8 : slabdata 1 1 0 bio-0 399 570 128 30 1 : tunables 120 60 8 : slabdata 19 19 324 biovec-256 2 2 3072 2 2 : tunables 24 12 8 : slabdata 1 1 0 biovec-128 5 5 1536 5 2 : tunables 24 12 8 : slabdata 1 1 0 biovec-64 0 0 768 5 1 : tunables 54 27 8 : slabdata 0 0 0 biovec-16 0 20 192 20 1 : tunables 120 60 8 : slabdata 0 1 0 tegra_iovmm_block 397 472 64 59 1 : tunables 120 60 8 : slabdata 8 8 0 sock_inode_cache 159 170 384 10 1 : tunables 54 27 8 : slabdata 17 17 0 skbuff_fclone_cache 0 0 384 10 1 : tunables 54 27 8 : slabdata 0 0 0 skbuff_head_cache 137 240 192 20 1 : tunables 120 60 8 : slabdata 12 12 60 file_lock_cache 16 74 104 37 1 : tunables 120 60 8 : slabdata 2 2 0 shmem_inode_cache 274 300 392 10 1 : tunables 54 27 8 : slabdata 30 30 0 proc_inode_cache 726 750 384 10 1 : tunables 54 27 8 : slabdata 75 75 0 sigqueue 17 27 144 27 1 : tunables 120 60 8 : slabdata 1 1 0 bdev_cache 9 14 512 7 1 : tunables 54 27 8 : slabdata 2 2 0 sysfs_dir_cache 8087 8190 48 78 1 : tunables 120 60 8 : slabdata 105 105 0 mnt_cache 30 48 160 24 1 : tunables 120 60 8 : slabdata 2 2 0 filp 1719 1800 160 24 1 : tunables 120 60 8 : slabdata 75 75 0 inode_cache 6285 6292 352 11 1 : tunables 54 27 8 : slabdata 572 572 0 dentry 9067 9106 136 29 1 : tunables 120 60 8 : slabdata 314 314 0 names_cache 5 5 4096 1 1 : tunables 24 12 8 : slabdata 5 5 0 buffer_head 38688 38763 64 59 1 : tunables 120 60 8 : slabdata 657 657 0 nsproxy 0 0 24 145 1 : tunables 120 60 8 : slabdata 0 0 0 vm_area_struct 6330 6380 88 44 1 : tunables 120 60 8 : slabdata 145 145 0 mm_struct 51 72 416 9 1 : tunables 54 27 8 : slabdata 8 8 0 fs_cache 57 118 64 59 1 : tunables 120 60 8 : slabdata 2 2 0 files_cache 58 68 224 17 1 : tunables 120 60 8 : slabdata 4 4 0 signal_cache 139 168 576 7 1 : tunables 54 27 8 : slabdata 24 24 0 sighand_cache 136 144 1312 3 1 : tunables 24 12 8 : slabdata 48 48 0 task_struct 477 486 1216 3 1 : tunables 24 12 8 : slabdata 162 162 0 cred_jar 192 480 96 40 1 : tunables 120 60 8 : slabdata 12 12 0 anon_vma_chain 7924 7975 24 145 1 : tunables 120 60 8 : slabdata 55 55 0 anon_vma 4096 4140 40 92 1 : tunables 120 60 8 : slabdata 45 45 0 pid 506 590 64 59 1 : tunables 120 60 8 : slabdata 10 10 0 radix_tree_node 2166 2236 296 13 1 : tunables 54 27 8 : slabdata 172 172 0 idr_layer_cache 320 338 152 26 1 : tunables 120 60 8 : slabdata 13 13 0 size-4194304 0 0 4194304 1 1024 : tunables 1 1 0 : slabdata 0 0 0 size-2097152 0 0 2097152 1 512 : tunables 1 1 0 : slabdata 0 0 0 size-1048576 0 0 1048576 1 256 : tunables 1 1 0 : slabdata 0 0 0 size-524288 0 0 524288 1 128 : tunables 1 1 0 : slabdata 0 0 0 size-262144 0 0 262144 1 64 : tunables 1 1 0 : slabdata 0 0 0 size-131072 1 1 131072 1 32 : tunables 8 4 0 : slabdata 1 1 0 size-65536 4 4 65536 1 16 : tunables 8 4 0 : slabdata 4 4 0 size-32768 18 18 32768 1 8 : tunables 8 4 0 : slabdata 18 18 0 size-16384 9 9 16384 1 4 : tunables 8 4 0 : slabdata 9 9 0 size-8192 23 23 8192 1 2 : tunables 8 4 0 : slabdata 23 23 0 size-4096 25 25 4096 1 1 : tunables 24 12 8 : slabdata 25 25 0 size-2048 217 222 2048 2 1 : tunables 24 12 8 : slabdata 111 111 0 size-1024 295 296 1024 4 1 : tunables 54 27 8 : slabdata 74 74 0 size-512 903 944 512 8 1 : tunables 54 27 8 : slabdata 118 118 135 size-256 399 450 256 15 1 : tunables 120 60 8 : slabdata 30 30 15 size-192 216 280 192 20 1 : tunables 120 60 8 : slabdata 14 14 0 size-128 1744 1800 128 30 1 : tunables 120 60 8 : slabdata 60 60 30 size-96 2100 2160 96 40 1 : tunables 120 60 8 : slabdata 54 54 0 size-64 2490 2655 64 59 1 : tunables 120 60 8 : slabdata 45 45 0 size-32 9826 10170 32 113 1 : tunables 120 60 8 : slabdata 90 90 0 kmem_cache 162 240 96 40 1 : tunables 120 60 8 : slabdata 6 6 0 root@android:/sdcard/modem_CoreDump # cat /proc/meminfo cat /proc/meminfo MemTotal: 747864 kB MemFree: 7000 kB Buffers: 5596 kB Cached: 361884 kB SwapCached: 0 kB Active: 147068 kB Inactive: 333448 kB Active(anon): 113212 kB Inactive(anon): 296 kB Active(file): 33856 kB Inactive(file): 333152 kB Unevictable: 96 kB Mlocked: 0 kB HighTotal: 0 kB HighFree: 0 kB LowTotal: 747864 kB LowFree: 7000 kB SwapTotal: 0 kB SwapFree: 0 kB Dirty: 0 kB Writeback: 0 kB AnonPages: 113172 kB Mapped: 44288 kB Shmem: 376 kB Slab: 15280 kB SReclaimable: 7976 kB SUnreclaim: 7304 kB KernelStack: 3712 kB PageTables: 5628 kB NFS_Unstable: 0 kB Bounce: 0 kB WritebackTmp: 0 kB CommitLimit: 373932 kB Committed_AS: 2894244 kB VmallocTotal: 131072 kB VmallocUsed: 39136 kB VmallocChunk: 76676 kB DirectMap4k: 399364 kB DirectMap2M: 370688 kB /* Issue just happened */ root@android:/sdcard/modem_CoreDump # cat /proc/buddyinfo cat /proc/buddyinfo Node 0, zone Normal 949 0 0 2 3 3 0 0 1 1 0 root@android:/sdcard/modem_CoreDump # cat /proc/slabinfo cat /proc/slabinfo slabinfo - version: 2.1 # name <active_objs> <num_objs> <objsize> <objperslab> <pagesperslab> : tunables <limit> <batchcount> <sharedfactor> : slabdata <active_slabs> <num_slabs> <sharedavail> ext4_groupinfo_4k 33 35 112 35 1 : tunables 120 60 8 : slabdata 1 1 0 MHI-RAW 0 0 448 9 1 : tunables 54 27 8 : slabdata 0 0 0 MHI-DGRAM 2 18 448 9 1 : tunables 54 27 8 : slabdata 2 2 0 PNPIPE 0 0 480 8 1 : tunables 54 27 8 : slabdata 0 0 0 PHONET 19 36 448 9 1 : tunables 54 27 8 : slabdata 4 4 0 xfrm6_tunnel_spi 0 0 64 59 1 : tunables 120 60 8 : slabdata 0 0 0 fib6_nodes 3 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 ip6_dst_cache 2 17 224 17 1 : tunables 120 60 8 : slabdata 1 1 0 ndisc_cache 2 12 320 12 1 : tunables 54 27 8 : slabdata 1 1 0 RAWv6 7 10 736 5 1 : tunables 54 27 8 : slabdata 2 2 0 UDPLITEv6 0 0 736 5 1 : tunables 54 27 8 : slabdata 0 0 0 UDPv6 5 5 736 5 1 : tunables 54 27 8 : slabdata 1 1 0 tw_sock_TCPv6 0 0 160 24 1 : tunables 120 60 8 : slabdata 0 0 0 request_sock_TCPv6 0 0 128 30 1 : tunables 120 60 8 : slabdata 0 0 0 TCPv6 0 0 1408 5 2 : tunables 24 12 8 : slabdata 0 0 0 xt_hashlimit 0 0 80 48 1 : tunables 120 60 8 : slabdata 0 0 0 nf_conntrack_expect 0 0 176 22 1 : tunables 120 60 8 : slabdata 0 0 0 nf_conntrack_c0b56b00 0 0 240 16 1 : tunables 120 60 8 : slabdata 0 0 0 flow_cache 0 0 88 44 1 : tunables 120 60 8 : slabdata 0 0 0 dm_crypt_io 0 0 112 35 1 : tunables 120 60 8 : slabdata 0 0 0 kcopyd_job 0 0 2808 2 2 : tunables 24 12 8 : slabdata 0 0 0 io 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 dm_uevent 0 0 2464 3 2 : tunables 24 12 8 : slabdata 0 0 0 dm_rq_clone_bio_info 0 0 8 339 1 : tunables 120 60 8 : slabdata 0 0 0 dm_rq_target_io 0 0 248 16 1 : tunables 120 60 8 : slabdata 0 0 0 dm_target_io 0 0 16 203 1 : tunables 120 60 8 : slabdata 0 0 0 dm_io 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 sd_ext_cdb 2 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 fuse_request 5 20 384 10 1 : tunables 54 27 8 : slabdata 2 2 0 fuse_inode 99 99 448 9 1 : tunables 54 27 8 : slabdata 11 11 0 ntfs_big_inode_cache 0 0 544 7 1 : tunables 54 27 8 : slabdata 0 0 0 ntfs_inode_cache 0 0 192 20 1 : tunables 120 60 8 : slabdata 0 0 0 ntfs_name_cache 0 0 512 8 1 : tunables 54 27 8 : slabdata 0 0 0 ntfs_attr_ctx_cache 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 ntfs_index_ctx_cache 0 0 64 59 1 : tunables 120 60 8 : slabdata 0 0 0 nfs_direct_cache 0 0 88 44 1 : tunables 120 60 8 : slabdata 0 0 0 nfs_write_data 36 40 480 8 1 : tunables 54 27 8 : slabdata 5 5 0 nfs_read_data 32 32 480 8 1 : tunables 54 27 8 : slabdata 4 4 0 nfs_inode_cache 0 0 608 6 1 : tunables 54 27 8 : slabdata 0 0 0 nfs_page 0 0 64 59 1 : tunables 120 60 8 : slabdata 0 0 0 fat_inode_cache 0 0 440 9 1 : tunables 54 27 8 : slabdata 0 0 0 fat_cache 0 0 24 145 1 : tunables 120 60 8 : slabdata 0 0 0 jbd2_inode 270 290 24 145 1 : tunables 120 60 8 : slabdata 2 2 0 jbd2_journal_handle 8 145 24 145 1 : tunables 120 60 8 : slabdata 1 1 0 jbd2_journal_head 102 118 64 59 1 : tunables 120 60 8 : slabdata 2 2 0 jbd2_revoke_table 14 203 16 203 1 : tunables 120 60 8 : slabdata 1 1 0 jbd2_revoke_record 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 journal_handle 0 0 24 145 1 : tunables 120 60 8 : slabdata 0 0 0 journal_head 0 0 64 59 1 : tunables 120 60 8 : slabdata 0 0 0 revoke_table 0 0 16 203 1 : tunables 120 60 8 : slabdata 0 0 0 revoke_record 0 0 16 203 1 : tunables 120 60 8 : slabdata 0 0 0 ext4_inode_cache 1092 1092 624 6 1 : tunables 54 27 8 : slabdata 182 182 0 ext4_xattr 0 0 56 67 1 : tunables 120 60 8 : slabdata 0 0 0 ext4_free_data 1 92 40 92 1 : tunables 120 60 8 : slabdata 1 1 0 ext4_allocation_context 4 35 112 35 1 : tunables 120 60 8 : slabdata 1 1 0 ext4_prealloc_space 53 53 72 53 1 : tunables 120 60 8 : slabdata 1 1 0 ext4_system_zone 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 ext4_io_end 0 0 576 7 1 : tunables 54 27 8 : slabdata 0 0 0 ext4_io_page 2 339 8 339 1 : tunables 120 60 8 : slabdata 1 1 0 ext2_inode_cache 0 0 512 8 1 : tunables 54 27 8 : slabdata 0 0 0 ext2_xattr 0 0 56 67 1 : tunables 120 60 8 : slabdata 0 0 0 ext3_inode_cache 0 0 520 7 1 : tunables 54 27 8 : slabdata 0 0 0 ext3_xattr 0 0 56 67 1 : tunables 120 60 8 : slabdata 0 0 0 kioctx 0 0 224 17 1 : tunables 120 60 8 : slabdata 0 0 0 kiocb 0 0 128 30 1 : tunables 120 60 8 : slabdata 0 0 0 inotify_event_private_data 16 203 16 203 1 : tunables 120 60 8 : slabdata 1 1 0 inotify_inode_mark 11 48 80 48 1 : tunables 120 60 8 : slabdata 1 1 0 fasync_cache 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 ashmem_range_cache 7 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 ashmem_area_cache 35 65 288 13 1 : tunables 54 27 8 : slabdata 5 5 0 posix_timers_cache 1 29 136 29 1 : tunables 120 60 8 : slabdata 1 1 0 uid_cache 23 59 64 59 1 : tunables 120 60 8 : slabdata 1 1 0 rpc_buffers 8 8 2048 2 1 : tunables 24 12 8 : slabdata 4 4 0 rpc_tasks 8 30 128 30 1 : tunables 120 60 8 : slabdata 1 1 0 rpc_inode_cache 12 14 512 7 1 : tunables 54 27 8 : slabdata 2 2 0 UNIX 98 98 544 7 1 : tunables 54 27 8 : slabdata 14 14 0 UDP-Lite 0 0 608 6 1 : tunables 54 27 8 : slabdata 0 0 0 tcp_bind_bucket 1 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 inet_peer_cache 4 24 160 24 1 : tunables 120 60 8 : slabdata 1 1 0 secpath_cache 0 0 32 113 1 : tunables 120 60 8 : slabdata 0 0 0 xfrm_dst_cache 0 0 288 13 1 : tunables 54 27 8 : slabdata 0 0 0 ip_fib_trie 6 113 32 113 1 : tunables 120 60 8 : slabdata 1 1 0 ip_fib_alias 7 145 24 145 1 : tunables 120 60 8 : slabdata 1 1 0 ip_dst_cache 0 0 160 24 1 : tunables 120 60 8 : slabdata 0 0 0 arp_cache 0 0 320 12 1 : tunables 54 27 8 : slabdata 0 0 0 PING 0 0 576 7 1 : tunables 54 27 8 : slabdata 0 0 0 RAW 5 7 576 7 1 : tunables 54 27 8 : slabdata 1 1 0 UDP 6 6 608 6 1 : tunables 54 27 8 : slabdata 1 1 0 tw_sock_TCP 0 0 128 30 1 : tunables 120 60 8 : slabdata 0 0 0 request_sock_TCP 0 0 96 40 1 : tunables 120 60 8 : slabdata 0 0 0 TCP 1 3 1280 3 1 : tunables 24 12 8 : slabdata 1 1 0 combo_block 1 78 48 78 1 : tunables 120 60 8 : slabdata 1 1 0 buddy_heap 0 0 528 7 1 : tunables 54 27 8 : slabdata 0 0 0 eventpoll_pwq 104 184 40 92 1 : tunables 120 60 8 : slabdata 2 2 0 eventpoll_epi 104 120 96 40 1 : tunables 120 60 8 : slabdata 3 3 0 trpc_msg 0 0 272 14 1 : tunables 54 27 8 : slabdata 0 0 0 sgpool-128 2 2 2048 2 1 : tunables 24 12 8 : slabdata 1 1 0 sgpool-64 2 4 1024 4 1 : tunables 54 27 8 : slabdata 1 1 0 sgpool-32 2 8 512 8 1 : tunables 54 27 8 : slabdata 1 1 0 sgpool-16 2 15 256 15 1 : tunables 120 60 8 : slabdata 1 1 0 sgpool-8 2 30 128 30 1 : tunables 120 60 8 : slabdata 1 1 0 scsi_data_buffer 0 0 24 145 1 : tunables 120 60 8 : slabdata 0 0 0 blkdev_queue 11 14 1112 7 2 : tunables 24 12 8 : slabdata 2 2 0 blkdev_requests 99 108 216 18 1 : tunables 120 60 8 : slabdata 6 6 0 blkdev_ioc 34 156 48 78 1 : tunables 120 60 8 : slabdata 2 2 0 fsnotify_event_holder 0 0 16 203 1 : tunables 120 60 8 : slabdata 0 0 0 fsnotify_event 17 53 72 53 1 : tunables 120 60 8 : slabdata 1 1 0 bio-0 564 750 128 30 1 : tunables 120 60 8 : slabdata 25 25 464 biovec-256 2 2 3072 2 2 : tunables 24 12 8 : slabdata 1 1 0 biovec-128 0 0 1536 5 2 : tunables 24 12 8 : slabdata 0 0 0 biovec-64 1 5 768 5 1 : tunables 54 27 8 : slabdata 1 1 0 biovec-16 4 20 192 20 1 : tunables 120 60 8 : slabdata 1 1 0 tegra_iovmm_block 397 472 64 59 1 : tunables 120 60 8 : slabdata 8 8 0 sock_inode_cache 170 170 384 10 1 : tunables 54 27 8 : slabdata 17 17 0 skbuff_fclone_cache 0 0 384 10 1 : tunables 54 27 8 : slabdata 0 0 0 skbuff_head_cache 552 700 192 20 1 : tunables 120 60 8 : slabdata 35 35 480 file_lock_cache 10 74 104 37 1 : tunables 120 60 8 : slabdata 2 2 0 shmem_inode_cache 298 300 392 10 1 : tunables 54 27 8 : slabdata 30 30 0 proc_inode_cache 736 740 384 10 1 : tunables 54 27 8 : slabdata 74 74 0 sigqueue 20 27 144 27 1 : tunables 120 60 8 : slabdata 1 1 0 bdev_cache 9 14 512 7 1 : tunables 54 27 8 : slabdata 2 2 0 sysfs_dir_cache 8127 8268 48 78 1 : tunables 120 60 8 : slabdata 106 106 60 mnt_cache 30 48 160 24 1 : tunables 120 60 8 : slabdata 2 2 0 filp 1699 1800 160 24 1 : tunables 120 60 8 : slabdata 75 75 0 inode_cache 6284 6303 352 11 1 : tunables 54 27 8 : slabdata 573 573 0 dentry 9232 9251 136 29 1 : tunables 120 60 8 : slabdata 319 319 0 names_cache 3 3 4096 1 1 : tunables 24 12 8 : slabdata 3 3 0 buffer_head 42069 42539 64 59 1 : tunables 120 60 8 : slabdata 721 721 0 nsproxy 0 0 24 145 1 : tunables 120 60 8 : slabdata 0 0 0 vm_area_struct 6328 6380 88 44 1 : tunables 120 60 8 : slabdata 145 145 0 mm_struct 65 72 416 9 1 : tunables 54 27 8 : slabdata 8 8 0 fs_cache 111 118 64 59 1 : tunables 120 60 8 : slabdata 2 2 0 files_cache 68 68 224 17 1 : tunables 120 60 8 : slabdata 4 4 0 signal_cache 147 154 576 7 1 : tunables 54 27 8 : slabdata 22 22 0 sighand_cache 138 138 1312 3 1 : tunables 24 12 8 : slabdata 46 46 0 task_struct 480 483 1216 3 1 : tunables 24 12 8 : slabdata 161 161 0 cred_jar 251 480 96 40 1 : tunables 120 60 8 : slabdata 12 12 0 anon_vma_chain 7960 7975 24 145 1 : tunables 120 60 8 : slabdata 55 55 0 anon_vma 4140 4232 40 92 1 : tunables 120 60 8 : slabdata 46 46 0 pid 531 590 64 59 1 : tunables 120 60 8 : slabdata 10 10 0 radix_tree_node 2145 2249 296 13 1 : tunables 54 27 8 : slabdata 173 173 0 idr_layer_cache 317 338 152 26 1 : tunables 120 60 8 : slabdata 13 13 0 size-4194304 0 0 4194304 1 1024 : tunables 1 1 0 : slabdata 0 0 0 size-2097152 0 0 2097152 1 512 : tunables 1 1 0 : slabdata 0 0 0 size-1048576 0 0 1048576 1 256 : tunables 1 1 0 : slabdata 0 0 0 size-524288 0 0 524288 1 128 : tunables 1 1 0 : slabdata 0 0 0 size-262144 0 0 262144 1 64 : tunables 1 1 0 : slabdata 0 0 0 size-131072 1 1 131072 1 32 : tunables 8 4 0 : slabdata 1 1 0 size-65536 4 4 65536 1 16 : tunables 8 4 0 : slabdata 4 4 0 size-32768 19 19 32768 1 8 : tunables 8 4 0 : slabdata 19 19 0 size-16384 9 9 16384 1 4 : tunables 8 4 0 : slabdata 9 9 0 size-8192 23 23 8192 1 2 : tunables 8 4 0 : slabdata 23 23 0 size-4096 25 25 4096 1 1 : tunables 24 12 8 : slabdata 25 25 0 size-2048 218 218 2048 2 1 : tunables 24 12 8 : slabdata 109 109 0 size-1024 294 300 1024 4 1 : tunables 54 27 8 : slabdata 75 75 0 size-512 921 928 512 8 1 : tunables 54 27 8 : slabdata 116 116 54 size-256 435 480 256 15 1 : tunables 120 60 8 : slabdata 32 32 0 size-192 242 300 192 20 1 : tunables 120 60 8 : slabdata 15 15 0 size-128 1798 1800 128 30 1 : tunables 120 60 8 : slabdata 60 60 0 size-96 2122 2160 96 40 1 : tunables 120 60 8 : slabdata 54 54 0 size-64 2544 2714 64 59 1 : tunables 120 60 8 : slabdata 46 46 0 size-32 10298 10509 32 113 1 : tunables 120 60 8 : slabdata 93 93 388 kmem_cache 162 240 96 40 1 : tunables 120 60 8 : slabdata 6 6 0 root@android:/sdcard/modem_CoreDump # cat /proc/meminfo cat /proc/meminfo MemTotal: 747864 kB MemFree: 7652 kB Buffers: 5148 kB Cached: 362600 kB SwapCached: 0 kB Active: 155380 kB Inactive: 326744 kB Active(anon): 114552 kB Inactive(anon): 296 kB Active(file): 40828 kB Inactive(file): 326448 kB Unevictable: 96 kB Mlocked: 0 kB HighTotal: 0 kB HighFree: 0 kB LowTotal: 747864 kB LowFree: 7652 kB SwapTotal: 0 kB SwapFree: 0 kB Dirty: 40 kB Writeback: 7900 kB AnonPages: 114504 kB Mapped: 22296 kB Shmem: 376 kB Slab: 15912 kB SReclaimable: 8284 kB SUnreclaim: 7628 kB KernelStack: 3760 kB PageTables: 5628 kB NFS_Unstable: 0 kB Bounce: 0 kB WritebackTmp: 0 kB CommitLimit: 373932 kB Committed_AS: 2894900 kB VmallocTotal: 131072 kB VmallocUsed: 39136 kB VmallocChunk: 76676 kB DirectMap4k: 399364 kB DirectMap2M: 370688 kB root@android:/sdcard/modem_CoreDump # ls -l ls -l -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 14:58 20120726_145803_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 14:58 20120726_145803_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 14:58 20120726_145803_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 14:58 20120726_145803_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 14:58 20120726_145803_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 14:58 20120726_145837_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 14:58 20120726_145837_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 14:58 20120726_145837_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 14:58 20120726_145837_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 14:58 20120726_145837_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:00 20120726_150019_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:00 20120726_150019_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:00 20120726_150019_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:00 20120726_150019_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:00 20120726_150019_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:01 20120726_150100_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:01 20120726_150100_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:01 20120726_150100_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:01 20120726_150100_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:01 20120726_150100_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:01 20120726_150140_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:01 20120726_150140_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:01 20120726_150140_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:01 20120726_150140_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:01 20120726_150140_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:02 20120726_150214_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:02 20120726_150214_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:02 20120726_150214_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:02 20120726_150214_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:02 20120726_150214_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:03 20120726_150258_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:03 20120726_150258_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:03 20120726_150258_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:03 20120726_150258_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:03 20120726_150258_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:03 20120726_150342_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:03 20120726_150342_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:03 20120726_150342_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:03 20120726_150342_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:03 20120726_150342_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:07 20120726_150656_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:07 20120726_150656_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:07 20120726_150656_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:07 20120726_150656_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:07 20120726_150656_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:07 20120726_150730_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:07 20120726_150730_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:07 20120726_150730_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:07 20120726_150730_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:07 20120726_150730_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:08 20120726_150801_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:08 20120726_150801_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:08 20120726_150801_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:08 20120726_150801_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:08 20120726_150801_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:08 20120726_150845_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:08 20120726_150845_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:08 20120726_150845_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:08 20120726_150845_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:08 20120726_150845_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:09 20120726_150928_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:09 20120726_150928_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:09 20120726_150928_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:09 20120726_150928_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:09 20120726_150928_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:10 20120726_150957_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:10 20120726_150957_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:10 20120726_150957_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:10 20120726_150957_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:10 20120726_150957_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:10 20120726_151031_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:10 20120726_151031_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:10 20120726_151031_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:10 20120726_151031_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:10 20120726_151031_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:11 20120726_151100_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:11 20120726_151100_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:11 20120726_151100_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:11 20120726_151100_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:11 20120726_151100_TCM_R42.bin -rw-rw-r-- root sdcard_rw 41943040 2012-07-26 15:12 20120726_151203_CELL_SDRAM.bin -rw-rw-r-- root sdcard_rw 1048576 2012-07-26 15:12 20120726_151203_MH-C_SHARED.bin -rw-rw-r-- root sdcard_rw 8192 2012-07-26 15:12 20120726_151203_STATRAM.bin -rw-rw-r-- root sdcard_rw 98304 2012-07-26 15:12 20120726_151203_TCM_R41.bin -rw-rw-r-- root sdcard_rw 32768 2012-07-26 15:12 20120726_151203_TCM_R42.bin
[ 9.816203] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 9.847557] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 9.854508] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 9.861968] usb 1-1: Product: HakuyaS USB [ 9.866158] usb 1-1: Manufacturer: Renesas [ 9.872683] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 10.086520] Tegra auto-hotplug enabled [ 10.094191] android_usb: already disabled [ 10.098540] mtp_bind_config [ 10.101640] adb_bind_config /system/bin/sh: No controlling tty (open[ 10.108387] adb_open(adbd) /dev/tty: No such device or address) /system/bin/sh: warning: won't have full job control root@android:/ # [ 10.193381] CPU1: shutdown [ 10.338352] android_work: did not send uevent (0 0 (null)) [ 10.455185] modem_hsic_open [ 10.463493] modem_hsic_read : [ 10.468083] modem_do_read_io [ 10.471128] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 10.471516] modem_read_bulk_callback [ 10.471528] modem_read_bulk_callback, length = 69 [ 10.485936] modem_hsic_read : copy_to_user bytes_read =69 [ 10.513595] android_work: sent uevent USB_STATE=CONNECTED [ 10.521987] android_work: sent uevent USB_STATE=DISCONNECTED [ 10.718734] android_work: sent uevent USB_STATE=CONNECTED [ 10.765687] android_usb gadget: high speed config #1: android [ 10.774355] android_work: sent uevent USB_STATE=CONFIGURED [ 11.255587] modem_hsic_read : [ 11.258865] modem_do_read_io [ 11.261665] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 11.286070] pn_socket_ioctl with SIOCCONFIGTYPE [ 11.290809] [ 11.290812] Phonet register resource type 5 on dbc54200 [ 11.300024] pn_socket_ioctl with SIOCCONFIGSUBTYPE [ 11.304918] [ 11.304921] Phonet register resource subtype 132 on dbc54200 [ 11.312686] init: sys_prop: permission denied uid:1013 name:media.tegra.max.out.channels [ 11.321250] init: sys_prop: permission denied uid:1013 name:media.tegra.out.channel.map [ 11.390647] modem_read_bulk_callback [ 11.394187] modem_read_bulk_callback, length = 12 [ 11.399049] modem_hsic_read : copy_to_user bytes_read =12 [ 13.863168] modem_hsic_release : [ 13.923707] modem4_load: Called with value : 0 [ 13.928245] modem4_setdata: powerstate = 255. [ 13.932724] modem4_setdata: Active wakelock in UNK [ 13.937688] Wake40 for irq=53 [ 13.940763] Disabling wake40 [ 13.943761] tegra-ehci tegra-ehci.1: remove, state 1 [ 13.953816] usb usb1: USB disconnect, device number 1 [ 13.958956] usb 1-1: USB disconnect, device number 2 [ 13.964155] boot_hsic_disconnect : [ 13.968003] boot_hsic_delete : [ 13.971302] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 14.386676] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 14.487669] CPU2: shutdown [ 14.526276] modem4_pre_phy_off. [ 14.579985] modem4_load: Called with value : 1 [ 14.584798] Reset USB controller WAR. [ 14.588750] tegra USB phy - inst[1] platform info: [ 14.593605] port_otg: no [ 14.596229] has_hostpc: yes [ 14.599142] phy_interface: USB_PHY_INTF_HSIC [ 14.603557] op_mode: TEGRA_USB_OPMODE_HOST [ 14.607813] vbus_gpio: -1 [ 14.610592] vbus_reg: NULL [ 14.613412] hot_plug: disabled [ 14.616606] remote_wakeup: disabled [ 14.620197] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 14.639239] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 14.645401] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 14.654932] tegra CPU: force EDP limit 1100000 kHz [ 14.665445] CPU1: Booted secondary processor [ 14.672151] Switched to NOHz mode on CPU #1 [ 14.676226] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 14.696205] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 14.704419] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 14.711384] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 14.718848] usb usb1: Product: Tegra EHCI Host Controller [ 14.724486] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 14.730583] usb usb1: SerialNumber: tegra-ehci.1 [ 14.735823] hub 1-0:1.0: USB hub found [ 14.739742] hub 1-0:1.0: 1 port detected [ 14.743829] modem4_phy_ready. [ 14.746885] modem4_phy_ready : Driving AWR high. [ 14.826683] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 14.834322] Wake40 for irq=53 [ 14.837362] Enabling wake40 [ 15.546234] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 16.387351] nvavp nvavp: using SMMU at ff00000 to load AVP kernel [ 16.402125] nvavp nvavp: read firmware from 'nvavp_os_0ff00000.bin' (15340 bytes) [ 16.435042] nvavp nvavp: entry=00000094 control=000049d0 debug=000051d0 size=15316 [ 16.443130] nvavp nvavp: AVP os at vaddr=f0301000 paddr=ff00000 reset_addr=0ff00094 [ 16.458078] nvavp nvavp: read ucode firmware from 'nvavp_vid_ucode_alt.bin' (26284 bytes) [ 16.602927] nvavp nvavp: using SMMU at ff00000 to load AVP kernel [ 16.609523] nvavp nvavp: AVP os at vaddr=f0301000 paddr=ff00000 reset_addr=0ff00094 [ 16.765473] extern1 rate=12288000 [ 16.785208] init: sys_prop: permission denied uid:1013 name:media.tegra.max.out.channels [ 16.796708] init: sys_prop: permission denied uid:1013 name:media.tegra.max.out.channels [ 16.851930] nvavp nvavp: using SMMU at ff00000 to load AVP kernel [ 16.858522] nvavp nvavp: AVP os at vaddr=f0301000 paddr=ff00000 reset_addr=0ff00094 [ 17.076773] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 17.084058] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 17.091435] usb 1-1: Product: Pegasus-S HSIC [ 17.096230] usb 1-1: Manufacturer: Renesas [ 17.407740] CPU1: shutdown [ 17.721884] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 18.435019] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 18.445141] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 18.461973] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 18.474499] modem4_usbnotify: Modem attached. [ 18.479462] modem4_setdata: powerstate = 0. [ 18.484037] modem4_setdata: Releasing wakelock. [ 18.645835] Renesas HSIC netdevice mounted (usb0) [ 18.653153] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 18.660981] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 18.921153] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 18.929540] cdc_ncm: usb0: network connection: connected [ 18.938370] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 19.619365] CPU3: shutdown [ 20.048966] request_suspend_state: wakeup (3->0) at 19492850002 (2011-01-01 01:04:00.575448001 UTC) [ 20.200396] atmel_mxt_ts 1-004a: mxt_start: is_stopped = 0 [ 20.382855] acc_open [ 20.385172] acc_release [ 20.451650] tegra_uart tegra_uart.2: Setting clk_src clk_m [ 20.466455] tegra_uart tegra_uart.2: Setting clk_src clk_m [ 20.480820] tegra_uart tegra_uart.2: Setting clk_src clk_m [ 21.649883] tegra CPU: force EDP limit 1200000 kHz [ 21.670684] CPU1: Booted secondary processor [ 21.676156] Switched to NOHz mode on CPU #1 [ 21.744213] tegra CPU: force EDP limit 1100000 kHz [ 21.759785] CPU2: Booted secondary processor [ 21.766174] Switched to NOHz mode on CPU #2 [ 22.243440] tegra_uart tegra_uart.2: Setting clk_src pll_p [ 22.307501] Wake9 for irq=370 [ 22.310553] Enabling wake9 [ 22.313401] gpio bank wake found: wake9 for irq=87 [ 22.318267] Enabling wake9 [ 23.214091] mtp_open [ 24.644011] CPU1: shutdown [ 26.202210] init: sys_prop: permission denied uid:1013 name:media.tegra.max.out.channels [ 26.223639] extern1 rate=12288000 [ 26.733019] CPU2: shutdown [ 27.480224] init: sys_prop: permission denied uid:1013 name:media.tegra.max.out.channels [ 28.752422] CPU1: Booted secondary processor [ 28.766142] Switched to NOHz mode on CPU #1 [ 29.206166] usb0: no IPv6 routers present [ 29.849432] phonet_rcv Drop message ! [ 29.854363] phonet_rcv Drop message ! [ 30.142232] phonet_rcv Drop message ! [ 30.146579] phonet_rcv Drop message ! [ 30.742205] phonet_rcv Drop message ! [ 30.758922] phonet_rcv Drop message ! [ 30.945041] CPU1: shutdown [ 32.959089] CPU1: Booted secondary processor [ 32.966141] Switched to NOHz mode on CPU #1 [ 35.058662] tegra CPU: force EDP limit 1100000 kHz [ 35.069000] CPU2: Booted secondary processor [ 35.076166] Switched to NOHz mode on CPU #2 [ 37.533110] CPU1: shutdown [ 39.550659] CPU2: shutdown [ 39.801824] modem4_l2_suspend. [ 39.805490] modem4_setdata: powerstate = 2. [ 40.033454] cdc_ncm 1-1:1.0: usb0: Delaying transmission for resumption [ 40.040764] modem4_l2_resume. [ 40.043981] modem4_setdata: powerstate = 0. [ 40.118074] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 41.556090] CPU1: Booted secondary processor [ 41.561008] Switched to NOHz mode on CPU #1 [ 43.860769] CPU1: shutdown [ 44.315551] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 44.384113] Modem crash occurs - NB modem reboot since power on : 1 [ 44.393207] modem4_load: Called with value : 0 [ 44.397743] modem4_setdata: powerstate = 255. [ 44.402156] modem4_setdata: Taking wakelock. [ 44.406644] Wake40 for irq=53 [ 44.409664] Disabling wake40 [ 44.412602] tegra-ehci tegra-ehci.1: remove, state 1 [ 44.417716] usb usb1: USB disconnect, device number 1 [ 44.422878] usb 1-1: USB disconnect, device number 2 [ 44.428049] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 44.466418] modem4_usbnotify: Modem detached. [ 44.470910] modem4_setdata: powerstate = 255. [ 44.475317] modem4_setdata: Active wakelock in UNK [ 44.496474] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 44.516154] modem4_pre_phy_off. [ 44.520562] modem4_load: Called with value : 1 [ 44.525323] Reset USB controller WAR. [ 44.529183] tegra USB phy - inst[1] platform info: [ 44.534041] port_otg: no [ 44.536654] has_hostpc: yes [ 44.539499] phy_interface: USB_PHY_INTF_HSIC [ 44.543819] op_mode: TEGRA_USB_OPMODE_HOST [ 44.548021] vbus_gpio: -1 [ 44.550752] vbus_reg: NULL [ 44.553511] hot_plug: disabled [ 44.556637] remote_wakeup: disabled [ 44.560255] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 44.579105] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 44.585186] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 44.616159] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 44.636132] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 44.642183] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 44.649095] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 44.656466] usb usb1: Product: Tegra EHCI Host Controller [ 44.661916] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 44.667950] usb usb1: SerialNumber: tegra-ehci.1 [ 44.672909] hub 1-0:1.0: USB hub found [ 44.676745] hub 1-0:1.0: 1 port detected [ 44.680812] modem4_phy_ready. [ 44.693856] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 44.700578] Wake40 for irq=53 [ 44.703599] Enabling wake40 [ 45.066275] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 45.098369] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 45.105320] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 45.113038] usb 1-1: Product: HakuyaS USB [ 45.117351] usb 1-1: Manufacturer: Renesas [ 45.127286] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 45.707675] modem_hsic_open [ 46.714702] modem_hsic_read : [ 46.719382] modem_do_read_io [ 46.722859] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 46.730684] modem_read_bulk_callback [ 46.734684] modem_read_bulk_callback, length = 69 [ 46.740947] modem_hsic_read : copy_to_user bytes_read =69 [ 48.916991] modem_hsic_read : [ 48.920813] modem_do_read_io [ 48.924552] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 48.931944] modem_read_bulk_callback [ 48.935949] modem_read_bulk_callback, length = 12 [ 48.943001] modem_hsic_read : copy_to_user bytes_read =12 [ 51.409968] modem_hsic_release : [ 51.464234] modem4_load: Called with value : 0 [ 51.468784] modem4_setdata: powerstate = 255. [ 51.473205] modem4_setdata: Active wakelock in UNK [ 51.478202] Wake40 for irq=53 [ 51.481223] Disabling wake40 [ 51.484160] tegra-ehci tegra-ehci.1: remove, state 1 [ 51.489264] usb usb1: USB disconnect, device number 1 [ 51.494368] usb 1-1: USB disconnect, device number 2 [ 51.499565] boot_hsic_disconnect : [ 51.503354] boot_hsic_delete : [ 51.506656] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 51.526425] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 51.546172] modem4_pre_phy_off. [ 51.558577] CPU1: Booted secondary processor [ 51.566154] Switched to NOHz mode on CPU #1 [ 51.601441] modem4_load: Called with value : 1 [ 51.611941] Reset USB controller WAR. [ 51.615988] tegra USB phy - inst[1] platform info: [ 51.621072] port_otg: no [ 51.624037] has_hostpc: yes [ 51.627082] phy_interface: USB_PHY_INTF_HSIC [ 51.631576] op_mode: TEGRA_USB_OPMODE_HOST [ 51.636091] vbus_gpio: -1 [ 51.638850] vbus_reg: NULL [ 51.641671] hot_plug: disabled [ 51.644833] remote_wakeup: disabled [ 51.648581] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 51.672761] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 51.678881] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 51.716157] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 51.736137] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 51.742243] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 51.749114] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 51.756496] usb usb1: Product: Tegra EHCI Host Controller [ 51.761995] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 51.768094] usb usb1: SerialNumber: tegra-ehci.1 [ 51.773109] hub 1-0:1.0: USB hub found [ 51.777006] hub 1-0:1.0: 1 port detected [ 51.781011] modem4_phy_ready. [ 51.784038] modem4_phy_ready : Driving AWR high. [ 51.862449] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 51.869931] Wake40 for irq=53 [ 51.873016] Enabling wake40 [ 52.236274] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 53.653749] CPU1: shutdown [ 53.765947] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 53.773049] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 53.781240] usb 1-1: Product: Pegasus-S HSIC [ 53.785816] usb 1-1: Manufacturer: Renesas [ 54.411079] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 55.123091] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 55.129374] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 55.153777] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 55.167004] modem4_usbnotify: Modem attached. [ 55.171488] modem4_setdata: powerstate = 0. [ 55.175793] modem4_setdata: Releasing wakelock. [ 55.279095] Renesas HSIC netdevice mounted (usb0) [ 55.285187] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 55.292626] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 55.617526] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 55.626705] cdc_ncm: usb0: network connection: connected [ 55.644456] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 66.166261] usb0: no IPv6 routers present [ 67.378184] phonet_rcv Drop message ! [ 67.382680] phonet_rcv Drop message ! [ 67.743365] phonet_rcv Drop message ! [ 67.747918] phonet_rcv Drop message ! [ 68.632714] phonet_rcv Drop message ! [ 68.647424] phonet_rcv Drop message ! [ 73.103454] CPU1: Booted secondary processor [ 73.111201] Switched to NOHz mode on CPU #1 [ 75.230755] CPU1: shutdown [ 80.604498] modem4_l2_suspend. [ 80.643532] modem4_setdata: powerstate = 2. [ 80.867039] modem4_wake_irq: Modem wakeup request from L2. [ 80.873924] modem4_l2_resume. [ 80.877629] modem4_setdata: powerstate = 0. [ 80.940630] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 85.637370] tegra CPU: force EDP limit 1200000 kHz [ 85.647870] CPU1: Booted secondary processor [ 85.656137] Switched to NOHz mode on CPU #1 [ 87.735519] CPU1: shutdown [ 89.682033] modem4_l2_suspend. [ 89.685585] modem4_setdata: powerstate = 2. [ 92.757293] modem4_wake_irq: Modem wakeup request from L2. [ 92.796583] modem4_l2_resume. [ 92.800198] modem4_setdata: powerstate = 0. [ 92.860629] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 115.605337] modem4_l2_suspend. [ 115.609269] modem4_setdata: powerstate = 2. [ 115.707071] modem4_wake_irq: Modem wakeup request from L2. [ 115.713954] modem4_l2_resume. [ 115.717664] modem4_setdata: powerstate = 0. [ 115.780612] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 125.623534] modem4_l2_suspend. [ 125.628099] modem4_setdata: powerstate = 2. [ 125.816319] modem4_wake_irq: Modem wakeup request from L2. [ 125.823209] modem4_l2_resume. [ 125.827146] modem4_setdata: powerstate = 0. [ 125.900672] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 146.601607] modem4_l2_suspend. [ 146.604848] modem4_setdata: powerstate = 2. [ 149.717358] modem4_wake_irq: Modem wakeup request from L2. [ 149.756567] modem4_l2_resume. [ 149.760176] modem4_setdata: powerstate = 0. [ 149.820638] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 205.425417] CPU1: Booted secondary processor [ 205.431101] Switched to NOHz mode on CPU #1 [ 207.505254] CPU1: shutdown [ 210.148742] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 210.168855] Modem crash occurs - NB modem reboot since power on : 2 [ 210.188050] modem4_load: Called with value : 0 [ 210.192759] modem4_setdata: powerstate = 255. [ 210.197775] modem4_setdata: Taking wakelock. [ 210.202618] Wake40 for irq=53 [ 210.205828] Disabling wake40 [ 210.209462] tegra-ehci tegra-ehci.1: remove, state 1 [ 210.214917] usb usb1: USB disconnect, device number 1 [ 210.220291] usb 1-1: USB disconnect, device number 2 [ 210.225566] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 210.266569] modem4_usbnotify: Modem detached. [ 210.271095] modem4_setdata: powerstate = 255. [ 210.275596] modem4_setdata: Active wakelock in UNK [ 210.298413] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 210.316253] modem4_pre_phy_off. [ 210.321910] modem4_load: Called with value : 1 [ 210.326952] Reset USB controller WAR. [ 210.330932] tegra USB phy - inst[1] platform info: [ 210.336041] port_otg: no [ 210.338795] has_hostpc: yes [ 210.341736] phy_interface: USB_PHY_INTF_HSIC [ 210.346396] op_mode: TEGRA_USB_OPMODE_HOST [ 210.350641] vbus_gpio: -1 [ 210.353403] vbus_reg: NULL [ 210.356279] hot_plug: disabled [ 210.359609] remote_wakeup: disabled [ 210.363286] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 210.382512] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 210.388741] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 210.426221] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 210.446173] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 210.452376] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 210.459259] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 210.466651] usb usb1: Product: Tegra EHCI Host Controller [ 210.472247] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 210.478460] usb usb1: SerialNumber: tegra-ehci.1 [ 210.483528] hub 1-0:1.0: USB hub found [ 210.487362] hub 1-0:1.0: 1 port detected [ 210.491364] modem4_phy_ready. [ 210.504408] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 210.511151] Wake40 for irq=53 [ 210.514173] Enabling wake40 [ 210.541111] tegra CPU: force EDP limit 1200000 kHz [ 210.551495] CPU1: Booted secondary processor [ 210.556129] Switched to NOHz mode on CPU #1 [ 210.926448] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 210.957990] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 210.965145] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 210.972784] usb 1-1: Product: HakuyaS USB [ 210.977435] usb 1-1: Manufacturer: Renesas [ 210.991087] modem_hsic_open [ 210.991113] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 211.004497] modem_hsic_release : [ 211.523032] modem_hsic_open [ 211.533891] modem_hsic_read : [ 211.537759] modem_do_read_io [ 211.540756] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 211.540932] modem_read_bulk_callback [ 211.540953] modem_read_bulk_callback, length = 69 [ 211.556219] modem_hsic_read : copy_to_user bytes_read =69 [ 212.149231] modem_hsic_read : [ 212.152449] modem_do_read_io [ 212.155286] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 212.280776] modem_read_bulk_callback [ 212.284241] modem_read_bulk_callback, length = 12 [ 212.294056] modem_hsic_read : copy_to_user bytes_read =12 [ 214.637353] tegra CPU: force EDP limit 1100000 kHz [ 214.649296] CPU2: Booted secondary processor [ 214.656140] Switched to NOHz mode on CPU #2 [ 214.757936] modem_hsic_release : [ 214.811788] modem4_load: Called with value : 0 [ 214.816325] modem4_setdata: powerstate = 255. [ 214.820799] modem4_setdata: Active wakelock in UNK [ 214.825731] Wake40 for irq=53 [ 214.828759] Disabling wake40 [ 214.831789] tegra-ehci tegra-ehci.1: remove, state 1 [ 214.836862] usb usb1: USB disconnect, device number 1 [ 214.841977] usb 1-1: USB disconnect, device number 2 [ 214.847165] boot_hsic_disconnect : [ 214.850985] boot_hsic_delete : [ 214.854283] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 215.056547] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 215.186181] modem4_pre_phy_off. [ 215.239691] modem4_load: Called with value : 1 [ 215.244413] Reset USB controller WAR. [ 215.248349] tegra USB phy - inst[1] platform info: [ 215.253217] port_otg: no [ 215.255824] has_hostpc: yes [ 215.258701] phy_interface: USB_PHY_INTF_HSIC [ 215.263032] op_mode: TEGRA_USB_OPMODE_HOST [ 215.267208] vbus_gpio: -1 [ 215.269889] vbus_reg: NULL [ 215.272718] hot_plug: disabled [ 215.275831] remote_wakeup: disabled [ 215.279423] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 215.298360] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 215.304407] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 215.336173] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 215.358541] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 215.364796] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 215.371964] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 215.379416] usb usb1: Product: Tegra EHCI Host Controller [ 215.385146] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 215.391317] usb usb1: SerialNumber: tegra-ehci.1 [ 215.397297] hub 1-0:1.0: USB hub found [ 215.401253] hub 1-0:1.0: 1 port detected [ 215.405537] modem4_phy_ready. [ 215.408767] modem4_phy_ready : Driving AWR high. [ 215.503116] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 215.511354] Wake40 for irq=53 [ 215.514501] Enabling wake40 [ 218.541717] CPU1: shutdown [ 218.796254] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 220.326219] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 220.333414] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 220.341570] usb 1-1: Product: Pegasus-S HSIC [ 220.346500] usb 1-1: Manufacturer: Renesas [ 220.547963] CPU2: shutdown [ 220.972420] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 221.679884] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 221.686121] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 221.709463] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 221.721589] modem4_usbnotify: Modem attached. [ 221.726458] modem4_setdata: powerstate = 0. [ 221.730810] modem4_setdata: Releasing wakelock. [ 221.750273] Renesas HSIC netdevice mounted (usb0) [ 221.755340] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 221.760802] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 222.163841] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 222.172928] cdc_ncm: usb0: network connection: connected [ 222.181691] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 232.496331] usb0: no IPv6 routers present [ 233.336841] phonet_rcv Drop message ! [ 233.341342] phonet_rcv Drop message ! [ 233.694591] phonet_rcv Drop message ! [ 233.699617] phonet_rcv Drop message ! [ 234.879360] phonet_rcv Drop message ! [ 234.893776] phonet_rcv Drop message ! [ 238.646222] tegra CPU: force EDP limit 1200000 kHz [ 238.662817] CPU1: Booted secondary processor [ 238.676150] Switched to NOHz mode on CPU #1 [ 238.717642] tegra CPU: force EDP limit 1100000 kHz [ 238.733728] CPU2: Booted secondary processor [ 238.746151] Switched to NOHz mode on CPU #2 [ 242.138284] CPU1: shutdown [ 243.579094] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 243.593531] Modem crash occurs - NB modem reboot since power on : 3 [ 243.606805] modem4_load: Called with value : 0 [ 243.611516] modem4_setdata: powerstate = 255. [ 243.616016] modem4_setdata: Taking wakelock. [ 243.620473] Wake40 for irq=53 [ 243.623560] Disabling wake40 [ 243.626515] tegra-ehci tegra-ehci.1: remove, state 1 [ 243.631556] usb usb1: USB disconnect, device number 1 [ 243.636739] usb 1-1: USB disconnect, device number 2 [ 243.641838] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 243.756468] modem4_usbnotify: Modem detached. [ 243.760906] modem4_setdata: powerstate = 255. [ 243.765374] modem4_setdata: Active wakelock in UNK [ 243.837944] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 243.886276] modem4_pre_phy_off. [ 243.891642] modem4_load: Called with value : 1 [ 243.896738] Reset USB controller WAR. [ 243.900777] tegra USB phy - inst[1] platform info: [ 243.905685] port_otg: no [ 243.908375] has_hostpc: yes [ 243.911236] phy_interface: USB_PHY_INTF_HSIC [ 243.915623] op_mode: TEGRA_USB_OPMODE_HOST [ 243.919799] vbus_gpio: -1 [ 243.922476] vbus_reg: NULL [ 243.925297] hot_plug: disabled [ 243.928421] remote_wakeup: disabled [ 243.931991] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 243.950930] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 243.957001] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 243.986185] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 244.006147] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 244.012213] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 244.019176] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 244.026474] usb usb1: Product: Tegra EHCI Host Controller [ 244.032002] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 244.038017] usb usb1: SerialNumber: tegra-ehci.1 [ 244.043162] hub 1-0:1.0: USB hub found [ 244.047016] hub 1-0:1.0: 1 port detected [ 244.051028] modem4_phy_ready. [ 244.064162] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 244.070927] Wake40 for irq=53 [ 244.074017] Enabling wake40 [ 244.427686] CPU2: shutdown [ 244.626376] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 244.657983] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 244.664934] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 244.672756] usb 1-1: Product: HakuyaS USB [ 244.677140] usb 1-1: Manufacturer: Renesas [ 244.696227] modem_hsic_open [ 244.699015] modem_hsic_release : [ 244.702990] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 245.078254] modem_hsic_open [ 246.084944] modem_hsic_read : [ 246.088920] modem_do_read_io [ 246.092158] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 246.098716] modem_read_bulk_callback [ 246.102549] modem_read_bulk_callback, length = 69 [ 246.108176] modem_hsic_read : copy_to_user bytes_read =69 [ 246.748394] tegra CPU: force EDP limit 1200000 kHz [ 246.758856] CPU1: Booted secondary processor [ 246.766136] Switched to NOHz mode on CPU #1 [ 247.726819] modem_hsic_read : [ 247.730265] modem_do_read_io [ 247.733287] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 247.740111] modem_read_bulk_callback [ 247.743759] modem_read_bulk_callback, length = 12 [ 247.749193] modem_hsic_read : copy_to_user bytes_read =12 [ 249.837297] tegra CPU: force EDP limit 1100000 kHz [ 249.847775] CPU2: Booted secondary processor [ 249.856130] Switched to NOHz mode on CPU #2 [ 250.213856] modem_hsic_release : [ 250.267733] modem4_load: Called with value : 0 [ 250.272304] modem4_setdata: powerstate = 255. [ 250.276753] modem4_setdata: Active wakelock in UNK [ 250.281778] Wake40 for irq=53 [ 250.284839] Disabling wake40 [ 250.297415] tegra-ehci tegra-ehci.1: remove, state 1 [ 250.302466] usb usb1: USB disconnect, device number 1 [ 250.307666] usb 1-1: USB disconnect, device number 2 [ 250.312784] boot_hsic_disconnect : [ 250.316681] boot_hsic_delete : [ 250.319979] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 250.466560] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 250.596181] modem4_pre_phy_off. [ 250.649704] modem4_load: Called with value : 1 [ 250.654494] Reset USB controller WAR. [ 250.658321] tegra USB phy - inst[1] platform info: [ 250.663233] port_otg: no [ 250.665826] has_hostpc: yes [ 250.668695] phy_interface: USB_PHY_INTF_HSIC [ 250.673024] op_mode: TEGRA_USB_OPMODE_HOST [ 250.677248] vbus_gpio: -1 [ 250.679928] vbus_reg: NULL [ 250.682694] hot_plug: disabled [ 250.685806] remote_wakeup: disabled [ 250.689447] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 250.708314] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 250.714424] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 250.746172] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 250.766137] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 250.772242] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 250.779118] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 250.786470] usb usb1: Product: Tegra EHCI Host Controller [ 250.791928] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 250.797978] usb usb1: SerialNumber: tegra-ehci.1 [ 250.803019] hub 1-0:1.0: USB hub found [ 250.806932] hub 1-0:1.0: 1 port detected [ 250.810945] modem4_phy_ready. [ 250.813976] modem4_phy_ready : Driving AWR high. [ 250.893596] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 250.901123] Wake40 for irq=53 [ 250.904216] Enabling wake40 [ 251.276284] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 252.805143] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 252.812378] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 252.820069] usb 1-1: Product: Pegasus-S HSIC [ 252.824589] usb 1-1: Manufacturer: Renesas [ 253.037299] CPU1: shutdown [ 253.450192] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 254.163208] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 254.169466] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 254.184459] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 254.202979] modem4_usbnotify: Modem attached. [ 254.207745] modem4_setdata: powerstate = 0. [ 254.212097] modem4_setdata: Releasing wakelock. [ 254.310015] Renesas HSIC netdevice mounted (usb0) [ 254.316051] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 254.323570] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 254.649754] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 254.658475] cdc_ncm: usb0: network connection: connected [ 254.667156] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 255.074774] CPU2: shutdown [ 265.226256] usb0: no IPv6 routers present [ 266.051696] phonet_rcv Drop message ! [ 266.056783] phonet_rcv Drop message ! [ 266.423256] phonet_rcv Drop message ! [ 266.427851] phonet_rcv Drop message ! [ 267.378487] phonet_rcv Drop message ! [ 267.392984] phonet_rcv Drop message ! [ 273.919334] CPU1: Booted secondary processor [ 273.926153] Switched to NOHz mode on CPU #1 [ 275.602227] modem4_l2_suspend. [ 275.605586] modem4_setdata: powerstate = 2. [ 276.112550] CPU1: shutdown [ 285.126352] modem4_wake_irq: Modem wakeup request from L2. [ 285.166557] modem4_l2_resume. [ 285.170664] modem4_setdata: powerstate = 0. [ 285.233034] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 287.404060] CPU1: Booted secondary processor [ 287.411144] Switched to NOHz mode on CPU #1 [ 289.507454] CPU1: shutdown [ 289.811719] modem4_l2_suspend. [ 289.815814] modem4_setdata: powerstate = 2. [ 289.951297] cdc_ncm 1-1:1.0: usb0: Delaying transmission for resumption [ 289.958328] modem4_l2_resume. [ 289.961538] modem4_setdata: powerstate = 0. [ 290.037833] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 292.614548] modem4_l2_suspend. [ 292.634845] modem4_setdata: powerstate = 2. [ 293.082775] modem4_wake_irq: Modem wakeup request from L2. [ 293.090395] modem4_l2_resume. [ 293.093725] modem4_setdata: powerstate = 0. [ 293.157937] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 293.353593] CPU1: Booted secondary processor [ 293.361096] Switched to NOHz mode on CPU #1 [ 295.457295] CPU1: shutdown [ 301.624227] modem4_l2_suspend. [ 301.628639] modem4_setdata: powerstate = 2. [ 304.594476] modem4_wake_irq: Modem wakeup request from L2. [ 304.636695] modem4_l2_resume. [ 304.640362] modem4_setdata: powerstate = 0. [ 304.701342] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 340.413482] CPU1: Booted secondary processor [ 340.421053] Switched to NOHz mode on CPU #1 [ 343.697870] CPU1: shutdown [ 345.131033] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 345.137459] Modem crash occurs - NB modem reboot since power on : 4 [ 345.152887] modem4_load: Called with value : 0 [ 345.158054] modem4_setdata: powerstate = 255. [ 345.162986] modem4_setdata: Taking wakelock. [ 345.167595] Wake40 for irq=53 [ 345.170680] Disabling wake40 [ 345.173676] tegra-ehci tegra-ehci.1: remove, state 1 [ 345.179118] usb usb1: USB disconnect, device number 1 [ 345.184352] usb 1-1: USB disconnect, device number 2 [ 345.189708] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 345.236356] modem4_usbnotify: Modem detached. [ 345.240835] modem4_setdata: powerstate = 255. [ 345.245243] modem4_setdata: Active wakelock in UNK [ 345.277219] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 345.296284] modem4_pre_phy_off. [ 345.302673] modem4_load: Called with value : 1 [ 345.308271] Reset USB controller WAR. [ 345.312436] tegra USB phy - inst[1] platform info: [ 345.317725] port_otg: no [ 345.320489] has_hostpc: yes [ 345.323508] phy_interface: USB_PHY_INTF_HSIC [ 345.328362] op_mode: TEGRA_USB_OPMODE_HOST [ 345.333028] vbus_gpio: -1 [ 345.335763] vbus_reg: NULL [ 345.338609] hot_plug: disabled [ 345.341774] remote_wakeup: disabled [ 345.345508] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 345.365510] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 345.371661] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 345.406174] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 345.426235] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 345.432600] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 345.439589] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 345.447101] usb usb1: Product: Tegra EHCI Host Controller [ 345.452643] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 345.459127] usb usb1: SerialNumber: tegra-ehci.1 [ 345.464792] hub 1-0:1.0: USB hub found [ 345.469041] hub 1-0:1.0: 1 port detected [ 345.473072] modem4_phy_ready. [ 345.486217] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 345.492946] Wake40 for irq=53 [ 345.495970] Enabling wake40 [ 345.726833] tegra CPU: force EDP limit 1200000 kHz [ 345.741646] CPU1: Booted secondary processor [ 345.746137] Switched to NOHz mode on CPU #1 [ 345.787370] tegra CPU: force EDP limit 1100000 kHz [ 345.798312] CPU2: Booted secondary processor [ 345.806136] Switched to NOHz mode on CPU #2 [ 345.876321] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 345.908843] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 345.915996] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 345.923615] usb 1-1: Product: HakuyaS USB [ 345.928181] usb 1-1: Manufacturer: Renesas [ 345.947424] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 345.948265] modem_hsic_open [ 345.948310] modem_hsic_release : [ 346.499972] modem_hsic_open [ 346.506381] modem_hsic_read : [ 346.510184] modem_do_read_io [ 346.513228] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 346.513458] modem_read_bulk_callback [ 346.513481] modem_read_bulk_callback, length = 69 [ 346.528847] modem_hsic_read : copy_to_user bytes_read =69 [ 347.256095] modem_hsic_read : [ 347.259337] modem_do_read_io [ 347.262183] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 347.387493] modem_read_bulk_callback [ 347.390965] modem_read_bulk_callback, length = 12 [ 347.395882] modem_hsic_read : copy_to_user bytes_read =12 [ 347.902751] CPU1: shutdown [ 349.864736] modem_hsic_release : [ 349.918592] modem4_load: Called with value : 0 [ 349.923096] modem4_setdata: powerstate = 255. [ 349.927586] modem4_setdata: Active wakelock in UNK [ 349.932514] Wake40 for irq=53 [ 349.935541] Disabling wake40 [ 349.938559] tegra-ehci tegra-ehci.1: remove, state 1 [ 349.943602] usb usb1: USB disconnect, device number 1 [ 349.948727] usb 1-1: USB disconnect, device number 2 [ 349.953891] boot_hsic_disconnect : [ 349.957735] boot_hsic_delete : [ 349.961029] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 349.987428] tegra CPU: force EDP limit 1100000 kHz [ 349.996688] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 349.998158] CPU1: Booted secondary processor [ 350.006147] Switched to NOHz mode on CPU #1 [ 350.116196] modem4_pre_phy_off. [ 350.169789] modem4_load: Called with value : 1 [ 350.174531] Reset USB controller WAR. [ 350.178436] tegra USB phy - inst[1] platform info: [ 350.183287] port_otg: no [ 350.185880] has_hostpc: yes [ 350.188822] phy_interface: USB_PHY_INTF_HSIC [ 350.193171] op_mode: TEGRA_USB_OPMODE_HOST [ 350.197373] vbus_gpio: -1 [ 350.200131] vbus_reg: NULL [ 350.202912] hot_plug: disabled [ 350.206065] remote_wakeup: disabled [ 350.210139] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 350.229501] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 350.235631] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 350.276190] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 350.296152] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 350.302200] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 350.309348] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 350.317073] usb usb1: Product: Tegra EHCI Host Controller [ 350.322535] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 350.328584] usb usb1: SerialNumber: tegra-ehci.1 [ 350.333654] hub 1-0:1.0: USB hub found [ 350.337512] hub 1-0:1.0: 1 port detected [ 350.341582] modem4_phy_ready. [ 350.344611] modem4_phy_ready : Driving AWR high. [ 350.434522] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 350.442165] Wake40 for irq=53 [ 350.445197] Enabling wake40 [ 350.836331] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 352.365215] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 352.372468] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 352.380270] usb 1-1: Product: Pegasus-S HSIC [ 352.385152] usb 1-1: Manufacturer: Renesas [ 352.926120] CPU1: shutdown [ 353.010238] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 353.723454] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 353.729716] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 353.746731] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 353.761032] modem4_usbnotify: Modem attached. [ 353.765846] modem4_setdata: powerstate = 0. [ 353.770338] modem4_setdata: Releasing wakelock. [ 353.851082] Renesas HSIC netdevice mounted (usb0) [ 353.857416] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 353.864966] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 354.207638] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 354.217576] cdc_ncm: usb0: network connection: connected [ 354.228289] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 354.897214] CPU2: shutdown [ 364.816259] usb0: no IPv6 routers present [ 365.190477] phonet_rcv Drop message ! [ 365.194976] phonet_rcv Drop message ! [ 365.555040] phonet_rcv Drop message ! [ 365.559620] phonet_rcv Drop message ! [ 366.591764] phonet_rcv Drop message ! [ 366.606221] phonet_rcv Drop message ! [ 371.214006] CPU1: Booted secondary processor [ 371.221207] Switched to NOHz mode on CPU #1 [ 373.292574] CPU1: shutdown [ 379.565068] modem4_l2_suspend. [ 379.568970] modem4_setdata: powerstate = 2. [ 379.740164] modem4_wake_irq: Modem wakeup request from L2. [ 379.747295] modem4_l2_resume. [ 379.750886] modem4_setdata: powerstate = 0. [ 379.821239] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 382.273469] CPU1: Booted secondary processor [ 382.281133] Switched to NOHz mode on CPU #1 [ 385.362380] CPU1: shutdown [ 386.186682] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 386.192722] Modem crash occurs - NB modem reboot since power on : 5 [ 386.208145] modem4_load: Called with value : 0 [ 386.212713] modem4_setdata: powerstate = 255. [ 386.217392] modem4_setdata: Taking wakelock. [ 386.221925] Wake40 for irq=53 [ 386.225009] Disabling wake40 [ 386.228366] tegra-ehci tegra-ehci.1: remove, state 1 [ 386.233546] usb usb1: USB disconnect, device number 1 [ 386.238878] usb 1-1: USB disconnect, device number 2 [ 386.244112] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 386.286346] modem4_usbnotify: Modem detached. [ 386.290767] modem4_setdata: powerstate = 255. [ 386.295233] modem4_setdata: Active wakelock in UNK [ 386.327246] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 386.346254] modem4_pre_phy_off. [ 386.352851] modem4_load: Called with value : 1 [ 386.358255] Reset USB controller WAR. [ 386.362574] tegra USB phy - inst[1] platform info: [ 386.368020] port_otg: no [ 386.370836] has_hostpc: yes [ 386.373860] phy_interface: USB_PHY_INTF_HSIC [ 386.378900] op_mode: TEGRA_USB_OPMODE_HOST [ 386.383399] vbus_gpio: -1 [ 386.386164] vbus_reg: NULL [ 386.388984] hot_plug: disabled [ 386.392249] remote_wakeup: disabled [ 386.395882] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 386.416877] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 386.423084] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 386.456170] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 386.476191] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 386.482542] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 386.489531] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 386.497101] usb usb1: Product: Tegra EHCI Host Controller [ 386.502791] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 386.509131] usb usb1: SerialNumber: tegra-ehci.1 [ 386.514855] hub 1-0:1.0: USB hub found [ 386.518989] hub 1-0:1.0: 1 port detected [ 386.523017] modem4_phy_ready. [ 386.536222] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 386.542949] Wake40 for irq=53 [ 386.545972] Enabling wake40 [ 386.906285] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 386.937938] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 386.945094] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 386.955039] usb 1-1: Product: HakuyaS USB [ 386.959834] usb 1-1: Manufacturer: Renesas [ 386.975730] modem_hsic_open [ 386.978593] modem_hsic_release : [ 386.983675] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 387.378018] tegra CPU: force EDP limit 1200000 kHz [ 387.388271] CPU1: Booted secondary processor [ 387.396151] Switched to NOHz mode on CPU #1 [ 387.447327] tegra CPU: force EDP limit 1100000 kHz [ 387.458335] CPU2: Booted secondary processor [ 387.466137] Switched to NOHz mode on CPU #2 [ 387.549889] modem_hsic_open [ 387.557359] modem_hsic_read : [ 387.561197] modem_do_read_io [ 387.564419] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 387.564528] modem_read_bulk_callback [ 387.564551] modem_read_bulk_callback, length = 69 [ 387.579684] modem_hsic_read : copy_to_user bytes_read =69 [ 388.177463] modem_hsic_read : [ 388.180745] modem_do_read_io [ 388.183533] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 388.308867] modem_read_bulk_callback [ 388.312408] modem_read_bulk_callback, length = 12 [ 388.317321] modem_hsic_read : copy_to_user bytes_read =12 [ 390.781413] modem_hsic_release : [ 390.793014] CPU2: shutdown [ 390.835594] modem4_load: Called with value : 0 [ 390.840135] modem4_setdata: powerstate = 255. [ 390.844605] modem4_setdata: Active wakelock in UNK [ 390.849550] Wake40 for irq=53 [ 390.852635] Disabling wake40 [ 390.855576] tegra-ehci tegra-ehci.1: remove, state 1 [ 390.860635] usb usb1: USB disconnect, device number 1 [ 390.865798] usb 1-1: USB disconnect, device number 2 [ 390.870920] boot_hsic_disconnect : [ 390.874733] boot_hsic_delete : [ 390.878116] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 391.426506] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 391.506314] modem4_pre_phy_off. [ 391.560900] modem4_load: Called with value : 1 [ 391.566609] Reset USB controller WAR. [ 391.570805] tegra USB phy - inst[1] platform info: [ 391.575827] port_otg: no [ 391.578710] has_hostpc: yes [ 391.581941] phy_interface: USB_PHY_INTF_HSIC [ 391.586486] op_mode: TEGRA_USB_OPMODE_HOST [ 391.590816] vbus_gpio: -1 [ 391.593864] vbus_reg: NULL [ 391.596864] hot_plug: disabled [ 391.600044] remote_wakeup: disabled [ 391.603750] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 391.622987] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 391.629120] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 391.666160] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 391.686211] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 391.692621] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 391.700096] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 391.707937] usb usb1: Product: Tegra EHCI Host Controller [ 391.713586] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 391.720011] usb usb1: SerialNumber: tegra-ehci.1 [ 391.725430] hub 1-0:1.0: USB hub found [ 391.729363] hub 1-0:1.0: 1 port detected [ 391.733542] modem4_phy_ready. [ 391.736735] modem4_phy_ready : Driving AWR high. [ 391.815194] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 391.822793] Wake40 for irq=53 [ 391.825821] Enabling wake40 [ 392.301537] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 393.538198] CPU1: shutdown [ 393.840444] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 393.848007] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 393.855645] usb 1-1: Product: Pegasus-S HSIC [ 393.860305] usb 1-1: Manufacturer: Renesas [ 394.485529] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 395.197430] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 395.203659] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 395.220433] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 395.231262] Renesas HSIC netdevice mounted (usb0) [ 395.236954] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 395.242840] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 395.252499] modem4_usbnotify: Modem attached. [ 395.257809] modem4_setdata: powerstate = 0. [ 395.262095] modem4_setdata: Releasing wakelock. [ 395.687240] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 395.701290] cdc_ncm: usb0: network connection: connected [ 395.713307] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 405.746265] usb0: no IPv6 routers present [ 406.920523] phonet_rcv Drop message ! [ 406.925011] phonet_rcv Drop message ! [ 407.309067] phonet_rcv Drop message ! [ 407.314043] phonet_rcv Drop message ! [ 408.163854] phonet_rcv Drop message ! [ 408.178254] phonet_rcv Drop message ! [ 416.083894] CPU1: Booted secondary processor [ 416.096211] Switched to NOHz mode on CPU #1 [ 418.178797] CPU1: shutdown [ 422.142834] CPU1: Booted secondary processor [ 422.156158] Switched to NOHz mode on CPU #1 [ 422.223736] CPU2: Booted secondary processor [ 422.236155] Switched to NOHz mode on CPU #2 [ 425.121873] CPU1: shutdown [ 426.058187] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 426.070324] Modem crash occurs - NB modem reboot since power on : 6 [ 426.089672] modem4_load: Called with value : 0 [ 426.094361] modem4_setdata: powerstate = 255. [ 426.098894] modem4_setdata: Taking wakelock. [ 426.103425] Wake40 for irq=53 [ 426.106613] Disabling wake40 [ 426.109639] tegra-ehci tegra-ehci.1: remove, state 1 [ 426.114762] usb usb1: USB disconnect, device number 1 [ 426.120073] usb 1-1: USB disconnect, device number 2 [ 426.125183] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 426.216913] modem4_usbnotify: Modem detached. [ 426.221533] modem4_setdata: powerstate = 255. [ 426.226379] modem4_setdata: Active wakelock in UNK [ 426.307244] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 426.366349] modem4_pre_phy_off. [ 426.373002] modem4_load: Called with value : 1 [ 426.378492] Reset USB controller WAR. [ 426.382869] tegra USB phy - inst[1] platform info: [ 426.387989] port_otg: no [ 426.390654] has_hostpc: yes [ 426.393660] phy_interface: USB_PHY_INTF_HSIC [ 426.398070] op_mode: TEGRA_USB_OPMODE_HOST [ 426.402281] vbus_gpio: -1 [ 426.405112] vbus_reg: NULL [ 426.407964] hot_plug: disabled [ 426.411085] remote_wakeup: disabled [ 426.414651] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 426.433568] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 426.439686] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 426.476236] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 426.496186] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 426.502393] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 426.509500] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 426.516888] usb usb1: Product: Tegra EHCI Host Controller [ 426.522551] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 426.528654] usb usb1: SerialNumber: tegra-ehci.1 [ 426.533875] hub 1-0:1.0: USB hub found [ 426.537743] hub 1-0:1.0: 1 port detected [ 426.541840] modem4_phy_ready. [ 426.554905] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 426.561645] Wake40 for irq=53 [ 426.564732] Enabling wake40 [ 427.117676] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 427.159456] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 427.186397] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 427.201060] usb 1-1: Product: HakuyaS USB [ 427.223217] usb 1-1: Manufacturer: Renesas [ 427.248148] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 427.264967] tegra CPU: force EDP limit 1100000 kHz [ 427.273923] modem_hsic_openCPU1: Booted secondary processor [ 427.285246] modem_hsic_release : [ 427.288878] Switched to NOHz mode on CPU #1 [ 427.568943] modem_hsic_open [ 427.575109] modem_hsic_read : [ 427.579012] modem_do_read_io [ 427.582224] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 427.588801] modem_read_bulk_callback [ 427.592461] modem_read_bulk_callback, length = 69 [ 427.602971] modem_hsic_read : copy_to_user bytes_read =69 [ 428.227335] modem_hsic_read : [ 428.230620] modem_do_read_io [ 428.233410] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 428.362301] modem_read_bulk_callback [ 428.365830] modem_read_bulk_callback, length = 12 [ 428.370698] modem_hsic_read : copy_to_user bytes_read =12 [ 429.533465] CPU1: shutdown [ 430.337368] tegra CPU: force EDP limit 1100000 kHz [ 430.347853] CPU1: Booted secondary processor [ 430.356137] Switched to NOHz mode on CPU #1 [ 430.835962] modem_hsic_release : [ 430.894668] modem4_load: Called with value : 0 [ 430.899259] modem4_setdata: powerstate = 255. [ 430.903674] modem4_setdata: Active wakelock in UNK [ 430.908623] Wake40 for irq=53 [ 430.911651] Disabling wake40 [ 430.914609] tegra-ehci tegra-ehci.1: remove, state 1 [ 430.920361] usb usb1: USB disconnect, device number 1 [ 430.925772] usb 1-1: USB disconnect, device number 2 [ 430.930915] boot_hsic_disconnect : [ 430.934803] boot_hsic_delete : [ 430.938151] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 431.086466] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 431.216178] modem4_pre_phy_off. [ 431.269718] modem4_load: Called with value : 1 [ 431.274508] Reset USB controller WAR. [ 431.278362] tegra USB phy - inst[1] platform info: [ 431.283742] port_otg: no [ 431.286469] has_hostpc: yes [ 431.289348] phy_interface: USB_PHY_INTF_HSIC [ 431.293677] op_mode: TEGRA_USB_OPMODE_HOST [ 431.297910] vbus_gpio: -1 [ 431.300590] vbus_reg: NULL [ 431.303358] hot_plug: disabled [ 431.306480] remote_wakeup: disabled [ 431.310111] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 431.328989] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 431.335107] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 431.366161] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 431.386161] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 431.392361] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 431.399229] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 431.406608] usb usb1: Product: Tegra EHCI Host Controller [ 431.412097] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 431.418178] usb usb1: SerialNumber: tegra-ehci.1 [ 431.423347] hub 1-0:1.0: USB hub found [ 431.427413] hub 1-0:1.0: 1 port detected [ 431.431442] modem4_phy_ready. [ 431.434471] modem4_phy_ready : Driving AWR high. [ 431.514027] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 431.521594] Wake40 for irq=53 [ 431.524688] Enabling wake40 [ 431.896395] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 433.427271] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 433.434440] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 433.442165] usb 1-1: Product: Pegasus-S HSIC [ 433.446779] usb 1-1: Manufacturer: Renesas [ 433.673753] CPU1: shutdown [ 434.072429] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 434.785464] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 434.791740] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 434.805116] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 434.820136] modem4_usbnotify: Modem attached. [ 434.824622] modem4_setdata: powerstate = 0. [ 434.828978] modem4_setdata: Releasing wakelock. [ 434.930286] Renesas HSIC netdevice mounted (usb0) [ 434.936900] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 434.944814] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 435.275867] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 435.286614] cdc_ncm: usb0: network connection: connected [ 435.308411] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 435.641976] CPU2: shutdown [ 445.366262] usb0: no IPv6 routers present [ 446.703937] phonet_rcv Drop message ! [ 446.709031] phonet_rcv Drop message ! [ 447.060713] phonet_rcv Drop message ! [ 447.065166] phonet_rcv Drop message ! [ 447.908813] phonet_rcv Drop message ! [ 447.923247] phonet_rcv Drop message ! [ 454.000143] CPU1: Booted secondary processor [ 454.006139] Switched to NOHz mode on CPU #1 [ 456.263730] CPU1: shutdown [ 458.275865] CPU1: Booted secondary processor [ 458.281181] Switched to NOHz mode on CPU #1 [ 458.453480] CPU2: Booted secondary processor [ 458.466241] Switched to NOHz mode on CPU #2 [ 461.479036] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 461.484561] Modem crash occurs - NB modem reboot since power on : 7 [ 461.502814] modem4_load: Called with value : 0 [ 461.507469] modem4_setdata: powerstate = 255. [ 461.511951] modem4_setdata: Taking wakelock. [ 461.516581] Wake40 for irq=53 [ 461.519616] Disabling wake40 [ 461.522568] tegra-ehci tegra-ehci.1: remove, state 1 [ 461.527692] usb usb1: USB disconnect, device number 1 [ 461.532806] usb 1-1: USB disconnect, device number 2 [ 461.537988] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 461.557618] CPU1: shutdown [ 461.687010] modem4_usbnotify: Modem detached. [ 461.691836] modem4_setdata: powerstate = 255. [ 461.696521] modem4_setdata: Active wakelock in UNK [ 461.736866] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 461.776506] modem4_pre_phy_off. [ 461.781442] modem4_load: Called with value : 1 [ 461.786494] Reset USB controller WAR. [ 461.790382] tegra USB phy - inst[1] platform info: [ 461.795437] port_otg: no [ 461.798178] has_hostpc: yes [ 461.801113] phy_interface: USB_PHY_INTF_HSIC [ 461.805494] op_mode: TEGRA_USB_OPMODE_HOST [ 461.809910] vbus_gpio: -1 [ 461.812602] vbus_reg: NULL [ 461.815372] hot_plug: disabled [ 461.818535] remote_wakeup: disabled [ 461.822179] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 461.841175] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 461.847287] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 461.876249] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 461.896192] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 461.902421] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 461.909329] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 461.916712] usb usb1: Product: Tegra EHCI Host Controller [ 461.922182] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 461.928240] usb usb1: SerialNumber: tegra-ehci.1 [ 461.933375] hub 1-0:1.0: USB hub found [ 461.937284] hub 1-0:1.0: 1 port detected [ 461.941291] modem4_phy_ready. [ 461.954338] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 461.961158] Wake40 for irq=53 [ 461.964186] Enabling wake40 [ 462.326272] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 462.358633] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 462.365793] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 462.373357] usb 1-1: Product: HakuyaS USB [ 462.377910] usb 1-1: Manufacturer: Renesas [ 462.400766] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 462.405029] modem_hsic_open [ 462.405126] modem_hsic_release : [ 462.968107] modem_hsic_open [ 462.974479] modem_hsic_read : [ 462.978400] modem_do_read_io [ 462.981401] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 462.988202] modem_read_bulk_callback [ 462.991859] modem_read_bulk_callback, length = 69 [ 462.997234] modem_hsic_read : copy_to_user bytes_read =69 [ 463.589338] modem_hsic_read : [ 463.592560] modem_do_read_io [ 463.595340] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 463.658115] tegra CPU: force EDP limit 1100000 kHz [ 463.672750] CPU1: Booted secondary processor [ 463.686153] Switched to NOHz mode on CPU #1 [ 463.724401] modem_read_bulk_callback [ 463.728007] modem_read_bulk_callback, length = 12 [ 463.733381] modem_hsic_read : copy_to_user bytes_read =12 [ 466.212820] modem_hsic_release : [ 466.262924] CPU2: shutdown [ 466.266778] modem4_load: Called with value : 0 [ 466.271337] modem4_setdata: powerstate = 255. [ 466.275828] modem4_setdata: Active wakelock in UNK [ 466.280783] Wake40 for irq=53 [ 466.283811] Disabling wake40 [ 466.286775] tegra-ehci tegra-ehci.1: remove, state 1 [ 466.291881] usb usb1: USB disconnect, device number 1 [ 466.297049] usb 1-1: USB disconnect, device number 2 [ 466.302315] boot_hsic_disconnect : [ 466.306331] boot_hsic_delete : [ 466.309633] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 466.346478] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 466.362162] tegra CPU: force EDP limit 1100000 kHz [ 466.373920] CPU2: Booted secondary processor [ 466.386136] Switched to NOHz mode on CPU #2 [ 466.456589] modem4_pre_phy_off. [ 466.510129] modem4_load: Called with value : 1 [ 466.514865] Reset USB controller WAR. [ 466.518741] tegra USB phy - inst[1] platform info: [ 466.523591] port_otg: no [ 466.526215] has_hostpc: yes [ 466.529128] phy_interface: USB_PHY_INTF_HSIC [ 466.533476] op_mode: TEGRA_USB_OPMODE_HOST [ 466.537666] vbus_gpio: -1 [ 466.540440] vbus_reg: NULL [ 466.543208] hot_plug: disabled [ 466.546339] remote_wakeup: disabled [ 466.549914] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 466.568861] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 466.574976] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 466.606159] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 466.626153] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 466.632199] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 466.639164] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 466.646565] usb usb1: Product: Tegra EHCI Host Controller [ 466.652039] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 466.658095] usb usb1: SerialNumber: tegra-ehci.1 [ 466.663186] hub 1-0:1.0: USB hub found [ 466.667079] hub 1-0:1.0: 1 port detected [ 466.671203] modem4_phy_ready. [ 466.674246] modem4_phy_ready : Driving AWR high. [ 466.778056] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 466.785665] Wake40 for irq=53 [ 466.788722] Enabling wake40 [ 467.146318] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 468.674085] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 468.681344] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 468.688926] usb 1-1: Product: Pegasus-S HSIC [ 468.693645] usb 1-1: Manufacturer: Renesas [ 468.867736] CPU1: shutdown [ 469.319307] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 470.030196] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 470.036647] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 470.054792] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 470.073978] modem4_usbnotify: Modem attached. [ 470.078610] modem4_setdata: powerstate = 0. [ 470.082915] modem4_setdata: Releasing wakelock. [ 470.194546] Renesas HSIC netdevice mounted (usb0) [ 470.200779] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 470.213315] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 470.513268] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 470.522154] cdc_ncm: usb0: network connection: connected [ 470.535049] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 470.988853] CPU2: shutdown [ 480.986268] usb0: no IPv6 routers present [ 481.583825] phonet_rcv Drop message ! [ 481.588437] phonet_rcv Drop message ! [ 481.922617] phonet_rcv Drop message ! [ 481.927666] phonet_rcv Drop message ! [ 482.644111] phonet_rcv Drop message ! [ 482.658919] phonet_rcv Drop message ! [ 489.485054] CPU1: Booted secondary processor [ 489.496207] Switched to NOHz mode on CPU #1 [ 491.578699] CPU1: shutdown [ 493.605229] modem4_l2_suspend. [ 493.609163] modem4_setdata: powerstate = 2. [ 493.639514] modem4_wake_irq: Modem wakeup request from L2. [ 493.646670] modem4_l2_resume. [ 493.650267] modem4_setdata: powerstate = 0. [ 493.710568] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 500.023293] CPU1: Booted secondary processor [ 500.031485] Switched to NOHz mode on CPU #1 [ 501.298310] tegra CPU: force EDP limit 1100000 kHz [ 501.311923] CPU2: Booted secondary processor [ 501.321341] Switched to NOHz mode on CPU #2 [ 503.727456] CPU1: shutdown [ 503.943450] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 503.948870] Modem crash occurs - NB modem reboot since power on : 8 [ 503.967296] modem4_load: Called with value : 0 [ 503.972103] modem4_setdata: powerstate = 255. [ 503.976917] modem4_setdata: Taking wakelock. [ 503.981527] Wake40 for irq=53 [ 503.984614] Disabling wake40 [ 503.987748] tegra-ehci tegra-ehci.1: remove, state 1 [ 503.992917] usb usb1: USB disconnect, device number 1 [ 503.998283] usb 1-1: USB disconnect, device number 2 [ 504.003506] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 504.136519] modem4_usbnotify: Modem detached. [ 504.140950] modem4_setdata: powerstate = 255. [ 504.145361] modem4_setdata: Active wakelock in UNK [ 504.186634] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 504.241076] modem4_pre_phy_off. [ 504.245847] modem4_load: Called with value : 1 [ 504.250635] Reset USB controller WAR. [ 504.254457] tegra USB phy - inst[1] platform info: [ 504.259422] port_otg: no [ 504.262032] has_hostpc: yes [ 504.264899] phy_interface: USB_PHY_INTF_HSIC [ 504.269324] op_mode: TEGRA_USB_OPMODE_HOST [ 504.273493] vbus_gpio: -1 [ 504.276195] vbus_reg: NULL [ 504.278961] hot_plug: disabled [ 504.282132] remote_wakeup: disabled [ 504.285699] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 504.304614] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 504.310674] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 504.346167] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 505.036210] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 505.042345] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 505.049284] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 505.056601] usb usb1: Product: Tegra EHCI Host Controller [ 505.062123] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 505.068114] usb usb1: SerialNumber: tegra-ehci.1 [ 505.073230] hub 1-0:1.0: USB hub found [ 505.077077] hub 1-0:1.0: 1 port detected [ 505.081085] modem4_phy_ready. [ 505.094148] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 505.100982] Wake40 for irq=53 [ 505.104013] Enabling wake40 [ 505.716550] CPU2: shutdown [ 505.876247] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 505.907934] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 505.915083] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 505.922685] usb 1-1: Product: HakuyaS USB [ 505.927348] usb 1-1: Manufacturer: Renesas [ 505.941355] modem_hsic_open [ 505.944249] modem_hsic_release : [ 505.948437] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 506.108054] modem_hsic_open [ 507.114639] modem_hsic_read : [ 507.118536] modem_do_read_io [ 507.121770] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 507.128319] modem_read_bulk_callback [ 507.131949] modem_read_bulk_callback, length = 69 [ 507.137530] modem_hsic_read : copy_to_user bytes_read =69 [ 507.795595] tegra CPU: force EDP limit 1200000 kHz [ 507.806144] CPU1: Booted secondary processor [ 507.816139] Switched to NOHz mode on CPU #1 [ 508.762452] modem_hsic_read : [ 508.766087] modem_do_read_io [ 508.769260] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 508.775821] modem_read_bulk_callback [ 508.779652] modem_read_bulk_callback, length = 12 [ 508.790578] modem_hsic_read : copy_to_user bytes_read =12 [ 511.256719] modem_hsic_release : [ 511.310576] modem4_load: Called with value : 0 [ 511.315080] modem4_setdata: powerstate = 255. [ 511.319560] modem4_setdata: Active wakelock in UNK [ 511.324486] Wake40 for irq=53 [ 511.327511] Disabling wake40 [ 511.330531] tegra-ehci tegra-ehci.1: remove, state 1 [ 511.335577] usb usb1: USB disconnect, device number 1 [ 511.340754] usb 1-1: USB disconnect, device number 2 [ 511.345862] boot_hsic_disconnect : [ 511.349701] boot_hsic_delete : [ 511.353050] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 511.386498] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 511.440990] modem4_pre_phy_off. [ 511.494501] modem4_load: Called with value : 1 [ 511.499222] Reset USB controller WAR. [ 511.503088] tegra USB phy - inst[1] platform info: [ 511.507957] port_otg: no [ 511.510549] has_hostpc: yes [ 511.513455] phy_interface: USB_PHY_INTF_HSIC [ 511.517794] op_mode: TEGRA_USB_OPMODE_HOST [ 511.521946] vbus_gpio: -1 [ 511.524678] vbus_reg: NULL [ 511.527451] hot_plug: disabled [ 511.530560] remote_wakeup: disabled [ 511.534123] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 511.553043] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 511.559155] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 511.596172] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 511.616145] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 511.622183] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 511.629094] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 511.636434] usb usb1: Product: Tegra EHCI Host Controller [ 511.641886] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 511.647922] usb usb1: SerialNumber: tegra-ehci.1 [ 511.652930] hub 1-0:1.0: USB hub found [ 511.656776] hub 1-0:1.0: 1 port detected [ 511.660839] modem4_phy_ready. [ 511.663867] modem4_phy_ready : Driving AWR high. [ 511.742187] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 511.749761] Wake40 for irq=53 [ 511.752788] Enabling wake40 [ 512.095987] CPU1: shutdown [ 512.116302] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 513.647081] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 513.654267] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 513.661979] usb 1-1: Product: Pegasus-S HSIC [ 513.666820] usb 1-1: Manufacturer: Renesas [ 514.292610] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 515.005615] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 515.013381] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 515.043352] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 515.057879] modem4_usbnotify: Modem attached. [ 515.062696] modem4_setdata: powerstate = 0. [ 515.067813] modem4_setdata: Releasing wakelock. [ 515.164012] Renesas HSIC netdevice mounted (usb0) [ 515.172772] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 515.182634] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 515.496293] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 515.506402] cdc_ncm: usb0: network connection: connected [ 515.522726] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 525.616640] usb0: no IPv6 routers present [ 527.114651] phonet_rcv Drop message ! [ 527.119263] phonet_rcv Drop message ! [ 527.481988] phonet_rcv Drop message ! [ 527.487028] phonet_rcv Drop message ! [ 528.224994] phonet_rcv Drop message ! [ 528.239654] phonet_rcv Drop message ! [ 531.557355] tegra CPU: force EDP limit 1200000 kHz [ 531.568524] CPU1: Booted secondary processor [ 531.576137] Switched to NOHz mode on CPU #1 [ 533.652719] CPU1: shutdown [ 535.681711] tegra CPU: force EDP limit 1200000 kHz [ 535.697823] CPU1: Booted secondary processor [ 535.706170] Switched to NOHz mode on CPU #1 [ 535.711674] binder: 745:754 refcount change on invalid ref 20 [ 535.718258] binder: 745:754 refcount change on invalid ref 21 [ 535.725936] binder: 745:754 refcount change on invalid ref 22 [ 535.732481] binder: 745:754 refcount change on invalid ref 23 [ 535.739592] tegra CPU: force EDP limit 1100000 kHz [ 535.750688] CPU2: Booted secondary processor [ 535.756139] Switched to NOHz mode on CPU #2 [ 537.962448] CPU1: shutdown [ 539.946900] CPU2: shutdown [ 540.561934] modem4_l2_suspend. [ 540.565284] modem4_setdata: powerstate = 2. [ 541.030438] modem4_wake_irq: Modem wakeup request from L2. [ 541.036642] modem4_l2_resume. [ 541.039851] modem4_setdata: powerstate = 0. [ 541.097036] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 544.513719] CPU1: Booted secondary processor [ 544.521001] Switched to NOHz mode on CPU #1 [ 547.497293] CPU1: shutdown [ 548.420688] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 548.427244] Modem crash occurs - NB modem reboot since power on : 9 [ 548.442671] modem4_load: Called with value : 0 [ 548.447797] modem4_setdata: powerstate = 255. [ 548.452725] modem4_setdata: Taking wakelock. [ 548.457287] Wake40 for irq=53 [ 548.460369] Disabling wake40 [ 548.463524] tegra-ehci tegra-ehci.1: remove, state 1 [ 548.468866] usb usb1: USB disconnect, device number 1 [ 548.474097] usb 1-1: USB disconnect, device number 2 [ 548.479458] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 548.526373] modem4_usbnotify: Modem detached. [ 548.530795] modem4_setdata: powerstate = 255. [ 548.535207] modem4_setdata: Active wakelock in UNK [ 548.567397] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 548.586327] modem4_pre_phy_off. [ 548.591618] modem4_load: Called with value : 1 [ 548.596803] Reset USB controller WAR. [ 548.600754] tegra USB phy - inst[1] platform info: [ 548.605799] port_otg: no [ 548.608526] has_hostpc: yes [ 548.611590] phy_interface: USB_PHY_INTF_HSIC [ 548.615915] op_mode: TEGRA_USB_OPMODE_HOST [ 548.620185] vbus_gpio: -1 [ 548.623031] vbus_reg: NULL [ 548.625795] hot_plug: disabled [ 548.628967] remote_wakeup: disabled [ 548.632530] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 548.651428] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 548.657469] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 548.686222] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 548.706191] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 548.712334] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 548.719234] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 548.726574] usb usb1: Product: Tegra EHCI Host Controller [ 548.732078] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 548.738054] usb usb1: SerialNumber: tegra-ehci.1 [ 548.743079] hub 1-0:1.0: USB hub found [ 548.746966] hub 1-0:1.0: 1 port detected [ 548.750967] modem4_phy_ready. [ 548.764012] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 548.770757] Wake40 for irq=53 [ 548.773782] Enabling wake40 [ 549.136271] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 549.168076] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 549.175227] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 549.182642] usb 1-1: Product: HakuyaS USB [ 549.187420] usb 1-1: Manufacturer: Renesas [ 549.202003] modem_hsic_open [ 549.205909] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 549.216682] modem_hsic_release : [ 549.779711] modem_hsic_open [ 550.792062] modem_hsic_read : [ 550.796942] modem_do_read_io [ 550.800435] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 550.808264] modem_read_bulk_callback [ 550.812278] modem_read_bulk_callback, length = 69 [ 550.818930] modem_hsic_read : copy_to_user bytes_read =69 [ 553.002236] modem_hsic_read : [ 553.006068] modem_do_read_io [ 553.009651] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 553.017488] modem_read_bulk_callback [ 553.021499] modem_read_bulk_callback, length = 12 [ 553.028610] modem_hsic_read : copy_to_user bytes_read =12 [ 555.495281] modem_hsic_release : [ 555.608392] modem4_load: Called with value : 0 [ 555.613173] modem4_setdata: powerstate = 255. [ 555.617695] modem4_setdata: Active wakelock in UNK [ 555.622945] Wake40 for irq=53 [ 555.626079] Disabling wake40 [ 555.629132] tegra-ehci tegra-ehci.1: remove, state 1 [ 555.634450] usb usb1: USB disconnect, device number 1 [ 555.639895] usb 1-1: USB disconnect, device number 2 [ 555.645296] boot_hsic_disconnect : [ 555.649555] boot_hsic_delete : [ 555.652966] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 555.671617] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 555.696175] modem4_pre_phy_off. [ 555.700559] tegra CPU: force EDP limit 1200000 kHz [ 555.711005] CPU1: Booted secondary processor [ 555.716134] Switched to NOHz mode on CPU #1 [ 555.749743] modem4_load: Called with value : 1 [ 555.754650] Reset USB controller WAR. [ 555.758587] tegra USB phy - inst[1] platform info: [ 555.763594] port_otg: no [ 555.766270] has_hostpc: yes [ 555.769231] phy_interface: USB_PHY_INTF_HSIC [ 555.773732] op_mode: TEGRA_USB_OPMODE_HOST [ 555.778038] vbus_gpio: -1 [ 555.780795] vbus_reg: NULL [ 555.783631] hot_plug: disabled [ 555.786978] remote_wakeup: disabled [ 555.790566] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 555.809501] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 555.815561] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 555.846160] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 555.866134] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 555.872242] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 555.879214] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 555.886521] usb usb1: Product: Tegra EHCI Host Controller [ 555.892098] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 555.898116] usb usb1: SerialNumber: tegra-ehci.1 [ 555.903235] hub 1-0:1.0: USB hub found [ 555.907086] hub 1-0:1.0: 1 port detected [ 555.911093] modem4_phy_ready. [ 555.914178] modem4_phy_ready : Driving AWR high. [ 555.992836] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 556.000433] Wake40 for irq=53 [ 556.003463] Enabling wake40 [ 556.366261] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 557.668203] CPU1: shutdown [ 557.895233] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 557.902384] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 557.910093] usb 1-1: Product: Pegasus-S HSIC [ 557.914680] usb 1-1: Manufacturer: Renesas [ 558.540281] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 559.253270] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 559.259924] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 559.278172] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 559.289758] modem4_usbnotify: Modem attached. [ 559.294236] modem4_setdata: powerstate = 0. [ 559.298979] modem4_setdata: Releasing wakelock. [ 559.409234] Renesas HSIC netdevice mounted (usb0) [ 559.415219] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 559.422809] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 559.738266] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 559.748882] cdc_ncm: usb0: network connection: connected [ 559.759797] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 570.736260] usb0: no IPv6 routers present [ 571.382931] phonet_rcv Drop message ! [ 571.387910] phonet_rcv Drop message ! [ 571.748532] phonet_rcv Drop message ! [ 571.753001] phonet_rcv Drop message ! [ 572.652721] phonet_rcv Drop message ! [ 572.667515] phonet_rcv Drop message ! [ 580.763737] modem4_l2_suspend. [ 580.767953] modem4_setdata: powerstate = 2. [ 589.915931] modem4_wake_irq: Modem wakeup request from L2. [ 589.931177] cdc_ncm 1-1:1.0: usb0: Delaying transmission for resumption [ 589.956368] modem4_l2_resume. [ 589.959608] modem4_setdata: powerstate = 0. [ 590.023282] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 597.776441] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 597.797454] Modem crash occurs - NB modem reboot since power on : 10 [ 597.816693] modem4_load: Called with value : 0 [ 597.821770] modem4_setdata: powerstate = 255. [ 597.826738] modem4_setdata: Taking wakelock. [ 597.831543] Wake40 for irq=53 [ 597.834749] Disabling wake40 [ 597.838378] tegra-ehci tegra-ehci.1: remove, state 1 [ 597.843828] usb usb1: USB disconnect, device number 1 [ 597.849065] usb 1-1: USB disconnect, device number 2 [ 597.854495] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 597.896556] modem4_usbnotify: Modem detached. [ 597.901107] modem4_setdata: powerstate = 255. [ 597.905608] modem4_setdata: Active wakelock in UNK [ 597.926928] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 597.946184] modem4_pre_phy_off. [ 597.950950] modem4_load: Called with value : 1 [ 597.955699] Reset USB controller WAR. [ 597.959646] tegra USB phy - inst[1] platform info: [ 597.964640] port_otg: no [ 597.967457] has_hostpc: yes [ 597.970307] phy_interface: USB_PHY_INTF_HSIC [ 597.974627] op_mode: TEGRA_USB_OPMODE_HOST [ 597.978788] vbus_gpio: -1 [ 597.981463] vbus_reg: NULL [ 597.984221] hot_plug: disabled [ 597.987392] remote_wakeup: disabled [ 597.990952] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 598.009851] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 598.015880] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 598.046232] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 598.066187] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 598.072336] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 598.079195] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 598.086530] usb usb1: Product: Tegra EHCI Host Controller [ 598.092032] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 598.098008] usb usb1: SerialNumber: tegra-ehci.1 [ 598.103032] hub 1-0:1.0: USB hub found [ 598.106925] hub 1-0:1.0: 1 port detected [ 598.110927] modem4_phy_ready. [ 598.123969] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 598.130705] Wake40 for irq=53 [ 598.133730] Enabling wake40 [ 598.163768] tegra CPU: force EDP limit 1200000 kHz [ 598.174257] CPU1: Booted secondary processor [ 598.180707] tegra CPU: force EDP limit 1100000 kHz [ 598.186152] Switched to NOHz mode on CPU #1 [ 598.191424] CPU2: Booted secondary processor [ 598.196128] Switched to NOHz mode on CPU #2 [ 598.516449] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 598.548754] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 598.555903] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 598.563746] usb 1-1: Product: HakuyaS USB [ 598.568118] usb 1-1: Manufacturer: Renesas [ 598.592633] modem_hsic_open [ 598.595519] modem_hsic_release : [ 598.599681] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 599.137081] modem_hsic_open [ 599.141509] modem_hsic_read : [ 599.144969] modem_do_read_io [ 599.147868] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 599.147910] modem_read_bulk_callback [ 599.147917] modem_read_bulk_callback, length = 69 [ 599.162287] modem_hsic_read : copy_to_user bytes_read =69 [ 599.755347] modem_hsic_read : [ 599.758686] modem_do_read_io [ 599.761492] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 599.886783] modem_read_bulk_callback [ 599.890314] modem_read_bulk_callback, length = 12 [ 599.900078] modem_hsic_read : copy_to_user bytes_read =12 [ 600.301663] CPU1: shutdown [ 602.337572] tegra CPU: force EDP limit 1100000 kHz [ 602.348051] CPU1: Booted secondary processor [ 602.356140] Switched to NOHz mode on CPU #1 [ 602.371569] modem_hsic_release : [ 602.425517] modem4_load: Called with value : 0 [ 602.430222] modem4_setdata: powerstate = 255. [ 602.434662] modem4_setdata: Active wakelock in UNK [ 602.439629] Wake40 for irq=53 [ 602.442742] Disabling wake40 [ 602.445708] tegra-ehci tegra-ehci.1: remove, state 1 [ 602.450835] usb usb1: USB disconnect, device number 1 [ 602.456058] usb 1-1: USB disconnect, device number 2 [ 602.461206] boot_hsic_disconnect : [ 602.465072] boot_hsic_delete : [ 602.468415] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 602.597318] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 602.756313] modem4_pre_phy_off. [ 602.810652] modem4_load: Called with value : 1 [ 602.816282] Reset USB controller WAR. [ 602.820451] tegra USB phy - inst[1] platform info: [ 602.825484] port_otg: no [ 602.828614] has_hostpc: yes [ 602.831669] phy_interface: USB_PHY_INTF_HSIC [ 602.836270] op_mode: TEGRA_USB_OPMODE_HOST [ 602.840824] vbus_gpio: -1 [ 602.843671] vbus_reg: NULL [ 602.846703] hot_plug: disabled [ 602.850004] remote_wakeup: disabled [ 602.853920] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 602.873066] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 602.879338] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 602.916163] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 602.936164] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 602.942289] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 602.949200] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 602.956598] usb usb1: Product: Tegra EHCI Host Controller [ 602.962081] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 602.968159] usb usb1: SerialNumber: tegra-ehci.1 [ 602.973235] hub 1-0:1.0: USB hub found [ 602.977197] hub 1-0:1.0: 1 port detected [ 602.981233] modem4_phy_ready. [ 602.984263] modem4_phy_ready : Driving AWR high. [ 603.093102] Wake40 for irq=53 [ 603.096161] Enabling wake40 [ 603.456291] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 604.646677] CPU1: shutdown [ 604.985491] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 604.992712] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 605.000511] usb 1-1: Product: Pegasus-S HSIC [ 605.005175] usb 1-1: Manufacturer: Renesas [ 605.630735] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 606.343763] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 606.350339] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 606.369380] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 606.383163] modem4_usbnotify: Modem attached. [ 606.388103] modem4_setdata: powerstate = 0. [ 606.392854] modem4_setdata: Releasing wakelock. [ 606.502060] Renesas HSIC netdevice mounted (usb0) [ 606.509225] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 606.516856] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 606.648823] CPU2: shutdown [ 606.831214] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 606.839677] cdc_ncm: usb0: network connection: connected [ 606.848413] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 617.396253] usb0: no IPv6 routers present [ 618.372399] phonet_rcv Drop message ! [ 618.377503] phonet_rcv Drop message ! [ 618.738479] phonet_rcv Drop message ! [ 618.742927] phonet_rcv Drop message ! [ 619.583842] phonet_rcv Drop message ! [ 619.598643] phonet_rcv Drop message ! [ 625.417544] CPU1: Booted secondary processor [ 625.426248] Switched to NOHz mode on CPU #1 [ 625.477296] tegra CPU: force EDP limit 1100000 kHz [ 625.488200] CPU2: Booted secondary processor [ 625.496137] Switched to NOHz mode on CPU #2 [ 626.295041] binder: 745:817 refcount change on invalid ref 20 [ 626.301001] binder: 745:817 refcount change on invalid ref 20 [ 626.307392] binder: transaction release 14457 bad handle 20 [ 627.608314] CPU1: shutdown [ 629.593809] CPU2: shutdown [ 630.561814] modem4_l2_suspend. [ 630.565362] modem4_setdata: powerstate = 2. [ 630.848270] modem4_wake_irq: Modem wakeup request from L2. [ 630.854187] modem4_l2_resume. [ 630.857697] modem4_setdata: powerstate = 0. [ 630.918195] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 639.763510] modem4_l2_suspend. [ 639.768015] modem4_setdata: powerstate = 2. [ 640.036351] modem4_wake_irq: Modem wakeup request from L2. [ 640.043245] modem4_l2_resume. [ 640.047038] modem4_setdata: powerstate = 0. [ 640.120601] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 655.564036] modem4_l2_suspend. [ 655.567972] modem4_setdata: powerstate = 2. [ 655.702687] modem4_wake_irq: Modem wakeup request from L2. [ 655.709729] modem4_l2_resume. [ 655.713328] modem4_setdata: powerstate = 0. [ 655.780690] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 660.563581] modem4_l2_suspend. [ 660.567509] modem4_setdata: powerstate = 2. [ 663.640991] modem4_wake_irq: Modem wakeup request from L2. [ 663.686812] modem4_l2_resume. [ 663.690483] modem4_setdata: powerstate = 0. [ 663.760593] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 738.351501] CPU1: Booted secondary processor [ 738.356166] Switched to NOHz mode on CPU #1 [ 741.318789] tegra CPU: force EDP limit 1100000 kHz [ 741.331976] CPU2: Booted secondary processor [ 741.341467] Switched to NOHz mode on CPU #2 [ 743.093136] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 743.116629] Modem crash occurs - NB modem reboot since power on : 11 [ 743.128919] modem4_load: Called with value : 0 [ 743.133514] modem4_setdata: powerstate = 255. [ 743.138102] modem4_setdata: Taking wakelock. [ 743.142547] Wake40 for irq=53 [ 743.145578] Disabling wake40 [ 743.148538] tegra-ehci tegra-ehci.1: remove, state 1 [ 743.153648] usb usb1: USB disconnect, device number 1 [ 743.158771] usb 1-1: USB disconnect, device number 2 [ 743.163934] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 743.256504] modem4_usbnotify: Modem detached. [ 743.261007] modem4_setdata: powerstate = 255. [ 743.265425] modem4_setdata: Active wakelock in UNK [ 743.316597] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 743.376498] modem4_pre_phy_off. [ 743.383518] modem4_load: Called with value : 1 [ 743.389311] Reset USB controller WAR. [ 743.393500] tegra USB phy - inst[1] platform info: [ 743.398787] port_otg: no [ 743.401551] has_hostpc: yes [ 743.404570] phy_interface: USB_PHY_INTF_HSIC [ 743.408981] op_mode: TEGRA_USB_OPMODE_HOST [ 743.413293] vbus_gpio: -1 [ 743.416022] vbus_reg: NULL [ 743.418856] hot_plug: disabled [ 743.422021] remote_wakeup: disabled [ 743.425760] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 743.444639] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 743.450766] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 743.486166] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 743.506180] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 743.512508] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 743.519502] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 743.527023] usb usb1: Product: Tegra EHCI Host Controller [ 743.532560] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 743.538828] usb usb1: SerialNumber: tegra-ehci.1 [ 743.544024] hub 1-0:1.0: USB hub found [ 743.547960] hub 1-0:1.0: 1 port detected [ 743.551987] modem4_phy_ready. [ 743.565090] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 743.571905] Wake40 for irq=53 [ 743.574938] Enabling wake40 [ 743.735676] CPU1: shutdown [ 744.586567] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 744.619060] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 744.626399] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 744.633784] usb 1-1: Product: HakuyaS USB [ 744.638578] usb 1-1: Manufacturer: Renesas [ 744.652066] modem_hsic_openmodem_hsic_open [ 744.656348] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 744.656757] modem_hsic_open [ 744.670889] modem_hsic_read : [ 744.674341] modem_do_read_io [ 744.682080] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 744.682202] modem_read_bulk_callback [ 744.682209] modem_read_bulk_callback, length = 69 [ 744.696499] modem_hsic_read : copy_to_user bytes_read =69 [ 745.285920] modem_hsic_read : [ 745.289152] modem_do_read_io [ 745.291933] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 745.420950] modem_read_bulk_callback [ 745.424422] modem_read_bulk_callback, length = 12 [ 745.434258] modem_hsic_read : copy_to_user bytes_read =12 [ 745.723852] CPU2: shutdown [ 747.898186] modem_hsic_release : [ 747.924266] tegra CPU: force EDP limit 1200000 kHz [ 747.934680] CPU1: Booted secondary processor [ 747.946135] Switched to NOHz mode on CPU #1 [ 747.952042] modem4_load: Called with value : 0 [ 747.956591] modem4_setdata: powerstate = 255. [ 747.961078] modem4_setdata: Active wakelock in UNK [ 747.966018] Wake40 for irq=53 [ 747.969045] Disabling wake40 [ 747.972005] tegra-ehci tegra-ehci.1: remove, state 1 [ 747.977178] usb usb1: USB disconnect, device number 1 [ 747.982298] usb 1-1: USB disconnect, device number 2 [ 747.987499] boot_hsic_disconnect : [ 747.991375] boot_hsic_delete : [ 747.994699] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 748.036471] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 748.076189] modem4_pre_phy_off. [ 748.129957] modem4_load: Called with value : 1 [ 748.135361] Reset USB controller WAR. [ 748.139848] tegra USB phy - inst[1] platform info: [ 748.144884] port_otg: no [ 748.147925] has_hostpc: yes [ 748.151015] phy_interface: USB_PHY_INTF_HSIC [ 748.155728] op_mode: TEGRA_USB_OPMODE_HOST [ 748.165831] vbus_gpio: -1 [ 748.168774] vbus_reg: NULL [ 748.171956] hot_plug: disabled [ 748.175173] remote_wakeup: disabled [ 748.178834] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 748.197775] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 748.203836] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 748.222291] tegra CPU: force EDP limit 1100000 kHz [ 748.234092] CPU2: Booted secondary processor [ 748.236181] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 748.246134] Switched to NOHz mode on CPU #2 [ 748.256149] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 748.262203] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 748.269127] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 748.276512] usb usb1: Product: Tegra EHCI Host Controller [ 748.281992] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 748.288103] usb usb1: SerialNumber: tegra-ehci.1 [ 748.293205] hub 1-0:1.0: USB hub found [ 748.297074] hub 1-0:1.0: 1 port detected [ 748.301162] modem4_phy_ready. [ 748.304193] modem4_phy_ready : Driving AWR high. [ 748.383721] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 748.391342] Wake40 for irq=53 [ 748.394379] Enabling wake40 [ 748.786293] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 750.314148] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 750.321400] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 750.328861] usb 1-1: Product: Pegasus-S HSIC [ 750.333586] usb 1-1: Manufacturer: Renesas [ 750.531576] CPU1: shutdown [ 750.959357] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 751.671528] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 751.678015] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 751.700675] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 751.713291] modem4_usbnotify: Modem attached. [ 751.718176] modem4_setdata: powerstate = 0. [ 751.722529] modem4_setdata: Releasing wakelock. [ 751.806283] Renesas HSIC netdevice mounted (usb0) [ 751.812494] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 751.825013] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 752.154173] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 752.162788] cdc_ncm: usb0: network connection: connected [ 752.171435] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 752.522573] CPU2: shutdown [ 762.807952] usb0: no IPv6 routers present [ 763.575398] phonet_rcv Drop message ! [ 763.579999] phonet_rcv Drop message ! [ 763.948873] phonet_rcv Drop message ! [ 763.953819] phonet_rcv Drop message ! [ 764.531390] phonet_rcv Drop message ! [ 764.546781] phonet_rcv Drop message ! [ 770.383849] CPU1: Booted secondary processor [ 770.396212] Switched to NOHz mode on CPU #1 [ 770.819304] binder: 745:818 refcount change on invalid ref 21 [ 770.825492] binder: 745:818 refcount change on invalid ref 21 [ 770.831591] binder: transaction release 15012 bad handle 21 [ 774.268638] CPU1: shutdown [ 776.919351] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 776.937296] Modem crash occurs - NB modem reboot since power on : 12 [ 776.956562] modem4_load: Called with value : 0 [ 776.961921] modem4_setdata: powerstate = 255. [ 776.966674] modem4_setdata: Taking wakelock. [ 776.971523] Wake40 for irq=53 [ 776.974941] Disabling wake40 [ 776.978349] tegra-ehci tegra-ehci.1: remove, state 1 [ 776.983788] usb usb1: USB disconnect, device number 1 [ 776.989161] usb 1-1: USB disconnect, device number 2 [ 776.994434] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 777.036654] modem4_usbnotify: Modem detached. [ 777.041207] modem4_setdata: powerstate = 255. [ 777.045840] modem4_setdata: Active wakelock in UNK [ 777.067339] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 777.086234] modem4_pre_phy_off. [ 777.091719] modem4_load: Called with value : 1 [ 777.096759] Reset USB controller WAR. [ 777.100864] tegra USB phy - inst[1] platform info: [ 777.105801] port_otg: no [ 777.108544] has_hostpc: yes [ 777.111510] phy_interface: USB_PHY_INTF_HSIC [ 777.116053] op_mode: TEGRA_USB_OPMODE_HOST [ 777.120388] vbus_gpio: -1 [ 777.123157] vbus_reg: NULL [ 777.126226] hot_plug: disabled [ 777.129428] remote_wakeup: disabled [ 777.133099] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 777.152327] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 777.158566] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 777.196208] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 777.216303] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 777.222484] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 777.229653] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 777.236940] usb usb1: Product: Tegra EHCI Host Controller [ 777.242443] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 777.248422] usb usb1: SerialNumber: tegra-ehci.1 [ 777.253495] hub 1-0:1.0: USB hub found [ 777.257329] hub 1-0:1.0: 1 port detected [ 777.261331] modem4_phy_ready. [ 777.274429] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 777.281125] Wake40 for irq=53 [ 777.284201] Enabling wake40 [ 777.351424] tegra CPU: force EDP limit 1200000 kHz [ 777.372792] CPU1: Booted secondary processor [ 777.386154] Switched to NOHz mode on CPU #1 [ 777.429429] tegra CPU: force EDP limit 1100000 kHz [ 777.439854] CPU2: Booted secondary processor [ 777.446161] Switched to NOHz mode on CPU #2 [ 777.646292] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 777.678189] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 777.685141] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 777.692899] usb 1-1: Product: HakuyaS USB [ 777.697292] usb 1-1: Manufacturer: Renesas [ 777.716418] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 777.726967] modem_hsic_open [ 777.729688] modem_hsic_release : [ 778.287456] modem_hsic_open [ 778.293996] modem_hsic_read : [ 778.297556] modem_do_read_io [ 778.300344] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 778.300482] modem_read_bulk_callback [ 778.300488] modem_read_bulk_callback, length = 69 [ 778.314772] modem_hsic_read : copy_to_user bytes_read =69 [ 778.906194] modem_hsic_read : [ 778.909442] modem_do_read_io [ 778.912244] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 779.037601] modem_read_bulk_callback [ 779.041070] modem_read_bulk_callback, length = 12 [ 779.046929] modem_hsic_read : copy_to_user bytes_read =12 [ 781.457376] CPU2: shutdown [ 781.510856] modem_hsic_release : [ 781.564674] modem4_load: Called with value : 0 [ 781.569274] modem4_setdata: powerstate = 255. [ 781.573750] modem4_setdata: Active wakelock in UNK [ 781.578793] Wake40 for irq=53 [ 781.581836] Disabling wake40 [ 781.584791] tegra-ehci tegra-ehci.1: remove, state 1 [ 781.595312] usb usb1: USB disconnect, device number 1 [ 781.600536] usb 1-1: USB disconnect, device number 2 [ 781.605655] boot_hsic_disconnect : [ 781.609540] boot_hsic_delete : [ 781.612836] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 781.646503] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 781.716178] modem4_pre_phy_off. [ 781.769718] modem4_load: Called with value : 1 [ 781.774494] Reset USB controller WAR. [ 781.778329] tegra USB phy - inst[1] platform info: [ 781.783268] port_otg: no [ 781.785877] has_hostpc: yes [ 781.788790] phy_interface: USB_PHY_INTF_HSIC [ 781.793117] op_mode: TEGRA_USB_OPMODE_HOST [ 781.797343] vbus_gpio: -1 [ 781.800018] vbus_reg: NULL [ 781.802782] hot_plug: disabled [ 781.805890] remote_wakeup: disabled [ 781.809530] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 781.828420] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 781.834529] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 781.866169] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 781.886156] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 781.892256] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 781.899115] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 781.906462] usb usb1: Product: Tegra EHCI Host Controller [ 781.911914] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 781.917955] usb usb1: SerialNumber: tegra-ehci.1 [ 781.922988] hub 1-0:1.0: USB hub found [ 781.926908] hub 1-0:1.0: 1 port detected [ 781.930943] modem4_phy_ready. [ 781.933997] modem4_phy_ready : Driving AWR high. [ 782.012753] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 782.020283] Wake40 for irq=53 [ 782.023373] Enabling wake40 [ 782.386350] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 783.916115] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 783.923323] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 783.931052] usb 1-1: Product: Pegasus-S HSIC [ 783.935565] usb 1-1: Manufacturer: Renesas [ 784.173817] CPU1: shutdown [ 784.561241] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 785.270265] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 785.276547] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 785.291255] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 785.302845] modem4_usbnotify: Modem attached. [ 785.307670] modem4_setdata: powerstate = 0. [ 785.312051] modem4_setdata: Releasing wakelock. [ 785.429544] Renesas HSIC netdevice mounted (usb0) [ 785.435536] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 785.443003] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 785.756217] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 785.764893] cdc_ncm: usb0: network connection: connected [ 785.773531] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 796.586259] usb0: no IPv6 routers present [ 797.278570] phonet_rcv Drop message ! [ 797.283070] phonet_rcv Drop message ! [ 797.626312] phonet_rcv Drop message ! [ 797.630768] phonet_rcv Drop message ! [ 798.236822] phonet_rcv Drop message ! [ 798.252458] phonet_rcv Drop message ! [ 801.312548] tegra CPU: force EDP limit 1200000 kHz [ 801.323890] CPU1: Booted secondary processor [ 801.336138] Switched to NOHz mode on CPU #1 [ 803.486276] CPU1: shutdown [ 805.494066] CPU1: Booted secondary processor [ 805.501493] Switched to NOHz mode on CPU #1 [ 805.577764] tegra CPU: force EDP limit 1100000 kHz [ 805.589008] CPU2: Booted secondary processor [ 805.596147] Switched to NOHz mode on CPU #2 [ 807.850456] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 807.864973] Modem crash occurs - NB modem reboot since power on : 13 [ 807.882986] modem4_load: Called with value : 0 [ 807.888039] modem4_setdata: powerstate = 255. [ 807.892640] modem4_setdata: Taking wakelock. [ 807.897588] Wake40 for irq=53 [ 807.900787] Disabling wake40 [ 807.903802] tegra-ehci tegra-ehci.1: remove, state 1 [ 807.908950] usb usb1: USB disconnect, device number 1 [ 807.914220] usb 1-1: USB disconnect, device number 2 [ 807.919484] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 808.056478] modem4_usbnotify: Modem detached. [ 808.060917] modem4_setdata: powerstate = 255. [ 808.065394] modem4_setdata: Active wakelock in UNK [ 808.127674] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 808.176368] modem4_pre_phy_off. [ 808.181137] modem4_load: Called with value : 1 [ 808.185884] Reset USB controller WAR. [ 808.189782] tegra USB phy - inst[1] platform info: [ 808.194648] port_otg: no [ 808.197284] has_hostpc: yes [ 808.200159] phy_interface: USB_PHY_INTF_HSIC [ 808.204555] op_mode: TEGRA_USB_OPMODE_HOST [ 808.208729] vbus_gpio: -1 [ 808.211410] vbus_reg: NULL [ 808.214235] hot_plug: disabled [ 808.217370] remote_wakeup: disabled [ 808.220944] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 808.239905] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 808.246031] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 808.292239] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 808.316249] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 808.322677] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 808.329958] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 808.337447] usb usb1: Product: Tegra EHCI Host Controller [ 808.343268] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 808.349468] usb usb1: SerialNumber: tegra-ehci.1 [ 808.356077] hub 1-0:1.0: USB hub found [ 808.360022] hub 1-0:1.0: 1 port detected [ 808.364108] modem4_phy_ready. [ 808.369490] CPU2: shutdown [ 808.377467] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 808.384294] Wake40 for irq=53 [ 808.387321] Enabling wake40 [ 808.776290] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 808.818254] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 808.825223] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 808.832973] usb 1-1: Product: HakuyaS USB [ 808.845286] usb 1-1: Manufacturer: Renesas [ 808.857431] modem_hsic_open [ 808.860324] modem_hsic_release : [ 808.864301] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 809.391278] modem_hsic_open [ 809.397608] modem_hsic_read : [ 809.401509] modem_do_read_io [ 809.404695] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 809.411231] modem_read_bulk_callback [ 809.415062] modem_read_bulk_callback, length = 69 [ 809.425416] modem_hsic_read : copy_to_user bytes_read =69 [ 810.048353] modem_hsic_read : [ 810.051627] modem_do_read_io [ 810.054410] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 810.183469] modem_read_bulk_callback [ 810.187365] modem_read_bulk_callback, length = 12 [ 810.192648] modem_hsic_read : copy_to_user bytes_read =12 [ 810.476831] CPU1: shutdown [ 812.528371] tegra CPU: force EDP limit 1200000 kHz [ 812.538731] CPU1: Booted secondary processor [ 812.546128] Switched to NOHz mode on CPU #1 [ 812.663162] modem_hsic_release : [ 812.716997] modem4_load: Called with value : 0 [ 812.721562] modem4_setdata: powerstate = 255. [ 812.725972] modem4_setdata: Active wakelock in UNK [ 812.730987] Wake40 for irq=53 [ 812.734015] Disabling wake40 [ 812.736966] tegra-ehci tegra-ehci.1: remove, state 1 [ 812.742064] usb usb1: USB disconnect, device number 1 [ 812.747190] usb 1-1: USB disconnect, device number 2 [ 812.752298] boot_hsic_disconnect : [ 812.756166] boot_hsic_delete : [ 812.759461] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 812.796419] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 812.896431] modem4_pre_phy_off. [ 812.950778] modem4_load: Called with value : 1 [ 812.956420] Reset USB controller WAR. [ 812.960586] tegra USB phy - inst[1] platform info: [ 812.965803] port_otg: no [ 812.968632] has_hostpc: yes [ 812.971660] phy_interface: USB_PHY_INTF_HSIC [ 812.976182] op_mode: TEGRA_USB_OPMODE_HOST [ 812.980502] vbus_gpio: -1 [ 812.983231] vbus_reg: NULL [ 812.986048] hot_plug: disabled [ 812.989330] remote_wakeup: disabled [ 812.992965] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 813.011880] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 813.017929] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 813.046159] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 813.082711] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 813.088823] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 813.095666] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 813.103017] usb usb1: Product: Tegra EHCI Host Controller [ 813.108480] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 813.114510] usb usb1: SerialNumber: tegra-ehci.1 [ 813.119523] hub 1-0:1.0: USB hub found [ 813.123403] hub 1-0:1.0: 1 port detected [ 813.127432] modem4_phy_ready. [ 813.130463] modem4_phy_ready : Driving AWR high. [ 813.208934] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 813.216471] Wake40 for irq=53 [ 813.219560] Enabling wake40 [ 814.956177] CPU1: shutdown [ 815.106292] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 816.635374] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 816.642420] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 816.650321] usb 1-1: Product: Pegasus-S HSIC [ 816.654895] usb 1-1: Manufacturer: Renesas [ 817.280628] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 817.996644] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 818.003301] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 818.035800] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 818.047602] Renesas HSIC netdevice mounted (usb0) [ 818.053550] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 818.061145] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 818.084887] modem4_usbnotify: Modem attached. [ 818.096240] modem4_setdata: powerstate = 0. [ 818.106250] modem4_setdata: Releasing wakelock. [ 818.283919] CPU1: Booted secondary processor [ 818.296178] Switched to NOHz mode on CPU #1 [ 818.478196] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 818.486114] cdc_ncm: usb0: network connection: connected [ 818.494637] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 820.388513] CPU1: shutdown [ 829.306829] usb0: no IPv6 routers present [ 829.489952] phonet_rcv Drop message ! [ 829.494444] phonet_rcv Drop message ! [ 829.874441] phonet_rcv Drop message ! [ 829.879030] phonet_rcv Drop message ! [ 830.708635] phonet_rcv Drop message ! [ 830.722987] phonet_rcv Drop message ! [ 836.133892] CPU1: Booted secondary processor [ 836.141309] Switched to NOHz mode on CPU #1 [ 838.219347] binder: 745:761 refcount change on invalid ref 22 [ 838.225333] binder: 745:761 refcount change on invalid ref 22 [ 838.231953] binder: transaction release 16445 bad handle 22 [ 838.317531] CPU2: Booted secondary processor [ 838.326139] Switched to NOHz mode on CPU #2 [ 840.416984] CPU1: shutdown [ 840.671810] modem4_l2_suspend. [ 840.675300] modem4_setdata: powerstate = 2. [ 840.787475] modem4_wake_irq: Modem wakeup request from L2. [ 840.793175] modem4_l2_resume. [ 840.796522] modem4_setdata: powerstate = 0. [ 840.858561] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 842.437905] CPU2: shutdown [ 843.572019] modem4_l2_suspend. [ 843.575373] modem4_setdata: powerstate = 2. [ 843.805799] modem4_wake_irq: Modem wakeup request from L2. [ 843.812008] modem4_l2_resume. [ 843.815214] modem4_setdata: powerstate = 0. [ 843.878248] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 846.772993] CPU1: Booted secondary processor [ 846.786143] Switched to NOHz mode on CPU #1 [ 849.267656] CPU1: shutdown [ 850.688754] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 850.694749] Modem crash occurs - NB modem reboot since power on : 14 [ 850.709225] modem4_load: Called with value : 0 [ 850.713792] modem4_setdata: powerstate = 255. [ 850.718355] modem4_setdata: Taking wakelock. [ 850.723063] Wake40 for irq=53 [ 850.726149] Disabling wake40 [ 850.729411] tegra-ehci tegra-ehci.1: remove, state 1 [ 850.734676] usb usb1: USB disconnect, device number 1 [ 850.739921] usb 1-1: USB disconnect, device number 2 [ 850.745241] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 850.786348] modem4_usbnotify: Modem detached. [ 850.790827] modem4_setdata: powerstate = 255. [ 850.795237] modem4_setdata: Active wakelock in UNK [ 850.827211] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 850.846272] modem4_pre_phy_off. [ 850.852972] modem4_load: Called with value : 1 [ 850.858584] Reset USB controller WAR. [ 850.862755] tegra USB phy - inst[1] platform info: [ 850.867847] port_otg: no [ 850.870805] has_hostpc: yes [ 850.873823] phy_interface: USB_PHY_INTF_HSIC [ 850.878682] op_mode: TEGRA_USB_OPMODE_HOST [ 850.883342] vbus_gpio: -1 [ 850.886079] vbus_reg: NULL [ 850.888924] hot_plug: disabled [ 850.892091] remote_wakeup: disabled [ 850.895829] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 850.916724] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 850.922990] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 850.956170] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 850.976191] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 850.982540] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 850.989590] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 850.997132] usb usb1: Product: Tegra EHCI Host Controller [ 851.002677] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 851.009148] usb usb1: SerialNumber: tegra-ehci.1 [ 851.014753] hub 1-0:1.0: USB hub found [ 851.018995] hub 1-0:1.0: 1 port detected [ 851.023022] modem4_phy_ready. [ 851.036209] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 851.042937] Wake40 for irq=53 [ 851.045958] Enabling wake40 [ 851.416515] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 851.449282] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 851.462592] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 851.473121] usb 1-1: Product: HakuyaS USB [ 851.478383] usb 1-1: Manufacturer: Renesas [ 851.503683] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 851.517426] modem_hsic_open [ 851.520255] modem_hsic_release : [ 852.005968] CPU1: Booted secondary processor [ 852.016208] Switched to NOHz mode on CPU #1 [ 852.050056] modem_hsic_open [ 852.056298] modem_hsic_read : [ 852.060096] modem_do_read_io [ 852.063292] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 852.063425] modem_read_bulk_callback [ 852.063445] modem_read_bulk_callback, length = 69 [ 852.078539] modem_hsic_read : copy_to_user bytes_read =69 [ 852.670334] modem_hsic_read : [ 852.673610] modem_do_read_io [ 852.676405] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 852.801947] modem_read_bulk_callback [ 852.805504] modem_read_bulk_callback, length = 12 [ 852.810412] modem_hsic_read : copy_to_user bytes_read =12 [ 855.275094] modem_hsic_release : [ 855.329614] modem4_load: Called with value : 0 [ 855.334145] modem4_setdata: powerstate = 255. [ 855.338636] modem4_setdata: Active wakelock in UNK [ 855.343566] Wake40 for irq=53 [ 855.346589] Disabling wake40 [ 855.349599] tegra-ehci tegra-ehci.1: remove, state 1 [ 855.354641] usb usb1: USB disconnect, device number 1 [ 855.359818] usb 1-1: USB disconnect, device number 2 [ 855.364926] boot_hsic_disconnect : [ 855.368776] boot_hsic_delete : [ 855.372129] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 855.406540] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 855.456173] modem4_pre_phy_off. [ 855.509688] modem4_load: Called with value : 1 [ 855.514509] Reset USB controller WAR. [ 855.518481] tegra USB phy - inst[1] platform info: [ 855.523331] port_otg: no [ 855.525920] has_hostpc: yes [ 855.528847] phy_interface: USB_PHY_INTF_HSIC [ 855.533172] op_mode: TEGRA_USB_OPMODE_HOST [ 855.537336] vbus_gpio: -1 [ 855.540070] vbus_reg: NULL [ 855.542832] hot_plug: disabled [ 855.545939] remote_wakeup: disabled [ 855.549516] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 855.568443] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 855.574637] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 855.606162] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 855.626160] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 855.632207] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 855.639127] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 855.646473] usb usb1: Product: Tegra EHCI Host Controller [ 855.651924] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 855.657965] usb usb1: SerialNumber: tegra-ehci.1 [ 855.663169] hub 1-0:1.0: USB hub found [ 855.667055] hub 1-0:1.0: 1 port detected [ 855.671123] modem4_phy_ready. [ 855.674151] modem4_phy_ready : Driving AWR high. [ 855.752734] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 855.760330] Wake40 for irq=53 [ 855.763357] Enabling wake40 [ 856.030185] CPU1: shutdown [ 856.166297] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 857.696623] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 857.703804] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 857.711772] usb 1-1: Product: Pegasus-S HSIC [ 857.716789] usb 1-1: Manufacturer: Renesas [ 858.340575] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 859.053578] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 859.060905] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 859.089024] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 859.103020] modem4_usbnotify: Modem attached. [ 859.108045] modem4_setdata: powerstate = 0. [ 859.112543] modem4_setdata: Releasing wakelock. [ 859.174694] Renesas HSIC netdevice mounted (usb0) [ 859.183362] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 859.193308] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 859.542622] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 859.553132] cdc_ncm: usb0: network connection: connected [ 859.565839] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 870.116338] usb0: no IPv6 routers present [ 871.160462] phonet_rcv Drop message ! [ 871.164954] phonet_rcv Drop message ! [ 871.504529] phonet_rcv Drop message ! [ 871.509562] phonet_rcv Drop message ! [ 872.087030] phonet_rcv Drop message ! [ 872.101387] phonet_rcv Drop message ! [ 879.439484] binder: 745:767 refcount change on invalid ref 23 [ 879.445364] binder: 745:767 refcount change on invalid ref 23 [ 879.451917] binder: transaction release 17524 bad handle 23 [ 879.459129] tegra CPU: force EDP limit 1200000 kHz [ 879.470833] CPU1: Booted secondary processor [ 879.476142] Switched to NOHz mode on CPU #1 [ 879.527483] tegra CPU: force EDP limit 1100000 kHz [ 879.538035] CPU2: Booted secondary processor [ 879.546144] Switched to NOHz mode on CPU #2 [ 881.735938] CPU1: shutdown [ 881.752868] modem4_l2_suspend. [ 881.757342] modem4_setdata: powerstate = 2. [ 881.834871] cdc_ncm 1-1:1.0: usb0: Delaying transmission for resumption [ 881.842190] modem4_l2_resume. [ 881.845401] modem4_setdata: powerstate = 0. [ 881.907462] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 883.733854] CPU2: shutdown [ 884.570784] modem4_l2_suspend. [ 884.573909] modem4_setdata: powerstate = 2. [ 884.706644] modem4_wake_irq: Modem wakeup request from L2. [ 884.712561] modem4_l2_resume. [ 884.715957] modem4_setdata: powerstate = 0. [ 884.778296] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 889.863336] CPU1: Booted secondary processor [ 889.876139] Switched to NOHz mode on CPU #1 [ 892.168330] CPU1: shutdown [ 893.800818] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 893.807465] Modem crash occurs - NB modem reboot since power on : 15 [ 893.820442] modem4_load: Called with value : 0 [ 893.825106] modem4_setdata: powerstate = 255. [ 893.829616] modem4_setdata: Taking wakelock. [ 893.834141] Wake40 for irq=53 [ 893.837326] Disabling wake40 [ 893.840609] tegra-ehci tegra-ehci.1: remove, state 1 [ 893.845768] usb usb1: USB disconnect, device number 1 [ 893.851099] usb 1-1: USB disconnect, device number 2 [ 893.856389] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 893.896356] modem4_usbnotify: Modem detached. [ 893.900792] modem4_setdata: powerstate = 255. [ 893.905260] modem4_setdata: Active wakelock in UNK [ 893.937322] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 893.956322] modem4_pre_phy_off. [ 893.962600] modem4_load: Called with value : 1 [ 893.968034] Reset USB controller WAR. [ 893.972398] tegra USB phy - inst[1] platform info: [ 893.977496] port_otg: no [ 893.980261] has_hostpc: yes [ 893.983280] phy_interface: USB_PHY_INTF_HSIC [ 893.988345] op_mode: TEGRA_USB_OPMODE_HOST [ 893.992851] vbus_gpio: -1 [ 893.995587] vbus_reg: NULL [ 893.998537] hot_plug: disabled [ 894.001702] remote_wakeup: disabled [ 894.005338] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 894.025434] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 894.031529] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 894.066192] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 894.086317] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 894.092519] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 894.099583] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 894.107092] usb usb1: Product: Tegra EHCI Host Controller [ 894.112598] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 894.118579] usb usb1: SerialNumber: tegra-ehci.1 [ 894.123653] hub 1-0:1.0: USB hub found [ 894.127489] hub 1-0:1.0: 1 port detected [ 894.131544] modem4_phy_ready. [ 894.144588] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 894.151271] Wake40 for irq=53 [ 894.154348] Enabling wake40 [ 894.216151] tegra CPU: force EDP limit 1200000 kHz [ 894.231447] CPU1: Booted secondary processor [ 894.236131] Switched to NOHz mode on CPU #1 [ 894.257334] tegra CPU: force EDP limit 1100000 kHz [ 894.271677] CPU2: Booted secondary processor [ 894.276147] Switched to NOHz mode on CPU #2 [ 894.516319] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 894.548070] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 894.555029] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 894.562890] usb 1-1: Product: HakuyaS USB [ 894.567391] usb 1-1: Manufacturer: Renesas [ 894.590555] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 894.601140] modem_hsic_open [ 894.604081] modem_hsic_release : [ 895.158319] modem_hsic_open [ 895.164257] modem_hsic_read : [ 895.168324] modem_do_read_io [ 895.171353] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 895.171527] modem_read_bulk_callback [ 895.171546] modem_read_bulk_callback, length = 69 [ 895.186772] modem_hsic_read : copy_to_user bytes_read =69 [ 895.781334] modem_hsic_read : [ 895.784556] modem_do_read_io [ 895.787373] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 895.912913] modem_read_bulk_callback [ 895.916392] modem_read_bulk_callback, length = 12 [ 895.925799] modem_hsic_read : copy_to_user bytes_read =12 [ 897.319364] CPU2: shutdown [ 897.737412] tegra CPU: force EDP limit 1100000 kHz [ 897.748000] CPU2: Booted secondary processor [ 897.756141] Switched to NOHz mode on CPU #2 [ 898.394577] modem_hsic_release : [ 898.448534] modem4_load: Called with value : 0 [ 898.453045] modem4_setdata: powerstate = 255. [ 898.457477] modem4_setdata: Active wakelock in UNK [ 898.462484] Wake40 for irq=53 [ 898.465534] Disabling wake40 [ 898.468505] tegra-ehci tegra-ehci.1: remove, state 1 [ 898.473627] usb usb1: USB disconnect, device number 1 [ 898.478766] usb 1-1: USB disconnect, device number 2 [ 898.483950] boot_hsic_disconnect : [ 898.487810] boot_hsic_delete : [ 898.491110] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 898.566512] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 898.670982] modem4_pre_phy_off. [ 898.724574] modem4_load: Called with value : 1 [ 898.729440] Reset USB controller WAR. [ 898.735167] tegra USB phy - inst[1] platform info: [ 898.740390] port_otg: no [ 898.743002] has_hostpc: yes [ 898.745871] phy_interface: USB_PHY_INTF_HSIC [ 898.750282] op_mode: TEGRA_USB_OPMODE_HOST [ 898.754435] vbus_gpio: -1 [ 898.757160] vbus_reg: NULL [ 898.759948] hot_plug: disabled [ 898.763129] remote_wakeup: disabled [ 898.766713] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 898.785653] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 898.791740] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 898.826161] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 898.846147] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 898.852280] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 898.859185] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 898.867023] usb usb1: Product: Tegra EHCI Host Controller [ 898.872702] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 898.878725] usb usb1: SerialNumber: tegra-ehci.1 [ 898.883846] hub 1-0:1.0: USB hub found [ 898.887702] hub 1-0:1.0: 1 port detected [ 898.891711] modem4_phy_ready. [ 898.894743] modem4_phy_ready : Driving AWR high. [ 898.974143] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 898.981769] Wake40 for irq=53 [ 898.984822] Enabling wake40 [ 899.346295] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 900.876718] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 900.883852] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 900.891598] usb 1-1: Product: Pegasus-S HSIC [ 900.896680] usb 1-1: Manufacturer: Renesas [ 901.156062] CPU1: shutdown [ 901.521330] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 902.233472] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 902.240066] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 902.255818] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 902.273050] modem4_usbnotify: Modem attached. [ 902.277631] modem4_setdata: powerstate = 0. [ 902.282045] modem4_setdata: Releasing wakelock. [ 902.390448] Renesas HSIC netdevice mounted (usb0) [ 902.396925] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 902.404673] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 902.716476] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 902.725165] cdc_ncm: usb0: network connection: connected [ 902.733318] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 903.159007] CPU2: shutdown [ 912.938212] usb0: no IPv6 routers present [ 914.227799] phonet_rcv Drop message ! [ 914.232795] phonet_rcv Drop message ! [ 914.575251] phonet_rcv Drop message ! [ 914.579809] phonet_rcv Drop message ! [ 915.455353] phonet_rcv Drop message ! [ 915.469909] phonet_rcv Drop message ! [ 919.255136] CPU1: Booted secondary processor [ 919.261057] Switched to NOHz mode on CPU #1 [ 919.444872] CPU2: Booted secondary processor [ 919.451116] Switched to NOHz mode on CPU #2 [ 922.130739] CPU2: shutdown [ 923.997093] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 924.013086] Modem crash occurs - NB modem reboot since power on : 16 [ 924.029178] modem4_load: Called with value : 0 [ 924.033795] modem4_setdata: powerstate = 255. [ 924.038546] modem4_setdata: Taking wakelock. [ 924.043092] Wake40 for irq=53 [ 924.046176] Disabling wake40 [ 924.049378] tegra-ehci tegra-ehci.1: remove, state 1 [ 924.054589] usb usb1: USB disconnect, device number 1 [ 924.059899] usb 1-1: USB disconnect, device number 2 [ 924.065128] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 924.157442] modem4_usbnotify: Modem detached. [ 924.162244] modem4_setdata: powerstate = 255. [ 924.167234] modem4_setdata: Active wakelock in UNK [ 924.206665] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 924.256234] modem4_pre_phy_off. [ 924.265785] modem4_load: Called with value : 1 [ 924.271460] Reset USB controller WAR. [ 924.275328] tegra USB phy - inst[1] platform info: [ 924.280524] port_otg: no [ 924.283131] has_hostpc: yes [ 924.285988] phy_interface: USB_PHY_INTF_HSIC [ 924.290409] op_mode: TEGRA_USB_OPMODE_HOST [ 924.294574] vbus_gpio: -1 [ 924.297271] vbus_reg: NULL [ 924.300035] hot_plug: disabled [ 924.303201] remote_wakeup: disabled [ 924.306785] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 924.325715] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 924.331808] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 924.366210] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 924.386159] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 924.392294] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 924.399248] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 924.406567] usb usb1: Product: Tegra EHCI Host Controller [ 924.412103] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 924.418119] usb usb1: SerialNumber: tegra-ehci.1 [ 924.423366] hub 1-0:1.0: USB hub found [ 924.427232] hub 1-0:1.0: 1 port detected [ 924.431261] modem4_phy_ready. [ 924.444368] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 924.451152] Wake40 for irq=53 [ 924.454180] Enabling wake40 [ 924.536567] CPU1: shutdown [ 924.816312] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 924.847989] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 924.855823] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 924.863852] usb 1-1: Product: HakuyaS USB [ 924.868787] usb 1-1: Manufacturer: Renesas [ 924.879889] modem_hsic_open [ 924.882652] modem_hsic_release : [ 924.886725] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 925.458453] modem_hsic_open [ 926.465127] modem_hsic_read : [ 926.469022] modem_do_read_io [ 926.472251] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 926.478802] modem_read_bulk_callback [ 926.482434] modem_read_bulk_callback, length = 69 [ 926.488007] modem_hsic_read : copy_to_user bytes_read =69 [ 927.123046] tegra CPU: force EDP limit 1200000 kHz [ 927.133589] CPU1: Booted secondary processor [ 927.140014] tegra CPU: force EDP limit 1100000 kHz [ 927.141273] Switched to NOHz mode on CPU #1 [ 927.159460] CPU2: Booted secondary processor [ 927.166144] Switched to NOHz mode on CPU #2 [ 928.111745] modem_hsic_read : [ 928.115211] modem_do_read_io [ 928.118344] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 928.125127] modem_read_bulk_callback [ 928.128780] modem_read_bulk_callback, length = 12 [ 928.134096] modem_hsic_read : copy_to_user bytes_read =12 [ 929.363577] CPU2: shutdown [ 930.603329] modem_hsic_release : [ 930.657971] modem4_load: Called with value : 0 [ 930.662536] modem4_setdata: powerstate = 255. [ 930.666962] modem4_setdata: Active wakelock in UNK [ 930.671947] Wake40 for irq=53 [ 930.674972] Disabling wake40 [ 930.677930] tegra-ehci tegra-ehci.1: remove, state 1 [ 930.683030] usb usb1: USB disconnect, device number 1 [ 930.688149] usb 1-1: USB disconnect, device number 2 [ 930.693320] boot_hsic_disconnect : [ 930.697344] boot_hsic_delete : [ 930.700643] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 930.736550] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 930.781052] modem4_pre_phy_off. [ 930.834570] modem4_load: Called with value : 1 [ 930.839355] Reset USB controller WAR. [ 930.843164] tegra USB phy - inst[1] platform info: [ 930.848089] port_otg: no [ 930.850680] has_hostpc: yes [ 930.853530] phy_interface: USB_PHY_INTF_HSIC [ 930.857866] op_mode: TEGRA_USB_OPMODE_HOST [ 930.862075] vbus_gpio: -1 [ 930.864750] vbus_reg: NULL [ 930.867524] hot_plug: disabled [ 930.870691] remote_wakeup: disabled [ 930.874256] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 930.893177] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 930.899234] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 930.936160] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 930.956144] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 930.962239] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 930.969095] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 930.976441] usb usb1: Product: Tegra EHCI Host Controller [ 930.981894] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 930.987935] usb usb1: SerialNumber: tegra-ehci.1 [ 930.992944] hub 1-0:1.0: USB hub found [ 930.996849] hub 1-0:1.0: 1 port detected [ 931.000855] modem4_phy_ready. [ 931.003884] modem4_phy_ready : Driving AWR high. [ 931.082251] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 931.089760] Wake40 for irq=53 [ 931.092845] Enabling wake40 [ 931.366453] tegra CPU: force EDP limit 1100000 kHz [ 931.380491] CPU2: Booted secondary processor [ 931.386137] Switched to NOHz mode on CPU #2 [ 931.456281] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 932.984463] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 932.991545] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 932.999351] usb 1-1: Product: Pegasus-S HSIC [ 933.003877] usb 1-1: Manufacturer: Renesas [ 933.467414] CPU1: shutdown [ 933.630511] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 934.341636] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 934.348101] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 934.366840] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 934.385356] modem4_usbnotify: Modem attached. [ 934.389901] modem4_setdata: powerstate = 0. [ 934.394316] modem4_setdata: Releasing wakelock. [ 934.499318] Renesas HSIC netdevice mounted (usb0) [ 934.505329] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 934.512866] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 934.827153] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 934.835833] cdc_ncm: usb0: network connection: connected [ 934.844109] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 935.482564] CPU2: shutdown [ 945.256361] usb0: no IPv6 routers present [ 946.270339] phonet_rcv Drop message ! [ 946.275323] phonet_rcv Drop message ! [ 946.634773] phonet_rcv Drop message ! [ 946.639327] phonet_rcv Drop message ! [ 947.598222] phonet_rcv Drop message ! [ 947.610986] phonet_rcv Drop message ! [ 952.992563] CPU1: Booted secondary processor [ 953.006144] Switched to NOHz mode on CPU #1 [ 956.177688] tegra CPU: force EDP limit 1100000 kHz [ 956.189498] CPU2: Booted secondary processor [ 956.196142] Switched to NOHz mode on CPU #2 [ 957.743079] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 957.752438] Modem crash occurs - NB modem reboot since power on : 17 [ 957.772135] modem4_load: Called with value : 0 [ 957.777169] modem4_setdata: powerstate = 255. [ 957.781778] modem4_setdata: Taking wakelock. [ 957.786613] Wake40 for irq=53 [ 957.789811] Disabling wake40 [ 957.792825] tegra-ehci tegra-ehci.1: remove, state 1 [ 957.797967] usb usb1: USB disconnect, device number 1 [ 957.803241] usb 1-1: USB disconnect, device number 2 [ 957.808379] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 957.986714] modem4_usbnotify: Modem detached. [ 957.991168] modem4_setdata: powerstate = 255. [ 957.995653] modem4_setdata: Active wakelock in UNK [ 958.036554] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 958.141448] modem4_pre_phy_off. [ 958.148360] modem4_load: Called with value : 1 [ 958.153921] Reset USB controller WAR. [ 958.158389] tegra USB phy - inst[1] platform info: [ 958.163414] port_otg: no [ 958.166218] has_hostpc: yes [ 958.169244] phy_interface: USB_PHY_INTF_HSIC [ 958.173624] op_mode: TEGRA_USB_OPMODE_HOST [ 958.177845] vbus_gpio: -1 [ 958.180578] vbus_reg: NULL [ 958.183497] hot_plug: disabled [ 958.186657] remote_wakeup: disabled [ 958.190240] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 958.209171] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 958.215295] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 958.246165] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 958.266181] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 958.272385] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 958.279486] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 958.286868] usb usb1: Product: Tegra EHCI Host Controller [ 958.292531] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 958.298649] usb usb1: SerialNumber: tegra-ehci.1 [ 958.303878] hub 1-0:1.0: USB hub found [ 958.307771] hub 1-0:1.0: 1 port detected [ 958.311871] modem4_phy_ready. [ 958.324937] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 958.331689] Wake40 for irq=53 [ 958.334782] Enabling wake40 [ 958.500672] CPU1: shutdown [ 958.696362] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 958.728003] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 958.734958] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 958.742721] usb 1-1: Product: HakuyaS USB [ 958.747594] usb 1-1: Manufacturer: Renesas [ 958.759229] modem_hsic_open [ 958.762021] modem_hsic_release : [ 958.765967] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 959.338961] modem_hsic_open [ 959.345096] modem_hsic_read : [ 959.349189] modem_do_read_io [ 959.352194] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 959.358717] modem_read_bulk_callback [ 959.362550] modem_read_bulk_callback, length = 69 [ 959.372828] modem_hsic_read : copy_to_user bytes_read =69 [ 959.963871] modem_hsic_read : [ 959.967137] modem_do_read_io [ 959.969922] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 960.098921] modem_read_bulk_callback [ 960.102387] modem_read_bulk_callback, length = 12 [ 960.112138] modem_hsic_read : copy_to_user bytes_read =12 [ 960.486859] CPU2: shutdown [ 962.533923] tegra CPU: force EDP limit 1200000 kHz [ 962.544412] CPU1: Booted secondary processor [ 962.551103] Switched to NOHz mode on CPU #1 [ 962.576087] modem_hsic_release : [ 962.627273] tegra CPU: force EDP limit 1100000 kHz [ 962.632341] modem4_load: Called with value : 0 [ 962.636882] modem4_setdata: powerstate = 255. [ 962.641364] modem4_setdata: Active wakelock in UNK [ 962.643344] CPU2: Booted secondary processor [ 962.646132] Switched to NOHz mode on CPU #2 [ 962.654978] Wake40 for irq=53 [ 962.658030] Disabling wake40 [ 962.661017] tegra-ehci tegra-ehci.1: remove, state 1 [ 962.666185] usb usb1: USB disconnect, device number 1 [ 962.671340] usb 1-1: USB disconnect, device number 2 [ 962.677476] boot_hsic_disconnect : [ 962.682230] boot_hsic_delete : [ 962.685554] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 962.806444] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 962.926177] modem4_pre_phy_off. [ 962.979759] modem4_load: Called with value : 1 [ 962.984502] Reset USB controller WAR. [ 962.988342] tegra USB phy - inst[1] platform info: [ 962.993253] port_otg: no [ 962.995846] has_hostpc: yes [ 962.998724] phy_interface: USB_PHY_INTF_HSIC [ 963.003136] op_mode: TEGRA_USB_OPMODE_HOST [ 963.007368] vbus_gpio: -1 [ 963.010062] vbus_reg: NULL [ 963.012835] hot_plug: disabled [ 963.016026] remote_wakeup: disabled [ 963.019653] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 963.038741] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 963.050090] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 963.086155] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 963.106150] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 963.112255] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 963.119216] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 963.126533] usb usb1: Product: Tegra EHCI Host Controller [ 963.132052] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 963.138070] usb usb1: SerialNumber: tegra-ehci.1 [ 963.143179] hub 1-0:1.0: USB hub found [ 963.147054] hub 1-0:1.0: 1 port detected [ 963.151113] modem4_phy_ready. [ 963.154228] modem4_phy_ready : Driving AWR high. [ 963.239539] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 963.247240] Wake40 for irq=53 [ 963.250290] Enabling wake40 [ 963.626276] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 965.157180] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 965.164168] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 965.171938] usb 1-1: Product: Pegasus-S HSIC [ 965.176881] usb 1-1: Manufacturer: Renesas [ 965.459262] CPU1: shutdown [ 965.802423] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 966.515653] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 966.522123] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 966.540180] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 966.553588] modem4_usbnotify: Modem attached. [ 966.558864] modem4_setdata: powerstate = 0. [ 966.563391] modem4_setdata: Releasing wakelock. [ 966.656289] Renesas HSIC netdevice mounted (usb0) [ 966.663120] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 966.670500] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 967.004067] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 967.012850] cdc_ncm: usb0: network connection: connected [ 967.022166] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 967.474453] CPU2: shutdown [ 977.546375] usb0: no IPv6 routers present [ 978.390627] phonet_rcv Drop message ! [ 978.395115] phonet_rcv Drop message ! [ 978.756306] phonet_rcv Drop message ! [ 978.760755] phonet_rcv Drop message ! [ 979.641523] phonet_rcv Drop message ! [ 979.656012] phonet_rcv Drop message ! [ 981.497966] tegra CPU: force EDP limit 1200000 kHz [ 981.512077] CPU1: Booted secondary processor [ 981.520447] Switched to NOHz mode on CPU #1 [ 981.567525] tegra CPU: force EDP limit 1100000 kHz [ 981.581972] CPU2: Booted secondary processor [ 981.591164] Switched to NOHz mode on CPU #2 [ 983.579222] CPU1: shutdown [ 985.591205] CPU2: shutdown [ 986.211346] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 986.217525] Modem crash occurs - NB modem reboot since power on : 18 [ 986.232865] modem4_load: Called with value : 0 [ 986.238229] modem4_setdata: powerstate = 255. [ 986.243050] modem4_setdata: Taking wakelock. [ 986.247612] Wake40 for irq=53 [ 986.250800] Disabling wake40 [ 986.253796] tegra-ehci tegra-ehci.1: remove, state 1 [ 986.259167] usb usb1: USB disconnect, device number 1 [ 986.264468] usb 1-1: USB disconnect, device number 2 [ 986.269738] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 986.316364] modem4_usbnotify: Modem detached. [ 986.320785] modem4_setdata: powerstate = 255. [ 986.325255] modem4_setdata: Active wakelock in UNK [ 986.357285] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 986.376218] modem4_pre_phy_off. [ 986.381336] modem4_load: Called with value : 1 [ 986.386305] Reset USB controller WAR. [ 986.390399] tegra USB phy - inst[1] platform info: [ 986.395305] port_otg: no [ 986.397987] has_hostpc: yes [ 986.400896] phy_interface: USB_PHY_INTF_HSIC [ 986.405394] op_mode: TEGRA_USB_OPMODE_HOST [ 986.409858] vbus_gpio: -1 [ 986.412641] vbus_reg: NULL [ 986.415593] hot_plug: disabled [ 986.418831] remote_wakeup: disabled [ 986.422601] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 986.441557] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 986.447592] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 986.476221] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 986.496197] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 986.502279] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 986.509201] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 986.516483] usb usb1: Product: Tegra EHCI Host Controller [ 986.521986] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 986.527964] usb usb1: SerialNumber: tegra-ehci.1 [ 986.533042] hub 1-0:1.0: USB hub found [ 986.536884] hub 1-0:1.0: 1 port detected [ 986.540885] modem4_phy_ready. [ 986.553985] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 986.560688] Wake40 for irq=53 [ 986.563767] Enabling wake40 [ 986.926315] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 986.959806] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 986.967701] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 986.975302] usb 1-1: Product: HakuyaS USB [ 986.980324] usb 1-1: Manufacturer: Renesas [ 987.003172] modem_hsic_open [ 987.006824] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 987.017207] modem_hsic_release : [ 987.575283] modem_hsic_open [ 988.582591] modem_hsic_read : [ 988.587332] modem_do_read_io [ 988.591300] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 988.598706] modem_read_bulk_callback [ 988.602720] modem_read_bulk_callback, length = 69 [ 988.609252] modem_hsic_read : copy_to_user bytes_read =69 [ 990.808227] modem_hsic_read : [ 990.812536] modem_do_read_io [ 990.815963] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 990.823333] modem_read_bulk_callback [ 990.827837] modem_read_bulk_callback, length = 12 [ 990.834483] modem_hsic_read : copy_to_user bytes_read =12 [ 993.301861] modem_hsic_release : [ 993.356191] modem4_load: Called with value : 0 [ 993.360724] modem4_setdata: powerstate = 255. [ 993.365225] modem4_setdata: Active wakelock in UNK [ 993.370285] Wake40 for irq=53 [ 993.373328] Disabling wake40 [ 993.376365] tegra-ehci tegra-ehci.1: remove, state 1 [ 993.381683] usb usb1: USB disconnect, device number 1 [ 993.386809] usb 1-1: USB disconnect, device number 2 [ 993.391968] boot_hsic_disconnect : [ 993.395770] boot_hsic_delete : [ 993.399074] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 993.426480] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 993.446187] modem4_pre_phy_off. [ 993.476386] CPU1: Booted secondary processor [ 993.486192] Switched to NOHz mode on CPU #1 [ 993.499965] modem4_load: Called with value : 1 [ 993.505317] Reset USB controller WAR. [ 993.509619] tegra USB phy - inst[1] platform info: [ 993.514934] port_otg: no [ 993.517802] has_hostpc: yes [ 993.520829] phy_interface: USB_PHY_INTF_HSIC [ 993.525522] op_mode: TEGRA_USB_OPMODE_HOST [ 993.530006] vbus_gpio: -1 [ 993.532763] vbus_reg: NULL [ 993.535582] hot_plug: disabled [ 993.538769] remote_wakeup: disabled [ 993.542340] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 993.561263] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 993.567332] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 993.596153] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 993.616135] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 993.622242] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 993.629111] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 993.636494] usb usb1: Product: Tegra EHCI Host Controller [ 993.642067] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 993.648084] usb usb1: SerialNumber: tegra-ehci.1 [ 993.653169] hub 1-0:1.0: USB hub found [ 993.657008] hub 1-0:1.0: 1 port detected [ 993.661011] modem4_phy_ready. [ 993.664038] modem4_phy_ready : Driving AWR high. [ 993.742403] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 993.749970] Wake40 for irq=53 [ 993.752999] Enabling wake40 [ 994.116288] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 995.646309] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 995.653276] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 995.660893] usb 1-1: Product: Pegasus-S HSIC [ 995.665399] usb 1-1: Manufacturer: Renesas [ 995.856360] CPU1: shutdown [ 996.291409] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 997.000423] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 997.006996] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 997.026944] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 997.039627] modem4_usbnotify: Modem attached. [ 997.044108] modem4_setdata: powerstate = 0. [ 997.048789] modem4_setdata: Releasing wakelock. [ 997.158902] Renesas HSIC netdevice mounted (usb0) [ 997.164902] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 997.172491] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 997.487271] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 997.496012] cdc_ncm: usb0: network connection: connected [ 997.503954] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 1008.276266] usb0: no IPv6 routers present [ 1009.199921] phonet_rcv Drop message ! [ 1009.204882] phonet_rcv Drop message ! [ 1009.606692] phonet_rcv Drop message ! [ 1009.611187] phonet_rcv Drop message ! [ 1010.299652] phonet_rcv Drop message ! [ 1010.314175] phonet_rcv Drop message ! [ 1017.384637] CPU1: Booted secondary processor [ 1017.391232] Switched to NOHz mode on CPU #1 [ 1019.487472] CPU1: shutdown [ 1021.567520] modem4_l2_suspend. [ 1021.571313] modem4_setdata: powerstate = 2. [ 1022.057725] modem4_wake_irq: Modem wakeup request from L2. [ 1022.064109] modem4_l2_resume. [ 1022.067924] modem4_setdata: powerstate = 0. [ 1022.130604] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 1030.563643] modem4_l2_suspend. [ 1030.568241] modem4_setdata: powerstate = 2. [ 1030.799293] modem4_wake_irq: Modem wakeup request from L2. [ 1030.805676] modem4_l2_resume. [ 1030.809886] modem4_setdata: powerstate = 0. [ 1030.870720] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 1045.114207] CPU1: Booted secondary processor [ 1045.126160] Switched to NOHz mode on CPU #1 [ 1047.954863] swapper: page allocation failure: order:3, mode:0x20 [ 1047.961366] Mem-info: [ 1047.963874] Normal per-cpu: [ 1047.966907] CPU 0: hi: 186, btch: 31 usd: 159 [ 1047.972125] CPU 1: hi: 186, btch: 31 usd: 33 [ 1047.977170] active_anon:28600 inactive_anon:74 isolated_anon:0 [ 1047.977183] active_file:10204 inactive_file:79597 isolated_file:0 [ 1047.977195] unevictable:24 dirty:1320 writeback:4702 unstable:0 [ 1047.977207] free:1135 slab_reclaimable:2074 slab_unreclaimable:4610 [ 1047.977220] mapped:5573 shmem:94 pagetables:1407 bounce:0 [ 1048.008770] Normal free:4540kB min:3496kB low:4368kB high:5244kB active_anon:114400kB inactive_anon:296kB active_file:40816kB inactive_file:318388kB unevictable:96kB isolated(anon):0kB isolated(file):0kB present:764176kB mlocked:0kB dirty:5280kB writeback:18808kB mapped:22292kB shmem:376kB slab_reclaimable:8296kB slab_unreclaimable:18440kB kernel_stack:3752kB pagetables:5628kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [ 1048.049885] lowmem_reserve[]: 0 0 0 [ 1048.054534] Normal: 579*4kB 158*8kB 60*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4540kB [ 1048.068206] 89941 total pagecache pages [ 1048.072264] 0 pages in swap cache [ 1048.075806] Swap cache stats: add 0, delete 0, find 0/0 [ 1048.081451] Free swap = 0kB [ 1048.084557] Total swap = 0kB [ 1048.181007] 196096 pages of RAM [ 1048.184407] 1973 free pages [ 1048.187625] 9188 reserved pages [ 1048.190995] 6700 slab pages [ 1048.194012] 156876 pages shared [ 1048.197379] 0 pages swap cached [ 1048.201069] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1048.206822] swapper: page allocation failure: order:3, mode:0x20 [ 1048.213277] Mem-info: [ 1048.215783] Normal per-cpu: [ 1048.218813] CPU 0: hi: 186, btch: 31 usd: 159 [ 1048.223831] CPU 1: hi: 186, btch: 31 usd: 33 [ 1048.228878] active_anon:28600 inactive_anon:74 isolated_anon:0 [ 1048.228890] active_file:10204 inactive_file:79597 isolated_file:0 [ 1048.228902] unevictable:24 dirty:1320 writeback:4702 unstable:0 [ 1048.228915] free:1135 slab_reclaimable:2074 slab_unreclaimable:4610 [ 1048.228927] mapped:5573 shmem:94 pagetables:1407 bounce:0 [ 1048.260473] Normal free:4540kB min:3496kB low:4368kB high:5244kB active_anon:114400kB inactive_anon:296kB active_file:40816kB inactive_file:318388kB unevictable:96kB isolated(anon):0kB isolated(file):0kB present:764176kB mlocked:0kB dirty:5280kB writeback:18808kB mapped:22292kB shmem:376kB slab_reclaimable:8296kB slab_unreclaimable:18440kB kernel_stack:3752kB pagetables:5628kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [ 1048.301595] lowmem_reserve[]: 0 0 0 [ 1048.306256] Normal: 579*4kB 158*8kB 60*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4540kB [ 1048.320134] 89941 total pagecache pages [ 1048.324396] 0 pages in swap cache [ 1048.327939] Swap cache stats: add 0, delete 0, find 0/0 [ 1048.333589] Free swap = 0kB [ 1048.336694] Total swap = 0kB [ 1048.430936] 196096 pages of RAM [ 1048.434340] 1973 free pages [ 1048.437560] 9188 reserved pages [ 1048.440927] 6700 slab pages [ 1048.443946] 156876 pages shared [ 1048.447313] 0 pages swap cached [ 1048.450929] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1048.457446] swapper: page allocation failure: order:3, mode:0x20 [ 1048.463889] Mem-info: [ 1048.466394] Normal per-cpu: [ 1048.469423] CPU 0: hi: 186, btch: 31 usd: 159 [ 1048.474647] CPU 1: hi: 186, btch: 31 usd: 33 [ 1048.479691] active_anon:28600 inactive_anon:74 isolated_anon:0 [ 1048.479703] active_file:10204 inactive_file:79597 isolated_file:0 [ 1048.479716] unevictable:24 dirty:1320 writeback:4702 unstable:0 [ 1048.479728] free:1135 slab_reclaimable:2074 slab_unreclaimable:4610 [ 1048.479740] mapped:5573 shmem:94 pagetables:1407 bounce:0 [ 1048.511288] Normal free:4540kB min:3496kB low:4368kB high:5244kB active_anon:114400kB inactive_anon:296kB active_file:40816kB inactive_file:318388kB unevictable:96kB isolated(anon):0kB isolated(file):0kB present:764176kB mlocked:0kB dirty:5280kB writeback:18808kB mapped:22292kB shmem:376kB slab_reclaimable:8296kB slab_unreclaimable:18440kB kernel_stack:3752kB pagetables:5628kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [ 1048.552398] lowmem_reserve[]: 0 0 0 [ 1048.557042] Normal: 579*4kB 158*8kB 60*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4540kB [ 1048.570720] 89941 total pagecache pages [ 1048.574978] 0 pages in swap cache [ 1048.578521] Swap cache stats: add 0, delete 0, find 0/0 [ 1048.584170] Free swap = 0kB [ 1048.587277] Total swap = 0kB [ 1048.678294] 196096 pages of RAM [ 1048.681693] 1973 free pages [ 1048.684915] 9188 reserved pages [ 1048.688281] 6700 slab pages [ 1048.691304] 156876 pages shared [ 1048.694671] 0 pages swap cached [ 1048.698271] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1048.704767] swapper: page allocation failure: order:3, mode:0x20 [ 1048.711202] Mem-info: [ 1048.713708] Normal per-cpu: [ 1048.716736] CPU 0: hi: 186, btch: 31 usd: 159 [ 1048.721961] CPU 1: hi: 186, btch: 31 usd: 33 [ 1048.727008] active_anon:28600 inactive_anon:74 isolated_anon:0 [ 1048.727020] active_file:10204 inactive_file:79597 isolated_file:0 [ 1048.727032] unevictable:24 dirty:1320 writeback:4702 unstable:0 [ 1048.727045] free:1135 slab_reclaimable:2074 slab_unreclaimable:4610 [ 1048.727057] mapped:5573 shmem:94 pagetables:1407 bounce:0 [ 1048.758616] Normal free:4540kB min:3496kB low:4368kB high:5244kB active_anon:114400kB inactive_anon:296kB active_file:40816kB inactive_file:318388kB unevictable:96kB isolated(anon):0kB isolated(file):0kB present:764176kB mlocked:0kB dirty:5280kB writeback:18808kB mapped:22292kB shmem:376kB slab_reclaimable:8296kB slab_unreclaimable:18440kB kernel_stack:3752kB pagetables:5628kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [ 1048.799736] lowmem_reserve[]: 0 0 0 [ 1048.804602] Normal: 579*4kB 158*8kB 60*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4540kB [ 1048.818294] 89941 total pagecache pages [ 1048.822558] 0 pages in swap cache [ 1048.826104] Swap cache stats: add 0, delete 0, find 0/0 [ 1048.831756] Free swap = 0kB [ 1048.834861] Total swap = 0kB [ 1048.929710] 196096 pages of RAM [ 1048.933123] 1974 free pages [ 1048.936348] 9188 reserved pages [ 1048.939715] 6700 slab pages [ 1048.942734] 156872 pages shared [ 1048.946102] 0 pages swap cached [ 1048.949705] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1048.962055] cdc_ncm 1-1:1.0: usb0: rxqlen 1 --> 5 [ 1048.971862] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1048.984128] swapper: page allocation failure: order:3, mode:0x20 [ 1048.990366] Mem-info: [ 1048.992758] Normal per-cpu: [ 1048.995668] CPU 0: hi: 186, btch: 31 usd: 159 [ 1049.000570] CPU 1: hi: 186, btch: 31 usd: 174 [ 1049.005592] active_anon:28600 inactive_anon:74 isolated_anon:0 [ 1049.005599] active_file:10204 inactive_file:79406 isolated_file:0 [ 1049.005606] unevictable:24 dirty:1319 writeback:4572 unstable:0 [ 1049.005612] free:1161 slab_reclaimable:2074 slab_unreclaimable:4786 [ 1049.005619] mapped:5573 shmem:94 pagetables:1407 bounce:0 [ 1049.036312] Normal free:4644kB min:3496kB low:4368kB high:5244kB active_anon:114400kB inactive_anon:296kB active_file:40816kB inactive_file:317624kB unevictable:96kB isolated(anon):0kB isolated(file):0kB present:764176kB mlocked:0kB dirty:5276kB writeback:18288kB mapped:22292kB shmem:376kB slab_reclaimable:8296kB slab_unreclaimable:19144kB kernel_stack:3752kB pagetables:5628kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [ 1049.077003] lowmem_reserve[]: 0 0 0 [ 1049.081106] Normal: 569*4kB 166*8kB 61*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4580kB [ 1049.093433] 89733 total pagecache pages [ 1049.097483] 0 pages in swap cache [ 1049.100910] Swap cache stats: add 0, delete 0, find 0/0 [ 1049.106346] Free swap = 0kB [ 1049.109337] Total swap = 0kB [ 1049.161086] 196096 pages of RAM [ 1049.164355] 2124 free pages [ 1049.167366] 9188 reserved pages [ 1049.170618] 6877 slab pages [ 1049.173524] 156766 pages shared [ 1049.176776] 0 pages swap cached [ 1049.180205] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1049.185522] swapper: page allocation failure: order:3, mode:0x20 [ 1049.191744] Mem-info: [ 1049.194129] Normal per-cpu: [ 1049.197038] CPU 0: hi: 186, btch: 31 usd: 159 [ 1049.201940] CPU 1: hi: 186, btch: 31 usd: 174 [ 1049.206957] active_anon:28600 inactive_anon:74 isolated_anon:0 [ 1049.206963] active_file:10204 inactive_file:79406 isolated_file:0 [ 1049.206970] unevictable:24 dirty:1319 writeback:4572 unstable:0 [ 1049.206977] free:1161 slab_reclaimable:2074 slab_unreclaimable:4786 [ 1049.206983] mapped:5573 shmem:94 pagetables:1407 bounce:0 [ 1049.237575] Normal free:4644kB min:3496kB low:4368kB high:5244kB active_anon:114400kB inactive_anon:296kB active_file:40816kB inactive_file:317624kB unevictable:96kB isolated(anon):0kB isolated(file):0kB present:764176kB mlocked:0kB dirty:5276kB writeback:18288kB mapped:22292kB shmem:376kB slab_reclaimable:8296kB slab_unreclaimable:19144kB kernel_stack:3752kB pagetables:5628kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [ 1049.278366] lowmem_reserve[]: 0 0 0 [ 1049.282468] Normal: 569*4kB 166*8kB 61*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4580kB [ 1049.294796] 89733 total pagecache pages [ 1049.298844] 0 pages in swap cache [ 1049.302272] Swap cache stats: add 0, delete 0, find 0/0 [ 1049.307605] Free swap = 0kB [ 1049.310701] Total swap = 0kB [ 1049.361670] 196096 pages of RAM [ 1049.364940] 2124 free pages [ 1049.367846] 9188 reserved pages [ 1049.371205] 6877 slab pages [ 1049.374108] 156766 pages shared [ 1049.377362] 0 pages swap cached [ 1049.380741] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1049.387088] swapper: page allocation failure: order:3, mode:0x20 [ 1049.393314] Mem-info: [ 1049.395700] Normal per-cpu: [ 1049.398609] CPU 0: hi: 186, btch: 31 usd: 159 [ 1049.403512] CPU 1: hi: 186, btch: 31 usd: 174 [ 1049.408527] active_anon:28600 inactive_anon:74 isolated_anon:0 [ 1049.408534] active_file:10204 inactive_file:79406 isolated_file:0 [ 1049.408541] unevictable:24 dirty:1319 writeback:4572 unstable:0 [ 1049.408547] free:1161 slab_reclaimable:2074 slab_unreclaimable:4786 [ 1049.408554] mapped:5573 shmem:94 pagetables:1407 bounce:0 [ 1049.439248] Normal free:4644kB min:3496kB low:4368kB high:5244kB active_anon:114400kB inactive_anon:296kB active_file:40816kB inactive_file:317624kB unevictable:96kB isolated(anon):0kB isolated(file):0kB present:764176kB mlocked:0kB dirty:5276kB writeback:18288kB mapped:22292kB shmem[ 1050.167645] 196096 pages of RAM [ 1050.170910] 2124 free pages [ 1050.173917] 9188 reserved pages [ 1050.177167] 6877 slab pages [ 1050.180071] 156766 pages shared [ 1050.183323] 0 pages swap cached [ 1050.186702] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.193981] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.200884] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 1050.207645] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1050.214382] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.221404] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1050.228226] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.233476] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.239849] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.246133] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.252502] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.258783] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.265401] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.271590] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.277807] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.283959] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.290177] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.306496] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 4 [ 1050.311870] cdc_ncm 1-1:1.0: usb0: rxqlen 4 --> 5 [ 1050.317219] cdc_ncm 1-1:1.0: usb0: rxqlen 2 --> 5 [ 1050.322957] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1050.332437] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.337667] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.343873] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.350134] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.356338] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.362704] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.368875] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.375082] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.381244] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.387462] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.393611] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.400952] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 1050.405903] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.411780] cdc_ncm 1-1:1.0: usb0: rxqlen 4 --> 5 [ 1050.416821] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.423427] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.429860] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.436121] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.442323] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.448725] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.454889] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.461155] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.467386] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.473552] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.496851] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x104 [ 1050.503045] cdc_ncm 1-1:1.0: usb0: rxqlen 1 --> 5 [ 1050.508501] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1050.535062] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.540289] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.546490] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.552746] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.558946] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.565202] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.571517] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.577740] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.583891] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.590296] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.596872] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.603449] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 3 [ 1050.608987] cdc_ncm 1-1:1.0: usb0: rxqlen 3 --> 5 [ 1050.614384] cdc_ncm 1-1:1.0: usb0: rxqlen 3 --> 5 [ 1050.620187] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.625422] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.631629] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.637914] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.644071] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.650291] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.656450] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.662679] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.668845] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.675052] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.681211] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.687427] cdc_ncm 1-1:1.0: usb0: rxqlen 2 --> 0 [ 1050.716562] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x104 [ 1050.722874] cdc_ncm 1-1:1.0: usb0: rxqlen 1 --> 5 [ 1050.728264] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1050.749436] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.754606] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.760865] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.767069] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.773329] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.779530] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.785892] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.792119] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.798281] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.804492] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.810652] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.817770] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 1050.822719] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.828539] cdc_ncm 1-1:1.0: usb0: rxqlen 4 --> 5 [ 1050.833374] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.839924] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.846618] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.852950] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.859567] cdc_ncm 1-1:1.0: usb0: rxqlen 3 --> 5 [ 1050.864456] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.870660] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.876921] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.883124] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.889383] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.895740] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.903264] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x104 [ 1050.909501] cdc_ncm 1-1:1.0: usb0: rxqlen 1 --> 5 [ 1050.914946] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1050.921811] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.927702] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1050.933689] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.939623] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1050.945721] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1050.950944] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.957145] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.963403] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.969606] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.975865] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.982194] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.988433] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1050.994586] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.000804] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.006962] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.016765] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 1051.022215] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1051.047440] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1051.052610] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.058869] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.065070] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.071330] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.077531] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.083901] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.090129] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.096287] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.102682] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.109136] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.116160] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1051.121300] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.127533] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.133691] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.139915] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.146065] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.152284] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.158470] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.164683] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.170844] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.177231] cdc_ncm 1-1:1.0: usb0: kevent 2 may have been dropped [ 1051.206615] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x104 [ 1051.212905] cdc_ncm 1-1:1.0: usb0: rxqlen 1 --> 5 [ 1051.218341] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1051.224949] cdc_ncm 1-1:1.0: usb0: kevent 2 scheduled [ 1051.230289] cdc_ncm 1-1:1.0: usb0: kevent done, flags = 0x100 [ 1051.511742] CPU1: shutdown [ 1052.747191] cdc_ncm 1-1:1.0: usb0: rx throttle -71 [ 1052.753724] Modem crash occurs - NB modem reboot since power on : 19 [ 1052.766349] modem4_load: Called with value : 0 [ 1052.771024] modem4_setdata: powerstate = 255. [ 1052.775495] modem4_setdata: Taking wakelock. [ 1052.780301] Wake40 for irq=53 [ 1052.783456] Disabling wake40 [ 1052.786575] tegra-ehci tegra-ehci.1: remove, state 1 [ 1052.791734] usb usb1: USB disconnect, device number 1 [ 1052.797072] usb 1-1: USB disconnect, device number 2 [ 1052.802390] cdc_ncm 1-1:1.0: usb0: unregister 'cdc_ncm' usb-tegra-ehci.1-1, CDC NCM [ 1052.846424] modem4_usbnotify: Modem detached. [ 1052.850867] modem4_setdata: powerstate = 255. [ 1052.855328] modem4_setdata: Active wakelock in UNK [ 1052.876515] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 1052.896210] modem4_pre_phy_off. [ 1052.900780] modem4_load: Called with value : 1 [ 1052.905477] Reset USB controller WAR. [ 1052.909308] tegra USB phy - inst[1] platform info: [ 1052.914205] port_otg: no [ 1052.916806] has_hostpc: yes [ 1052.919657] phy_interface: USB_PHY_INTF_HSIC [ 1052.924046] op_mode: TEGRA_USB_OPMODE_HOST [ 1052.928208] vbus_gpio: -1 [ 1052.930881] vbus_reg: NULL [ 1052.933694] hot_plug: disabled [ 1052.936811] remote_wakeup: disabled [ 1052.940373] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 1052.959279] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 1052.965315] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 1052.996297] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 1053.016194] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 1053.022342] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 1053.029283] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 1053.036583] usb usb1: Product: Tegra EHCI Host Controller [ 1053.042088] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 1053.048068] usb usb1: SerialNumber: tegra-ehci.1 [ 1053.053147] hub 1-0:1.0: USB hub found [ 1053.056982] hub 1-0:1.0: 1 port detected [ 1053.060984] modem4_phy_ready. [ 1053.074084] modem4_phy_ready: Timeout 4 modem ready. Maybe 1st enum ? [ 1053.080769] Wake40 for irq=53 [ 1053.083790] Enabling wake40 [ 1053.506215] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 1053.526383] tegra CPU: force EDP limit 1200000 kHz [ 1053.536822] CPU1: Booted secondary processor [ 1053.537612] usb 1-1: New USB device found, idVendor=045b, idProduct=0213 [ 1053.537620] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 1053.537627] usb 1-1: Product: HakuyaS USB [ 1053.537632] usb 1-1: Manufacturer: Renesas [ 1053.539886] modem_boot_hsic 1-1:1.0: USB HAKUYA-S device now attached to USBRenesas-192vid 0x045B pid 0x0213 [ 1053.544108] modem_hsic_open [ 1053.544137] modem_hsic_release : [ 1053.586135] Switched to NOHz mode on CPU #1 [ 1053.597233] tegra CPU: force EDP limit 1100000 kHz [ 1053.607611] CPU2: Booted secondary processor [ 1053.616129] Switched to NOHz mode on CPU #2 [ 1054.087916] modem_hsic_open [ 1054.098969] modem_hsic_read : [ 1054.102782] modem_do_read_io [ 1054.105981] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 1054.106125] modem_read_bulk_callback [ 1054.106146] modem_read_bulk_callback, length = 69 [ 1054.121100] modem_hsic_read : copy_to_user bytes_read =69 [ 1054.737425] modem_hsic_read : [ 1054.740726] modem_do_read_io [ 1054.743535] modem_hsic_read : modem_do_read_io3 , retval = =0 [ 1054.868840] modem_read_bulk_callback [ 1054.872371] modem_read_bulk_callback, length = 12 [ 1054.882133] modem_hsic_read : copy_to_user bytes_read =12 [ 1055.818313] CPU2: shutdown [ 1057.346292] modem_hsic_release : [ 1057.400149] modem4_load: Called with value : 0 [ 1057.404711] modem4_setdata: powerstate = 255. [ 1057.409141] modem4_setdata: Active wakelock in UNK [ 1057.414070] Wake40 for irq=53 [ 1057.417154] Disabling wake40 [ 1057.425034] tegra-ehci tegra-ehci.1: remove, state 1 [ 1057.430094] usb usb1: USB disconnect, device number 1 [ 1057.435258] usb 1-1: USB disconnect, device number 2 [ 1057.440381] boot_hsic_disconnect : [ 1057.444274] boot_hsic_delete : [ 1057.447612] modem_boot_hsic 1-1:1.0: USB Hakuya Renesas Modem #192 now disconnected [ 1057.476488] tegra-ehci tegra-ehci.1: USB bus 1 deregistered [ 1057.497466] tegra CPU: force EDP limit 1100000 kHz [ 1057.508505] CPU2: Booted secondary processor [ 1057.516139] Switched to NOHz mode on CPU #2 [ 1057.516221] modem4_pre_phy_off. [ 1057.566559] modem4_load: Called with value : 1 [ 1057.571352] Reset USB controller WAR. [ 1057.575144] tegra USB phy - inst[1] platform info: [ 1057.580111] port_otg: no [ 1057.582708] has_hostpc: yes [ 1057.585559] phy_interface: USB_PHY_INTF_HSIC [ 1057.589956] op_mode: TEGRA_USB_OPMODE_HOST [ 1057.594176] vbus_gpio: -1 [ 1057.596880] vbus_reg: NULL [ 1057.599661] hot_plug: disabled [ 1057.602790] remote_wakeup: disabled [ 1057.606481] create_regulator: fixed_reg_pmu_3v3_en: Failed to create debugfs directory [ 1057.625368] tegra-ehci tegra-ehci.1: Tegra EHCI Host Controller [ 1057.631489] tegra-ehci tegra-ehci.1: new USB bus registered, assigned bus number 1 [ 1057.666159] tegra-ehci tegra-ehci.1: irq 53, io mem 0x7d004000 [ 1057.686141] tegra-ehci tegra-ehci.1: USB 2.0 started, EHCI 1.00 [ 1057.692244] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 1057.699114] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 1057.706507] usb usb1: Product: Tegra EHCI Host Controller [ 1057.711992] usb usb1: Manufacturer: Linux 3.1.10-dirty ehci_hcd [ 1057.718055] usb usb1: SerialNumber: tegra-ehci.1 [ 1057.723257] hub 1-0:1.0: USB hub found [ 1057.727230] hub 1-0:1.0: 1 port detected [ 1057.731252] modem4_phy_ready. [ 1057.734284] modem4_phy_ready : Driving AWR high. [ 1057.814074] uhsic_phy_bus_port_power: timeout waiting for UHSIC_CONNECT_DETECT [ 1057.821613] Wake40 for irq=53 [ 1057.824707] Enabling wake40 [ 1058.186330] usb 1-1: new high speed USB device number 2 using tegra-ehci [ 1059.716222] usb 1-1: New USB device found, idVendor=045b, idProduct=020f [ 1059.723406] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 1059.731251] usb 1-1: Product: Pegasus-S HSIC [ 1059.735775] usb 1-1: Manufacturer: Renesas [ 1060.241621] CPU1: shutdown [ 1060.361286] dwNtbInMaxSize=16900 dwNtbOutMaxSize=16896 wNdpOutPayloadRemainder=508 wNdpOutDivisor=512 wNdpOutAlignment=4 wNtbOutMaxDatagrams=1 flags=0x0 [ 1061.074408] usb 1-1: MAC-Address: 0x74:0x90:0x50:0x00:0x00:0x01 [ 1061.080668] cdc_ncm 1-1:1.0: status ep1in, 64 bytes period 7 [ 1061.097186] cdc_ncm 1-1:1.0: usb0: register 'cdc_ncm' at usb-tegra-ehci.1-1, CDC NCM, 74:90:50:00:00:01 [ 1061.111047] modem4_usbnotify: Modem attached. [ 1061.115653] modem4_setdata: powerstate = 0. [ 1061.120476] modem4_setdata: Releasing wakelock. [ 1061.230516] Renesas HSIC netdevice mounted (usb0) [ 1061.241901] cdc_ncm 1-1:1.0: usb0: rxqlen 0 --> 5 [ 1061.249768] ADDRCONF(NETDEV_UP): usb0: link is not ready [ 1061.564051] cdc_ncm: usb0: 50 mbit/s downlink 100 mbit/s uplink [ 1061.572794] cdc_ncm: usb0: network connection: connected [ 1061.582016] ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready [ 1062.247623] CPU2: shutdown