Gridftp-examples

From CEDPS

Here are suggested sample GridFTP logs for different logging levels.

Note the client logs should be the same, except that default is no logging.

Default Server logs:

ts=2007-08-23T14:06:26.707679Z id=32177 event=globus-gridftp-server.child.start c.id=32179
ts=2007-08-23T14:06:26.737713Z id=32179 event=globus-gridftp-server.configuration.start
ts=2007-08-23T14:06:26.738002Z id=32179 event=globus-gridftp-server.configuration.end configfile=/etc/grid-security/gridftp.conf status=0
ts=2007-08-23T14:06:26.740370Z id=32179 event=globus-gridftp-server.start mode=inetd contact=mldev.mcs.anl.gov:5002
ts=2007-08-23T14:06:26.740374Z id=32179 event=globus-gridftp-server.session.start remotehost=mldev.mcs.anl.gov:55560
ts=2007-08-23T14:06:26.741054Z id=32179 event=globus-gridftp-server.session.authn.start
ts=2007-08-23T14:06:26.951926Z id=32179 event=globus-gridftp-server.session.authn.end user=:globus-mapping: DN="/DC=org/DC=doegrids/OU=People/CN=Michael Link" status=0
ts=2007-08-23T14:06:26.952022Z id=32179 event=globus-gridftp-server.session.authz.start user=:globus-mapping:DN="/DC=org/DC=doegrids/OU=People/CN=Michael Link"
ts=2007-08-23T14:06:26.955290Z id=32179 event=globus-gridftp-server.session.authz.end localuser=mlink DN="/DC=org/DC=doegrids/OU=People/CN=Michael Link" status=0
ts=2007-08-23T14:06:27.009671Z id=32179 event=globus-gridftp-server.transfer.start file="/dev/zero"
ts=2007-08-23T14:06:27.409272Z id=32179 event=globus-gridftp-server.transfer.end localuser=mlink file=/dev/zero tcpbuffer=87664 blocksize=262144 bytes=20971520 streams=1 stripes=1 remoteIP=10.1.1.128 type=ERET  status=0 ts=2007-08-23T14:06:27.422656Z id=32179 event=globus-gridftp-server.session.end remotehost=mldev.mcs.anl.gov:55560 status=0
ts=2007-08-23T14:06:27.423149Z id=32179 event=globus-gridftp-server.end status=0
ts=2007-08-23T14:06:27.428324Z id=32177 event=globus-gridftp-server.child.end c.id=32179 exitcode=0 status=0

Server logs + 'bottleneck' summary option; same at above, plus something like this at the end:

ts=2007-10-19T20:51:10.918573Z event=transfer.disk.write.summ level=INFO guid=0 stream.id=1 n=194 nv=194 dur=9.065035 t.m=0.009369 t.x=0.019603 t.s=2.252600 t.sd=0.002878 v.m=262144.000000 v.x=262144.000000 v.s=50855936.000000 v.sd=0.000000 r.m=13372647.043820 r.x=27979933.824314 r.s=4589372127.414373 r.sd=4413926.331186
ts=2007-10-19T20:51:10.918824Z event=transfer.net.read.summ level=INFO guid=0 stream.id=1 n=49 nv=49 dur=9.685020 t.m=0.127064 t.x=0.642231 t.s=9.683142 t.sd=0.094449 v.m=262140.000000 v.x=262140.000000 v.s=12844860.000000 v.sd=0.000000 r.m=408170.891782 r.x=2063054.838507 r.s=74640068.731048 r.sd=475928.497465
ts=2007-10-19T20:51:10.918880Z event=transfer.net.read.summ level=INFO guid=0 stream.id=2 n=48 nv=48 dur=9.565483 t.m=0.127684 t.x=0.642209 t.s=9.563758 t.sd=0.094322 v.m=262140.000000 v.x=262140.000000 v.s=12582720.000000 v.sd=0.000000 r.m=408184.874394 r.x=2053037.185552 r.s=72294143.251418 r.sd=466673.049573
ts=2007-10-19T20:51:10.918937Z event=transfer.net.read.summ level=INFO guid=0 stream.id=3 n=49 nv=49 dur=9.694512 t.m=0.127843 t.x=0.642044 t.s=9.693452 t.sd=0.094750 v.m=262140.000000 v.x=262140.000000 v.s=12844860.000000 v.sd=0.000000 r.m=408289.774533 r.x=2050483.796532 r.s=74790864.447571 r.sd=486406.891322
 

Server logs + interval option:

Same as above, plus the ".summ" events every N seconds

Server logs with full logging option; logs like this for ALL IO:

ts=2007-10-19T21:03:41.058242Z event=transfer.disk.write.start level=DEBUG guid=8a08ec76-1179-41ca-bff4-b8e532d4c8b4 stream.id=1 block.id=2
ts=2007-10-19T21:03:41.078182Z event=transfer.disk.write.end level=DEBUG guid=8a08ec76-1179-41ca-bff4-b8e532d4c8b4 stream.id=1 block.id=2 bytes=262144.000000
ts=2007-10-19T21:03:41.342079Z event=transfer.net.read.start level=DEBUG guid=8a08ec76-1179-41ca-bff4-b8e532d4c8b4 stream.id=1 block.id=8
ts=2007-10-19T21:03:41.344179Z event=transfer.net.read.end level=DEBUG guid=8a08ec76-1179-41ca-bff4-b8e532d4c8b4 stream.id=2 block.id=5 bytes=262140.000000