java.lang.RuntimeException: java.lang.reflect.InvocationTargetException at org.sophie2.core.prolib.util.ReflectionUtil.unwrap(ReflectionUtil.java:326) at org.sophie2.core.prolib.impl.ResourceProperty$Setuper.update(ResourceProperty.java:90) at org.sophie2.core.prolib.impl.AutoTracker.doUpdate(AutoTracker.java:66) at org.sophie2.core.prolib.impl.AutoTracker$1.changed(AutoTracker.java:31) at org.sophie2.core.prolib.BasePro.fireChanged(BasePro.java:131) at org.sophie2.core.prolib.BasePro$BaseProChange.fire(BasePro.java:187) at org.sophie2.core.prolib.events.ProChange.execute(ProChange.java:44) at org.sophie2.core.prolib.BasePro$BaseProChange.execute(BasePro.java:204) at org.sophie2.core.prolib.util.DefaultChangeManager.register(DefaultChangeManager.java:34) at org.sophie2.core.prolib.events.ProChange.register(ProChange.java:38) at org.sophie2.core.prolib.BasePro$BaseProChange.register(BasePro.java:197) at org.sophie2.core.prolib.impl.ObjectProperty$ValueChange.register(ObjectProperty.java:252) at org.sophie2.core.prolib.impl.AutoProperty.setValue(AutoProperty.java:208) at org.sophie2.core.prolib.impl.AutoProperty.access$000(AutoProperty.java:30) at org.sophie2.core.prolib.impl.AutoProperty$Updater.wasUpdated(AutoProperty.java:62) at org.sophie2.core.prolib.impl.AutoTracker.doUpdate(AutoTracker.java:91) at org.sophie2.core.prolib.impl.AutoTracker$1.changed(AutoTracker.java:31) at org.sophie2.core.prolib.Aspect.fireChanged(Aspect.java:87) at org.sophie2.base.model.resources.r4.access.MasterTopAccess.switchToNextRevision(MasterTopAccess.java:215) at org.sophie2.base.model.resources.r4.access.MasterTopAccess.registerChange(MasterTopAccess.java:185) at org.sophie2.base.model.resources.r4.access.MasterTopAccess.registerChange(MasterTopAccess.java:167) at org.sophie2.base.model.resources.r4.access.DelegatingAccess.registerChange(DelegatingAccess.java:78) at org.sophie2.base.model.resources.r4.changes.AutoAction.register(AutoAction.java:102) at org.sophie2.main.func.timelines.hud.ChildRow$ChildRowLogic$2.handle(ChildRow.java:543) at org.sophie2.core.mvc.SimpleOperation.handle(SimpleOperation.java:64) at org.sophie2.core.mvc.LogicR3.fire(LogicR3.java:39) at org.sophie2.core.mvc.LogicR3.fire(LogicR3.java:79) at org.sophie2.base.bound.BoundControl.submitData(BoundControl.java:552) at org.sophie2.base.bound.BoundControl.syncInputToModel(BoundControl.java:450) at org.sophie2.base.bound.BoundComboBox$1dataInputControl$1.itemStateChanged(BoundComboBox.java:121) at javax.swing.JComboBox.fireItemStateChanged(JComboBox.java:1205) at javax.swing.JComboBox.selectedItemChanged(JComboBox.java:1253) at javax.swing.JComboBox.contentsChanged(JComboBox.java:1309) at javax.swing.AbstractListModel.fireContentsChanged(AbstractListModel.java:100) at javax.swing.DefaultComboBoxModel.setSelectedItem(DefaultComboBoxModel.java:88) at javax.swing.JComboBox.setSelectedItem(JComboBox.java:557) at javax.swing.JComboBox.setSelectedIndex(JComboBox.java:603) at javax.swing.plaf.basic.BasicComboPopup$Handler.mouseReleased(BasicComboPopup.java:816) at java.awt.AWTEventMulticaster.mouseReleased(AWTEventMulticaster.java:273) at java.awt.Component.processMouseEvent(Component.java:6348) at javax.swing.JComponent.processMouseEvent(JComponent.java:3267) at javax.swing.plaf.basic.BasicComboPopup$1.processMouseEvent(BasicComboPopup.java:480) at java.awt.Component.processEvent(Component.java:6113) at java.awt.Container.processEvent(Container.java:2085) at java.awt.Component.dispatchEventImpl(Component.java:4714) at java.awt.Container.dispatchEventImpl(Container.java:2143) at java.awt.Component.dispatchEvent(Component.java:4544) at java.awt.LightweightDispatcher.retargetMouseEvent(Container.java:4618) at java.awt.LightweightDispatcher.processMouseEvent(Container.java:4282) at java.awt.LightweightDispatcher.dispatchEvent(Container.java:4212) at java.awt.Container.dispatchEventImpl(Container.java:2129) at java.awt.Window.dispatchEventImpl(Window.java:2475) at java.awt.Component.dispatchEvent(Component.java:4544) at java.awt.EventQueue.dispatchEvent(EventQueue.java:635) at java.awt.EventDispatchThread.pumpOneEventForFilters(EventDispatchThread.java:296) at java.awt.EventDispatchThread.pumpEventsForFilter(EventDispatchThread.java:211) at java.awt.EventDispatchThread.pumpEventsForHierarchy(EventDispatchThread.java:201) at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:196) at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:188) at java.awt.EventDispatchThread.run(EventDispatchThread.java:122) Caused by: java.lang.reflect.InvocationTargetException at sun.reflect.GeneratedMethodAccessor251.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at org.sophie2.core.prolib.impl.ResourceProperty$Setuper.update(ResourceProperty.java:86) ... 58 more Caused by: java.lang.AssertionError at org.sophie2.base.model.book.timelines.TimelineOptions.getMillis(TimelineOptions.java:151) at org.sophie2.main.func.timelines.TimelinesPalette.drawActivationContents(TimelinesPalette.java:971) at org.sophie2.main.func.timelines.TimelinesPalette.drawClipContents(TimelinesPalette.java:894) at org.sophie2.main.func.timelines.TimelinesPalette.drawClip(TimelinesPalette.java:868) at org.sophie2.main.func.timelines.TimelinesPalette.drawChannel(TimelinesPalette.java:809) at org.sophie2.main.func.timelines.TimelinesPalette$ChannelsPanel.paintComponent(TimelinesPalette.java:401) at org.sophie2.main.func.timelines.TimelinesPalette$1channelsPanel.setupRepaint(TimelinesPalette.java:494) ... 62 more ---------------------------------------- 2009-10-15T14:22:21-0400 ---------------------------------------- sophie2-author.log [[INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.core.modularity.CoreModularityModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.core.mvc.CoreMvcModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.bound.BoundModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.commons.BaseCommonsModule, [INFO] org.sophie2.core.logging.SophieLog.addTarget(SophieLog.java:402): Added log target using logging file: /Users/dan/Desktop/sophie2-author-mac.app/Contents/Resources/logs/sophie2-author.log, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.model.resources.r4.BaseModelResourcesR4Module, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.config.BaseConfigModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.connectivity.BaseConnectivityModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.dialogs.BaseDialogsModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.dnd.BaseDndModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.visual.BaseVisualModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.halos.BaseHalosModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.layout.BaseLayoutModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.media.BaseMediaModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.model.book.BaseModelBookModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.model.security.BaseModelSecurityModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.persistence.BasePersistenceModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.model.text.BaseModelTextModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.scene.BaseSceneModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.skins.BaseSkinsModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.base.natlib.BaseNatlibModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.media.natlib.MainMediaNatlibModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.comment.CommentModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.func.annotations.AnnotationsModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.func.embedded.EmbeddedBooksModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.func.pdf.PdfModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.func.plain.PlainTextModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.func.print.PrintModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.func.html.HtmlModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.func.rtf.RtfModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.func.scripting.ScriptingModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.app.commons.MainAppModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.app.halos.MainAppHalosModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.app.layout.MainAppLayoutModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.app.menus.MainAppMenusModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.app.model.MainAppModelModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.dnd.MainDndModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.extra.func.browser.BrowserModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.file.FileFunctionalityModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.help.HelpModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.links.LinksModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.text.TextFuncModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.media.MainFuncMediaModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.image.ImageModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.resources.MainFuncResourcesModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.config.MainFuncConfigModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.timelines.MainFuncTimelinesModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.func.servers.MainFuncServersModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.layout.mydoggy.LayoutMyDoggyModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.scene.jogl.MainSceneJoglModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.scene.simple.MainSceneSimpleModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.scene.sprites.MainSceneSpritesModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.skin.alternative.AlternativeSkinsModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.main.ws_connector.WSConnectorModule, [INFO] org.sophie2.core.modularity.SophieModule.start(SophieModule.java:38): Starting org.sophie2.author.AuthorModule, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [WARN] org.sophie2.main.func.servers.view.ConnectionsPalette.initAccounts(ConnectionsPalette.java:446): Cannot find main window, [INFO] org.sophie2.base.visual.NullVisualProvider.create(NullVisualProvider.java:44): Creating instance of org.sophie2.base.menus.MenuItem, [INFO] org.sophie2.base.visual.NullVisualProvider.create(NullVisualProvider.java:44): Creating instance of org.sophie2.base.menus.MenuItem, [INFO] org.sophie2.base.visual.NullVisualProvider.create(NullVisualProvider.java:44): Creating instance of org.sophie2.base.menus.MenuItem, [INFO] org.sophie2.base.visual.NullVisualProvider.create(NullVisualProvider.java:44): Creating instance of org.sophie2.base.menus.MenuItem, [INFO] org.sophie2.base.visual.NullVisualProvider.create(NullVisualProvider.java:44): Creating instance of org.sophie2.base.menus.MenuItem, [INFO] org.sophie2.main.func.resources.view.ResourceDetailsPalette.(ResourceDetailsPalette.java:64): ResourceDetailsPalette created., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] AudioOutputBridge::doStart() begin, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] device=2 at: audio_output.cpp:140, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] at: audio_output.cpp:141, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] info.name=Built-in Output at: audio_output.cpp:144, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] at: audio_output.cpp:151, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] AudioOutputBridge::doStart() end, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 0, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = -1, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 0, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 0, [INFO] org.sophie2.main.layout.mydoggy.MDSkinUpdater.setUpIcons(MDSkinUpdater.java:242): No icon provided for ID = FLOATING, [INFO] org.sophie2.main.layout.mydoggy.MDSkinUpdater.setUpIcons(MDSkinUpdater.java:242): No icon provided for ID = FLOATING_INACTIVE, [INFO] org.sophie2.main.layout.mydoggy.MDSkinUpdater.setUpIcons(MDSkinUpdater.java:242): No icon provided for ID = FIX, [INFO] org.sophie2.main.layout.mydoggy.MDSkinUpdater.setUpIcons(MDSkinUpdater.java:242): No icon provided for ID = FIX_INACTIVE, [INFO] org.sophie2.main.layout.mydoggy.MDSkinUpdater.setUpIcons(MDSkinUpdater.java:242): No icon provided for ID = SLIDING, [INFO] org.sophie2.main.layout.mydoggy.MDSkinUpdater.setUpIcons(MDSkinUpdater.java:242): No icon provided for ID = SLIDING_INACTIVE, [INFO] org.sophie2.main.layout.mydoggy.MDFrameWindow$1globalContainer.setup(MDFrameWindow.java:129): Global container setup successfully., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 7, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 313344, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 219618, [WARN] org.sophie2.main.app.commons.app.DocumentsLogic$4.handle(DocumentsLogic.java:140): (R4) Reimplement page centering!, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 8, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 365568, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 431298, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 11, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 523264, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 588735, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 17, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 754688, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 760284, [WARN] org.sophie2.main.app.commons.app.DocumentsLogic$4.handle(DocumentsLogic.java:140): (R4) Reimplement page centering!, [WARN] org.sophie2.main.app.commons.app.DocumentsLogic$4.handle(DocumentsLogic.java:140): (R4) Reimplement page centering!, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 19, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 873472, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 938448, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 23, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 1033216, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 1098531, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 26, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 1190912, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 1256850, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] AudioInputBridge:Received command with id: 1, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] AudioInputBridge::doStart(), [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] AudioInputBridge:Received command with id: 1401, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Start Record initialization..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] at: audio_input.cpp:100, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] at: audio_input.cpp:103, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] at: audio_input.cpp:105, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] at: audio_input.cpp:107, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] at: audio_input.cpp:113, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] device=0 at: audio_input.cpp:114, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] info.name=Built-in Microphone at: audio_input.cpp:117, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] End Record initialization..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 30, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 1358848, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 1425312, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] AudioInputBridge:Received command with id: 1402, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] data.size()=4 at: audio_input.cpp:153, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] recordedSize=136500 at: audio_input.cpp:154, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] numCallCallback=910 at: audio_input.cpp:155, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] AudioInputBridge:Received command with id: 0, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] AudioInputBridge::doStop(), [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] AudioInputBridge::doStop() end, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 34, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 1542144, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 1608327, [WARN] org.sophie2.main.app.commons.app.DocumentsLogic$4.handle(DocumentsLogic.java:140): (R4) Reimplement page centering!, [WARN] org.sophie2.main.media.natlib.decoder.NativeMediaHandler.finalize(NativeMediaHandler.java:90): NativeMediaHandler not disposed: org.sophie2.main.media.natlib.decoder.NativeMediaHandler@63783ff8, [WARN] org.sophie2.main.media.natlib.decoder.NativeMediaHandler.finalize(NativeMediaHandler.java:90): NativeMediaHandler not disposed: org.sophie2.main.media.natlib.decoder.NativeMediaHandler@6bafe5cc, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 39, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 1748992, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 1808541, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Starting media_decoder, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] executing open command (used to be-media_decoder.open())..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] opening input file..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] finding Streams of input file..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Audio stream found!, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] , [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Input #0, wav, from 'sophie:///a':, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Duration: 00:00:03.09, bitrate: 1411 kb/s, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Stream #0.0: Audio: pcm_s16le, 44100 Hz, 2 channels, s16, 1411 kb/s, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 44, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 1957888, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 2022867, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 49, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 2166784, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 2232342, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 53, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 2339840, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 2405214, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Starting media_decoder, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] executing open command (used to be-media_decoder.open())..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] opening input file..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] finding Streams of input file..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Audio stream found!, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] , [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Input #0, wav, from 'sophie:///a':, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Duration: 00:00:03.09, bitrate: 1411 kb/s, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Stream #0.0: Audio: pcm_s16le, 44100 Hz, 2 channels, s16, 1411 kb/s, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 56, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 2505728, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 2570589, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 60, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 2662400, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 2728467, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 63, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 2820096, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 2886345, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 67, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 2977792, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 3044223, [WARN] org.sophie2.main.app.commons.app.DocumentsLogic$4.handle(DocumentsLogic.java:140): (R4) Reimplement page centering!, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 72, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 3189760, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 3253698, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Starting media_decoder, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] executing open command (used to be-media_decoder.open())..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] opening input file..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] finding Streams of input file..., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Audio stream found!, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] , [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Input #0, wav, from 'sophie:///a':, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Duration: 00:00:03.09, bitrate: 1411 kb/s, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] Stream #0.0: Audio: pcm_s16le, 44100 Hz, 2 channels, s16, 1411 kb/s, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 77, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 3399680, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 3463173, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 81, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 3607552, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 3671766, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 85, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 3766272, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 3831408, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 89, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 3936256, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 4002516, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 92, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 4093952, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 4160394, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 96, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 4256768, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 4320918, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 100, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 4421632, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 4487616, [INFO] org.sophie2.base.scene.events.SceneInteractionLogic$2.handle(SceneInteractionLogic.java:267): EventR3{id=DND_PRE_IMPORT, context=[org.sophie2.main.app.commons.page.RootPageView@4672c7b7, org.sophie2.main.scene.simple.SimpleSceneVisual@6e3c4818, org.sophie2.main.app.commons.element.ElementView$1sceneElement$1@25cd4e12], target=[org.sophie2.base.dnd.SophieDragDropHandler$DndPreImport@7d042d3b, ImmPoint(x=278.000, y=353.000)], cause=EventR3{id=DND_PRE_IMPORT, context=[org.sophie2.main.scene.simple.SimpleSceneVisual@6e3c4818, null, org.sophie2.main.scene.simple.SimpleSceneVisual$ScenePanel[,0,0,720x610,alignmentX=0.0,alignmentY=0.0,border=javax.swing.plaf.synth.SynthBorder@2f9b087d,flags=1,maximumSize=,minimumSize=,preferredSize=java.awt.Dimension[width=720,height=610]]], target=[org.sophie2.base.dnd.SophieDragDropHandler$DndPreImport@7d042d3b, ImmPoint(x=318.000, y=418.000)], cause=null}}, [INFO] org.sophie2.main.app.commons.page.ScenePageLogic$7.handle(ScenePageLogic.java:248): EventR3{id=DND_PRE_IMPORT, context=[org.sophie2.main.app.commons.page.PageWorkArea@388c6589, org.sophie2.main.scene.simple.SimpleSceneVisual@6e3c4818, null], target=[org.sophie2.base.dnd.SophieDragDropHandler$DndPreImport@7d042d3b, ImmPoint(x=278.000, y=353.000)], cause=EventR3{id=DND_PRE_IMPORT, context=[org.sophie2.main.scene.simple.SimpleSceneVisual@6e3c4818, null, org.sophie2.main.scene.simple.SimpleSceneVisual$ScenePanel[,0,0,720x610,alignmentX=0.0,alignmentY=0.0,border=javax.swing.plaf.synth.SynthBorder@2f9b087d,flags=1,maximumSize=,minimumSize=,preferredSize=java.awt.Dimension[width=720,height=610]]], target=[org.sophie2.base.dnd.SophieDragDropHandler$DndPreImport@7d042d3b, ImmPoint(x=318.000, y=418.000)], cause=null}}, [WARN] org.sophie2.base.dnd.AwtTransferable.registerData(AwtTransferable.java:48): Transfers for java.awt.datatransfer.DataFlavor[mimetype=string/toolwindowmanager;representationclass=java.io.InputStream] not implemented yet., [WARN] org.sophie2.base.dnd.AwtTransferable.registerData(AwtTransferable.java:48): Transfers for java.awt.datatransfer.DataFlavor[mimetype=string/toolwindowid;representationclass=java.io.InputStream] not implemented yet., [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 103, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 4586496, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 4652550, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 107, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 4744192, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 4810428, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 111, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 4901888, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 4968306, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 114, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 5061632, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 5125743, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 118, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 5218304, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 5283621, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 121, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 5376000, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 5441499, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 125, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 5533696, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 5599377, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 129, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 5691392, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 5757255, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 132, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 5849088, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 5915133, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 136, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 6006784, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 6072570, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 139, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 6164480, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 6230448, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 143, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 6322176, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 6387885, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 146, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 6479872, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 6545763, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 150, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 6637568, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 6703200, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 154, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 6795264, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 6861078, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 157, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 6953984, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 7018515, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 161, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 7110656, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 7176393, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 164, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 7268352, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 7334271, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 168, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 7426048, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 7491708, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 171, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 7583744, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 7649586, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 175, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 7741440, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 7807023, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 179, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 7899136, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 7964901, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 182, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 8056832, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 8122779, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 186, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 8214528, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 8280216, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 189, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 8372224, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 8438094, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 193, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 8529920, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 8595531, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 196, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 8687616, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 8753409, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 200, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 8845312, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 8911287, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 204, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 9003008, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 9068724, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 207, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 9160704, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 9226602, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 211, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 9318400, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 9384039, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 214, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 9476096, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 9541917, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 218, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 9633792, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 9699795, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 222, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 9791488, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 9857232, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 225, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 9949184, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 10015110, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 229, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 10106880, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 10172988, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 232, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 10264576, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 10330866, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 236, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 10422272, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 10488303, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 239, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 10579968, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 10646181, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 243, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 10737664, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 10803618, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 247, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 10895360, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 10961496, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 250, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 11053056, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 11118933, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 254, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 11210752, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 11276811, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 257, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 11368448, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 11434248, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 261, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 11526144, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 11592567, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 265, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 11686912, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 11751768, [WARN] org.sophie2.main.app.commons.app.DocumentsLogic$4.handle(DocumentsLogic.java:140): (R4) Reimplement page centering!, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 268, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 11844608, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 11910528, [WARN] org.sophie2.main.app.commons.app.DocumentsLogic$4.handle(DocumentsLogic.java:140): (R4) Reimplement page centering!, [WARN] org.sophie2.main.app.commons.app.DocumentsLogic$4.handle(DocumentsLogic.java:140): (R4) Reimplement page centering!, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 272, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 12025856, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 12091779, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 276, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 12183552, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 12249657, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 279, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 12342272, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 12407535, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 283, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 12499968, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 12565413, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 287, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 12670976, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 12736521, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 291, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 12838912, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 12905424, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 294, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 13007872, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 13073445, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 301, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 13296640, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 13273218, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 303, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 13404160, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 13469463, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 308, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 13621248, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 13671882, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 312, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 13769728, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 13835934, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 316, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 13940736, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 14006160, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 320, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 14138368, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 14175063, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 325, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 14353408, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 14380569, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() time = 331, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() firstTime = 19717, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() playPos = 14618624, [INFO] org.sophie2.base.natlib.NativeBridge.dumpError(NativeBridge.java:259): [native-err] GetStatusCommand::execute() writePos = 14599746] ---------------------------------------- sun.java2d.opengl=True java.runtime.name=Java(TM) SE Runtime Environment sun.boot.library.path=/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Libraries java.vm.version=14.1-b02-90 awt.nativeDoubleBuffering=true gopherProxySet=false java.vm.vendor=Apple Inc. java.vendor.url=http://www.apple.com/ path.separator=: java.vm.name=Java HotSpot(TM) 64-Bit Server VM file.encoding.pkg=sun.io sun.java.launcher=SUN_STANDARD user.country=US sun.os.patch.level=unknown java.vm.specification.name=Java Virtual Machine Specification user.dir=/Users/dan/Desktop/sophie2-author-mac.app/Contents/Resources edition=author java.runtime.version=1.6.0_15-b03-219 java.awt.graphicsenv=apple.awt.CGraphicsEnvironment java.endorsed.dirs=/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/endorsed os.arch=x86_64 apple.awt.graphics.UseOpenGL=false java.io.tmpdir=/var/folders/+-/+-cb7wAiExOnK77sddGqWk+++TI/-Tmp-/ line.separator= java.vm.specification.vendor=Sun Microsystems Inc. os.name=Mac OS X sun.jnu.encoding=MacRoman mightyClassLoader=org.apache.felix.framework.FelixMigthyClassLoader@7a0938f0 java.library.path=.:/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java java.specification.name=Java Platform API Specification java.class.version=50.0 sun.management.compiler=HotSpot 64-Bit Server Compiler os.version=10.6.1 http.nonProxyHosts=local|*.local|169.254/16|*.169.254/16 user.home=/Users/dan user.timezone=America/New_York java.awt.printerjob=apple.awt.CPrinterJob bundlesConfigFile=file:/Users/dan/Desktop/sophie2-author-mac.app/Contents/Resources/author-run/author.bundles.config file.encoding=MacRoman java.specification.version=1.6 java.class.path=org.sophie2.launcher-2.0.jar user.name=dan apple.awt.graphics.UseQuartz=false java.vm.specification.version=1.0 java.home=/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home sun.arch.data.model=64 user.language=en java.specification.vendor=Sun Microsystems Inc. awt.toolkit=apple.awt.CToolkit java.vm.info=mixed mode java.version=1.6.0_15 java.ext.dirs=/Library/Java/Extensions:/System/Library/Java/Extensions:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Home/lib/ext sun.boot.class.path=/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/jsfd.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/classes.jar:/System/Library/Frameworks/JavaVM.framework/Frameworks/JavaRuntimeSupport.framework/Resources/Java/JavaRuntimeSupport.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/ui.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/laf.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/sunrsasign.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/jsse.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/jce.jar:/System/Library/Frameworks/JavaVM.framework/Versions/1.6.0/Classes/charsets.jar java.vendor=Apple Inc. file.separator=/ sophie2.loaded=true java.vendor.url.bug=http://bugreport.apple.com/ sun.io.unicode.encoding=UnicodeLittle sun.cpu.endian=little mrj.version=1060.1.6.0_15-219 socksNonProxyHosts=local|*.local|169.254/16|*.169.254/16 ftp.nonProxyHosts=local|*.local|169.254/16|*.169.254/16 sun.awt.exception.handler=apple.awt.CToolkit$EventQueueExceptionHandler sun.cpu.isalist= ---------------------------------------- dbvisel@gmail.com ----------------------------------------