{"action":"created","issue":{"url":"https://api.github.com/repos/Hexxeh/rpi-firmware/issues/88","labels_url":"https://api.github.com/repos/Hexxeh/rpi-firmware/issues/88/labels{/name}","comments_url":"https://api.github.com/repos/Hexxeh/rpi-firmware/issues/88/comments","events_url":"https://api.github.com/repos/Hexxeh/rpi-firmware/issues/88/events","html_url":"https://github.com/Hexxeh/rpi-firmware/issues/88","id":96923446,"number":88,"title":"gstreamer gets stuck","user":{"login":"cangaru","id":13083964,"avatar_url":"https://avatars.githubusercontent.com/u/13083964?v=3","gravatar_id":"","url":"https://api.github.com/users/cangaru","html_url":"https://github.com/cangaru","followers_url":"https://api.github.com/users/cangaru/followers","following_url":"https://api.github.com/users/cangaru/following{/other_user}","gists_url":"https://api.github.com/users/cangaru/gists{/gist_id}","starred_url":"https://api.github.com/users/cangaru/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/cangaru/subscriptions","organizations_url":"https://api.github.com/users/cangaru/orgs","repos_url":"https://api.github.com/users/cangaru/repos","events_url":"https://api.github.com/users/cangaru/events{/privacy}","received_events_url":"https://api.github.com/users/cangaru/received_events","type":"User","site_admin":false},"labels":[],"state":"open","locked":false,"assignee":null,"milestone":null,"comments":9,"created_at":"2015-07-23T23:08:47Z","updated_at":"2015-07-26T11:59:57Z","closed_at":null,"body":"Latest rpi firmware, gstreamer now gets stuck. I have the last bit of the debug output, but I'm not sure what the error is:\r\n\r\n0:00:31.520362250  2807  0x1c55c00 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed NULL to READY (VOID_PENDING pending)\r\n0:00:31.520563447  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:312:gst_bus_post:<bus1> [msg 0x1dc5418] posting on bus state-changed message: 0x1dc5418, time 99:99:99.999999999, seq-num 50, element 'h264parse0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;\r\n0:00:31.520978705  2807  0x1c55c00 DEBUG                    bin gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0x1dc5418] handling child h264parse0 message of type state-changed\r\n0:00:31.521166621  2807  0x1c55c00 DEBUG                    bin gstbin.c:3729:gst_bin_handle_message_func:<pipeline0> posting message upward\r\n0:00:31.521275162  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:312:gst_bus_post:<bus2> [msg 0x1dc5418] posting on bus state-changed message: 0x1dc5418, time 99:99:99.999999999, seq-num 50, element 'h264parse0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;\r\n0:00:31.521573754  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:347:gst_bus_post:<bus2> [msg 0x1dc5418] pushing on async queue\r\n0:00:31.521834481  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:350:gst_bus_post:<bus2> [msg 0x1dc5418] pushed on async queue\r\n0:00:31.522003230  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:343:gst_bus_post:<bus1> [msg 0x1dc5418] dropped\r\n0:00:31.522115782  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<h264parse0> returned SUCCESS\r\n0:00:31.522430467  2807  0x1c55c00 INFO              GST_STATES gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 2(READY) successfully\r\n0:00:31.522727341  2807  0x1c55c00 DEBUG                    bin gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives ac3parse0\r\n0:00:31.522837913  2807  0x1c55c00 DEBUG                    bin gstbin.c:885:find_message:<pipeline0> no message found matching types 00001000\r\n0:00:31.522991506  2807  0x1c55c00 DEBUG                    bin gstbin.c:892:find_message:<pipeline0>   structure-change\r\n0:00:31.523150515  2807  0x1c55c00 DEBUG                    bin gstbin.c:2010:update_degree:<pipeline0> change element avenc_ac3-0, degree 1->0, linked to ac3parse0\r\n0:00:31.523430826  2807  0x1c55c00 DEBUG                    bin gstbin.c:1893:add_to_queue:<pipeline0> adding 'avenc_ac3-0' to queue\r\n0:00:31.523723376  2807  0x1c55c00 INFO              GST_STATES gstbin.c:2227:gst_bin_element_set_state:<ac3parse0> current NULL pending VOID_PENDING, desired next READY\r\n0:00:31.523904261  2807  0x1c55c00 DEBUG                    bin gstbin.c:885:find_message:<pipeline0> no message found matching types 00100000\r\n0:00:31.524014208  2807  0x1c55c00 DEBUG                    bin gstbin.c:892:find_message:<pipeline0>   async-start\r\n0:00:31.524333894  2807  0x1c55c00 DEBUG                    bin gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element ac3parse0 to READY, base_time 0:00:00.000000000\r\n0:00:31.524617486  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<ac3parse0> set_state to READY\r\n0:00:31.524729985  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<ac3parse0> setting target state to READY\r\n0:00:31.524885401  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<ac3parse0> current NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS\r\n0:00:31.525064723  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<ac3parse0> final: setting state from NULL to READY\r\n0:00:31.525348315  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<ac3parse0> element changed state SUCCESS\r\n0:00:31.525626386  2807  0x1c55c00 INFO              GST_STATES gstelement.c:2328:gst_element_continue_state:<ac3parse0> completed state change to READY\r\n0:00:31.525782375  2807  0x1c55c00 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<ac3parse0> notifying about state-changed NULL to READY (VOID_PENDING pending)\r\n0:00:31.525982790  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:312:gst_bus_post:<bus1> [msg 0x1dc5380] posting on bus state-changed message: 0x1dc5380, time 99:99:99.999999999, seq-num 51, element 'ac3parse0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;\r\n0:00:31.526353726  2807  0x1c55c00 DEBUG                    bin gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0x1dc5380] handling child ac3parse0 message of type state-changed\r\n0:00:31.526477319  2807  0x1c55c00 DEBUG                    bin gstbin.c:3729:gst_bin_handle_message_func:<pipeline0> posting message upward\r\n0:00:31.526621537  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:312:gst_bus_post:<bus2> [msg 0x1dc5380] posting on bus state-changed message: 0x1dc5380, time 99:99:99.999999999, seq-num 51, element 'ac3parse0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;\r\n0:00:31.527042472  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:347:gst_bus_post:<bus2> [msg 0x1dc5380] pushing on async queue\r\n0:00:31.527156534  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:350:gst_bus_post:<bus2> [msg 0x1dc5380] pushed on async queue\r\n0:00:31.527314658  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:343:gst_bus_post:<bus1> [msg 0x1dc5380] dropped\r\n0:00:31.527468563  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<ac3parse0> returned SUCCESS\r\n0:00:31.527764968  2807  0x1c55c00 INFO              GST_STATES gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'ac3parse0' changed state to 2(READY) successfully\r\n0:00:31.528033351  2807  0x1c55c00 DEBUG                    bin gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives capsfilter1\r\n0:00:31.528145538  2807  0x1c55c00 DEBUG                    bin gstbin.c:885:find_message:<pipeline0> no message found matching types 00001000\r\n0:00:31.528299808  2807  0x1c55c00 DEBUG                    bin gstbin.c:892:find_message:<pipeline0>   structure-change\r\n0:00:31.528454547  2807  0x1c55c00 DEBUG                    bin gstbin.c:2010:update_degree:<pipeline0> change element omxh264enc-omxh264enc0, degree 1->0, linked to capsfilter1\r\n0:00:31.528738868  2807  0x1c55c00 DEBUG                    bin gstbin.c:1893:add_to_queue:<pipeline0> adding 'omxh264enc-omxh264enc0' to queue\r\n0:00:31.529031314  2807  0x1c55c00 INFO              GST_STATES gstbin.c:2227:gst_bin_element_set_state:<capsfilter1> current NULL pending VOID_PENDING, desired next READY\r\n0:00:31.529210480  2807  0x1c55c00 DEBUG                    bin gstbin.c:885:find_message:<pipeline0> no message found matching types 00100000\r\n0:00:31.529319906  2807  0x1c55c00 DEBUG                    bin gstbin.c:892:find_message:<pipeline0>   async-start\r\n0:00:31.529613134  2807  0x1c55c00 DEBUG                    bin gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element capsfilter1 to READY, base_time 0:00:00.000000000\r\n0:00:31.529894226  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<capsfilter1> set_state to READY\r\n0:00:31.530007090  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<capsfilter1> setting target state to READY\r\n0:00:31.530161047  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<capsfilter1> current NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS\r\n0:00:31.530335473  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<capsfilter1> final: setting state from NULL to READY\r\n0:00:31.530634586  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<capsfilter1> element changed state SUCCESS\r\n0:00:31.530927293  2807  0x1c55c00 INFO              GST_STATES gstelement.c:2328:gst_element_continue_state:<capsfilter1> completed state change to READY\r\n0:00:31.531046407  2807  0x1c55c00 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<capsfilter1> notifying about state-changed NULL to READY (VOID_PENDING pending)\r\n0:00:31.531280728  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:312:gst_bus_post:<bus1> [msg 0x1dc5328] posting on bus state-changed message: 0x1dc5328, time 99:99:99.999999999, seq-num 52, element 'capsfilter1', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;\r\n0:00:31.531636403  2807  0x1c55c00 DEBUG                    bin gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0x1dc5328] handling child capsfilter1 message of type state-changed\r\n0:00:31.531763330  2807  0x1c55c00 DEBUG                    bin gstbin.c:3729:gst_bin_handle_message_func:<pipeline0> posting message upward\r\n0:00:31.531914475  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:312:gst_bus_post:<bus2> [msg 0x1dc5328] posting on bus state-changed message: 0x1dc5328, time 99:99:99.999999999, seq-num 52, element 'capsfilter1', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;\r\n0:00:31.532330254  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:347:gst_bus_post:<bus2> [msg 0x1dc5328] pushing on async queue\r\n0:00:31.532495253  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:350:gst_bus_post:<bus2> [msg 0x1dc5328] pushed on async queue\r\n0:00:31.532607908  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:343:gst_bus_post:<bus1> [msg 0x1dc5328] dropped\r\n0:00:31.532901448  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<capsfilter1> returned SUCCESS\r\n0:00:31.533158322  2807  0x1c55c00 INFO              GST_STATES gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'capsfilter1' changed state to 2(READY) successfully\r\n0:00:31.533301706  2807  0x1c55c00 DEBUG                    bin gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives avenc_ac3-0\r\n0:00:31.533456966  2807  0x1c55c00 DEBUG                    bin gstbin.c:885:find_message:<pipeline0> no message found matching types 00001000\r\n0:00:31.533713527  2807  0x1c55c00 DEBUG                    bin gstbin.c:892:find_message:<pipeline0>   structure-change\r\n0:00:31.533882276  2807  0x1c55c00 DEBUG                    bin gstbin.c:2010:update_degree:<pipeline0> change element audiorate0, degree 1->0, linked to avenc_ac3-0\r\n0:00:31.534141545  2807  0x1c55c00 DEBUG                    bin gstbin.c:1893:add_to_queue:<pipeline0> adding 'audiorate0' to queue\r\n0:00:31.534263471  2807  0x1c55c00 INFO              GST_STATES gstbin.c:2227:gst_bin_element_set_state:<avenc_ac3-0> current NULL pending VOID_PENDING, desired next READY\r\n0:00:31.534438575  2807  0x1c55c00 DEBUG                    bin gstbin.c:885:find_message:<pipeline0> no message found matching types 00100000\r\n0:00:31.534590136  2807  0x1c55c00 DEBUG                    bin gstbin.c:892:find_message:<pipeline0>   async-start\r\n0:00:31.534847583  2807  0x1c55c00 DEBUG                    bin gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element avenc_ac3-0 to READY, base_time 0:00:00.000000000\r\n0:00:31.535118727  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<avenc_ac3-0> set_state to READY\r\n0:00:31.535230810  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<avenc_ac3-0> setting target state to READY\r\n0:00:31.535384194  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<avenc_ac3-0> current NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS\r\n0:00:31.535560078  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<avenc_ac3-0> final: setting state from NULL to READY\r\n0:00:31.535857941  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2636:gst_element_change_state:<avenc_ac3-0> element changed state SUCCESS\r\n0:00:31.536120648  2807  0x1c55c00 INFO              GST_STATES gstelement.c:2328:gst_element_continue_state:<avenc_ac3-0> completed state change to READY\r\n0:00:31.536235856  2807  0x1c55c00 INFO              GST_STATES gstelement.c:2233:_priv_gst_element_state_changed:<avenc_ac3-0> notifying about state-changed NULL to READY (VOID_PENDING pending)\r\n0:00:31.536469084  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:312:gst_bus_post:<bus1> [msg 0x1dc52d0] posting on bus state-changed message: 0x1dc52d0, time 99:99:99.999999999, seq-num 53, element 'avenc_ac3-0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;\r\n0:00:31.536817363  2807  0x1c55c00 DEBUG                    bin gstbin.c:3396:gst_bin_handle_message_func:<pipeline0> [msg 0x1dc52d0] handling child avenc_ac3-0 message of type state-changed\r\n0:00:31.536941685  2807  0x1c55c00 DEBUG                    bin gstbin.c:3729:gst_bin_handle_message_func:<pipeline0> posting message upward\r\n0:00:31.537126111  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:312:gst_bus_post:<bus2> [msg 0x1dc52d0] posting on bus state-changed message: 0x1dc52d0, time 99:99:99.999999999, seq-num 53, element 'avenc_ac3-0', GstMessageStateChanged, old-state=(GstState)GST_STATE_NULL, new-state=(GstState)GST_STATE_READY, pending-state=(GstState)GST_STATE_VOID_PENDING;\r\n0:00:31.537542671  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:347:gst_bus_post:<bus2> [msg 0x1dc52d0] pushing on async queue\r\n0:00:31.537776836  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:350:gst_bus_post:<bus2> [msg 0x1dc52d0] pushed on async queue\r\n0:00:31.537930950  2807  0x1c55c00 DEBUG                GST_BUS gstbus.c:343:gst_bus_post:<bus1> [msg 0x1dc52d0] dropped\r\n0:00:31.538081105  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2563:gst_element_set_state_func:<avenc_ac3-0> returned SUCCESS\r\n0:00:31.538298865  2807  0x1c55c00 INFO              GST_STATES gstbin.c:2656:gst_bin_change_state_func:<pipeline0> child 'avenc_ac3-0' changed state to 2(READY) successfully\r\n0:00:31.538588082  2807  0x1c55c00 DEBUG                    bin gstbin.c:2094:gst_bin_sort_iterator_next:<pipeline0> queue head gives omxh264enc-omxh264enc0\r\n0:00:31.538755268  2807  0x1c55c00 DEBUG                    bin gstbin.c:885:find_message:<pipeline0> no message found matching types 00001000\r\n0:00:31.538864486  2807  0x1c55c00 DEBUG                    bin gstbin.c:892:find_message:<pipeline0>   structure-change\r\n0:00:31.539021413  2807  0x1c55c00 DEBUG                    bin gstbin.c:2010:update_degree:<pipeline0> change element videorate0, degree 1->0, linked to omxh264enc-omxh264enc0\r\n0:00:31.539192401  2807  0x1c55c00 DEBUG                    bin gstbin.c:1893:add_to_queue:<pipeline0> adding 'videorate0' to queue\r\n0:00:31.539479327  2807  0x1c55c00 INFO              GST_STATES gstbin.c:2227:gst_bin_element_set_state:<omxh264enc-omxh264enc0> current NULL pending VOID_PENDING, desired next READY\r\n0:00:31.539745523  2807  0x1c55c00 DEBUG                    bin gstbin.c:885:find_message:<pipeline0> no message found matching types 00100000\r\n0:00:31.539855887  2807  0x1c55c00 DEBUG                    bin gstbin.c:892:find_message:<pipeline0>   async-start\r\n0:00:31.540004428  2807  0x1c55c00 DEBUG                    bin gstbin.c:2322:gst_bin_element_set_state:<pipeline0> setting element omxh264enc-omxh264enc0 to READY, base_time 0:00:00.000000000\r\n0:00:31.540358384  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2479:gst_element_set_state_func:<omxh264enc-omxh264enc0> set_state to READY\r\n0:00:31.540489216  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2504:gst_element_set_state_func:<omxh264enc-omxh264enc0> setting target state to READY\r\n0:00:31.540750725  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2517:gst_element_set_state_func:<omxh264enc-omxh264enc0> current NULL, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS\r\n0:00:31.541061349  2807  0x1c55c00 DEBUG             GST_STATES gstelement.c:2551:gst_element_set_state_func:<omxh264enc-omxh264enc0> final: setting state from NULL to READY\r\n"},"comment":{"url":"https://api.github.com/repos/Hexxeh/rpi-firmware/issues/comments/124975747","html_url":"https://github.com/Hexxeh/rpi-firmware/issues/88#issuecomment-124975747","issue_url":"https://api.github.com/repos/Hexxeh/rpi-firmware/issues/88","id":124975747,"user":{"login":"popcornmix","id":1053730,"avatar_url":"https://avatars.githubusercontent.com/u/1053730?v=3","gravatar_id":"","url":"https://api.github.com/users/popcornmix","html_url":"https://github.com/popcornmix","followers_url":"https://api.github.com/users/popcornmix/followers","following_url":"https://api.github.com/users/popcornmix/following{/other_user}","gists_url":"https://api.github.com/users/popcornmix/gists{/gist_id}","starred_url":"https://api.github.com/users/popcornmix/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/popcornmix/subscriptions","organizations_url":"https://api.github.com/users/popcornmix/orgs","repos_url":"https://api.github.com/users/popcornmix/repos","events_url":"https://api.github.com/users/popcornmix/events{/privacy}","received_events_url":"https://api.github.com/users/popcornmix/received_events","type":"User","site_admin":false},"created_at":"2015-07-26T11:59:56Z","updated_at":"2015-07-26T11:59:56Z","body":"Can you provide something I can run to see the failure?\r\nE.g. tar up your gstreamer and video file? Binary only is okay."}}