[52.006908] Initializing watchdogs [52.007272] /dev/watchdog0 [52.041922] [001/136] (960s left) gem_exec_schedule (u-submit-golden-slice) [52.541709] Starting subtest: u-submit-golden-slice [52.564168] Starting dynamic subtest: rcs0 [52.585789] Dynamic subtest rcs0: SUCCESS (0.086s) [52.620621] Starting dynamic subtest: bcs0 [52.641437] Dynamic subtest bcs0: SUCCESS (0.066s) [52.674273] Starting dynamic subtest: vcs0 [52.693227] Dynamic subtest vcs0: SUCCESS (0.060s) [52.722923] Starting dynamic subtest: vecs0 [52.741445] Dynamic subtest vecs0: SUCCESS (0.061s) [52.763573] Subtest u-submit-golden-slice: SUCCESS (0.275s) [53.074475] [002/136] (959s left) kms_rotation_crc (cursor-rotation-180) [53.467260] Starting subtest: cursor-rotation-180 [54.311295] Subtest cursor-rotation-180: SUCCESS (0.856s) [54.792621] [003/136] (957s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs) [55.348747] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s) [55.680410] [004/136] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [56.161723] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [56.199363] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [56.301581] [005/136] (956s left) api_intel_bb (add-remove-objects) [56.585122] Starting subtest: add-remove-objects [56.604091] Subtest add-remove-objects: SUCCESS (0.021s) [56.748680] [006/136] (956s left) kms_vblank (pipe-d-query-idle) [57.139792] Subtest pipe-D-query-idle: SKIP (0.000s) [57.287484] [007/136] (955s left) gem_exec_fence (syncobj-timeline-unused-fence) [58.279929] Starting subtest: syncobj-timeline-unused-fence [58.298517] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s) [58.553709] [008/136] (954s left) i915_pm_dc (dc5-dpms) [59.948217] Starting subtest: dc5-dpms [61.660884] Subtest dc5-dpms: SUCCESS (1.730s) [61.897517] [009/136] (951s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [62.352394] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [62.391212] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [62.493260] [010/136] (950s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [62.939791] Starting subtest: fbc-modesetfrombusy [64.103170] Subtest fbc-modesetfrombusy: SUCCESS (1.233s) [64.256503] [011/136] (949s left) syncobj_timeline (multi-wait-all-available-submitted) [64.543913] Starting subtest: multi-wait-all-available-submitted [64.565782] Subtest multi-wait-all-available-submitted: SUCCESS (0.002s) [64.665311] [012/136] (948s left) v3d/v3d_submit_csd (multisync-out-syncs) [65.022153] Subtest multisync-out-syncs: SKIP (0.000s) [65.130200] [013/136] (948s left) gem_userptr_blits (relocations) [65.494863] Starting subtest: relocations [65.532166] Subtest relocations: SKIP (0.003s) [65.637586] [014/136] (948s left) i915_pm_rpm (pc8-residency) [67.717278] Starting subtest: pc8-residency [67.770521] Subtest pc8-residency: SKIP (0.000s) [68.251430] [015/136] (945s left) gem_bad_reloc (negative-reloc) [68.583407] Starting subtest: negative-reloc [68.656845] Subtest negative-reloc: SUCCESS (0.002s) [68.778358] [016/136] (945s left) gem_ctx_persistence (many-contexts) [69.081635] Starting subtest: many-contexts [101.960552] Subtest many-contexts: SUCCESS (32.898s) [102.070211] [017/136] (911s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc) [102.573859] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc [102.615236] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s) [102.983503] [018/136] (911s left) kms_flip (basic-flip-vs-dpms) [103.357284] Starting subtest: basic-flip-vs-dpms [103.377655] Starting dynamic subtest: A-DP1 [104.537204] Dynamic subtest A-DP1: SUCCESS (1.185s) [104.572529] Starting dynamic subtest: B-DP1 [105.617467] Dynamic subtest B-DP1: SUCCESS (1.074s) [105.650138] Starting dynamic subtest: C-DP1 [106.690525] Dynamic subtest C-DP1: SUCCESS (1.075s) [106.711305] Subtest basic-flip-vs-dpms: SUCCESS (3.342s) [107.080969] [019/136] (907s left) vc4/vc4_perfmon (create-perfmon-0) [107.463744] Subtest create-perfmon-0: SKIP (0.000s) [107.563395] [020/136] (906s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [108.002386] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [108.039958] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [108.148118] [021/136] (906s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs) [108.707119] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s) [109.005755] [022/136] (905s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [109.457412] Starting subtest: psr-rgb101010-draw-blt [109.495669] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [109.598269] [023/136] (905s left) gem_exec_reloc (basic-wc) [109.904908] Starting subtest: basic-wc [109.925714] Subtest basic-wc: SUCCESS (0.022s) [110.138597] [024/136] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [110.584701] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [110.622447] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [110.734468] [025/136] (904s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [111.104143] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [111.141974] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [111.253177] [026/136] (903s left) kms_big_fb (4-tiled-64bpp-rotate-270) [111.678473] Starting subtest: 4-tiled-64bpp-rotate-270 [111.717682] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s) [111.825779] [027/136] (903s left) gem_ppgtt (shrink-vs-evict-pinned) [112.112782] Starting subtest: shrink-vs-evict-pinned [117.361969] Subtest shrink-vs-evict-pinned: SUCCESS (5.090s) [117.467667] [028/136] (897s left) gem_lmem_swapping (parallel-random-verify) [117.769130] Subtest parallel-random-verify: SKIP (0.000s) [117.877448] [029/136] (897s left) sw_sync (sync_multi_timeline_wait) [118.158373] Starting subtest: sync_multi_timeline_wait [118.177678] Subtest sync_multi_timeline_wait: SUCCESS (0.001s) [118.299528] [030/136] (897s left) prime_mmap_kms (buffer-sharing) [118.680964] Starting subtest: buffer-sharing [118.989272] Subtest buffer-sharing: SUCCESS (0.286s) [119.348726] [031/136] (896s left) prime_mmap (test_reprime) [119.660141] Starting subtest: test_reprime [119.680885] Starting dynamic subtest: test_reprime-smem [119.702384] Dynamic subtest test_reprime-smem: SUCCESS (0.009s) [119.721307] Subtest test_reprime: SUCCESS (0.009s) [119.823585] [032/136] (895s left) gem_ctx_persistence (engines-hostile-preempt) [120.102799] Starting subtest: engines-hostile-preempt [120.122139] Starting dynamic subtest: rcs0 [120.216047] Dynamic subtest rcs0: SUCCESS (0.093s) [120.250648] Starting dynamic subtest: bcs0 [120.290325] Dynamic subtest bcs0: SUCCESS (0.089s) [120.323132] Starting dynamic subtest: vcs0 [120.386365] Dynamic subtest vcs0: SUCCESS (0.090s) [120.420715] Starting dynamic subtest: vecs0 [120.470099] Dynamic subtest vecs0: SUCCESS (0.096s) [120.489125] Subtest engines-hostile-preempt: SUCCESS (0.368s) [120.603334] [033/136] (895s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [121.027226] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [121.064575] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [121.178062] [034/136] (894s left) kms_big_fb (x-tiled-addfb-size-overflow) [121.604558] Starting subtest: x-tiled-addfb-size-overflow [121.626343] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.002s) [121.735417] [035/136] (894s left) kms_flip (2x-flip-vs-modeset-vs-hang) [122.106433] Starting subtest: 2x-flip-vs-modeset-vs-hang [122.143981] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.004s) [122.257201] [036/136] (893s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [122.748515] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [123.071339] [037/136] (893s left) gem_userptr_blits (set-cache-level) [123.410390] Starting subtest: set-cache-level [123.429101] Subtest set-cache-level: SUCCESS (0.001s) [123.557642] [038/136] (892s left) gem_eio (wait-wedge-1us) [123.885102] Starting subtest: wait-wedge-1us [123.969562] Subtest wait-wedge-1us: SUCCESS (0.109s) [124.189604] [039/136] (892s left) v3d/v3d_submit_cl (bad-multisync-in-sync) [124.558460] Subtest bad-multisync-in-sync: SKIP (0.000s) [124.668594] [040/136] (891s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [124.975520] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [125.016423] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [125.196126] [041/136] (891s left) gem_exec_whisper (basic-forked-all) [125.522961] Starting subtest: basic-forked-all [147.949082] Subtest basic-forked-all: SUCCESS (22.413s) [148.143326] [042/136] (868s left) kms_atomic (atomic-invalid-params) [148.656220] Starting subtest: atomic-invalid-params [148.744678] Subtest atomic-invalid-params: SUCCESS (0.090s) [149.221695] [043/136] (867s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render) [149.672394] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render [149.709756] Subtest psr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s) [149.821112] [044/136] (866s left) kms_force_connector_basic (force-edid) [150.122751] Subtest force-edid: SKIP (0.000s) [150.228153] [045/136] (866s left) kms_cursor_legacy (flip-vs-cursor-toggle) [150.593742] Starting subtest: flip-vs-cursor-toggle [172.392685] Subtest flip-vs-cursor-toggle: SUCCESS (21.779s) [172.765465] [046/136] (844s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [173.160870] Starting subtest: short-flip-after-cursor-atomic-transitions [174.290851] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.129s) [174.677299] [047/136] (842s left) syncobj_wait (reset-signaled) [174.949853] Starting subtest: reset-signaled [174.969222] Subtest reset-signaled: SUCCESS (0.001s) [175.079906] [048/136] (842s left) kms_ccs (pipe-c-bad-aux-stride-yf_tiled_ccs) [175.627130] Starting subtest: pipe-C-bad-aux-stride-yf_tiled_ccs [175.667065] Subtest pipe-C-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s) [175.951180] [049/136] (841s left) gem_shrink (reclaim) [176.256281] Starting subtest: reclaim [178.688110] Subtest reclaim: SUCCESS (2.268s) [178.774859] [050/136] (838s left) core_auth (getclient-master-drop) [179.061867] Starting subtest: getclient-master-drop [179.083227] Subtest getclient-master-drop: SUCCESS (0.005s) [179.167559] [051/136] (838s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [179.620198] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [181.948067] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.403s) [182.133213] [052/136] (835s left) kms_cursor_crc (cursor-offscreen-128x42) [182.530667] Starting subtest: cursor-offscreen-128x42 [182.552045] Starting dynamic subtest: pipe-A-DP-1 [185.030886] Dynamic subtest pipe-A-DP-1: SUCCESS (2.502s) [185.118931] Starting dynamic subtest: pipe-B-DP-1 [187.669990] Dynamic subtest pipe-B-DP-1: SUCCESS (2.550s) [187.788147] Starting dynamic subtest: pipe-C-DP-1 [190.332151] Dynamic subtest pipe-C-DP-1: SUCCESS (2.589s) [190.353921] Subtest cursor-offscreen-128x42: SUCCESS (7.796s) [190.724768] [053/136] (826s left) syncobj_timeline (wait-any-complex) [191.008996] Starting subtest: wait-any-complex [191.061891] Subtest wait-any-complex: SUCCESS (0.065s) [191.192566] [054/136] (826s left) gem_mmap (basic-small-bo) [191.472787] Starting subtest: basic-small-bo [193.961362] Subtest basic-small-bo: SUCCESS (2.499s) [194.108484] [055/136] (823s left) kms_invalid_mode (bad-vtotal) [194.683885] Starting subtest: bad-vtotal [194.703460] Starting dynamic subtest: DP-1-pipe-A [194.751853] Dynamic subtest DP-1-pipe-A: SUCCESS (0.093s) [194.788830] Starting dynamic subtest: DP-1-pipe-B [194.811209] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s) [194.854956] Starting dynamic subtest: DP-1-pipe-C [194.875902] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s) [194.896981] Subtest bad-vtotal: SUCCESS (0.099s) [195.140624] [056/136] (822s left) gem_gtt_cpu_tlb [195.562847] [057/136] (822s left) gem_partial_pwrite_pread (reads-uncached) [195.881114] Starting subtest: reads-uncached [203.100251] Subtest reads-uncached: SUCCESS (7.219s) [203.223205] [058/136] (814s left) i915_hangman (detector) [203.538599] Starting subtest: detector [203.559957] Starting dynamic subtest: rcs0 [212.927721] Dynamic subtest rcs0: SUCCESS (9.385s) [212.968103] Starting dynamic subtest: bcs0 [222.975582] Dynamic subtest bcs0: SUCCESS (9.926s) [223.014029] Starting dynamic subtest: vcs0 [232.958264] Dynamic subtest vcs0: SUCCESS (10.092s) [232.994329] Starting dynamic subtest: vecs0 [242.946921] Dynamic subtest vecs0: SUCCESS (9.975s) [242.966063] Subtest detector: SUCCESS (39.382s) [243.079878] [059/136] (775s left) kms_chamelium_color (ctm-0-25) [243.473346] Subtest ctm-0-25: SKIP (0.000s) [243.584080] [060/136] (774s left) kms_psr (psr2_cursor_render) [243.888433] Subtest psr2_cursor_render: SKIP (0.000s) [244.003831] [061/136] (774s left) kms_psr (cursor_render) [244.295981] Subtest cursor_render: SKIP (0.000s) [244.389239] [062/136] (774s left) sw_sync (sync_multi_consumer_producer) [244.690468] Starting subtest: sync_multi_consumer_producer [245.764555] Subtest sync_multi_consumer_producer: SUCCESS (1.072s) [245.854508] [063/136] (772s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [246.231819] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [246.250903] Starting dynamic subtest: pipe-A-valid-mode [246.643886] Dynamic subtest pipe-A-valid-mode: SKIP (0.385s) [246.687900] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.386s) [247.021300] [064/136] (771s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [247.465087] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [247.504551] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [247.617147] [065/136] (771s left) kms_flip (2x-flip-vs-panning) [247.996326] Starting subtest: 2x-flip-vs-panning [248.038504] Subtest 2x-flip-vs-panning: SKIP (0.004s) [248.147791] [066/136] (770s left) gem_create (create-massive) [248.442732] Starting subtest: create-massive [248.461923] Subtest create-massive: SUCCESS (0.000s) [248.689975] [067/136] (770s left) gem_userptr_blits (vma-merge) [249.062972] Starting subtest: vma-merge [270.050781] Subtest vma-merge: FAIL (20.714s) [270.142738] [068/136] (749s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render) [270.570913] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render [270.608338] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s) [270.728208] [069/136] (748s left) gem_exec_balancer (bonded-chain) [271.042528] Starting subtest: bonded-chain [275.860557] Subtest bonded-chain: SUCCESS (4.655s) [280.886240] [070/136] (738s left) kms_vblank (pipe-c-ts-continuation-suspend) [281.264806] Starting subtest: pipe-C-ts-continuation-suspend [299.824829] Subtest pipe-C-ts-continuation-suspend: SUCCESS (2.166s) [306.155235] [071/136] (735s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [306.451848] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [306.473394] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.002s) [306.566699] [072/136] (735s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc) [307.086745] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc [307.147201] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [307.459551] [073/136] (734s left) kms_cursor_legacy (forked-move) [307.873591] Starting subtest: forked-move [307.892801] Starting dynamic subtest: pipe-A [329.431853] Dynamic subtest pipe-A: SUCCESS (21.557s) [329.488464] Starting dynamic subtest: pipe-B [351.170779] Dynamic subtest pipe-B: SUCCESS (21.559s) [351.237288] Starting dynamic subtest: pipe-C [372.731562] Dynamic subtest pipe-C: SUCCESS (21.566s) [372.827666] Starting dynamic subtest: all-pipes [394.293302] Dynamic subtest all-pipes: SUCCESS (21.564s) [394.312322] Subtest forked-move: SUCCESS (86.249s) [394.408990] [074/136] (647s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [394.830656] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [394.868494] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [394.991368] [075/136] (647s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs_cc) [395.452799] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc [395.517233] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [395.862920] [076/136] (646s left) sysfs_timeslice_duration (duration) [396.151458] Starting subtest: duration [396.171038] Starting dynamic subtest: vecs0 [396.295273] Dynamic subtest vecs0: SUCCESS (0.098s) [396.338547] Starting dynamic subtest: vcs0 [396.462328] Dynamic subtest vcs0: SUCCESS (0.088s) [396.509678] Starting dynamic subtest: bcs0 [396.633098] Dynamic subtest bcs0: SUCCESS (0.100s) [396.672966] Starting dynamic subtest: rcs0 [396.793030] Dynamic subtest rcs0: SUCCESS (0.107s) [396.813898] Subtest duration: SUCCESS (0.398s) [396.924159] [077/136] (645s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt) [397.379365] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt [399.271334] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (1.983s) [399.458013] [078/136] (643s left) perf (invalid-open-flags) [399.873913] Starting subtest: invalid-open-flags [399.899366] Subtest invalid-open-flags: SUCCESS (0.001s) [400.016290] [079/136] (642s left) dmabuf_sync_file (import-multiple-read-only) [400.318054] Starting subtest: import-multiple-read-only [400.340452] Subtest import-multiple-read-only: SUCCESS (0.016s) [400.437572] [080/136] (642s left) prime_vgem (basic-fence-mmap) [400.742800] Starting subtest: basic-fence-mmap [400.807870] Subtest basic-fence-mmap: SUCCESS (0.071s) [400.959509] [081/136] (641s left) gem_exec_basic (basic) [401.267394] Starting subtest: basic [401.286626] Starting dynamic subtest: rcs0-smem [401.308397] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [401.351529] Starting dynamic subtest: bcs0-smem [401.372944] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [401.416325] Starting dynamic subtest: vcs0-smem [401.436129] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [401.476904] Starting dynamic subtest: vecs0-smem [401.496165] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [401.515397] Subtest basic: SUCCESS (0.011s) [401.614499] [082/136] (641s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs) [401.978262] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs [402.016622] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s) [402.499390] [083/136] (640s left) syncobj_wait (invalid-reset-illegal-handle) [402.788196] Starting subtest: invalid-reset-illegal-handle [402.807276] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [402.922486] [084/136] (640s left) gem_mmap_gtt (pf-nonblock) [403.203670] Starting subtest: pf-nonblock [403.222564] Subtest pf-nonblock: SUCCESS (0.006s) [403.371341] [085/136] (639s left) gem_exec_schedule (fairslice) [403.816886] Starting subtest: fairslice [403.837868] Starting dynamic subtest: rcs0 [405.725106] Dynamic subtest rcs0: SUCCESS (2.033s) [405.765540] Starting dynamic subtest: bcs0 [407.763309] Dynamic subtest bcs0: SUCCESS (2.033s) [407.805757] Starting dynamic subtest: vcs0 [409.785943] Dynamic subtest vcs0: SUCCESS (2.027s) [409.825916] Starting dynamic subtest: vecs0 [411.825551] Dynamic subtest vecs0: SUCCESS (2.028s) [411.846767] Subtest fairslice: SUCCESS (8.125s) [412.149383] [086/136] (631s left) kms_rotation_crc (sprite-rotation-90) [412.521172] Starting subtest: sprite-rotation-90 [418.870580] Subtest sprite-rotation-90: SUCCESS (6.351s) [419.319331] [087/136] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [419.782648] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [419.837099] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [419.988708] [088/136] (623s left) kms_cursor_crc (cursor-rapid-movement-512x512) [420.393088] Starting subtest: cursor-rapid-movement-512x512 [420.433983] Subtest cursor-rapid-movement-512x512: SKIP (0.000s) [420.550245] [089/136] (623s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs) [421.065757] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs [421.107552] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.002s) [421.451004] [090/136] (622s left) kms_selftest (all-tests) [421.729728] Starting subtest: all-tests [421.772893] Subtest all-tests: SKIP (0.000s) [421.905285] [091/136] (621s left) gem_exec_reloc (basic-cpu) [422.198362] Starting subtest: basic-cpu [422.217991] Subtest basic-cpu: SUCCESS (0.023s) [422.431797] [092/136] (621s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [422.876492] Starting subtest: yf-tiled-64bpp-rotate-180 [422.919406] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [423.031131] [093/136] (621s left) kms_plane (plane-panning-bottom-right) [423.405414] Starting subtest: plane-panning-bottom-right [423.427037] Starting dynamic subtest: pipe-A-planes [424.217276] Dynamic subtest pipe-A-planes: SUCCESS (0.790s) [424.260675] Starting dynamic subtest: pipe-B-planes [425.188203] Dynamic subtest pipe-B-planes: SUCCESS (0.973s) [425.209273] Subtest plane-panning-bottom-right: SUCCESS (1.764s) [425.576132] [094/136] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [426.001799] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [426.043871] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [426.159314] [095/136] (618s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [426.647873] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [426.970612] [096/136] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [427.397081] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [427.434495] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [427.557989] [097/136] (616s left) gem_tiled_partial_pwrite_pread (writes) [427.862836] Starting subtest: writes [430.200148] Subtest writes: SUCCESS (2.353s) [430.365331] [098/136] (614s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs) [430.852137] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs [430.896031] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s) [431.248328] [099/136] (613s left) kms_cursor_crc (cursor-random-32x10) [431.643133] Starting subtest: cursor-random-32x10 [431.856868] Subtest cursor-random-32x10: SKIP (0.176s) [431.968122] [100/136] (612s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [432.420839] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [432.458411] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [432.584692] [101/136] (612s left) kms_flip (2x-flip-vs-modeset) [432.952247] Starting subtest: 2x-flip-vs-modeset [432.990017] Subtest 2x-flip-vs-modeset: SKIP (0.004s) [433.112046] [102/136] (611s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [433.478281] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [433.497455] Starting dynamic subtest: pipe-A-valid-mode [433.611071] Dynamic subtest pipe-A-valid-mode: SKIP (0.107s) [433.652886] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.109s) [433.951094] [103/136] (611s left) gem_eio (in-flight-immediate) [434.279252] Starting subtest: in-flight-immediate [435.300185] Subtest in-flight-immediate: SUCCESS (1.032s) [435.535785] [104/136] (609s left) gem_exec_capture (capture-recoverable) [435.836240] Starting subtest: capture-recoverable [435.881698] Subtest capture-recoverable: SKIP (0.000s) [436.018523] [105/136] (609s left) perf_pmu (semaphore-busy) [436.297167] Starting subtest: semaphore-busy [436.319395] Starting dynamic subtest: rcs0 [437.883915] Dynamic subtest rcs0: SUCCESS (1.569s) [437.927689] Starting dynamic subtest: bcs0 [439.453285] Dynamic subtest bcs0: SUCCESS (1.564s) [439.496675] Starting dynamic subtest: vcs0 [441.015198] Dynamic subtest vcs0: SUCCESS (1.565s) [441.058191] Starting dynamic subtest: vecs0 [442.561943] Dynamic subtest vecs0: SUCCESS (1.546s) [442.584539] Subtest semaphore-busy: SUCCESS (6.248s) [442.722108] [106/136] (602s left) syncobj_timeline (host-signal-ordered) [443.001339] Starting subtest: host-signal-ordered [443.022737] Subtest host-signal-ordered: SUCCESS (0.002s) [443.134077] [107/136] (602s left) kms_addfb_basic (invalid-set-prop) [443.698669] Starting subtest: invalid-set-prop [443.721024] Subtest invalid-set-prop: SUCCESS (0.000s) [443.848520] [108/136] (601s left) kms_getfb (getfb-addfb-different-handles) [444.132233] Starting subtest: getfb-addfb-different-handles [444.153260] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [444.279663] [109/136] (601s left) kms_vblank (pipe-b-wait-busy-hang) [444.645214] Starting subtest: pipe-B-wait-busy-hang [452.039939] Subtest pipe-B-wait-busy-hang: SUCCESS (7.270s) [452.311603] [110/136] (593s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [452.586504] Starting subtest: etime-multi-wait-for-submit-submitted [452.689239] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s) [452.824152] [111/136] (593s left) vc4/vc4_purgeable_bo (access-purged-bo-mem) [453.196140] Subtest access-purged-bo-mem: SKIP (0.000s) [453.294589] [112/136] (592s left) i915_pm_rpm (universal-planes-dpms) [455.358003] Starting subtest: universal-planes-dpms [455.380773] Starting dynamic subtest: plane-31 [458.127768] Dynamic subtest plane-31: SUCCESS (2.770s) [458.169807] Starting dynamic subtest: plane-39 [461.079833] Dynamic subtest plane-39: SUCCESS (2.948s) [461.124540] Starting dynamic subtest: plane-47 [463.982131] Dynamic subtest plane-47: SUCCESS (2.897s) [464.033036] Starting dynamic subtest: plane-55 [466.751115] Dynamic subtest plane-55: SUCCESS (2.775s) [466.771902] Subtest universal-planes-dpms: SUCCESS (11.396s) [467.246918] [113/136] (579s left) kms_plane_alpha_blend (coverage-7efc) [467.659015] Starting subtest: coverage-7efc [468.000729] Starting dynamic subtest: pipe-A-DP-1 [468.476129] Dynamic subtest pipe-A-DP-1: SUCCESS (0.461s) [468.547102] Starting dynamic subtest: pipe-C-DP-1 [469.338713] Dynamic subtest pipe-C-DP-1: SUCCESS (0.812s) [469.359463] Subtest coverage-7efc: SUCCESS (1.686s) [469.759739] [114/136] (576s left) kms_vrr (flip-dpms) [470.144301] Starting subtest: flip-dpms [470.182032] Subtest flip-dpms: SKIP (0.000s) [470.303239] [115/136] (576s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [470.579939] Starting subtest: cpuset-basic-small-copy-XY [477.292682] Subtest cpuset-basic-small-copy-XY: SUCCESS (6.722s) [477.456503] [116/136] (569s left) kms_properties (connector-properties-atomic) [478.011237] Starting subtest: connector-properties-atomic [478.619765] Subtest connector-properties-atomic: SUCCESS (0.594s) [478.983557] [117/136] (567s left) kms_atomic_interruptible (legacy-setmode) [479.396976] Starting subtest: legacy-setmode [479.418795] Starting dynamic subtest: DP-1-pipe-A [485.910762] Dynamic subtest DP-1-pipe-A: SUCCESS (6.494s) [485.930047] Subtest legacy-setmode: SUCCESS (6.496s) [486.276935] [118/136] (560s left) kms_plane_scaling (planes-downscale-factor-0-75) [486.652716] Starting subtest: planes-downscale-factor-0-75 [486.671842] Starting dynamic subtest: pipe-A-DP-1 [486.917296] Dynamic subtest pipe-A-DP-1: SUCCESS (0.266s) [486.960165] Starting dynamic subtest: pipe-B-DP-1 [487.357733] Dynamic subtest pipe-B-DP-1: SUCCESS (0.433s) [487.401918] Starting dynamic subtest: pipe-C-DP-1 [487.548565] Dynamic subtest pipe-C-DP-1: SKIP (0.162s) [487.567688] Subtest planes-downscale-factor-0-75: SUCCESS (0.865s) [487.982120] [119/136] (558s left) kms_lease (setcrtc_implicit_plane) [488.354835] Starting subtest: setcrtc_implicit_plane [488.373968] Starting dynamic subtest: pipe-A-DP-1 [488.935716] Dynamic subtest pipe-A-DP-1: SUCCESS (0.571s) [488.982798] Starting dynamic subtest: pipe-B-DP-1 [489.347783] Dynamic subtest pipe-B-DP-1: SUCCESS (0.407s) [489.392529] Starting dynamic subtest: pipe-C-DP-1 [489.773410] Dynamic subtest pipe-C-DP-1: SUCCESS (0.419s) [489.792600] Subtest setcrtc_implicit_plane: SUCCESS (1.401s) [490.135060] [120/136] (556s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [490.522948] Starting subtest: primary-yf-tiled-reflect-x-90 [490.560418] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [490.681115] [121/136] (556s left) i915_pm_rpm (gem-evict-pwrite) [492.546968] Starting subtest: gem-evict-pwrite [493.847630] Subtest gem-evict-pwrite: SUCCESS (1.299s) [494.393155] [122/136] (552s left) kms_big_fb (y-tiled-32bpp-rotate-180) [494.875625] Starting subtest: y-tiled-32bpp-rotate-180 [500.482545] Subtest y-tiled-32bpp-rotate-180: SUCCESS (5.654s) [501.192347] [123/136] (546s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20) [501.592278] Starting subtest: plane-upscale-with-pixel-format-20x20 [501.614258] Starting dynamic subtest: pipe-A-DP-1 [502.083506] Dynamic subtest pipe-A-DP-1: SUCCESS (0.498s) [502.148533] Starting dynamic subtest: pipe-B-DP-1 [502.905033] Dynamic subtest pipe-B-DP-1: SUCCESS (0.802s) [502.961854] Starting dynamic subtest: pipe-C-DP-1 [503.238935] Dynamic subtest pipe-C-DP-1: SUCCESS (0.342s) [503.259732] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (1.646s) [503.673181] [124/136] (543s left) kms_color (deep-color) [504.052809] Starting subtest: deep-color [504.091724] Subtest deep-color: SKIP (0.000s) [504.215117] [125/136] (543s left) gem_exec_schedule (preempt-other) [504.695040] Starting subtest: preempt-other [504.716539] Starting dynamic subtest: rcs0 [504.737032] Dynamic subtest rcs0: SUCCESS (0.081s) [504.784980] Starting dynamic subtest: bcs0 [504.804945] Dynamic subtest bcs0: SUCCESS (0.086s) [504.852216] Starting dynamic subtest: vcs0 [504.872927] Dynamic subtest vcs0: SUCCESS (0.082s) [504.917590] Starting dynamic subtest: vecs0 [504.939595] Dynamic subtest vecs0: SUCCESS (0.084s) [504.960492] Subtest preempt-other: SUCCESS (0.339s) [505.290684] [126/136] (542s left) kms_flip (nonexisting-fb-interruptible) [505.670765] Starting subtest: nonexisting-fb-interruptible [505.690647] Starting dynamic subtest: A-DP1 [506.193853] Dynamic subtest A-DP1: SUCCESS (0.527s) [506.237288] Starting dynamic subtest: B-DP1 [506.647689] Dynamic subtest B-DP1: SUCCESS (0.432s) [506.690180] Starting dynamic subtest: C-DP1 [507.062542] Dynamic subtest C-DP1: SUCCESS (0.415s) [507.083644] Subtest nonexisting-fb-interruptible: SUCCESS (1.387s) [507.523593] [127/136] (540s left) perf_pmu (faulting-read) [507.812756] Starting subtest: faulting-read [507.832303] Starting dynamic subtest: gtt [507.852914] Dynamic subtest gtt: SUCCESS (0.008s) [507.897568] Starting dynamic subtest: wb [507.919059] Dynamic subtest wb: SUCCESS (0.002s) [507.962103] Starting dynamic subtest: wc [507.982304] Dynamic subtest wc: SUCCESS (0.001s) [508.023305] Starting dynamic subtest: uc [508.042606] Dynamic subtest uc: SUCCESS (0.001s) [508.061655] Subtest faulting-read: SUCCESS (0.019s) [508.182805] [128/136] (539s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [508.619092] Starting subtest: psr-1p-primscrn-spr-indfb-move [508.661341] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [508.784814] [129/136] (539s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [509.219118] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [511.630005] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.479s) [511.816755] [130/136] (536s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [514.855503] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [514.989626] [131/136] (533s left) kms_hdmi_inject (inject-audio) [515.299041] Subtest inject-audio: SKIP (0.000s) [515.412866] [132/136] (533s left) kms_big_fb (linear-64bpp-rotate-0) [515.830912] Starting subtest: linear-64bpp-rotate-0 [525.612770] Subtest linear-64bpp-rotate-0: SUCCESS (9.819s) [526.810944] [133/136] (521s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [527.249174] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [527.308720] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.002s) [527.440164] [134/136] (521s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs) [528.005411] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs [528.044307] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s) [528.398045] [135/136] (520s left) gem_create (hog-create) [528.682601] Starting subtest: hog-create [528.704287] Starting dynamic subtest: smem0 [560.945254] Dynamic subtest smem0: SUCCESS (32.260s) [560.966072] Subtest hog-create: SUCCESS (32.261s) [561.174010] [136/136] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [561.585778] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [561.625770] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [561.702206] Closing watchdogs Done.