[62.702365] Initializing watchdogs
[62.702444]   /dev/watchdog0
[62.722389] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.732908] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.736520] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.738752] [001/130] (960s left) perf_pmu (gt-awake)
[62.809007] Starting subtest: gt-awake
[67.209787] Subtest gt-awake: SUCCESS (4.401s)
[67.557759] [002/130] (955s left) i915_getparams_basic (basic-eu-total)
[67.680346] Starting subtest: basic-eu-total
[67.682176] Subtest basic-eu-total: SUCCESS (0.000s)
[67.871751] [003/130] (955s left) kms_psr (fbc-psr2-sprite-plane-move)
[68.116479] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[68.171661] [004/130] (955s left) kms_getfb (getfb2-accept-nv12)
[68.347812] Starting subtest: getfb2-accept-nv12
[68.349732] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[68.574888] [005/130] (954s left) syncobj_timeline (etime-single-wait-submitted)
[68.651394] Starting subtest: etime-single-wait-submitted
[68.759384] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[68.902695] [006/130] (954s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[69.087387] Starting subtest: fbcpsr-tiling-4
[69.089028] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[69.277758] [007/130] (954s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[69.475333] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[69.477124] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[69.662153] [008/130] (954s left) gem_create (create-size-update)
[69.728030] Starting subtest: create-size-update
[69.728902] Subtest create-size-update: SUCCESS (0.000s)
[69.997158] [009/130] (953s left) gem_exec_nop (basic-parallel)
[70.081570] Starting subtest: basic-parallel
[74.459923] Subtest basic-parallel: SUCCESS (4.379s)
[74.792497] [010/130] (949s left) perf_pmu (rc6)
[74.854343] Starting subtest: rc6
[74.855242] Starting dynamic subtest: gt0
[81.207598] Dynamic subtest gt0: SUCCESS (6.352s)
[81.216950] Starting dynamic subtest: runtime-pm-gt0
[89.244009] Dynamic subtest runtime-pm-gt0: SUCCESS (8.035s)
[89.252851] Starting dynamic subtest: runtime-pm-long-gt0
[101.922908] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.678s)
[101.931532] Starting dynamic subtest: other-idle-gt0
[101.933293] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[101.934227] Subtest rc6: SUCCESS (27.069s)
[102.638538] [011/130] (921s left) kms_cursor_crc (cursor-sliding-64x64)
[102.963371] Starting subtest: cursor-sliding-64x64
[102.977936] Starting dynamic subtest: pipe-A-DP-3
[107.426713] Dynamic subtest pipe-A-DP-3: SUCCESS (4.448s)
[107.477155] Starting dynamic subtest: pipe-D-DP-3
[111.761032] Dynamic subtest pipe-D-DP-3: SUCCESS (4.292s)
[111.761949] Subtest cursor-sliding-64x64: SUCCESS (8.798s)
[112.173259] [012/130] (911s left) perf (rc6-disable)
[112.488404] Starting subtest: rc6-disable
[112.674126] Subtest rc6-disable: SUCCESS (0.186s)
[112.775955] [013/130] (911s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[112.843977] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[112.951410] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[113.019811] [014/130] (911s left) gem_workarounds (suspend-resume-fd)
[113.109909] Starting subtest: suspend-resume-fd
[132.236401] Subtest suspend-resume-fd: SUCCESS (3.882s)
[132.320331] [015/130] (891s left) gem_basic (create-close)
[132.392356] Starting subtest: create-close
[132.394348] Subtest create-close: SUCCESS (0.000s)
[132.473045] [016/130] (891s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[132.554396] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[132.657600] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[132.779598] [017/130] (891s left) gen7_exec_parse (basic-allowed)
[132.865484] Subtest basic-allowed: SKIP (0.000s)
[132.965002] [018/130] (891s left) prime_busy (after-wait)
[133.041396] Starting subtest: after-wait
[133.045826] Starting dynamic subtest: rcs0
[133.119478] Dynamic subtest rcs0: SUCCESS (0.074s)
[133.130547] Starting dynamic subtest: bcs0
[133.178133] Dynamic subtest bcs0: SUCCESS (0.058s)
[133.199262] Starting dynamic subtest: vcs0
[133.219872] Dynamic subtest vcs0: SUCCESS (0.041s)
[133.242261] Starting dynamic subtest: vcs1
[133.261514] Dynamic subtest vcs1: SUCCESS (0.041s)
[133.280815] Starting dynamic subtest: vecs0
[133.303690] Dynamic subtest vecs0: SUCCESS (0.042s)
[133.322396] Starting dynamic subtest: vecs1
[133.346031] Dynamic subtest vecs1: SUCCESS (0.042s)
[133.362387] Starting dynamic subtest: ccs0
[133.386568] Dynamic subtest ccs0: SUCCESS (0.040s)
[133.502544] Subtest after-wait: SUCCESS (0.453s)
[133.589501] [019/130] (890s left) i915_query (engine-info-invalid)
[133.658190] Starting subtest: engine-info-invalid
[133.659200] Subtest engine-info-invalid: SUCCESS (0.000s)
[133.743447] [020/130] (890s left) kms_flip (2x-flip-vs-dpms-on-nop)
[133.917900] Starting subtest: 2x-flip-vs-dpms-on-nop
[133.932827] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.015s)
[134.000003] [021/130] (890s left) gem_eio (in-flight-internal-1us)
[134.289661] Starting subtest: in-flight-internal-1us
[136.142674] Subtest in-flight-internal-1us: SUCCESS (1.853s)
[136.319269] [022/130] (888s left) kms_psr2_su (page_flip-xrgb8888)
[136.387299] Subtest page_flip-XRGB8888: SKIP (0.000s)
[136.479199] [023/130] (888s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[136.553831] Starting subtest: x-tiled-to-vebox-yf-tiled
[136.555928] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[136.770014] [024/130] (887s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[136.955560] Starting subtest: yf-tiled-16bpp-rotate-270
[136.957452] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[137.035951] [025/130] (887s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[137.215200] Starting subtest: bad-pixel-format-y-tiled-ccs
[137.216083] Starting dynamic subtest: pipe-A-DP-3
[137.224225] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[137.235019] Starting dynamic subtest: pipe-B-DP-3
[137.243039] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[137.254051] Starting dynamic subtest: pipe-C-DP-3
[137.262265] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[137.272982] Starting dynamic subtest: pipe-D-DP-3
[137.284513] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[137.286796] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[137.605117] [026/130] (887s left) gem_exec_params (dr1-dirt)
[137.678291] Starting subtest: DR1-dirt
[137.679300] Subtest DR1-dirt: SUCCESS (0.000s)
[137.765481] [027/130] (887s left) kms_color (legacy-gamma)
[137.940962] Starting subtest: legacy-gamma
[137.941833] Starting dynamic subtest: pipe-A-DP-3
[138.637295] Dynamic subtest pipe-A-DP-3: SUCCESS (0.696s)
[138.652726] Starting dynamic subtest: pipe-B-DP-3
[139.241604] Dynamic subtest pipe-B-DP-3: SUCCESS (0.603s)
[139.260200] Starting dynamic subtest: pipe-C-DP-3
[139.839620] Dynamic subtest pipe-C-DP-3: SUCCESS (0.598s)
[139.852681] Starting dynamic subtest: pipe-D-DP-3
[140.448107] Dynamic subtest pipe-D-DP-3: SUCCESS (0.608s)
[140.449068] Subtest legacy-gamma: SUCCESS (2.507s)
[140.630159] [028/130] (884s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[140.815778] Starting subtest: x-tiled-8bpp-rotate-0
[142.409403] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.593s)
[142.554244] [029/130] (882s left) prime_mmap (test_correct)
[142.632703] Starting subtest: test_correct
[142.633597] Starting dynamic subtest: test_correct-smem
[142.680513] Dynamic subtest test_correct-smem: SUCCESS (0.048s)
[142.692107] Starting dynamic subtest: test_correct-lmem0
[142.876369] Dynamic subtest test_correct-lmem0: SUCCESS (0.195s)
[142.877259] Subtest test_correct: SUCCESS (0.243s)
[142.951890] [030/130] (882s left) kms_pm_backlight (fade-with-suspend)
[143.130883] Subtest fade-with-suspend: SKIP (0.000s)
[143.182281] [031/130] (881s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[143.366111] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[143.415747] [032/130] (881s left) gem_ppgtt (blt-vs-render-ctx0)
[143.490244] Starting subtest: blt-vs-render-ctx0
[176.411815] Subtest blt-vs-render-ctx0: SUCCESS (32.920s)
[176.572596] [033/130] (848s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[176.800237] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[176.801148] Starting dynamic subtest: pipe-A-DP-3
[176.822224] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[176.834259] Starting dynamic subtest: pipe-B-DP-3
[176.855471] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[176.867476] Starting dynamic subtest: pipe-C-DP-3
[176.894502] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[176.907336] Starting dynamic subtest: pipe-D-DP-3
[176.929279] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[176.931524] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[177.206408] [034/130] (848s left) gem_lmem_swapping (verify-random-ccs)
[179.938916] Starting subtest: verify-random-ccs
[179.939812] Starting dynamic subtest: lmem0
[186.815110] Dynamic subtest lmem0: SUCCESS (6.875s)
[186.816016] Subtest verify-random-ccs: SUCCESS (6.876s)
[187.949552] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[187.951261] [035/130] (837s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[189.583878] Starting subtest: plane-primary-toggle-with-vblank-wait
[189.587437] Starting dynamic subtest: pipe-A-DP-3
[189.850908] Dynamic subtest pipe-A-DP-3: SUCCESS (0.263s)
[189.976773] Starting dynamic subtest: pipe-B-DP-3
[190.258376] Dynamic subtest pipe-B-DP-3: SUCCESS (0.296s)
[190.348729] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.765s)
[190.516306] [FACT kms_atomic_transition (plane-primary-toggle-with-vblank-wait)] new: kernel.kmod_is_loaded.i915: true
[190.519240] [036/130] (834s left) gem_exec_alignment (pi-isolated)
[190.603711] Starting subtest: pi-isolated
[207.405494] Subtest pi-isolated: SUCCESS (16.800s)
[207.835996] [037/130] (817s left) kms_pm_rpm (modeset-stress-extra-wait)
[210.330079] Starting subtest: modeset-stress-extra-wait
[262.810268] Subtest modeset-stress-extra-wait: SUCCESS (52.481s)
[262.904191] [038/130] (762s left) gem_exec_params (cliprects_ptr-dirt)
[262.982525] Starting subtest: cliprects_ptr-dirt
[262.983474] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[263.080993] [039/130] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[263.265776] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[263.267437] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[263.354541] [040/130] (762s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[263.532537] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[263.533495] Starting dynamic subtest: pipe-A-DP-3
[263.541730] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[263.553426] Starting dynamic subtest: pipe-B-DP-3
[263.561798] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[263.573166] Starting dynamic subtest: pipe-C-DP-3
[263.581307] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[263.592953] Starting dynamic subtest: pipe-D-DP-3
[263.603251] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[263.605280] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[263.919685] [041/130] (761s left) kms_busy (extended-modeset-hang-newfb)
[264.107701] Starting subtest: extended-modeset-hang-newfb
[264.109708] Starting dynamic subtest: pipe-A
[279.836261] Dynamic subtest pipe-A: SUCCESS (15.727s)
[279.850697] Starting dynamic subtest: pipe-D
[295.548349] Dynamic subtest pipe-D: SUCCESS (15.707s)
[295.550929] Subtest extended-modeset-hang-newfb: SUCCESS (31.441s)
[295.766777] [042/130] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[295.946220] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[295.947877] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[296.020269] [043/130] (729s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[296.099474] Starting subtest: multi-wait-available-unsubmitted-signaled
[296.100385] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[296.153043] [044/130] (729s left) gem_softpin (evict-prime)
[296.229884] Starting subtest: evict-prime
[296.230786] Starting dynamic subtest: rcs0
[297.481822] Dynamic subtest rcs0: SUCCESS (1.251s)
[297.497477] Starting dynamic subtest: bcs0
[298.648878] Dynamic subtest bcs0: SUCCESS (1.166s)
[298.662572] Starting dynamic subtest: vcs0
[299.824802] Dynamic subtest vcs0: SUCCESS (1.175s)
[299.839571] Starting dynamic subtest: vcs1
[301.044041] Dynamic subtest vcs1: SUCCESS (1.218s)
[301.056599] Starting dynamic subtest: vecs0
[302.296837] Dynamic subtest vecs0: SUCCESS (1.252s)
[302.316572] Starting dynamic subtest: vecs1
[303.492217] Dynamic subtest vecs1: SUCCESS (1.193s)
[303.504709] Starting dynamic subtest: ccs0
[304.705752] Dynamic subtest ccs0: SUCCESS (1.214s)
[304.724544] Starting dynamic subtest: all
[305.841663] Dynamic subtest all: SUCCESS (1.135s)
[305.842983] Subtest evict-prime: SUCCESS (9.612s)
[305.917169] [045/130] (719s left) gem_exec_schedule (preempt-queue)
[306.025204] Subtest preempt-queue: SKIP (0.000s)
[306.352030] [046/130] (719s left) gem_userptr_blits (coherency-unsync)
[306.431149] Subtest coherency-unsync: SKIP (0.000s)
[306.529824] [047/130] (719s left) kms_cursor_legacy (single-move)
[306.710433] Starting subtest: single-move
[306.711382] Starting dynamic subtest: pipe-A
[312.090755] Dynamic subtest pipe-A: SUCCESS (5.379s)
[312.103475] Starting dynamic subtest: pipe-B
[317.470533] Dynamic subtest pipe-B: SUCCESS (5.379s)
[317.483139] Starting dynamic subtest: pipe-C
[322.857540] Dynamic subtest pipe-C: SUCCESS (5.386s)
[322.869892] Starting dynamic subtest: pipe-D
[328.236865] Dynamic subtest pipe-D: SUCCESS (5.379s)
[328.249510] Starting dynamic subtest: all-pipes
[333.616956] Dynamic subtest all-pipes: SUCCESS (5.379s)
[333.617820] Subtest single-move: SUCCESS (26.906s)
[333.672243] [048/130] (692s left) kms_vblank (query-forked-busy)
[333.846846] Starting subtest: query-forked-busy
[333.848928] Starting dynamic subtest: pipe-A-DP-3
[336.403503] Dynamic subtest pipe-A-DP-3: SUCCESS (2.553s)
[336.462272] Starting dynamic subtest: pipe-D-DP-3
[338.947423] Dynamic subtest pipe-D-DP-3: SUCCESS (2.532s)
[338.948717] Subtest query-forked-busy: SUCCESS (5.101s)
[339.233265] [049/130] (686s left) gem_pwrite (basic-exhaustion)
[339.313454] Subtest basic-exhaustion: SKIP (0.000s)
[339.385500] [050/130] (686s left) gem_userptr_blits (sync-unmap)
[339.466572] Starting subtest: sync-unmap
[339.489598] Subtest sync-unmap: SUCCESS (0.023s)
[339.629878] [051/130] (686s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[339.817762] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[340.970959] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.153s)
[341.177091] [052/130] (685s left) perf_pmu (busy-double-start)
[341.238975] Starting subtest: busy-double-start
[341.239851] Starting dynamic subtest: rcs0
[344.876786] Dynamic subtest rcs0: SUCCESS (3.636s)
[344.893170] Starting dynamic subtest: bcs0
[348.486585] Dynamic subtest bcs0: SUCCESS (3.607s)
[348.502731] Starting dynamic subtest: vcs0
[352.057470] Dynamic subtest vcs0: SUCCESS (3.568s)
[352.073275] Starting dynamic subtest: vcs1
[355.653407] Dynamic subtest vcs1: SUCCESS (3.593s)
[355.669905] Starting dynamic subtest: vecs0
[359.258595] Dynamic subtest vecs0: SUCCESS (3.602s)
[359.274729] Starting dynamic subtest: vecs1
[362.856478] Dynamic subtest vecs1: SUCCESS (3.595s)
[362.872728] Starting dynamic subtest: ccs0
[366.459438] Dynamic subtest ccs0: SUCCESS (3.600s)
[366.461204] Subtest busy-double-start: SUCCESS (25.221s)
[366.552234] [053/130] (659s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[366.622730] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[366.730373] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[366.790489] [054/130] (659s left) gem_exec_fence (basic-wait)
[367.016481] Starting subtest: basic-wait
[367.017908] Starting dynamic subtest: rcs0
[367.143040] Dynamic subtest rcs0: SUCCESS (0.127s)
[367.191209] Starting dynamic subtest: bcs0
[367.202684] Dynamic subtest bcs0: SUCCESS (0.057s)
[367.220511] Starting dynamic subtest: vcs0
[367.257693] Dynamic subtest vcs0: SUCCESS (0.054s)
[367.274431] Starting dynamic subtest: vcs1
[367.314050] Dynamic subtest vcs1: SUCCESS (0.055s)
[367.350543] Starting dynamic subtest: vecs0
[367.376885] Dynamic subtest vecs0: SUCCESS (0.062s)
[367.397511] Starting dynamic subtest: vecs1
[367.439028] Dynamic subtest vecs1: SUCCESS (0.061s)
[367.470135] Starting dynamic subtest: ccs0
[367.492967] Dynamic subtest ccs0: SUCCESS (0.053s)
[367.494030] Subtest basic-wait: SUCCESS (0.480s)
[368.248227] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[368.257200] [055/130] (658s left) kms_addfb_basic (addfb25-modifier-no-flag)
[368.443905] Starting subtest: addfb25-modifier-no-flag
[368.444763] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[368.522680] [056/130] (657s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[368.708774] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[368.710837] Starting dynamic subtest: pipe-A-DP-3
[368.731766] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[368.744687] Starting dynamic subtest: pipe-B-DP-3
[368.765790] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[368.778965] Starting dynamic subtest: pipe-C-DP-3
[368.805096] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[368.817795] Starting dynamic subtest: pipe-D-DP-3
[368.842295] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[368.844357] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.013s)
[369.128232] [057/130] (657s left) kms_fb_coherency (memset-crc)
[369.314449] Starting subtest: memset-crc
[369.315369] Starting dynamic subtest: mmap-offset-fixed
[369.910033] Dynamic subtest mmap-offset-fixed: CRASH (0.281s)
[370.268137] Subtest memset-crc: CRASH (0.599s)
[370.346369] [058/130] (656s left) gem_lmem_swapping (massive)
[372.954634] Starting subtest: massive
[372.955537] Starting dynamic subtest: lmem0
[383.361264] Dynamic subtest lmem0: SUCCESS (10.406s)
[383.362241] Subtest massive: SUCCESS (10.407s)
[384.714188] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[384.715153] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[384.716864] [059/130] (641s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[386.378615] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[386.522062] [FACT kms_chamelium_hpd (hdmi-hpd-after-suspend)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[386.524392] [FACT kms_chamelium_hpd (hdmi-hpd-after-suspend)] new: kernel.kmod_is_loaded.i915: true
[386.527023] [060/130] (640s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[386.717282] Starting subtest: async-flip-with-page-flip-events-linear
[386.957888] Starting dynamic subtest: pipe-A-DP-3
[389.242360] Dynamic subtest pipe-A-DP-3: SUCCESS (2.283s)
[389.460983] Starting dynamic subtest: pipe-B-DP-3
[391.546629] Dynamic subtest pipe-B-DP-3: SUCCESS (2.096s)
[391.750960] Starting dynamic subtest: pipe-C-DP-3
[393.834352] Dynamic subtest pipe-C-DP-3: SUCCESS (2.095s)
[394.035311] Starting dynamic subtest: pipe-D-DP-3
[396.119549] Dynamic subtest pipe-D-DP-3: SUCCESS (2.098s)
[396.121521] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.403s)
[396.535439] [061/130] (630s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[396.632352] Starting subtest: stress-mm-invalidate-close-overlap
[398.781356] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[398.907847] [062/130] (627s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[399.102165] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[402.011233] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.910s)
[402.161295] [063/130] (624s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[402.350876] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[402.366462] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.015s)
[402.425468] [064/130] (624s left) kms_flip (plain-flip-fb-recreate-interruptible)
[402.619447] Starting subtest: plain-flip-fb-recreate-interruptible
[402.624072] Starting dynamic subtest: A-DP3
[410.756180] Dynamic subtest A-DP3: SUCCESS (8.131s)
[410.799548] Starting dynamic subtest: B-DP3
[418.825599] Dynamic subtest B-DP3: SUCCESS (8.064s)
[418.869985] Starting dynamic subtest: C-DP3
[426.897597] Dynamic subtest C-DP3: SUCCESS (8.067s)
[426.943437] Starting dynamic subtest: D-DP3
[434.968538] Dynamic subtest D-DP3: SUCCESS (8.066s)
[434.976959] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.356s)
[435.268638] [065/130] (591s left) gem_exec_fence (syncobj-repeat)
[435.795781] Starting subtest: syncobj-repeat
[436.122534] Subtest syncobj-repeat: SUCCESS (0.326s)
[436.538643] [066/130] (590s left) i915_query (query-topology-coherent-slice-mask)
[436.617570] Starting subtest: query-topology-coherent-slice-mask
[436.619469] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[436.739280] [067/130] (590s left) kms_cursor_crc (cursor-onscreen-512x512)
[437.199498] Starting subtest: cursor-onscreen-512x512
[437.201358] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[437.401088] [068/130] (589s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[437.589378] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[437.591128] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[437.661831] [069/130] (589s left) kms_plane_scaling (invalid-num-scalers)
[437.849492] Starting subtest: invalid-num-scalers
[437.855959] Starting dynamic subtest: pipe-A-DP-3-invalid-num-scalers
[437.878037] Dynamic subtest pipe-A-DP-3-invalid-num-scalers: SUCCESS (0.021s)
[437.895559] Starting dynamic subtest: pipe-B-DP-3-invalid-num-scalers
[437.921814] Dynamic subtest pipe-B-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[437.940167] Starting dynamic subtest: pipe-C-DP-3-invalid-num-scalers
[437.965863] Dynamic subtest pipe-C-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[437.984487] Starting dynamic subtest: pipe-D-DP-3-invalid-num-scalers
[438.011831] Dynamic subtest pipe-D-DP-3-invalid-num-scalers: SUCCESS (0.038s)
[438.012599] Subtest invalid-num-scalers: SUCCESS (0.163s)
[438.095157] [070/130] (589s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[438.173476] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[438.241990] [071/130] (589s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[440.267973] Starting subtest: gem-execbuf-stress-pc8
[440.417136] Subtest gem-execbuf-stress-pc8: SKIP (0.149s)
[440.621156] [072/130] (586s left) syncobj_timeline (wait-any-interrupted)
[440.700764] Starting subtest: wait-any-interrupted
[440.804785] Subtest wait-any-interrupted: SUCCESS (0.103s)
[440.927030] [073/130] (586s left) sw_sync (sync_merge_same)
[440.975774] Starting subtest: sync_merge_same
[440.976667] Subtest sync_merge_same: SUCCESS (0.000s)
[441.026511] [074/130] (586s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[441.219207] Starting subtest: psr-2p-pri-indfb-multidraw
[441.220875] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[441.294255] [075/130] (586s left) kms_hdr (bpc-switch-suspend)
[441.480659] Starting subtest: bpc-switch-suspend
[444.734820] Starting dynamic subtest: pipe-A-DP-3
[464.601632] Dynamic subtest pipe-A-DP-3: SUCCESS (5.075s)
[464.602600] Subtest bpc-switch-suspend: SUCCESS (8.331s)
[464.881995] [076/130] (562s left) api_intel_bb (blit-noreloc-keep-cache)
[464.970727] Starting subtest: blit-noreloc-keep-cache
[465.005202] Subtest blit-noreloc-keep-cache: SUCCESS (0.036s)
[465.093663] [077/130] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[465.290193] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[465.291864] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[465.362148] [078/130] (562s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[465.563105] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[465.565591] Starting dynamic subtest: pipe-A-valid-mode
[465.639728] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[465.641403] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.076s)
[465.811786] [079/130] (562s left) kms_chamelium_frames (hdmi-crc-fast)
[466.086467] Subtest hdmi-crc-fast: SKIP (0.000s)
[466.236429] [080/130] (561s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[466.421075] Starting subtest: primary-4-tiled-reflect-x-0
[476.696394] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.274s)
[476.995080] [081/130] (551s left) sw_sync (sync_merge)
[477.043315] Starting subtest: sync_merge
[477.044178] Subtest sync_merge: SUCCESS (0.000s)
[477.093292] [082/130] (551s left) gem_ctx_persistence (engines-mixed-process)
[477.182704] Starting subtest: engines-mixed-process
[477.183622] Starting dynamic subtest: rcs0
[478.932324] Dynamic subtest rcs0: SUCCESS (1.749s)
[478.948365] Starting dynamic subtest: bcs0
[480.941686] Dynamic subtest bcs0: SUCCESS (2.007s)
[480.960753] Starting dynamic subtest: vcs0
[482.889902] Dynamic subtest vcs0: SUCCESS (1.946s)
[482.905833] Starting dynamic subtest: vcs1
[484.942885] Dynamic subtest vcs1: SUCCESS (2.052s)
[484.958881] Starting dynamic subtest: vecs0
[486.929900] Dynamic subtest vecs0: SUCCESS (1.986s)
[486.945338] Starting dynamic subtest: vecs1
[488.915180] Dynamic subtest vecs1: SUCCESS (1.984s)
[488.933088] Starting dynamic subtest: ccs0
[490.894170] Dynamic subtest ccs0: SUCCESS (1.977s)
[490.895251] Subtest engines-mixed-process: SUCCESS (13.712s)
[490.956493] [083/130] (537s left) gem_exec_parallel (userptr)
[491.043623] Starting subtest: userptr
[491.044525] Starting dynamic subtest: rcs0
[492.598742] Dynamic subtest rcs0: SUCCESS (1.556s)
[492.617256] Starting dynamic subtest: bcs0
[494.082561] Dynamic subtest bcs0: SUCCESS (1.482s)
[494.099413] Starting dynamic subtest: vcs0
[495.659783] Dynamic subtest vcs0: SUCCESS (1.576s)
[495.678216] Starting dynamic subtest: vcs1
[497.191891] Dynamic subtest vcs1: SUCCESS (1.531s)
[497.219140] Starting dynamic subtest: vecs0
[498.655675] Dynamic subtest vecs0: SUCCESS (1.462s)
[498.674018] Starting dynamic subtest: vecs1
[500.149598] Dynamic subtest vecs1: SUCCESS (1.493s)
[500.166994] Starting dynamic subtest: ccs0
[501.620597] Dynamic subtest ccs0: SUCCESS (1.470s)
[501.621822] Subtest userptr: SUCCESS (10.579s)
[501.886887] [084/130] (526s left) kms_flip (absolute-wf_vblank-interruptible)
[502.079278] Starting subtest: absolute-wf_vblank-interruptible
[502.084092] Starting dynamic subtest: A-DP3
[510.062693] Dynamic subtest A-DP3: SUCCESS (7.979s)
[510.081025] Starting dynamic subtest: B-DP3
[517.972115] Dynamic subtest B-DP3: SUCCESS (7.905s)
[517.988697] Starting dynamic subtest: C-DP3
[525.887571] Dynamic subtest C-DP3: SUCCESS (7.914s)
[525.903846] Starting dynamic subtest: D-DP3
[533.634702] Dynamic subtest D-DP3: SUCCESS (7.746s)
[533.637099] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.559s)
[533.911499] [085/130] (494s left) kms_force_connector_basic (prune-stale-modes)
[534.018143] Starting subtest: prune-stale-modes
[534.041628] Subtest prune-stale-modes: SUCCESS (0.023s)
[534.298885] [086/130] (494s left) gem_ctx_persistence (processes)
[534.384867] Starting subtest: processes
[535.955417] Subtest processes: SUCCESS (1.571s)
[536.016207] [087/130] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[536.209412] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[536.211103] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[536.302455] [088/130] (492s left) gem_exec_flush (basic-uc-ro-default)
[536.392594] Subtest basic-uc-ro-default: SKIP (0.000s)
[536.486168] [089/130] (492s left) kms_psr (pr-dpms)
[536.671766] Subtest pr-dpms: SKIP (0.000s)
[536.730503] [090/130] (491s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[536.920439] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[536.922174] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[536.998388] [091/130] (491s left) kms_lease (lease-invalid-crtc)
[537.189518] Starting subtest: lease-invalid-crtc
[537.190422] Starting dynamic subtest: pipe-A-DP-3
[537.191309] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[537.205428] Starting dynamic subtest: pipe-B-DP-3
[537.206328] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[537.220146] Starting dynamic subtest: pipe-C-DP-3
[537.221426] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[537.235134] Starting dynamic subtest: pipe-D-DP-3
[537.236396] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[537.237605] Subtest lease-invalid-crtc: SUCCESS (0.007s)
[537.287207] [092/130] (491s left) i915_query (query-topology-unsupported)
[537.368785] Starting subtest: query-topology-unsupported
[537.370782] Subtest query-topology-unsupported: SKIP (0.000s)
[537.464689] [093/130] (491s left) prime_self_import (export-vs-gem_close-race)
[537.512626] Starting subtest: export-vs-gem_close-race
[542.597595] Subtest export-vs-gem_close-race: SUCCESS (5.085s)
[542.670911] [094/130] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[542.878314] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[547.046304] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: FAIL (3.821s)
[547.126422] [095/130] (481s left) gem_exec_reloc (basic-cpu-active)
[547.210630] Subtest basic-cpu-active: SKIP (0.000s)
[547.302201] [096/130] (481s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[547.489442] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[547.491099] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[547.565562] [097/130] (481s left) syncobj_timeline (invalid-transfer-non-existent-point)
[547.645553] Starting subtest: invalid-transfer-non-existent-point
[547.646477] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[547.742220] [098/130] (481s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[547.936135] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[547.937893] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[548.016417] [099/130] (481s left) kms_vblank (query-idle-hang)
[548.201059] Starting subtest: query-idle-hang
[548.203484] Starting dynamic subtest: pipe-A-DP-3
[574.608322] Dynamic subtest pipe-A-DP-3: SUCCESS (26.404s)
[574.625715] Starting dynamic subtest: pipe-D-DP-3
[599.569839] Dynamic subtest pipe-D-DP-3: SUCCESS (24.957s)
[599.570708] Subtest query-idle-hang: SUCCESS (51.368s)
[599.763017] [100/130] (429s left) i915_drm_fdinfo (busy-idle)
[599.833456] Starting subtest: busy-idle
[599.834507] Starting dynamic subtest: rcs0
[599.857351] Dynamic subtest rcs0: SKIP (0.023s)
[599.872393] Starting dynamic subtest: bcs0
[599.874171] Dynamic subtest bcs0: SKIP (0.000s)
[599.888660] Starting dynamic subtest: vcs0
[599.890914] Dynamic subtest vcs0: SKIP (0.000s)
[599.905160] Starting dynamic subtest: vcs1
[599.907626] Dynamic subtest vcs1: SKIP (0.000s)
[599.921108] Starting dynamic subtest: vecs0
[599.923353] Dynamic subtest vecs0: SKIP (0.000s)
[599.936826] Starting dynamic subtest: vecs1
[599.939146] Dynamic subtest vecs1: SKIP (0.000s)
[599.952725] Starting dynamic subtest: ccs0
[599.954958] Dynamic subtest ccs0: SKIP (0.000s)
[599.957307] Subtest busy-idle: SKIP (0.033s)
[600.005581] [101/130] (429s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[600.194320] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[604.707927] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.514s)
[604.859910] [102/130] (424s left) kms_psr (psr-primary-mmap-cpu)
[605.050551] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[605.105423] [103/130] (424s left) kms_pm_rpm (dpms-non-lpsp)
[607.121806] Starting subtest: dpms-non-lpsp
[607.313334] Subtest dpms-non-lpsp: SUCCESS (0.192s)
[607.478832] [104/130] (421s left) device_reset (unbind-reset-rebind)
[607.561882] Starting subtest: unbind-reset-rebind
[610.000979] Subtest unbind-reset-rebind: SUCCESS (2.438s)
[610.056900] [105/130] (419s left) kms_pipe_crc_basic (read-crc)
[610.241936] Starting subtest: read-crc
[610.244428] Starting dynamic subtest: pipe-A-DP-3
[610.963674] Dynamic subtest pipe-A-DP-3: SUCCESS (0.720s)
[610.986409] Starting dynamic subtest: pipe-B-DP-3
[611.541522] Dynamic subtest pipe-B-DP-3: SUCCESS (0.575s)
[611.565707] Starting dynamic subtest: pipe-C-DP-3
[612.071083] Dynamic subtest pipe-C-DP-3: SUCCESS (0.525s)
[612.088786] Starting dynamic subtest: pipe-D-DP-3
[612.632466] Dynamic subtest pipe-D-DP-3: SUCCESS (0.559s)
[612.633380] Subtest read-crc: SUCCESS (2.390s)
[612.868862] [106/130] (416s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[613.062132] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[613.063822] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[613.138957] [107/130] (416s left) kms_async_flips (test-time-stamp)
[613.331911] Starting subtest: test-time-stamp
[613.560649] Starting dynamic subtest: pipe-A-DP-3
[613.879346] Dynamic subtest pipe-A-DP-3: SUCCESS (0.316s)
[614.129096] Starting dynamic subtest: pipe-B-DP-3
[614.266554] Dynamic subtest pipe-B-DP-3: SUCCESS (0.151s)
[614.499221] Starting dynamic subtest: pipe-C-DP-3
[614.632069] Dynamic subtest pipe-C-DP-3: SUCCESS (0.144s)
[614.878145] Starting dynamic subtest: pipe-D-DP-3
[615.016281] Dynamic subtest pipe-D-DP-3: SUCCESS (0.151s)
[615.017726] Subtest test-time-stamp: SUCCESS (1.684s)
[615.468919] [108/130] (414s left) api_intel_bb (reset-bb)
[615.552964] Starting subtest: reset-bb
[615.581215] Subtest reset-bb: SUCCESS (0.028s)
[615.685572] [109/130] (414s left) gem_exec_whisper (basic-normal-all)
[615.773827] Starting subtest: basic-normal-all
[617.978587] Subtest basic-normal-all: SUCCESS (2.203s)
[618.221599] [110/130] (411s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[618.413967] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[618.475415] [111/130] (411s left) fbdev (eof)
[618.527805] Starting subtest: eof
[618.528691] Subtest eof: SUCCESS (0.000s)
[618.586586] [112/130] (411s left) kms_psr (pr-cursor-blt)
[618.776033] Subtest pr-cursor-blt: SKIP (0.000s)
[618.842438] [113/130] (411s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[618.928421] Starting subtest: y-tiled-to-vebox-yf-tiled
[618.930586] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[619.106461] [114/130] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[619.297708] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[619.299434] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[619.377093] [115/130] (410s left) kms_plane (pixel-format-source-clamping)
[619.570494] Starting subtest: pixel-format-source-clamping
[619.592993] Starting dynamic subtest: pipe-A-plane-0
[627.109917] Dynamic subtest pipe-A-plane-0: SUCCESS (7.517s)
[627.152353] Starting dynamic subtest: pipe-A-plane-3
[630.993125] Dynamic subtest pipe-A-plane-3: SUCCESS (3.881s)
[631.009294] Starting dynamic subtest: pipe-A-plane-5
[631.010199] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[631.249506] Starting dynamic subtest: pipe-B-plane-0
[638.104567] Dynamic subtest pipe-B-plane-0: SUCCESS (6.883s)
[638.122395] Starting dynamic subtest: pipe-B-plane-3
[641.921179] Dynamic subtest pipe-B-plane-3: SUCCESS (3.816s)
[641.938184] Starting dynamic subtest: pipe-B-plane-5
[641.939117] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[641.997433] Subtest pixel-format-source-clamping: SUCCESS (22.427s)
[642.270182] [116/130] (387s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[642.465269] Starting subtest: 4-tiled-addfb-size-offset-overflow
[642.466065] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[642.572177] [117/130] (387s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[642.759611] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[642.760486] Starting dynamic subtest: pipe-A-valid-mode
[645.083457] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.321s)
[645.084801] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (2.324s)
[645.303588] [118/130] (384s left) gem_mmap_offset (oob-read)
[645.382681] Starting subtest: oob-read
[645.383638] Subtest oob-read: SUCCESS (0.000s)
[645.479623] [119/130] (384s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[645.671483] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[645.673170] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[645.746218] [120/130] (384s left) kms_chamelium_color (ctm-blue-to-red)
[645.932451] Subtest ctm-blue-to-red: SKIP (0.000s)
[645.995330] [121/130] (384s left) gem_eio (wait-immediate)
[646.281936] Starting subtest: wait-immediate
[646.934612] Subtest wait-immediate: SUCCESS (0.653s)
[647.113567] [122/130] (383s left) gem_exec_suspend (basic-s3-devices)
[647.201732] Starting subtest: basic-S3-devices
[647.202631] Starting dynamic subtest: smem
[657.335360] Dynamic subtest smem: SUCCESS (10.133s)
[657.351731] Starting dynamic subtest: lmem0
[667.216555] Dynamic subtest lmem0: SUCCESS (9.879s)
[667.217630] Subtest basic-S3-devices: SUCCESS (20.014s)
[667.473337] [123/130] (363s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[667.557118] Starting subtest: invalid-multi-wait-unsubmitted
[667.558036] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[667.658633] [124/130] (362s left) gem_exec_balancer (full-late-pulse)
[667.747871] Starting subtest: full-late-pulse
[669.779405] Subtest full-late-pulse: SUCCESS (2.031s)
[670.145683] [125/130] (360s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[670.343361] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[670.345120] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[670.429694] [126/130] (360s left) syncobj_wait (single-wait-for-submit-submitted)
[670.510640] Starting subtest: single-wait-for-submit-submitted
[670.618932] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[670.739672] [127/130] (360s left) gem_exec_schedule (semaphore-resolve)
[670.828708] Starting subtest: semaphore-resolve
[670.912733] Subtest semaphore-resolve: SUCCESS (0.084s)
[671.266723] [128/130] (359s left) syncobj_basic (bad-pad-handle-to-fd)
[671.347862] Starting subtest: bad-pad-handle-to-fd
[671.348747] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[671.430240] [129/130] (359s left) gen7_exec_parse (chained-batch)
[671.521513] Subtest chained-batch: SKIP (0.000s)
[671.644184] [130/130] (359s left) kms_cursor_crc (cursor-onscreen-256x256)
[672.050580] Starting subtest: cursor-onscreen-256x256
[672.056348] Starting dynamic subtest: pipe-A-DP-3
[674.860130] Dynamic subtest pipe-A-DP-3: SUCCESS (2.803s)
[674.915256] Starting dynamic subtest: pipe-D-DP-3
[677.592580] Dynamic subtest pipe-D-DP-3: SUCCESS (2.690s)
[677.593530] Subtest cursor-onscreen-256x256: SUCCESS (5.541s)
[677.914518] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: i915_getparams_basic
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: gem_exec_nop
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_workarounds
results: parsing output: 14/ for test: gem_basic
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gen7_exec_parse
results: parsing output: 17/ for test: prime_busy
results: parsing output: 18/ for test: i915_query
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_psr2_su
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_ppgtt
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: gem_exec_alignment
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: gem_pwrite
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_fb_coherency
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_pipe_b_c_ivb
results: parsing output: 70/ for test: i915_pm_rpm
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_hdr
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_chamelium_frames
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_exec_parallel
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_force_connector_basic
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: prime_self_import
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: device_reset
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_chamelium_color
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_exec_suspend
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: syncobj_basic
results: parsing output: 128/ for test: gen7_exec_parse
results: parsing output: 129/ for test: kms_cursor_crc
Done.