05-29 03:15:59 PDT I/SessionRunner: Starting session runner b8795bd0-88ca-42ff-961f-b04435502de0, server_version=[lab_version: "4.302.0" github_version: "206a5798bcc3663648ab32f8a88719d1a38a746b" process_id: 25114 client_version: "4.32.0"], memory_info=[jvm_used=35.77MB, jvm_total=112MB, jvm_max=24GB, heap_used=28.95MB, free=1.3GB, used=60.54GB, total=61.84GB] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/SessionPluginLoader: Loading session plugin: label=[label: "AtsSessionPlugin"], config=[loading_config { plugin_class_name: "com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin" plugin_module_class_name: "com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPluginModule" } execution_config { config { type_url: "type.googleapis.com/mobileharness.infra.ats.console.controller.AtsSessionPluginConfig" value: "\n\210\002\n\003gts\022\v/google_xts\"\023WvtsDeviceTestCases:\003gtsj/com.google.android.wvts.WidevineDashPolicyTestsr\242\001\032Mgts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests*\003gts*\002-m*\023WvtsDeviceTestCases*\002-t*/com.google.android.wvts.WidevineDashPolicyTests\200\001\000\330\001\000" } } explicit_label { label: "AtsSessionPlugin" }] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/SessionRunner: Session detail:
session_id { id: "b8795bd0-88ca-42ff-961f-b04435502de0" } session_status: SESSION_RUNNING session_config { session_name: "run_command" session_property { key: "olc_server_session_client_id" value: "ats-console-edeb77ec-584b-4d76-8bdb-ded239085ca7" } session_plugin_configs { session_plugin_config { loading_config { plugin_class_name: "com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin" plugin_module_class_name: "com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPluginModule" } execution_config { config { [type.googleapis.com/mobileharness.infra.ats.console.controller.AtsSessionPluginConfig] { run_command { test_plan: "gts" xts_root_dir: "/google_xts" module_name: "WvtsDeviceTestCases" xts_type: "gts" test_name: "com.google.android.wvts.WidevineDashPolicyTests" initial_state { command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" } html_in_zip: false report_system_checkers: false } } } } explicit_label { label: "AtsSessionPlugin" } } } } session_output { session_property { key: "olc_server_session_client_id" value: "ats-console-edeb77ec-584b-4d76-8bdb-ded239085ca7" } session_timing_info { session_submitted_time { seconds: 1780049759 nanos: 662661002 } } } {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/SessionPluginRunner: Posting SessionStartingEvent {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/SessionPluginRunner: Posting SessionStartingEvent(b8795bd0-88ca-42ff-961f-b04435502de0) to subscriber [com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin#onSessionStarting(SessionStartingEvent)@80041717] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/AtsSessionPlugin: Config: run_command { test_plan: "gts" xts_root_dir: "/google_xts" module_name: "WvtsDeviceTestCases" xts_type: "gts" test_name: "com.google.android.wvts.WidevineDashPolicyTests" initial_state { command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" } html_in_zip: false report_system_checkers: false } {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/SessionInfo: New session plugin output, session_id=b8795bd0-88ca-42ff-961f-b04435502de0, plugin_label=AtsSessionPlugin, new_plugin_output=[run_command_state { command_id: "1" command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" }] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/AtsSessionPlugin: Command [1] scheduled, args=[gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/SessionPluginRunner: Subscriber [com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin#onSessionStarting(SessionStartingEvent)@80041717] handled SessionStartingEvent(b8795bd0-88ca-42ff-961f-b04435502de0) {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/SessionPluginRunner: Posting SessionStartedEvent {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/SessionPluginRunner: Posting SessionStartedEvent(b8795bd0-88ca-42ff-961f-b04435502de0) to subscriber [com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin#onSessionStarted(SessionStartedEvent)@80041717] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/AtsSessionPlugin: Command [1] started, args=[gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/SessionRequestHandlerUtil: Obtained device info: DeviceInfo{deviceId=SKBFXABCDEFG, supportedAbiList=Optional[armeabi-v7a,armeabi], supportedAbi=Optional[armeabi-v7a]} {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/TestSuiteHelper: abi 'armeabi' is supported by device but not by this suite build ([arm64-v8a, armeabi-v7a, x86_64, x86]), tests will not run against it. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:15:59 PDT I/TestSuiteHelper: The set of abis running against: [{armeabi-v7a, bitness=32}] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/LocalFileUtil: Checked fully accessibility of file /tmp/mh_res_files/devtools/mobileharness/infra/controller/test/util/xtsdownloader/configs/mcts_list.txt. Permissions: rw-r--r-- {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/ResUtil: Copy resource /devtools/mobileharness/infra/controller/test/util/xtsdownloader/configs/mcts_list.txt to /tmp/mh_res_files/devtools/mobileharness/infra/controller/test/util/xtsdownloader/configs/mcts_list.txt {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/ResUtil: Resource SessionRequestHandlerUtil_/devtools/mobileharness/infra/controller/test/util/xtsdownloader/configs/mcts_list.txt is already copied to /tmp/mh_res_files/devtools/mobileharness/infra/controller/test/util/xtsdownloader/configs/mcts_list.txt {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/SessionRequestHandlerUtil: All android devices: [SKBFXABCDEFG] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/SessionRequestHandlerUtil: XtsTradefedTest job config: name: "xts-tradefed-test-job" tests { content: "xts-tradefed-test-gts" } exec_mode: "local" job_timeout_sec: 1296000 test_timeout_sec: 1295940 start_timeout_sec: 1209600 test_attempts: 1 priority: HIGH gen_file_dir: "/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723" driver { name: "XtsTradefedTest" param: "{\"xts_test_plan\":\"gts\",\"xts_root_dir\":\"/google_xts\",\"xts_type\":\"gts\",\"run_command_args\":\"-m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests\"}" } device { sub_device_spec { type: "AndroidDevice" dimensions { content { key: "id" value: "regex:(SKBFXABCDEFG)" } } } } {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/Timeout: Max job timeout is set as PT360H, max test timeout is set as PT360H {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobSettingsCreator: Gen file dir: /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobSettingsCreator: Tmp file dir: /tmp/olc_server_temp_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_tmp_xts-tradefed-test-job_7fe000f9-e4bc-47ca-93c2-21c969ad19e5 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobInfoCreator: Job type is empty, use the first sub device to set job type {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobInfoCreator: Gen file dir: /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/SessionRequestHandlerUtil: Tradefed job info for xts-tradefed-test-job:
"params": {check_installed_gms_core_version=false, olc_session_client_id=ats-console-edeb77ec-584b-4d76-8bdb-ded239085ca7, tags=, clear_gservices_overrides=false}
"subDeviceSpecs": [[["AndroidDevice",{"id":"regex:(SKBFXABCDEFG)"},[],{}]],[]]
"files": {} {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/AtsSessionPlugin: Failed to create non-tradefed jobs for session [b8795bd0-88ca-42ff-961f-b04435502de0] due to skippable exception: [No matched non-tradefed modules to create jobs]. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/SessionPluginRunner: Subscriber [com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin#onSessionStarted(SessionStartedEvent)@80041717] handled SessionStartedEvent(b8795bd0-88ca-42ff-961f-b04435502de0) {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/LongevityTestHelper: Acquiring lock to persist job info to /tmp/olc_server_temp_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/persistence/dcb139eb-3978-4e6c-bb3a-f696af89a988.textproto {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/LongevityTestHelper: Start to persist job info to /tmp/olc_server_temp_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/persistence/dcb139eb-3978-4e6c-bb3a-f696af89a988.textproto {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/LongevityTestHelper: Stop persisting job info after PT0.057534755S {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/SessionJobRunner: Starting job dcb139eb-3978-4e6c-bb3a-f696af89a988 of session b8795bd0-88ca-42ff-961f-b04435502de0 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobManager: JobManager is started {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/TestManager: Started {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobManager: Loaded API plugin: com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/Status: Status NEW -> RUNNING {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobManager: Started job dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobRunner: Job started {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT W/JobInfo: The sub device spec should exist and the global scoped spec should not be used. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobRunner: Loading client jar plugins for job dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/PluginCreator: Loading plugins from jars [] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/PluginCreator: No plugin module class name given, searching plugin module classes by plugin module annotation {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/PluginCreator: No plugin class name given, searching plugin class by plugin annotation {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/PluginCreator: No plugin is loaded {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/AtsSessionPlugin: Command [1]'s invocations [99454df0-db51-4708-b6fa-ddde8ac22fae] are waiting for devices. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobRunner: Pre run job finished {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobRunner: Job detail: 
ID:	dcb139eb-3978-4e6c-bb3a-f696af89a988
NAME:	xts-tradefed-test-job

DIMENSIONS:
- id=regex:(SKBFXABCDEFG)

PARAMETERS:
- olc_session_client_id=ats-console-edeb77ec-584b-4d76-8bdb-ded239085ca7
- xts_log_root_path=/google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653
- job_persistent_path=/tmp/olc_server_temp_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/persistence/dcb139eb-3978-4e6c-bb3a-f696af89a988.textproto
- check_installed_gms_core_version=false
- disable_tf_result_log=true
- tags=
- clear_gservices_overrides=false

TESTS:
- xts-tradefed-test-gts
 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/SimpleScheduler: Added job dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/SimpleScheduler: Added test 99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/JobRunner: Device allocation started {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:00 PDT I/SimpleScheduler: Created allocation Allocation{test=99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988, devices=[SKBFXABCDEFG]}
05-29 03:16:01 PDT I/Status: Status NEW -> ASSIGNED {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/JobRunner: Allocation: Allocation{test=99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988, devices=[SKBFXABCDEFG]} {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/JobRunner: Device allocation finished {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/JobRunner: Allocated devices [SKBFXABCDEFG] for test 99454df0-db51-4708-b6fa-ddde8ac22fae {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/Status: Status ASSIGNED -> RUNNING {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalDeviceTestRunnerLauncher: Reserving devices [SKBFXABCDEFG] for test [99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalDeviceRunner: Reserved to test 99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/TestManager: Add test runner to test manager: 99454df0-db51-4708-b6fa-ddde8ac22fae {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/TestManager: Start test 99454df0-db51-4708-b6fa-ddde8ac22fae {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalDeviceRunner: Found test 99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988
05-29 03:16:01 PDT I/LocalDeviceTestRunnerLauncher: Executing test [99454df0-db51-4708-b6fa-ddde8ac22fae] on its primary device runner [SKBFXABCDEFG] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/TestRunnerLauncher: Executing test [99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/BaseTestRunner: Start pre-running test xts-tradefed-test-gts on device(s) [SKBFXABCDEFG] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestFlow: Loading lab plugins for test 99454df0-db51-4708-b6fa-ddde8ac22fae {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/PluginCreator: Loading plugins from jars [] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/PluginCreator: No plugin module class name given, searching plugin module classes by plugin module annotation {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/PluginCreator: No plugin class name given, searching plugin class by plugin annotation {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/PluginCreator: No plugin is loaded {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/BaseTestRunner: Update the status of test: [xts-tradefed-test-gts], devices: [[SKBFXABCDEFG]] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/BaseTestRunner: Post TestStartingEvent to test 99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/AtsSessionPlugin: Command [1]'s invocation [99454df0-db51-4708-b6fa-ddde8ac22fae] allocated devices [SKBFXABCDEFG]. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/SessionInfo: New session plugin output, session_id=b8795bd0-88ca-42ff-961f-b04435502de0, plugin_label=AtsSessionPlugin, new_plugin_output=[run_command_state { command_id: "1" command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" running_invocation { key: "99454df0-db51-4708-b6fa-ddde8ac22fae" value { invocation { command_id: "1" start_time { seconds: 1780049761 nanos: 472812349 } device_id: "SKBFXABCDEFG" state_summary: "gts" } start_time { seconds: 1780049761 nanos: 472812349 } } } separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" }] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestRunner: Pre-run test {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestFlow: --------- Device: PreRunTest (99454df0-db51-4708-b6fa-ddde8ac22fae) --------- {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestFlow: Pre-run test of device [SKBFXABCDEFG] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/AndroidDeviceDelegate: Stop package on device SKBFXABCDEFG before test started: com.google.android.apps.internal.statusbarhider {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/AndroidRealDeviceDelegate: Device daemon is disabled on device SKBFXABCDEFG {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/AndroidRealDeviceDelegate: Ignoring attempt to enable device SKBFXABCDEFG charging before test 99454df0-db51-4708-b6fa-ddde8ac22fae because disabled enforceSafeDischarge. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestFlow: Pre-run test of device [SKBFXABCDEFG] finished {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/NoOpTestFlowConverter: Run test in MH classic mode because ATS uses classic mode {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestFlow: Start test [xts-tradefed-test-gts] on device(s) [SKBFXABCDEFG]:
 + Test Name: xts-tradefed-test-gts
 + Test ID: 99454df0-db51-4708-b6fa-ddde8ac22fae
 + Job Name: xts-tradefed-test-job
 + Job ID: dcb139eb-3978-4e6c-bb3a-f696af89a988
 + Device Information:
   + Device: SKBFXABCDEFG
       - num_cpus = 4
       - sign = release-keys
       - language = en
       - incremental_build = 15.561.116-20260519
       - gmscore_signature = 98deb0ca
       - supports_adhoc = true
       - type = bfx_at100
       - uuid = SKBFXABCDEFG
       - product_device = bfx-at100
       - device_form = physical
       - veritymode = enforcing
       - model = bfx-at100
       - screen_size = 1920x1080
       - id = SKBFXABCDEFG
       - release_version = 12
       - brand = skb
       - build_type = user
       - hardware = amlogic
       - free_internal_storage = 3.05GB
       - writable_external_storage = /storage/emulated/0
       - mcc_mnc = 
       - device_class_name = AndroidRealDevice
       - revision = 0
       - battery_status = ok
       - battery_temperature = 4
       - external_storage_status = ok
       - screen_density = 320
       - codename = rel
       - network_address = fe80::ee5c:68ff:fe1d:bc62/64,192.168.40.6/24
       - free_internal_storage_percentage = 76.18%
       - device = bfx-at100
       - product_board = bfx-at100
       - internet = false
       - release_version_major = 12
       - communication_type = USB
       - communication_type = ADB
       - iccids = 
       - control_id = SKBFXABCDEFG
       - free_external_storage = 3.05GB
       - launcher_1 = false
       - uuid_volatile = false
       - locale = en-us
       - launcher_3 = false
       - native_bridge = 0
       - internal_storage_status = ok
       - free_external_storage_percentage = 76.18%
       - total_memory = 2941 MB
       - feature = android.software.leanback
       - feature = android.software.leanback_only
       - launcher_gel = false
       - sdk_version = 31
       - rooted = false
       - characteristics = tv,nosdcard
       - os = android
       - battery_level = 50
       - bluetooth_mac_address = 22:22:40:6b:7a:68
       - screenshot_able = true
       - abi = armeabi-v7a
       - gms_version = 26.18.33 (180300-913931251)
       - supports_gmscore = true
       - svelte_device = false
       - build = STTC.220724.001.15.561.116-20260519 release-keys
       - build = sttc.220724.001.15.561.116-20260519 release-keys
       - serial = SKBFXABCDEFG
       - serial = skbfxabcdefg
       - abilist = armeabi-v7a,armeabi
       - build_alias = sttc.220724.001
       - preview_sdk_version = 0 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestFlow: Adding common dimensions [] shared among testbed to test 99454df0-db51-4708-b6fa-ddde8ac22fae {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalFileUtil: Checked fully accessibility of file /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723. Permissions: rwxr-xr-x {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalFileUtil: Checked fully accessibility of file /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae. Permissions: rwxr-xr-x {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestRunner: Register test message subscriber: XtsTradefedTest {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/BaseTestRunner: Local test message subscribers: [] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/BaseTestRunner: Post TestStartedEvent to test 99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/BaseTestRunner: Pre-run test xts-tradefed-test-gts finished {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/BaseTestRunner: Start running test xts-tradefed-test-gts on device(s) [SKBFXABCDEFG] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestFlow: --------- Device: RunTest (99454df0-db51-4708-b6fa-ddde8ac22fae) --------- {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestRunner: Starting driver [XtsTradefedTest] of test xts-tradefed-test-gts {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalTestRunner: XtsTradefedTest is starting {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT W/JobInfo: The sub device spec should exist and the global scoped spec should not be used. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/XtsTradefedTest: spec: xts_type: "gts"
xts_root_dir: "/google_xts"
xts_test_plan: "gts"
run_command_args: "-m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests"
olc_session_client_id: "ats-console-edeb77ec-584b-4d76-8bdb-ded239085ca7"
xts_log_root_path: "/google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653"
disable_tf_result_log: true
 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/XtsTradefedTest: params: Parameters:
	Name: olc_session_client_id
	Value: ats-console-edeb77ec-584b-4d76-8bdb-ded239085ca7
	Name: xts_log_root_path
	Value: /google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653
	Name: job_persistent_path
	Value: /tmp/olc_server_temp_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/persistence/dcb139eb-3978-4e6c-bb3a-f696af89a988.textproto
	Name: check_installed_gms_core_version
	Value: false
	Name: disable_tf_result_log
	Value: true
	Name: tags
	Value: 
	Name: clear_gservices_overrides
	Value: false
 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/XtsTradefedTest: proto spec: com.google.wireless.qa.mobileharness.shared.model.job.in.spec.ProtoJobSpec@1cb3d044 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/DeviceCacheManager: Add cache(GENERAL) for device [SKBFXABCDEFG] with timeout PT359H58M59.614S {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalFileUtil: Checked fully accessibility of file /tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e. Permissions: rwxr-xr-x {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/XtsTradefedTest: Finished integrating the test cases [/google_xts/android-gts/testcases] with the temp XTS workspace [/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases]. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/XtsTradefedTest: xTS Tradefed temp working root directory is /tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/LocalFileUtil: Checked fully accessibility of file /tmp/mh_res_files/com/google/devtools/mobileharness/platform/android/xts/agent/tradefed_invocation_agent_deploy.jar. Permissions: rw-r--r-- {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/ResUtil: Copy resource /com/google/devtools/mobileharness/platform/android/xts/agent/tradefed_invocation_agent_deploy.jar to /tmp/mh_res_files/com/google/devtools/mobileharness/platform/android/xts/agent/tradefed_invocation_agent_deploy.jar {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/XtsTradefedTest: Running gts command:
PATH=/usr/bin:/usr/bin:/usr/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin LD_LIBRARY_PATH=/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/lib:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/lib64:/google_xts/android-gts/tools/../../android-gts/lib:/google_xts/android-gts/tools/../../android-gts/lib64: TF_WORK_DIR=/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e /tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/jdk/bin/java -Xmx24g -XX:+HeapDumpOnOutOfMemoryError -javaagent:/tmp/mh_res_files/com/google/devtools/mobileharness/platform/android/xts/agent/tradefed_invocation_agent_deploy.jar=/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/tf_runtime_info -cp /tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/tools/tradefed.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/tools/gts-tradefed-tests.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/tools/compatibility-host-util.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/tools/loganalysis.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/tools/compatibility-tradefed.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/tools/gts-tradefed.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsDozeHostSideTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsKidsHomeHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsPlayStoreCommon.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsTvHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsInstantAppsHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsCastHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsAssistantHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsBackgroundInstallControlManagerHostTest.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsSampleHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsJniUncompressHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsPlayStoreHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsHomeHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsNetStatsHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsWellbeingHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsEdiHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/AngleGTSTestCommon.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsBootStatsTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsStagedInstallHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsRollbackManagerTest.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/xts-business-logic.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsLargeApkHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsIncrementalInstallProxyHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsAccountsHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsPackageManagerHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsNetUnofficialApisUsageTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsLinkerConfigTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsGameOverlayTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsMemoryHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsFontHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsSearchHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsUnofficialApisUsageTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsScreenshotHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsBootHealthHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsLocationHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsVndkDependencyTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsSsaidHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsPreserveLegacyStorageHostTest.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsStatsdHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsSensorHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsVoiceInteractionHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsEntertainmentSpaceHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsTelephonyNumberVerificationHostCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsAssistantMicHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsTestHarnessModeTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsGmscoreHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsSetupWizardHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsDebugfsMountTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsOsHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsWebViewHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsGeminiHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsSettingsHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsUsbHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsNetworkStackHostTestCases/GtsNetworkStackHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsContactsProviderHostCases/GtsContactsProviderHostCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsAngleHostsideTestCases/GtsAngleHostsideTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsAngleHostsideTestCases/AngleGTSTestCommon.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/MicrodroidHostTestCases.GTS/MicrodroidHostTestCases.GTS.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsArtManagerHostTestCases/GtsArtManagerHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsPermissionControllerHostTestCases/GtsPermissionControllerHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsBackupHostTestCases/GtsBackupHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/CtsClasspathDeviceInfoTestCases/CtsClasspathDeviceInfoTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/GtsSecurityHostTestCases/GtsSecurityHostTestCases.jar:/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/testcases/CtsEdiHostTestCases/CtsEdiHostTestCases.jar -DGTS_ROOT=/tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e com.android.compatibility.common.tradefed.command.CompatibilityConsole run commandAndExit gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests -s SKBFXABCDEFG {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:01 PDT I/XtsTradefedTest: xTS TF started, pid=25742 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:02 PDT I/TestManager: (1) Test Ids: 99454df0-db51-4708-b6fa-ddde8ac22fae {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:05 PDT I/AtsSessionPlugin: Updated invocation info of test [99454df0-db51-4708-b6fa-ddde8ac22fae]: invocation { command_id: "1" start_time { seconds: 1780049761 nanos: 472812349 } device_id: "SKBFXABCDEFG" state_summary: "(not invoked)" } start_time { seconds: 1780049761 nanos: 472812349 } {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:05 PDT I/SessionInfo: New session plugin output, session_id=b8795bd0-88ca-42ff-961f-b04435502de0, plugin_label=AtsSessionPlugin, new_plugin_output=[run_command_state { command_id: "1" command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" running_invocation { key: "99454df0-db51-4708-b6fa-ddde8ac22fae" value { invocation { command_id: "1" start_time { seconds: 1780049761 nanos: 472812349 } device_id: "SKBFXABCDEFG" state_summary: "(not invoked)" } start_time { seconds: 1780049761 nanos: 472812349 } } } separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" }] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:10 PDT I/AtsSessionPlugin: Updated invocation info of test [99454df0-db51-4708-b6fa-ddde8ac22fae]: invocation { command_id: "1" start_time { seconds: 1780049761 nanos: 472812349 } device_id: "SKBFXABCDEFG" state_summary: "running gts on build(s) \'DeviceBuildInfo{bid=13064529, serial=SKBFXABCDEFG}\'" } start_time { seconds: 1780049761 nanos: 472812349 } {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:10 PDT I/SessionInfo: New session plugin output, session_id=b8795bd0-88ca-42ff-961f-b04435502de0, plugin_label=AtsSessionPlugin, new_plugin_output=[run_command_state { command_id: "1" command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" running_invocation { key: "99454df0-db51-4708-b6fa-ddde8ac22fae" value { invocation { command_id: "1" start_time { seconds: 1780049761 nanos: 472812349 } device_id: "SKBFXABCDEFG" state_summary: "running gts on build(s) \'DeviceBuildInfo{bid=13064529, serial=SKBFXABCDEFG}\'" } start_time { seconds: 1780049761 nanos: 472812349 } } } separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" }] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:16:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:17:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:18:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:18:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:19:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:19:55 PDT I/OlcServer: OLC server memory info: jvm_used=54.88MB, jvm_total=112MB, jvm_max=24GB, heap_used=50.11MB, free=732MB, used=61.13GB, total=61.84GB
05-29 03:20:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:20:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:21:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:22:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:22:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:23:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:24:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:24:55 PDT I/OlcServer: OLC server memory info: jvm_used=39.34MB, jvm_total=112MB, jvm_max=24GB, heap_used=34.98MB, free=560MB, used=61.29GB, total=61.84GB
05-29 03:24:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:24:55 PDT I/ApiConfigFileProcessor: Not load api config file because both api_config and lab_device_config flag are empty.
05-29 03:25:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:26:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:26:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:27:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:28:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:28:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:29:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:29:55 PDT I/OlcServer: OLC server memory info: jvm_used=21.42MB, jvm_total=112MB, jvm_max=24GB, heap_used=18.93MB, free=2.06GB, used=59.78GB, total=61.84GB
05-29 03:30:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:30:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:31:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:32:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:32:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:33:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:34:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:34:55 PDT I/OlcServer: OLC server memory info: jvm_used=49.99MB, jvm_total=112MB, jvm_max=24GB, heap_used=34.93MB, free=1.09GB, used=60.75GB, total=61.84GB
05-29 03:34:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:34:55 PDT I/ApiConfigFileProcessor: Not load api config file because both api_config and lab_device_config flag are empty.
05-29 03:35:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:36:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:36:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:37:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:38:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:38:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:39:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:39:55 PDT I/OlcServer: OLC server memory info: jvm_used=28.37MB, jvm_total=112MB, jvm_max=24GB, heap_used=19.27MB, free=906MB, used=60.96GB, total=61.84GB
05-29 03:40:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:40:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:41:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:42:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:42:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:43:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:44:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:44:55 PDT I/OlcServer: OLC server memory info: jvm_used=53.4MB, jvm_total=112MB, jvm_max=24GB, heap_used=51.27MB, free=1.06GB, used=60.78GB, total=61.84GB
05-29 03:44:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:44:55 PDT I/ApiConfigFileProcessor: Not load api config file because both api_config and lab_device_config flag are empty.
05-29 03:45:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:46:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:46:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:47:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:48:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:48:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:49:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:49:55 PDT I/OlcServer: OLC server memory info: jvm_used=32.43MB, jvm_total=112MB, jvm_max=24GB, heap_used=19.62MB, free=929MB, used=60.93GB, total=61.84GB
05-29 03:50:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:50:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:51:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:52:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:52:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:53:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:54:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:54:55 PDT I/OlcServer: OLC server memory info: jvm_used=57.4MB, jvm_total=112MB, jvm_max=24GB, heap_used=51.62MB, free=1.11GB, used=60.73GB, total=61.84GB
05-29 03:54:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:54:55 PDT I/ApiConfigFileProcessor: Not load api config file because both api_config and lab_device_config flag are empty.
05-29 03:55:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:56:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:56:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:57:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:58:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:58:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 03:59:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 03:59:55 PDT I/OlcServer: OLC server memory info: jvm_used=34.76MB, jvm_total=112MB, jvm_max=24GB, heap_used=19.48MB, free=1.31GB, used=60.53GB, total=61.84GB
05-29 04:00:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:00:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:01:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:02:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:02:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:03:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:04:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:04:55 PDT I/OlcServer: OLC server memory info: jvm_used=59.93MB, jvm_total=112MB, jvm_max=24GB, heap_used=51.48MB, free=1.37GB, used=60.47GB, total=61.84GB
05-29 04:04:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:04:55 PDT I/ApiConfigFileProcessor: Not load api config file because both api_config and lab_device_config flag are empty.
05-29 04:05:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:06:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:06:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:07:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:08:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:08:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:09:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:09:55 PDT I/OlcServer: OLC server memory info: jvm_used=37.47MB, jvm_total=112MB, jvm_max=24GB, heap_used=35.86MB, free=1.2GB, used=60.64GB, total=61.84GB
05-29 04:10:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:10:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:11:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:12:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:12:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:13:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:14:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:14:55 PDT I/OlcServer: OLC server memory info: jvm_used=61.96MB, jvm_total=112MB, jvm_max=24GB, heap_used=51.86MB, free=495MB, used=61.36GB, total=61.84GB
05-29 04:14:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:14:55 PDT I/ApiConfigFileProcessor: Not load api config file because both api_config and lab_device_config flag are empty.
05-29 04:15:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:16:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:16:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:17:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:18:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:18:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:19:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:19:55 PDT I/OlcServer: OLC server memory info: jvm_used=39.31MB, jvm_total=112MB, jvm_max=24GB, heap_used=35.78MB, free=1.29GB, used=60.55GB, total=61.84GB
05-29 04:20:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:20:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:21:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:22:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:22:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:23:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:24:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:24:55 PDT I/OlcServer: OLC server memory info: jvm_used=64.01MB, jvm_total=112MB, jvm_max=24GB, heap_used=51.78MB, free=1.3GB, used=60.54GB, total=61.84GB
05-29 04:24:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:24:55 PDT I/ApiConfigFileProcessor: Not load api config file because both api_config and lab_device_config flag are empty.
05-29 04:25:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:26:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:26:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:27:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:28:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:28:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:29:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:29:55 PDT I/OlcServer: OLC server memory info: jvm_used=41.62MB, jvm_total=112MB, jvm_max=24GB, heap_used=20.11MB, free=1.36GB, used=60.48GB, total=61.84GB
05-29 04:30:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:30:55 PDT I/LocalMode: Device count: 1, status:
======== AndroidRealDevice ========
BUSY(1):	SKBFXABCDEFG
05-29 04:31:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:00 PDT I/JobManager: (1) Job Ids: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/XtsTradefedTest: One TF finished (the command is still running, and it will finish after all TF and the post-processing finish) {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/XtsTradefedTest: Finished running gts test. xTS run command exit code: Optional[0] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/Result: Result UNKNOWN -> PASS, caller=[com.google.devtools.mobileharness.api.model.job.out.Result.setPass(Result.java:102)  <--  com.google.wireless.qa.mobileharness.shared.api.driver.XtsTradefedTest.setTestResult(XtsTradefedTest.java:266)  <--  com.google.wireless.qa.mobileharness.shared.api.driver.XtsTradefedTest.run(XtsTradefedTest.java:235)  <--  com.google.devtools.mobileharness.infra.controller.test.local.LocalTestRunner$DriverEventGenerator.run(LocalTestRunner.java:279)] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/DeviceCacheManager: Invalidating [GENERAL] cache for device [SKBFXABCDEFG] succeeded. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/LocalFileUtil: Checked fully accessibility of file /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files. Permissions: rwxr-xr-x {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/LocalFileUtil: Checked fully accessibility of file /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results. Permissions: rwxr-xr-x {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/LocalFileUtil: Copy file or dir from /tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/results/2026.05.29_10.16.03.zip to /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/LocalFileUtil: Copy file or dir from /tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/results/2026.05.29_10.16.03 to /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/LocalFileUtil: Copy file or dir from /tmp/xts-root-dir-3b1b13d9-8dd6-4c30-a22b-21b398124c5e/android-gts/logs to /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/LocalTestRunner: XtsTradefedTest has ended {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/LocalTestRunner: Driver [XtsTradefedTest] of test xts-tradefed-test-gts ended {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/BaseTestRunner: Update the status of test: [xts-tradefed-test-gts], devices: [[SKBFXABCDEFG]] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/BaseTestRunner: Run test xts-tradefed-test-gts finished {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/BaseTestRunner: Start post-run test xts-tradefed-test-gts on device(s) [SKBFXABCDEFG] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/BaseTestRunner: Post TestEndingEvent to test 99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/TestCommandHistorySaver: Saving test command history... {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/Status: Status RUNNING -> DONE {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/BaseTestRunner: Finish [dcb139eb-3978-4e6c-bb3a-f696af89a988:xts-tradefed-test-gts] : PASS {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/LocalTestFlow: --------- Device: PostRunTest (99454df0-db51-4708-b6fa-ddde8ac22fae) --------- {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/LocalTestFlow: Post-run test of device [SKBFXABCDEFG] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT W/DeviceCacheManager: Invalidating [GENERAL] cache for device [SKBFXABCDEFG] failed. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:32 PDT I/AndroidRealDeviceDelegate: Ignoring attempt to clear multi-user on device SKBFXABCDEFG. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/AndroidRealDeviceDelegate: Largest PM UID on device SKBFXABCDEFG is: 10089 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/LocalTestFlow: Post-run test of device [SKBFXABCDEFG] finished, result=NONE {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/LocalTestFlow: Adding common dimensions [] shared among testbed to test 99454df0-db51-4708-b6fa-ddde8ac22fae {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/BaseTestRunner: Post TestEndedEvent to test 99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/AtsSessionPlugin: Command [1]'s invocations completed. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/SessionInfo: New session plugin output, session_id=b8795bd0-88ca-42ff-961f-b04435502de0, plugin_label=AtsSessionPlugin, new_plugin_output=[run_command_state { command_id: "1" total_execution_time { seconds: 4591 nanos: 584991765 } command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" }] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/GenFileHandler: Start uploading test generated files {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/GenFileHandler: Saved the test log to /tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/test_output.txt {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/GenFileHandler: Finish uploading test generated files {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/BaseTestRunner: Stopped {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/BaseTestRunner: Post-run test xts-tradefed-test-gts finished {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/BaseTestRunner: End test xts-tradefed-test-gts on devices(s) [SKBFXABCDEFG] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT W/DeviceCacheManager: Invalidating [GENERAL] cache for device [SKBFXABCDEFG] failed.
05-29 04:32:33 PDT W/DeviceCacheManager: Invalidating [CONTAINER] cache for device [SKBFXABCDEFG] failed.
05-29 04:32:33 PDT I/DeviceRebootUtil: Skip checking consecutive test results because this device SKBFXABCDEFG doesn't support reboot
05-29 04:32:33 PDT I/LocalDeviceRunner: Posting TestExecutionEndedEvent, allocation=Allocation{test=99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988, devices=[SKBFXABCDEFG]}, result=PASS, need_reboot=false
05-29 04:32:33 PDT I/JobManager: Release allocation Allocation{test=99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988, devices=[SKBFXABCDEFG]}, result=PASS, device_dirty=false
05-29 04:32:33 PDT I/LocalDeviceVerifier: Device SKBFXABCDEFG not rebootable.
05-29 04:32:33 PDT I/LocalDeviceAllocator: Release device SKBFXABCDEFG in scheduler, DeviceDirty=false
05-29 04:32:33 PDT I/Allocations: Un-assign test 99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988
05-29 04:32:33 PDT I/Allocations: Free device SKBFXABCDEFG
05-29 04:32:33 PDT I/SimpleScheduler: Remove test 99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988
05-29 04:32:33 PDT I/SimpleScheduler: Test 99454df0-db51-4708-b6fa-ddde8ac22fae removed from job dcb139eb-3978-4e6c-bb3a-f696af89a988
05-29 04:32:33 PDT I/SimpleScheduler: Allocation Allocation{test=99454df0-db51-4708-b6fa-ddde8ac22fae@dcb139eb-3978-4e6c-bb3a-f696af89a988, devices=[SKBFXABCDEFG]} released
05-29 04:32:33 PDT I/LocalDeviceRunner: TestExecutionEndedEvent posted
05-29 04:32:33 PDT I/LocalDeviceRunner: Update device SKBFXABCDEFG last IDLE time: 2026-05-29T11:32:33.015585082Z
05-29 04:32:33 PDT I/JobRunner: Job done {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/SimpleScheduler: Job deleted: dcb139eb-3978-4e6c-bb3a-f696af89a988 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/JobRunner: Job runner post run job {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/JobRunner: Shutdown test thread pool {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT W/TestManager: Interrupted sleep interrupted {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/TestManager: Stopped! {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/JobRunner: Finalize job {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/Result: Result UNKNOWN -> PASS, caller=[com.google.devtools.mobileharness.api.model.job.out.Result.setPass(Result.java:102)  <--  com.google.devtools.mobileharness.infra.client.api.controller.job.JobRunner.finalizeJobResult(JobRunner.java:1446)  <--  com.google.devtools.mobileharness.infra.client.api.controller.job.JobRunner.postRunJob(JobRunner.java:1018)  <--  com.google.devtools.mobileharness.infra.client.api.controller.job.JobRunner.run(JobRunner.java:587)] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/Status: Status RUNNING -> DONE {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/AtsSessionPlugin: All added tradefed jobs have been done, try add non-tradefed jobs if needed. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/JobReporter: The job xts-tradefed-test-job PASS!
Passed tests(1) {
  xts-tradefed-test-gts: PASS
}
PASS!
Tests run: 1, Passed: 1   
 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/GenFileHandler: GenFileHandler started to ack JobEndEvent. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/GenFileHandler: GenFileHandler finished to ack JobEndEvent. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:33 PDT I/JobRunner: Job stopped {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/SessionJobRunner: All jobs of session b8795bd0-88ca-42ff-961f-b04435502de0 finished {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/SessionPluginRunner: Posting SessionEndedEvent {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/SessionPluginRunner: Posting SessionEndedEvent(b8795bd0-88ca-42ff-961f-b04435502de0) to subscriber [com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin#onSessionEnded(SessionEndedEvent)@80041717] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/RunCommandHandler: Command [1] is done and start to handle result which may take several minutes based on the session scale. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/SessionResultHandlerUtil: Acquiring lock to process result. Session id: b8795bd0-88ca-42ff-961f-b04435502de0 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/SessionResultHandlerUtil: Acquired lock to process result. Session id: b8795bd0-88ca-42ff-961f-b04435502de0 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/SessionResultHandlerUtil: Copying tradefed test log relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/test_output.txt] into dir [/google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653/inv_7399009622885890721/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/SessionResultHandlerUtil: Copying tradefed test log relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/command_history.txt] into dir [/google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653/inv_7399009622885890721/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/SessionResultHandlerUtil: Copying tradefed test log relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/tf_runtime_info] into dir [/google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653/inv_7399009622885890721/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:34 PDT I/SessionResultHandlerUtil: Copying tradefed test log relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/tf_runtime_info.lck] into dir [/google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653/inv_7399009622885890721/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/device-info-files] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/proto] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/compatibility_result.xsl] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/logo.png] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/invocation_summary.txt] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/test_result.html] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/report-log-files] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/checksum-suite.data] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/test_result.xml] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/test_result_failures_suite.html] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/module_reports] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/config] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/compatibility_result.css] into tmp dir [/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/device-info-files] into dir [/google_xts/android-gts/results/2026.05.29_10.15.59.688_5653] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/proto] into dir [/google_xts/android-gts/results/2026.05.29_10.15.59.688_5653] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/invocation_summary.txt] into dir [/google_xts/android-gts/results/2026.05.29_10.15.59.688_5653] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/report-log-files] into dir [/google_xts/android-gts/results/2026.05.29_10.15.59.688_5653] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Copying tradefed test result relevant file/dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723/test_99454df0-db51-4708-b6fa-ddde8ac22fae/android-gts-gen-files/results/2026.05.29_10.16.03/config] into dir [/google_xts/android-gts/results/2026.05.29_10.15.59.688_5653] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/CompatibilityReportMerger: Start to parse result bundle files:
 - Test result XML: /tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae/test_result.xml, Test record file: Optional[/tmp/1869a1dd-1f41-4a98-9e86-cc9acf0836ab/XtsTradefedTest_test_99454df0-db51-4708-b6fa-ddde8ac22fae/proto/test-record.pb] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/CompatibilityReportMerger: Given reports number: 1, usable parsed results number: 1 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/CompatibilityReportMerger: Given reports number: 1, usable reports number: 1 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/CompatibilityReportMerger: Given reports number: 1, usable reports number: 1 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/CompatibilityReportCreator: No test record specified. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/CompatibilityReportCreator: Viewable report: /google_xts/android-gts/results/2026.05.29_10.15.59.688_5653/test_result.html {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/CompatibilityReportCreator: Failure HTML report: /google_xts/android-gts/results/2026.05.29_10.15.59.688_5653/test_result_failures_suite.html {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Result processing finished. Session id: b8795bd0-88ca-42ff-961f-b04435502de0 {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionResultHandlerUtil: Cleaning up job [dcb139eb-3978-4e6c-bb3a-f696af89a988] gen dir [/tmp/olc_server_gen_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/job_gen_xts-tradefed-test-job_827662d3-079d-4bb8-8fc6-5311ba81f723] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SuiteResultReporter: Getting invocation summary... {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/RunCommandHandler: Invocation summary file [/google_xts/android-gts/results/2026.05.29_10.15.59.688_5653/invocation_summary.txt] exists, overriding it. {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionInfo: New session plugin output, session_id=b8795bd0-88ca-42ff-961f-b04435502de0, plugin_label=AtsSessionPlugin, new_plugin_output=[success { output_message: "run_command session_id: [b8795bd0-88ca-42ff-961f-b04435502de0], command_id: [1], result: COMPLETED.\ncommand_line_args: gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests\n\n============================================\n================= Results ==================\n=============== Consumed Time ==============\n    armeabi-v7a WvtsDeviceTestCases: 1h 15m 17s\nTotal aggregated tests run time: 1h 15m 17s\n============== TOP 1 Slow Modules ==============\n    armeabi-v7a WvtsDeviceTestCases: 0.04 tests/sec [166 tests / 4517121 msec]\n============== Modules Preparation Times ==============\n    armeabi-v7a WvtsDeviceTestCases => prep = 3723 ms || clean = 2113 ms\nTotal preparation time: 3s  ||  Total tear down time: 2s\n=======================================================\n=============== Summary ===============\nTotal Run time: 1h 16m 28s\n1/1 modules completed\nTotal Tests       : 166\nPASSED            : 127\nFAILED            : 13\nASSUMPTION_FAILURE: 26\n============== End of Results ==============\n============================================\n=========== Result/Log Location ============\nLOG DIRECTORY               : /google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653\nRESULT DIRECTORY            : /google_xts/android-gts/results/2026.05.29_10.15.59.688_5653\n=================== End ====================\n" } run_command_state { command_id: "1" total_execution_time { seconds: 4591 nanos: 584991765 } command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" }] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionPluginRunner: Subscriber [com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin#onSessionEnded(SessionEndedEvent)@80041717] handled SessionEndedEvent(b8795bd0-88ca-42ff-961f-b04435502de0) {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionManager: Session finished, session_id=b8795bd0-88ca-42ff-961f-b04435502de0, final_session_detail=[session_id { id: "b8795bd0-88ca-42ff-961f-b04435502de0" } session_status: SESSION_FINISHED session_config { session_name: "run_command" session_property { key: "olc_server_session_client_id" value: "ats-console-edeb77ec-584b-4d76-8bdb-ded239085ca7" } session_plugin_configs { session_plugin_config { loading_config { plugin_class_name: "com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPlugin" plugin_module_class_name: "com.google.devtools.mobileharness.infra.ats.console.controller.sessionplugin.AtsSessionPluginModule" } execution_config { config { [type.googleapis.com/mobileharness.infra.ats.console.controller.AtsSessionPluginConfig] { run_command { test_plan: "gts" xts_root_dir: "/google_xts" module_name: "WvtsDeviceTestCases" xts_type: "gts" test_name: "com.google.android.wvts.WidevineDashPolicyTests" initial_state { command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" } html_in_zip: false report_system_checkers: false } } } } explicit_label { label: "AtsSessionPlugin" } } } } session_output { session_property { key: "olc_server_session_client_id" value: "ats-console-edeb77ec-584b-4d76-8bdb-ded239085ca7" } session_property { key: "olc_server_session_command_id" value: "1" } session_property { key: "olc_server_session_contain_started_test" value: "true" } session_property { key: "olc_server_session_log_file_path" value: "/google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653/olc_server_session_logs/olc_server_session_log.txt" } session_property { key: "timestamp_dir_name" value: "2026.05.29_10.15.59.688_5653" } session_plugin_output { key: "AtsSessionPlugin" value { output { [type.googleapis.com/mobileharness.infra.ats.console.controller.AtsSessionPluginOutput] { success { output_message: "run_command session_id: [b8795bd0-88ca-42ff-961f-b04435502de0], command_id: [1], result: COMPLETED.\ncommand_line_args: gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests\n\n============================================\n================= Results ==================\n=============== Consumed Time ==============\n    armeabi-v7a WvtsDeviceTestCases: 1h 15m 17s\nTotal aggregated tests run time: 1h 15m 17s\n============== TOP 1 Slow Modules ==============\n    armeabi-v7a WvtsDeviceTestCases: 0.04 tests/sec [166 tests / 4517121 msec]\n============== Modules Preparation Times ==============\n    armeabi-v7a WvtsDeviceTestCases => prep = 3723 ms || clean = 2113 ms\nTotal preparation time: 3s  ||  Total tear down time: 2s\n=======================================================\n=============== Summary ===============\nTotal Run time: 1h 16m 28s\n1/1 modules completed\nTotal Tests       : 166\nPASSED            : 127\nFAILED            : 13\nASSUMPTION_FAILURE: 26\n============== End of Results ==============\n============================================\n=========== Result/Log Location ============\nLOG DIRECTORY               : /google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653\nRESULT DIRECTORY            : /google_xts/android-gts/results/2026.05.29_10.15.59.688_5653\n=================== End ====================\n" } run_command_state { command_id: "1" total_execution_time { seconds: 4591 nanos: 584991765 } command_line_args: "gts -m WvtsDeviceTestCases -t com.google.android.wvts.WidevineDashPolicyTests" separated_command_line_args: "gts" separated_command_line_args: "-m" separated_command_line_args: "WvtsDeviceTestCases" separated_command_line_args: "-t" separated_command_line_args: "com.google.android.wvts.WidevineDashPolicyTests" } } } } } session_timing_info { session_submitted_time { seconds: 1780049759 nanos: 662661002 } } }] {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/SessionManager: Copying server session log file from /tmp/olc_server_temp_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/olc_server_session_log/olc_server_session_log_0.txt to /google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653/olc_server_session_logs/olc_server_session_log.txt {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
05-29 04:32:35 PDT I/LocalFileUtil: Copy file or dir from /tmp/olc_server_temp_files/session_b8795bd0-88ca-42ff-961f-b04435502de0/olc_server_session_log/olc_server_session_log_0.txt to /google_xts/android-gts/logs/2026.05.29_10.15.59.688_5653/olc_server_session_logs/olc_server_session_log.txt {olc_session_id=b8795bd0, olc_client_id=ats-console-edeb77ec}
