Results 1 to 7 of 7

Thread: RTMP output packet time debugging & ingestion packet timecode debugging

  1. #1
    Join Date
    Dec 2011
    Posts
    24

    Question RTMP output packet time debugging & ingestion packet timecode debugging

    Hi,

    Wowza Media Server 3.0.5 build1220 (16 February 2012) introduces:

    RTMP output packet time debugging (Streams/Property debugOutgoingRTMPPacketTimes)
    ingestion packet timecode debugging (Streams/Property debugIncomingPacketTimes)

    Can You explain how to utilize this debugging features ?

  2. #2
    Join Date
    Sep 2011
    Posts
    1,933

    Default

    Hi
    At a guess i would try to utilise it like this,
    Under the section /Streams/Properties/ add this property:

    <Property>
    <Name>debugOutgoingRTMPPacketTimes</Name>
    <Value>true</Value>
    <Type>Boolean</Type>
    </Property>

    <Property>
    <Name>debugIncomingPacketTimes</Name>
    <Value>true</Value>
    <Type>Boolean</Type>
    </Property>

    Let me know if that works.

    Jason

  3. #3
    Join Date
    Dec 2011
    Posts
    24

    Default

    This is great I can see debug output in logs.

    Can You explain in more detail what is meaning of logged fields ?

  4. #4
    Join Date
    Sep 2011
    Posts
    1,933

    Default

    Hi
    You would have to post your logs to show me what you mean.

    Are you seeing that when you see the new debug output in logs?

    Jason

  5. #5
    Join Date
    Dec 2011
    Posts
    24

    Default

    It looks like this:

    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:1 dsz:29 toff:577 rt:1331741018013/1492 seq:29
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00557 tc1080/40 rt:1331741018013/ 40
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:31 toff:498 rt:1331741018014/1 seq:31
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00895 tc1120/40 rt:1331741018014/ 79
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1160/40 rt:1331741018014/ 119
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:33 toff:418 rt:1331741018014/0 seq:33
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00863 tc1200/40 rt:1331741018014/ 159
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00532 tc1240/40 rt:1331741018015/ 198
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:35 toff:339 rt:1331741018015/1 seq:35
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc1280/40 rt:1331741018015/ 238
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1320/40 rt:1331741018015/ 278
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:37 toff:260 rt:1331741018016/1 seq:37
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc1360/40 rt:1331741018016/ 317
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1400/40 rt:1331741018016/ 357
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:39 toff:180 rt:1331741018016/0 seq:39
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc1440/40 rt:1331741018016/ 397
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1480/40 rt:1331741018017/ 436
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:41 toff:101 rt:1331741018017/1 seq:41
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc1520/40 rt:1331741018017/ 476
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1560/40 rt:1331741018017/ 516
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:43 toff:22 rt:1331741018018/1 seq:43
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc1600/40 rt:1331741018018/ 555
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1640/40 rt:1331741018018/ 595
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:45 toff:-58 rt:1331741018018/0 seq:45
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc1680/40 rt:1331741018018/ 635
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1720/40 rt:1331741018019/ 674
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:47 toff:-137 rt:1331741018019/1 seq:47
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc1760/40 rt:1331741018019/ 714
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1800/40 rt:1331741018019/ 754
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:49 toff:-216 rt:1331741018020/1 seq:49
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc1840/40 rt:1331741018020/ 793
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1880/40 rt:1331741018020/ 833
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:51 toff:-296 rt:1331741018020/0 seq:51
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc1920/40 rt:1331741018021/ 872
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc1960/40 rt:1331741018021/ 912
    2012-03-14 17:03:38 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:53 toff:-375 rt:1331741018021/1 seq:53
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x17 sz:25365 tc2000/40 rt:1331741019514/-541
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:1 dsz:54 toff:1078 rt:1331741019514/1493 seq:54
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:01196 tc2040/40 rt:1331741019514/-501
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00559 tc2080/40 rt:1331741019515/-462
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:56 toff:999 rt:1331741019515/1 seq:56
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00998 tc2120/40 rt:1331741019515/-422
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00538 tc2160/40 rt:1331741019515/-382
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:58 toff:920 rt:1331741019516/1 seq:58
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00873 tc2200/40 rt:1331741019516/-343
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00534 tc2240/40 rt:1331741019516/-303
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:60 toff:840 rt:1331741019516/0 seq:60
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00925 tc2280/40 rt:1331741019516/-263
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00537 tc2320/40 rt:1331741019517/-224
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:62 toff:761 rt:1331741019517/1 seq:62
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00858 tc2360/40 rt:1331741019517/-184
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00533 tc2400/40 rt:1331741019517/-144
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:64 toff:682 rt:1331741019518/1 seq:64
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00855 tc2440/40 rt:1331741019518/-105
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00533 tc2480/40 rt:1331741019518/-65
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:66 toff:602 rt:1331741019518/0 seq:66
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00953 tc2520/40 rt:1331741019518/-25
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00538 tc2560/40 rt:1331741019519/ 14
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:68 toff:523 rt:1331741019519/1 seq:68
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00857 tc2600/40 rt:1331741019519/ 54
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00533 tc2640/40 rt:1331741019519/ 94
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:70 toff:443 rt:1331741019519/0 seq:70
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00855 tc2680/40 rt:1331741019520/ 133
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00533 tc2720/40 rt:1331741019520/ 173
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:72 toff:364 rt:1331741019520/1 seq:72
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00855 tc2760/40 rt:1331741019520/ 213
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00533 tc2800/40 rt:1331741019520/ 253
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:74 toff:285 rt:1331741019521/1 seq:74
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00855 tc2840/40 rt:1331741019521/ 292
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00533 tc2880/40 rt:1331741019521/ 332
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:76 toff:205 rt:1331741019521/0 seq:76
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00855 tc2920/40 rt:1331741019521/ 372
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00533 tc2960/40 rt:1331741019522/ 411
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:78 toff:126 rt:1331741019522/1 seq:78
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x17 sz:25359 tc3000/40 rt:1331741019522/ 451
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:01187 tc3040/40 rt:1331741019522/ 491
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:80 toff:47 rt:1331741019523/1 seq:80
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00557 tc3080/40 rt:1331741019523/ 530
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00895 tc3120/40 rt:1331741019523/ 570
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:82 toff:-33 rt:1331741019523/0 seq:82
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc3160/40 rt:1331741019523/ 610
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00863 tc3200/40 rt:1331741019524/ 649
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:84 toff:-112 rt:1331741019524/1 seq:84
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00532 tc3240/40 rt:1331741019524/ 689
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc3280/40 rt:1331741019524/ 729
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:86 toff:-192 rt:1331741019524/0 seq:86
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc3320/40 rt:1331741019525/ 768
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc3360/40 rt:1331741019525/ 808
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:88 toff:-271 rt:1331741019525/1 seq:88
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc3400/40 rt:1331741019525/ 848
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00852 tc3440/40 rt:1331741019525/ 888
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:90 toff:-350 rt:1331741019526/1 seq:90
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc3480/40 rt:1331741019526/ 927
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00869 tc3520/40 rt:1331741019526/ 967
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:92 toff:-430 rt:1331741019526/0 seq:92
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00536 tc3560/40 rt:1331741019526/ 1007
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00886 tc3600/40 rt:1331741019527/ 1046
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:94 toff:-509 rt:1331741019527/1 seq:94
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00533 tc3640/40 rt:1331741019527/ 1086
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00886 tc3680/40 rt:1331741019527/ 1126
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:96 toff:-589 rt:1331741019527/0 seq:96
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc3720/40 rt:1331741019528/ 1165
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00870 tc3760/40 rt:1331741019531/ 1202
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:98 toff:-665 rt:1331741019531/4 seq:98
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00531 tc3800/40 rt:1331741019531/ 1242
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00870 tc3840/40 rt:1331741019531/ 1282
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:100 toff:-744 rt:1331741019532/1 seq:100
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00536 tc3880/40 rt:1331741019532/ 1321
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00864 tc3920/40 rt:1331741019532/ 1361
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.rsend[live/_definst_/composite_0]: notify:false tsz:2 dsz:102 toff:-824 rt:1331741019532/0 seq:102
    2012-03-14 17:03:39 INFO server comment - LiveReceiver.video[live/_definst_/composite_0]: hdr:0x27 sz:00532 tc3960/40 rt:1331741019532/ 1401
    Thanks

  6. #6

    Default

    These flags are for our own internal use. Quickly the fields are:

    hdr:0x27 sz:00873 tc2200/40 rt:1331741019516/-343

    hdr: first byte of package
    sz: size of packate
    tc: packet absolute timecode
    rt: realtime timecode for packet in milliseconds
    [second-number]: calculated offset of packet timecode from the realtime clock

    Again, this is for our own internal use.

    Charlie

  7. #7
    Join Date
    Dec 2011
    Posts
    24

    Default

    Thanks,

    Can You explain what fields notify, tsz, dsz, toff means ?
    notify:false tsz:2 dsz:49 toff:-216 rt:1331741018020/1 seq:49
    `rt` would be realtime timecode for packet in milliseconds ?
    `seq` would be packet sequence number ?

Similar Threads

  1. Replies: 2
    Last Post: 01-13-2015, 03:20 AM
  2. Debugging & Recovering from Woza's instability
    By SamGoody in forum General Forum
    Replies: 1
    Last Post: 11-28-2013, 07:24 AM

Posting Permissions

  • You may not post new threads
  • You may not post replies
  • You may not post attachments
  • You may not edit your posts
  •