[ 268.343985] type=1400 audit(1368808523.497:10): apparmor="STATUS" operation="profile_load" name="/usr/lib/libvirt/virt-aa-helper" pid=4303 comm="apparmor_parser" [ 268.743733] Ebtables v2.0 registered [ 268.758732] ip_tables: (C) 2000-2006 Netfilter Core Team [ 268.773235] ip6_tables: (C) 2000-2006 Netfilter Core Team [ 583.918474] openvswitch: Open vSwitch switching datapath [ 608.697477] IPv6: ADDRCONF(NETDEV_UP): s1-eth1: link is not ready [ 608.746466] IPv6: ADDRCONF(NETDEV_CHANGE): s1-eth1: link becomes ready [ 608.869824] IPv6: ADDRCONF(NETDEV_UP): s1-eth2: link is not ready [ 608.940724] IPv6: ADDRCONF(NETDEV_CHANGE): s1-eth2: link becomes ready [ 609.049357] IPv6: ADDRCONF(NETDEV_UP): s1-eth3: link is not ready [ 609.113500] IPv6: ADDRCONF(NETDEV_CHANGE): s1-eth3: link becomes ready [ 609.222490] IPv6: ADDRCONF(NETDEV_UP): s1-eth4: link is not ready [ 609.285303] IPv6: ADDRCONF(NETDEV_CHANGE): s1-eth4: link becomes ready [ 609.394483] IPv6: ADDRCONF(NETDEV_UP): s1-eth5: link is not ready [ 609.456664] IPv6: ADDRCONF(NETDEV_CHANGE): s1-eth5: link becomes ready [ 609.565741] IPv6: ADDRCONF(NETDEV_UP): s1-eth6: link is not ready [ 609.639230] IPv6: ADDRCONF(NETDEV_CHANGE): s1-eth6: link becomes ready [ 609.742882] IPv6: ADDRCONF(NETDEV_UP): s1-eth7: link is not ready [ 609.825695] IPv6: ADDRCONF(NETDEV_CHANGE): s1-eth7: link becomes ready [ 609.937683] IPv6: ADDRCONF(NETDEV_UP): s2-eth1: link is not ready [ 610.006319] IPv6: ADDRCONF(NETDEV_CHANGE): s2-eth1: link becomes ready [ 610.113681] IPv6: ADDRCONF(NETDEV_UP): s2-eth2: link is not ready [ 610.192154] IPv6: ADDRCONF(NETDEV_CHANGE): s2-eth2: link becomes ready [ 610.302946] IPv6: ADDRCONF(NETDEV_UP): s2-eth3: link is not ready [ 610.375659] IPv6: ADDRCONF(NETDEV_CHANGE): s2-eth3: link becomes ready [ 610.485828] IPv6: ADDRCONF(NETDEV_UP): s2-eth4: link is not ready [ 610.558245] IPv6: ADDRCONF(NETDEV_CHANGE): s2-eth4: link becomes ready [ 610.677532] IPv6: ADDRCONF(NETDEV_UP): s2-eth5: link is not ready [ 610.761749] IPv6: ADDRCONF(NETDEV_CHANGE): s2-eth5: link becomes ready [ 610.866279] IPv6: ADDRCONF(NETDEV_UP): s2-eth6: link is not ready [ 610.932650] IPv6: ADDRCONF(NETDEV_CHANGE): s2-eth6: link becomes ready [ 611.041778] IPv6: ADDRCONF(NETDEV_UP): s2-eth7: link is not ready [ 611.118259] IPv6: ADDRCONF(NETDEV_CHANGE): s2-eth7: link becomes ready [ 611.226282] IPv6: ADDRCONF(NETDEV_UP): s1-eth8: link is not ready [ 611.242847] IPv6: ADDRCONF(NETDEV_CHANGE): s1-eth8: link becomes ready [ 611.441561] device s1 entered promiscuous mode [ 611.489178] device s1-eth1 entered promiscuous mode [ 611.501477] device s1-eth2 entered promiscuous mode [ 611.513307] device s1-eth3 entered promiscuous mode [ 611.527442] device s1-eth4 entered promiscuous mode [ 611.539612] device s1-eth5 entered promiscuous mode [ 611.553826] device s1-eth6 entered promiscuous mode [ 611.571768] device s1-eth7 entered promiscuous mode [ 611.580718] device s1-eth8 entered promiscuous mode [ 611.614072] device s2 entered promiscuous mode [ 611.663765] device s2-eth1 entered promiscuous mode [ 611.678141] device s2-eth2 entered promiscuous mode [ 611.690220] device s2-eth3 entered promiscuous mode [ 611.709404] device s2-eth4 entered promiscuous mode [ 611.724433] device s2-eth5 entered promiscuous mode [ 611.740260] device s2-eth6 entered promiscuous mode [ 611.754697] device s2-eth7 entered promiscuous mode [ 611.773817] device s2-eth8 entered promiscuous mode [ 617.969584] device s1-eth1 left promiscuous mode [ 617.996523] device s1-eth2 left promiscuous mode [ 617.996531] device s1-eth3 left promiscuous mode [ 617.996534] device s1-eth4 left promiscuous mode [ 617.996537] device s1-eth5 left promiscuous mode [ 617.996540] device s1-eth6 left promiscuous mode [ 617.996543] device s1-eth7 left promiscuous mode [ 617.996546] device s1-eth8 left promiscuous mode [ 617.996549] device s1 left promiscuous mode [ 618.142086] device s2-eth8 left promiscuous mode [ 618.164798] device s2-eth1 left promiscuous mode [ 618.164805] device s2-eth2 left promiscuous mode [ 618.164809] device s2-eth3 left promiscuous mode [ 618.164812] device s2-eth4 left promiscuous mode [ 618.164834] device s2-eth5 left promiscuous mode [ 618.164840] device s2-eth6 left promiscuous mode [ 618.164843] device s2-eth7 left promiscuous mode [ 618.164846] device s2 left promiscuous mode [ 618.483362] IPv6: ADDRCONF(NETDEV_UP): s1-eth1: link is not ready [ 628.220062] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 638.460029] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 648.712030] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 658.720053] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 668.800063] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 678.828052] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 689.068072] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 699.324048] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 709.564040] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 719.816036] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 730.056027] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 740.296027] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 750.536030] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 760.788026] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 771.028027] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 781.268057] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 791.508027] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 801.760026] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 812.000029] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 822.240031] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 832.480024] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 840.564053] INFO: task mnexec:9343 blocked for more than 120 seconds. [ 840.564268] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.564494] mnexec D ffff88003fc14240 0 9343 8358 0x00000000 [ 840.564498] ffff880036c3fe20 0000000000000046 ffff880036c3ffd8 0000000000014240 [ 840.564501] ffff880036c3ffd8 0000000000014240 ffff88003c1add40 ffffffff81ccea60 [ 840.564503] ffff88003c1add40 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.564506] Call Trace: [ 840.564531] [] schedule_preempt_disabled+0x29/0x70 [ 840.564535] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.564550] [] ? __kmalloc+0x14f/0x180 [ 840.564554] [] mutex_lock+0x1f/0x30 [ 840.564564] [] copy_net_ns+0x65/0x100 [ 840.564574] [] create_new_namespaces+0xf9/0x180 [ 840.564577] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.564582] [] sys_unshare+0x181/0x2a0 [ 840.564585] [] system_call_fastpath+0x1a/0x1f [ 840.564587] INFO: task mnexec:9344 blocked for more than 120 seconds. [ 840.564799] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.565028] mnexec D ffff88003fc14240 0 9344 8358 0x00000000 [ 840.565031] ffff88003c64de20 0000000000000046 ffff88003c64dfd8 0000000000014240 [ 840.565033] ffff88003c64dfd8 0000000000014240 ffff88003c1a9750 ffffffff81ccea60 [ 840.565035] ffff88003c1a9750 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.565037] Call Trace: [ 840.565040] [] schedule_preempt_disabled+0x29/0x70 [ 840.565043] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.565046] [] ? __kmalloc+0x14f/0x180 [ 840.565049] [] mutex_lock+0x1f/0x30 [ 840.565051] [] copy_net_ns+0x65/0x100 [ 840.565070] [] create_new_namespaces+0xf9/0x180 [ 840.565074] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.565077] [] sys_unshare+0x181/0x2a0 [ 840.565079] [] system_call_fastpath+0x1a/0x1f [ 840.565081] INFO: task mnexec:9345 blocked for more than 120 seconds. [ 840.565281] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.565511] mnexec D ffff88003fc14240 0 9345 8358 0x00000000 [ 840.565514] ffff88003b367e20 0000000000000046 ffff88003b367fd8 0000000000014240 [ 840.565516] ffff88003b367fd8 0000000000014240 ffff88003c1a8000 ffffffff81ccea60 [ 840.565518] ffff88003c1a8000 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.565520] Call Trace: [ 840.565523] [] schedule_preempt_disabled+0x29/0x70 [ 840.565526] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.565528] [] ? copy_net_ns+0x46/0x100 [ 840.565531] [] mutex_lock+0x1f/0x30 [ 840.565533] [] copy_net_ns+0x65/0x100 [ 840.565535] [] create_new_namespaces+0xf9/0x180 [ 840.565538] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.565540] [] sys_unshare+0x181/0x2a0 [ 840.565542] [] system_call_fastpath+0x1a/0x1f [ 840.565544] INFO: task mnexec:9346 blocked for more than 120 seconds. [ 840.565885] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.566398] mnexec D ffff88003fc14240 0 9346 8358 0x00000000 [ 840.566400] ffff880036cf7e20 0000000000000046 ffff880036cf7fd8 0000000000014240 [ 840.566402] ffff880036cf7fd8 0000000000014240 ffff8800370e8000 ffffffff81ccea60 [ 840.566404] ffff8800370e8000 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.566406] Call Trace: [ 840.566409] [] schedule_preempt_disabled+0x29/0x70 [ 840.566411] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.566414] [] ? __kmalloc+0x14f/0x180 [ 840.566417] [] mutex_lock+0x1f/0x30 [ 840.566419] [] copy_net_ns+0x65/0x100 [ 840.566422] [] create_new_namespaces+0xf9/0x180 [ 840.566424] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.566426] [] sys_unshare+0x181/0x2a0 [ 840.566428] [] system_call_fastpath+0x1a/0x1f [ 840.566430] INFO: task mnexec:9347 blocked for more than 120 seconds. [ 840.566782] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.567311] mnexec D ffff88003fc14240 0 9347 8358 0x00000000 [ 840.567313] ffff880036ddde20 0000000000000046 ffff880036dddfd8 0000000000014240 [ 840.567315] ffff880036dddfd8 0000000000014240 ffff8800370edd40 ffffffff81ccea60 [ 840.567317] ffff8800370edd40 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.567319] Call Trace: [ 840.567322] [] schedule_preempt_disabled+0x29/0x70 [ 840.567324] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.567327] [] ? __kmalloc+0x14f/0x180 [ 840.567330] [] mutex_lock+0x1f/0x30 [ 840.567332] [] copy_net_ns+0x65/0x100 [ 840.567334] [] create_new_namespaces+0xf9/0x180 [ 840.567337] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.567339] [] sys_unshare+0x181/0x2a0 [ 840.567341] [] system_call_fastpath+0x1a/0x1f [ 840.567343] INFO: task mnexec:9348 blocked for more than 120 seconds. [ 840.567690] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.568225] mnexec D ffff88003fc14240 0 9348 8358 0x00000000 [ 840.568227] ffff880036de5e20 0000000000000046 ffff880036de5fd8 0000000000014240 [ 840.568229] ffff880036de5fd8 0000000000014240 ffff880036f80000 ffffffff81ccea60 [ 840.568232] ffff880036f80000 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.568242] Call Trace: [ 840.568246] [] schedule_preempt_disabled+0x29/0x70 [ 840.568248] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.568251] [] ? __kmalloc+0x14f/0x180 [ 840.568254] [] mutex_lock+0x1f/0x30 [ 840.568256] [] copy_net_ns+0x65/0x100 [ 840.568259] [] create_new_namespaces+0xf9/0x180 [ 840.568261] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.568263] [] sys_unshare+0x181/0x2a0 [ 840.568266] [] system_call_fastpath+0x1a/0x1f [ 840.568268] INFO: task mnexec:9349 blocked for more than 120 seconds. [ 840.568613] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.569143] mnexec D ffff88003fc14240 0 9349 8358 0x00000000 [ 840.569145] ffff880037253e20 0000000000000046 ffff880037253fd8 0000000000014240 [ 840.569147] ffff880037253fd8 0000000000014240 ffff880036f82ea0 ffffffff81ccea60 [ 840.569149] ffff880036f82ea0 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.569152] Call Trace: [ 840.569155] [] schedule_preempt_disabled+0x29/0x70 [ 840.569157] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.569161] [] ? __kmalloc+0x14f/0x180 [ 840.569163] [] mutex_lock+0x1f/0x30 [ 840.569165] [] copy_net_ns+0x65/0x100 [ 840.569168] [] create_new_namespaces+0xf9/0x180 [ 840.569171] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.569173] [] sys_unshare+0x181/0x2a0 [ 840.569175] [] system_call_fastpath+0x1a/0x1f [ 840.569177] INFO: task mnexec:9350 blocked for more than 120 seconds. [ 840.569529] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.570058] mnexec D ffff88003fc14240 0 9350 8358 0x00000000 [ 840.570060] ffff880036d53e20 0000000000000046 ffff880036d53fd8 0000000000014240 [ 840.570062] ffff880036d53fd8 0000000000014240 ffff880036c85d40 ffffffff81ccea60 [ 840.570064] ffff880036c85d40 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.570066] Call Trace: [ 840.570069] [] schedule_preempt_disabled+0x29/0x70 [ 840.570071] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.570074] [] ? __kmalloc+0x14f/0x180 [ 840.570077] [] mutex_lock+0x1f/0x30 [ 840.570079] [] copy_net_ns+0x65/0x100 [ 840.570081] [] create_new_namespaces+0xf9/0x180 [ 840.570084] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.570086] [] sys_unshare+0x181/0x2a0 [ 840.570088] [] system_call_fastpath+0x1a/0x1f [ 840.570090] INFO: task mnexec:9351 blocked for more than 120 seconds. [ 840.570438] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.570951] mnexec D ffff88003fc14240 0 9351 8358 0x00000000 [ 840.570953] ffff88003d4d9e20 0000000000000046 ffff88003d4d9fd8 0000000000014240 [ 840.570955] ffff88003d4d9fd8 0000000000014240 ffff88003b27aea0 ffffffff81ccea60 [ 840.570957] ffff88003b27aea0 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.570959] Call Trace: [ 840.570962] [] schedule_preempt_disabled+0x29/0x70 [ 840.570964] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.570967] [] ? __kmalloc+0x14f/0x180 [ 840.570970] [] mutex_lock+0x1f/0x30 [ 840.570972] [] copy_net_ns+0x65/0x100 [ 840.570975] [] create_new_namespaces+0xf9/0x180 [ 840.570977] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.570979] [] sys_unshare+0x181/0x2a0 [ 840.570981] [] system_call_fastpath+0x1a/0x1f [ 840.570991] INFO: task mnexec:9352 blocked for more than 120 seconds. [ 840.571338] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 840.571850] mnexec D ffff88003fc14240 0 9352 8358 0x00000000 [ 840.571853] ffff88003c173e20 0000000000000046 ffff88003c173fd8 0000000000014240 [ 840.571855] ffff88003c173fd8 0000000000014240 ffff8800372d1750 ffffffff81ccea60 [ 840.571857] ffff8800372d1750 ffffffff81ccea64 00000000ffffffff ffffffff81ccea68 [ 840.571859] Call Trace: [ 840.571862] [] schedule_preempt_disabled+0x29/0x70 [ 840.571864] [] __mutex_lock_slowpath+0xe7/0x160 [ 840.571867] [] ? __kmalloc+0x14f/0x180 [ 840.571870] [] mutex_lock+0x1f/0x30 [ 840.571872] [] copy_net_ns+0x65/0x100 [ 840.571874] [] create_new_namespaces+0xf9/0x180 [ 840.571877] [] unshare_nsproxy_namespaces+0x61/0xa0 [ 840.571879] [] sys_unshare+0x181/0x2a0 [ 840.571881] [] system_call_fastpath+0x1a/0x1f [ 842.720027] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 852.972039] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 863.212025] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 873.452058] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 883.692028] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 893.944199] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 904.184033] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 914.424026] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 924.664031] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 934.716026] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 944.804046] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 955.044023] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 965.284034] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 975.536035] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 985.776028] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 996.016024] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1006.256028] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1016.508027] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1026.748044] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1036.988059] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1047.228049] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1057.468075] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1067.720038] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1077.960073] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1088.200041] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1098.440034] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1108.456034] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1118.556053] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1128.596029] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1138.836025] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1149.076036] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1159.316025] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1169.556034] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1179.796025] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1190.048028] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1200.288057] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1210.528026] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1220.768029] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1231.020050] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1241.260029] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1251.500056] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1261.740029] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1271.992030] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1282.232069] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1292.472029] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1302.712028] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1312.720031] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1322.972041] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1332.996042] unregister_netdevice: waiting for lo to become free. Usage count = 2 [ 1343.076057] unregister_netdevice: waiting for lo to become free. Usage count = 2