Skip to content

Instantly share code, notes, and snippets.

@jcourtois

jcourtois/00 lvs Secret

Last active August 29, 2015 14:06
Show Gist options
  • Save jcourtois/49358546b9e4bdeb9242 to your computer and use it in GitHub Desktop.
Save jcourtois/49358546b9e4bdeb9242 to your computer and use it in GitHub Desktop.
Download ZIP
lvm freezing up part 2
Raw
00 lvs
root@573972-cinder01_cinder_volumes_container-7454dcdb:~# lvs
LV VG Attr LSize Pool Origin Data% Move Log Copy% Convert
_snapshot-124c8f86-8890-402d-a8c9-4988671ed1bd cinder-volumes -wi-a---- 1.00g
volume-1fbc2275-1221-440f-8f7e-fbbe1cdab46b cinder-volumes -wi-so--- 1.00g
volume-5949fff8-be52-4e0a-b326-e390ad632358 cinder-volumes -wi-so--- 1.00g
volume-7131b1c6-b61e-496b-9139-c36b30a4ca0a cinder-volumes -wi-s---- 1.00g
volume-869dde9b-acec-4149-89eb-2821b9916192 cinder-volumes -wi-s---- 1.00g
volume-cda769a8-a36d-4178-b7df-ce6842ffad60 cinder-volumes -wi-so--- 1.00g
Raw
000 cinder list --all-tenants
root@569037-infra01_utility_container-3f642025:~# cinder list --all-tenants
+--------------------------------------+-----------+-------------------+------+-------------+----------+-------------+
| ID | Status | Display Name | Size | Volume Type | Bootable | Attached to |
+--------------------------------------+-----------+-------------------+------+-------------+----------+-------------+
| 1fbc2275-1221-440f-8f7e-fbbe1cdab46b | deleting | Volume_9ahfZSiKkM | 1 | lvm | false | |
| 5949fff8-be52-4e0a-b326-e390ad632358 | deleting | Volume_cYlqPgTQHW | 1 | lvm | false | |
| 7131b1c6-b61e-496b-9139-c36b30a4ca0a | available | Volume_hRJrCX3Pl5 | 1 | lvm | false | |
| 869dde9b-acec-4149-89eb-2821b9916192 | available | Volume_09x3gJi18m | 1 | lvm | false | |
| cda769a8-a36d-4178-b7df-ce6842ffad60 | deleting | Volume_i8hy23oPLV | 1 | lvm | false | |
+--------------------------------------+-----------+-------------------+------+-------------+----------+-------------+
Raw
0000 cinder snapshot-list
root@569037-infra01_utility_container-3f642025:~# cinder snapshot-list --all-tenants
+--------------------------------------+--------------------------------------+----------------+---------------------+------+
| ID | Volume ID | Status | Display Name | Size |
+--------------------------------------+--------------------------------------+----------------+---------------------+------+
| 124c8f86-8890-402d-a8c9-4988671ed1bd | 7131b1c6-b61e-496b-9139-c36b30a4ca0a | error_deleting | Snapshot_S2ZVmkqor4 | 1 |
+--------------------------------------+--------------------------------------+----------------+---------------------+------+
Raw
0000 locked processes
root 18208 0.0 0.0 62100 2004 ? S Sep21 0:00 sudo cinder-rootwrap /etc/cinder/rootwrap.conf dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--5949fff8--be52--4e0a--b326--e390ad632358 cou
root 18209 0.0 0.0 39240 9356 ? S Sep21 0:00 \_ /usr/bin/python /usr/local/bin/cinder-rootwrap /etc/cinder/rootwrap.conf dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--5949fff8--be52
root 18210 0.0 0.0 5408 1404 ? D Sep21 0:00 \_ /bin/dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--5949fff8--be52--4e0a--b326--e390ad632358 count=1024 bs=1M conv=fdatasync
root 18341 0.0 0.0 62100 2004 ? S Sep21 0:00 sudo cinder-rootwrap /etc/cinder/rootwrap.conf dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--cda769a8--a36d--4178--b7df--ce6842ffad60 cou
root 18342 0.0 0.0 39240 9352 ? S Sep21 0:00 \_ /usr/bin/python /usr/local/bin/cinder-rootwrap /etc/cinder/rootwrap.conf dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--cda769a8--a36d
root 18343 0.0 0.0 5408 1404 ? D Sep21 0:00 \_ /bin/dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--cda769a8--a36d--4178--b7df--ce6842ffad60 count=1024 bs=1M conv=fdatasync
root 18507 0.0 0.0 62100 2004 ? S Sep21 0:00 sudo cinder-rootwrap /etc/cinder/rootwrap.conf dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--1fbc2275--1221--440f--8f7e--fbbe1cdab46b cou
root 18508 0.0 0.0 39240 9352 ? S Sep21 0:00 \_ /usr/bin/python /usr/local/bin/cinder-rootwrap /etc/cinder/rootwrap.conf dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--1fbc2275--1221
root 18509 0.0 0.0 5408 1408 ? D Sep21 0:00 \_ /bin/dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--1fbc2275--1221--440f--8f7e--fbbe1cdab46b count=1024 bs=1M conv=fdatasync
cinder 27945 2.3 0.1 121908 50456 ? Ss 17:19 0:01 /usr/bin/python /usr/local/bin/cinder-volume --log-file=/var/log/cinder/cinder-volume.log
cinder 27951 0.6 0.2 228892 65540 ? S 17:19 0:00 \_ /usr/bin/python /usr/local/bin/cinder-volume --log-file=/var/log/cinder/cinder-volume.log
root 27971 0.0 0.0 62100 2008 ? S 17:19 0:00 \_ sudo cinder-rootwrap /etc/cinder/rootwrap.conf dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--1fbc2275--1221--440f--8f7e--fbbe1cda
root 27972 0.0 0.0 39240 9356 ? S 17:19 0:00 \_ /usr/bin/python /usr/local/bin/cinder-rootwrap /etc/cinder/rootwrap.conf dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--1fbc22
root 27973 0.6 0.0 5408 1408 ? D 17:19 0:00 \_ /bin/dd if=/dev/zero of=/dev/mapper/cinder--volumes-volume--1fbc2275--1221--440f--8f7e--fbbe1cdab46b count=1024 bs=1M conv=fdatasy
Raw
00000 kernel logs from host showing locked dd process
root@569058-cinder01:/var/log# sed -n 126,214p kern.log.1
Sep 18 22:11:50 569058-cinder01 kernel: [608059.553806] IPv6: ADDRCONF(NETDEV_CHANGE): veth7V8NXC: link becomes ready
Sep 18 22:11:50 569058-cinder01 kernel: [608059.553893] IPv6: ADDRCONF(NETDEV_CHANGE): vethE0R2M0: link becomes ready
Sep 20 13:59:19 569058-cinder01 kernel: [751446.541687] bio: create slab <bio-1> at 1
Sep 21 00:10:55 569058-cinder01 kernel: [788177.232162] bio: create slab <bio-1> at 1
Sep 21 01:25:12 569058-cinder01 kernel: [792638.890639] Not tainted 3.13.0-34-generic #60-Ubuntu
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950796] ffff8807e0ddfd58 0000000000000002 ffff8806b75f47d0 ffff8807e0ddffd8
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950801] ffff88082ffb87e8 0000000000000002 ffffffff8114e180 ffff8807e0ddfdd0
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950810] [<ffffffff8114e180>] ? wait_on_page_read+0x60/0x60
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950822] [<ffffffff817204dd>] io_schedule+0x9d/0x140
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950824] [<ffffffff8114e18e>] sleep_on_page+0xe/0x20
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950826] [<ffffffff81720962>] __wait_on_bit+0x62/0x90
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950828] [<ffffffff8114df4f>] wait_on_page_bit+0x7f/0x90
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950832] [<ffffffff810aaf40>] ? autoremove_wake_function+0x40/0x40
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950834] [<ffffffff8114e059>] filemap_fdatawait_range+0xf9/0x190
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950841] [<ffffffff8114f8ff>] filemap_write_and_wait_range+0x3f/0x70
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950856] [<ffffffff811f56fb>] blkdev_fsync+0x1b/0x50
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950859] [<ffffffff811ec871>] do_fsync+0x51/0x80
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950861] [<ffffffff811ecb23>] SyS_fdatasync+0x13/0x20
Sep 21 01:25:12 569058-cinder01 kernel: [792638.950868] [<ffffffff8172c97f>] tracesys+0xe1/0xe6
Sep 21 01:27:13 569058-cinder01 kernel: [792759.162517] ffff8807e0ddfd58 0000000000000002 ffff8806b75f47d0 ffff8807e0ddffd8
Sep 21 01:27:13 569058-cinder01 kernel: [792759.162524] Call Trace:
Sep 21 01:29:13 569058-cinder01 kernel: [792879.274242] INFO: task dd:22264 blocked for more than 120 seconds.
Sep 21 01:29:13 569058-cinder01 kernel: [792879.333561] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Sep 21 01:29:13 569058-cinder01 kernel: [792879.398151] dd D ffff88080f114440 0 22264 22263 0x00000100
Sep 21 01:29:13 569058-cinder01 kernel: [792879.398159] ffff88082ffb87e8 0000000000000002 ffffffff8114e180 ffff8807e0ddfdd0
Sep 21 01:29:13 569058-cinder01 kernel: [792879.398183] [<ffffffff817204dd>] io_schedule+0x9d/0x140
Sep 21 01:29:13 569058-cinder01 kernel: [792879.398197] [<ffffffff81720962>] __wait_on_bit+0x62/0x90
Sep 21 01:29:13 569058-cinder01 kernel: [792879.398203] [<ffffffff810aaf40>] ? autoremove_wake_function+0x40/0x40
Sep 21 01:29:13 569058-cinder01 kernel: [792879.398209] [<ffffffff8114f8ff>] filemap_write_and_wait_range+0x3f/0x70
Sep 21 01:29:13 569058-cinder01 kernel: [792879.398220] [<ffffffff811ec871>] do_fsync+0x51/0x80
Sep 21 01:29:13 569058-cinder01 kernel: [792879.398239] INFO: task dd:22541 blocked for more than 120 seconds.
Sep 21 01:29:13 569058-cinder01 kernel: [792879.470048] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Sep 21 01:29:13 569058-cinder01 kernel: [792879.547029] dd D ffff88080f094440 0 22541 22540 0x00000100
Sep 21 01:29:13 569058-cinder01 kernel: [792879.547031] ffff8807a6e4fd58 0000000000000002 ffff8807f6530000 ffff8807a6e4ffd8
Sep 21 01:29:13 569058-cinder01 kernel: [792879.547035] ffff88082ffc32e8 0000000000000002 ffffffff8114e180 ffff8807a6e4fdd0
Sep 21 01:29:13 569058-cinder01 kernel: [792879.547053] [<ffffffff817204dd>] io_schedule+0x9d/0x140
Sep 21 01:29:13 569058-cinder01 kernel: [792879.547060] [<ffffffff8114df4f>] wait_on_page_bit+0x7f/0x90
Sep 21 01:29:13 569058-cinder01 kernel: [792879.547080] [<ffffffff8114f8ff>] filemap_write_and_wait_range+0x3f/0x70
Sep 21 01:29:13 569058-cinder01 kernel: [792879.547082] [<ffffffff811f56fb>] blkdev_fsync+0x1b/0x50
Sep 21 01:29:13 569058-cinder01 kernel: [792879.547084] [<ffffffff811ec871>] do_fsync+0x51/0x80
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661400] ffff88082ffb87e8 0000000000000002 ffffffff8114e180 ffff8807e0ddfdd0
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661406] [<ffffffff8114e180>] ? wait_on_page_read+0x60/0x60
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661413] [<ffffffff8114e18e>] sleep_on_page+0xe/0x20
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661416] [<ffffffff8114df4f>] wait_on_page_bit+0x7f/0x90
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661421] [<ffffffff8114e059>] filemap_fdatawait_range+0xf9/0x190
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661423] [<ffffffff8114f8ff>] filemap_write_and_wait_range+0x3f/0x70
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661426] [<ffffffff811f56fb>] blkdev_fsync+0x1b/0x50
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661428] [<ffffffff811ec871>] do_fsync+0x51/0x80
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661430] [<ffffffff811ecb23>] SyS_fdatasync+0x13/0x20
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661441] ffff88082ffc32e8 0000000000000002 ffffffff8114e180 ffff8807a6e4fdd0
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661445] [<ffffffff817204dd>] io_schedule+0x9d/0x140
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661450] [<ffffffff8114df4f>] wait_on_page_bit+0x7f/0x90
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661455] [<ffffffff8114f8ff>] filemap_write_and_wait_range+0x3f/0x70
Sep 21 01:31:13 569058-cinder01 kernel: [792999.661459] [<ffffffff811ecb23>] SyS_fdatasync+0x13/0x20
Sep 21 01:33:13 569058-cinder01 kernel: [793119.824314] Not tainted 3.13.0-34-generic #60-Ubuntu
Sep 21 01:33:13 569058-cinder01 kernel: [793119.974616] ffff8807e0ddfd58 0000000000000002 ffff8806b75f47d0 ffff8807e0ddffd8
Sep 21 01:33:13 569058-cinder01 kernel: [793119.974634] Call Trace:
Sep 21 01:33:13 569058-cinder01 kernel: [793119.974647] [<ffffffff8114e18e>] sleep_on_page+0xe/0x20
Sep 21 01:33:13 569058-cinder01 kernel: [793119.974659] [<ffffffff81720962>] __wait_on_bit+0x62/0x90
Sep 21 01:33:13 569058-cinder01 kernel: [793119.974661] [<ffffffff8114df4f>] wait_on_page_bit+0x7f/0x90
Sep 21 01:33:13 569058-cinder01 kernel: [793119.974665] [<ffffffff810aaf40>] ? autoremove_wake_function+0x40/0x40
Sep 21 01:33:13 569058-cinder01 kernel: [793119.974671] [<ffffffff8114f8ff>] filemap_write_and_wait_range+0x3f/0x70
Sep 21 01:33:13 569058-cinder01 kernel: [793119.974678] [<ffffffff811f56fb>] blkdev_fsync+0x1b/0x50
Sep 21 01:33:13 569058-cinder01 kernel: [793119.974696] [<ffffffff811ecb23>] SyS_fdatasync+0x13/0x20
Sep 21 01:33:13 569058-cinder01 kernel: [793120.027069] Not tainted 3.13.0-34-generic #60-Ubuntu
Sep 21 01:33:13 569058-cinder01 kernel: [793120.182457] ffff8807a6e4fd58 0000000000000002 ffff8807f6530000 ffff8807a6e4ffd8
Sep 21 01:33:13 569058-cinder01 kernel: [793120.182474] Call Trace:
Sep 21 01:33:13 569058-cinder01 kernel: [793120.182482] [<ffffffff8114e18e>] sleep_on_page+0xe/0x20
Sep 21 01:33:13 569058-cinder01 kernel: [793120.182488] [<ffffffff810aaf40>] ? autoremove_wake_function+0x40/0x40
Sep 21 01:33:13 569058-cinder01 kernel: [793120.182502] [<ffffffff8114e059>] filemap_fdatawait_range+0xf9/0x190
Sep 21 01:33:13 569058-cinder01 kernel: [793120.182505] [<ffffffff8114f8ff>] filemap_write_and_wait_range+0x3f/0x70
Sep 21 01:33:13 569058-cinder01 kernel: [793120.182509] [<ffffffff811ec871>] do_fsync+0x51/0x80
Sep 21 01:35:13 569058-cinder01 kernel: [793240.347749] Not tainted 3.13.0-34-generic #60-Ubuntu
Sep 21 01:35:13 569058-cinder01 kernel: [793240.503140] ffff8807e0ddfd58 0000000000000002 ffff8806b75f47d0 ffff8807e0ddffd8
Sep 21 01:35:13 569058-cinder01 kernel: [793240.503158] Call Trace:
Sep 21 01:35:13 569058-cinder01 kernel: [793240.503181] [<ffffffff8114e18e>] sleep_on_page+0xe/0x20
Sep 21 01:35:13 569058-cinder01 kernel: [793240.503183] [<ffffffff81720962>] __wait_on_bit+0x62/0x90
Sep 21 01:35:13 569058-cinder01 kernel: [793240.503185] [<ffffffff8114df4f>] wait_on_page_bit+0x7f/0x90
Sep 21 01:35:13 569058-cinder01 kernel: [793240.503192] [<ffffffff8114e059>] filemap_fdatawait_range+0xf9/0x190
Sep 21 01:35:13 569058-cinder01 kernel: [793240.503199] [<ffffffff8114f8ff>] filemap_write_and_wait_range+0x3f/0x70
Sep 21 01:35:13 569058-cinder01 kernel: [793240.503220] [<ffffffff811ec871>] do_fsync+0x51/0x80
Sep 21 01:35:13 569058-cinder01 kernel: [793240.503233] INFO: task dd:22541 blocked for more than 120 seconds.
Sep 21 01:35:14 569058-cinder01 kernel: [793240.710861] ffff8807a6e4fd58 0000000000000002 ffff8807f6530000 ffff8807a6e4ffd8
Sep 21 01:35:14 569058-cinder01 kernel: [793240.710868] Call Trace:
Sep 21 01:35:14 569058-cinder01 kernel: [793240.710887] [<ffffffff8114e18e>] sleep_on_page+0xe/0x20
Sep 21 01:35:14 569058-cinder01 kernel: [793240.710893] [<ffffffff810aaf40>] ? autoremove_wake_function+0x40/0x40
Sep 21 01:35:14 569058-cinder01 kernel: [793240.710911] [<ffffffff8114f8ff>] filemap_write_and_wait_range+0x3f/0x70
Sep 21 01:35:14 569058-cinder01 kernel: [793240.710913] [<ffffffff811f56fb>] blkdev_fsync+0x1b/0x50
Sep 21 01:35:14 569058-cinder01 kernel: [793240.710915] [<ffffffff811ec871>] do_fsync+0x51/0x80
Raw
0_ stack trace from cinder-volumes
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Traceback (most recent call last):
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/rpc/dispatcher.py", line 134, in _dispatch_and_reply
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher incoming.message))
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/rpc/dispatcher.py", line 177, in _dispatch
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher return self._do_dispatch(endpoint, method, ctxt, args)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/rpc/dispatcher.py", line 123, in _do_dispatch
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher result = getattr(endpoint, method)(ctxt, **new_args)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/manager.py", line 166, in lso_inner1
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher return lso_inner2(inst, context, snapshot_id, **kwargs)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/openstack/common/lockutils.py", line 233, in inner
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher retval = f(*args, **kwargs)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/manager.py", line 165, in lso_inner2
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher return f(*_args, **_kwargs)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/manager.py", line 542, in delete_snapshot
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher {'status': 'error_deleting'})
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/openstack/common/excutils.py", line 68, in __exit__
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher six.reraise(self.type_, self.value, self.tb)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/manager.py", line 530, in delete_snapshot
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher self.driver.delete_snapshot(snapshot_ref)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/drivers/lvm.py", line 252, in delete_snapshot
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher self._delete_volume(snapshot, is_snapshot=True)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/drivers/lvm.py", line 133, in _delete_volume
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher self.vg.delete(name)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/brick/local_dev/lvm.py", line 599, in delete
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher root_helper=self._root_helper, run_as_root=True)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/utils.py", line 136, in execute
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher return processutils.execute(*cmd, **kwargs)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/openstack/common/processutils.py", line 173, in execute
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher cmd=' '.join(cmd))
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher ProcessExecutionError: Unexpected error while running command.
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Command: sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvremove --config activation { retry_deactivation = 1} devices { ignore_suspended_devices = 1} -f cinder-volumes/_snapshot-124c8f86-8890-402d-a8c9-4988671ed1bd
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Exit code: 5
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Stdout: ''
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Stderr: ' device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n Unable to deactivate cinder--volumes-_snapshot--124c8f86--8890--402d--a8c9--4988671ed1bd (252:4)\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n Unable to deactivate cinder--volumes-_snapshot--124c8f86--8890--402d--a8c9--4988671ed1bd-cow (252:6)\n Unable to deactivate logical volume "_snapshot-124c8f86-8890-402d-a8c9-4988671ed1bd"\n'
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher
Raw
1_ more complete except from cinder-volume.log
2014-09-20 20:24:04.452 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 20:24:04.474 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 20:24:04.490 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 20:24:04.509 890 INFO cinder.volume.manager [req-90ef3382-822e-4a59-90bc-f5078ea03b2e 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 9c3a1c0d-29bc-4c5c-8b44-50ff4df56e61: deleting
2014-09-20 20:24:04.521 890 INFO cinder.volume.manager [req-37da269e-8124-4b64-9b08-f8242714a8bb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume eeaa0fdb-ac7d-4cf5-9490-7b82e801641d: deleting
2014-09-20 20:24:04.531 890 INFO cinder.volume.manager [req-69bb0307-7aff-4abc-b26a-57541aa7da00 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 73584646-91f4-4651-b3a6-f46ee352fe50: deleting
2014-09-20 20:24:05.082 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 20:24:05.257 890 INFO cinder.brick.iscsi.iscsi [req-f025becb-bf93-48c4-8acb-a19ed88ba310 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Removing iscsi_target for: a8f54f91-ecb7-4886-9146-1754c96e0ef2
2014-09-20 20:24:05.264 890 INFO cinder.volume.iscsi [req-a9ecb84e-e13c-4335-9976-ce098e9ac2fa 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 7c043506-d8ef-4d58-854f-1a37f28f65a4
2014-09-20 20:24:05.269 890 INFO cinder.volume.iscsi [req-90ef3382-822e-4a59-90bc-f5078ea03b2e 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 9c3a1c0d-29bc-4c5c-8b44-50ff4df56e61
2014-09-20 20:24:05.457 890 INFO cinder.volume.manager [req-bedc0800-e8a1-4e09-9d1e-f8c4722bbe24 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 425474e9-599f-43dc-ae65-951fb8de74eb: deleted successfully
2014-09-20 20:24:05.476 890 INFO cinder.volume.manager [req-bedc0800-e8a1-4e09-9d1e-f8c4722bbe24 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-20 20:24:06.315 890 INFO cinder.brick.iscsi.iscsi [req-56f226d2-4e82-4395-af64-93bc74ced056 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Removing iscsi_target for: bc5bed98-1546-464b-af81-2c9204c94454
2014-09-20 20:24:06.323 890 INFO cinder.volume.iscsi [req-69bb0307-7aff-4abc-b26a-57541aa7da00 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 73584646-91f4-4651-b3a6-f46ee352fe50
2014-09-20 20:24:06.336 890 INFO cinder.volume.iscsi [req-37da269e-8124-4b64-9b08-f8242714a8bb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: eeaa0fdb-ac7d-4cf5-9490-7b82e801641d
2014-09-20 20:24:06.482 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 20:24:06.610 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 20:24:06.705 890 INFO cinder.volume.utils [req-696fec8f-7edc-4102-b904-57785db2030e 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--5cfc961c--a88c--452d--8531--0570b07dbc58
2014-09-20 20:24:06.719 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 20:24:06.745 890 INFO cinder.volume.manager [req-41fbf14c-c028-43f0-9029-4825f6804e48 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume a8f54f91-ecb7-4886-9146-1754c96e0ef2: deleting
2014-09-20 20:24:06.840 890 INFO cinder.volume.iscsi [req-41fbf14c-c028-43f0-9029-4825f6804e48 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: a8f54f91-ecb7-4886-9146-1754c96e0ef2
2014-09-20 20:24:06.848 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 20:24:06.871 890 INFO cinder.volume.manager [req-c1fc6365-c664-45d3-b375-f64285a208e3 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume bc5bed98-1546-464b-af81-2c9204c94454: deleting
2014-09-20 20:24:06.964 890 INFO cinder.volume.iscsi [req-c1fc6365-c664-45d3-b375-f64285a208e3 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: bc5bed98-1546-464b-af81-2c9204c94454
2014-09-20 20:24:07.051 890 INFO cinder.volume.utils [req-a9ecb84e-e13c-4335-9976-ce098e9ac2fa 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--7c043506--d8ef--4d58--854f--1a37f28f65a4
2014-09-20 20:24:07.057 890 INFO cinder.volume.utils [req-90ef3382-822e-4a59-90bc-f5078ea03b2e 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--9c3a1c0d--29bc--4c5c--8b44--50ff4df56e61
2014-09-20 20:24:07.264 890 INFO cinder.volume.utils [req-37da269e-8124-4b64-9b08-f8242714a8bb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--eeaa0fdb--ac7d--4cf5--9490--7b82e801641d
2014-09-20 20:24:07.277 890 INFO cinder.volume.utils [req-69bb0307-7aff-4abc-b26a-57541aa7da00 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--73584646--91f4--4651--b3a6--f46ee352fe50
2014-09-20 20:24:09.804 890 INFO cinder.volume.utils [req-41fbf14c-c028-43f0-9029-4825f6804e48 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--a8f54f91--ecb7--4886--9146--1754c96e0ef2
2014-09-20 20:24:09.811 890 INFO cinder.volume.utils [req-c1fc6365-c664-45d3-b375-f64285a208e3 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--bc5bed98--1546--464b--af81--2c9204c94454
2014-09-20 20:24:15.845 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:25:15.845 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:26:15.845 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:27:15.845 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:28:15.846 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:29:15.854 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:30:15.862 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:31:15.874 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:32:15.879 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:33:15.886 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:34:15.896 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:35:15.902 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:36:15.910 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:37:13.007 890 INFO cinder.volume.manager [req-75054048-95e7-43d0-a39f-9a4c947e8911 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 85a890f8-9e25-4875-b156-c049db5fcfb5: deleted successfully
2014-09-20 20:37:13.021 890 INFO cinder.volume.manager [req-75054048-95e7-43d0-a39f-9a4c947e8911 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-20 20:37:15.913 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:38:15.922 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:39:15.930 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:40:15.939 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:41:15.949 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:42:15.959 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:43:15.967 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:44:15.976 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:45:15.986 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:46:15.995 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:47:16.004 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:48:16.012 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:49:16.021 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:49:20.034 890 INFO cinder.volume.manager [req-a9ecb84e-e13c-4335-9976-ce098e9ac2fa 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 7c043506-d8ef-4d58-854f-1a37f28f65a4: deleted successfully
2014-09-20 20:49:20.048 890 INFO cinder.volume.manager [req-a9ecb84e-e13c-4335-9976-ce098e9ac2fa 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 20:50:15.725 890 INFO cinder.volume.manager [req-41fbf14c-c028-43f0-9029-4825f6804e48 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume a8f54f91-ecb7-4886-9146-1754c96e0ef2: deleted successfully
2014-09-20 20:50:15.739 890 INFO cinder.volume.manager [req-41fbf14c-c028-43f0-9029-4825f6804e48 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 20:50:16.022 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:50:19.537 890 INFO cinder.volume.manager [req-69bb0307-7aff-4abc-b26a-57541aa7da00 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 73584646-91f4-4651-b3a6-f46ee352fe50: deleted successfully
2014-09-20 20:50:19.552 890 INFO cinder.volume.manager [req-69bb0307-7aff-4abc-b26a-57541aa7da00 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 20:50:25.008 890 INFO cinder.volume.manager [req-90ef3382-822e-4a59-90bc-f5078ea03b2e 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 9c3a1c0d-29bc-4c5c-8b44-50ff4df56e61: deleted successfully
2014-09-20 20:50:25.021 890 INFO cinder.volume.manager [req-90ef3382-822e-4a59-90bc-f5078ea03b2e 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 20:50:29.937 890 INFO cinder.volume.manager [req-37da269e-8124-4b64-9b08-f8242714a8bb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume eeaa0fdb-ac7d-4cf5-9490-7b82e801641d: deleted successfully
2014-09-20 20:50:29.950 890 INFO cinder.volume.manager [req-37da269e-8124-4b64-9b08-f8242714a8bb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 20:50:34.713 890 INFO cinder.volume.manager [req-c1fc6365-c664-45d3-b375-f64285a208e3 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume bc5bed98-1546-464b-af81-2c9204c94454: deleted successfully
2014-09-20 20:50:34.727 890 INFO cinder.volume.manager [req-c1fc6365-c664-45d3-b375-f64285a208e3 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 20:50:35.803 890 INFO cinder.volume.manager [req-696fec8f-7edc-4102-b904-57785db2030e 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 5cfc961c-a88c-452d-8531-0570b07dbc58: deleted successfully
2014-09-20 20:50:35.816 890 INFO cinder.volume.manager [req-696fec8f-7edc-4102-b904-57785db2030e 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 20:51:16.029 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:52:16.038 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:53:16.047 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:54:16.056 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:55:16.065 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:56:16.073 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:57:16.083 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:58:16.092 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 20:59:16.100 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:00:16.110 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:01:16.118 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:02:16.126 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:03:16.135 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:04:16.144 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:05:16.152 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:06:16.160 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:07:16.166 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:08:16.174 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:09:16.183 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:10:16.191 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:11:16.198 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:12:16.206 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:13:16.215 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:14:16.223 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:15:16.230 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:16:16.239 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:17:16.247 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:18:16.255 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:19:16.262 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:20:16.271 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:21:16.278 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:22:16.285 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:22:17.319 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:22:17.382 890 INFO cinder.volume.flows.manager.create_volume [req-fe4b4fd1-ac6e-474b-ba32-2b81ea96720d ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 991ed3e9-1523-40dc-af2e-cd1612c2bc85: being created using CreateVolumeFromSpecTask._create_from_image with specification: {'status': u'creating', 'image_location': (None, None), 'volume_size': 100, 'volume_name': u'volume-991ed3e9-1523-40dc-af2e-cd1612c2bc85', 'image_id': u'8550cab6-0235-4174-abab-2b20f152462c', 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f83f43e1f90>, 'image_meta': {'status': u'active', 'name': u'cirros', 'deleted': False, 'container_format': u'bare', 'created_at': datetime.datetime(2014, 9, 19, 20, 42, 46, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f4324e10>), 'disk_format': u'raw', 'updated_at': datetime.datetime(2014, 9, 19, 20, 42, 48, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f4324e10>), 'id': u'8550cab6-0235-4174-abab-2b20f152462c', 'owner': u'14ec5d3ea7614a23b98edf77e08c5dfc', 'min_ram': 0, 'checksum': u'133eae9fb1c98f45894a4e60d8736619', 'min_disk': 0, 'is_public': True, 'deleted_at': None, 'properties': {}, 'size': 13200896}}
2014-09-20 21:22:20.478 890 INFO cinder.volume.flows.manager.create_volume [req-fe4b4fd1-ac6e-474b-ba32-2b81ea96720d ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-991ed3e9-1523-40dc-af2e-cd1612c2bc85 (991ed3e9-1523-40dc-af2e-cd1612c2bc85): created successfully
2014-09-20 21:22:22.315 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:22:22.334 890 INFO cinder.brick.iscsi.iscsi [req-bf64073f-5274-441e-baeb-ff057c0b701c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-991ed3e9-1523-40dc-af2e-cd1612c2bc85
2014-09-20 21:22:23.240 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:23:14.252 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:23:14.313 890 INFO cinder.volume.flows.manager.create_volume [req-cf1a76ba-3227-492b-8a6b-52ca5ca1a8d2 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 8ddd6fe0-1298-4b6b-9cef-ffa5ffd56412: being created using CreateVolumeFromSpecTask._create_from_image with specification: {'status': u'creating', 'image_location': (None, None), 'volume_size': 100, 'volume_name': u'volume-8ddd6fe0-1298-4b6b-9cef-ffa5ffd56412', 'image_id': u'8550cab6-0235-4174-abab-2b20f152462c', 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f83f459f3d0>, 'image_meta': {'status': u'active', 'name': u'cirros', 'deleted': False, 'container_format': u'bare', 'created_at': datetime.datetime(2014, 9, 19, 20, 42, 46, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f4041f50>), 'disk_format': u'raw', 'updated_at': datetime.datetime(2014, 9, 19, 20, 42, 48, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f4041f50>), 'id': u'8550cab6-0235-4174-abab-2b20f152462c', 'owner': u'14ec5d3ea7614a23b98edf77e08c5dfc', 'min_ram': 0, 'checksum': u'133eae9fb1c98f45894a4e60d8736619', 'min_disk': 0, 'is_public': True, 'deleted_at': None, 'properties': {}, 'size': 13200896}}
2014-09-20 21:23:16.285 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:23:16.903 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:23:17.052 890 INFO cinder.brick.iscsi.iscsi [req-9ca746f9-945e-403b-a760-82bcbf1f64a3 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Removing iscsi_target for: 991ed3e9-1523-40dc-af2e-cd1612c2bc85
2014-09-20 21:23:17.083 890 INFO cinder.volume.flows.manager.create_volume [req-cf1a76ba-3227-492b-8a6b-52ca5ca1a8d2 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-8ddd6fe0-1298-4b6b-9cef-ffa5ffd56412 (8ddd6fe0-1298-4b6b-9cef-ffa5ffd56412): created successfully
2014-09-20 21:23:17.281 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:23:17.463 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:23:17.481 890 INFO cinder.volume.manager [req-1660936f-ba8b-4bc8-b131-f92e4f6bfcbc ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 991ed3e9-1523-40dc-af2e-cd1612c2bc85: deleting
2014-09-20 21:23:18.334 890 INFO cinder.volume.iscsi [req-1660936f-ba8b-4bc8-b131-f92e4f6bfcbc ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 991ed3e9-1523-40dc-af2e-cd1612c2bc85
2014-09-20 21:23:19.091 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:23:19.110 890 INFO cinder.brick.iscsi.iscsi [req-0d9e74bb-e82f-4df0-a910-6a415153c3b3 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-8ddd6fe0-1298-4b6b-9cef-ffa5ffd56412
2014-09-20 21:23:19.390 890 INFO cinder.volume.utils [req-1660936f-ba8b-4bc8-b131-f92e4f6bfcbc ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--991ed3e9--1523--40dc--af2e--cd1612c2bc85
2014-09-20 21:23:19.958 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:24:16.294 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:25:16.303 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:26:16.308 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:26:22.047 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:26:25.023 890 INFO cinder.brick.iscsi.iscsi [req-8ba63cc0-f76f-482e-a7b1-a6034170eb60 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Removing iscsi_target for: 8ddd6fe0-1298-4b6b-9cef-ffa5ffd56412
2014-09-20 21:26:25.582 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:26:25.755 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:26:25.774 890 INFO cinder.volume.manager [req-5ca84db4-5f94-48d8-8fdc-6560475c1413 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 8ddd6fe0-1298-4b6b-9cef-ffa5ffd56412: deleting
2014-09-20 21:26:25.859 890 INFO cinder.volume.iscsi [req-5ca84db4-5f94-48d8-8fdc-6560475c1413 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 8ddd6fe0-1298-4b6b-9cef-ffa5ffd56412
2014-09-20 21:26:25.984 890 INFO cinder.volume.utils [req-5ca84db4-5f94-48d8-8fdc-6560475c1413 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--8ddd6fe0--1298--4b6b--9cef--ffa5ffd56412
2014-09-20 21:26:40.339 890 INFO cinder.volume.manager [req-1660936f-ba8b-4bc8-b131-f92e4f6bfcbc ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 991ed3e9-1523-40dc-af2e-cd1612c2bc85: deleted successfully
2014-09-20 21:26:40.356 890 INFO cinder.volume.manager [req-1660936f-ba8b-4bc8-b131-f92e4f6bfcbc ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-20 21:27:16.315 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:28:16.322 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:29:16.326 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:29:37.586 890 INFO cinder.volume.manager [req-5ca84db4-5f94-48d8-8fdc-6560475c1413 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 8ddd6fe0-1298-4b6b-9cef-ffa5ffd56412: deleted successfully
2014-09-20 21:29:37.599 890 INFO cinder.volume.manager [req-5ca84db4-5f94-48d8-8fdc-6560475c1413 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-20 21:30:16.333 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:31:16.340 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:32:16.347 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:33:16.347 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:34:16.354 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:35:16.361 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:36:16.362 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:37:16.368 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:38:16.375 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:39:16.383 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:40:16.390 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:41:16.397 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:42:16.404 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:43:16.411 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:44:16.418 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:45:16.425 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:46:16.432 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:47:16.438 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:48:16.444 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:49:16.451 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:50:16.457 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:51:16.463 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:52:16.470 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:53:16.476 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:54:16.481 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:55:16.489 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:56:16.494 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:56:30.344 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:56:30.407 890 INFO cinder.volume.flows.manager.create_volume [req-d5a757d7-0188-4b04-aa9b-03366e543cf7 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 3a387809-e77e-4bf1-bd1e-cae7c4ee1e5b: being created using CreateVolumeFromSpecTask._create_from_image with specification: {'status': u'creating', 'image_location': (None, None), 'volume_size': 100, 'volume_name': u'volume-3a387809-e77e-4bf1-bd1e-cae7c4ee1e5b', 'image_id': u'8550cab6-0235-4174-abab-2b20f152462c', 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f83f403b590>, 'image_meta': {'status': u'active', 'name': u'cirros', 'deleted': False, 'container_format': u'bare', 'created_at': datetime.datetime(2014, 9, 19, 20, 42, 46, tzinfo=<iso8601.iso8601.Utc object at 0x7f83efff00d0>), 'disk_format': u'raw', 'updated_at': datetime.datetime(2014, 9, 19, 20, 42, 48, tzinfo=<iso8601.iso8601.Utc object at 0x7f83efff00d0>), 'id': u'8550cab6-0235-4174-abab-2b20f152462c', 'owner': u'14ec5d3ea7614a23b98edf77e08c5dfc', 'min_ram': 0, 'checksum': u'133eae9fb1c98f45894a4e60d8736619', 'min_disk': 0, 'is_public': True, 'deleted_at': None, 'properties': {}, 'size': 13200896}}
2014-09-20 21:56:33.116 890 INFO cinder.volume.flows.manager.create_volume [req-d5a757d7-0188-4b04-aa9b-03366e543cf7 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-3a387809-e77e-4bf1-bd1e-cae7c4ee1e5b (3a387809-e77e-4bf1-bd1e-cae7c4ee1e5b): created successfully
2014-09-20 21:56:34.991 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:56:35.009 890 INFO cinder.brick.iscsi.iscsi [req-4655f3a0-266c-432e-96a5-c9f80bab7a23 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-3a387809-e77e-4bf1-bd1e-cae7c4ee1e5b
2014-09-20 21:56:35.760 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:57:06.185 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:57:06.252 890 INFO cinder.volume.flows.manager.create_volume [req-aa880f64-7bf9-4d0f-8472-5224efc4c792 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume b57dcfc1-d8c6-4f2b-8c35-06bc8af83469: being created using CreateVolumeFromSpecTask._create_from_image with specification: {'status': u'creating', 'image_location': (None, None), 'volume_size': 100, 'volume_name': u'volume-b57dcfc1-d8c6-4f2b-8c35-06bc8af83469', 'image_id': u'8550cab6-0235-4174-abab-2b20f152462c', 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f83f42f4ad0>, 'image_meta': {'status': u'active', 'name': u'cirros', 'deleted': False, 'container_format': u'bare', 'created_at': datetime.datetime(2014, 9, 19, 20, 42, 46, tzinfo=<iso8601.iso8601.Utc object at 0x7f83effb3950>), 'disk_format': u'raw', 'updated_at': datetime.datetime(2014, 9, 19, 20, 42, 48, tzinfo=<iso8601.iso8601.Utc object at 0x7f83effb3950>), 'id': u'8550cab6-0235-4174-abab-2b20f152462c', 'owner': u'14ec5d3ea7614a23b98edf77e08c5dfc', 'min_ram': 0, 'checksum': u'133eae9fb1c98f45894a4e60d8736619', 'min_disk': 0, 'is_public': True, 'deleted_at': None, 'properties': {}, 'size': 13200896}}
2014-09-20 21:57:08.698 890 INFO cinder.volume.flows.manager.create_volume [req-aa880f64-7bf9-4d0f-8472-5224efc4c792 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-b57dcfc1-d8c6-4f2b-8c35-06bc8af83469 (b57dcfc1-d8c6-4f2b-8c35-06bc8af83469): created successfully
2014-09-20 21:57:10.650 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:57:10.666 890 INFO cinder.brick.iscsi.iscsi [req-08de4c11-ac1b-426f-9da6-9746deb659ed ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-b57dcfc1-d8c6-4f2b-8c35-06bc8af83469
2014-09-20 21:57:11.579 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 21:57:16.499 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:58:16.504 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 21:59:16.512 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:00:16.517 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:00:25.656 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:00:25.718 890 INFO cinder.volume.flows.manager.create_volume [req-afbb771d-642b-4ade-a5fe-2c6447d9a63b ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 4570b526-8947-45ac-8476-63b5da016807: being created using CreateVolumeFromSpecTask._create_from_image with specification: {'status': u'creating', 'image_location': (None, None), 'volume_size': 100, 'volume_name': u'volume-4570b526-8947-45ac-8476-63b5da016807', 'image_id': u'8550cab6-0235-4174-abab-2b20f152462c', 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f83f4c630d0>, 'image_meta': {'status': u'active', 'name': u'cirros', 'deleted': False, 'container_format': u'bare', 'created_at': datetime.datetime(2014, 9, 19, 20, 42, 46, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f40a8050>), 'disk_format': u'raw', 'updated_at': datetime.datetime(2014, 9, 19, 20, 42, 48, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f40a8050>), 'id': u'8550cab6-0235-4174-abab-2b20f152462c', 'owner': u'14ec5d3ea7614a23b98edf77e08c5dfc', 'min_ram': 0, 'checksum': u'133eae9fb1c98f45894a4e60d8736619', 'min_disk': 0, 'is_public': True, 'deleted_at': None, 'properties': {}, 'size': 13200896}}
2014-09-20 22:00:26.924 890 INFO cinder.volume.flows.manager.create_volume [req-afbb771d-642b-4ade-a5fe-2c6447d9a63b ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-4570b526-8947-45ac-8476-63b5da016807 (4570b526-8947-45ac-8476-63b5da016807): created successfully
2014-09-20 22:00:27.455 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:00:27.471 890 INFO cinder.brick.iscsi.iscsi [req-2122e097-cd9b-4c59-9dcd-e06f3542bef8 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-4570b526-8947-45ac-8476-63b5da016807
2014-09-20 22:00:29.509 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:00:50.221 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:00:50.323 890 INFO cinder.brick.iscsi.iscsi [req-dee429e6-c137-4076-bb38-4c66c5d19aaf 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Removing iscsi_target for: b57dcfc1-d8c6-4f2b-8c35-06bc8af83469
2014-09-20 22:00:50.547 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:00:50.716 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:00:50.733 890 INFO cinder.volume.manager [req-20d277e7-c4af-4260-b353-63896f524134 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume b57dcfc1-d8c6-4f2b-8c35-06bc8af83469: deleting
2014-09-20 22:00:50.816 890 INFO cinder.volume.iscsi [req-20d277e7-c4af-4260-b353-63896f524134 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: b57dcfc1-d8c6-4f2b-8c35-06bc8af83469
2014-09-20 22:00:50.912 890 INFO cinder.volume.utils [req-20d277e7-c4af-4260-b353-63896f524134 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--b57dcfc1--d8c6--4f2b--8c35--06bc8af83469
2014-09-20 22:00:56.074 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:00:56.189 890 INFO cinder.brick.iscsi.iscsi [req-35a55b22-060e-4b96-a85b-d7dfb281bb54 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Removing iscsi_target for: 3a387809-e77e-4bf1-bd1e-cae7c4ee1e5b
2014-09-20 22:00:56.432 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:00:56.637 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:00:56.657 890 INFO cinder.volume.manager [req-25f19435-98e7-4a88-8e74-b5f3343c46e7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 3a387809-e77e-4bf1-bd1e-cae7c4ee1e5b: deleting
2014-09-20 22:00:56.745 890 INFO cinder.volume.iscsi [req-25f19435-98e7-4a88-8e74-b5f3343c46e7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 3a387809-e77e-4bf1-bd1e-cae7c4ee1e5b
2014-09-20 22:01:00.598 890 INFO cinder.volume.utils [req-25f19435-98e7-4a88-8e74-b5f3343c46e7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--3a387809--e77e--4bf1--bd1e--cae7c4ee1e5b
2014-09-20 22:01:16.524 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:01:21.497 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:01:21.520 890 INFO cinder.volume.manager [req-1252c879-001f-4f24-a23f-1274ffb47dee 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 6ff28d6b-2563-4c3e-b8db-18003b035da8: deleting
2014-09-20 22:01:22.071 890 INFO cinder.volume.iscsi [req-1252c879-001f-4f24-a23f-1274ffb47dee 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 6ff28d6b-2563-4c3e-b8db-18003b035da8
2014-09-20 22:01:23.926 890 INFO cinder.volume.utils [req-1252c879-001f-4f24-a23f-1274ffb47dee 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--6ff28d6b--2563--4c3e--b8db--18003b035da8
2014-09-20 22:02:16.530 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:02:37.687 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:02:37.756 890 INFO cinder.volume.flows.manager.create_volume [req-71bb8dfb-e31b-4110-a941-ef0ad3eca4c1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 14f9de82-31b6-452d-9c99-6695ff44c598: being created using CreateVolumeFromSpecTask._create_from_image with specification: {'status': u'creating', 'image_location': (None, None), 'volume_size': 100, 'volume_name': u'volume-14f9de82-31b6-452d-9c99-6695ff44c598', 'image_id': u'8550cab6-0235-4174-abab-2b20f152462c', 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f83f42606d0>, 'image_meta': {'status': u'active', 'name': u'cirros', 'deleted': False, 'container_format': u'bare', 'created_at': datetime.datetime(2014, 9, 19, 20, 42, 46, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f412b450>), 'disk_format': u'raw', 'updated_at': datetime.datetime(2014, 9, 19, 20, 42, 48, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f412b450>), 'id': u'8550cab6-0235-4174-abab-2b20f152462c', 'owner': u'14ec5d3ea7614a23b98edf77e08c5dfc', 'min_ram': 0, 'checksum': u'133eae9fb1c98f45894a4e60d8736619', 'min_disk': 0, 'is_public': True, 'deleted_at': None, 'properties': {}, 'size': 13200896}}
2014-09-20 22:02:49.486 890 INFO cinder.volume.flows.manager.create_volume [req-71bb8dfb-e31b-4110-a941-ef0ad3eca4c1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-14f9de82-31b6-452d-9c99-6695ff44c598 (14f9de82-31b6-452d-9c99-6695ff44c598): created successfully
2014-09-20 22:02:50.426 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:02:50.447 890 INFO cinder.brick.iscsi.iscsi [req-69cd1cc6-85c6-417c-a318-400437a27b29 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-14f9de82-31b6-452d-9c99-6695ff44c598
2014-09-20 22:02:53.549 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:03:16.536 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:04:16.542 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:05:16.548 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:06:04.262 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:06:04.335 890 INFO cinder.volume.flows.manager.create_volume [req-045b5ba5-95a0-4782-9c4b-594238fc1d7b ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume bcbf0f5f-5ab1-4aeb-896d-57a3c632ac00: being created using CreateVolumeFromSpecTask._create_from_image with specification: {'status': u'creating', 'image_location': (None, None), 'volume_size': 100, 'volume_name': u'volume-bcbf0f5f-5ab1-4aeb-896d-57a3c632ac00', 'image_id': u'8550cab6-0235-4174-abab-2b20f152462c', 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f83f4df05d0>, 'image_meta': {'status': u'active', 'name': u'cirros', 'deleted': False, 'container_format': u'bare', 'created_at': datetime.datetime(2014, 9, 19, 20, 42, 46, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f4586210>), 'disk_format': u'raw', 'updated_at': datetime.datetime(2014, 9, 19, 20, 42, 48, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f4586210>), 'id': u'8550cab6-0235-4174-abab-2b20f152462c', 'owner': u'14ec5d3ea7614a23b98edf77e08c5dfc', 'min_ram': 0, 'checksum': u'133eae9fb1c98f45894a4e60d8736619', 'min_disk': 0, 'is_public': True, 'deleted_at': None, 'properties': {}, 'size': 13200896}}
2014-09-20 22:06:16.550 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:06:21.434 890 INFO cinder.volume.flows.manager.create_volume [req-045b5ba5-95a0-4782-9c4b-594238fc1d7b ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-bcbf0f5f-5ab1-4aeb-896d-57a3c632ac00 (bcbf0f5f-5ab1-4aeb-896d-57a3c632ac00): created successfully
2014-09-20 22:06:22.824 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:06:22.845 890 INFO cinder.brick.iscsi.iscsi [req-098e6cfb-6944-4591-8413-90d084bf23a9 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-bcbf0f5f-5ab1-4aeb-896d-57a3c632ac00
2014-09-20 22:06:26.708 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:07:16.555 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:08:16.561 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:09:16.567 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:09:59.085 890 INFO cinder.volume.manager [req-20d277e7-c4af-4260-b353-63896f524134 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume b57dcfc1-d8c6-4f2b-8c35-06bc8af83469: deleted successfully
2014-09-20 22:09:59.099 890 INFO cinder.volume.manager [req-20d277e7-c4af-4260-b353-63896f524134 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 22:10:16.571 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:10:20.610 890 INFO cinder.volume.manager [req-25f19435-98e7-4a88-8e74-b5f3343c46e7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 3a387809-e77e-4bf1-bd1e-cae7c4ee1e5b: deleted successfully
2014-09-20 22:10:20.622 890 INFO cinder.volume.manager [req-25f19435-98e7-4a88-8e74-b5f3343c46e7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 22:10:23.373 890 INFO cinder.volume.manager [req-1252c879-001f-4f24-a23f-1274ffb47dee 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 6ff28d6b-2563-4c3e-b8db-18003b035da8: deleted successfully
2014-09-20 22:10:23.389 890 INFO cinder.volume.manager [req-1252c879-001f-4f24-a23f-1274ffb47dee 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 22:11:16.576 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:12:16.582 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:12:41.505 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:12:41.679 890 INFO cinder.brick.iscsi.iscsi [req-f6524253-18de-4fc2-b852-8951ce201cd7 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Removing iscsi_target for: bcbf0f5f-5ab1-4aeb-896d-57a3c632ac00
2014-09-20 22:12:41.910 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:12:42.095 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:12:42.114 890 INFO cinder.volume.manager [req-7868937c-7dc0-45d9-9c54-b0c7f567efea ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume bcbf0f5f-5ab1-4aeb-896d-57a3c632ac00: deleting
2014-09-20 22:12:42.197 890 INFO cinder.volume.iscsi [req-7868937c-7dc0-45d9-9c54-b0c7f567efea ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: bcbf0f5f-5ab1-4aeb-896d-57a3c632ac00
2014-09-20 22:12:44.278 890 INFO cinder.volume.utils [req-7868937c-7dc0-45d9-9c54-b0c7f567efea ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--bcbf0f5f--5ab1--4aeb--896d--57a3c632ac00
2014-09-20 22:13:16.589 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:14:16.594 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:15:16.600 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:15:55.065 890 INFO cinder.volume.manager [req-7868937c-7dc0-45d9-9c54-b0c7f567efea ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume bcbf0f5f-5ab1-4aeb-896d-57a3c632ac00: deleted successfully
2014-09-20 22:15:55.079 890 INFO cinder.volume.manager [req-7868937c-7dc0-45d9-9c54-b0c7f567efea ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-20 22:16:16.602 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:17:16.608 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:18:16.614 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:19:16.620 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:20:16.625 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:21:16.629 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:21:27.385 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:21:27.446 890 INFO cinder.volume.flows.manager.create_volume [req-1cc065c1-7919-413b-b113-bb3eb4309c21 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume de8152d0-3c49-47c4-8acd-ffa1606a2a88: being created using CreateVolumeFromSpecTask._create_from_image with specification: {'status': u'creating', 'image_location': (None, None), 'volume_size': 100, 'volume_name': u'volume-de8152d0-3c49-47c4-8acd-ffa1606a2a88', 'image_id': u'8550cab6-0235-4174-abab-2b20f152462c', 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f83f414e850>, 'image_meta': {'status': u'active', 'name': u'cirros', 'deleted': False, 'container_format': u'bare', 'created_at': datetime.datetime(2014, 9, 19, 20, 42, 46, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f4bf1790>), 'disk_format': u'raw', 'updated_at': datetime.datetime(2014, 9, 19, 20, 42, 48, tzinfo=<iso8601.iso8601.Utc object at 0x7f83f4bf1790>), 'id': u'8550cab6-0235-4174-abab-2b20f152462c', 'owner': u'14ec5d3ea7614a23b98edf77e08c5dfc', 'min_ram': 0, 'checksum': u'133eae9fb1c98f45894a4e60d8736619', 'min_disk': 0, 'is_public': True, 'deleted_at': None, 'properties': {}, 'size': 13200896}}
2014-09-20 22:21:30.371 890 INFO cinder.volume.flows.manager.create_volume [req-1cc065c1-7919-413b-b113-bb3eb4309c21 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-de8152d0-3c49-47c4-8acd-ffa1606a2a88 (de8152d0-3c49-47c4-8acd-ffa1606a2a88): created successfully
2014-09-20 22:21:32.125 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:21:32.142 890 INFO cinder.brick.iscsi.iscsi [req-d7153560-b929-4896-a1c0-166eaa3e0069 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-de8152d0-3c49-47c4-8acd-ffa1606a2a88
2014-09-20 22:21:33.123 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 22:22:16.636 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:22:34.252 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:22:34.458 890 INFO cinder.brick.iscsi.iscsi [req-382a0bc7-b839-4589-8420-c18e69fc6611 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Removing iscsi_target for: 4570b526-8947-45ac-8476-63b5da016807
2014-09-20 22:22:35.631 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:22:35.818 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:22:35.836 890 INFO cinder.volume.manager [req-9a0c82f3-31fc-4873-9aa2-a36e9cee7ac6 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 4570b526-8947-45ac-8476-63b5da016807: deleting
2014-09-20 22:22:35.920 890 INFO cinder.volume.iscsi [req-9a0c82f3-31fc-4873-9aa2-a36e9cee7ac6 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 4570b526-8947-45ac-8476-63b5da016807
2014-09-20 22:22:36.016 890 INFO cinder.volume.utils [req-9a0c82f3-31fc-4873-9aa2-a36e9cee7ac6 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--4570b526--8947--45ac--8476--63b5da016807
2014-09-20 22:22:41.504 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:22:41.618 890 INFO cinder.brick.iscsi.iscsi [req-c124dd21-03f8-41bc-8487-4db1cc67b9b1 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Removing iscsi_target for: 14f9de82-31b6-452d-9c99-6695ff44c598
2014-09-20 22:22:41.839 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:22:42.032 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:22:42.054 890 INFO cinder.volume.manager [req-3e0bb04c-ea51-4ef7-a572-08802d9337e0 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 14f9de82-31b6-452d-9c99-6695ff44c598: deleting
2014-09-20 22:22:42.148 890 INFO cinder.volume.iscsi [req-3e0bb04c-ea51-4ef7-a572-08802d9337e0 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 14f9de82-31b6-452d-9c99-6695ff44c598
2014-09-20 22:22:44.155 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:22:44.509 890 INFO cinder.brick.iscsi.iscsi [req-eee4ef14-f1e5-4699-9864-ec6a17c3882b 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Removing iscsi_target for: de8152d0-3c49-47c4-8acd-ffa1606a2a88
2014-09-20 22:22:44.753 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:22:44.946 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-20 22:22:44.966 890 INFO cinder.volume.manager [req-f87a74a4-2e34-4515-9ad4-b8c8799c7ca5 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume de8152d0-3c49-47c4-8acd-ffa1606a2a88: deleting
2014-09-20 22:22:45.059 890 INFO cinder.volume.iscsi [req-f87a74a4-2e34-4515-9ad4-b8c8799c7ca5 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: de8152d0-3c49-47c4-8acd-ffa1606a2a88
2014-09-20 22:22:47.413 890 INFO cinder.volume.utils [req-3e0bb04c-ea51-4ef7-a572-08802d9337e0 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--14f9de82--31b6--452d--9c99--6695ff44c598
2014-09-20 22:22:49.866 890 INFO cinder.volume.utils [req-f87a74a4-2e34-4515-9ad4-b8c8799c7ca5 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--de8152d0--3c49--47c4--8acd--ffa1606a2a88
2014-09-20 22:23:16.641 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:24:16.642 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:25:16.646 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:26:16.652 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:27:16.654 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:28:16.660 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:29:16.664 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:30:16.666 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:31:16.672 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:31:53.164 890 INFO cinder.volume.manager [req-9a0c82f3-31fc-4873-9aa2-a36e9cee7ac6 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 4570b526-8947-45ac-8476-63b5da016807: deleted successfully
2014-09-20 22:31:53.178 890 INFO cinder.volume.manager [req-9a0c82f3-31fc-4873-9aa2-a36e9cee7ac6 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 22:32:05.736 890 INFO cinder.volume.manager [req-f87a74a4-2e34-4515-9ad4-b8c8799c7ca5 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume de8152d0-3c49-47c4-8acd-ffa1606a2a88: deleted successfully
2014-09-20 22:32:05.749 890 INFO cinder.volume.manager [req-f87a74a4-2e34-4515-9ad4-b8c8799c7ca5 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 22:32:08.749 890 INFO cinder.volume.manager [req-3e0bb04c-ea51-4ef7-a572-08802d9337e0 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 14f9de82-31b6-452d-9c99-6695ff44c598: deleted successfully
2014-09-20 22:32:08.763 890 INFO cinder.volume.manager [req-3e0bb04c-ea51-4ef7-a572-08802d9337e0 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-20 22:32:16.676 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:33:16.678 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:34:16.682 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:35:16.687 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:36:16.690 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:37:16.696 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:38:16.700 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:39:16.706 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:40:16.710 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:41:16.714 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:42:16.719 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:43:16.723 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:44:16.726 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:45:16.731 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:46:16.736 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:47:16.740 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:48:16.744 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:49:16.748 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:50:16.753 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:51:16.757 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:52:16.761 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:53:16.765 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:54:16.768 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:55:16.773 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:56:16.777 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:57:16.780 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:58:16.784 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 22:59:16.787 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:00:16.791 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:01:16.795 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:02:16.799 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:03:16.802 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:04:16.805 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:05:16.808 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:06:16.811 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:07:16.814 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:08:16.817 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:09:16.821 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:10:16.822 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:11:16.824 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:12:16.827 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:13:16.830 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:14:16.832 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:15:16.836 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:16:16.840 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:17:16.843 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:18:16.844 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:19:16.847 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:20:16.849 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:21:16.851 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:22:16.854 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:23:16.857 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:24:16.860 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:25:16.863 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:26:16.864 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:27:16.866 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:28:16.869 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:29:16.871 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:30:16.873 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:31:16.877 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:32:16.878 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:33:16.880 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:34:16.883 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:35:16.884 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:36:16.886 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:37:16.888 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:38:16.890 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:39:16.892 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:40:16.892 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:41:16.894 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:42:16.896 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:43:16.898 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:44:16.899 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:45:16.901 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:46:16.902 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:47:16.904 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:48:16.905 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:49:16.907 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:50:02.330 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 23:50:02.354 890 INFO cinder.volume.flows.manager.create_volume [req-0b065e1f-47b0-4326-8521-6fe9684c4143 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 2ee6ff36-b992-4f33-aebd-7bc042998948: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 100, 'volume_name': u'volume-2ee6ff36-b992-4f33-aebd-7bc042998948'}
2014-09-20 23:50:03.153 890 INFO cinder.volume.flows.manager.create_volume [req-0b065e1f-47b0-4326-8521-6fe9684c4143 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-2ee6ff36-b992-4f33-aebd-7bc042998948 (2ee6ff36-b992-4f33-aebd-7bc042998948): created successfully
2014-09-20 23:50:10.009 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 23:50:10.028 890 INFO cinder.brick.iscsi.iscsi [req-5b4d99c7-1706-4a35-a621-c10fbf9a3106 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-2ee6ff36-b992-4f33-aebd-7bc042998948
2014-09-20 23:50:16.352 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 23:50:16.905 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:50:25.659 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 23:50:25.760 890 INFO cinder.brick.iscsi.iscsi [req-e6c71ce3-d42a-4ef3-8801-bc4c03b4c3bb ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Removing iscsi_target for: 2ee6ff36-b992-4f33-aebd-7bc042998948
2014-09-20 23:50:25.986 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 23:50:30.291 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-20 23:50:30.310 890 INFO cinder.volume.manager [req-1c6d49e9-b51e-4e01-86a0-813412316516 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 2ee6ff36-b992-4f33-aebd-7bc042998948: deleting
2014-09-20 23:50:31.162 890 INFO cinder.volume.iscsi [req-1c6d49e9-b51e-4e01-86a0-813412316516 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 2ee6ff36-b992-4f33-aebd-7bc042998948
2014-09-20 23:50:31.258 890 INFO cinder.volume.utils [req-1c6d49e9-b51e-4e01-86a0-813412316516 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--2ee6ff36--b992--4f33--aebd--7bc042998948
2014-09-20 23:51:16.907 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:52:16.910 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:53:16.910 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:53:39.269 890 INFO cinder.volume.manager [req-1c6d49e9-b51e-4e01-86a0-813412316516 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 2ee6ff36-b992-4f33-aebd-7bc042998948: deleted successfully
2014-09-20 23:53:39.287 890 INFO cinder.volume.manager [req-1c6d49e9-b51e-4e01-86a0-813412316516 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-20 23:54:16.911 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:55:16.913 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:56:16.914 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:57:16.915 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:58:16.916 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-20 23:59:16.917 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:00:16.917 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:01:16.917 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:02:16.918 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:03:16.919 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:04:16.918 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:05:16.919 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:06:16.919 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:07:16.919 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:08:16.920 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:09:16.920 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:10:16.920 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:10:54.703 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:10:54.727 890 INFO cinder.volume.flows.manager.create_volume [req-a5a4fbfa-dab0-44e7-9514-6a3006fb9953 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 715a0855-766e-46d1-9565-be3eec074567: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 100, 'volume_name': u'volume-715a0855-766e-46d1-9565-be3eec074567'}
2014-09-21 00:10:55.608 890 INFO cinder.volume.flows.manager.create_volume [req-a5a4fbfa-dab0-44e7-9514-6a3006fb9953 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-715a0855-766e-46d1-9565-be3eec074567 (715a0855-766e-46d1-9565-be3eec074567): created successfully
2014-09-21 00:11:01.394 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:11:01.412 890 INFO cinder.brick.iscsi.iscsi [req-9e1ed1a8-ab6a-4b04-8c57-c18452b9c59c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-715a0855-766e-46d1-9565-be3eec074567
2014-09-21 00:11:07.864 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:11:12.457 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:11:16.810 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:11:16.826 890 INFO cinder.brick.iscsi.iscsi [req-57cdfd3f-e29a-4a14-92b4-81a1bd288def ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-715a0855-766e-46d1-9565-be3eec074567
2014-09-21 00:11:16.921 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:11:17.336 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:12:16.920 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:12:19.280 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:12:19.578 890 INFO cinder.brick.iscsi.iscsi [req-4f13876c-8de7-40d4-a6c7-bd229f28aeca ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Removing iscsi_target for: 715a0855-766e-46d1-9565-be3eec074567
2014-09-21 00:12:19.788 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:13:16.920 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:14:16.920 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:15:16.921 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:16:00.912 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:16:00.935 890 INFO cinder.volume.flows.manager.create_volume [req-73b27b81-39b0-48cd-b33a-f9a03b0fe884 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 17926894-ad46-491d-b3e4-2f83aa2dc36a: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 100, 'volume_name': u'volume-17926894-ad46-491d-b3e4-2f83aa2dc36a'}
2014-09-21 00:16:01.696 890 INFO cinder.volume.flows.manager.create_volume [req-73b27b81-39b0-48cd-b33a-f9a03b0fe884 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-17926894-ad46-491d-b3e4-2f83aa2dc36a (17926894-ad46-491d-b3e4-2f83aa2dc36a): created successfully
2014-09-21 00:16:07.563 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:16:07.580 890 INFO cinder.brick.iscsi.iscsi [req-c06fb4fb-0986-4155-bed8-62a5dee0d3c4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-17926894-ad46-491d-b3e4-2f83aa2dc36a
2014-09-21 00:16:13.876 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:16:16.920 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:16:31.428 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:16:31.658 890 INFO cinder.brick.iscsi.iscsi [req-d5a8807b-71ae-4a19-a2a9-f60c9550fb67 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Removing iscsi_target for: 17926894-ad46-491d-b3e4-2f83aa2dc36a
2014-09-21 00:16:33.293 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:16:33.312 890 INFO cinder.brick.iscsi.iscsi [req-25667110-8469-4a1a-bfe1-cc63b1b81f90 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating iscsi_target for: volume-17926894-ad46-491d-b3e4-2f83aa2dc36a
2014-09-21 00:17:16.920 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:18:16.921 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:18:24.626 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:18:25.694 890 INFO cinder.brick.iscsi.iscsi [req-159a5c00-a08d-41bf-ba41-4e7867a05812 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Removing iscsi_target for: 17926894-ad46-491d-b3e4-2f83aa2dc36a
2014-09-21 00:18:25.921 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:18:27.699 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 00:18:27.718 890 INFO cinder.volume.manager [req-d846b471-58e8-48d7-a264-258fa35c4ec6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 17926894-ad46-491d-b3e4-2f83aa2dc36a: deleting
2014-09-21 00:18:28.694 890 INFO cinder.volume.iscsi [req-d846b471-58e8-48d7-a264-258fa35c4ec6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 17926894-ad46-491d-b3e4-2f83aa2dc36a
2014-09-21 00:18:28.789 890 INFO cinder.volume.utils [req-d846b471-58e8-48d7-a264-258fa35c4ec6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--17926894--ad46--491d--b3e4--2f83aa2dc36a
2014-09-21 00:19:16.922 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:20:16.921 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:21:16.931 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:21:37.931 890 INFO cinder.volume.manager [req-d846b471-58e8-48d7-a264-258fa35c4ec6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 17926894-ad46-491d-b3e4-2f83aa2dc36a: deleted successfully
2014-09-21 00:21:37.950 890 INFO cinder.volume.manager [req-d846b471-58e8-48d7-a264-258fa35c4ec6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-21 00:22:16.940 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:23:16.950 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:24:16.959 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:25:16.968 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:26:16.978 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:27:16.987 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:28:16.996 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:29:17.005 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:30:17.014 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:31:17.023 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:32:17.033 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:33:17.041 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:34:17.050 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:35:17.059 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:36:17.066 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:37:17.075 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:38:17.084 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:39:17.092 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:40:17.100 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:41:17.109 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:42:17.117 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:43:17.126 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:44:17.135 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:45:17.143 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:46:17.152 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:47:17.160 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:48:17.168 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:49:17.177 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:50:17.185 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:51:17.194 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:52:17.194 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:53:17.200 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:54:17.209 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:55:17.217 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:56:17.225 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:57:17.233 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:58:17.242 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 00:59:17.249 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:00:17.257 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:01:17.265 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:02:17.272 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:03:17.279 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:04:17.288 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:05:17.295 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:06:17.304 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:07:17.311 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:08:17.318 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:09:17.326 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:10:17.333 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:11:17.337 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:12:17.346 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:13:17.353 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:14:17.360 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:15:17.367 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:15:30.219 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:15:30.243 890 INFO cinder.volume.flows.manager.create_volume [req-2ba62cb0-1f32-4355-a923-fe97ade938b5 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 7131b1c6-b61e-496b-9139-c36b30a4ca0a: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-7131b1c6-b61e-496b-9139-c36b30a4ca0a'}
2014-09-21 01:15:30.361 890 INFO cinder.volume.flows.manager.create_volume [req-2ba62cb0-1f32-4355-a923-fe97ade938b5 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-7131b1c6-b61e-496b-9139-c36b30a4ca0a (7131b1c6-b61e-496b-9139-c36b30a4ca0a): created successfully
2014-09-21 01:15:31.039 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:15:31.059 890 INFO cinder.volume.manager [req-28b4e9fd-04ba-4465-9e17-44a94ff32bc6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] snapshot 124c8f86-8890-402d-a8c9-4988671ed1bd: creating
2014-09-21 01:15:31.340 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:15:31.364 890 INFO cinder.volume.flows.manager.create_volume [req-386e512f-f6db-4bef-bd7f-7446ad14767e ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 98aee902-8035-4193-8781-1aa5d9e68928: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-98aee902-8035-4193-8781-1aa5d9e68928'}
2014-09-21 01:15:31.789 890 INFO cinder.volume.flows.manager.create_volume [req-386e512f-f6db-4bef-bd7f-7446ad14767e ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-98aee902-8035-4193-8781-1aa5d9e68928 (98aee902-8035-4193-8781-1aa5d9e68928): created successfully
2014-09-21 01:15:32.838 890 INFO cinder.volume.manager [req-28b4e9fd-04ba-4465-9e17-44a94ff32bc6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] snapshot 124c8f86-8890-402d-a8c9-4988671ed1bd: created successfully
2014-09-21 01:16:17.374 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:17:17.382 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:18:17.390 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:18:27.954 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:18:27.978 890 INFO cinder.volume.flows.manager.create_volume [req-b39335e8-5e25-47b3-b12c-afb73df43559 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 781998a0-e126-48b6-a22c-d0a64e54a7e2: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-781998a0-e126-48b6-a22c-d0a64e54a7e2'}
2014-09-21 01:18:28.227 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:18:28.251 890 INFO cinder.volume.flows.manager.create_volume [req-51dc72cd-83ba-4d62-a716-49ed96316269 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume ee6f36a7-c762-4eee-9034-395b90d6e57e: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-ee6f36a7-c762-4eee-9034-395b90d6e57e'}
2014-09-21 01:18:28.825 890 INFO cinder.volume.flows.manager.create_volume [req-51dc72cd-83ba-4d62-a716-49ed96316269 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-ee6f36a7-c762-4eee-9034-395b90d6e57e (ee6f36a7-c762-4eee-9034-395b90d6e57e): created successfully
2014-09-21 01:18:28.849 890 INFO cinder.volume.flows.manager.create_volume [req-b39335e8-5e25-47b3-b12c-afb73df43559 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-781998a0-e126-48b6-a22c-d0a64e54a7e2 (781998a0-e126-48b6-a22c-d0a64e54a7e2): created successfully
2014-09-21 01:18:49.192 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:18:49.211 890 INFO cinder.volume.manager [req-8e336caf-716b-4ac4-b506-e27dda15e1e1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume ee6f36a7-c762-4eee-9034-395b90d6e57e: deleting
2014-09-21 01:18:49.212 890 INFO cinder.volume.iscsi [req-8e336caf-716b-4ac4-b506-e27dda15e1e1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: ee6f36a7-c762-4eee-9034-395b90d6e57e
2014-09-21 01:18:50.807 890 INFO cinder.volume.utils [req-8e336caf-716b-4ac4-b506-e27dda15e1e1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--ee6f36a7--c762--4eee--9034--395b90d6e57e
2014-09-21 01:18:53.898 890 INFO cinder.volume.manager [req-8e336caf-716b-4ac4-b506-e27dda15e1e1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume ee6f36a7-c762-4eee-9034-395b90d6e57e: deleted successfully
2014-09-21 01:18:53.917 890 INFO cinder.volume.manager [req-8e336caf-716b-4ac4-b506-e27dda15e1e1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-21 01:19:10.658 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:19:10.684 890 INFO cinder.volume.flows.manager.create_volume [req-27af7150-f794-421b-b89d-2b398c8a959d ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume c9ab9c99-2cd8-495d-b614-25adba4e2bb7: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-c9ab9c99-2cd8-495d-b614-25adba4e2bb7'}
2014-09-21 01:19:10.854 890 INFO cinder.volume.flows.manager.create_volume [req-27af7150-f794-421b-b89d-2b398c8a959d ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-c9ab9c99-2cd8-495d-b614-25adba4e2bb7 (c9ab9c99-2cd8-495d-b614-25adba4e2bb7): created successfully
2014-09-21 01:19:12.533 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:19:12.552 890 INFO cinder.volume.manager [req-bd4cfa8f-d349-4184-bb56-2627f8a4d1f4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume c9ab9c99-2cd8-495d-b614-25adba4e2bb7: deleting
2014-09-21 01:19:12.553 890 INFO cinder.volume.iscsi [req-bd4cfa8f-d349-4184-bb56-2627f8a4d1f4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: c9ab9c99-2cd8-495d-b614-25adba4e2bb7
2014-09-21 01:19:12.648 890 INFO cinder.volume.utils [req-bd4cfa8f-d349-4184-bb56-2627f8a4d1f4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--c9ab9c99--2cd8--495d--b614--25adba4e2bb7
2014-09-21 01:19:16.856 890 INFO cinder.volume.manager [req-bd4cfa8f-d349-4184-bb56-2627f8a4d1f4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume c9ab9c99-2cd8-495d-b614-25adba4e2bb7: deleted successfully
2014-09-21 01:19:16.874 890 INFO cinder.volume.manager [req-bd4cfa8f-d349-4184-bb56-2627f8a4d1f4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-21 01:19:17.391 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:19:33.245 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:19:33.271 890 INFO cinder.volume.flows.manager.create_volume [req-7ad14454-2e2e-4a6f-8df9-4ff9ad6ad312 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 09079a4e-0dcc-4534-b17e-0679d7e7f513: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-09079a4e-0dcc-4534-b17e-0679d7e7f513'}
2014-09-21 01:19:33.412 890 INFO cinder.volume.flows.manager.create_volume [req-7ad14454-2e2e-4a6f-8df9-4ff9ad6ad312 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-09079a4e-0dcc-4534-b17e-0679d7e7f513 (09079a4e-0dcc-4534-b17e-0679d7e7f513): created successfully
2014-09-21 01:19:34.152 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:19:34.171 890 INFO cinder.volume.manager [req-7334b2ea-9e88-41ab-9085-16d32ce55500 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 09079a4e-0dcc-4534-b17e-0679d7e7f513: deleting
2014-09-21 01:19:34.171 890 INFO cinder.volume.iscsi [req-7334b2ea-9e88-41ab-9085-16d32ce55500 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 09079a4e-0dcc-4534-b17e-0679d7e7f513
2014-09-21 01:19:35.819 890 INFO cinder.volume.utils [req-7334b2ea-9e88-41ab-9085-16d32ce55500 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--09079a4e--0dcc--4534--b17e--0679d7e7f513
2014-09-21 01:19:38.910 890 INFO cinder.volume.manager [req-7334b2ea-9e88-41ab-9085-16d32ce55500 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 09079a4e-0dcc-4534-b17e-0679d7e7f513: deleted successfully
2014-09-21 01:19:38.929 890 INFO cinder.volume.manager [req-7334b2ea-9e88-41ab-9085-16d32ce55500 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-21 01:19:54.950 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:19:54.977 890 INFO cinder.volume.flows.manager.create_volume [req-f0d6fca6-9eca-4179-b030-06959b3b4df6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume dcaafac2-c26d-4dee-84fc-c0fab329765a: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-dcaafac2-c26d-4dee-84fc-c0fab329765a'}
2014-09-21 01:19:55.916 890 INFO cinder.volume.flows.manager.create_volume [req-f0d6fca6-9eca-4179-b030-06959b3b4df6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-dcaafac2-c26d-4dee-84fc-c0fab329765a (dcaafac2-c26d-4dee-84fc-c0fab329765a): created successfully
2014-09-21 01:20:16.034 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:20:16.053 890 INFO cinder.volume.manager [req-37921d50-6d3e-43f6-bd8e-afc3327c00f6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume dcaafac2-c26d-4dee-84fc-c0fab329765a: deleting
2014-09-21 01:20:16.054 890 INFO cinder.volume.iscsi [req-37921d50-6d3e-43f6-bd8e-afc3327c00f6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: dcaafac2-c26d-4dee-84fc-c0fab329765a
2014-09-21 01:20:17.390 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:20:17.837 890 INFO cinder.volume.utils [req-37921d50-6d3e-43f6-bd8e-afc3327c00f6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--dcaafac2--c26d--4dee--84fc--c0fab329765a
2014-09-21 01:20:20.922 890 INFO cinder.volume.manager [req-37921d50-6d3e-43f6-bd8e-afc3327c00f6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume dcaafac2-c26d-4dee-84fc-c0fab329765a: deleted successfully
2014-09-21 01:20:20.940 890 INFO cinder.volume.manager [req-37921d50-6d3e-43f6-bd8e-afc3327c00f6 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-21 01:20:36.715 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:20:36.742 890 INFO cinder.volume.flows.manager.create_volume [req-a5d9e90c-762e-4150-aba6-e96b8a52668f ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 1e6fd8a5-7b6c-45f2-b94a-c88d7aa9baf3: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-1e6fd8a5-7b6c-45f2-b94a-c88d7aa9baf3'}
2014-09-21 01:20:37.861 890 INFO cinder.volume.flows.manager.create_volume [req-a5d9e90c-762e-4150-aba6-e96b8a52668f ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-1e6fd8a5-7b6c-45f2-b94a-c88d7aa9baf3 (1e6fd8a5-7b6c-45f2-b94a-c88d7aa9baf3): created successfully
2014-09-21 01:20:58.276 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:20:58.296 890 INFO cinder.volume.manager [req-4215c128-844d-4369-aa23-1614e31edca4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 1e6fd8a5-7b6c-45f2-b94a-c88d7aa9baf3: deleting
2014-09-21 01:20:58.296 890 INFO cinder.volume.iscsi [req-4215c128-844d-4369-aa23-1614e31edca4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 1e6fd8a5-7b6c-45f2-b94a-c88d7aa9baf3
2014-09-21 01:20:59.847 890 INFO cinder.volume.utils [req-4215c128-844d-4369-aa23-1614e31edca4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--1e6fd8a5--7b6c--45f2--b94a--c88d7aa9baf3
2014-09-21 01:21:02.925 890 INFO cinder.volume.manager [req-4215c128-844d-4369-aa23-1614e31edca4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 1e6fd8a5-7b6c-45f2-b94a-c88d7aa9baf3: deleted successfully
2014-09-21 01:21:02.940 890 INFO cinder.volume.manager [req-4215c128-844d-4369-aa23-1614e31edca4 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-21 01:21:17.397 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:21:18.942 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:21:18.970 890 INFO cinder.volume.flows.manager.create_volume [req-0ac743e5-acae-47fb-8940-b5827d3730c7 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 5949fff8-be52-4e0a-b326-e390ad632358: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-5949fff8-be52-4e0a-b326-e390ad632358'}
2014-09-21 01:21:19.870 890 INFO cinder.volume.flows.manager.create_volume [req-0ac743e5-acae-47fb-8940-b5827d3730c7 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-5949fff8-be52-4e0a-b326-e390ad632358 (5949fff8-be52-4e0a-b326-e390ad632358): created successfully
2014-09-21 01:21:40.060 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:21:40.101 890 INFO cinder.volume.flows.manager.create_volume [req-10daeb60-33fa-466c-931f-df6a336131ca ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume afff6134-1ccb-4454-87a2-8056ddaa5484: being created using CreateVolumeFromSpecTask._create_from_source_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-afff6134-1ccb-4454-87a2-8056ddaa5484', 'source_volid': u'5949fff8-be52-4e0a-b326-e390ad632358', 'source_volstatus': u'available'}
2014-09-21 01:21:40.121 890 INFO cinder.volume.drivers.lvm [req-10daeb60-33fa-466c-931f-df6a336131ca ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating clone of volume: 5949fff8-be52-4e0a-b326-e390ad632358
2014-09-21 01:21:40.327 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:21:50.877 890 INFO cinder.volume.utils [req-10daeb60-33fa-466c-931f-df6a336131ca ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-clone--snap--afff6134--1ccb--4454--87a2--8056ddaa5484-cow
2014-09-21 01:21:54.259 890 INFO cinder.volume.flows.manager.create_volume [req-10daeb60-33fa-466c-931f-df6a336131ca ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-afff6134-1ccb-4454-87a2-8056ddaa5484 (afff6134-1ccb-4454-87a2-8056ddaa5484): created successfully
2014-09-21 01:21:54.278 890 INFO cinder.volume.manager [req-583d6a2f-6bd6-4ca0-92c5-4689992612e1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 5949fff8-be52-4e0a-b326-e390ad632358: deleting
2014-09-21 01:21:54.279 890 INFO cinder.volume.iscsi [req-583d6a2f-6bd6-4ca0-92c5-4689992612e1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 5949fff8-be52-4e0a-b326-e390ad632358
2014-09-21 01:21:54.374 890 INFO cinder.volume.utils [req-583d6a2f-6bd6-4ca0-92c5-4689992612e1 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--5949fff8--be52--4e0a--b326--e390ad632358
2014-09-21 01:22:17.405 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:23:17.412 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:24:17.420 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:25:02.755 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:25:02.780 890 INFO cinder.volume.flows.manager.create_volume [req-905dbb19-6515-4145-ad1e-8b2bbad0a00c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume cda769a8-a36d-4178-b7df-ce6842ffad60: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-cda769a8-a36d-4178-b7df-ce6842ffad60'}
2014-09-21 01:25:03.012 890 INFO cinder.volume.flows.manager.create_volume [req-905dbb19-6515-4145-ad1e-8b2bbad0a00c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-cda769a8-a36d-4178-b7df-ce6842ffad60 (cda769a8-a36d-4178-b7df-ce6842ffad60): created successfully
2014-09-21 01:25:03.630 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:25:03.670 890 INFO cinder.volume.flows.manager.create_volume [req-f4f3d9a4-7b48-4e6c-a9a4-c73cba8ca58c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 8ffb80bd-f052-4408-8ce0-55e21ce63129: being created using CreateVolumeFromSpecTask._create_from_source_volume with specification: {'status': u'creating', 'volume_size': 2, 'volume_name': u'volume-8ffb80bd-f052-4408-8ce0-55e21ce63129', 'source_volid': u'cda769a8-a36d-4178-b7df-ce6842ffad60', 'source_volstatus': u'available'}
2014-09-21 01:25:03.690 890 INFO cinder.volume.drivers.lvm [req-f4f3d9a4-7b48-4e6c-a9a4-c73cba8ca58c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Creating clone of volume: cda769a8-a36d-4178-b7df-ce6842ffad60
2014-09-21 01:25:13.919 890 INFO cinder.volume.utils [req-f4f3d9a4-7b48-4e6c-a9a4-c73cba8ca58c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-clone--snap--8ffb80bd--f052--4408--8ce0--55e21ce63129-cow
2014-09-21 01:25:17.419 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:25:18.216 890 INFO cinder.volume.flows.manager.create_volume [req-f4f3d9a4-7b48-4e6c-a9a4-c73cba8ca58c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-8ffb80bd-f052-4408-8ce0-55e21ce63129 (8ffb80bd-f052-4408-8ce0-55e21ce63129): created successfully
2014-09-21 01:25:24.893 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:25:24.913 890 INFO cinder.volume.manager [req-a461701f-7541-4b15-aa51-0196bd16af84 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 8ffb80bd-f052-4408-8ce0-55e21ce63129: deleting
2014-09-21 01:25:24.913 890 INFO cinder.volume.iscsi [req-a461701f-7541-4b15-aa51-0196bd16af84 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 8ffb80bd-f052-4408-8ce0-55e21ce63129
2014-09-21 01:25:26.931 890 INFO cinder.volume.utils [req-a461701f-7541-4b15-aa51-0196bd16af84 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--8ffb80bd--f052--4408--8ce0--55e21ce63129
2014-09-21 01:25:31.991 890 INFO cinder.volume.manager [req-a461701f-7541-4b15-aa51-0196bd16af84 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 8ffb80bd-f052-4408-8ce0-55e21ce63129: deleted successfully
2014-09-21 01:25:32.010 890 INFO cinder.volume.manager [req-a461701f-7541-4b15-aa51-0196bd16af84 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Updating volume status
2014-09-21 01:25:45.426 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:25:45.449 890 INFO cinder.volume.manager [req-39e94d5c-d709-4182-98b9-e4f2c349ae3e ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume cda769a8-a36d-4178-b7df-ce6842ffad60: deleting
2014-09-21 01:25:45.449 890 INFO cinder.volume.iscsi [req-39e94d5c-d709-4182-98b9-e4f2c349ae3e ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: cda769a8-a36d-4178-b7df-ce6842ffad60
2014-09-21 01:25:45.545 890 INFO cinder.volume.utils [req-39e94d5c-d709-4182-98b9-e4f2c349ae3e ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--cda769a8--a36d--4178--b7df--ce6842ffad60
2014-09-21 01:26:17.426 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:27:17.433 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:28:17.440 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:29:17.447 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:30:17.453 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:31:17.459 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:32:17.467 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:33:17.473 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:33:19.414 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:33:19.440 890 INFO cinder.volume.flows.manager.create_volume [req-4b199902-9a7d-477a-a27d-306c7a2f0876 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 187741ab-590a-43da-9423-2c8bdde371c0: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-187741ab-590a-43da-9423-2c8bdde371c0'}
2014-09-21 01:33:20.101 890 INFO cinder.volume.flows.manager.create_volume [req-4b199902-9a7d-477a-a27d-306c7a2f0876 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-187741ab-590a-43da-9423-2c8bdde371c0 (187741ab-590a-43da-9423-2c8bdde371c0): created successfully
2014-09-21 01:34:04.808 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:34:04.830 890 INFO cinder.volume.flows.manager.create_volume [req-d5bf1897-5b90-4008-8d44-b8754051f7a8 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 869dde9b-acec-4149-89eb-2821b9916192: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-869dde9b-acec-4149-89eb-2821b9916192'}
2014-09-21 01:34:05.107 890 INFO cinder.volume.flows.manager.create_volume [req-d5bf1897-5b90-4008-8d44-b8754051f7a8 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-869dde9b-acec-4149-89eb-2821b9916192 (869dde9b-acec-4149-89eb-2821b9916192): created successfully
2014-09-21 01:34:17.480 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:34:25.756 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:34:25.777 890 INFO cinder.volume.manager [req-42158de9-9626-4c74-a9d6-d190c0074b99 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] snapshot 595d486e-636d-44c4-bd94-aa1ae8d4a3d2: creating
2014-09-21 01:34:27.201 890 INFO cinder.volume.manager [req-42158de9-9626-4c74-a9d6-d190c0074b99 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] snapshot 595d486e-636d-44c4-bd94-aa1ae8d4a3d2: created successfully
2014-09-21 01:35:17.486 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:36:17.492 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:37:17.498 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:37:50.026 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:37:50.049 890 INFO cinder.volume.flows.manager.create_volume [req-74c0e4a0-3175-468a-bd6b-4699f627eccb ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume 1fbc2275-1221-440f-8f7e-fbbe1cdab46b: being created using CreateVolumeFromSpecTask._create_raw_volume with specification: {'status': u'creating', 'volume_size': 1, 'volume_name': u'volume-1fbc2275-1221-440f-8f7e-fbbe1cdab46b'}
2014-09-21 01:37:50.179 890 INFO cinder.volume.flows.manager.create_volume [req-74c0e4a0-3175-468a-bd6b-4699f627eccb ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Volume volume-1fbc2275-1221-440f-8f7e-fbbe1cdab46b (1fbc2275-1221-440f-8f7e-fbbe1cdab46b): created successfully
2014-09-21 01:37:51.030 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:37:51.046 890 INFO cinder.volume.manager [req-5edf5bc0-5e94-4d05-8785-31bbb215c06c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] snapshot 076be844-1585-4cbf-abdb-8b984113c50f: creating
2014-09-21 01:37:51.341 890 INFO cinder.volume.manager [req-5edf5bc0-5e94-4d05-8785-31bbb215c06c ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] snapshot 076be844-1585-4cbf-abdb-8b984113c50f: created successfully
2014-09-21 01:38:12.008 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:38:12.024 890 INFO cinder.volume.manager [req-5e61eb25-4ed6-4d6a-bbd9-acaeed6eb9d7 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] snapshot 076be844-1585-4cbf-abdb-8b984113c50f: deleting
2014-09-21 01:38:12.170 890 INFO cinder.volume.utils [req-5e61eb25-4ed6-4d6a-bbd9-acaeed6eb9d7 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-_snapshot--076be844--1585--4cbf--abdb--8b984113c50f-cow
2014-09-21 01:38:15.291 890 WARNING cinder.quota [req-5e61eb25-4ed6-4d6a-bbd9-acaeed6eb9d7 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Deprecated: Default quota for resource: snapshots_lvm is set by the default quota flag: quota_snapshots_lvm, it is now deprecated. Please use the the default quota class for default quota.
2014-09-21 01:38:15.314 890 INFO cinder.volume.manager [req-5e61eb25-4ed6-4d6a-bbd9-acaeed6eb9d7 ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] snapshot 076be844-1585-4cbf-abdb-8b984113c50f: deleted successfully
2014-09-21 01:38:17.500 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:38:32.569 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'ef85716627bf47f98a7c89844a375e79', u'tenant': u'f2ff773f37e24f8eb967de102273dbd3', u'user_identity': u'ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -'}
2014-09-21 01:38:32.592 890 INFO cinder.volume.manager [req-2bf04d8e-f5ef-47e8-b9ed-0372bede07be ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] volume 1fbc2275-1221-440f-8f7e-fbbe1cdab46b: deleting
2014-09-21 01:38:32.593 890 INFO cinder.volume.iscsi [req-2bf04d8e-f5ef-47e8-b9ed-0372bede07be ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 1fbc2275-1221-440f-8f7e-fbbe1cdab46b
2014-09-21 01:38:33.227 890 INFO cinder.volume.utils [req-2bf04d8e-f5ef-47e8-b9ed-0372bede07be ef85716627bf47f98a7c89844a375e79 f2ff773f37e24f8eb967de102273dbd3 - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--1fbc2275--1221--440f--8f7e--fbbe1cdab46b
2014-09-21 01:39:17.507 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:40:17.513 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:41:17.519 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:42:17.524 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:43:17.530 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:44:17.537 890 INFO cinder.volume.manager [-] Updating volume status
2014-09-21 01:44:22.120 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-21 01:44:22.142 890 INFO cinder.volume.manager [req-f8c91d11-6937-429a-82f1-ec148a40a3af 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 187741ab-590a-43da-9423-2c8bdde371c0: deleting
2014-09-21 01:44:22.142 890 INFO cinder.volume.iscsi [req-f8c91d11-6937-429a-82f1-ec148a40a3af 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 187741ab-590a-43da-9423-2c8bdde371c0
2014-09-21 01:44:23.250 890 INFO cinder.volume.utils [req-f8c91d11-6937-429a-82f1-ec148a40a3af 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--187741ab--590a--43da--9423--2c8bdde371c0
2014-09-21 01:44:25.156 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-21 01:44:25.177 890 INFO cinder.volume.manager [req-687a6f24-c945-4c04-b4b4-ea29ca72b1cb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 715a0855-766e-46d1-9565-be3eec074567: deleting
2014-09-21 01:44:25.870 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-21 01:44:25.890 890 INFO cinder.volume.manager [req-534cfc6c-2bdb-4ec1-b709-0895bdd0c12b 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 781998a0-e126-48b6-a22c-d0a64e54a7e2: deleting
2014-09-21 01:44:25.891 890 INFO cinder.volume.iscsi [req-534cfc6c-2bdb-4ec1-b709-0895bdd0c12b 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 781998a0-e126-48b6-a22c-d0a64e54a7e2
2014-09-21 01:44:26.365 890 INFO cinder.volume.iscsi [req-687a6f24-c945-4c04-b4b4-ea29ca72b1cb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 715a0855-766e-46d1-9565-be3eec074567
2014-09-21 01:44:27.366 890 INFO cinder.volume.utils [req-687a6f24-c945-4c04-b4b4-ea29ca72b1cb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--715a0855--766e--46d1--9565--be3eec074567
2014-09-21 01:44:27.372 890 INFO cinder.volume.utils [req-534cfc6c-2bdb-4ec1-b709-0895bdd0c12b 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--781998a0--e126--48b6--a22c--d0a64e54a7e2
2014-09-21 01:44:27.384 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-21 01:44:27.408 890 INFO cinder.volume.manager [req-d9b4be32-2872-4baa-995c-503cadf5c618 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 98aee902-8035-4193-8781-1aa5d9e68928: deleting
2014-09-21 01:44:27.409 890 INFO cinder.volume.iscsi [req-d9b4be32-2872-4baa-995c-503cadf5c618 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: 98aee902-8035-4193-8781-1aa5d9e68928
2014-09-21 01:44:27.457 890 INFO cinder.volume.manager [req-f8c91d11-6937-429a-82f1-ec148a40a3af 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 187741ab-590a-43da-9423-2c8bdde371c0: deleted successfully
2014-09-21 01:44:27.481 890 INFO cinder.volume.manager [req-f8c91d11-6937-429a-82f1-ec148a40a3af 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-21 01:44:27.543 890 INFO cinder.volume.utils [req-d9b4be32-2872-4baa-995c-503cadf5c618 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--98aee902--8035--4193--8781--1aa5d9e68928
2014-09-21 01:44:28.170 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-21 01:44:28.193 890 INFO cinder.volume.manager [req-6ce264f3-5e3f-4c56-aeca-2d221582a1a7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume afff6134-1ccb-4454-87a2-8056ddaa5484: deleting
2014-09-21 01:44:28.194 890 INFO cinder.volume.iscsi [req-6ce264f3-5e3f-4c56-aeca-2d221582a1a7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Skipping remove_export. No iscsi_target is presently exported for volume: afff6134-1ccb-4454-87a2-8056ddaa5484
2014-09-21 01:44:31.106 890 INFO cinder.volume.utils [req-6ce264f3-5e3f-4c56-aeca-2d221582a1a7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-volume--afff6134--1ccb--4454--87a2--8056ddaa5484
2014-09-21 01:44:36.919 890 INFO cinder.volume.manager [req-534cfc6c-2bdb-4ec1-b709-0895bdd0c12b 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 781998a0-e126-48b6-a22c-d0a64e54a7e2: deleted successfully
2014-09-21 01:44:36.937 890 INFO cinder.volume.manager [req-534cfc6c-2bdb-4ec1-b709-0895bdd0c12b 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-21 01:44:40.389 890 INFO cinder.volume.manager [req-d9b4be32-2872-4baa-995c-503cadf5c618 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume 98aee902-8035-4193-8781-1aa5d9e68928: deleted successfully
2014-09-21 01:44:40.410 890 INFO cinder.volume.manager [req-d9b4be32-2872-4baa-995c-503cadf5c618 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-21 01:44:40.429 890 INFO cinder.volume.manager [req-6ce264f3-5e3f-4c56-aeca-2d221582a1a7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] volume afff6134-1ccb-4454-87a2-8056ddaa5484: deleted successfully
2014-09-21 01:44:40.448 890 INFO cinder.volume.manager [req-6ce264f3-5e3f-4c56-aeca-2d221582a1a7 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Updating volume status
2014-09-21 01:44:52.957 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-21 01:44:52.978 890 INFO cinder.volume.manager [req-99034d1a-0da2-4373-bbb3-6b2926d0b9eb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] snapshot 124c8f86-8890-402d-a8c9-4988671ed1bd: deleting
2014-09-21 01:44:53.639 890 INFO cinder.volume.utils [req-99034d1a-0da2-4373-bbb3-6b2926d0b9eb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-_snapshot--124c8f86--8890--402d--a8c9--4988671ed1bd-cow
2014-09-21 01:45:02.542 890 WARNING cinder.context [-] Arguments dropped when creating context: {u'user': u'154a0e04a04b49408d620a29778d8722', u'tenant': u'14ec5d3ea7614a23b98edf77e08c5dfc', u'user_identity': u'154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -'}
2014-09-21 01:45:02.562 890 INFO cinder.volume.manager [req-7caa32b2-2f82-4d36-a83a-4c0fd558ecae 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] snapshot 595d486e-636d-44c4-bd94-aa1ae8d4a3d2: deleting
2014-09-21 01:45:03.728 890 INFO cinder.volume.utils [req-7caa32b2-2f82-4d36-a83a-4c0fd558ecae 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Performing secure delete on volume: /dev/mapper/cinder--volumes-_snapshot--595d486e--636d--44c4--bd94--aa1ae8d4a3d2-cow
2014-09-21 01:45:15.175 890 ERROR oslo.messaging.rpc.dispatcher [req-99034d1a-0da2-4373-bbb3-6b2926d0b9eb 154a0e04a04b49408d620a29778d8722 14ec5d3ea7614a23b98edf77e08c5dfc - - -] Exception during message handling: Unexpected error while running command.
Command: sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvremove --config activation { retry_deactivation = 1} devices { ignore_suspended_devices = 1} -f cinder-volumes/_snapshot-124c8f86-8890-402d-a8c9-4988671ed1bd
Exit code: 5
Stdout: ''
Stderr: ' device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n Unable to deactivate cinder--volumes-_snapshot--124c8f86--8890--402d--a8c9--4988671ed1bd (252:4)\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n Unable to deactivate cinder--volumes-_snapshot--124c8f86--8890--402d--a8c9--4988671ed1bd-cow (252:6)\n Unable to deactivate logical volume "_snapshot-124c8f86-8890-402d-a8c9-4988671ed1bd"\n'
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Traceback (most recent call last):
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/rpc/dispatcher.py", line 134, in _dispatch_and_reply
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher incoming.message))
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/rpc/dispatcher.py", line 177, in _dispatch
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher return self._do_dispatch(endpoint, method, ctxt, args)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo/messaging/rpc/dispatcher.py", line 123, in _do_dispatch
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher result = getattr(endpoint, method)(ctxt, **new_args)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/manager.py", line 166, in lso_inner1
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher return lso_inner2(inst, context, snapshot_id, **kwargs)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/openstack/common/lockutils.py", line 233, in inner
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher retval = f(*args, **kwargs)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/manager.py", line 165, in lso_inner2
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher return f(*_args, **_kwargs)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/manager.py", line 542, in delete_snapshot
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher {'status': 'error_deleting'})
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/openstack/common/excutils.py", line 68, in __exit__
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher six.reraise(self.type_, self.value, self.tb)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/manager.py", line 530, in delete_snapshot
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher self.driver.delete_snapshot(snapshot_ref)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/drivers/lvm.py", line 252, in delete_snapshot
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher self._delete_volume(snapshot, is_snapshot=True)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/volume/drivers/lvm.py", line 133, in _delete_volume
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher self.vg.delete(name)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/brick/local_dev/lvm.py", line 599, in delete
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher root_helper=self._root_helper, run_as_root=True)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/utils.py", line 136, in execute
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher return processutils.execute(*cmd, **kwargs)
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/cinder/openstack/common/processutils.py", line 173, in execute
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher cmd=' '.join(cmd))
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher ProcessExecutionError: Unexpected error while running command.
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Command: sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvremove --config activation { retry_deactivation = 1} devices { ignore_suspended_devices = 1} -f cinder-volumes/_snapshot-124c8f86-8890-402d-a8c9-4988671ed1bd
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Exit code: 5
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Stdout: ''
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher Stderr: ' device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n Unable to deactivate cinder--volumes-_snapshot--124c8f86--8890--402d--a8c9--4988671ed1bd (252:4)\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n device-mapper: remove ioctl on failed: Device or resource busy\n Unable to deactivate cinder--volumes-_snapshot--124c8f86--8890--402d--a8c9--4988671ed1bd-cow (252:6)\n Unable to deactivate logical volume "_snapshot-124c8f86-8890-402d-a8c9-4988671ed1bd"\n'
2014-09-21 01:45:15.175 890 TRACE oslo.messaging.rpc.dispatcher
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment