0:00:05.033048235  3470       0x639630 DEBUG                GST_BUS gstbus.c:1148:gst_bus_poll: running mainloop 0x6eafa0
0:00:05.036279336  3470       0x766a80 DEBUG          v4l2allocator gstv4l2allocator.c:706:gst_v4l2_allocator_start:<v4l2src0:pool:src:allocator> allocated 4 mmap buffers out of 4 requested
0:00:05.036391980  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:300:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator> Got mmap buffer
0:00:05.036414964  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:301:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   index:     0
0:00:05.036435706  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:302:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   type:      1
0:00:05.036455883  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:303:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   flags:     00002000
0:00:05.036475663  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:304:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   field:     0
0:00:05.036494773  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:305:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   memory:    1
0:00:05.036514671  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:306:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   planes:    1
0:00:05.036533861  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:313:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   [0] bytesused: 0, length: 1703160
0:00:05.036555956  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:315:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   [0] MMAP offset:  0
0:00:05.036582383  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:300:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator> Got mmap buffer
0:00:05.036601841  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:301:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   index:     1
0:00:05.036669764  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:302:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   type:      1
0:00:05.036688591  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:303:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   flags:     00002000
0:00:05.036707432  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:304:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   field:     0
0:00:05.036754377  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:305:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   memory:    1
0:00:05.036774960  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:306:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   planes:    1
0:00:05.036793468  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:313:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   [0] bytesused: 0, length: 1703160
0:00:05.036814564  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:315:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   [0] MMAP offset:  1703936
0:00:05.036840383  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:300:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator> Got mmap buffer
0:00:05.036859173  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:301:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   index:     2
0:00:05.036877013  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:302:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   type:      1
0:00:05.036895034  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:303:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   flags:     00002000
0:00:05.036913482  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:304:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   field:     0
0:00:05.036931990  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:305:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   memory:    1
0:00:05.036949985  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:306:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   planes:    1
0:00:05.036968015  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:313:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   [0] bytesused: 0, length: 1703160
0:00:05.036988745  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:315:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   [0] MMAP offset:  3407872
0:00:05.037012881  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:300:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator> Got mmap buffer
0:00:05.037031682  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:301:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   index:     3
0:00:05.037049798  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:302:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   type:      1
0:00:05.037067750  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:303:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   flags:     00002000
0:00:05.037085927  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:304:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   field:     0
0:00:05.037104012  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:305:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   memory:    1
0:00:05.037121975  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:306:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   planes:    1
0:00:05.037139850  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:313:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   [0] bytesused: 0, length: 1703160
0:00:05.037160444  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:315:gst_v4l2_memory_group_new:<v4l2src0:pool:src:allocator>   [0] MMAP offset:  5111808
0:00:05.037182269  3470       0x766a80 WARN          v4l2bufferpool gstv4l2bufferpool.c:745:gst_v4l2_buffer_pool_start:<v4l2src0:pool:src> Uncertain or not enough buffers, enabling copy threshold
0:00:05.037222497  3470       0x766a80 DEBUG             bufferpool gstbufferpool.c:583:default_set_config:<v4l2src0:pool:src> config GstBufferPoolConfig, caps=(GstCaps)"video/x-bayer\,\ format\=\(string\)rggb\,\ width\=\(int\)1672\,\ height\=\(int\)1026\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ colorimetry\=\(string\)sRGB\,\ framerate\=\(fraction\)2000000/129", size=(uint)1703160, min-buffers=(uint)4, max-buffers=(uint)32, allocator=(GstAllocator)"NULL", params=(GstAllocationParams)NULL;
0:00:05.037442848  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:819:gst_v4l2_allocator_alloc_mmap:<v4l2src0:pool:src:allocator> mmap buffer length 1703160, data offset 0, plane 0
0:00:05.037472353  3470       0x766a80 DEBUG             GST_MEMORY gstmemory.c:137:gst_memory_init: new memory 0x7f24b4010000, maxsize:1703160 offset:0 size:1703160
0:00:05.037500012  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:656:gst_buffer_new: new 0x7f24b40117e0
0:00:05.037518954  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:293:_memory_add: buffer 0x7f24b40117e0, idx -1, mem 0x7f24b4010000, lock 1
0:00:05.037545638  3470       0x766a80 LOG               bufferpool gstbufferpool.c:284:do_alloc_buffer:<v4l2src0:pool:src> allocated buffer 0/32, 0x7f24b40117e0
0:00:05.037570577  3470       0x766a80 DEBUG         v4l2bufferpool gstv4l2bufferpool.c:1363:gst_v4l2_buffer_pool_release_buffer:<v4l2src0:pool:src> release buffer 0x7f24b40117e0
0:00:05.037597845  3470       0x766a80 LOG           v4l2bufferpool gstv4l2bufferpool.c:1074:gst_v4l2_buffer_pool_qbuf:<v4l2src0:pool:src> queuing buffer 0
0:00:05.037697439  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:1256:gst_v4l2_allocator_qbuf:<v4l2src0:pool:src:allocator> queued buffer 0 (flags 0x2003)
0:00:05.037807323  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:819:gst_v4l2_allocator_alloc_mmap:<v4l2src0:pool:src:allocator> mmap buffer length 1703160, data offset 0, plane 0
0:00:05.037832187  3470       0x766a80 DEBUG             GST_MEMORY gstmemory.c:137:gst_memory_init: new memory 0x7f24b4010090, maxsize:1703160 offset:0 size:1703160
0:00:05.037856280  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:656:gst_buffer_new: new 0x7f24b40118f0
0:00:05.037873884  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:293:_memory_add: buffer 0x7f24b40118f0, idx -1, mem 0x7f24b4010090, lock 1
0:00:05.037898425  3470       0x766a80 LOG               bufferpool gstbufferpool.c:284:do_alloc_buffer:<v4l2src0:pool:src> allocated buffer 1/32, 0x7f24b40118f0
0:00:05.037921171  3470       0x766a80 DEBUG         v4l2bufferpool gstv4l2bufferpool.c:1363:gst_v4l2_buffer_pool_release_buffer:<v4l2src0:pool:src> release buffer 0x7f24b40118f0
0:00:05.037942874  3470       0x766a80 LOG           v4l2bufferpool gstv4l2bufferpool.c:1074:gst_v4l2_buffer_pool_qbuf:<v4l2src0:pool:src> queuing buffer 1
0:00:05.037966958  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:1256:gst_v4l2_allocator_qbuf:<v4l2src0:pool:src:allocator> queued buffer 1 (flags 0x2003)
0:00:05.038066374  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:819:gst_v4l2_allocator_alloc_mmap:<v4l2src0:pool:src:allocator> mmap buffer length 1703160, data offset 0, plane 0
0:00:05.038090912  3470       0x766a80 DEBUG             GST_MEMORY gstmemory.c:137:gst_memory_init: new memory 0x7f24b4010120, maxsize:1703160 offset:0 size:1703160
0:00:05.038114165  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:656:gst_buffer_new: new 0x7f24b4011a00
0:00:05.038132375  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:293:_memory_add: buffer 0x7f24b4011a00, idx -1, mem 0x7f24b4010120, lock 1
0:00:05.038156365  3470       0x766a80 LOG               bufferpool gstbufferpool.c:284:do_alloc_buffer:<v4l2src0:pool:src> allocated buffer 2/32, 0x7f24b4011a00
0:00:05.038178327  3470       0x766a80 DEBUG         v4l2bufferpool gstv4l2bufferpool.c:1363:gst_v4l2_buffer_pool_release_buffer:<v4l2src0:pool:src> release buffer 0x7f24b4011a00
0:00:05.038199550  3470       0x766a80 LOG           v4l2bufferpool gstv4l2bufferpool.c:1074:gst_v4l2_buffer_pool_qbuf:<v4l2src0:pool:src> queuing buffer 2
0:00:05.038223642  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:1256:gst_v4l2_allocator_qbuf:<v4l2src0:pool:src:allocator> queued buffer 2 (flags 0x2003)
0:00:05.038334288  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:819:gst_v4l2_allocator_alloc_mmap:<v4l2src0:pool:src:allocator> mmap buffer length 1703160, data offset 0, plane 0
0:00:05.038358294  3470       0x766a80 DEBUG             GST_MEMORY gstmemory.c:137:gst_memory_init: new memory 0x7f24b40101b0, maxsize:1703160 offset:0 size:1703160
0:00:05.038381448  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:656:gst_buffer_new: new 0x7f24b4011b10
0:00:05.038398724  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:293:_memory_add: buffer 0x7f24b4011b10, idx -1, mem 0x7f24b40101b0, lock 1
0:00:05.038422627  3470       0x766a80 LOG               bufferpool gstbufferpool.c:284:do_alloc_buffer:<v4l2src0:pool:src> allocated buffer 3/32, 0x7f24b4011b10
0:00:05.038444609  3470       0x766a80 DEBUG         v4l2bufferpool gstv4l2bufferpool.c:1363:gst_v4l2_buffer_pool_release_buffer:<v4l2src0:pool:src> release buffer 0x7f24b4011b10
0:00:05.038465582  3470       0x766a80 LOG           v4l2bufferpool gstv4l2bufferpool.c:1074:gst_v4l2_buffer_pool_qbuf:<v4l2src0:pool:src> queuing buffer 3
0:00:05.038489556  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:1256:gst_v4l2_allocator_qbuf:<v4l2src0:pool:src:allocator> queued buffer 3 (flags 0x2003)
0:00:05.038533918  3470       0x766a80 DEBUG         v4l2bufferpool gstv4l2bufferpool.c:942:gst_v4l2_buffer_pool_flush_stop:<v4l2src0:pool:src> stop flushing
0:00:06.006944581  3470       0x766a80 DEBUG         v4l2bufferpool gstv4l2bufferpool.c:621:gst_v4l2_buffer_pool_streamon:<v4l2src0:pool:src> Started streaming
0:00:06.007056572  3470       0x766a80 LOG                 GST_POLL gstpoll.c:1487:gst_poll_set_flushing: 0x7f24b4001630: flushing: 0
0:00:06.007130435  3470       0x766a80 DEBUG                basesrc gstbasesrc.c:3148:gst_base_src_prepare_allocation:<v4l2src0> ALLOCATION (1) params: allocation query: 0x7f24b4001680, GstQueryAllocation, caps=(GstCaps)"video/x-bayer\,\ format\=\(string\)rggb\,\ width\=\(int\)1672\,\ height\=\(int\)1026\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ colorimetry\=\(string\)sRGB\,\ framerate\=\(fraction\)2000000/129", need-pool=(boolean)true, allocator=(GArray)NULL, pool=(GArray)NULL, meta=(GArray)NULL;
0:00:06.007362731  3470       0x766a80 DEBUG                basesrc gstbasesrc.c:2972:gst_base_src_set_allocation:<v4l2src0> activate pool
0:00:06.007407919  3470       0x766a80 LOG               bufferpool gstbufferpool.c:475:gst_buffer_pool_set_active:<v4l2src0:pool:src> active 1
0:00:06.007454936  3470       0x766a80 DEBUG             bufferpool gstbufferpool.c:521:gst_buffer_pool_set_active:<v4l2src0:pool:src> pool was in the right state
0:00:06.007498442  3470       0x766a80 DEBUG                basesrc gstbasesrc.c:2998:gst_base_src_set_allocation:<v4l2src0> deactivate old pool
0:00:06.007537718  3470       0x766a80 LOG               bufferpool gstbufferpool.c:475:gst_buffer_pool_set_active:<v4l2src0:pool:src> active 0
0:00:06.007581585  3470       0x766a80 DEBUG             bufferpool gstbufferpool.c:521:gst_buffer_pool_set_active:<v4l2src0:pool:src> pool was in the right state
0:00:06.007676038  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:407:gst_v4l2_allocator_dispose:<v4l2src0:pool:src:allocator> called
0:00:06.007745612  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:424:gst_v4l2_allocator_finalize:<v4l2src0:pool:src:allocator> called
0:00:06.007805791  3470       0x766a80 DEBUG               GST_POLL gstpoll.c:650:gst_poll_free: 0x7f24b4001400: freeing
0:00:06.007952238  3470       0x766a80 DEBUG             bufferpool gstbufferpool.c:190:gst_buffer_pool_finalize:<v4l2src0:pool:src> finalize
0:00:06.007999059  3470       0x766a80 LOG               bufferpool gstbufferpool.c:475:gst_buffer_pool_set_active:<v4l2src0:pool:src> active 0
0:00:06.008045019  3470       0x766a80 DEBUG             bufferpool gstbufferpool.c:521:gst_buffer_pool_set_active:<v4l2src0:pool:src> pool was in the right state
0:00:06.008120313  3470       0x766a80 DEBUG               GST_POLL gstpoll.c:650:gst_poll_free: 0x7f24b4001450: freeing
0:00:06.008274170  3470       0x766a80 LOG                  basesrc gstbasesrc.c:2735:gst_base_src_loop:<v4l2src0> next_ts 99:99:99.999999999 size 4096
0:00:06.008347421  3470       0x766a80 DEBUG                basesrc gstbasesrc.c:2457:gst_base_src_get_range:<v4l2src0> calling create offset 18446744073709551615 length 4096, time 0
0:00:06.008414022  3470       0x766a80 DEBUG         v4l2bufferpool gstv4l2bufferpool.c:1285:gst_v4l2_buffer_pool_acquire_buffer:<v4l2src0:pool:src> acquire
0:00:06.008455442  3470       0x766a80 LOG           v4l2bufferpool gstv4l2bufferpool.c:1014:gst_v4l2_buffer_pool_poll:<v4l2src0:pool:src> polling device
0:00:06.008490304  3470       0x766a80 DEBUG               GST_POLL gstpoll.c:1195:gst_poll_wait: 0x7f24b4001630: timeout :99:99:99.999999999
0:00:06.052308015  3470       0x766a80 DEBUG               GST_POLL gstpoll.c:1066:gst_poll_fd_has_error: 0x7f24b4001630: fd (fd:21, idx:1) 0
0:00:06.052445785  3470       0x766a80 LOG           v4l2bufferpool gstv4l2bufferpool.c:1140:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src> dequeueing a buffer
0:00:06.052496818  3470       0x766a80 LOG            v4l2allocator gstv4l2allocator.c:1305:gst_v4l2_allocator_dqbuf:<v4l2src0:pool:src:allocator> dequeued buffer 0 (flags 0x2105)
0:00:06.052536611  3470       0x766a80 DEBUG          v4l2allocator gstv4l2allocator.c:1309:gst_v4l2_allocator_dqbuf:<v4l2src0:pool:src:allocator> driver pretends buffer is queued even if dequeue succeeded
0:00:06.052567137  3470       0x766a80 LOG           v4l2bufferpool gstv4l2bufferpool.c:1170:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src> dequeued buffer 0x7f24b40117e0 seq:0 (ix=0), mem 0x7f24b4010000 used 1703160, plane=0, flags 00002101, ts 78:48:58.539625000, pool-queued=3, buffer=0x7f24b40117e0
0:00:06.052692676  3470       0x766a80 DEBUG         v4l2bufferpool gstv4l2bufferpool.c:1688:gst_v4l2_buffer_pool_process:<v4l2src0:pool:src> process buffer 0x7f24baa76d20
0:00:06.052739954  3470       0x766a80 DEBUG              GST_CLOCK gstclock.c:983:gst_clock_get_internal_time:<GstSystemClock> internal time 78:48:58.549131052
0:00:06.052782016  3470       0x766a80 DEBUG              GST_CLOCK gstclock.c:1028:gst_clock_get_time:<GstSystemClock> adjusted time 78:48:58.549131052
0:00:06.052825394  3470       0x766a80 DEBUG                v4l2src gstv4l2src.c:777:gst_v4l2src_create:<v4l2src0> ts: 78:48:58.539625000 now 78:48:58.549215208 delay 0:00:00.009590208
0:00:06.052877549  3470       0x766a80 LOG                  default gstobject.c:1103:gst_object_sync_values:<v4l2src0> sync_values
0:00:06.052902390  3470       0x766a80 INFO                 v4l2src gstv4l2src.c:813:gst_v4l2src_create:<v4l2src0> sync to 0:00:00.018657700 out ts 0:00:04.408237326
0:00:06.052951897  3470       0x766a80 DEBUG                basesrc gstbasesrc.c:2317:gst_base_src_do_sync:<v4l2src0> no sync needed
0:00:06.052978943  3470       0x766a80 DEBUG                basesrc gstbasesrc.c:2521:gst_base_src_get_range:<v4l2src0> buffer ok
0:00:06.053016923  3470       0x766a80 LOG           GST_SCHEDULING gstpad.c:3987:gst_pad_chain_data_unchecked:<capsfilter0:sink> calling chainfunction &gst_base_transform_chain with buffer buffer: 0x7f24b40117e0, pts 0:00:04.408237326, dts 99:99:99.999999999, dur 0:00:00.017741800, size 1703160, offset 1, offset_end 2, flags 0x302000
0:00:06.053091046  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:2024:gst_base_transform_handle_buffer:<capsfilter0> handling buffer 0x7f24b40117e0 of size 1703160 and offset 1
0:00:06.053131075  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:2108:gst_base_transform_handle_buffer:<capsfilter0> calling prepare buffer
0:00:06.053164518  3470       0x766a80 DEBUG               GST_CAPS gstpad.c:2535:gst_pad_has_current_caps:<capsfilter0:sink> check current pad caps video/x-bayer, format=(string)rggb, width=(int)1672, height=(int)1026, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)sRGB, framerate=(fraction)2000000/129
0:00:06.053274048  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:2115:gst_base_transform_handle_buffer:<capsfilter0> using allocated buffer in 0x7f24b40117e0, out 0x7f24b40117e0
0:00:06.053311158  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:2132:gst_base_transform_handle_buffer:<capsfilter0> doing inplace transform
0:00:06.053342312  3470       0x766a80 LOG           GST_SCHEDULING gstpad.c:3987:gst_pad_chain_data_unchecked:<bayer2rgb0:sink> calling chainfunction &gst_base_transform_chain with buffer buffer: 0x7f24b40117e0, pts 0:00:04.408237326, dts 99:99:99.999999999, dur 0:00:00.017741800, size 1703160, offset 1, offset_end 2, flags 0x302000
0:00:06.053399586  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:2024:gst_base_transform_handle_buffer:<bayer2rgb0> handling buffer 0x7f24b40117e0 of size 1703160 and offset 1
0:00:06.053435746  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:2108:gst_base_transform_handle_buffer:<bayer2rgb0> calling prepare buffer
0:00:06.053461281  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:1615:default_prepare_output_buffer:<bayer2rgb0> setting pool 0x764b90 active
0:00:06.053493679  3470       0x766a80 LOG               bufferpool gstbufferpool.c:475:gst_buffer_pool_set_active:<ximagebufferpool1> active 1
0:00:06.053523610  3470       0x766a80 LOG               bufferpool gstbufferpool.c:351:do_start:<ximagebufferpool1> starting
0:00:06.053547711  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:656:gst_buffer_new: new 0x7f24b4011c20
0:00:06.053581554  3470       0x766a80 DEBUG             ximagepool ximagepool.c:238:ximage_memory_alloc:<ximagesink0> creating image 0x7f24b400c180 (1672x1026)
0:00:06.053651267  3470       0x766a80 LOG               ximagepool ximagepool.c:276:ximage_memory_alloc:<ximagesink0> XShm image size is 6861888, width 1672, stride 6688
0:00:06.054474028  3470       0x766a80 DEBUG             ximagepool ximagepool.c:305:ximage_memory_alloc:<ximagesink0> XServer ShmAttached to 0x1fc0002, id 0xe00006
0:00:06.054574604  3470       0x766a80 DEBUG             ximagepool ximagepool.c:348:ximage_memory_alloc:<ximagesink0> memory 0x7f24b8569000, align 0, offset 0
0:00:06.054665793  3470       0x766a80 DEBUG             GST_MEMORY gstmemory.c:137:gst_memory_init: new memory 0x7f24b400c180, maxsize:6861888 offset:0 size:6861888
0:00:06.054711831  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:293:_memory_add: buffer 0x7f24b4011c20, idx -1, mem 0x7f24b400c180, lock 1
0:00:06.054755171  3470       0x766a80 LOG               bufferpool gstbufferpool.c:284:do_alloc_buffer:<ximagebufferpool1> allocated buffer 0/0, 0x7f24b4011c20
0:00:06.054792408  3470       0x766a80 LOG               bufferpool gstbufferpool.c:1220:default_release_buffer:<ximagebufferpool1> released buffer 0x7f24b4011c20 0
0:00:06.054824840  3470       0x766a80 DEBUG             GST_BUFFER gstbuffer.c:1224:gst_buffer_is_memory_range_writable: idx 0, length -1
0:00:06.054860661  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:656:gst_buffer_new: new 0x7f24b40113a0
0:00:06.054893844  3470       0x766a80 DEBUG             ximagepool ximagepool.c:238:ximage_memory_alloc:<ximagesink0> creating image 0x7f24b400c240 (1672x1026)
0:00:06.054936057  3470       0x766a80 LOG               ximagepool ximagepool.c:276:ximage_memory_alloc:<ximagesink0> XShm image size is 6861888, width 1672, stride 6688
0:00:06.055829006  3470       0x766a80 DEBUG             ximagepool ximagepool.c:305:ximage_memory_alloc:<ximagesink0> XServer ShmAttached to 0x1fc8003, id 0xe00007
0:00:06.055941232  3470       0x766a80 DEBUG             ximagepool ximagepool.c:348:ximage_memory_alloc:<ximagesink0> memory 0x7f24ab974000, align 0, offset 0
0:00:06.055982151  3470       0x766a80 DEBUG             GST_MEMORY gstmemory.c:137:gst_memory_init: new memory 0x7f24b400c240, maxsize:6861888 offset:0 size:6861888
0:00:06.056049710  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:293:_memory_add: buffer 0x7f24b40113a0, idx -1, mem 0x7f24b400c240, lock 1
0:00:06.056095870  3470       0x766a80 LOG               bufferpool gstbufferpool.c:284:do_alloc_buffer:<ximagebufferpool1> allocated buffer 1/0, 0x7f24b40113a0
0:00:06.056132920  3470       0x766a80 LOG               bufferpool gstbufferpool.c:1220:default_release_buffer:<ximagebufferpool1> released buffer 0x7f24b40113a0 0
0:00:06.056165073  3470       0x766a80 DEBUG             GST_BUFFER gstbuffer.c:1224:gst_buffer_is_memory_range_writable: idx 0, length -1
0:00:06.056205995  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:1620:default_prepare_output_buffer:<bayer2rgb0> using pool alloc
0:00:06.056235255  3470       0x766a80 LOG               bufferpool gstbufferpool.c:1087:default_acquire_buffer:<ximagebufferpool1> acquired buffer 0x7f24b4011c20
0:00:06.056264756  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:1760:default_copy_metadata:<bayer2rgb0> copying metadata
0:00:06.056289776  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:396:gst_buffer_copy_into: copy 0x7f24b40117e0 to 0x7f24b4011c20, offset 0-1703160/1703160
0:00:06.056332206  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:2115:gst_base_transform_handle_buffer:<bayer2rgb0> using allocated buffer in 0x7f24b40117e0, out 0x7f24b4011c20
0:00:06.056366214  3470       0x766a80 DEBUG          basetransform gstbasetransform.c:2135:gst_base_transform_handle_buffer:<bayer2rgb0> doing non-inplace transform
0:00:06.056391112  3470       0x766a80 DEBUG              bayer2rgb gstbayer2rgb.c:464:gst_bayer2rgb_transform: transforming buffer
0:00:06.056415331  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:1570:gst_buffer_map_range: buffer 0x7f24b40117e0, idx 0, length -1, flags 0001
0:00:06.056452721  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:202:_get_merged_memory: buffer 0x7f24b40117e0, idx 0, length 1
0:00:06.056492161  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:1570:gst_buffer_map_range: buffer 0x7f24b4011c20, idx 0, length -1, flags 0002
0:00:06.056528045  3470       0x766a80 LOG               GST_BUFFER gstbuffer.c:202:_get_merged_memory: buffer 0x7f24b4011c20, idx 0, length 1
Caught SIGSEGV