- このトピックには34件の返信、2人の参加者があり、最後ににより1年、 8ヶ月前に更新されました。
-
投稿
-
Tikiさん、はじめまして。
タイトルの現象は 5.2.2 UWP 版で以下の状況で発生しました。
・RAMDecode（すべて）
・ランダム再生
・WASAPI（Exclusive Event）現象発生中の動画を添付します。
（＊動画は466kBまでサイズを落としていますが不適切でしたら削除お願いいたします）現象が発生してからの記録のため途中からですが、再生時間 0:51 で Player View の Time やインジゲーターが止まり、フリーズしかたかな？！と思ったのですが、録画中に 0:52, 0:53 と普通に再生が再開しました。現象発生から１０数秒くらいだと思います。
なお、今回はじめて発生しました。これまでは以下の設定にしており、先週水木金土の４日間毎日１０時間連続再生で発生しませんでした。
・RAMDecode（すべて）
・リピート再生
・Bit Perfect（BP2）
・WASAPI（Exclusive Event）リピート再生の有無とランダム再生の有無とBP2の有無が違いとなります。
これだけで原因を特定することは難しいと思いますので、次回発生時に何か調査のために役立つ情報収集ができれば、と思い投稿させていただきました。
よろしくお願いいたします。
こんにちは。適切なサイズの動画ありがとうございます。
デコード待ちが発生したのかと予想しましたが、そうではありませんでした。スペクトル表示も完全に止まっていることから、おそらくビデオカードあたりで一時的なフリーズが発生したのではないかと思います (わたしのPCも含めて、環境によってはときどき発生しています。長くなると「予期しない状態を検知した」と表示されることもあります)。
こんにちは。
ログのアップありがとうございます。この事象は、最初にご報告いただいた画面・操作のフリーズが発生したあと、発生したということでしょうか?
デバイスののスタートは、設定項目の
■ ツリー項目: 再生の設定 – WASAPIの設定 – (デバイス名)
■ プロパティ: 基本の設定 – 再生終了時にデバイスも終了させるがYesになっていると、シーク操作後に発生します (既定でYesになっています)。これはシーク時に一時的にデバイスを停止させた後、再開始に失敗するデバイスがあったためで、シークの都度そのように動作させるようになります。
今回のログでは見た目には何回もシーク操作が行われたかのような動作になっています。操作がフリーズしている間に、そのような操作をされたということはないでしょうか?
シーク操作は、短い間隔で連続して操作されたと考えているわけではなく、時間を置いて操作された結果がフリーズ解除後に一気に処理されたのかと考えました。
他には現在のところ考えられる原因はありません。引き続き検討します。
こんばんは。ログの送付ありがとうございました。
内容拝見しましたが、たしかに不可思議にSeekが繰り返されていることは確認できましたが、なぜそのような動作になっているのかはわかりませんでした。
Noirさんは、UWP版をご利用と伺いました。最近のマイクロソフトストアは、特定のユーザー向けにプライベートなリリースを行える機構がありますので、Noirさん向けに、この問題調査用の仕掛けを入れたTuneBrowserをリリースさせていただきたいと思います。
今回のケースは経験したことのない事象のため、おそらく一度では解決できず、複数回のやりとりになると思われます。どうぞその点についてご了承ください。
ご利用のマイクロソフトアカウントは、このフォーラムの登録メールアドレスとおなじでしょうか。異なる場合、ここにはメールアドレスは書かないで、ちがうという旨だけお知らせください。わたしから照会用のメールをお出しさせていただきます。
こんばんは。
アカウントの情報ありがとうございました。先ほど、お届けいただいた2つのメールアドレスに対して調査用のTuneBrowserのリリース手続きを行いました。これはマイクロソフトがパッケージフライトと呼んでいるリリース方式ですが、これも通常と同様にマイクロソフトストアの審査があります。そのため少々時間がかかるかもしれません。
今回のリリースでは、短時間にSeekが複数回発生すると(1秒間に4回です)、その状態を検出してダンプファイルを生成するようにしています。予期しない状態を検出したという文言と操作を問い合わせるダイアログボックスが表示されますので、送信を選択してください。
この予期しない状態の検出は、連発しないように1日1回だけ行われるようにしています。
わたしの環境では再現しない状況で検出の仕掛けを実装したので、もしかしたらうまく動作しない可能性もあります。現象が発生しているはずなのに検出できていないようであれば、お知らせくださると助かります。
よろしくお願いします。
マイクロソフトストアから、フライトが公開されたとの連絡がありました。思ったより早かったです。Version は5.2.4です。
それともう一点、お伝えするのを忘れました。このバージョンはわたしの手許の開発中のものです。そのため5.2.3とは動作が異なるところがあります。ご了承ください。もし支障があれば、お知らせください。
ありがとうございます！
たまたま先ほどの投稿をみてマイクロソフトストアで更新をチェックしたらダウンロードできてたので早いなー、と思ってたところです。
マイクロソフトさんからも連絡がいくのですね。親切ですね。
早速、この環境で再生してみますね！
引き続きどうぞよろしくお願いいたします！！
Attachments:
状況のご報告ありがとうございました。
引き続き、よろしくお願いします。
ご報告ありがとうございました。
もうしばらく、待ってみましょうか。よろしくお願いします。
ダンプファイル受領しました。ありがとうございます。
内容を確認して、またご報告します。
こんばんは。
内容確認しました。事象はしっかり記録されていました。
シークが繰り返された原因は、やはり短時間の間にマウスによるシーク操作が行われたためでした (1秒間に数回以上)。Noirさんがそんなに短時間にシーク操作を行うことはできないと言われていたことは承知しています。ですが、記録上はシークバーのコントロールに対して、マウス操作が行われてイベントが発生しています。
なにかそういった操作を発生させるような他のアプリケーションなどをご利用でないでしょうか。わたしも具体的には思いつきませんが…。
よろしくお願いします。
動画で確認できるのは、描画がフリーズしているということだったかと思います。その事象とシーク操作の連発とが、どういう関係にあるのかは、わたしにはわかりません。シーク操作が連発したから描画がフリーズしたのか、描画がフリーズする事象が発生したからシーク操作が連発したのか、という話ですが…。
ウインドウの状態はフォアグラウンドにありましたでしょうか？
ログをたどってみましたが、それ関係のイベントの記録はなく、わかりませんでした。
参考になるかどうかわかりませんが、ある連続操作のところのログは以下のような感じです。CTBarSliderCtrlはシーク用のスライダコントロール、OnLButtonDownはマウスボタンを押したイベント、OnLButtonUpはマウスボタンを離したイベント、時刻の “23:17:17,004.3101” の004.3101はミリ秒です。23:17:17に4回のマウスボタン操作の記録があります。
2023/04/24 23:17:17,004.3101 00002d34 TB::CTBarSliderCtrl::OnLButtonDown 2023/04/24 23:17:17,009.5103 00002d34 TB::CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:17,016.5236 00002d34 TB::CTBarSliderCtrl::OnLButtonDown 2023/04/24 23:17:17,019.9919 00002d34 TB::CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:17,029.6875 00002d34 TB::CTBarSliderCtrl::OnLButtonDown 2023/04/24 23:17:17,033.8597 00002d34 TB::CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:17,082.1819 00002d34 TB::CTBarSliderCtrl::OnLButtonDown 2023/04/24 23:17:17,146.1015 00002d34 TB::CTBarSliderCtrl::OnLButtonUp例が悪かったようですみません。前後も含めたログを再掲させていただきます。
2023/04/24 23:17:15,994.0768 00002d34 CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:15,999.6647 000012f4 Processing PlayerCmd:[Seek] 2023/04/24 23:17:16,042.9781 000027a0 Calling Lua: OnPlaybackFile 2023/04/24 23:17:16,154.0533 00002d34 CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:16,159.4184 000012f4 Processing PlayerCmd:[Seek] 2023/04/24 23:17:16,216.7780 000027a0 Calling Lua: OnPlaybackFile 2023/04/24 23:17:16,281.9767 00002d34 CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:16,286.9115 000012f4 Processing PlayerCmd:[Seek] 2023/04/24 23:17:16,330.5251 000027a0 Calling Lua: OnPlaybackFile 2023/04/24 23:17:16,434.4246 00002d34 CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:16,440.0747 000012f4 Processing PlayerCmd:[Seek] 2023/04/24 23:17:16,479.8746 000027a0 Calling Lua: OnPlaybackFile 2023/04/24 23:17:16,586.1570 00002d34 CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:16,591.6618 000012f4 Processing PlayerCmd:[Seek] 2023/04/24 23:17:16,591.6794 000012f4 UnexpectedState caused: TooManySeek. 2023/04/24 23:17:17,009.5103 00002d34 CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:17,019.9919 00002d34 CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:17,033.8597 00002d34 CTBarSliderCtrl::OnLButtonUp 2023/04/24 23:17:17,146.1015 00002d34 CTBarSliderCtrl::OnLButtonUpここで、2023/04/24 23:17:16,591.6794で予期しない状態を検出しており、その後の2023/04/24 23:17:17以降のシークはこのログの範囲では処理されていませんでした。ここで挙げたログでは、23:17:15～23:17:16の間にも同様の事象が発生しています。気にされていたCalling Luaの行も含めてあります。
お詳しいようですのでさらに付加情報を申し上げると、00002d34とか000012f4はスレッドのIDです。2023/04/24 23:17:16,591.6794で再生制御を行っているスレッドが予期しない状態を検出しているため、23:17:17以降の操作はすぐには処理されない状態になっています。
スライダーによるシーク操作が短時間に連発していることについて、不思議に思われるのは当然と思います。わたしにもわかりません。すくなくともそのタイミングでのリアルタイムでのマウス操作ではないような気がします。ただTuneBrowserから見ると、スライダーが連続で操作されてその処理を行ったようにしか見えません。
ログの追加のご依頼もありましたが、すみませんがこれ以上のTuneBrowserを改修しての対応はご容赦いただければと思います。
あと、キーボード操作はマウスボタンではないので、一般にはキーボード操作をしたからといってマウスイベントが発生することはありません。
キーボード操作はマウスボタンではないので、一般にはキーボード操作をしたからといってマウスイベントが発生することはありません。
こんばんは。
ログをみるかぎりでは、スライダー以外ではマウスイベントは発生していないようでした。
簡単ですが、よろしくお願いします。
念のため、なのですが、トピックタイトルにある「一時的に再生が停滞して１０数秒後に再開」という現象は、最初にも書いたようにわたしの環境でも発生します。一昨日は、ある用途でUSB3.2 Gen2のディスクに大きな負荷をかけたときに、まさに描画も再生も停滞して十数秒後に再開する動作が発生しました。
その事象が起きたとしても、TuneBrowserからはどうにもできません。
いまここで議論をしているのは、シークが連発するという動作のほうですよね。今回お送りいただいたダンプファイル上は、シーク連発中、動作の停滞が発生しているようには見受けられませんでした (だからマウスイベントを処理できているわけですが)。ただダンプファイル上は性能への影響を抑制するため1秒～数秒間程度しか詳細のログがとれないようにしているので、それより前になにか起きていた可能性は否定はできません。
- このトピックに返信するにはログインが必要です。