Attachment 608550 Details for Bug 802423 – Trace output of the lock translator from the gluster volume clvolume1

Trace output of the lock translator from the gluster volume clvolume1

gluster_clvolume1_lock_translator_trace.log (text/x-log), 169.53 KB, created by Andreas Schmechtig on 2012-08-31 15:36:08 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Andreas Schmechtig

Created: 2012-08-31 15:36:08 UTC

Size: 169.53 KB

patch

obsolete

>[2012-02-01 13:26:25.995038] I [glusterfsd.c:1493:main] 0-/opt/glusterfs/3.2.5/sbin/glusterfsd: Started running /opt/glusterfs/3.2.5/sbin/glusterfsd version 3.2.5
>[2012-02-01 13:26:26.4108] W [socket.c:419:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-02-01 13:26:26.4166] W [socket.c:1846:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-02-01 13:26:26.47930] W [graph.c:291:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24014'
>[2012-02-01 13:26:26.57209] W [rpc-transport.c:447:validate_volume_options] 0-tcp.clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-02-01 13:26:26.57373] W [posix.c:4733:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4: end-volume
>  5: 
>  6: volume clvolume1-access-control
>  7:     type features/access-control
>  8:     subvolumes clvolume1-posix
>  9: end-volume
> 10: 
> 11: volume clvolume1-locks
> 12:     type features/locks
> 13:     subvolumes clvolume1-access-control
> 14: end-volume
> 15: 
> 16: volume clvolume1-io-threads
> 17:     type performance/io-threads
> 18:     subvolumes clvolume1-locks
> 19: end-volume
> 20: 
> 21: volume clvolume1-marker
> 22:     type features/marker
> 23:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 24:     option timestamp-file /etc/glusterd/vols/clvolume1/marker.tstamp
> 25:     option xtime off
> 26:     option quota off
> 27:     subvolumes clvolume1-io-threads
> 28: end-volume
> 29: 
> 30: volume /export1
> 31:     type debug/io-stats
> 32:     option latency-measurement off
> 33:     option count-fop-hits off
> 34:     subvolumes clvolume1-marker
> 35: end-volume
> 36: 
> 37: volume clvolume1-server
> 38:     type protocol/server
> 39:     option transport-type tcp
> 40:     option auth.addr./export1.allow *
> 41:     subvolumes /export1
> 42: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-02-01 13:26:30.212153] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.23:1008 (version: 3.2.5)
>[2012-02-01 13:26:31.12328] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.112:1002 (version: 3.2.5)
>[2012-02-01 13:26:31.263978] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.112:1000 (version: 3.2.5)
>[2012-02-01 13:27:01.845637] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.23:1003 (version: 3.2.5)
>[2012-02-07 11:50:41.627794] W [glusterfsd.c:727:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x7fd91a97f70d] (-->/lib64/libpthread.so.0(+0x77f1) [0x7fd91ac427f1] (-->/opt/glusterfs/3.2.5/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x404edd]))) 0-: received signum (15), shutting down
>[2012-02-07 11:51:10.404872] I [glusterfsd.c:1493:main] 0-/opt/glusterfs/3.2.5/sbin/glusterfsd: Started running /opt/glusterfs/3.2.5/sbin/glusterfsd version 3.2.5
>[2012-02-07 11:51:10.413574] W [socket.c:419:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-02-07 11:51:10.413614] W [socket.c:1846:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-02-07 11:51:10.498206] W [graph.c:291:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24014'
>[2012-02-07 11:51:10.524124] W [rpc-transport.c:447:validate_volume_options] 0-tcp.clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-02-07 11:51:10.524276] W [posix.c:4733:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4: end-volume
>  5: 
>  6: volume clvolume1-access-control
>  7:     type features/access-control
>  8:     subvolumes clvolume1-posix
>  9: end-volume
> 10: 
> 11: volume clvolume1-locks
> 12:     type features/locks
> 13:     subvolumes clvolume1-access-control
> 14: end-volume
> 15: 
> 16: volume clvolume1-io-threads
> 17:     type performance/io-threads
> 18:     subvolumes clvolume1-locks
> 19: end-volume
> 20: 
> 21: volume clvolume1-marker
> 22:     type features/marker
> 23:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 24:     option timestamp-file /etc/glusterd/vols/clvolume1/marker.tstamp
> 25:     option xtime off
> 26:     option quota off
> 27:     subvolumes clvolume1-io-threads
> 28: end-volume
> 29: 
> 30: volume /export1
> 31:     type debug/io-stats
> 32:     option latency-measurement off
> 33:     option count-fop-hits off
> 34:     subvolumes clvolume1-marker
> 35: end-volume
> 36: 
> 37: volume clvolume1-server
> 38:     type protocol/server
> 39:     option transport-type tcp
> 40:     option auth.addr./export1.allow *
> 41:     subvolumes /export1
> 42: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-02-07 11:51:14.606071] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.23:1003 (version: 3.2.5)
>[2012-02-07 11:51:15.952709] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.112:1010 (version: 3.2.5)
>[2012-02-07 11:51:17.366298] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.23:998 (version: 3.2.5)
>[2012-02-07 11:51:43.992432] W [socket.c:204:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection reset by peer)
>[2012-02-07 11:51:43.992461] W [socket.c:1494:__socket_proto_state_machine] 0-tcp.clvolume1-server: reading from socket failed. Error (Connection reset by peer), peer (132.10.95.112:1010)
>[2012-02-07 11:51:43.992498] I [server.c:438:server_rpc_notify] 0-clvolume1-server: disconnected connection from 132.10.95.112:1010
>[2012-02-07 11:51:43.992521] I [server-helpers.c:783:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-18830-2012/02/01-13:18:02:321462-clvolume1-client-0
>[2012-02-07 11:51:53.131766] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.112:1020 (version: 3.2.5)
>[2012-02-07 11:51:53.436783] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.112:1019 (version: 3.2.5)
>[2012-03-26 14:07:05.41655] I [server3_1-fops.c:1340:server_open_cbk] 0-clvolume1-server: 60787: OPEN /a2285468/invalid_auto.sql (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:05.42528] I [server3_1-fops.c:1340:server_open_cbk] 0-clvolume1-server: 60790: OPEN /a2285468/invalid_auto.sql (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:08.785799] I [server3_1-fops.c:1340:server_open_cbk] 0-clvolume1-server: 61316: OPEN /a2285468/invalid_auto.sql (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:08.791030] I [server3_1-fops.c:1340:server_open_cbk] 0-clvolume1-server: 61318: OPEN /a2285468/invalid_auto.sql (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:50.147155] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 167432: STAT /a2285468/bin/swpsichpruef.e (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:50.148871] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 167434: STAT /a2285468/bin/swpsichpruef.e (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:50.240570] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 167696: STAT /a2285468/bin/lzIdent.pl (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:50.242198] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 167698: STAT /a2285468/bin/lzIdent.pl (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:52.381736] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 438032: STAT /a2285468/bin/kibs_pflege (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:52.383126] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 438035: STAT /a2285468/bin/kibs_pflege (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:53.361530] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 176332: STAT /a2285468/IT-QS/TAN/create_comhome.sql (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:53.363334] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 176335: STAT /a2285468/IT-QS/TAN/create_comhome.sql (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:55.103279] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 180558: STAT /a2285468/bin/loescheInteressenten.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:55.104388] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 180560: STAT /a2285468/bin/loescheInteressenten.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:56.154354] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 449039: STAT /a2285468/bin/tgfbrief.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:56.155788] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 449042: STAT /a2285468/bin/tgfbrief.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:56.236028] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 183609: STAT /a2285468/var/ftpdown/c/tgl/wpkauco (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:56.237929] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 183612: STAT /a2285468/var/ftpdown/c/tgl/wpkauco (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:57.808873] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 454095: STAT /a2285468/profile.template.10g (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:57.810010] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 454097: STAT /a2285468/profile.template.10g (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:58.120630] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 455009: STAT /a2285468/var/backup/install.sql_vor.SCR11761_UPDATE.sql.log.20100923-115212.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:58.122431] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 455013: STAT /a2285468/var/backup/install.sql_vor.SCR11761_UPDATE.sql.log.20100923-115212.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:58.553124] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 456259: STAT /a2285468/bin/cat_ivr_statistik.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:58.554462] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 456262: STAT /a2285468/bin/cat_ivr_statistik.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:58.701570] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 456732: STAT /a2285468/var/backup/install.sql_nach.SCR13001.sql.log.20110303-152248.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:58.703018] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 456735: STAT /a2285468/var/backup/install.sql_nach.SCR13001.sql.log.20110303-152248.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:59.78878] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 457966: STAT /a2285468/20120319064012/tmp/064346/ccf/img/aktienselector_kunden.gif (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:59.80276] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 457969: STAT /a2285468/20120319064012/tmp/064346/ccf/img/aktienselector_kunden.gif (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:59.438471] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 459045: STAT /a2285468/bin/tgk40_mailing (0) ==> -1 (No such file or directory)
>[2012-03-26 14:07:59.439744] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 459047: STAT /a2285468/bin/tgk40_mailing (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:04.140240] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 202294: STAT /a2285468/var/backup/install.sql_nach.MigriereJubidepot.sql.log.20100630-091712.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:04.142047] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 202296: STAT /a2285468/var/backup/install.sql_nach.MigriereJubidepot.sql.log.20100630-091712.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:05.914004] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 478739: STAT /a2285468/build/log/2011-08-19.14-59-00.log.0e817efa-cbce-4826-a937-0086e8805c26/deploy.checkSTP.output.log (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:05.915505] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 478742: STAT /a2285468/build/log/2011-08-19.14-59-00.log.0e817efa-cbce-4826-a937-0086e8805c26/deploy.checkSTP.output.log (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:14.402358] I [server3_1-fops.c:964:server_unlink_cbk] 0-clvolume1-server: 502700: UNLINK /a2285468/bin/limitpruef_recv (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:14.403577] I [server3_1-fops.c:1340:server_open_cbk] 0-clvolume1-server: 502702: OPEN /a2285468/bin/limitpruef_recv (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:14.513054] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 503026: STAT /a2285468/bin/PKontoBearbeiten (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:14.514307] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 503029: STAT /a2285468/bin/PKontoBearbeiten (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:15.229422] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 227436: STAT /a2285468/20120319064012/tmp/login/login?CIF_Check=true (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:15.231279] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 227438: STAT /a2285468/20120319064012/tmp/login/login?CIF_Check=true (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:18.191856] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 514094: STAT /a2285468/var/traces/diba.log.301110 (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:18.193152] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 514097: STAT /a2285468/var/traces/diba.log.301110 (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:18.548577] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 233737: STAT /a2285468/build/log/2011-11-17.15-39-21.log.aeaf80c6-bb81-4d87-b2c6-f727728aafe5/deploy.checkSTP.REPORT.lst (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:18.549996] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 233740: STAT /a2285468/build/log/2011-11-17.15-39-21.log.aeaf80c6-bb81-4d87-b2c6-f727728aafe5/deploy.checkSTP.REPORT.lst (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:20.45371] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 237421: STAT /a2285468/bin/PmKickbackBuchen.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:20.47246] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 237422: STAT /a2285468/bin/PmKickbackBuchen.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:24.642231] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 247945: STAT /a2285468/var/backup/install.sql_nach.scr12135_ebox.sql.log.20110120-125211.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:24.644784] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 247948: STAT /a2285468/var/backup/install.sql_nach.scr12135_ebox.sql.log.20110120-125211.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:25.705171] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 250155: STAT /a2285468/bin/mfgchecksaldo.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:25.706753] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 250157: STAT /a2285468/bin/mfgchecksaldo.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:25.764190] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 536607: STAT /a2285468/bin/etikett.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:25.765577] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 536609: STAT /a2285468/bin/etikett.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:25.933058] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 537161: STAT /a2285468/bin/checkPostJB (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:25.934437] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 537164: STAT /a2285468/bin/checkPostJB (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:25.994241] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 537353: STAT /a2285468/20120319064012/tmp/064346/ccf/img/yellowdot.gif (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:25.995907] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 537355: STAT /a2285468/20120319064012/tmp/064346/ccf/img/yellowdot.gif (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:26.372330] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 251692: STAT /a2285468/bin/PKontoBearbeiten (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:26.374121] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 251694: STAT /a2285468/bin/PKontoBearbeiten (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:26.713708] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 252452: STAT /a2285468/bin/mahnkasperr (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:26.715446] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 252454: STAT /a2285468/bin/mahnkasperr (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:29.300442] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 547300: STAT /a2285468/bin/buchung_send.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:29.301850] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 547303: STAT /a2285468/bin/buchung_send.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:35.697652] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 566758: STAT /a2285468/cfg/receive_deamon_filelist.cfg (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:35.699019] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 566761: STAT /a2285468/cfg/receive_deamon_filelist.cfg (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:35.994892] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 274217: STAT /a2285468/bin/ack_file (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:35.997224] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 274219: STAT /a2285468/bin/ack_file (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:37.505080] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 572183: STAT /a2285468/bin/b_schnitt (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:37.506518] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 572186: STAT /a2285468/bin/b_schnitt (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:37.843967] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 278776: STAT /a2285468/bin/AutoEmailBenachrichtigung (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:37.845736] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 278778: STAT /a2285468/bin/AutoEmailBenachrichtigung (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:40.460091] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 285067: STAT /a2285468/bin/cdlib.pm (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:40.461642] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 285069: STAT /a2285468/bin/cdlib.pm (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:41.699353] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 585211: STAT /a2285468/bin/VVKickbackAAListe.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:41.700618] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 585213: STAT /a2285468/bin/VVKickbackAAListe.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:41.939587] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 585954: STAT /a2285468/bin/genBerufAntraege (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:41.940696] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 585957: STAT /a2285468/bin/genBerufAntraege (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:42.306925] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 587167: STAT /a2285468/input/F_GKGTGP_4_0610_OB.pdf (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:42.308005] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 587170: STAT /a2285468/input/F_GKGTGP_4_0610_OB.pdf (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:47.223344] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 601683: STAT /a2285468/bin/tgk40_mailing (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:47.224882] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 601685: STAT /a2285468/bin/tgk40_mailing (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:50.821312] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 309812: STAT /a2285468/bin/WpsVerkaufSend.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:50.823337] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 309815: STAT /a2285468/bin/WpsVerkaufSend.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:52.971125] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 618475: STAT /a2285468/bin/pcservd_nt.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:52.972563] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 618477: STAT /a2285468/bin/pcservd_nt.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:56.734039] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 323640: STAT /a2285468/bin/KombiOrderAbgleich (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:56.736094] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 323643: STAT /a2285468/bin/KombiOrderAbgleich (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:56.867929] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 629805: STAT /a2285468/bin/FSA_send.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:56.869671] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 629807: STAT /a2285468/bin/FSA_send.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:59.402725] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 637329: STAT /a2285468/bin/ks_loyalty.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:59.403884] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 637332: STAT /a2285468/bin/ks_loyalty.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:59.986087] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 638996: STAT /a2285468/var/backup/install.sql_vor.SCR12544.sql.log.20101216-102300.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:08:59.987614] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 638999: STAT /a2285468/var/backup/install.sql_vor.SCR12544.sql.log.20101216-102300.gz (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:00.623910] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 641025: STAT /a2285468/bin/ftp_to_host (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:00.625257] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 641027: STAT /a2285468/bin/ftp_to_host (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:00.728910] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 641322: STAT /a2285468/bin/ftp_to_host (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:00.730055] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 641324: STAT /a2285468/bin/ftp_to_host (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:02.520167] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 647138: STAT /a2285468/build/log/2012-01-19.11-11-22.log.f1210a16-416b-44dd-b504-7b9e341d5f97/sql.log.zip (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:02.521754] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 647141: STAT /a2285468/build/log/2012-01-19.11-11-22.log.f1210a16-416b-44dd-b504-7b9e341d5f97/sql.log.zip (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:04.159173] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 652295: STAT /a2285468/var/traces/tr.tr (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:04.160556] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 652298: STAT /a2285468/var/traces/tr.tr (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:04.899400] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 654254: STAT /a2285468/20120319064012/tmp/064346/ccf/css/style_keyfocus.css.orig (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:04.901035] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 654257: STAT /a2285468/20120319064012/tmp/064346/ccf/css/style_keyfocus.css.orig (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:07.53256] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 660823: STAT /a2285468/build/log/2011-09-08.09-02-10.log.165b6e02-c79b-419d-9a2a-8d7ebc403b8e/deploy.checkSTP.REPORT.lst (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:07.54700] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 660825: STAT /a2285468/build/log/2011-09-08.09-02-10.log.165b6e02-c79b-419d-9a2a-8d7ebc403b8e/deploy.checkSTP.REPORT.lst (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:07.944786] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 663517: STAT /a2285468/var/traces/diba.log.080911 (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:07.946216] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 663520: STAT /a2285468/var/traces/diba.log.080911 (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:08.661805] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 666013: STAT /a2285468/bin/nachfassbrief (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:08.663005] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 666016: STAT /a2285468/bin/nachfassbrief (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:10.245662] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 670685: STAT /a2285468/bin/send_dwh_abh_log.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:10.247046] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 670687: STAT /a2285468/bin/send_dwh_abh_log.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:11.706742] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 356913: STAT /a2285468/bin/BerdepAuMErmitteln (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:11.708360] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 356915: STAT /a2285468/bin/BerdepAuMErmitteln (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:12.666967] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 677783: STAT /a2285468/build/log/2011-12-19.09-24-39.log.4eaf1661-85c3-4fa1-a368-55e3ac398141/sql_post.SCR12598_MT_MIG_04.sql.log (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:12.668436] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 677786: STAT /a2285468/build/log/2011-12-19.09-24-39.log.4eaf1661-85c3-4fa1-a368-55e3ac398141/sql_post.SCR12598_MT_MIG_04.sql.log (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:12.950930] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 678690: STAT /a2285468/bin/send_ivr_statistik_to_dwh.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:12.952187] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 678692: STAT /a2285468/bin/send_ivr_statistik_to_dwh.sh (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:17.286356] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 368728: STAT /a2285468/tmp/sql_nach_FALLBACK.lst (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:17.287738] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 368731: STAT /a2285468/tmp/sql_nach_FALLBACK.lst (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:21.206366] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 701582: STAT /a2285468/bin/FSA_ablage (0) ==> -1 (No such file or directory)
>[2012-03-26 14:09:21.207577] I [server3_1-fops.c:1492:server_stat_cbk] 0-clvolume1-server: 701585: STAT /a2285468/bin/FSA_ablage (0) ==> -1 (No such file or directory)
>[2012-08-28 13:48:48.130933] W [socket.c:204:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection timed out)
>[2012-08-28 13:48:48.152707] W [socket.c:1494:__socket_proto_state_machine] 0-tcp.clvolume1-server: reading from socket failed. Error (Connection timed out), peer (132.10.95.112:1020)
>[2012-08-28 13:48:48.152810] I [server.c:438:server_rpc_notify] 0-clvolume1-server: disconnected connection from 132.10.95.112:1020
>[2012-08-28 13:48:48.152864] I [server-helpers.c:783:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1618-2012/02/07-11:51:49:444684-clvolume1-client-0
>[2012-08-28 13:48:55.6513] W [socket.c:1494:__socket_proto_state_machine] 0-socket.glusterfsd: reading from socket failed. Error (Transport endpoint is not connected), peer ()
>[2012-08-28 13:48:55.45420] W [glusterfsd.c:727:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x30362e570d] (-->/lib64/libpthread.so.0() [0x30366077f1] (-->/opt/glusterfs/3.2.5/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x404edd]))) 0-: received signum (15), shutting down
>[2012-08-28 13:49:31.557284] I [glusterfsd.c:1493:main] 0-/opt/glusterfs/3.2.5/sbin/glusterfsd: Started running /opt/glusterfs/3.2.5/sbin/glusterfsd version 3.2.5
>[2012-08-28 13:49:31.678771] W [graph.c:291:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24014'
>[2012-08-28 13:49:31.680383] W [rpc-transport.c:447:validate_volume_options] 0-tcp.clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-28 13:49:31.680659] W [posix.c:4733:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4: end-volume
>  5: 
>  6: volume clvolume1-access-control
>  7:     type features/access-control
>  8:     subvolumes clvolume1-posix
>  9: end-volume
> 10: 
> 11: volume clvolume1-locks
> 12:     type features/locks
> 13:     subvolumes clvolume1-access-control
> 14: end-volume
> 15: 
> 16: volume clvolume1-io-threads
> 17:     type performance/io-threads
> 18:     subvolumes clvolume1-locks
> 19: end-volume
> 20: 
> 21: volume clvolume1-marker
> 22:     type features/marker
> 23:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 24:     option timestamp-file /etc/glusterd/vols/clvolume1/marker.tstamp
> 25:     option xtime off
> 26:     option quota off
> 27:     subvolumes clvolume1-io-threads
> 28: end-volume
> 29: 
> 30: volume /export1
> 31:     type debug/io-stats
> 32:     option latency-measurement off
> 33:     option count-fop-hits off
> 34:     subvolumes clvolume1-marker
> 35: end-volume
> 36: 
> 37: volume clvolume1-server
> 38:     type protocol/server
> 39:     option transport-type tcp
> 40:     option auth.addr./export1.allow *
> 41:     subvolumes /export1
> 42: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-28 13:49:35.279454] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.23:1021 (version: 3.2.5)
>[2012-08-28 13:49:35.439414] W [socket.c:419:__socket_keepalive] 0-socket: failed to set keep idle on socket 11
>[2012-08-28 13:49:35.439451] W [socket.c:1846:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-28 13:49:35.869436] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.23:1000 (version: 3.2.5)
>[2012-08-28 13:49:39.409284] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.112:991 (version: 3.2.5)
>[2012-08-28 13:49:39.683590] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.112:990 (version: 3.2.5)
>[2012-08-28 14:18:17.388333] W [glusterfsd.c:727:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x7f34f9bbd67d] (-->/lib64/libpthread.so.0(+0x7851) [0x7f34f9e6f851] (-->/opt/glusterfs/3.2.5/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x404edd]))) 0-: received signum (15), shutting down
>[2012-08-28 14:18:48.601226] I [glusterfsd.c:1493:main] 0-/opt/glusterfs/3.2.5/sbin/glusterfsd: Started running /opt/glusterfs/3.2.5/sbin/glusterfsd version 3.2.5
>[2012-08-28 14:18:48.614961] W [socket.c:419:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-28 14:18:48.615058] W [socket.c:1846:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-28 14:18:48.678735] W [graph.c:291:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24014'
>[2012-08-28 14:18:48.686711] W [rpc-transport.c:447:validate_volume_options] 0-tcp.clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-28 14:18:48.686953] W [posix.c:4733:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4: end-volume
>  5: 
>  6: volume clvolume1-access-control
>  7:     type features/access-control
>  8:     subvolumes clvolume1-posix
>  9: end-volume
> 10: 
> 11: volume clvolume1-locks
> 12:     type features/locks
> 13:     subvolumes clvolume1-access-control
> 14: end-volume
> 15: 
> 16: volume clvolume1-io-threads
> 17:     type performance/io-threads
> 18:     subvolumes clvolume1-locks
> 19: end-volume
> 20: 
> 21: volume clvolume1-marker
> 22:     type features/marker
> 23:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 24:     option timestamp-file /etc/glusterd/vols/clvolume1/marker.tstamp
> 25:     option xtime off
> 26:     option quota off
> 27:     subvolumes clvolume1-io-threads
> 28: end-volume
> 29: 
> 30: volume /export1
> 31:     type debug/io-stats
> 32:     option latency-measurement off
> 33:     option count-fop-hits off
> 34:     subvolumes clvolume1-marker
> 35: end-volume
> 36: 
> 37: volume clvolume1-server
> 38:     type protocol/server
> 39:     option transport-type tcp
> 40:     option auth.addr./export1.allow *
> 41:     subvolumes /export1
> 42: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-28 14:18:52.366894] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.23:1021 (version: 3.2.5)
>[2012-08-28 14:18:52.845020] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.112:1006 (version: 3.2.5)
>[2012-08-28 14:18:52.856116] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.23:999 (version: 3.2.5)
>[2012-08-28 14:18:52.948690] I [server-handshake.c:542:server_setvolume] 0-clvolume1-server: accepted client from 132.10.95.112:1005 (version: 3.2.5)
>[2012-08-28 14:56:35.437530] W [socket.c:1494:__socket_proto_state_machine] 0-tcp.clvolume1-server: reading from socket failed. Error (Transport endpoint is not connected), peer (132.10.95.23:1021)
>[2012-08-28 14:56:35.437653] I [server.c:438:server_rpc_notify] 0-clvolume1-server: disconnected connection from 132.10.95.23:1021
>[2012-08-28 14:56:35.437710] I [server-helpers.c:783:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat01.de.comdirect.com-1805-2012/08/28-14:18:48:288827-clvolume1-client-0
>[2012-08-28 14:56:51.96497] W [socket.c:1494:__socket_proto_state_machine] 0-tcp.clvolume1-server: reading from socket failed. Error (Transport endpoint is not connected), peer (132.10.95.112:1005)
>[2012-08-28 14:56:51.96605] I [server.c:438:server_rpc_notify] 0-clvolume1-server: disconnected connection from 132.10.95.112:1005
>[2012-08-28 14:56:51.96652] I [server-helpers.c:783:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1885-2012/08/28-14:18:33:842880-clvolume1-client-0
>[2012-08-28 14:56:57.429431] W [socket.c:1494:__socket_proto_state_machine] 0-socket.glusterfsd: reading from socket failed. Error (Transport endpoint is not connected), peer ()
>[2012-08-28 14:56:57.429630] W [socket.c:1494:__socket_proto_state_machine] 0-glusterfs: reading from socket failed. Error (Transport endpoint is not connected), peer (127.0.0.1:24007)
>[2012-08-28 14:56:57.566806] W [glusterfsd.c:727:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x7f5394b3267d] (-->/lib64/libpthread.so.0(+0x7851) [0x7f5394de4851] (-->/opt/glusterfs/3.2.5/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x404edd]))) 0-: received signum (15), shutting down
>[2012-08-28 14:56:57.576163] I [socket.c:2275:socket_submit_request] 0-glusterfs: not connected (priv->connected = 0)
>[2012-08-28 14:56:57.576192] W [rpc-clnt.c:1417:rpc_clnt_submit] 0-glusterfs: failed to submit rpc-request (XID: 0x3x Program: Gluster Portmap, ProgVers: 1, Proc: 5) to rpc-transport (glusterfs)
>[2012-08-28 15:10:23.393850] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-28 15:10:23.436646] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24009'
>[2012-08-28 15:10:23.436684] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-28 15:10:23.456533] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-28 15:10:23.459749] W [posix.c:4057:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15: end-volume
> 16: 
> 17: volume clvolume1-io-threads
> 18:     type performance/io-threads
> 19:     subvolumes clvolume1-locks
> 20: end-volume
> 21: 
> 22: volume clvolume1-index
> 23:     type features/index
> 24:     option index-base /export1/.glusterfs/indices
> 25:     subvolumes clvolume1-io-threads
> 26: end-volume
> 27: 
> 28: volume clvolume1-marker
> 29:     type features/marker
> 30:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 31:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 32:     option xtime off
> 33:     option quota off
> 34:     subvolumes clvolume1-index
> 35: end-volume
> 36: 
> 37: volume /export1
> 38:     type debug/io-stats
> 39:     option latency-measurement off
> 40:     option count-fop-hits off
> 41:     subvolumes clvolume1-marker
> 42: end-volume
> 43: 
> 44: volume clvolume1-server
> 45:     type protocol/server
> 46:     option transport-type tcp
> 47:     option auth.addr./export1.allow *
> 48:     subvolumes /export1
> 49: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-28 15:10:27.377767] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-28 15:10:27.377815] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-28 15:10:27.463489] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-4382-2012/08/28-15:10:23:418251-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:10:27.550028] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-4387-2012/08/28-15:10:23:424793-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:14:36.314971] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-4173-2012/08/28-15:14:32:179714-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:14:36.322231] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-4178-2012/08/28-15:14:32:191275-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:15:19.256161] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-4274-2012/08/28-15:15:15:224716-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:15:22.589128] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-4625-2012/08/28-15:15:18:567116-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:16:23.613730] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat01.de.comdirect.com-4625-2012/08/28-15:15:18:567116-clvolume1-client-0-0
>[2012-08-28 15:16:23.613835] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat01.de.comdirect.com-4625-2012/08/28-15:15:18:567116-clvolume1-client-0-0
>[2012-08-28 15:16:23.613877] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat01.de.comdirect.com-4625-2012/08/28-15:15:18:567116-clvolume1-client-0-0
>[2012-08-28 15:16:31.265296] W [glusterfsd.c:831:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x7f53bdff667d] (-->/lib64/libpthread.so.0(+0x7851) [0x7f53be642851] (-->/usr/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x405cfd]))) 0-: received signum (15), shutting down
>[2012-08-28 15:16:31.265441] E [rpcsvc.c:1155:rpcsvc_program_unregister_portmap] 0-rpc-service: Could not unregister with portmap
>[2012-08-28 15:16:58.621230] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-28 15:16:58.752835] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24009'
>[2012-08-28 15:16:58.752874] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-28 15:16:58.766343] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-28 15:16:58.800749] W [posix.c:4057:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15: end-volume
> 16: 
> 17: volume clvolume1-io-threads
> 18:     type performance/io-threads
> 19:     subvolumes clvolume1-locks
> 20: end-volume
> 21: 
> 22: volume clvolume1-index
> 23:     type features/index
> 24:     option index-base /export1/.glusterfs/indices
> 25:     subvolumes clvolume1-io-threads
> 26: end-volume
> 27: 
> 28: volume clvolume1-marker
> 29:     type features/marker
> 30:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 31:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 32:     option xtime off
> 33:     option quota off
> 34:     subvolumes clvolume1-index
> 35: end-volume
> 36: 
> 37: volume /export1
> 38:     type debug/io-stats
> 39:     option latency-measurement off
> 40:     option count-fop-hits off
> 41:     subvolumes clvolume1-marker
> 42: end-volume
> 43: 
> 44: volume clvolume1-server
> 45:     type protocol/server
> 46:     option transport-type tcp
> 47:     option auth.addr./export1.allow *
> 48:     subvolumes /export1
> 49: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-28 15:17:02.571372] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-28 15:17:02.571449] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-28 15:17:02.721186] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1521-2012/08/28-15:16:58:663291-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:17:02.769857] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1527-2012/08/28-15:16:58:682023-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:17:04.363532] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-4178-2012/08/28-15:14:32:191275-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:17:04.371596] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-4173-2012/08/28-15:14:32:179714-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:17:06.337730] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1857-2012/08/28-15:17:02:266598-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:17:08.277439] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-4274-2012/08/28-15:15:15:224716-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:17:12.680905] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-4274-2012/08/28-15:15:15:224716-clvolume1-client-0-0
>[2012-08-28 15:17:12.681003] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-4274-2012/08/28-15:15:15:224716-clvolume1-client-0-0
>[2012-08-28 15:17:12.681050] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-4274-2012/08/28-15:15:15:224716-clvolume1-client-0-0
>[2012-08-28 15:17:42.371554] W [socket.c:195:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection timed out)
>[2012-08-28 15:17:42.371611] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-4173-2012/08/28-15:14:32:179714-clvolume1-client-0-0
>[2012-08-28 15:17:42.371630] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-4173-2012/08/28-15:14:32:179714-clvolume1-client-0-0
>[2012-08-28 15:17:42.371653] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-4173-2012/08/28-15:14:32:179714-clvolume1-client-0-0
>[2012-08-28 15:17:42.403442] W [socket.c:195:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection timed out)
>[2012-08-28 15:17:42.403489] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-4178-2012/08/28-15:14:32:191275-clvolume1-client-0-0
>[2012-08-28 15:17:42.403507] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-4178-2012/08/28-15:14:32:191275-clvolume1-client-0-0
>[2012-08-28 15:17:42.403529] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-4178-2012/08/28-15:14:32:191275-clvolume1-client-0-0
>[2012-08-28 15:22:07.944391] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-2379-2012/08/28-15:22:03:883017-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:22:07.975032] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-2385-2012/08/28-15:22:03:900915-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:22:45.988459] W [socket.c:195:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection timed out)
>[2012-08-28 15:22:45.988530] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-2379-2012/08/28-15:22:03:883017-clvolume1-client-0-0
>[2012-08-28 15:22:45.988552] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-2379-2012/08/28-15:22:03:883017-clvolume1-client-0-0
>[2012-08-28 15:22:45.988585] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-2379-2012/08/28-15:22:03:883017-clvolume1-client-0-0
>[2012-08-28 15:22:46.015493] W [socket.c:195:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection timed out)
>[2012-08-28 15:22:46.015557] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-2385-2012/08/28-15:22:03:900915-clvolume1-client-0-0
>[2012-08-28 15:22:46.015597] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-2385-2012/08/28-15:22:03:900915-clvolume1-client-0-0
>[2012-08-28 15:22:46.015629] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-2385-2012/08/28-15:22:03:900915-clvolume1-client-0-0
>[2012-08-28 15:26:44.464887] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1574-2012/08/28-15:26:40:401346-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:26:44.542800] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1582-2012/08/28-15:26:40:425135-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-28 15:26:48.072965] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1906-2012/08/28-15:26:43:993720-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-29 09:29:29.068817] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat01.de.comdirect.com-1857-2012/08/28-15:17:02:266598-clvolume1-client-0-0
>[2012-08-29 09:29:29.068876] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat01.de.comdirect.com-1857-2012/08/28-15:17:02:266598-clvolume1-client-0-0
>[2012-08-29 09:29:29.068907] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat01.de.comdirect.com-1857-2012/08/28-15:17:02:266598-clvolume1-client-0-0
>[2012-08-29 09:29:38.879337] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-1906-2012/08/28-15:26:43:993720-clvolume1-client-0-0
>[2012-08-29 09:29:38.879397] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-1906-2012/08/28-15:26:43:993720-clvolume1-client-0-0
>[2012-08-29 09:29:38.879424] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1906-2012/08/28-15:26:43:993720-clvolume1-client-0-0
>[2012-08-29 09:29:47.273234] W [socket.c:1512:__socket_proto_state_machine] 0-glusterfs: reading from socket failed. Error (Transport endpoint is not connected), peer (127.0.0.1:24007)
>[2012-08-29 09:29:47.412758] W [glusterfsd.c:831:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x7f677fe6167d] (-->/lib64/libpthread.so.0(+0x7851) [0x7f67804ad851] (-->/usr/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x405cfd]))) 0-: received signum (15), shutting down
>[2012-08-29 09:29:47.417269] I [socket.c:2315:socket_submit_request] 0-glusterfs: not connected (priv->connected = 0)
>[2012-08-29 09:29:47.417312] W [rpc-clnt.c:1498:rpc_clnt_submit] 0-glusterfs: failed to submit rpc-request (XID: 0x3x Program: Gluster Portmap, ProgVers: 1, Proc: 5) to rpc-transport (glusterfs)
>[2012-08-29 09:29:55.543025] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-29 09:29:57.627409] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24009'
>[2012-08-29 09:29:57.627453] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-29 09:29:57.658941] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-29 09:29:57.659344] W [posix.c:2074:init] 0-clvolume1-posixlocks: Volume is dangling. Please check the volume file.
>[2012-08-29 09:29:57.659501] W [posix.c:4057:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15: end-volume
> 16: 
> 17: volume clvolume1-posixlocks
> 18:     type features/posix-locks
> 19:     subvolumes clvolume1-posix
> 20: end-volume
> 21: 
> 22: volume clvolume1-io-threads
> 23:     type performance/io-threads
> 24:     subvolumes clvolume1-locks
> 25: end-volume
> 26: 
> 27: volume clvolume1-index
> 28:     type features/index
> 29:     option index-base /export1/.glusterfs/indices
> 30:     subvolumes clvolume1-io-threads
> 31: end-volume
> 32: 
> 33: volume clvolume1-marker
> 34:     type features/marker
> 35:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 36:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 37:     option xtime off
> 38:     option quota off
> 39:     subvolumes clvolume1-index
> 40: end-volume
> 41: 
> 42: volume /export1
> 43:     type debug/io-stats
> 44:     option latency-measurement off
> 45:     option count-fop-hits off
> 46:     subvolumes clvolume1-marker
> 47: end-volume
> 48: 
> 49: volume clvolume1-server
> 50:     type protocol/server
> 51:     option transport-type tcp
> 52:     option auth.addr./export1.allow *
> 53:     subvolumes /export1
> 54: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-29 09:29:58.158529] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1574-2012/08/28-15:26:40:401346-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-29 09:29:58.213544] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1582-2012/08/28-15:26:40:425135-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-29 09:29:58.855221] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-1574-2012/08/28-15:26:40:401346-clvolume1-client-0-0
>[2012-08-29 09:29:58.855263] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-1574-2012/08/28-15:26:40:401346-clvolume1-client-0-0
>[2012-08-29 09:29:58.855291] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1574-2012/08/28-15:26:40:401346-clvolume1-client-0-0
>[2012-08-29 09:29:59.532316] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-29 09:29:59.532363] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-29 09:29:59.863896] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-1582-2012/08/28-15:26:40:425135-clvolume1-client-0-0
>[2012-08-29 09:29:59.863933] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-1582-2012/08/28-15:26:40:425135-clvolume1-client-0-0
>[2012-08-29 09:29:59.863956] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1582-2012/08/28-15:26:40:425135-clvolume1-client-0-0
>[2012-08-29 09:30:01.639258] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-15662-2012/08/29-09:29:56:562726-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-29 09:30:01.642020] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-15668-2012/08/29-09:29:57:573035-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-29 09:30:04.901878] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-13451-2012/08/29-09:29:59:854889-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-29 09:30:04.961515] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-13457-2012/08/29-09:30:00:864393-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-29 09:30:05.606233] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-15739-2012/08/29-09:30:01:569288-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-29 10:30:31.924019] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-15375-2012/08/29-10:30:27:886819-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 10:24:33.687660] W [glusterfsd.c:831:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x3d9c0e767d] (-->/lib64/libpthread.so.0() [0x3d9c807851] (-->/usr/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x405cfd]))) 0-: received signum (15), shutting down
>[2012-08-30 10:24:33.687886] E [rpcsvc.c:1155:rpcsvc_program_unregister_portmap] 0-rpc-service: Could not unregister with portmap
>[2012-08-30 10:25:03.254625] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-30 10:25:03.831213] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24009'
>[2012-08-30 10:25:03.831253] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-30 10:25:03.854303] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-30 10:25:03.854555] W [posix.c:2074:init] 0-clvolume1-posixlocks: Volume is dangling. Please check the volume file.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15: end-volume
> 16: 
> 17: volume clvolume1-posixlocks
> 18:     type features/posix-locks
> 19:     subvolumes clvolume1-posix
> 20: end-volume
> 21: 
> 22: volume clvolume1-io-threads
> 23:     type performance/io-threads
> 24:     subvolumes clvolume1-locks
> 25: end-volume
> 26: 
> 27: volume clvolume1-index
> 28:     type features/index
> 29:     option index-base /export1/.glusterfs/indices
> 30:     subvolumes clvolume1-io-threads
> 31: end-volume
> 32: 
> 33: volume clvolume1-marker
> 34:     type features/marker
> 35:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 36:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 37:     option xtime off
> 38:     option quota off
> 39:     subvolumes clvolume1-index
> 40: end-volume
> 41: 
> 42: volume /export1
> 43:     type debug/io-stats
> 44:     option latency-measurement off
> 45:     option count-fop-hits off
> 46:     subvolumes clvolume1-marker
> 47: end-volume
> 48: 
> 49: volume clvolume1-server
> 50:     type protocol/server
> 51:     option transport-type tcp
> 52:     option auth.addr./export1.allow *
> 53:     subvolumes /export1
> 54: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-30 10:25:07.184247] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-30 10:25:07.184307] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-30 10:25:07.398155] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1568-2012/08/30-10:25:03:294430-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 10:25:09.162427] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1888-2012/08/30-10:24:51:974019-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 10:25:10.129711] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1571-2012/08/30-10:24:47:000775-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 10:25:10.284405] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1577-2012/08/30-10:24:47:032730-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 10:25:10.652879] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1574-2012/08/30-10:25:03:341872-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 10:25:12.305339] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1904-2012/08/30-10:25:08:185979-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 11:41:43.650824] I [glusterfsd-mgmt.c:64:mgmt_cbk_spec] 0-mgmt: Volume file changed
>[2012-08-30 11:41:43.690127] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat01.de.comdirect.com-1568-2012/08/30-10:25:03:294430-clvolume1-client-0-0
>[2012-08-30 11:41:43.690212] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat01.de.comdirect.com-1568-2012/08/30-10:25:03:294430-clvolume1-client-0-0
>[2012-08-30 11:41:43.690246] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat01.de.comdirect.com-1568-2012/08/30-10:25:03:294430-clvolume1-client-0-0
>[2012-08-30 11:41:44.696422] I [glusterfsd-mgmt.c:64:mgmt_cbk_spec] 0-mgmt: Volume file changed
>[2012-08-30 11:41:44.706323] I [glusterfsd-mgmt.c:1565:mgmt_getspec_cbk] 0-glusterfs: No change in volfile, continuing
>[2012-08-30 11:41:44.783198] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-1571-2012/08/30-10:24:47:000775-clvolume1-client-0-0
>[2012-08-30 11:41:44.783239] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-1571-2012/08/30-10:24:47:000775-clvolume1-client-0-0
>[2012-08-30 11:41:44.783266] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1571-2012/08/30-10:24:47:000775-clvolume1-client-0-0
>[2012-08-30 11:41:47.895497] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1904-2012/08/30-10:25:08:185979-clvolume1-client-0-1 (version: 3.3.0)
>[2012-08-30 11:41:48.747001] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-5099-2012/08/30-11:41:44:688526-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 11:41:49.771956] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1888-2012/08/30-10:24:51:974019-clvolume1-client-0-1 (version: 3.3.0)
>[2012-08-30 11:41:49.874547] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-4472-2012/08/30-11:41:45:785865-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 11:42:00.114147] I [glusterfsd-mgmt.c:64:mgmt_cbk_spec] 0-mgmt: Volume file changed
>[2012-08-30 11:42:00.127660] I [glusterfsd-mgmt.c:64:mgmt_cbk_spec] 0-mgmt: Volume file changed
>[2012-08-30 11:42:00.128516] I [glusterfsd-mgmt.c:1565:mgmt_getspec_cbk] 0-glusterfs: No change in volfile, continuing
>[2012-08-30 11:42:00.129638] I [glusterfsd-mgmt.c:1565:mgmt_getspec_cbk] 0-glusterfs: No change in volfile, continuing
>[2012-08-30 11:42:03.439781] I [glusterfsd-mgmt.c:64:mgmt_cbk_spec] 0-mgmt: Volume file changed
>[2012-08-30 11:42:03.450242] I [glusterfsd-mgmt.c:64:mgmt_cbk_spec] 0-mgmt: Volume file changed
>[2012-08-30 11:42:03.450974] I [glusterfsd-mgmt.c:1565:mgmt_getspec_cbk] 0-glusterfs: No change in volfile, continuing
>[2012-08-30 11:42:03.452054] I [glusterfsd-mgmt.c:1565:mgmt_getspec_cbk] 0-glusterfs: No change in volfile, continuing
>[2012-08-30 11:42:06.272888] I [glusterfsd-mgmt.c:64:mgmt_cbk_spec] 0-mgmt: Volume file changed
>[2012-08-30 11:42:06.276798] I [glusterfsd-mgmt.c:64:mgmt_cbk_spec] 0-mgmt: Volume file changed
>[2012-08-30 11:42:06.277687] I [glusterfsd-mgmt.c:1565:mgmt_getspec_cbk] 0-glusterfs: No change in volfile, continuing
>[2012-08-30 11:42:06.278948] I [glusterfsd-mgmt.c:1565:mgmt_getspec_cbk] 0-glusterfs: No change in volfile, continuing
>[2012-08-30 11:42:47.818689] W [glusterfsd.c:831:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x3d9c0e767d] (-->/lib64/libpthread.so.0() [0x3d9c807851] (-->/usr/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x405cfd]))) 0-: received signum (15), shutting down
>[2012-08-30 11:42:47.818809] E [rpcsvc.c:1155:rpcsvc_program_unregister_portmap] 0-rpc-service: Could not unregister with portmap
>[2012-08-30 11:43:16.416945] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-30 11:43:16.619432] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24009'
>[2012-08-30 11:43:16.619471] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-30 11:43:16.659900] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15: end-volume
> 16: 
> 17: volume clvolume1-io-threads
> 18:     type performance/io-threads
> 19:     subvolumes clvolume1-locks
> 20: end-volume
> 21: 
> 22: volume clvolume1-index
> 23:     type features/index
> 24:     option index-base /export1/.glusterfs/indices
> 25:     subvolumes clvolume1-io-threads
> 26: end-volume
> 27: 
> 28: volume clvolume1-marker
> 29:     type features/marker
> 30:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 31:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 32:     option xtime off
> 33:     option quota off
> 34:     subvolumes clvolume1-index
> 35: end-volume
> 36: 
> 37: volume /export1
> 38:     type debug/io-stats
> 39:     option latency-measurement off
> 40:     option count-fop-hits off
> 41:     subvolumes clvolume1-marker
> 42: end-volume
> 43: 
> 44: volume clvolume1-server
> 45:     type protocol/server
> 46:     option transport-type tcp
> 47:     option auth.addr./export1.allow *
> 48:     subvolumes /export1
> 49: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-30 11:43:20.360375] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-30 11:43:20.360410] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-30 11:43:20.391542] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1542-2012/08/30-11:43:06:259846-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 11:43:20.517832] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1580-2012/08/30-11:43:16:468321-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 11:43:20.562174] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1590-2012/08/30-11:43:16:482655-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 11:43:22.351237] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1871-2012/08/30-11:43:11:207372-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 11:43:23.609832] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1556-2012/08/30-11:43:06:297112-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 11:43:24.753697] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1920-2012/08/30-11:43:20:627322-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 12:09:32.971346] W [glusterfsd.c:831:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x3d9c0e767d] (-->/lib64/libpthread.so.0() [0x3d9c807851] (-->/usr/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x405cfd]))) 0-: received signum (15), shutting down
>[2012-08-30 12:09:32.971516] E [rpcsvc.c:1155:rpcsvc_program_unregister_portmap] 0-rpc-service: Could not unregister with portmap
>[2012-08-30 12:10:01.968364] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-30 12:10:02.211181] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24009'
>[2012-08-30 12:10:02.211217] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-30 12:10:02.276895] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-30 12:10:02.298572] W [posix.c:4057:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15: end-volume
> 16: 
> 17: volume clvolume1-io-threads
> 18:     type performance/io-threads
> 19:     subvolumes clvolume1-locks
> 20: end-volume
> 21: 
> 22: volume clvolume1-index
> 23:     type features/index
> 24:     option index-base /export1/.glusterfs/indices
> 25:     subvolumes clvolume1-io-threads
> 26: end-volume
> 27: 
> 28: volume clvolume1-marker
> 29:     type features/marker
> 30:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 31:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 32:     option xtime off
> 33:     option quota off
> 34:     subvolumes clvolume1-index
> 35: end-volume
> 36: 
> 37: volume /export1
> 38:     type debug/io-stats
> 39:     option latency-measurement off
> 40:     option count-fop-hits off
> 41:     subvolumes clvolume1-marker
> 42: end-volume
> 43: 
> 44: volume clvolume1-server
> 45:     type protocol/server
> 46:     option transport-type tcp
> 47:     option auth.addr./export1.allow *
> 48:     subvolumes /export1
> 49: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-30 12:10:05.905071] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-30 12:10:05.905115] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-30 12:10:06.111860] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1588-2012/08/30-12:10:02:032893-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 12:10:08.933907] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1570-2012/08/30-12:10:00:779836-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 12:10:08.950858] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1585-2012/08/30-12:10:00:853279-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 12:10:09.164892] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1594-2012/08/30-12:10:02:064058-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 12:10:10.468241] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1906-2012/08/30-12:10:06:341538-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 12:10:11.474355] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1924-2012/08/30-12:10:07:350074-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 13:25:18.368604] W [socket.c:195:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection reset by peer)
>[2012-08-30 13:25:18.368716] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-1906-2012/08/30-12:10:06:341538-clvolume1-client-0-0
>[2012-08-30 13:25:18.368741] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-1906-2012/08/30-12:10:06:341538-clvolume1-client-0-0
>[2012-08-30 13:25:18.368774] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1906-2012/08/30-12:10:06:341538-clvolume1-client-0-0
>[2012-08-30 13:25:18.933651] W [socket.c:195:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection reset by peer)
>[2012-08-30 13:25:18.933712] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-1570-2012/08/30-12:10:00:779836-clvolume1-client-0-0
>[2012-08-30 13:25:18.933750] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-1570-2012/08/30-12:10:00:779836-clvolume1-client-0-0
>[2012-08-30 13:25:18.933778] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1570-2012/08/30-12:10:00:779836-clvolume1-client-0-0
>[2012-08-30 13:25:18.991623] W [socket.c:195:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection reset by peer)
>[2012-08-30 13:25:18.991668] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-1585-2012/08/30-12:10:00:853279-clvolume1-client-0-0
>[2012-08-30 13:25:18.991686] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-1585-2012/08/30-12:10:00:853279-clvolume1-client-0-0
>[2012-08-30 13:25:18.991708] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1585-2012/08/30-12:10:00:853279-clvolume1-client-0-0
>[2012-08-30 13:25:23.181994] W [glusterfsd.c:831:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x3d9c0e767d] (-->/lib64/libpthread.so.0() [0x3d9c807851] (-->/usr/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x405cfd]))) 0-: received signum (15), shutting down
>[2012-08-30 13:25:23.182140] E [rpcsvc.c:1155:rpcsvc_program_unregister_portmap] 0-rpc-service: Could not unregister with portmap
>[2012-08-30 13:25:50.862665] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-30 13:25:51.175078] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24009'
>[2012-08-30 13:25:51.175125] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-30 13:25:51.462089] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-30 13:25:51.504462] W [posix.c:4057:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15: end-volume
> 16: 
> 17: volume clvolume1-io-threads
> 18:     type performance/io-threads
> 19:     subvolumes clvolume1-locks
> 20: end-volume
> 21: 
> 22: volume clvolume1-index
> 23:     type features/index
> 24:     option index-base /export1/.glusterfs/indices
> 25:     subvolumes clvolume1-io-threads
> 26: end-volume
> 27: 
> 28: volume clvolume1-marker
> 29:     type features/marker
> 30:     option volume-uuid 2a1af2f9-fd78-4c55-b2c6-d54df668db7d
> 31:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 32:     option xtime off
> 33:     option quota off
> 34:     subvolumes clvolume1-index
> 35: end-volume
> 36: 
> 37: volume /export1
> 38:     type debug/io-stats
> 39:     option latency-measurement off
> 40:     option count-fop-hits off
> 41:     subvolumes clvolume1-marker
> 42: end-volume
> 43: 
> 44: volume clvolume1-server
> 45:     type protocol/server
> 46:     option transport-type tcp
> 47:     option auth.addr./export1.allow *
> 48:     subvolumes /export1
> 49: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-30 13:25:54.810476] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-30 13:25:54.810551] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-30 13:25:55.047616] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1564-2012/08/30-13:25:50:958130-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 13:25:56.019492] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1558-2012/08/30-13:25:50:901418-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 13:25:56.627384] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1571-2012/08/30-13:25:21:543277-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 13:25:56.701458] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1584-2012/08/30-13:25:21:586384-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 13:25:59.590736] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1913-2012/08/30-13:25:55:459994-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 13:26:00.886703] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1905-2012/08/30-13:25:25:758077-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:30:55.078757] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-1905-2012/08/30-13:25:25:758077-clvolume1-client-0-0
>[2012-08-30 15:30:55.078924] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-1905-2012/08/30-13:25:25:758077-clvolume1-client-0-0
>[2012-08-30 15:30:55.078981] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-1905-2012/08/30-13:25:25:758077-clvolume1-client-0-0
>[2012-08-30 15:31:25.944902] W [glusterfsd.c:831:cleanup_and_exit] (-->/usr/lib64/libgfrpc.so.0(rpcsvc_notify+0x93) [0x3d9dc0a5b3] (-->/usr/lib64/libgfrpc.so.0(rpcsvc_handle_rpc_call+0x293) [0x3d9dc0a443] (-->/usr/sbin/glusterfsd(glusterfs_handle_terminate+0x15) [0x40a915]))) 0-: received signum (15), shutting down
>[2012-08-30 15:38:24.021332] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-30 15:38:26.062383] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24013'
>[2012-08-30 15:38:26.062431] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-30 15:38:26.086537] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-30 15:38:26.086999] W [posix.c:4057:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id b06f990b-938d-4069-905f-132995f9f360
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15: end-volume
> 16: 
> 17: volume clvolume1-io-threads
> 18:     type performance/io-threads
> 19:     subvolumes clvolume1-locks
> 20: end-volume
> 21: 
> 22: volume clvolume1-index
> 23:     type features/index
> 24:     option index-base /export1/.glusterfs/indices
> 25:     subvolumes clvolume1-io-threads
> 26: end-volume
> 27: 
> 28: volume clvolume1-marker
> 29:     type features/marker
> 30:     option volume-uuid b06f990b-938d-4069-905f-132995f9f360
> 31:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 32:     option xtime off
> 33:     option quota off
> 34:     subvolumes clvolume1-index
> 35: end-volume
> 36: 
> 37: volume /export1
> 38:     type debug/io-stats
> 39:     option latency-measurement off
> 40:     option count-fop-hits off
> 41:     subvolumes clvolume1-marker
> 42: end-volume
> 43: 
> 44: volume clvolume1-server
> 45:     type protocol/server
> 46:     option transport-type tcp
> 47:     option auth.login./export1.allow 80380ece-d6d0-45a1-8803-9958be88c429
> 48:     option auth.login.80380ece-d6d0-45a1-8803-9958be88c429.password ea1d8e96-f47e-463f-a3c8-099d8c750224
> 49:     option auth.addr./export1.allow *
> 50:     subvolumes /export1
> 51: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-30 15:38:27.943988] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-30 15:38:27.944076] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-30 15:38:30.079132] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-2576-2012/08/30-15:38:25:039939-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:38:30.125970] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-2582-2012/08/30-15:38:26:050267-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:38:32.188108] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-2189-2012/08/30-15:38:27:122041-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:38:32.213470] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-2195-2012/08/30-15:38:28:131735-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:39:50.622976] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-2423-2012/08/30-15:39:46:590223-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:40:04.462365] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-3165-2012/08/30-15:40:00:420325-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:40:50.948318] W [glusterfsd.c:831:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x3d9c0e767d] (-->/lib64/libpthread.so.0() [0x3d9c807851] (-->/usr/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x405cfd]))) 0-: received signum (15), shutting down
>[2012-08-30 15:40:50.948475] E [rpcsvc.c:1155:rpcsvc_program_unregister_portmap] 0-rpc-service: Could not unregister with portmap
>[2012-08-30 15:41:17.515025] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-30 15:41:17.780312] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24013'
>[2012-08-30 15:41:17.780350] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-30 15:41:17.910655] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-30 15:41:17.984491] W [posix.c:4057:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id b06f990b-938d-4069-905f-132995f9f360
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15: end-volume
> 16: 
> 17: volume clvolume1-io-threads
> 18:     type performance/io-threads
> 19:     subvolumes clvolume1-locks
> 20: end-volume
> 21: 
> 22: volume clvolume1-index
> 23:     type features/index
> 24:     option index-base /export1/.glusterfs/indices
> 25:     subvolumes clvolume1-io-threads
> 26: end-volume
> 27: 
> 28: volume clvolume1-marker
> 29:     type features/marker
> 30:     option volume-uuid b06f990b-938d-4069-905f-132995f9f360
> 31:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 32:     option xtime off
> 33:     option quota off
> 34:     subvolumes clvolume1-index
> 35: end-volume
> 36: 
> 37: volume /export1
> 38:     type debug/io-stats
> 39:     option latency-measurement off
> 40:     option count-fop-hits off
> 41:     subvolumes clvolume1-marker
> 42: end-volume
> 43: 
> 44: volume clvolume1-server
> 45:     type protocol/server
> 46:     option transport-type tcp
> 47:     option auth.login./export1.allow 80380ece-d6d0-45a1-8803-9958be88c429
> 48:     option auth.login.80380ece-d6d0-45a1-8803-9958be88c429.password ea1d8e96-f47e-463f-a3c8-099d8c750224
> 49:     option auth.addr./export1.allow *
> 50:     subvolumes /export1
> 51: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-30 15:41:20.225361] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-2189-2012/08/30-15:38:27:122041-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:41:20.287867] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-2195-2012/08/30-15:38:28:131735-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:41:21.434757] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 14
>[2012-08-30 15:41:21.434804] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-30 15:41:21.651846] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1561-2012/08/30-15:41:17:555257-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:41:21.678234] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1568-2012/08/30-15:41:17:575693-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:41:25.753405] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1893-2012/08/30-15:41:21:601360-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:41:52.287606] W [socket.c:195:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection reset by peer)
>[2012-08-30 15:41:52.287648] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-2189-2012/08/30-15:38:27:122041-clvolume1-client-0-0
>[2012-08-30 15:41:52.287666] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-2189-2012/08/30-15:38:27:122041-clvolume1-client-0-0
>[2012-08-30 15:41:52.287695] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-2189-2012/08/30-15:38:27:122041-clvolume1-client-0-0
>[2012-08-30 15:41:52.332649] W [socket.c:195:__socket_rwv] 0-tcp.clvolume1-server: readv failed (Connection reset by peer)
>[2012-08-30 15:41:52.332699] I [server.c:685:server_rpc_notify] 0-clvolume1-server: disconnecting connectionfrom cdusat02.de.comdirect.com-2195-2012/08/30-15:38:28:131735-clvolume1-client-0-0
>[2012-08-30 15:41:52.332719] I [server-helpers.c:741:server_connection_put] 0-clvolume1-server: Shutting down connection cdusat02.de.comdirect.com-2195-2012/08/30-15:38:28:131735-clvolume1-client-0-0
>[2012-08-30 15:41:52.332742] I [server-helpers.c:629:server_connection_destroy] 0-clvolume1-server: destroyed connection of cdusat02.de.comdirect.com-2195-2012/08/30-15:38:28:131735-clvolume1-client-0-0
>[2012-08-30 15:41:59.484081] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1600-2012/08/30-15:41:55:425944-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:41:59.510420] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1612-2012/08/30-15:41:55:439499-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 15:42:03.404821] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1926-2012/08/30-15:41:59:249695-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 16:02:21.172143] W [glusterfsd.c:831:cleanup_and_exit] (-->/lib64/libc.so.6(clone+0x6d) [0x3d9c0e767d] (-->/lib64/libpthread.so.0() [0x3d9c807851] (-->/usr/sbin/glusterfsd(glusterfs_sigwaiter+0xdd) [0x405cfd]))) 0-: received signum (15), shutting down
>[2012-08-30 16:02:21.172315] E [rpcsvc.c:1155:rpcsvc_program_unregister_portmap] 0-rpc-service: Could not unregister with portmap
>[2012-08-30 16:02:49.576507] I [glusterfsd.c:1666:main] 0-/usr/sbin/glusterfsd: Started running /usr/sbin/glusterfsd version 3.3.0
>[2012-08-30 16:02:49.863868] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-server: adding option 'listen-port' for volume 'clvolume1-server' with value '24013'
>[2012-08-30 16:02:49.863944] I [graph.c:241:gf_add_cmdline_options] 0-clvolume1-posix: adding option 'glusterd-uuid' for volume 'clvolume1-posix' with value 'e971f0ba-0ead-49e1-82ad-dacefa4755be'
>[2012-08-30 16:02:50.061106] W [options.c:782:xl_opt_validate] 0-clvolume1-server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
>[2012-08-30 16:02:50.089070] W [posix.c:4057:init] 0-clvolume1-posix: Posix access control list is not supported.
>Given volfile:
>+------------------------------------------------------------------------------+
>  1: volume clvolume1-posix
>  2:     type storage/posix
>  3:     option directory /export1
>  4:     option volume-id b06f990b-938d-4069-905f-132995f9f360
>  5: end-volume
>  6: 
>  7: volume clvolume1-access-control
>  8:     type features/access-control
>  9:     subvolumes clvolume1-posix
> 10: end-volume
> 11: 
> 12: volume clvolume1-locks
> 13:     type features/locks
> 14:     subvolumes clvolume1-access-control
> 15:     option trace on
> 16: end-volume
> 17: 
> 18: volume clvolume1-io-threads
> 19:     type performance/io-threads
> 20:     subvolumes clvolume1-locks
> 21: end-volume
> 22: 
> 23: volume clvolume1-index
> 24:     type features/index
> 25:     option index-base /export1/.glusterfs/indices
> 26:     subvolumes clvolume1-io-threads
> 27: end-volume
> 28: 
> 29: volume clvolume1-marker
> 30:     type features/marker
> 31:     option volume-uuid b06f990b-938d-4069-905f-132995f9f360
> 32:     option timestamp-file /var/lib/glusterd/vols/clvolume1/marker.tstamp
> 33:     option xtime off
> 34:     option quota off
> 35:     subvolumes clvolume1-index
> 36: end-volume
> 37: 
> 38: volume /export1
> 39:     type debug/io-stats
> 40:     option latency-measurement off
> 41:     option count-fop-hits off
> 42:     subvolumes clvolume1-marker
> 43: end-volume
> 44: 
> 45: volume clvolume1-server
> 46:     type protocol/server
> 47:     option transport-type tcp
> 48:     option auth.login./export1.allow 80380ece-d6d0-45a1-8803-9958be88c429
> 49:     option auth.login.80380ece-d6d0-45a1-8803-9958be88c429.password ea1d8e96-f47e-463f-a3c8-099d8c750224
> 50:     option auth.addr./export1.allow *
> 51:     subvolumes /export1
> 52: end-volume
>
>+------------------------------------------------------------------------------+
>[2012-08-30 16:02:53.483062] W [socket.c:410:__socket_keepalive] 0-socket: failed to set keep idle on socket 8
>[2012-08-30 16:02:53.483106] W [socket.c:1876:socket_server_event_handler] 0-socket.glusterfsd: Failed to set keep-alive: Operation not supported
>[2012-08-30 16:02:53.706500] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1552-2012/08/30-16:02:49:620443-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 16:02:53.786775] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1565-2012/08/30-16:02:37:628287-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 16:02:53.811448] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1563-2012/08/30-16:02:49:656626-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 16:02:56.739953] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1582-2012/08/30-16:02:37:660577-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 16:02:57.041783] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat02.de.comdirect.com-1901-2012/08/30-16:02:41:923323-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 16:02:58.022504] I [server-handshake.c:571:server_setvolume] 0-clvolume1-server: accepted client from cdusat01.de.comdirect.com-1885-2012/08/30-16:02:53:858980-clvolume1-client-0-0 (version: 3.3.0)
>[2012-08-30 16:09:56.412615] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511616700, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=28} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:09:56.412697] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511616700, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=28} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:09:56.413112] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=29} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:09:56.413450] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=30} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:09:56.413491] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=2727, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=30} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:09:56.413788] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:09:57.609015] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511614616, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=42} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:09:57.609065] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511614616, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=42} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:09:57.609302] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=43} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:09:57.609557] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=44} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:09:57.609596] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=2727, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=44} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:09:57.609859] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:09:57.617215] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=085a2726f7a39496, Transport=0x1460760, Frame=47} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLKW, type=READ, start=23596, len=0, pid=2727, lk-owner=085a2726f7a39496}
>[2012-08-30 16:09:57.617277] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=2727, lk-owner=085a2726f7a39496, Transport=0x1460760, Frame=47} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLKW, type=READ, start=23596, len=0, pid=2727, lk-owner=085a2726f7a39496}
>[2012-08-30 16:09:57.633217] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=48} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:09:57.633260] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=48} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:02.646947] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=49} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:02.647032] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=49} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:07.653263] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=50} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:07.661921] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=50} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:12.663344] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=51} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:12.663398] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=51} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:17.670312] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=52} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:17.670365] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=52} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:22.676783] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=53} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:22.676837] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=53} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:27.679017] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=58} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:27.679078] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=58} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:32.685472] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=59} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:32.685526] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=59} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:37.686913] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=60} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:37.686990] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=60} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:42.693268] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=61} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:42.693340] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=61} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:47.699839] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=62} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:47.699901] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=62} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:52.706229] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=63} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:52.706281] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=63} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:57.712806] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=64} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:10:57.712866] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=64} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:02.719180] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=65} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:02.719234] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=65} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:07.725679] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=66} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:07.725733] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=66} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:12.732080] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=68} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:12.732136] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=68} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:17.738923] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=69} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:17.739010] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=69} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:22.745480] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=70} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:22.745536] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=70} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2727, lk-owner=47a1bfda0ae9dd09}
>[2012-08-30 16:11:27.072088] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511612532, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=71} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:11:27.072228] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511612532, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=71} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:11:27.072680] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=2727, lk-owner=47a1bfda0ae9dd09, Transport=0x1460760, Frame=72} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:11:27.072992] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2727, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=73} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:11:27.073036] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=2727, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=73} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:11:27.073395] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:15:10.834927] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511608364, lk-owner=2ca033f4437f0000, Transport=0x1460760, Frame=119} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:15:10.835013] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511608364, lk-owner=2ca033f4437f0000, Transport=0x1460760, Frame=119} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:15:10.835262] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=120} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:15:10.835440] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=2ca033f4437f0000, Transport=0x1460760, Frame=121} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:15:10.835480] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=2803, lk-owner=2ca033f4437f0000, Transport=0x1460760, Frame=121} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:15:10.835700] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:15:11.919048] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511612532, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=134} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:15:11.919131] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511612532, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=134} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:15:11.919402] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=135} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:15:11.919687] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=136} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:15:11.919750] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=2803, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=136} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:15:11.920042] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:15:11.926424] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=7c258ce5198bf1ee, Transport=0x1460760, Frame=139} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLKW, type=READ, start=23596, len=0, pid=2803, lk-owner=7c258ce5198bf1ee}
>[2012-08-30 16:15:11.926498] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=2803, lk-owner=7c258ce5198bf1ee, Transport=0x1460760, Frame=139} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLKW, type=READ, start=23596, len=0, pid=2803, lk-owner=7c258ce5198bf1ee}
>[2012-08-30 16:15:11.944204] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=140} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:11.944268] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=140} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:16.950534] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=141} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:16.950633] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=141} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:21.956933] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=142} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:21.957299] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=142} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:26.963536] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=143} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:26.963631] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=143} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:31.969699] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=144} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:31.970044] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=144} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:36.971559] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=145} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:36.971689] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=145} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:41.973481] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=149} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:41.973545] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=149} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:46.979902] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=150} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:46.979957] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=150} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:51.986240] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=151} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:51.986295] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=151} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:56.992652] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=153} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:15:56.992808] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=153} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:16:01.999237] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=154} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:16:01.999293] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=154} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:16:07.001183] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=155} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:16:07.001241] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=155} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:16:12.007994] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=156} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:16:12.008050] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=156} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=2803, lk-owner=9c1b8784017e12dd}
>[2012-08-30 16:16:15.068507] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511618784, lk-owner=e0c833f4437f0000, Transport=0x1460760, Frame=157} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:16:15.068569] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511618784, lk-owner=e0c833f4437f0000, Transport=0x1460760, Frame=157} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:16:15.069739] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=2803, lk-owner=9c1b8784017e12dd, Transport=0x1460760, Frame=158} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-30 16:16:15.070046] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=2803, lk-owner=e0c833f4437f0000, Transport=0x1460760, Frame=159} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:16:15.070092] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=2803, lk-owner=e0c833f4437f0000, Transport=0x1460760, Frame=159} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-30 16:16:15.070312] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:25:48.162847] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511616700, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=177} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:25:48.162916] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511616700, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=177} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:25:48.163255] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=178} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:25:48.163449] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=179} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:25:48.163482] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=17840, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=179} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:25:48.163634] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:25:48.250857] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=46f8f8dfebd27e95, Transport=0x1460760, Frame=188} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLKW, type=READ, start=23596, len=0, pid=17840, lk-owner=46f8f8dfebd27e95}
>[2012-08-31 17:25:48.250894] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=17840, lk-owner=46f8f8dfebd27e95, Transport=0x1460760, Frame=188} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLKW, type=READ, start=23596, len=0, pid=17840, lk-owner=46f8f8dfebd27e95}
>[2012-08-31 17:25:48.269418] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=189} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:25:48.269446] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=189} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:25:53.276267] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=190} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:25:53.276322] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=190} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:25:58.283290] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=191} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:25:58.283354] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=191} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:03.286569] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=192} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:03.286638] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=192} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:08.292998] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=193} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:08.293274] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=193} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:13.300106] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=194} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:13.300182] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=194} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:18.302872] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=198} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:18.302937] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=198} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:23.310024] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=199} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:23.310100] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=199} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:28.317202] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=200} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:28.317297] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=200} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:33.324103] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=201} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:33.324165] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=201} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:38.331070] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=203} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:38.331133] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=203} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:43.338041] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=204} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:43.338104] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=204} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:48.341476] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=205} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:48.341719] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=205} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:53.348560] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=206} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:53.348637] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=206} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:58.355074] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=207} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:26:58.355117] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=207} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17840, lk-owner=8682e81f3c3e1b02}
>[2012-08-31 17:27:01.747425] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511614616, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=208} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:27:01.747488] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511614616, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=208} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:27:01.749608] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=17840, lk-owner=8682e81f3c3e1b02, Transport=0x1460760, Frame=209} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:27:01.749933] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17840, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=210} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:27:01.749977] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=17840, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=210} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:27:01.750304] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:27:03.750461] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511616700, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=216} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:27:03.750519] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511616700, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=216} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:27:03.750847] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=17888, lk-owner=9f74ffd89e91e7a3, Transport=0x1460760, Frame=217} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:27:03.751172] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17888, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=218} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:27:03.751280] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=17888, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=218} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:27:03.751580] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:28:09.898074] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511614616, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=292} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:28:09.898136] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511614616, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=292} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:28:09.898534] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=293} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:28:09.898851] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=294} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:28:09.898912] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=17932, lk-owner=98b833f4437f0000, Transport=0x1460760, Frame=294} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:28:09.899195] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:28:10.102697] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511618784, lk-owner=e0c833f4437f0000, Transport=0x1460760, Frame=303} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:28:10.102764] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511618784, lk-owner=e0c833f4437f0000, Transport=0x1460760, Frame=303} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:28:10.103167] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=304} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:28:10.103515] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e0c833f4437f0000, Transport=0x1460760, Frame=305} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:28:10.103568] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=17932, lk-owner=e0c833f4437f0000, Transport=0x1460760, Frame=305} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:28:10.103888] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:28:10.119735] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=87a0ebe530905efd, Transport=0x1460760, Frame=308} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLKW, type=READ, start=23596, len=0, pid=17932, lk-owner=87a0ebe530905efd}
>[2012-08-31 17:28:10.119792] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=17932, lk-owner=87a0ebe530905efd, Transport=0x1460760, Frame=308} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLKW, type=READ, start=23596, len=0, pid=17932, lk-owner=87a0ebe530905efd}
>[2012-08-31 17:28:10.172975] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=317} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:10.173075] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=317} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:15.180159] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=318} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:15.180267] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=318} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:20.182711] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=319} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:20.182785] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=319} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:25.189745] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=320} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:25.189815] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=320} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:30.196829] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=321} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:30.196891] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=321} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:35.203859] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=322} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:35.203929] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=322} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:40.206504] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=326} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:40.206559] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=326} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:45.213669] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=327} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:45.213730] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=327} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:50.220706] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=328} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:50.220780] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=328} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:55.227419] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=329} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:28:55.227639] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=329} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:00.234780] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=331} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:00.234851] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=331} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:05.241709] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=332} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:05.241774] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=332} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:10.248059] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=333} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:10.248125] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=333} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:15.255077] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=334} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:15.255144] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=334} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:20.262192] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=335} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:20.262293] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=335} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:25.269191] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=336} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:25.269301] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [TRYAGAIN] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=336} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=FCNTL, cmd=SETLK, type=WRITE, start=2147483539, len=1, pid=17932, lk-owner=e3fc7e049959b2d0}
>[2012-08-31 17:29:25.745755] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511612532, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=337} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:29:25.745812] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511612532, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=337} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:29:25.746420] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=17932, lk-owner=e3fc7e049959b2d0, Transport=0x1460760, Frame=338} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:29:25.746768] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17932, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=339} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:29:25.746815] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=17932, lk-owner=74b033f4437f0000, Transport=0x1460760, Frame=339} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:29:25.747127] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:29:27.805077] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=18446744073511616700, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=357} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:29:27.805134] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=18446744073511616700, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=357} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=WRITE, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:29:27.805496] I [common.c:378:pl_trace_flush] 0-clvolume1-locks: [FLUSH] Locker = {Pid=17963, lk-owner=d96e99c98486937a, Transport=0x1460760, Frame=358} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}
>[2012-08-31 17:29:27.805865] I [common.c:271:pl_trace_in] 0-clvolume1-locks: [REQUEST] Locker = {Pid=17963, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=359} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:29:27.805910] I [common.c:323:pl_trace_out] 0-clvolume1-locks: [GRANTED] Locker = {Pid=17963, lk-owner=bcc033f4437f0000, Transport=0x1460760, Frame=359} Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls} Lock = {lock=INODELK, cmd=SETLK, type=UNLOCK, domain: clvolume1-replicate-0, start=0, len=0, pid=0}
>[2012-08-31 17:29:27.806271] I [common.c:395:pl_trace_release] 0-clvolume1-locks: [RELEASE] Lockee = {gfid=f093990d-e7c9-4a95-8f04-2d8895574501, fd=0x1444afc, path=/test/lpar_report_20120809.xls}

Actions: View

Attachments on bug 802423: 608548 | 608549 | 608550 | 609273 | 609275 | 609277 | 609279