buzztrax icon indicating copy to clipboard operation
buzztrax copied to clipboard

Published 20 hours ago • verified publisher icon Buzztrax

simple goa-kick (FSM-KICK) gives me a gstreamer error

Open waffel opened this issue 10 years ago • 3 comments

image

No errors on command line (how to see whats really wrong?).

waffel avatar Mar 26 '14 18:03 waffel

GST_DEBUG="*:4" ./buzztrax-edit ... or GST_DEBUG_DUMP_DOT_DIR=$PWD ./buzztrax-edit and when the error happens, invoke the "Debug" menu -> "Dump pipeline graph and show". The last image is in $PWD as buzztrax.svg (or png).

ensonic avatar Mar 26 '14 21:03 ensonic

buzztrax

waffel avatar Mar 28 '14 15:03 waffel

0:00:52.075511203 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.075694391 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1; 0:00:52.075802083 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:326:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 2 channels 0:00:52.075885122 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.076150720 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.076637499 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.076771031 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:323:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 1-2 channels 0:00:52.076904913 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.077090475 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1; 0:00:52.077198865 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:326:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 2 channels 0:00:52.077286863 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.077537236 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.078029183 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.078216212 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:323:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 1-2 channels 0:00:52.078353935 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.078453595 20202 0xa0f7260 INFO basetransform gstbasetransform.c:1335:gst_base_transform_setcaps:<FSM-Kick_master:gain> reuse caps 0:00:52.078490889 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1; 0:00:52.078541872 20202 0xa0f7260 INFO GST_EVENT gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1 0:00:52.078641672 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1; 0:00:52.078753135 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:326:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 2 channels 0:00:52.078846231 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.079132780 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.079626264 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.079760005 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:323:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 1-2 channels 0:00:52.079891582 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.079988589 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)1; 0:00:52.080113391 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:326:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 2 channels 0:00:52.080199154 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.080446035 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.081204209 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.081345772 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:323:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 1-2 channels 0:00:52.081553055 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:326:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 2 channels 0:00:52.081638887 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.081891425 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.082398038 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.082535202 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:323:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 1-2 channels 0:00:52.082591982 20202 0xa0f7260 INFO basetransform gstbasetransform.c:1335:gst_base_transform_setcaps:<FSM-Kick_master:audioconvert> reuse caps 0:00:52.082633885 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1; 0:00:52.082681166 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1; 0:00:52.082732707 20202 0xa0f7260 INFO audioconvert audioconvert.c:620:audio_convert_prepare_context: depth in 32, out 32 0:00:52.082762180 20202 0xa0f7260 INFO audioconvert audioconvert.c:634:audio_convert_prepare_context: using no dither and noise shaping 0:00:52.082806248 20202 0xa0f7260 INFO audioconvert audioconvert.c:650:audio_convert_prepare_context: func index in 20, out 20 0:00:52.082834323 20202 0xa0f7260 INFO audioconvert audioconvert.c:658:audio_convert_prepare_context: use float mixing 0:00:52.082859675 20202 0xa0f7260 INFO audioconvert audioconvert.c:661:audio_convert_prepare_context: unitsizes: 4 -> 4 0:00:52.082889636 20202 0xa0f7260 INFO audioconvert audioconvert.c:671:audio_convert_prepare_context: in default 0, mix passthrough 1, out default 0 0:00:52.082918829 20202 0xa0f7260 INFO audioconvert audioconvert.c:678:audio_convert_prepare_context: scale in 0, out 0 0:00:52.082949837 20202 0xa0f7260 INFO GST_EVENT gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1 0:00:52.083030013 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:326:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 2 channels 0:00:52.080682022 20202 0x9bd8860 INFO bml src/bml/gstbmlv.c:123:gst_bmlv_set_property: bm=0x0xa0d5148 0:00:52.083112493 20202 0x9bd8860 INFO bml src/bml/gstbmlv.c:123:gst_bmlv_set_property: bm=0x0xa0d5148 0:00:52.083148809 20202 0x9bd8860 INFO bml src/bml/gstbmlv.c:123:gst_bmlv_set_property: bm=0x0xa0d5148 0:00:52.083182332 20202 0x9bd8860 INFO bml src/bml/gstbmlv.c:123:gst_bmlv_set_property: bm=0x0xa0d5148 0:00:52.083215505 20202 0x9bd8860 INFO bml src/bml/gstbmlv.c:123:gst_bmlv_set_property: bm=0x0xa0d5148 0:00:52.083248958 20202 0x9bd8860 INFO bml src/bml/gstbmlv.c:123:gst_bmlv_set_property: bm=0x0xa0d5148 0:00:52.083442133 20202 0x9bd8860 INFO GST_EVENT gstevent.c:709:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, stop=0:00:07.800000000, rate=1.000000, applied_rate=1.000000, flags=0x01, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 0:00:07.680000000 0:00:52.083550104 20202 0x9bd8860 INFO basesrc gstbasesrc.c:2772:gst_base_src_loop:FSM-Kick:FSM-Kick marking pending DISCONT 0:00:52.083969069 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.084280622 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.084774733 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.084910780 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:323:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 1-2 channels 0:00:52.084984949 20202 0xa0f7260 INFO audiopanorama audiopanorama.c:326:gst_audio_panorama_transform_caps:<FSM-Kick_master:pan> [0] allow 2 channels 0:00:52.085091454 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.085342456 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.085824345 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.085958925 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1; 0:00:52.086034841 20202 0xa0f7260 INFO GST_EVENT gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)2 0:00:52.086151262 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.086492845 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.086982976 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.087155619 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.087407389 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.087900593 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.088079031 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.088332547 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.088824005 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.088932745 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.088974998 20202 0xa0f7260 INFO adder gstadder.c:350:gst_adder_setcaps:master:adder:sink_0 setting caps to audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)2 0:00:52.089011663 20202 0xa0f7260 INFO adder gstadder.c:357:gst_adder_setcaps:master:adder:sink_0 handle caps change to audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)2 0:00:52.090650228 20202 0xa0f7260 INFO bt-core src/lib/core/pattern-control-source.c:229:bt_pattern_control_source_get_value_array: filling array with doubles: 1.000000 0:00:52.090780269 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)1; 0:00:52.090840819 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.090984478 20202 0xa0f7260 INFO adder gstadder.c:1165:gst_adder_collected:master:adder:src send pending stream start event 0:00:52.091064584 20202 0xa0f7260 INFO GST_EVENT gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)2 0:00:52.091109421 20202 0xa0f7260 INFO adder gstadder.c:1179:gst_adder_collected:master:adder:src send pending caps event caps event: 0xa13dae8, time 99:99:99.999999999, seq-num 191, GstEventCaps, caps=(GstCaps)audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.138152979 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.138526130 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.139254971 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)[ 1, 2147483647 ]; 0:00:52.139386408 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.139717655 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.140616973 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.140846395 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.140912881 20202 0xa0f7260 INFO audioconvert audioconvert.c:620:audio_convert_prepare_context: depth in 32, out 32 0:00:52.140948709 20202 0xa0f7260 INFO audioconvert audioconvert.c:634:audio_convert_prepare_context: using no dither and noise shaping 0:00:52.141002555 20202 0xa0f7260 INFO audioconvert audioconvert.c:650:audio_convert_prepare_context: func index in 20, out 20 0:00:52.141035240 20202 0xa0f7260 INFO audioconvert audioconvert.c:658:audio_convert_prepare_context: use float mixing 0:00:52.141082172 20202 0xa0f7260 INFO audioconvert audioconvert.c:661:audio_convert_prepare_context: unitsizes: 8 -> 8 0:00:52.141115415 20202 0xa0f7260 INFO audioconvert audioconvert.c:671:audio_convert_prepare_context: in default 0, mix passthrough 1, out default 0 0:00:52.141149147 20202 0xa0f7260 INFO audioconvert audioconvert.c:678:audio_convert_prepare_context: scale in 0, out 0 0:00:52.141185952 20202 0xa0f7260 INFO GST_EVENT gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw, layout=(string)interleaved, rate=(int)44100, format=(string)F32LE, channels=(int)2, channel-mask=(bitmask)0x0000000000000003 0:00:52.141372912 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.141670636 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.141833571 20202 0xa0f7260 INFO basetransform gstbasetransform.c:1335:gst_base_transform_setcaps:master:input_pre_level reuse caps 0:00:52.141883575 20202 0xa0f7260 INFO GST_EVENT gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw, layout=(string)interleaved, rate=(int)44100, format=(string)F32LE, channels=(int)2, channel-mask=(bitmask)0x0000000000000003 0:00:52.142218175 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.142432371 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.142539435 20202 0xa0f7260 INFO basetransform gstbasetransform.c:1335:gst_base_transform_setcaps:master:input_gain reuse caps 0:00:52.142588182 20202 0xa0f7260 INFO GST_EVENT gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw, layout=(string)interleaved, rate=(int)44100, format=(string)F32LE, channels=(int)2, channel-mask=(bitmask)0x0000000000000003 0:00:52.142702090 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.142831152 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.142878573 20202 0xa0f7260 INFO basetransform gstbasetransform.c:1335:gst_base_transform_setcaps:master:input_post_level reuse caps 0:00:52.142924108 20202 0xa0f7260 INFO GST_EVENT gstevent.c:628:gst_event_new_caps: creating caps event audio/x-raw, layout=(string)interleaved, rate=(int)44100, format=(string)F32LE, channels=(int)2, channel-mask=(bitmask)0x0000000000000003 0:00:52.143074123 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.143183072 20202 0xa0f7260 INFO GST_PADS gstpad.c:3626:gst_pad_peer_query:sink:proxypad1 pad has no peer 0:00:52.143292021 20202 0xa0f7260 INFO GST_EVENT gstevent.c:709:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:52.143372755 20202 0xa0f7260 INFO adder gstadder.c:1455:gst_adder_collected:master:adder:src sending pending new segment event time segment start=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999 0:00:52.143479958 20202 0xa0f7260 INFO structure gststructure.c:2853:gst_structure_get_valist: Expected field 'channel-mask' in structure: audio/x-raw, format=(string)F32LE, layout=(string)interleaved, rate=(int)44100, channels=(int)2; 0:00:52.143571657 20202 0xa0f7260 INFO audioconvert gstaudioconvert.c:257:gst_audio_convert_get_unit_size:master:audioconvert unit_size = 8 0:00:52.143616633 20202 0xa0f7260 INFO audioconvert gstaudioconvert.c:257:gst_audio_convert_get_unit_size:master:audioconvert unit_size = 8 0:00:52.143981473 20202 0xa0f7260 INFO task gsttask.c:300:gst_task_func:<FSM-Kick_master:queue:src> Task going to paused 0:00:52.144125481 20202 0x9bd8860 INFO basesrc gstbasesrc.c:2785:gst_base_src_loop:FSM-Kick:FSM-Kick pausing after gst_pad_push() = not-linked 0:00:52.144224862 20202 0x9bd8860 WARN basesrc gstbasesrc.c:2865:gst_base_src_loop:FSM-Kick:FSM-Kick error: Internal data flow error. 0:00:52.144266346 20202 0x9bd8860 WARN basesrc gstbasesrc.c:2865:gst_base_src_loop:FSM-Kick:FSM-Kick error: streaming task paused, reason not-linked (-1) 0:00:52.144330249 20202 0x9bd8860 INFO GST_ERROR_SYSTEM gstelement.c:1835:gst_element_message_full:FSM-Kick:FSM-Kick posting message: Internal data flow error. 0:00:52.144400926 20202 0x9bd8860 INFO GST_ERROR_SYSTEM gstelement.c:1858:gst_element_message_full:FSM-Kick:FSM-Kick posted error message: Internal data flow error. 0:00:52.144567772 20202 0x9bd8860 INFO task gsttask.c:300:gst_task_func:FSM-Kick:FSM-Kick:src Task going to paused 0:00:52.144669109 20202 0x9325220 INFO bt-edit src/ui/edit/main-toolbar.c:399:on_song_error: received error bus message from FSM-Kick:FSM-Kick 0:00:52.144728332 20202 0x9325220 WARN bt-edit src/ui/edit/main-toolbar.c:404:on_song_error:FSM-Kick:FSM-Kick ERROR: Internal data flow error. (GStreamer encountered a general stream error.) (gstbasesrc.c(2865): gst_base_src_loop (): /GstPipeline:song/BtSourceMachine:FSM-Kick/bml-FSM-Kick:FSM-Kick:FSM-Kick: streaming task paused, reason not-linked (-1)) 0:00:52.144789721 20202 0x9325220 INFO bt-edit src/ui/edit/main-toolbar.c:414:on_song_error: stopping 0:00:52.144829878 20202 0x9325220 INFO bt-core src/lib/core/song.c:944:bt_song_stop: stopping playback, is_playing: 1, is_preparing: 0 0:00:52.144898530 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.144969556 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:master current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.145016488 20202 0x9325220 INFO bt-core src/lib/core/sink-bin.c:1058:bt_sink_bin_change_state:master:master state change on the sink-bin: PLAYING -> PAUSED 0:00:52.145091775 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.145135354 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state: completed state change to PAUSED 0:00:52.145171322 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.145225168 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:master:master child 'sink-tee' changed state to 3(PAUSED) successfully 0:00:52.145273845 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.145315539 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state: completed state change to PAUSED 0:00:52.145350808 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.145400953 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:master:master child 'sink-audioresample' changed state to 3(PAUSED) successfully 0:00:52.145447116 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state: current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.145488531 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state: completed state change to PAUSED 0:00:52.145523730 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.145574433 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:master:master child 'sink-format' changed state to 3(PAUSED) successfully 0:00:52.145622343 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:master completed state change to PAUSED 0:00:52.145658659 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:master notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.145708873 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:master' changed state to 3(PAUSED) successfully 0:00:52.145757551 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:input_post_level current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.145799385 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:input_post_level completed state change to PAUSED 0:00:52.145834654 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:input_post_level notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.145883960 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:input_post_level' changed state to 3(PAUSED) successfully 0:00:52.145976636 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:input_gain current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.146019378 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:input_gain completed state change to PAUSED 0:00:52.146069313 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:input_gain notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.146120365 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:input_gain' changed state to 3(PAUSED) successfully 0:00:52.146168764 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:input_pre_level current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.146211156 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:input_pre_level completed state change to PAUSED 0:00:52.146246565 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:input_pre_level notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.146296290 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:input_pre_level' changed state to 3(PAUSED) successfully 0:00:52.146345177 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:audioconvert current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.146387081 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:audioconvert completed state change to PAUSED 0:00:52.146422070 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:audioconvert notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.146471586 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:audioconvert' changed state to 3(PAUSED) successfully 0:00:52.146518867 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:adder current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.146561469 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:adder completed state change to PAUSED 0:00:52.146597227 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:adder notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.146647301 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:adder' changed state to 3(PAUSED) successfully 0:00:52.146694094 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state: completed state change to PAUSED 0:00:52.146729362 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.146777901 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master' changed state to 3(PAUSED) successfully 0:00:52.146825321 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master> current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.146893345 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:pan> current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.146935039 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:pan> completed state change to PAUSED 0:00:52.146970796 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:pan> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.147021709 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:pan' changed state to 3(PAUSED) successfully 0:00:52.147083866 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:audioconvert> current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.147126049 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:audioconvert> completed state change to PAUSED 0:00:52.147161597 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:audioconvert> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.147211811 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:audioconvert' changed state to 3(PAUSED) successfully 0:00:52.147260279 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:gain> current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.147303091 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:gain> completed state change to PAUSED 0:00:52.147338848 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:gain> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.147389342 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:gain' changed state to 3(PAUSED) successfully 0:00:52.147437741 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:tee> current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.153797011 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:tee> completed state change to PAUSED 0:00:52.153844781 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:tee> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.153883681 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:tee' changed state to 3(PAUSED) successfully 0:00:52.153919299 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:queue> current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.153950867 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:queue> completed state change to PAUSED 0:00:52.153977266 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:queue> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.154014630 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:queue' changed state to 3(PAUSED) successfully 0:00:52.154071828 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master> completed state change to PAUSED 0:00:52.162834123 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.162941675 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'FSM-Kick_master' changed state to 3(PAUSED) successfully 0:00:52.163004670 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick> current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.163079607 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:FSM-Kick:tee current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.163112013 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:FSM-Kick:tee completed state change to PAUSED 0:00:52.163138971 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:FSM-Kick:tee notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.163178011 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick> child 'FSM-Kick:tee' changed state to 3(PAUSED) successfully 0:00:52.163214048 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:FSM-Kick:output_post_level current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.163244986 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:FSM-Kick:output_post_level completed state change to PAUSED 0:00:52.163271525 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:FSM-Kick:output_post_level notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.163308540 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick> child 'FSM-Kick:output_post_level' changed state to 3(PAUSED) successfully 0:00:52.163344088 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:FSM-Kick:output_gain current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.163376982 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:FSM-Kick:output_gain completed state change to PAUSED 0:00:52.163403032 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:FSM-Kick:output_gain notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.163439698 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick> child 'FSM-Kick:output_gain' changed state to 3(PAUSED) successfully 0:00:52.163473430 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:FSM-Kick:FSM-Kick current PLAYING pending VOID_PENDING, desired next PAUSED 0:00:52.163507721 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:FSM-Kick:FSM-Kick completed state change to PAUSED 0:00:52.163534051 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:FSM-Kick:FSM-Kick notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.163571694 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick> child 'FSM-Kick:FSM-Kick' changed state to 3(PAUSED) successfully 0:00:52.163606683 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick> completed state change to PAUSED 0:00:52.163632873 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending) 0:00:52.163669189 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'FSM-Kick' changed state to 3(PAUSED) successfully 0:00:52.163708299 20202 0x9325220 INFO GST_STATES gstelement.c:2303:gst_element_continue_state: committing state from PLAYING to PAUSED, pending READY, next READY 0:00:52.163738120 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PLAYING to PAUSED (READY pending) 0:00:52.163773948 20202 0x9325220 INFO GST_STATES gstelement.c:2310:gst_element_continue_state: continue state change PAUSED to READY, final READY 0:00:52.163822137 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next READY 0:00:52.163878707 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:master current PAUSED pending VOID_PENDING, desired next READY 0:00:52.163916071 20202 0x9325220 INFO bt-core src/lib/core/sink-bin.c:1058:bt_sink_bin_change_state:master:master state change on the sink-bin: PAUSED -> READY 0:00:52.163960279 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next READY 0:00:52.164001903 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state: completed state change to READY 0:00:52.164028372 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.164088433 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:master:master child 'sink-tee' changed state to 2(READY) successfully 0:00:52.164124820 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next READY 0:00:52.164169447 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state: completed state change to READY 0:00:52.164196125 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.164234607 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:master:master child 'sink-audioresample' changed state to 2(READY) successfully 0:00:52.164270714 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state: current PAUSED pending VOID_PENDING, desired next READY 0:00:52.164313455 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state: completed state change to READY 0:00:52.164339715 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.164377567 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:master:master child 'sink-format' changed state to 2(READY) successfully 0:00:52.164449152 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:master completed state change to READY 0:00:52.181363209 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:master notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.181464825 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:master' changed state to 2(READY) successfully 0:00:52.181525794 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:input_post_level current PAUSED pending VOID_PENDING, desired next READY 0:00:52.181636070 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:input_post_level completed state change to READY 0:00:52.181670571 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:input_post_level notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.181720087 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:input_post_level' changed state to 2(READY) successfully 0:00:52.181769952 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:input_gain current PAUSED pending VOID_PENDING, desired next READY 0:00:52.181852781 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:input_gain completed state change to READY 0:00:52.181885535 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:input_gain notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.181933585 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:input_gain' changed state to 2(READY) successfully 0:00:52.181982472 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:input_pre_level current PAUSED pending VOID_PENDING, desired next READY 0:00:52.182088907 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:input_pre_level completed state change to READY 0:00:52.182122569 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:input_pre_level notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.182171108 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:input_pre_level' changed state to 2(READY) successfully 0:00:52.182220204 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:audioconvert current PAUSED pending VOID_PENDING, desired next READY 0:00:52.182308411 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:audioconvert completed state change to READY 0:00:52.182341655 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:audioconvert notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.182389704 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:audioconvert' changed state to 2(READY) successfully 0:00:52.182439220 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:master:adder current PAUSED pending VOID_PENDING, desired next READY 0:00:52.182527776 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:master:adder completed state change to READY 0:00:52.191353135 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:master:adder notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.191450910 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master:adder' changed state to 2(READY) successfully 0:00:52.191522705 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state: completed state change to READY 0:00:52.191550431 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.191588633 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'master' changed state to 2(READY) successfully 0:00:52.191628721 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master> current PAUSED pending VOID_PENDING, desired next READY 0:00:52.191703937 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:pan> current PAUSED pending VOID_PENDING, desired next READY 0:00:52.191765675 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:pan> completed state change to READY 0:00:52.191793192 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:pan> notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.191832721 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:pan' changed state to 2(READY) successfully 0:00:52.191869456 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:audioconvert> current PAUSED pending VOID_PENDING, desired next READY 0:00:52.191921347 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:audioconvert> completed state change to READY 0:00:52.191948165 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:audioconvert> notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.191985738 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:audioconvert' changed state to 2(READY) successfully 0:00:52.192021775 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:gain> current PAUSED pending VOID_PENDING, desired next READY 0:00:52.192091265 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:gain> completed state change to READY 0:00:52.192118502 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:gain> notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.192156844 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:gain' changed state to 2(READY) successfully 0:00:52.192193370 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:tee> current PAUSED pending VOID_PENDING, desired next READY 0:00:52.192245679 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:tee> completed state change to READY 0:00:52.192272637 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:tee> notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.192310630 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:tee' changed state to 2(READY) successfully 0:00:52.192345270 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick_master:queue> current PAUSED pending VOID_PENDING, desired next READY 0:00:52.192416296 20202 0xa0f7260 INFO task gsttask.c:302:gst_task_func:<FSM-Kick_master:queue:src> Task resume from paused 0:00:52.192506598 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master:queue> completed state change to READY 0:00:52.192535093 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master:queue> notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.192573225 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick_master> child 'FSM-Kick_master:queue' changed state to 2(READY) successfully 0:00:52.192627560 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick_master> completed state change to READY 0:00:52.192654937 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick_master> notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.192692231 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'FSM-Kick_master' changed state to 2(READY) successfully 0:00:52.192725963 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:<FSM-Kick> current PAUSED pending VOID_PENDING, desired next READY 0:00:52.192791961 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:FSM-Kick:tee current PAUSED pending VOID_PENDING, desired next READY 0:00:52.192842315 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:FSM-Kick:tee completed state change to READY 0:00:52.192869413 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:FSM-Kick:tee notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.192907545 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick> child 'FSM-Kick:tee' changed state to 2(READY) successfully 0:00:52.192943232 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:FSM-Kick:output_post_level current PAUSED pending VOID_PENDING, desired next READY 0:00:52.192996380 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:FSM-Kick:output_post_level completed state change to READY 0:00:52.193023617 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:FSM-Kick:output_post_level notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.193082841 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick> child 'FSM-Kick:output_post_level' changed state to 2(READY) successfully 0:00:52.193118878 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:FSM-Kick:output_gain current PAUSED pending VOID_PENDING, desired next READY 0:00:52.193173003 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:FSM-Kick:output_gain completed state change to READY 0:00:52.193200590 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:FSM-Kick:output_gain notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.204612022 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick> child 'FSM-Kick:output_gain' changed state to 2(READY) successfully 0:00:52.204680464 20202 0x9325220 INFO GST_STATES gstbin.c:2227:gst_bin_element_set_state:FSM-Kick:FSM-Kick current PAUSED pending VOID_PENDING, desired next READY 0:00:52.204791648 20202 0x9bd8860 INFO task gsttask.c:302:gst_task_func:FSM-Kick:FSM-Kick:src Task resume from paused 0:00:52.204910305 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:FSM-Kick:FSM-Kick completed state change to READY 0:00:52.204939148 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:FSM-Kick:FSM-Kick notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.204977979 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func:<FSM-Kick> child 'FSM-Kick:FSM-Kick' changed state to 2(READY) successfully 0:00:52.205018555 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state:<FSM-Kick> completed state change to READY 0:00:52.205045374 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<FSM-Kick> notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.206270142 20202 0x9325220 INFO GST_STATES gstbin.c:2656:gst_bin_change_state_func: child 'FSM-Kick' changed state to 2(READY) successfully 0:00:52.206350178 20202 0x9325220 INFO GST_STATES gstelement.c:2328:gst_element_continue_state: completed state change to READY 0:00:52.206399205 20202 0x9325220 INFO GST_STATES gstelement.c:2233:_priv_gst_element_state_changed: notifying about state-changed PAUSED to READY (VOID_PENDING pending) 0:00:52.206463596 20202 0x9325220 INFO bt-core src/lib/core/song.c:973:bt_song_stop: playback stopped 0:00:52.207254664 20202 0x9325220 INFO bt-edit src/ui/edit/main-toolbar.c:113:on_song_is_playing_notify: song stop event occurred: 0x9325220 0:00:52.207731037 20202 0x9325220 INFO bt-edit src/ui/edit/main-toolbar.c:136:on_song_is_playing_notify: song stop event handled 0:00:52.208348973 20202 0x9325220 INFO bt-edit src/ui/edit/main-statusbar.c:156:on_song_is_playing_notify: play_start=0 0:00:54.418568431 20202 0x9325220 INFO bt-core src/lib/core/song.c:565:on_song_state_changed: state change on the bin: PLAYING -> PAUSED 0:00:54.418983066 20202 0x9325220 INFO bt-core src/lib/core/song.c:565:on_song_state_changed: state change on the bin: PAUSED -> READY 0:00:54.613659602 20202 0x9325220 INFO bt-edit src/ui/edit/main-page-sequence.c:3078:on_sequence_table_motion_notify_event: motion notify

waffel avatar Mar 28 '14 15:03 waffel