buzztard dataflow error with buzz machines as logged by gst

0:00:00.094125000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core core.c:93:bt_init_post:[00m init xml
0:00:00.094694000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core core.c:105:bt_init_post:[00m init gnome-vfs
0:00:00.122803000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core application.c:181:bt_application_init:[00m bin->ref_ct=1
0:00:00.122904000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core settings.c:67:bt_settings_new:[00m create a new settings object for thread 0x8096e30
0:00:00.123122000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:264:bt_gconf_settings_init:[00m !!!! self=0x80b46f0
0:00:00.129050000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:77:bt_gconf_settings_new:[00m about to register gconf notify handler
0:00:00.129262000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core settings.c:85:bt_settings_new:[00m settings created 0x80b46f0
0:00:00.133700000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:315:bt_edit_application_new:[00m new edit app created, app->ref_ct=1
0:00:00.133766000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:286:bt_main_window_new:[00m creating a new window, app->ref_ct=1
0:00:00.133917000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:129:bt_gconf_settings_get_property:[00m application reads [def] system toolbar-hide gconf_settings : 0
0:00:00.133950000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:141:bt_gconf_settings_get_property:[00m application reads [def] system tabs-hide gconf_settings : 0
0:00:00.144882000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-window.c:591:bt_main_window_set_property:[00m set the app for main_window: 0x80ac878, app->ref_ct=3
0:00:00.144961000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:295:bt_main_window_new:[00m new main_window created, app->ref_ct=1
0:00:00.210801000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:226:bt_main_window_init_ui:[00m before creating content, app->ref_ct=1
0:00:00.211429000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:129:bt_gconf_settings_get_property:[00m application reads [def] system toolbar-hide gconf_settings : 0
0:00:00.211461000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:141:bt_gconf_settings_get_property:[00m application reads [def] system tabs-hide gconf_settings : 0
0:00:00.266515000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:171:bt_gconf_settings_get_property:[00m application reads system toolbar style gconf_settings : 'both'
0:00:00.267163000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:466:on_toolbar_style_changed:[00m !!!  toolbar style has changed 'both'
0:00:00.269445000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-pages.c:106:bt_main_pages_init_ui:[00m before creating pages, app->ref_ct=1
0:00:00.271236000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:814:bt_main_page_machines_init_ui:[00m !!!! self=0x82be008
0:00:00.271309000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:149:bt_gconf_settings_get_property:[00m application reads grid-density gconf_settings : 'low'
0:00:00.272662000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core tools.c:59:bt_gst_registry_get_element_names_matching_all_categories:[00m run filter for categories: Source/Audio
0:00:00.272843000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core tools.c:64:bt_gst_registry_get_element_names_matching_all_categories:[00m filtering done
0:00:00.273643000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'alsasrc'
0:00:00.273904000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'audiotestsrc'
0:00:00.274016000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'bml-Arguelles-GoaKick'
0:00:00.274070000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:133:bt_machine_menu_init_submenu:[00m   subclass : 'BML'
0:00:00.274096000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:136:bt_machine_menu_init_submenu:[00m     create new: 'BML'
0:00:00.274395000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'bml-Arguelles-Guru-2'
0:00:00.274433000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:133:bt_machine_menu_init_submenu:[00m   subclass : 'BML'
0:00:00.274529000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'bml-CyanPhase-DTMF-1'
0:00:00.274563000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:133:bt_machine_menu_init_submenu:[00m   subclass : 'BML'
0:00:00.274657000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'gconfaudiosrc'
0:00:00.274766000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'halaudiosrc'
0:00:00.274900000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'osssrc'
0:00:00.275037000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'simsyn'
0:00:00.275430000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core tools.c:59:bt_gst_registry_get_element_names_matching_all_categories:[00m run filter for categories: Filter/Effect/Audio
0:00:00.275493000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core tools.c:64:bt_gst_registry_get_element_names_matching_all_categories:[00m filtering done
0:00:00.275547000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'audiodelay'
0:00:00.275663000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'audiorate'
0:00:00.275765000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'bml-Elak-SVF'
0:00:00.275798000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:133:bt_machine_menu_init_submenu:[00m   subclass : 'BML'
0:00:00.275814000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:136:bt_machine_menu_init_submenu:[00m     create new: 'BML'
0:00:00.276080000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:123:bt_machine_menu_init_submenu:[00m found source element : 'volume'
0:00:00.280304000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-machines.c:237:bt_main_page_machines_draw_grid:[00m redrawing grid : density=1  canvas=0x82ce020
0:00:00.281592000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:171:bt_gconf_settings_get_property:[00m application reads system toolbar style gconf_settings : 'both'
0:00:00.281708000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-machines.c:721:on_toolbar_style_changed:[00m !!!  toolbar style has changed 'both'
0:00:00.283091000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:914:bt_main_page_machines_init_ui:[00m   done
0:00:00.284138000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:1418:bt_main_page_patterns_init_ui:[00m !!!! self=0x82d4808
0:00:00.304282000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:787:pattern_pos_table_init:[00m     number of columns : 1
0:00:00.305021000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:1559:bt_main_page_patterns_init_ui:[00m   before context menu
0:00:00.305973000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:1622:bt_main_page_patterns_init_ui:[00m   done
0:00:00.306681000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:2135:bt_main_page_sequence_init_ui:[00m !!!! self=0x82be0f8
0:00:00.309695000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:655:sequence_pos_table_init:[00m     number of columns : 1
0:00:00.310310000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:694:sequence_table_init:[00m preparing sequence table
0:00:00.310711000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:751:sequence_table_init:[00m     number of columns : 1
0:00:00.311563000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:2318:bt_main_page_sequence_init_ui:[00m   done
0:00:00.311663000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:436:on_page_switched:[00m leave sequence page
0:00:00.312308000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-waves.c:413:bt_main_page_waves_init_ui:[00m !!!! self=0x82f5c88
0:00:00.373286000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:171:bt_gconf_settings_get_property:[00m application reads system toolbar style gconf_settings : 'both'
0:00:00.373706000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-waves.c:233:on_toolbar_style_changed:[00m !!!  toolbar style has changed 'both'
0:00:00.373752000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-waves.c:570:bt_main_page_waves_init_ui:[00m   done
0:00:00.376908000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:436:on_page_switched:[00m leave sequence page
0:00:00.377857000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-info.c:289:bt_main_page_info_init_ui:[00m !!!! self=0x82e1888
0:00:00.381034000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-info.c:391:bt_main_page_info_init_ui:[00m   scrolled window: 0x8123e78
0:00:00.382619000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-info.c:396:bt_main_page_info_init_ui:[00m   text view: 0x81fb818
0:00:00.386199000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-info.c:408:bt_main_page_info_init_ui:[00m   done
0:00:00.386341000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:436:on_page_switched:[00m leave sequence page
0:00:00.386365000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-info.c:82:on_page_switched:[00m leave info page
0:00:00.387037000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-pages.c:137:bt_main_pages_init_ui:[00m   done
0:00:00.392815000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:256:bt_main_window_init_ui:[00m content created, app->ref_ct=1
0:00:00.393003000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:266:bt_main_window_init_ui:[00m signal connected, app->ref_ct=1
0:00:00.393051000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:300:bt_main_window_new:[00m new main_window layouted, app->ref_ct=1
0:00:00.434232000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:436:on_page_switched:[00m leave sequence page
0:00:00.434625000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-info.c:82:on_page_switched:[00m leave info page
0:00:00.437817000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:459:on_header_size_allocate:[00m #### header label size 100 x 48
0:00:00.464788000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:309:bt_main_window_new:[00m new main_window shown
0:00:00.465095000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:323:bt_edit_application_new:[00m new edit app window created, app->ref_ct=1
0:00:00.465117000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:633:bt_edit_application_run:[00m application.run launched
0:00:00.466091000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:431:bt_song_info_init:[00m date initialized as 2007-02-19T14:01:11Z
0:00:00.466840000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1121:bt_song_init:[00m   done
0:00:00.466886000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1006:bt_song_set_property:[00m set the app for the song: 0x80ac878
0:00:00.466918000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1014:bt_song_set_property:[00m set the bin for the song: 0x8128030
0:00:00.467001000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:432:bt_song_new:[00m   lopp-signals connected
0:00:00.467082000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:156:bt_song_update_play_seek_event:[00m loop 0? -1 ... -1, length 0 bar_time 120000000
0:00:00.467127000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:435:bt_song_new:[00m   new song created: 0x8335590
0:00:00.467180000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1286:bt_sequence_set_property:[00m set the length for sequence: 64
0:00:00.467210000 [335m 2884[00m 0x8096e30 [33;01mWARN [00m [00m             bt-core sequence.c:176:bt_sequence_resize_data_length:[00m extending sequence length from 0 to 64 failed : data_count=0 = length=64 * tracks=0
0:00:00.467237000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:458:bt_song_set_unsaved:[00m unsaved = 1
0:00:00.467303000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:156:bt_song_update_play_seek_event:[00m loop 0? -1 ... -1, length 64 bar_time 120000000
0:00:00.467385000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:331:bt_setup_get_machine_by_id:[00m no machine found for id "master"
0:00:00.468036000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2501:bt_machine_init:[00m !!!! self=0x82de3c0
0:00:00.468081000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2353:bt_machine_set_property:[00m set the song for machine: 0x8335590
0:00:00.468116000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2358:bt_machine_set_property:[00m set the id for machine: master
0:00:00.468137000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2370:bt_machine_set_property:[00m set the plugin_name for machine: bt-sink-bin
0:00:00.468160000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:83:bt_sink_machine_new:[00m sink-machine-refs: 1
0:00:00.468187000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:1040:bt_machine_new:[00m initializing machine
0:00:00.468824000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:337:bt_sink_bin_update:[00m clearing sink-bin
0:00:00.468858000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:114:bt_sink_bin_clear:[00m clearing sink-bin : 0
0:00:00.468875000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:126:bt_sink_bin_clear:[00m done
0:00:00.468890000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:342:bt_sink_bin_update:[00m initializing sink-bin
0:00:00.468905000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core settings.c:82:bt_settings_new:[00m return cached settings object (refct=1) for thread 0x8096e30
0:00:00.468930000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core settings.c:85:bt_settings_new:[00m settings created 0x80b46f0
0:00:00.468966000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:113:bt_gconf_settings_get_property:[00m application reads audiosink gconf_settings : 'alsasink'
0:00:00.469547000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:165:bt_gconf_settings_get_property:[00m application reads system audiosink gconf_settings : '(null)'
0:00:00.469572000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:162:bt_sink_bin_determine_plugin_name:[00m get audiosink from config
0:00:00.469617000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:224:bt_sink_bin_determine_plugin_name:[00m using audio sink : "alsasink"
0:00:00.489995000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:132:bt_sink_bin_add_many:[00m add elements: list=0x843a620
0:00:00.490268000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:143:bt_sink_bin_link_many:[00m link elements: list=(nil)
0:00:00.490316000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:422:bt_sink_bin_update:[00m updating ghost pad : elem=0x843c048 (ref_ct=1),'player', pad=0x82f1118 (ref_ct=2)
0:00:00.490582000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:424:bt_sink_bin_update:[00m   done, pad=0x82f1118 (ref_ct=3)
0:00:00.490603000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:427:bt_sink_bin_update:[00m done
0:00:00.490705000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:744:bt_machine_init_core_machine:[00m   instantiated machine 0x8431838, "bt-sink-bin", machine->ref_count=1
0:00:00.490863000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:772:bt_machine_init_interfaces:[00m machine element instantiated and interfaces initialized
0:00:00.490933000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:981:bt_machine_setup:[00m machine-refs: 1
0:00:00.491093000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:959:bt_machine_init_voice_params:[00m   instance is monophonic!
0:00:00.491111000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:988:bt_machine_setup:[00m machine-refs: 1
0:00:00.491126000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:991:bt_machine_setup:[00m   added machine 0x8431838 to bin, machine->ref_count=1  bin->ref_count=4
0:00:00.491398000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1045:bt_pattern_set_property:[00m set the machine for pattern: 0x82de3c0 (machine-refs: 3)
0:00:00.491439000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1013:bt_pattern_set_property:[00m set the id for pattern: master___break
0:00:00.491461000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1018:bt_pattern_set_property:[00m set the display name for the pattern:    break
0:00:00.491525000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1025:bt_pattern_set_property:[00m set the length for pattern: 1
0:00:00.491546000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:178:bt_pattern_resize_data_length:[00m extended pattern length from 0 to 1 : data_count=1 = length=1 * ( ip=1 + gp=0 + voices=0 * vp=0 )
0:00:00.491574000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core pattern.c:142:bt_pattern_init_data:[00m data has already been initialized
0:00:00.491723000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1045:bt_pattern_set_property:[00m set the machine for pattern: 0x82de3c0 (machine-refs: 3)
0:00:00.491748000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1013:bt_pattern_set_property:[00m set the id for pattern: master___mute
0:00:00.491769000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1018:bt_pattern_set_property:[00m set the display name for the pattern:    mute
0:00:00.491787000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1025:bt_pattern_set_property:[00m set the length for pattern: 1
0:00:00.491802000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:178:bt_pattern_resize_data_length:[00m extended pattern length from 0 to 1 : data_count=1 = length=1 * ( ip=1 + gp=0 + voices=0 * vp=0 )
0:00:00.491828000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core pattern.c:142:bt_pattern_init_data:[00m data has already been initialized
0:00:00.491847000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:1015:bt_machine_setup:[00m machine-refs: 1
0:00:00.491880000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:87:bt_sink_machine_new:[00m sink-machine-refs: 2
0:00:00.491904000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:52:bt_sink_machine_post_init:[00m   master this will be the master for the song
0:00:00.491955000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1020:bt_song_set_property:[00m set the master for the song: 0x82de3c0 (machine-refs: 4)
0:00:00.491979000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:89:bt_sink_machine_new:[00m sink-machine-refs: 2
0:00:00.491996000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit edit-application.c:363:bt_edit_application_new_song:[00m sink-machine-refs: 2
0:00:00.492150000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:1072:bt_machine_enable_input_level:[00m  for machine 'master'
0:00:00.495169000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:670:bt_machine_add_input_element:[00m machine 'master_0x82de3c0' is not yet connected on the input side
0:00:00.495470000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:680:bt_machine_add_input_element:[00m sucessfully prepended element 'input_level_0x82de3c0' for 'master_0x82de3c0'
0:00:00.495504000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:1132:bt_machine_enable_input_gain:[00m  for machine 'master'
0:00:00.500199000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:683:bt_machine_add_input_element:[00m machine 'master_0x82de3c0' is connected to 'input_level_0x82de3c0'
0:00:00.500244000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:444:bt_machine_insert_element:[00m positions: 2 ... 3(input_gain_0x82de3c0) ... 4
0:00:00.500680000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:689:bt_machine_add_input_element:[00m sucessfully inserted element'input_gain_0x82de3c0' for 'master_0x82de3c0'
0:00:00.500704000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit edit-application.c:373:bt_edit_application_new_song:[00m sink-machine-refs: 2
0:00:00.500763000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:458:bt_song_set_unsaved:[00m unsaved = 0
0:00:00.500806000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit edit-application.c:805:bt_edit_application_set_property:[00m set the song for edit_application: 0x8335590
0:00:00.500839000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-menu.c:403:on_song_changed:[00m song has changed : app=0x80ac878, toolbar=0x81c5008
0:00:00.500903000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-menu.c:394:on_song_unsaved_changed:[00m song.unsaved has changed : song=0x8335590, menu=0x81c5008, unsaved=0
0:00:00.500932000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:401:on_song_changed:[00m song has changed : app=0x80ac878, toolbar=0x8128118
0:00:00.500970000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:416:on_song_changed:[00m connect to input-level : song=0x8335590,  master=0x82de3c0 (refs: 3)
0:00:00.625816000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:383:on_song_unsaved_changed:[00m song.unsaved has changed : song=0x8335590, toolbar=0x8128118
0:00:00.626144000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-machines.c:396:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82be008
0:00:00.626178000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:178:machine_view_refresh:[00m before destoying machine canvas items
0:00:00.626221000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:180:machine_view_refresh:[00m before destoying wire canvas items
0:00:00.626237000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:182:machine_view_refresh:[00m done
0:00:00.696320000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:229:machine_view_refresh:[00m drawing done
0:00:00.696759000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:1199:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82d4808
0:00:00.696850000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:666:machine_menu_add:[00m   adding "master"  (machine-refs: 3)
0:00:00.696961000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:676:machine_menu_add:[00m   (machine-refs: 4)
0:00:00.697493000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:1670:bt_main_page_patterns_get_current_machine:[00m get current machine
0:00:00.697629000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:1700:bt_main_page_patterns_get_current_pattern:[00m get current pattern
0:00:00.697659000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:1706:bt_main_page_patterns_get_current_pattern:[00m   got machine: (machine-refs: 6)
0:00:00.697677000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:1080:on_pattern_menu_changed:[00m new pattern selected : (nil)
0:00:00.697738000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:833:pattern_table_refresh:[00m refresh pattern table
0:00:00.697757000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:801:pattern_table_clear:[00m clearing pattern table
0:00:00.697781000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:809:pattern_table_clear:[00m done
0:00:00.697825000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:984:pattern_table_refresh:[00m     activating dummy store: 0x851f2c0
0:00:00.698326000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:998:pattern_table_refresh:[00m     number of columns : 1
0:00:00.698349000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:1004:pattern_table_refresh:[00m   done
0:00:00.832383000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:459:on_header_size_allocate:[00m #### header label size 100 x 48
0:00:00.894234000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:1426:bt_machine_is_polyphonic:[00m  is machine "master" polyphonic ? 0
0:00:00.894773000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:2069:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82be0f8
0:00:00.894865000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:779:sequence_table_refresh:[00m refresh sequence table
0:00:00.894894000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:783:sequence_table_refresh:[00m   size is 64, 0
0:00:00.895174000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:789:sequence_table_refresh:[00m   build model
0:00:00.897769000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:1441:on_label_menu_changed:[00m bars_menu has changed : page=0x82be0f8
0:00:00.897815000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:896:sequence_table_refresh:[00m   build view
0:00:00.897834000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:694:sequence_table_init:[00m preparing sequence table
0:00:00.897851000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:698:sequence_table_init:[00m holding label widget: 2
0:00:00.897928000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:701:sequence_table_init:[00m                     : 2
0:00:00.899112000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:751:sequence_table_init:[00m     number of columns : 1
0:00:00.899507000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:1035:sequence_table_refresh:[00m     number of columns : 2
0:00:00.899538000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:1060:pattern_list_refresh:[00m refresh pattern list
0:00:00.899570000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:2365:bt_main_page_sequence_get_current_machine:[00m get active machine
0:00:00.899745000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:1141:machine_menu_refresh:[00m refreshing track menu
0:00:00.902332000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:1413:on_bars_menu_changed:[00m bars_menu has changed : page=0x82be0f8
0:00:00.902517000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit sequence-view.c:283:bt_sequence_view_set_property:[00m visible-rows = 4
0:00:00.902544000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit sequence-view.c:283:bt_sequence_view_set_property:[00m visible-rows = 4
0:00:00.902563000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:370:sequence_model_recolorize:[00m recolorize sequence tree view
0:00:00.904447000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit sequence-view.c:283:bt_sequence_view_set_property:[00m visible-rows = 4
0:00:00.904509000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit sequence-view.c:283:bt_sequence_view_set_property:[00m visible-rows = 4
0:00:00.904574000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:370:sequence_model_recolorize:[00m recolorize sequence tree view
0:00:00.905030000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-waves.c:212:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82f5c88
0:00:00.905059000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-waves.c:88:waves_list_refresh:[00m refresh waves list: self=0x82f5c88, wavetable=0x83e2740
0:00:00.907843000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-info.c:235:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82e1888
0:00:00.908375000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-statusbar.c:204:on_song_changed:[00m song has changed : app=0x80ac878, self=0x80fc3f0
0:00:00.908432000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-statusbar.c:89:bt_main_statusbar_update_length:[00m   new msec : 7680
0:00:00.908584000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:136:on_song_changed:[00m song has changed : app=0x80ac878, window=0x813d830
0:00:00.908774000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:127:on_song_unsaved_changed:[00m song.unsaved has changed : song=0x8335590, menu=0x813d830, unsaved=0
0:00:00.908804000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit edit-application.c:382:bt_edit_application_new_song:[00m sink-machine-refs: 4
0:00:00.908856000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:266:bt_edit_application_run_ui:[00m application.run_ui launched
0:00:00.908911000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:160:bt_gconf_settings_get_property:[00m application reads news-seen gconf_settings : '100'
0:00:01.029991000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:459:on_header_size_allocate:[00m #### header label size 100 x 48
0:00:03.717065000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:329:bt_main_window_run:[00m before running the UI
0:00:05.549032000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:163:on_toolbar_open_clicked:[00m toolbar open event occurred
0:00:08.455572000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:414:bt_edit_application_load_song:[00m song name = /usr/local/share/buzztard/songs/buzz1.xml
0:00:08.455768000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:128:bt_song_io_detect:[00m detecting loader for file '/usr/local/share/buzztard/songs/buzz1.xml'
0:00:08.455914000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:78:bt_song_io_register_plugins:[00m register song-io plugins ...
0:00:08.455937000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:82:bt_song_io_register_plugins:[00m   scanning external song-io plugins in /usr/local/lib/songio/ ...
0:00:08.456049000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:95:bt_song_io_register_plugins:[00m     found file 'libbtbsl.la'
0:00:08.458912000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:100:bt_song_io_register_plugins:[00m     that is a shared object
0:00:08.458966000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:103:bt_song_io_register_plugins:[00m     and implements a songio subclass
0:00:08.459005000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:95:bt_song_io_register_plugins:[00m     found file 'libbtbsl.so.0.1.0'
0:00:08.459147000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:100:bt_song_io_register_plugins:[00m     that is a shared object
0:00:08.459213000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:103:bt_song_io_register_plugins:[00m     and implements a songio subclass
0:00:08.459241000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:95:bt_song_io_register_plugins:[00m     found file 'libbtbsl.a'
0:00:08.459412000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:135:bt_song_io_detect:[00m   trying ...
0:00:08.459437000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io-native.c:59:bt_song_io_native_detect:[00m file_name='/usr/local/share/buzztard/songs/buzz1.xml'
0:00:08.459486000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io-native.c:65:bt_song_io_native_detect:[00m creating absolute file uri string: file:///usr/local/share/buzztard/songs/buzz1.xml
0:00:08.459545000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io-native.c:89:bt_song_io_native_detect:[00m given uri exists
0:00:08.459657000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:138:bt_song_io_detect:[00m   found one!
0:00:08.563647000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:431:bt_song_info_init:[00m date initialized as 2007-02-19T14:01:19Z
0:00:08.563829000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1121:bt_song_init:[00m   done
0:00:08.563856000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1006:bt_song_set_property:[00m set the app for the song: 0x80ac878
0:00:08.563876000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1014:bt_song_set_property:[00m set the bin for the song: 0x8128030
0:00:08.563933000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:432:bt_song_new:[00m   lopp-signals connected
0:00:08.563967000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:156:bt_song_update_play_seek_event:[00m loop 0? -1 ... -1, length 0 bar_time 120000000
0:00:08.563998000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:435:bt_song_new:[00m   new song created: 0x8582510
0:00:08.564093000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io-native.c:121:bt_song_io_native_load:[00m native io will now load song from "/usr/local/share/buzztard/songs/buzz1.xml"
0:00:08.564128000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-io.c:324:bt_song_io_set_property:[00m set the status for song_io: Loading file '/usr/local/share/buzztard/songs/buzz1.xml'
0:00:08.564166000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:80:on_songio_status_changed:[00m songio_status has changed : "Loading file '/usr/local/share/buzztard/songs/buzz1.xml'"
0:00:08.568140000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:908:bt_song_persistence_load:[00m PERSISTENCE::song
0:00:08.568209000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:155:bt_song_info_persistence_load:[00m PERSISTENCE::song-info
0:00:08.568249000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:165:bt_song_info_persistence_load:[00m   "info"="one buzz generator"
0:00:08.568301000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:458:bt_song_set_unsaved:[00m unsaved = 1
0:00:08.568328000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:278:bt_song_info_set_property:[00m set the info for song_info: one buzz generator
0:00:08.568351000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:165:bt_song_info_persistence_load:[00m   "name"="buzz 1"
0:00:08.568457000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:287:bt_song_info_set_property:[00m set the name for song_info: buzz 1
0:00:08.568516000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:165:bt_song_info_persistence_load:[00m   "genre"="dark-wave"
0:00:08.568543000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:296:bt_song_info_set_property:[00m set the genre for song_info: dark-wave
0:00:08.568564000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:165:bt_song_info_persistence_load:[00m   "bpm"="120"
0:00:08.568621000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:316:bt_song_info_set_property:[00m set the bpm for song_info: 120
0:00:08.568642000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:165:bt_song_info_persistence_load:[00m   "tpb"="4"
0:00:08.568666000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:165:bt_song_info_persistence_load:[00m   "bars"="16"
0:00:08.568690000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:165:bt_song_info_persistence_load:[00m   "create-dts"="2005-09-20T22:10:56Z"
0:00:08.568747000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:165:bt_song_info_persistence_load:[00m   "change-dts"="2005-09-20T22:10:56Z"
0:00:08.570193000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:585:bt_setup_persistence_load:[00m PERSISTENCE::setup
0:00:08.570257000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2501:bt_machine_init:[00m !!!! self=0x83260a0
0:00:08.570285000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2353:bt_machine_set_property:[00m set the song for machine: 0x8582510
0:00:08.570335000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:121:bt_sink_machine_persistence_load:[00m PERSISTENCE::sink_machine
0:00:08.570363000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2370:bt_machine_set_property:[00m set the plugin_name for machine: bt-sink-bin
0:00:08.570384000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2173:bt_machine_persistence_load:[00m PERSISTENCE::machine
0:00:08.570408000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2358:bt_machine_set_property:[00m set the id for machine: audio_sink
0:00:08.570690000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:337:bt_sink_bin_update:[00m clearing sink-bin
0:00:08.570711000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:114:bt_sink_bin_clear:[00m clearing sink-bin : 0
0:00:08.570727000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:126:bt_sink_bin_clear:[00m done
0:00:08.570743000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:342:bt_sink_bin_update:[00m initializing sink-bin
0:00:08.570758000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core settings.c:82:bt_settings_new:[00m return cached settings object (refct=1) for thread 0x8096e30
0:00:08.570775000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core settings.c:85:bt_settings_new:[00m settings created 0x80b46f0
0:00:08.570811000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:113:bt_gconf_settings_get_property:[00m application reads audiosink gconf_settings : 'alsasink'
0:00:08.570836000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:165:bt_gconf_settings_get_property:[00m application reads system audiosink gconf_settings : '(null)'
0:00:08.570854000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:162:bt_sink_bin_determine_plugin_name:[00m get audiosink from config
0:00:08.570870000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:224:bt_sink_bin_determine_plugin_name:[00m using audio sink : "alsasink"
0:00:08.605866000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:132:bt_sink_bin_add_many:[00m add elements: list=0x85b4c10
0:00:08.606038000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:143:bt_sink_bin_link_many:[00m link elements: list=(nil)
0:00:08.606068000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:422:bt_sink_bin_update:[00m updating ghost pad : elem=0x843c2e8 (ref_ct=1),'player', pad=0x82f1718 (ref_ct=2)
0:00:08.606219000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:424:bt_sink_bin_update:[00m   done, pad=0x82f1718 (ref_ct=3)
0:00:08.606239000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:427:bt_sink_bin_update:[00m done
0:00:08.606299000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:744:bt_machine_init_core_machine:[00m   instantiated machine 0x84319e8, "bt-sink-bin", machine->ref_count=1
0:00:08.606322000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:772:bt_machine_init_interfaces:[00m machine element instantiated and interfaces initialized
0:00:08.606342000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:981:bt_machine_setup:[00m machine-refs: 1
0:00:08.606553000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:959:bt_machine_init_voice_params:[00m   instance is monophonic!
0:00:08.606570000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:988:bt_machine_setup:[00m machine-refs: 1
0:00:08.606585000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:991:bt_machine_setup:[00m   added machine 0x84319e8 to bin, machine->ref_count=1  bin->ref_count=6
0:00:08.606670000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1045:bt_pattern_set_property:[00m set the machine for pattern: 0x83260a0 (machine-refs: 3)
0:00:08.606697000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1013:bt_pattern_set_property:[00m set the id for pattern: audio_sink___break
0:00:08.606718000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1018:bt_pattern_set_property:[00m set the display name for the pattern:    break
0:00:08.606737000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1025:bt_pattern_set_property:[00m set the length for pattern: 1
0:00:08.606753000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:178:bt_pattern_resize_data_length:[00m extended pattern length from 0 to 1 : data_count=1 = length=1 * ( ip=1 + gp=0 + voices=0 * vp=0 )
0:00:08.606783000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core pattern.c:142:bt_pattern_init_data:[00m data has already been initialized
0:00:08.606842000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1045:bt_pattern_set_property:[00m set the machine for pattern: 0x83260a0 (machine-refs: 3)
0:00:08.606867000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1013:bt_pattern_set_property:[00m set the id for pattern: audio_sink___mute
0:00:08.606886000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1018:bt_pattern_set_property:[00m set the display name for the pattern:    mute
0:00:08.606904000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1025:bt_pattern_set_property:[00m set the length for pattern: 1
0:00:08.606919000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:178:bt_pattern_resize_data_length:[00m extended pattern length from 0 to 1 : data_count=1 = length=1 * ( ip=1 + gp=0 + voices=0 * vp=0 )
0:00:08.606947000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core pattern.c:142:bt_pattern_init_data:[00m data has already been initialized
0:00:08.607012000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:1015:bt_machine_setup:[00m machine-refs: 1
0:00:08.607113000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:52:bt_sink_machine_post_init:[00m   audio_sink this will be the master for the song
0:00:08.607139000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1020:bt_song_set_property:[00m set the master for the song: 0x83260a0 (machine-refs: 3)
0:00:08.607247000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2501:bt_machine_init:[00m !!!! self=0x8326140
0:00:08.607273000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2353:bt_machine_set_property:[00m set the song for machine: 0x8582510
0:00:08.607418000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2370:bt_machine_set_property:[00m set the plugin_name for machine: bml-CyanPhase-DTMF-1
0:00:08.607447000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2173:bt_machine_persistence_load:[00m PERSISTENCE::machine
0:00:08.607469000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2358:bt_machine_set_property:[00m set the id for machine: gen
0:00:08.926619000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:744:bt_machine_init_core_machine:[00m   instantiated machine 0x85f8010, "bml-CyanPhase-DTMF-1", machine->ref_count=1
0:00:08.926844000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:770:bt_machine_init_interfaces:[00m   tempo iface initialized
0:00:08.926865000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:772:bt_machine_init_interfaces:[00m machine element instantiated and interfaces initialized
0:00:08.926887000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:981:bt_machine_setup:[00m machine-refs: 1
0:00:08.927031000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:876:bt_machine_init_global_params:[00m     adding global_param [0/4] "Dial-Number"
0:00:08.927522000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:898:bt_machine_init_global_params:[00m     added global_param [0/4] "Dial-Number"
0:00:08.927544000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:876:bt_machine_init_global_params:[00m     adding global_param [1/4] "Sustain"
0:00:08.927572000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:898:bt_machine_init_global_params:[00m     added global_param [1/4] "Sustain"
0:00:08.927589000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:876:bt_machine_init_global_params:[00m     adding global_param [2/4] "Twist"
0:00:08.927615000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:898:bt_machine_init_global_params:[00m     added global_param [2/4] "Twist"
0:00:08.927633000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:876:bt_machine_init_global_params:[00m     adding global_param [3/4] "Volume"
0:00:08.927657000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:898:bt_machine_init_global_params:[00m     added global_param [3/4] "Volume"
0:00:08.927676000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:959:bt_machine_init_voice_params:[00m   instance is monophonic!
0:00:08.927692000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:988:bt_machine_setup:[00m machine-refs: 1
0:00:08.927707000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:991:bt_machine_setup:[00m   added machine 0x85f8010 to bin, machine->ref_count=1  bin->ref_count=7
0:00:08.927789000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1045:bt_pattern_set_property:[00m set the machine for pattern: 0x8326140 (machine-refs: 3)
0:00:08.927843000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1013:bt_pattern_set_property:[00m set the id for pattern: gen___break
0:00:08.927863000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1018:bt_pattern_set_property:[00m set the display name for the pattern:    break
0:00:08.927883000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1025:bt_pattern_set_property:[00m set the length for pattern: 1
0:00:08.927899000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:178:bt_pattern_resize_data_length:[00m extended pattern length from 0 to 1 : data_count=5 = length=1 * ( ip=1 + gp=4 + voices=0 * vp=0 )
0:00:08.927929000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core pattern.c:142:bt_pattern_init_data:[00m data has already been initialized
0:00:08.927991000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1045:bt_pattern_set_property:[00m set the machine for pattern: 0x8326140 (machine-refs: 3)
0:00:08.928015000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1013:bt_pattern_set_property:[00m set the id for pattern: gen___mute
0:00:08.928034000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1018:bt_pattern_set_property:[00m set the display name for the pattern:    mute
0:00:08.928052000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1025:bt_pattern_set_property:[00m set the length for pattern: 1
0:00:08.928068000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:178:bt_pattern_resize_data_length:[00m extended pattern length from 0 to 1 : data_count=5 = length=1 * ( ip=1 + gp=4 + voices=0 * vp=0 )
0:00:08.928094000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core pattern.c:142:bt_pattern_init_data:[00m data has already been initialized
0:00:08.928153000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1045:bt_pattern_set_property:[00m set the machine for pattern: 0x8326140 (machine-refs: 3)
0:00:08.928177000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1013:bt_pattern_set_property:[00m set the id for pattern: gen___solo
0:00:08.928196000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1018:bt_pattern_set_property:[00m set the display name for the pattern:    solo
0:00:08.928213000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1025:bt_pattern_set_property:[00m set the length for pattern: 1
0:00:08.928229000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:178:bt_pattern_resize_data_length:[00m extended pattern length from 0 to 1 : data_count=5 = length=1 * ( ip=1 + gp=4 + voices=0 * vp=0 )
0:00:08.928255000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core pattern.c:142:bt_pattern_init_data:[00m data has already been initialized
0:00:08.928284000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:1158:bt_machine_enable_output_gain:[00m  for machine 'gen'
0:00:08.928421000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:709:bt_machine_add_output_element:[00m machine 'gen_0x8326140' is not yet connected on the output side
0:00:08.928522000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:719:bt_machine_add_output_element:[00m sucessfully appended element 'output_gain_0x8326140' for 'gen_0x8326140'
0:00:08.928541000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:1015:bt_machine_setup:[00m machine-refs: 1
0:00:08.928593000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1045:bt_pattern_set_property:[00m set the machine for pattern: 0x8326140 (machine-refs: 3)
0:00:08.928638000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:882:bt_pattern_persistence_load:[00m PERSISTENCE::pattern
0:00:08.928665000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1013:bt_pattern_set_property:[00m set the id for pattern: gen_beeps
0:00:08.928686000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1018:bt_pattern_set_property:[00m set the display name for the pattern: beeps
0:00:08.928705000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1025:bt_pattern_set_property:[00m set the length for pattern: 16
0:00:08.928724000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:178:bt_pattern_resize_data_length:[00m extended pattern length from 0 to 16 : data_count=80 = length=16 * ( ip=1 + gp=4 + voices=0 * vp=0 )
0:00:08.928747000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core pattern.c:142:bt_pattern_init_data:[00m data has already been initialized
0:00:08.929040000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:678:bt_wire_set_property:[00m set the source element for the wire: (nil)
0:00:08.929070000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:683:bt_wire_set_property:[00m set the target element for the wire: (nil)
0:00:08.929096000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:593:bt_wire_persistence_load:[00m PERSISTENCE::wire
0:00:08.929124000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:600:bt_wire_persistence_load:[00m src gen -> 0x8326140
0:00:08.929145000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:605:bt_wire_persistence_load:[00m dst audio_sink -> 0x83260a0
0:00:08.929201000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:468:bt_setup_get_wire_by_machines:[00m no wire found for machines 0x8326140 0x83260a0
0:00:08.929219000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:468:bt_setup_get_wire_by_machines:[00m no wire found for machines 0x83260a0 0x8326140
0:00:08.929234000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:404:bt_wire_connect:[00m bin->refs=8, src->refs=2, dst->refs=2
0:00:08.929249000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:405:bt_wire_connect:[00m trying to link machines : 0x84422e0 'output_gain_0x8326140' -> 0x84319e8 'audio_sink_0x83260a0'
0:00:08.929275000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:126:bt_setup_get_wire_by_machine_type:[00m no wire found for src-machine 0x8326140
0:00:08.929304000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:126:bt_setup_get_wire_by_machine_type:[00m no wire found for dst-machine 0x83260a0
0:00:08.929319000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:453:bt_wire_connect:[00m link prepared, bin->refs=8, src->refs=2, dst->refs=2
0:00:08.929451000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:227:bt_wire_link_machines:[00m created volume-gain element for wire : 0x84422e0 'output_gain_0x8326140' -> 0x84319e8 'audio_sink_0x83260a0'
0:00:08.942402000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:232:bt_wire_link_machines:[00m created tee element for wire : 0x84422e0 'output_gain_0x8326140' -> 0x84319e8 'audio_sink_0x83260a0'
0:00:08.942559000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:235:bt_wire_link_machines:[00m trying to link machines directly : 0x84422e0 'output_gain_0x8326140' -> 0x84319e8 'audio_sink_0x83260a0'
0:00:08.944851000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:245:bt_wire_link_machines:[00m trying to link machines with convert
0:00:08.946724000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:292:bt_wire_link_machines:[00m   wire okay with convert
0:00:08.946777000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:459:bt_wire_connect:[00m linking machines succeeded, bin->refs=8, src->refs=2, dst->refs=2
0:00:08.946824000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:468:bt_setup_get_wire_by_machines:[00m no wire found for machines 0x8326140 0x83260a0
0:00:08.946844000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:468:bt_setup_get_wire_by_machines:[00m no wire found for machines 0x83260a0 0x8326140
0:00:08.946868000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1130:bt_sequence_persistence_load:[00m PERSISTENCE::sequence
0:00:08.946918000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1286:bt_sequence_set_property:[00m set the length for sequence: 64
0:00:08.946937000 [335m 2884[00m 0x8096e30 [33;01mWARN [00m [00m             bt-core sequence.c:176:bt_sequence_resize_data_length:[00m extending sequence length from 0 to 64 failed : data_count=0 = length=64 * tracks=0
0:00:08.946962000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1307:bt_sequence_set_property:[00m set the tracks for sequence: 1
0:00:08.946980000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:213:bt_sequence_resize_data_tracks:[00m resize to new_data_count=64
0:00:08.947005000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1314:bt_sequence_set_property:[00m set the loop for sequence: 0
0:00:08.947039000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1337:bt_sequence_set_property:[00m set the loop-start for sequence: -1
0:00:08.947061000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1344:bt_sequence_set_property:[00m set the loop-end for sequence: -1
0:00:08.947116000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:156:bt_song_update_play_seek_event:[00m loop 0? -1 ... -1, length 64 bar_time 125000000
0:00:08.947178000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:156:bt_song_update_play_seek_event:[00m loop 0? -1 ... -1, length 64 bar_time 125000000
0:00:08.947226000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:156:bt_song_update_play_seek_event:[00m loop 0? -1 ... -1, length 64 bar_time 125000000
0:00:08.947277000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:156:bt_song_update_play_seek_event:[00m loop 0? -1 ... -1, length 64 bar_time 125000000
0:00:08.947360000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:899:bt_sequence_set_label:[00m set label for time 0
0:00:08.947382000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:899:bt_sequence_set_label:[00m set label for time 63
0:00:08.947413000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1179:bt_sequence_persistence_load:[00m loading track with index=0 for machine="gen"
0:00:08.947433000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1184:bt_sequence_persistence_load:[00m   at 0, machinepattern "gen_beeps"
0:00:08.947487000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sequence.c:953:bt_sequence_set_pattern:[00m set pattern 0x85a7a48 for time 0, track 0
0:00:08.947506000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:969:bt_sequence_set_pattern:[00m set new pattern
0:00:08.947539000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sequence.c:348:bt_sequence_get_number_of_pattern_uses:[00m get pattern uses = 1
0:00:08.947568000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:425:bt_sequence_invalidate_pattern_region:[00m invalidate pattern 0x85a7a48 region for tick=    0, track=  0
0:00:08.947650000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:459:bt_sequence_invalidate_pattern_region:[00m done
0:00:08.947680000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:560:bt_sequence_repair_damage:[00m repair damage
0:00:08.947705000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:565:bt_sequence_repair_damage:[00m check damage for track 0
0:00:08.947727000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:568:bt_sequence_repair_damage:[00m repair damage for track 0
0:00:08.947755000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=    0
0:00:08.947865000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=    4
0:00:08.947898000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=    8
0:00:08.947924000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=    0
0:00:08.947948000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=    0
0:00:08.947971000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:988:bt_sequence_set_pattern:[00m done
0:00:08.947989000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1184:bt_sequence_persistence_load:[00m   at 32, machinepattern "gen_beeps"
0:00:08.948018000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sequence.c:953:bt_sequence_set_pattern:[00m set pattern 0x85a7a48 for time 32, track 0
0:00:08.948035000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:969:bt_sequence_set_pattern:[00m set new pattern
0:00:08.948056000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sequence.c:348:bt_sequence_get_number_of_pattern_uses:[00m get pattern uses = 2
0:00:08.948073000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:425:bt_sequence_invalidate_pattern_region:[00m invalidate pattern 0x85a7a48 region for tick=   32, track=  0
0:00:08.948115000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:459:bt_sequence_invalidate_pattern_region:[00m done
0:00:08.948131000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:560:bt_sequence_repair_damage:[00m repair damage
0:00:08.948147000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:565:bt_sequence_repair_damage:[00m check damage for track 0
0:00:08.948166000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:568:bt_sequence_repair_damage:[00m repair damage for track 0
0:00:08.948182000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=   36
0:00:08.948205000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=   40
0:00:08.948228000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=   32
0:00:08.948251000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=   32
0:00:08.948274000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:478:bt_sequence_repair_global_damage_entry:[00m repair global damage entry for tick=   32
0:00:08.948309000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:988:bt_sequence_set_pattern:[00m done
0:00:08.948798000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-io.c:324:bt_song_io_set_property:[00m set the status for song_io: (null)
0:00:08.948838000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:80:on_songio_status_changed:[00m songio_status has changed : ""
0:00:08.954791000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:270:bt_song_info_set_property:[00m set the file-name for song_info: buzz1.xml
0:00:08.954950000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song-io.c:233:bt_song_io_load:[00m loading done
0:00:08.954973000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:458:bt_song_set_unsaved:[00m unsaved = 0
0:00:08.955043000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:1072:bt_machine_enable_input_level:[00m  for machine 'audio_sink'
0:00:08.955300000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:683:bt_machine_add_input_element:[00m machine 'audio_sink_0x83260a0' is connected to 'audioconvert_0x85ab438'
0:00:08.955322000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:444:bt_machine_insert_element:[00m positions: -1 ... 2(input_level_0x83260a0) ... 4
0:00:08.957462000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:689:bt_machine_add_input_element:[00m sucessfully inserted element'input_level_0x83260a0' for 'audio_sink_0x83260a0'
0:00:08.957488000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:1132:bt_machine_enable_input_gain:[00m  for machine 'audio_sink'
0:00:08.957671000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:683:bt_machine_add_input_element:[00m machine 'audio_sink_0x83260a0' is connected to 'input_level_0x83260a0'
0:00:08.957692000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:444:bt_machine_insert_element:[00m positions: 2 ... 3(input_gain_0x83260a0) ... 4
0:00:08.959921000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:689:bt_machine_add_input_element:[00m sucessfully inserted element'input_gain_0x83260a0' for 'audio_sink_0x83260a0'
0:00:08.960324000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:841:bt_song_write_to_dot_file:[00m wire output_gain_0x8326140->input_level_0x83260a0 has 5 elements
0:00:08.960551000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1049:bt_song_dispose:[00m !!!! self=0x8335590
0:00:08.960905000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1057:bt_song_dispose:[00m ->NULL state change returned 1
0:00:08.960967000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1070:bt_song_dispose:[00m sink-machine-refs: 3
0:00:08.961001000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1077:bt_song_dispose:[00m refs: song_info: 1, sequence: 1, setup: 1, wavetable: 1
0:00:08.961020000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:388:bt_song_info_dispose:[00m !!!! self=0x842acb8
0:00:08.961043000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:397:bt_song_info_finalize:[00m !!!! self=0x842acb8
0:00:08.961084000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1362:bt_sequence_dispose:[00m !!!! self=0x842ad00
0:00:08.961110000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1385:bt_sequence_finalize:[00m !!!! self=0x842ad00
0:00:08.961135000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:726:bt_setup_dispose:[00m !!!! self=0x833b118
0:00:08.961152000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:745:bt_setup_dispose:[00m   free machine : 0x82de3c0 (3)
0:00:08.961190000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:758:bt_setup_finalize:[00m !!!! self=0x833b118
0:00:08.961210000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wavetable.c:299:bt_wavetable_dispose:[00m !!!! self=0x83e2740
0:00:08.961228000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wavetable.c:324:bt_wavetable_finalize:[00m !!!! self=0x83e2740
0:00:08.961254000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1090:bt_song_dispose:[00m   chaining up
0:00:08.961282000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1092:bt_song_dispose:[00m   done
0:00:08.961298000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1098:bt_song_finalize:[00m !!!! self=0x8335590
0:00:08.961313000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1100:bt_song_finalize:[00m   chaining up
0:00:08.961328000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1102:bt_song_finalize:[00m   done
0:00:08.961344000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit edit-application.c:805:bt_edit_application_set_property:[00m set the song for edit_application: 0x8582510
0:00:08.961373000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-menu.c:403:on_song_changed:[00m song has changed : app=0x80ac878, toolbar=0x81c5008
0:00:08.961401000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-menu.c:394:on_song_unsaved_changed:[00m song.unsaved has changed : song=0x8582510, menu=0x81c5008, unsaved=0
0:00:08.961429000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:401:on_song_changed:[00m song has changed : app=0x80ac878, toolbar=0x8128118
0:00:08.961459000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:416:on_song_changed:[00m connect to input-level : song=0x8582510,  master=0x83260a0 (refs: 4)
0:00:08.961536000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:383:on_song_unsaved_changed:[00m song.unsaved has changed : song=0x8582510, toolbar=0x8128118
0:00:08.961564000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-machines.c:396:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82be008
0:00:08.961587000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:178:machine_view_refresh:[00m before destoying machine canvas items
0:00:08.961615000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:651:bt_machine_canvas_item_dispose:[00m !!!! self=0x82bf930
0:00:08.961632000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:653:bt_machine_canvas_item_dispose:[00m machine-refs: 2
0:00:08.961654000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:658:bt_machine_canvas_item_dispose:[00m   unrefing done
0:00:08.961670000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:666:bt_machine_canvas_item_dispose:[00m   destroying dialogs done
0:00:08.962409000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:672:bt_machine_canvas_item_dispose:[00m   destroying done
0:00:08.962429000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:674:bt_machine_canvas_item_dispose:[00m   chaining up
0:00:08.962670000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:676:bt_machine_canvas_item_dispose:[00m   done
0:00:08.962693000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:685:bt_machine_canvas_item_finalize:[00m   done
0:00:08.962710000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:180:machine_view_refresh:[00m before destoying wire canvas items
0:00:08.962738000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:182:machine_view_refresh:[00m done
0:00:09.074997000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit wire-canvas-item.c:394:bt_wire_canvas_item_set_property:[00m set the src for wire_canvas_item: 0x82bfba0
0:00:09.075338000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit wire-canvas-item.c:402:bt_wire_canvas_item_set_property:[00m set the dst for wire_canvas_item: 0x82bfad0
0:00:09.075375000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit wire-canvas-item.c:473:bt_wire_canvas_item_realize:[00m realize for wire occured, wire=0x85ab438 : w=560,000000,h=0,000000
0:00:09.075639000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:229:machine_view_refresh:[00m drawing done
0:00:09.075669000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:1199:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82d4808
0:00:09.075719000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:666:machine_menu_add:[00m   adding "audio_sink"  (machine-refs: 4)
0:00:09.075836000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:676:machine_menu_add:[00m   (machine-refs: 5)
0:00:09.075862000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:666:machine_menu_add:[00m   adding "gen"  (machine-refs: 4)
0:00:09.075907000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:676:machine_menu_add:[00m   (machine-refs: 5)
0:00:09.076663000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:194:bt_sink_machine_dispose:[00m !!!! self=0x82de3c0
0:00:09.076689000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2409:bt_machine_dispose:[00m !!!! self=0x82de3c0, song=(nil)
0:00:09.076710000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2428:bt_machine_dispose:[00m   bin->ref_count=6
0:00:09.076730000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2433:bt_machine_dispose:[00m   removing machine "input_level_0x82de3c0" from bin, obj->ref_count=1
0:00:09.076759000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2437:bt_machine_dispose:[00m ->NULL state change returned 1
0:00:09.076887000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2439:bt_machine_dispose:[00m   bin->ref_count=6
0:00:09.076908000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2433:bt_machine_dispose:[00m   removing machine "input_gain_0x82de3c0" from bin, obj->ref_count=2
0:00:09.076928000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2437:bt_machine_dispose:[00m ->NULL state change returned 1
0:00:09.076958000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2439:bt_machine_dispose:[00m   bin->ref_count=6
0:00:09.076975000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2433:bt_machine_dispose:[00m   removing machine "master_0x82de3c0" from bin, obj->ref_count=1
0:00:09.077019000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2437:bt_machine_dispose:[00m ->NULL state change returned 1
0:00:09.077049000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:555:bt_sink_bin_dispose:[00m !!!! self=0x8431838
0:00:09.077067000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:557:bt_sink_bin_dispose:[00m self->sink=0x8433000, refct=1
0:00:09.077128000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:563:bt_sink_bin_dispose:[00m chaining up
0:00:09.077543000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:568:bt_sink_bin_dispose:[00m done
0:00:09.077566000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:574:bt_sink_bin_finalize:[00m !!!! self=0x8431838
0:00:09.077586000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2439:bt_machine_dispose:[00m   bin->ref_count=6
0:00:09.077603000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2443:bt_machine_dispose:[00m   releasing the bin, bin->ref_count=6
0:00:09.077618000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2450:bt_machine_dispose:[00m   releasing patterns
0:00:09.077634000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1066:bt_pattern_dispose:[00m !!!! self=0x8353950
0:00:09.077653000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1077:bt_pattern_finalize:[00m !!!! self=0x8353950
0:00:09.077671000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1066:bt_pattern_dispose:[00m !!!! self=0x8353990
0:00:09.077688000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1077:bt_pattern_finalize:[00m !!!! self=0x8353990
0:00:09.077705000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2461:bt_machine_dispose:[00m   chaining up
0:00:09.077727000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2463:bt_machine_dispose:[00m   done
0:00:09.077743000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:201:bt_sink_machine_finalize:[00m !!!! self=0x82de3c0
0:00:09.077759000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2469:bt_machine_finalize:[00m !!!! self=0x82de3c0
0:00:09.077811000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:1670:bt_main_page_patterns_get_current_machine:[00m get current machine
0:00:09.077871000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:718:pattern_menu_refresh:[00m   adding "beeps"
0:00:09.078243000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:1700:bt_main_page_patterns_get_current_pattern:[00m get current pattern
0:00:09.078276000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:1706:bt_main_page_patterns_get_current_pattern:[00m   got machine: (machine-refs: 7)
0:00:09.078300000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:1080:on_pattern_menu_changed:[00m new pattern selected : 0x85a7a48
0:00:09.078318000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:833:pattern_table_refresh:[00m refresh pattern table
0:00:09.078333000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:801:pattern_table_clear:[00m clearing pattern table
0:00:09.078349000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:803:pattern_table_clear:[00m is not empty
0:00:09.078527000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-patterns.c:809:pattern_table_clear:[00m done
0:00:09.078562000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:842:pattern_table_refresh:[00m   size is 16, 4
0:00:09.078578000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:845:pattern_table_refresh:[00m   build model
0:00:09.078946000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:886:pattern_table_refresh:[00m     activating store: 0x851f000
0:00:09.079155000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:891:pattern_table_refresh:[00m   build view
0:00:09.080692000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:998:pattern_table_refresh:[00m     number of columns : 5
0:00:09.080715000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:1004:pattern_table_refresh:[00m   done
0:00:09.141617000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:1426:bt_machine_is_polyphonic:[00m  is machine "gen" polyphonic ? 0
0:00:09.141861000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:2069:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82be0f8
0:00:09.141911000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:779:sequence_table_refresh:[00m refresh sequence table
0:00:09.141937000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:783:sequence_table_refresh:[00m   size is 64, 1
0:00:09.142271000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:789:sequence_table_refresh:[00m   build model
0:00:09.142370000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:838:sequence_table_refresh:[00m adding : 0 : start
0:00:09.143825000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:838:sequence_table_refresh:[00m adding : 63 : end
0:00:09.144925000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:1441:on_label_menu_changed:[00m bars_menu has changed : page=0x82be0f8
0:00:09.144984000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:1450:on_label_menu_changed:[00m   move to = 0
0:00:09.145095000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:896:sequence_table_refresh:[00m   build view
0:00:09.145117000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:694:sequence_table_init:[00m preparing sequence table
0:00:09.145134000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:698:sequence_table_init:[00m holding label widget: 3
0:00:09.145197000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:701:sequence_table_init:[00m                     : 3
0:00:09.146179000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:751:sequence_table_init:[00m     number of columns : 1
0:00:09.146258000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:1102:bt_machine_enable_output_level:[00m  for machine 'gen'
0:00:09.146463000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:722:bt_machine_add_output_element:[00m machine 'gen_0x8326140' is connected to 'output_gain_0x8326140'
0:00:09.146485000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core machine.c:444:bt_machine_insert_element:[00m positions: 4 ... 5(output_level_0x8326140) ... 6
0:00:09.146661000 [335m 2884[00m 0x8096e30 [33;01mWARN [00m [00m             bt-core machine.c:453:bt_machine_insert_element:[00m failed to link part 'output_level_0x8326140' inbetween 'gen_0x8326140' and 'output_gain_0x8326140'
0:00:09.146682000 [335m 2884[00m 0x8096e30 [31;01mERROR[00m [00m             bt-core machine.c:725:bt_machine_add_output_element:[00m failed to link the element 'output_level_0x8326140' for 'gen_0x8326140'
0:00:09.146699000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:929:sequence_table_refresh:[00m enabling output level for machine failed
0:00:09.147637000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:1035:sequence_table_refresh:[00m     number of columns : 3
0:00:09.147691000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:1060:pattern_list_refresh:[00m refresh pattern list
0:00:09.147775000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:2365:bt_main_page_sequence_get_current_machine:[00m get active machine
0:00:09.147880000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:1141:machine_menu_refresh:[00m refreshing track menu
0:00:09.150684000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:1413:on_bars_menu_changed:[00m bars_menu has changed : page=0x82be0f8
0:00:09.150756000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit sequence-view.c:283:bt_sequence_view_set_property:[00m visible-rows = 4
0:00:09.150781000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit sequence-view.c:283:bt_sequence_view_set_property:[00m visible-rows = 4
0:00:09.150800000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:370:sequence_model_recolorize:[00m recolorize sequence tree view
0:00:09.152082000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit sequence-view.c:283:bt_sequence_view_set_property:[00m visible-rows = 4
0:00:09.152284000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit sequence-view.c:283:bt_sequence_view_set_property:[00m visible-rows = 4
0:00:09.152308000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:370:sequence_model_recolorize:[00m recolorize sequence tree view
0:00:09.152695000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-waves.c:212:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82f5c88
0:00:09.152729000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-waves.c:88:waves_list_refresh:[00m refresh waves list: self=0x82f5c88, wavetable=0x8578b60
0:00:09.156557000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-info.c:235:on_song_changed:[00m song has changed : app=0x80ac878, self=0x82e1888
0:00:09.157105000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-info.c:208:on_info_changed:[00m info changed : self=0x82e1888
0:00:09.157319000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-statusbar.c:204:on_song_changed:[00m song has changed : app=0x80ac878, self=0x80fc3f0
0:00:09.157356000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-statusbar.c:89:bt_main_statusbar_update_length:[00m   new msec : 8000
0:00:09.157519000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:136:on_song_changed:[00m song has changed : app=0x80ac878, window=0x813d830
0:00:09.159118000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:127:on_song_unsaved_changed:[00m song.unsaved has changed : song=0x8582510, menu=0x813d830, unsaved=0
0:00:09.160248000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-io-native.c:245:bt_song_io_native_dispose:[00m !!!! self=0x8447e90
0:00:09.160273000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-io.c:338:bt_song_io_dispose:[00m !!!! self=0x8447e90
0:00:09.160296000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-io-native.c:252:bt_song_io_native_finalize:[00m !!!! self=0x8447e90
0:00:09.160312000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-io.c:346:bt_song_io_finalize:[00m !!!! self=0x8447e90
0:00:09.191931000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:459:on_header_size_allocate:[00m #### header label size 100 x 48
0:00:09.192204000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-page-sequence.c:459:on_header_size_allocate:[00m #### header label size 100 x 48
0:00:10.235836000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:189:on_toolbar_play_clicked:[00m toolbar play event occurred
0:00:10.236087000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:190:bt_song_is_playable:[00m check playability
0:00:10.236157000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:559:bt_song_play:[00m prepare playback
0:00:10.236208000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:228:bt_song_send_tags:[00m about to send metadata, taglist=0x8577d90
0:00:10.253692000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:567:bt_song_play:[00m ->PAUSED state change returned 2
0:00:10.253745000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:574:bt_song_play:[00m ->PAUSED needs async wait
0:00:10.255415000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:253:on_song_error:[00m received Error bus message
0:00:10.255489000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:623:bt_song_stop:[00m stopping playback, is_playing: 0, is_preparing: 1
0:00:10.255977000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:632:bt_song_stop:[00m ->READY state change returned 1
0:00:10.256041000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:121:on_song_is_playing_notify:[00m song stop event occured: 0x8096e30
0:00:10.256351000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:137:on_song_is_playing_notify:[00m song stop event handled
0:00:10.256409000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-statusbar.c:153:on_song_is_playing_notify:[00m play_start=0
0:00:10.256433000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-statusbar.c:108:on_song_play_pos_notify:[00m tick update
0:00:10.256698000 [335m 2884[00m 0x8096e30 [33;01mWARN [00m [00m             bt-edit main-toolbar.c:260:on_song_error:[00m ERROR: Internal data flow error. (gstbasesrc.c(1569): gst_base_src_loop (): /song/gen_0x8326140:
streaming task paused, reason not-linked (-1))

0:00:11.773212000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-toolbar.c:253:on_song_error:[00m received Error bus message
0:00:11.773301000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:623:bt_song_stop:[00m stopping playback, is_playing: 0, is_preparing: 0
0:00:11.773336000 [335m 2884[00m 0x8096e30 [33;01mWARN [00m [00m             bt-edit main-toolbar.c:260:on_song_error:[00m ERROR: Internal data flow error. (gstbasesrc.c(1569): gst_base_src_loop (): /song/gen_0x8326140:
streaming task paused, reason not-linked (-1))

0:00:16.350503000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:81:on_window_delete_event:[00m delete event occurred
0:00:16.350606000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-window.c:604:bt_main_window_dispose:[00m !!!! self=0x813d830
0:00:16.350683000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-window.c:610:bt_main_window_dispose:[00m   chaining up
0:00:16.351843000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:90:on_window_destroy:[00m destroy occurred
0:00:16.351885000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-window.c:92:on_window_destroy:[00m   leaving main-loop
0:00:16.355129000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-menu.c:674:bt_main_menu_dispose:[00m !!!! self=0x81c5008
0:00:16.358331000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-toolbar.c:654:bt_main_toolbar_dispose:[00m !!!! self=0x8128118
0:00:16.358364000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-toolbar.c:661:bt_main_toolbar_dispose:[00m disconnect handlers from song=0x8582510
0:00:16.363101000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-pages.c:232:bt_main_pages_dispose:[00m !!!! self=0x80fc000
0:00:16.363174000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:1065:bt_main_page_machines_dispose:[00m !!!! self=0x82be008
0:00:16.363237000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-machines.c:1067:bt_main_page_machines_dispose:[00m   unrefing popup
0:00:16.364198000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-menu.c:270:bt_machine_menu_dispose:[00m !!!! self=0x82bf860
0:00:16.368918000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit wire-canvas-item.c:419:bt_wire_canvas_item_dispose:[00m !!!! self=0x8507498
0:00:16.369001000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit wire-canvas-item.c:432:bt_wire_canvas_item_dispose:[00m wire-refs: 2
0:00:16.369022000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit wire-canvas-item.c:439:bt_wire_canvas_item_dispose:[00m   unrefing done
0:00:16.369264000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit wire-canvas-item.c:447:bt_wire_canvas_item_dispose:[00m   chaining up
0:00:16.369320000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit wire-canvas-item.c:449:bt_wire_canvas_item_dispose:[00m   done
0:00:16.369340000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit wire-canvas-item.c:458:bt_wire_canvas_item_finalize:[00m   done
0:00:16.369358000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:651:bt_machine_canvas_item_dispose:[00m !!!! self=0x82bfad0
0:00:16.369374000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:653:bt_machine_canvas_item_dispose:[00m machine-refs: 4
0:00:16.369390000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:658:bt_machine_canvas_item_dispose:[00m   unrefing done
0:00:16.369405000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:666:bt_machine_canvas_item_dispose:[00m   destroying dialogs done
0:00:16.370079000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:672:bt_machine_canvas_item_dispose:[00m   destroying done
0:00:16.370102000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:674:bt_machine_canvas_item_dispose:[00m   chaining up
0:00:16.370238000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:676:bt_machine_canvas_item_dispose:[00m   done
0:00:16.370259000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:685:bt_machine_canvas_item_finalize:[00m   done
0:00:16.370276000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:651:bt_machine_canvas_item_dispose:[00m !!!! self=0x82bfba0
0:00:16.370291000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:653:bt_machine_canvas_item_dispose:[00m machine-refs: 5
0:00:16.370306000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:658:bt_machine_canvas_item_dispose:[00m   unrefing done
0:00:16.370321000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:666:bt_machine_canvas_item_dispose:[00m   destroying dialogs done
0:00:16.371117000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:672:bt_machine_canvas_item_dispose:[00m   destroying done
0:00:16.371136000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:674:bt_machine_canvas_item_dispose:[00m   chaining up
0:00:16.371263000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:676:bt_machine_canvas_item_dispose:[00m   done
0:00:16.371283000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit machine-canvas-item.c:685:bt_machine_canvas_item_finalize:[00m   done
0:00:16.371399000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-patterns.c:1799:bt_main_page_patterns_dispose:[00m !!!! self=0x82d4808
0:00:16.374290000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit pattern-view.c:241:bt_pattern_view_dispose:[00m !!!! self=0x8136888
0:00:16.374910000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit pattern-view.c:241:bt_pattern_view_dispose:[00m !!!! self=0x8136968
0:00:16.375682000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:2602:bt_main_page_sequence_dispose:[00m !!!! self=0x82be0f8
0:00:16.375709000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-page-sequence.c:2610:bt_main_page_sequence_dispose:[00m disconnect handlers from song=0x8582510
0:00:16.377420000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit sequence-view.c:299:bt_sequence_view_dispose:[00m !!!! self=0x82dec98
0:00:16.378085000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit sequence-view.c:299:bt_sequence_view_dispose:[00m !!!! self=0x82def40
0:00:16.385429000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-statusbar.c:387:bt_main_statusbar_dispose:[00m !!!! self=0x80fc3f0
0:00:16.385473000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-statusbar.c:394:bt_main_statusbar_dispose:[00m disconnect handlers from song=0x8582510
0:00:16.385997000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-window.c:612:bt_main_window_dispose:[00m   done
0:00:16.386029000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit main-window.c:621:bt_main_window_finalize:[00m   done
0:00:16.393444000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit main-window.c:331:bt_main_window_run:[00m after running the UI
0:00:16.393684000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:285:bt_edit_application_run_ui:[00m application.run_ui finished : 1
0:00:16.393710000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:638:bt_edit_application_run:[00m application.run finished
0:00:16.393728000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit bt-edit.c:131:main:[00m app->ref_ct=1
0:00:16.393895000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit edit-application.c:824:bt_edit_application_dispose:[00m !!!! self=0x80ac878, self->ref_ct=1
0:00:16.393914000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-edit edit-application.c:827:bt_edit_application_dispose:[00m song->ref_ct=1
0:00:16.393934000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core song.c:623:bt_song_stop:[00m stopping playback, is_playing: 0, is_preparing: 0
0:00:16.393952000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1049:bt_song_dispose:[00m !!!! self=0x8582510
0:00:16.395162000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1057:bt_song_dispose:[00m ->NULL state change returned 1
0:00:16.395211000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1070:bt_song_dispose:[00m sink-machine-refs: 2
0:00:16.395234000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1077:bt_song_dispose:[00m refs: song_info: 1, sequence: 1, setup: 1, wavetable: 1
0:00:16.395252000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:388:bt_song_info_dispose:[00m !!!! self=0x8418230
0:00:16.395275000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song-info.c:397:bt_song_info_finalize:[00m !!!! self=0x8418230
0:00:16.395302000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1362:bt_sequence_dispose:[00m !!!! self=0x84181e8
0:00:16.395353000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sequence.c:1385:bt_sequence_finalize:[00m !!!! self=0x84181e8
0:00:16.395378000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:726:bt_setup_dispose:[00m !!!! self=0x833abb8
0:00:16.395395000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:734:bt_setup_dispose:[00m   free wire : 0x85ab438 (1)
0:00:16.395412000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:708:bt_wire_dispose:[00m !!!! self=0x85ab438
0:00:16.395429000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:320:bt_wire_unlink_machines:[00m unlink machines 'output_gain_0x8326140' -> 'input_level_0x83260a0'
0:00:16.395466000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:338:bt_wire_unlink_machines:[00m   removing convert from bin, obj->ref_count=1
0:00:16.395487000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:342:bt_wire_unlink_machines:[00m ->NULL state change returned 1
0:00:16.410247000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:716:bt_wire_dispose:[00m   removing machine "tee_0x85ab438" from bin, obj->ref_count=1
0:00:16.410487000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:720:bt_wire_dispose:[00m ->NULL state change returned 1
0:00:16.410569000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:724:bt_wire_dispose:[00m   removing machine "gain_0x85ab438" from bin, obj->ref_count=1
0:00:16.410594000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:728:bt_wire_dispose:[00m ->NULL state change returned 1
0:00:16.410649000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:733:bt_wire_dispose:[00m   releasing the bin, bin->ref_count=5
0:00:16.410677000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wire.c:748:bt_wire_finalize:[00m !!!! self=0x85ab438
0:00:16.410699000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:745:bt_setup_dispose:[00m   free machine : 0x83260a0 (1)
0:00:16.410717000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:194:bt_sink_machine_dispose:[00m !!!! self=0x83260a0
0:00:16.410735000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2409:bt_machine_dispose:[00m !!!! self=0x83260a0, song=0x8582510
0:00:16.410761000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2428:bt_machine_dispose:[00m   bin->ref_count=4
0:00:16.410779000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2433:bt_machine_dispose:[00m   removing machine "input_level_0x83260a0" from bin, obj->ref_count=1
0:00:16.410798000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2437:bt_machine_dispose:[00m ->NULL state change returned 1
0:00:16.410846000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2439:bt_machine_dispose:[00m   bin->ref_count=4
0:00:16.410864000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2433:bt_machine_dispose:[00m   removing machine "input_gain_0x83260a0" from bin, obj->ref_count=1
0:00:16.410883000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2437:bt_machine_dispose:[00m ->NULL state change returned 1
0:00:16.410944000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2439:bt_machine_dispose:[00m   bin->ref_count=4
0:00:16.410964000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2433:bt_machine_dispose:[00m   removing machine "audio_sink_0x83260a0" from bin, obj->ref_count=1
0:00:16.411018000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2437:bt_machine_dispose:[00m ->NULL state change returned 1
0:00:16.411049000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:555:bt_sink_bin_dispose:[00m !!!! self=0x84319e8
0:00:16.411111000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:557:bt_sink_bin_dispose:[00m self->sink=0x84330e0, refct=1
0:00:16.411163000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:563:bt_sink_bin_dispose:[00m chaining up
0:00:16.411315000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core sink-bin.c:568:bt_sink_bin_dispose:[00m done
0:00:16.411335000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-bin.c:574:bt_sink_bin_finalize:[00m !!!! self=0x84319e8
0:00:16.411357000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2439:bt_machine_dispose:[00m   bin->ref_count=4
0:00:16.411373000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2443:bt_machine_dispose:[00m   releasing the bin, bin->ref_count=4
0:00:16.411389000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2450:bt_machine_dispose:[00m   releasing patterns
0:00:16.411406000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1066:bt_pattern_dispose:[00m !!!! self=0x85a7908
0:00:16.411425000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1077:bt_pattern_finalize:[00m !!!! self=0x85a7908
0:00:16.411444000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1066:bt_pattern_dispose:[00m !!!! self=0x85a7948
0:00:16.411461000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1077:bt_pattern_finalize:[00m !!!! self=0x85a7948
0:00:16.411478000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2461:bt_machine_dispose:[00m   chaining up
0:00:16.411501000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2463:bt_machine_dispose:[00m   done
0:00:16.411517000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core sink-machine.c:201:bt_sink_machine_finalize:[00m !!!! self=0x83260a0
0:00:16.411533000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2469:bt_machine_finalize:[00m !!!! self=0x83260a0
0:00:16.411900000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:745:bt_setup_dispose:[00m   free machine : 0x8326140 (1)
0:00:16.411928000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core source-machine.c:191:bt_source_machine_dispose:[00m !!!! self=0x8326140
0:00:16.411944000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2409:bt_machine_dispose:[00m !!!! self=0x8326140, song=0x8582510
0:00:16.411965000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2428:bt_machine_dispose:[00m   bin->ref_count=3
0:00:16.411983000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2433:bt_machine_dispose:[00m   removing machine "gen_0x8326140" from bin, obj->ref_count=1
0:00:16.412006000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2437:bt_machine_dispose:[00m ->NULL state change returned 1
0:00:16.412576000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2439:bt_machine_dispose:[00m   bin->ref_count=3
0:00:16.412601000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2433:bt_machine_dispose:[00m   removing machine "output_level_0x8326140" from bin, obj->ref_count=1
0:00:16.412623000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2437:bt_machine_dispose:[00m ->NULL state change returned 1
0:00:16.412670000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2439:bt_machine_dispose:[00m   bin->ref_count=3
0:00:16.412688000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2433:bt_machine_dispose:[00m   removing machine "output_gain_0x8326140" from bin, obj->ref_count=1
0:00:16.412728000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2437:bt_machine_dispose:[00m ->NULL state change returned 1
0:00:16.412777000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2439:bt_machine_dispose:[00m   bin->ref_count=3
0:00:16.412795000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2443:bt_machine_dispose:[00m   releasing the bin, bin->ref_count=3
0:00:16.412811000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2450:bt_machine_dispose:[00m   releasing patterns
0:00:16.412827000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1066:bt_pattern_dispose:[00m !!!! self=0x85a7988
0:00:16.412846000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1077:bt_pattern_finalize:[00m !!!! self=0x85a7988
0:00:16.412863000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1066:bt_pattern_dispose:[00m !!!! self=0x85a79c8
0:00:16.412881000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1077:bt_pattern_finalize:[00m !!!! self=0x85a79c8
0:00:16.412898000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1066:bt_pattern_dispose:[00m !!!! self=0x85a7a08
0:00:16.412915000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1077:bt_pattern_finalize:[00m !!!! self=0x85a7a08
0:00:16.412931000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1066:bt_pattern_dispose:[00m !!!! self=0x85a7a48
0:00:16.412955000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core pattern.c:1077:bt_pattern_finalize:[00m !!!! self=0x85a7a48
0:00:16.412972000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2461:bt_machine_dispose:[00m   chaining up
0:00:16.412996000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2463:bt_machine_dispose:[00m   done
0:00:16.413013000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core source-machine.c:198:bt_source_machine_finalize:[00m !!!! self=0x8326140
0:00:16.413028000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core machine.c:2469:bt_machine_finalize:[00m !!!! self=0x8326140
0:00:16.413056000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core setup.c:758:bt_setup_finalize:[00m !!!! self=0x833abb8
0:00:16.413076000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wavetable.c:299:bt_wavetable_dispose:[00m !!!! self=0x8578b60
0:00:16.413094000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core wavetable.c:324:bt_wavetable_finalize:[00m !!!! self=0x8578b60
0:00:16.413125000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1090:bt_song_dispose:[00m   chaining up
0:00:16.413149000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1092:bt_song_dispose:[00m   done
0:00:16.413166000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1098:bt_song_finalize:[00m !!!! self=0x8582510
0:00:16.413180000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1100:bt_song_finalize:[00m   chaining up
0:00:16.413194000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core song.c:1102:bt_song_finalize:[00m   done
0:00:16.413214000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit ui-ressources.c:323:bt_ui_ressources_dispose:[00m !!!! self=0x812e048
0:00:16.413239000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit edit-application.c:838:bt_edit_application_dispose:[00m   chaining up
0:00:16.413255000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core application.c:152:bt_application_dispose:[00m !!!! self=0x80ac878, self->ref_ct=1
0:00:16.413270000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core application.c:153:bt_application_dispose:[00m bin->ref_ct=1
0:00:16.413296000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core application.c:154:bt_application_dispose:[00m bin->numchildren=0
0:00:16.413311000 [335m 2884[00m 0x8096e30 [32;01mINFO [00m [00m             bt-core application.c:155:bt_application_dispose:[00m settings->ref_ct=1
0:00:16.579747000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:247:bt_gconf_settings_dispose:[00m !!!! self=0x80b46f0
0:00:16.579799000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core settings.c:146:bt_settings_dispose:[00m !!!! self=0x80b46f0, self->ref_ct=1
0:00:16.579831000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core gconf-settings.c:254:bt_gconf_settings_finalize:[00m !!!! self=0x80b46f0
0:00:16.579849000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core settings.c:154:bt_settings_finalize:[00m !!!! self=0x80b46f0
0:00:16.579869000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core application.c:160:bt_application_dispose:[00m   chaining up
0:00:16.579899000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core application.c:162:bt_application_dispose:[00m   done
0:00:16.579917000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit edit-application.c:840:bt_edit_application_dispose:[00m   done
0:00:16.579935000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core application.c:168:bt_application_finalize:[00m !!!! self=0x80ac878
0:00:16.580438000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core application.c:170:bt_application_finalize:[00m   chaining up
0:00:16.580464000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-core application.c:172:bt_application_finalize:[00m   done
0:00:16.580482000 [335m 2884[00m 0x8096e30 [36mDEBUG[00m [00m             bt-edit edit-application.c:849:bt_edit_application_finalize:[00m   done