[60.520044] Initializing watchdogs
[60.520089]   /dev/watchdog0
[60.535676] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.540213] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.542434] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.545783] [001/132] (960s left) api_intel_bb (blit-reloc-keep-cache)
[60.628924] Starting subtest: blit-reloc-keep-cache
[60.633159] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[60.741193] [002/132] (960s left) kms_atomic (plane-primary-legacy)
[60.839075] Starting subtest: plane-primary-legacy
[60.841273] Starting dynamic subtest: pipe-A-eDP-1
[61.324142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[61.326498] Subtest plane-primary-legacy: SUCCESS (0.484s)
[62.149925] [003/132] (958s left) gem_lmem_swapping (parallel-random-verify-ccs)
[62.199117] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[62.243793] [004/132] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[62.339580] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[65.967987] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.632s)
[67.188887] [005/132] (954s left) kms_atomic_transition (plane-all-transition-fencing)
[67.365293] Starting subtest: plane-all-transition-fencing
[67.367684] Starting dynamic subtest: pipe-A-eDP-1
[69.862197] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[70.181172] Starting dynamic subtest: pipe-B-eDP-1
[73.381957] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.210s)
[73.698042] Subtest plane-all-transition-fencing: SUCCESS (6.334s)
[74.496722] [006/132] (946s left) gem_sync (basic-many-each)
[74.576840] Starting subtest: basic-many-each
[76.870826] Subtest basic-many-each: SUCCESS (2.280s)
[77.024218] [007/132] (944s left) drm_read (empty-block)
[77.169023] Starting subtest: empty-block
[78.168380] Subtest empty-block: SUCCESS (1.000s)
[78.312699] [008/132] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[78.421720] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[87.091779] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.675s)
[87.216225] [009/132] (934s left) sysfs_heartbeat_interval (nopreempt)
[87.293012] Starting subtest: nopreempt
[87.295043] Starting dynamic subtest: vecs0
[96.918984] Dynamic subtest vecs0: SUCCESS (9.626s)
[96.931841] Starting dynamic subtest: ccs0
[100.934666] Dynamic subtest ccs0: SUCCESS (4.016s)
[100.944982] Starting dynamic subtest: vcs0
[110.937363] Dynamic subtest vcs0: SUCCESS (10.003s)
[110.948155] Starting dynamic subtest: bcs0
[114.937495] Dynamic subtest bcs0: SUCCESS (3.997s)
[114.947594] Starting dynamic subtest: rcs0
[118.995754] Dynamic subtest rcs0: SUCCESS (4.059s)
[119.005627] Starting dynamic subtest: vcs1
[128.918712] Dynamic subtest vcs1: SUCCESS (9.918s)
[128.921454] Subtest nopreempt: SUCCESS (41.627s)
[128.991222] [010/132] (892s left) i915_drm_fdinfo (busy-check-all)
[129.030168] Starting subtest: busy-check-all
[129.032247] Starting dynamic subtest: rcs0
[129.036619] Dynamic subtest rcs0: SKIP (0.003s)
[129.044752] Starting dynamic subtest: bcs0
[129.048675] Dynamic subtest bcs0: SKIP (0.000s)
[129.056324] Starting dynamic subtest: vcs0
[129.060479] Dynamic subtest vcs0: SKIP (0.000s)
[129.068065] Starting dynamic subtest: vcs1
[129.071966] Dynamic subtest vcs1: SKIP (0.000s)
[129.079231] Starting dynamic subtest: vecs0
[129.083151] Dynamic subtest vecs0: SKIP (0.000s)
[129.090831] Starting dynamic subtest: ccs0
[129.095153] Dynamic subtest ccs0: SKIP (0.000s)
[129.099382] Subtest busy-check-all: SKIP (0.007s)
[129.134146] [011/132] (892s left) gem_workarounds (suspend-resume-fd)
[129.240202] Starting subtest: suspend-resume-fd
[145.548841] Subtest suspend-resume-fd: SUCCESS (1.689s)
[154.753417] [012/132] (875s left) kms_prop_blob (blob-prop-validate)
[154.837975] Starting subtest: blob-prop-validate
[154.840159] Subtest blob-prop-validate: SUCCESS (0.000s)
[154.930541] [013/132] (875s left) kms_flip (flip-vs-suspend-interruptible)
[155.026604] Starting subtest: flip-vs-suspend-interruptible
[155.028946] Starting dynamic subtest: A-eDP1
[188.554139] Dynamic subtest A-eDP1: SUCCESS (4.265s)
[188.563854] Starting dynamic subtest: B-eDP1
[223.562337] Dynamic subtest B-eDP1: SUCCESS (4.174s)
[223.572334] Starting dynamic subtest: C-eDP1
[258.564186] Dynamic subtest C-eDP1: SUCCESS (4.236s)
[258.578399] Starting dynamic subtest: D-eDP1
[292.538392] Dynamic subtest D-eDP1: SUCCESS (4.141s)
[292.558602] Subtest flip-vs-suspend-interruptible: SUCCESS (16.827s)
[302.811104] [014/132] (736s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[302.913257] Starting subtest: invalid-modeset-force-ultra-joiner
[302.917624] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[302.975561] [015/132] (736s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[303.074820] Starting subtest: pipe-fbc-rte
[303.081450] Starting dynamic subtest: pipe-B-eDP-1
[308.533529] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.462s)
[308.540558] Subtest pipe-fbc-rte: SUCCESS (5.465s)
[310.880769] [016/132] (728s left) gem_exec_balancer (parallel-keep-submit-fence)
[311.143959] Starting subtest: parallel-keep-submit-fence
[312.370687] Subtest parallel-keep-submit-fence: SUCCESS (1.226s)
[312.481089] [017/132] (727s left) gem_exec_params (secure-non-master)
[312.539228] Starting subtest: secure-non-master
[312.543268] Subtest secure-non-master: SKIP (0.000s)
[312.637770] [018/132] (727s left) kms_big_fb (linear-8bpp-rotate-180)
[312.733511] Starting subtest: linear-8bpp-rotate-180
[314.036980] Subtest linear-8bpp-rotate-180: SUCCESS (1.303s)
[314.161461] [019/132] (725s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[314.258098] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[314.262037] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[314.368632] [020/132] (725s left) gem_ctx_bad_destroy (invalid-ctx)
[314.419849] Starting subtest: invalid-ctx
[314.421869] Subtest invalid-ctx: SUCCESS (0.000s)
[314.491724] [021/132] (725s left) kms_plane_alpha_blend (coverage-7efc)
[314.580859] Starting subtest: coverage-7efc
[314.866419] Starting dynamic subtest: pipe-A-eDP-1
[315.491023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[315.514371] Starting dynamic subtest: pipe-D-eDP-1
[316.818788] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[316.821043] Subtest coverage-7efc: SUCCESS (2.237s)
[317.649354] [022/132] (722s left) prime_self_import (basic-with_one_bo_two_files)
[317.689471] Starting subtest: basic-with_one_bo_two_files
[317.703837] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[317.805858] [023/132] (722s left) gem_create (create-invalid-size)
[317.863728] Starting subtest: create-invalid-size
[317.865994] Subtest create-invalid-size: SUCCESS (0.000s)
[318.050344] [024/132] (722s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[318.144431] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[318.170010] Starting dynamic subtest: pipe-A-plane-0
[318.480646] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s)
[318.491753] Starting dynamic subtest: pipe-A-plane-3
[318.714338] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[319.848163] Starting dynamic subtest: pipe-B-plane-0
[320.143044] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[320.153016] Starting dynamic subtest: pipe-B-plane-3
[320.374234] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[320.686287] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.541s)
[321.528310] [025/132] (718s left) kms_psr (fbc-psr2-primary-blt)
[321.624229] Starting subtest: fbc-psr2-primary-blt
[321.626661] Starting dynamic subtest: eDP-1
[321.631250] Dynamic subtest eDP-1: SKIP (0.000s)
[321.635951] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[321.715578] [026/132] (718s left) kms_getfb (getfb2-handle-zero)
[321.820827] Starting subtest: getfb2-handle-zero
[321.823124] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[321.922783] [027/132] (718s left) kms_cursor_crc (cursor-random-128x42)
[322.176455] Starting subtest: cursor-random-128x42
[322.224193] Subtest cursor-random-128x42: SKIP (0.042s)
[322.414351] [028/132] (717s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[322.515165] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[322.518601] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[322.616340] [029/132] (717s left) kms_chamelium_color (ctm-0-75)
[322.699108] Subtest ctm-0-75: SKIP (0.000s)
[322.744612] [030/132] (717s left) gem_exec_params (invalid-bsd2-flag-on-render)
[322.806760] Starting subtest: invalid-bsd2-flag-on-render
[322.808836] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[322.901436] [031/132] (717s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[323.001923] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[323.003926] Starting dynamic subtest: pipe-A-eDP-1
[323.023342] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[323.033753] Starting dynamic subtest: pipe-B-eDP-1
[323.051225] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[323.059587] Starting dynamic subtest: pipe-C-eDP-1
[323.078073] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[323.086244] Starting dynamic subtest: pipe-D-eDP-1
[323.104526] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[323.108196] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[325.201958] [032/132] (715s left) syncobj_timeline (invalid-query-bad-pad)
[325.258027] Starting subtest: invalid-query-bad-pad
[325.260031] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[325.346539] [033/132] (715s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[325.448485] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[325.453009] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[326.540832] [034/132] (713s left) kms_big_fb (x-tiled-addfb-size-overflow)
[326.646186] Starting subtest: x-tiled-addfb-size-overflow
[326.648509] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[326.748377] [035/132] (713s left) gen9_exec_parse (bb-chained)
[326.809707] Subtest bb-chained: SKIP (0.000s)
[326.872638] [036/132] (713s left) syncobj_timeline (multi-wait-available-signaled)
[326.936197] Starting subtest: multi-wait-available-signaled
[326.938497] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[327.051640] [037/132] (713s left) perf_pmu (gt-awake)
[327.091779] Starting subtest: gt-awake
[336.229810] Subtest gt-awake: SUCCESS (9.136s)
[336.333371] [038/132] (704s left) gem_exec_schedule (u-semaphore-user)
[336.412062] Starting subtest: u-semaphore-user
[336.473507] Subtest u-semaphore-user: SUCCESS (0.063s)
[338.256354] [039/132] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[338.355346] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[338.359777] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[338.449686] [040/132] (702s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[338.544506] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[338.549037] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[338.635395] [041/132] (702s left) gem_flink_basic (flink-lifetime)
[338.690966] Starting subtest: flink-lifetime
[338.693301] Subtest flink-lifetime: SUCCESS (0.002s)
[338.792414] [042/132] (702s left) perf (buffer-fill)
[338.915150] Starting subtest: buffer-fill
[338.917363] Starting dynamic subtest: 0-rcs0
[341.208660] Dynamic subtest 0-rcs0: SUCCESS (2.293s)
[341.219052] Starting dynamic subtest: 1-vcs1
[345.649377] Dynamic subtest 1-vcs1: SUCCESS (4.439s)
[345.652438] Subtest buffer-fill: SUCCESS (6.735s)
[345.699244] [043/132] (695s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[345.802898] Starting subtest: fbc-rgb565-draw-mmap-cpu
[349.899282] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.099s)
[351.044780] [044/132] (689s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[351.168726] Starting subtest: cursorA-vs-flipB-atomic
[351.173301] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[351.327870] [045/132] (689s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[351.382747] Starting subtest: etime-single-wait-for-submit-submitted
[351.487884] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s)
[351.564891] [046/132] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[351.671227] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[351.675503] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[351.753045] [047/132] (689s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[351.818536] Starting subtest: invalid-bsd1-flag-on-vebox
[351.820760] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[351.914794] [048/132] (689s left) vgem_basic (sysfs)
[352.020878] Starting subtest: sysfs
[352.023140] Subtest sysfs: SUCCESS (0.000s)
[352.087951] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[352.092083] [049/132] (689s left) kms_psr (psr-primary-mmap-cpu)
[352.190866] Starting subtest: psr-primary-mmap-cpu
[352.193124] Starting dynamic subtest: eDP-1
[353.927599] Dynamic subtest eDP-1: SUCCESS (1.734s)
[353.929634] Subtest psr-primary-mmap-cpu: SUCCESS (1.735s)
[354.791087] [050/132] (686s left) gem_userptr_blits (access-control)
[354.870352] Starting subtest: access-control
[354.874720] Subtest access-control: SKIP (0.000s)
[355.002788] [051/132] (686s left) prime_busy (hang-wait)
[355.066661] Starting subtest: hang-wait
[355.068989] Starting dynamic subtest: rcs0
[380.745273] Dynamic subtest rcs0: SUCCESS (25.664s)
[380.756030] Starting dynamic subtest: bcs0
[387.894301] Dynamic subtest bcs0: SUCCESS (7.156s)
[387.905852] Starting dynamic subtest: vcs0
[394.863883] Dynamic subtest vcs0: SUCCESS (6.970s)
[394.875743] Starting dynamic subtest: vcs1
[401.853965] Dynamic subtest vcs1: SUCCESS (6.973s)
[401.864465] Starting dynamic subtest: vecs0
[408.882217] Dynamic subtest vecs0: SUCCESS (7.038s)
[408.893434] Starting dynamic subtest: ccs0
[422.654289] Dynamic subtest ccs0: SUCCESS (13.769s)
[422.656900] Subtest hang-wait: SUCCESS (67.580s)
[422.780384] [052/132] (618s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[422.908647] Starting subtest: cursor-vs-flip-atomic-transitions
[453.001583] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.089s)
[453.837752] [053/132] (587s left) kms_cursor_crc (cursor-onscreen-128x42)
[454.056359] Starting subtest: cursor-onscreen-128x42
[454.104464] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[454.290142] [054/132] (587s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[454.382450] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[454.386834] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[454.483632] [055/132] (586s left) gem_mmap_wc (read)
[454.536071] Subtest read: SKIP (0.000s)
[454.595051] [056/132] (586s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[454.650380] Starting subtest: x-tiled-to-vebox-y-tiled
[454.654650] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[454.836066] [057/132] (586s left) gem_create (create-ext-cpu-access-big)
[455.004644] Starting subtest: create-ext-cpu-access-big
[455.009006] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[455.078363] [058/132] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[455.185582] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[455.189547] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.293002] [059/132] (586s left) gem_ctx_exec (basic-nohangcheck)
[455.358555] Starting subtest: basic-nohangcheck
[455.620323] Subtest basic-nohangcheck: SUCCESS (0.261s)
[455.756586] [060/132] (585s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[455.844502] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[460.417377] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.576s)
[461.546644] [061/132] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[461.649450] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[461.653525] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[461.751524] [062/132] (579s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[461.855534] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[461.968085] [063/132] (579s left) kms_vblank (query-forked-hang)
[462.056562] Starting subtest: query-forked-hang
[462.058473] Starting dynamic subtest: pipe-A-eDP-1
[468.556304] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.497s)
[468.573261] Starting dynamic subtest: pipe-D-eDP-1
[474.513740] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.957s)
[474.516236] Subtest query-forked-hang: SUCCESS (12.458s)
[475.410991] [064/132] (566s left) kms_feature_discovery (display-3x)
[475.504822] Starting subtest: display-3x
[475.508973] Subtest display-3x: SKIP (0.000s)
[475.579981] [065/132] (566s left) syncobj_wait (reset-during-wait-for-submit)
[475.625601] Starting subtest: reset-during-wait-for-submit
[475.727741] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[475.821940] [066/132] (566s left) gem_exec_fence (syncobj-timeline-repeat)
[476.354500] Starting subtest: syncobj-timeline-repeat
[476.592157] Subtest syncobj-timeline-repeat: SUCCESS (0.238s)
[477.301148] [067/132] (564s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[477.413301] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[481.565021] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.154s)
[482.710638] [068/132] (559s left) gem_softpin (noreloc-interruptible)
[482.770786] Starting subtest: noreloc-interruptible
[488.203326] Subtest noreloc-interruptible: SUCCESS (5.380s)
[488.272676] [069/132] (553s left) kms_chamelium_edid (hdmi-edid-read)
[488.662716] Subtest hdmi-edid-read: SKIP (0.000s)
[489.505723] [070/132] (552s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[489.608092] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[489.612637] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[489.727850] [071/132] (552s left) gem_exec_balancer (hog)
[489.787130] Starting subtest: hog
[489.791677] Subtest hog: SKIP (0.000s)
[490.116073] [072/132] (552s left) kms_cursor_legacy (single-move)
[490.238383] Starting subtest: single-move
[490.240361] Starting dynamic subtest: pipe-A
[495.673883] Dynamic subtest pipe-A: SUCCESS (5.380s)
[495.685438] Starting dynamic subtest: pipe-B
[501.004610] Dynamic subtest pipe-B: SUCCESS (5.379s)
[501.016569] Starting dynamic subtest: pipe-C
[506.438173] Dynamic subtest pipe-C: SUCCESS (5.379s)
[506.450341] Starting dynamic subtest: pipe-D
[511.820590] Dynamic subtest pipe-D: SUCCESS (5.379s)
[511.832454] Starting dynamic subtest: all-pipes
[517.208161] Dynamic subtest all-pipes: SUCCESS (5.386s)
[517.210105] Subtest single-move: SUCCESS (26.916s)
[517.302341] [073/132] (524s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[517.403685] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[517.405952] Starting dynamic subtest: pipe-A
[517.423981] Dynamic subtest pipe-A: SKIP (0.018s)
[517.436052] Starting dynamic subtest: pipe-B
[517.456685] Dynamic subtest pipe-B: SKIP (0.031s)
[517.466380] Starting dynamic subtest: pipe-C
[517.490130] Dynamic subtest pipe-C: SKIP (0.031s)
[517.499718] Starting dynamic subtest: pipe-D
[517.521491] Dynamic subtest pipe-D: SKIP (0.031s)
[517.525273] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.115s)
[517.609183] [074/132] (524s left) gem_softpin (safe-alignment)
[517.673672] Starting subtest: safe-alignment
[517.698957] Subtest safe-alignment: SUCCESS (0.026s)
[519.270063] [075/132] (523s left) prime_vgem (basic-fence-mmap)
[519.338460] Starting subtest: basic-fence-mmap
[519.342501] Subtest basic-fence-mmap: SKIP (0.000s)
[519.434464] [076/132] (522s left) gem_flink_basic (bad-flink)
[519.494809] Starting subtest: bad-flink
[519.497094] Subtest bad-flink: SUCCESS (0.000s)
[519.580250] [077/132] (522s left) kms_pm_dc (dc5-psr)
[520.681481] Starting subtest: dc5-psr
[523.660502] Subtest dc5-psr: SUCCESS (2.980s)
[524.551794] [078/132] (517s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[524.671999] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[556.190565] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.518s)
[556.992818] [079/132] (485s left) gem_exec_schedule (wide)
[557.171933] Starting subtest: wide
[557.174282] Starting dynamic subtest: rcs0
[567.588894] Dynamic subtest rcs0: SUCCESS (10.365s)
[567.598879] Starting dynamic subtest: vcs0
[578.261363] Dynamic subtest vcs0: SUCCESS (10.720s)
[578.277472] Starting dynamic subtest: vcs1
[588.369582] Dynamic subtest vcs1: SUCCESS (10.105s)
[588.379645] Starting dynamic subtest: vecs0
[599.914178] Dynamic subtest vecs0: SUCCESS (11.542s)
[599.927629] Starting dynamic subtest: ccs0
[613.023093] Dynamic subtest ccs0: SUCCESS (13.058s)
[613.025320] Subtest wide: SUCCESS (55.798s)
[615.561818] [080/132] (426s left) i915_pm_rpm (gem-evict-pwrite)
[617.405740] Starting subtest: gem-evict-pwrite
[617.410829] Subtest gem-evict-pwrite: SKIP (0.000s)
[617.838136] [081/132] (424s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[617.943816] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[618.578886] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[618.748445] [082/132] (423s left) kms_psr (pr-primary-page-flip)
[618.860460] Starting subtest: pr-primary-page-flip
[618.864801] Subtest pr-primary-page-flip: SKIP (0.000s)
[618.934166] [083/132] (423s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[619.037235] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[626.338520] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.304s)
[626.454870] [084/132] (416s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[626.543093] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[626.545293] Starting dynamic subtest: pipe-A
[627.737189] Dynamic subtest pipe-A: SUCCESS (1.196s)
[627.754072] Starting dynamic subtest: pipe-B
[630.034186] Dynamic subtest pipe-B: SUCCESS (2.294s)
[630.044723] Starting dynamic subtest: pipe-C
[631.268325] Dynamic subtest pipe-C: SUCCESS (1.232s)
[631.279502] Starting dynamic subtest: pipe-D
[632.498698] Dynamic subtest pipe-D: SUCCESS (1.230s)
[632.500917] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.957s)
[633.692486] [085/132] (409s left) gem_exec_params (secure-non-root)
[633.746242] Starting subtest: secure-non-root
[633.750779] Subtest secure-non-root: SKIP (0.000s)
[633.852465] [086/132] (408s left) syncobj_timeline (wait-all-snapshot)
[633.914994] Starting subtest: wait-all-snapshot
[633.996670] Subtest wait-all-snapshot: SUCCESS (0.083s)
[634.099668] [087/132] (408s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[634.192224] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[634.194360] Starting dynamic subtest: pipe-A-default-mode
[635.362459] Dynamic subtest pipe-A-default-mode: SKIP (1.167s)
[635.366742] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.169s)
[635.498131] [088/132] (407s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[635.619735] Starting subtest: x-tiled-32bpp-rotate-180
[637.053910] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.434s)
[637.198731] [089/132] (405s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[637.301094] Starting subtest: pr-cursor-plane-move-continuous-sf
[637.304411] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[637.369346] [090/132] (405s left) gem_exec_params (mmapped)
[637.422641] Starting subtest: mmapped
[637.426609] Subtest mmapped: SUCCESS (0.003s)
[637.544788] [091/132] (405s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[637.632543] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[637.636140] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[637.717200] [092/132] (405s left) kms_psr2_su (frontbuffer-xrgb8888)
[637.773276] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[637.838571] [093/132] (405s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[637.933441] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[637.935483] Starting dynamic subtest: pipe-A-eDP-1
[637.955446] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[637.967315] Starting dynamic subtest: pipe-B-eDP-1
[637.984543] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[637.993496] Starting dynamic subtest: pipe-C-eDP-1
[638.010515] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[638.019070] Starting dynamic subtest: pipe-D-eDP-1
[638.036891] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[638.040379] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[640.425173] [094/132] (402s left) kms_content_protection (dp-mst-type-0)
[640.568098] Starting subtest: dp-mst-type-0
[640.572862] Subtest dp-mst-type-0: SKIP (0.000s)
[640.697116] [095/132] (402s left) kms_plane_multiple (2x-tiling-4)
[640.789828] Starting subtest: 2x-tiling-4
[640.794121] Subtest 2x-tiling-4: SKIP (0.000s)
[640.863748] [096/132] (402s left) kms_cursor_crc (cursor-sliding-256x256)
[641.090060] Starting subtest: cursor-sliding-256x256
[641.094795] Starting dynamic subtest: pipe-A-eDP-1
[644.306898] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.211s)
[644.335353] Starting dynamic subtest: pipe-D-eDP-1
[648.242861] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.913s)
[648.245088] Subtest cursor-sliding-256x256: SUCCESS (7.150s)
[649.083996] [097/132] (394s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[649.130737] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[649.239499] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[649.320064] [098/132] (393s left) gem_exec_schedule (preempt-other-chain)
[649.395886] Starting subtest: preempt-other-chain
[649.397796] Starting dynamic subtest: rcs0
[649.474542] Dynamic subtest rcs0: SUCCESS (0.085s)
[649.489881] Starting dynamic subtest: bcs0
[649.552994] Dynamic subtest bcs0: SUCCESS (0.078s)
[649.571821] Starting dynamic subtest: vcs0
[649.628771] Dynamic subtest vcs0: SUCCESS (0.074s)
[649.645547] Starting dynamic subtest: vcs1
[649.709077] Dynamic subtest vcs1: SUCCESS (0.080s)
[649.722659] Starting dynamic subtest: vecs0
[649.791168] Dynamic subtest vecs0: SUCCESS (0.080s)
[649.806120] Starting dynamic subtest: ccs0
[649.881368] Dynamic subtest ccs0: SUCCESS (0.090s)
[649.884086] Subtest preempt-other-chain: SUCCESS (0.493s)
[651.329042] [099/132] (392s left) kms_lease (implicit-plane-lease)
[651.428706] Starting subtest: implicit-plane-lease
[651.431043] Subtest implicit-plane-lease: SUCCESS (0.003s)
[651.548047] [100/132] (391s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[651.639619] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[651.641888] Starting dynamic subtest: pipe-A-eDP-1
[651.650853] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[651.662849] Starting dynamic subtest: pipe-B-eDP-1
[651.671479] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[651.681573] Starting dynamic subtest: pipe-C-eDP-1
[651.689571] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[651.699590] Starting dynamic subtest: pipe-D-eDP-1
[651.707963] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[651.712089] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[653.938956] [101/132] (389s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[654.040206] Starting subtest: plane-ctm3x4-lut1d
[654.202299] Starting dynamic subtest: pipe-A-plane-0
[654.589301] Dynamic subtest pipe-A-plane-0: FAIL (0.211s)
[654.599731] Starting dynamic subtest: pipe-A-plane-1
[654.811056] Dynamic subtest pipe-A-plane-1: FAIL (0.175s)
[654.821384] Starting dynamic subtest: pipe-A-plane-2
[655.037590] Dynamic subtest pipe-A-plane-2: FAIL (0.202s)
[656.079720] Starting dynamic subtest: pipe-B-plane-0
[656.491825] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[656.503345] Starting dynamic subtest: pipe-B-plane-1
[656.815200] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[656.827538] Starting dynamic subtest: pipe-B-plane-2
[657.130135] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[657.767954] Starting dynamic subtest: pipe-C-plane-0
[658.258909] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[658.270902] Starting dynamic subtest: pipe-C-plane-1
[658.670439] Dynamic subtest pipe-C-plane-1: FAIL (0.607s)
[658.686432] Starting dynamic subtest: pipe-C-plane-2
[659.055810] Dynamic subtest pipe-C-plane-2: FAIL (0.155s)
[659.827984] Starting dynamic subtest: pipe-D-plane-0
[660.419662] Dynamic subtest pipe-D-plane-0: FAIL (0.129s)
[660.430985] Starting dynamic subtest: pipe-D-plane-1
[660.889572] Dynamic subtest pipe-D-plane-1: FAIL (0.624s)
[660.901497] Starting dynamic subtest: pipe-D-plane-2
[661.358253] Dynamic subtest pipe-D-plane-2: FAIL (0.566s)
[661.449273] Subtest plane-ctm3x4-lut1d: FAIL (7.409s)
[662.292129] [102/132] (381s left) gem_mmap_offset (partial-unmap)
[662.343037] Starting subtest: partial-unmap
[662.345418] Starting dynamic subtest: smem0
[662.848119] Dynamic subtest smem0: SUCCESS (0.506s)
[662.850755] Subtest partial-unmap: SUCCESS (0.507s)
[662.954552] [103/132] (380s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[663.031319] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[663.036078] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[663.217574] [104/132] (380s left) perf (invalid-oa-format-id)
[663.306285] Starting subtest: invalid-oa-format-id
[663.313638] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[663.362509] [105/132] (380s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[663.456120] Starting subtest: y-tiled-16bpp-rotate-90
[663.460534] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[663.552928] [106/132] (380s left) kms_flip (bo-too-big-interruptible)
[663.647016] Starting subtest: bo-too-big-interruptible
[663.649088] Starting dynamic subtest: A-eDP1
[664.931168] Dynamic subtest A-eDP1: SUCCESS (1.282s)
[664.941458] Starting dynamic subtest: B-eDP1
[666.174027] Dynamic subtest B-eDP1: SUCCESS (1.241s)
[666.187051] Starting dynamic subtest: C-eDP1
[667.524580] Dynamic subtest C-eDP1: SUCCESS (1.350s)
[667.536501] Starting dynamic subtest: D-eDP1
[668.866969] Dynamic subtest D-eDP1: SUCCESS (1.341s)
[668.872798] Subtest bo-too-big-interruptible: SUCCESS (5.225s)
[670.066101] [107/132] (373s left) kms_flip (flip-vs-rmfb)
[670.154751] Starting subtest: flip-vs-rmfb
[670.157080] Starting dynamic subtest: A-eDP1
[678.858633] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[678.871605] Starting dynamic subtest: B-eDP1
[687.498020] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[687.509269] Starting dynamic subtest: C-eDP1
[696.120742] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[696.134303] Starting dynamic subtest: D-eDP1
[704.756116] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[704.760439] Subtest flip-vs-rmfb: SUCCESS (34.604s)
[705.941951] [108/132] (337s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[706.041016] Starting subtest: fbc-psr2-sprite-plane-onoff
[706.043433] Starting dynamic subtest: eDP-1
[706.048103] Dynamic subtest eDP-1: SKIP (0.000s)
[706.052268] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.002s)
[706.122307] [109/132] (337s left) kms_vrr (negative-basic)
[706.215542] Starting subtest: negative-basic
[706.222319] Starting dynamic subtest: pipe-A-eDP-1
[711.695093] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.410s)
[711.924881] Subtest negative-basic: SUCCESS (5.710s)
[712.780637] [110/132] (331s left) kms_vblank (query-busy-hang)
[712.880234] Starting subtest: query-busy-hang
[712.881992] Starting dynamic subtest: pipe-A-eDP-1
[738.984758] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.102s)
[738.998532] Starting dynamic subtest: pipe-D-eDP-1
[763.993098] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.004s)
[763.995443] Subtest query-busy-hang: SUCCESS (51.112s)
[764.847676] [111/132] (279s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[764.902228] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[764.980428] [112/132] (278s left) gem_ctx_exec (basic)
[765.039665] Starting subtest: basic
[765.045379] Subtest basic: SUCCESS (0.007s)
[765.162346] [113/132] (278s left) gem_ccs (block-copy-uncompressed)
[765.214180] Starting subtest: block-copy-uncompressed
[765.216016] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[765.233278] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[765.244246] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[765.251057] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[765.261130] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[765.268805] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[765.278666] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[765.286610] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[765.288847] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[765.404909] [114/132] (278s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[765.502848] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[765.506935] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[765.604865] [115/132] (278s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[765.658579] Starting subtest: saturated-hostile-nopreempt
[765.660960] Starting dynamic subtest: rcs0
[765.735471] Dynamic subtest rcs0: SKIP (0.074s)
[765.748170] Starting dynamic subtest: bcs0
[765.759906] Dynamic subtest bcs0: SKIP (0.023s)
[765.770127] Starting dynamic subtest: vcs0
[765.773722] Dynamic subtest vcs0: SKIP (0.012s)
[765.783540] Starting dynamic subtest: vcs1
[765.789344] Dynamic subtest vcs1: SKIP (0.014s)
[765.799094] Starting dynamic subtest: vecs0
[765.802841] Dynamic subtest vecs0: SKIP (0.011s)
[765.812586] Starting dynamic subtest: ccs0
[765.815971] Dynamic subtest ccs0: SKIP (0.013s)
[765.819623] Subtest saturated-hostile-nopreempt: SKIP (0.154s)
[765.893031] [116/132] (278s left) kms_flip (flip-vs-wf_vblank-interruptible)
[765.994908] Starting subtest: flip-vs-wf_vblank-interruptible
[765.996535] Starting dynamic subtest: A-eDP1
[767.888661] Dynamic subtest A-eDP1: SUCCESS (1.891s)
[767.905316] Starting dynamic subtest: B-eDP1
[769.817635] Dynamic subtest B-eDP1: SUCCESS (1.926s)
[769.833608] Starting dynamic subtest: C-eDP1
[771.734672] Dynamic subtest C-eDP1: SUCCESS (1.914s)
[771.746347] Starting dynamic subtest: D-eDP1
[773.581540] Dynamic subtest D-eDP1: SUCCESS (1.845s)
[773.586361] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.590s)
[774.815540] [117/132] (269s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[774.909184] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[774.913642] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[774.996232] [118/132] (269s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[775.079895] Starting subtest: fbc-shrfb-scaledprimary
[778.103185] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.026s)
[779.307753] [119/132] (264s left) dmabuf_sync_file (import-basic)
[779.348755] Starting subtest: import-basic
[779.350720] Subtest import-basic: SUCCESS (0.002s)
[779.405756] [120/132] (264s left) kms_chamelium_hpd (dp-hpd-storm)
[779.780010] Subtest dp-hpd-storm: SKIP (0.000s)
[780.596736] [121/132] (263s left) gem_lmem_swapping (heavy-random)
[780.641211] Subtest heavy-random: SKIP (0.000s)
[780.692703] [122/132] (263s left) gem_wait (write-wait)
[780.750804] Starting subtest: write-wait
[780.753240] Starting dynamic subtest: all-engines
[781.857105] Dynamic subtest all-engines: SUCCESS (1.106s)
[781.875338] Starting dynamic subtest: rcs0
[782.919231] Dynamic subtest rcs0: SUCCESS (1.059s)
[782.937909] Starting dynamic subtest: bcs0
[783.984358] Dynamic subtest bcs0: SUCCESS (1.063s)
[784.003496] Starting dynamic subtest: vcs0
[785.038779] Dynamic subtest vcs0: SUCCESS (1.052s)
[785.056418] Starting dynamic subtest: vcs1
[786.093156] Dynamic subtest vcs1: SUCCESS (1.052s)
[786.111902] Starting dynamic subtest: vecs0
[787.147102] Dynamic subtest vecs0: SUCCESS (1.052s)
[787.164338] Starting dynamic subtest: ccs0
[788.204096] Dynamic subtest ccs0: SUCCESS (1.055s)
[788.206822] Subtest write-wait: SUCCESS (7.454s)
[788.407027] [123/132] (255s left) kms_addfb_basic (addfb25-bad-modifier)
[788.506872] Starting subtest: addfb25-bad-modifier
[788.509024] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[788.607726] [124/132] (255s left) gem_ctx_shared (q-in-order)
[788.675485] Starting subtest: Q-in-order
[788.677737] Starting dynamic subtest: rcs0
[788.775632] Dynamic subtest rcs0: SUCCESS (0.099s)
[788.793968] Starting dynamic subtest: vcs0
[788.850810] Dynamic subtest vcs0: SUCCESS (0.075s)
[788.868481] Starting dynamic subtest: vcs1
[788.929003] Dynamic subtest vcs1: SUCCESS (0.077s)
[788.946401] Starting dynamic subtest: vecs0
[789.007541] Dynamic subtest vecs0: SUCCESS (0.077s)
[789.028180] Starting dynamic subtest: ccs0
[789.098987] Dynamic subtest ccs0: SUCCESS (0.090s)
[789.102132] Subtest Q-in-order: SUCCESS (0.423s)
[790.350660] [125/132] (254s left) api_intel_bb (intel-bb-blit-x)
[790.404577] Starting subtest: intel-bb-blit-x
[793.969270] Subtest intel-bb-blit-x: SUCCESS (3.565s)
[794.076943] [126/132] (250s left) i915_pciid
[794.240529] [127/132] (250s left) kms_psr (psr-cursor-mmap-cpu)
[794.336369] Starting subtest: psr-cursor-mmap-cpu
[794.338717] Starting dynamic subtest: eDP-1
[796.027318] Dynamic subtest eDP-1: SUCCESS (1.690s)
[796.029498] Subtest psr-cursor-mmap-cpu: SUCCESS (1.691s)
[796.893724] [128/132] (247s left) gem_exec_fence (basic-busy-all)
[796.953767] Starting subtest: basic-busy-all
[797.033245] Subtest basic-busy-all: SUCCESS (0.080s)
[799.290278] [129/132] (245s left) i915_suspend (fence-restore-untiled)
[799.352494] Starting subtest: fence-restore-untiled
[799.357647] Subtest fence-restore-untiled: SKIP (0.000s)
[799.438753] [130/132] (245s left) gem_mmap_offset (ptrace)
[799.500337] Starting subtest: ptrace
[799.502831] Starting dynamic subtest: smem0-wb
[799.516898] Dynamic subtest smem0-wb: SUCCESS (0.015s)
[799.528237] Starting dynamic subtest: smem0-wc
[799.539089] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[799.549098] Starting dynamic subtest: smem0-uc
[799.561501] Dynamic subtest smem0-uc: SUCCESS (0.022s)
[799.563912] Subtest ptrace: SUCCESS (0.065s)
[799.712815] [131/132] (245s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[799.812113] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[799.816318] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[799.924855] [132/132] (244s left) perf (invalid-oa-metric-set-id)
[800.013776] Starting subtest: invalid-oa-metric-set-id
[800.023787] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[800.073695] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: kms_atomic
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: gem_sync
results: parsing output: 6/ for test: drm_read
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: sysfs_heartbeat_interval
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: gem_workarounds
results: parsing output: 11/ for test: kms_prop_blob
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_joiner
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_ctx_bad_destroy
results: parsing output: 20/ for test: kms_plane_alpha_blend
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: gem_create
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_getfb
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_chamelium_color
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gen9_exec_parse
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_params
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: prime_busy
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: gem_create
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_ctx_exec
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: kms_feature_discovery
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: kms_chamelium_edid
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: prime_vgem
results: parsing output: 75/ for test: gem_flink_basic
results: parsing output: 76/ for test: kms_pm_dc
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_su
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_content_protection
results: parsing output: 94/ for test: kms_plane_multiple
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_lease
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_color_pipeline
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_vrr
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: kms_pipe_b_c_ivb
results: parsing output: 111/ for test: gem_ctx_exec
results: parsing output: 112/ for test: gem_ccs
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: dmabuf_sync_file
results: parsing output: 119/ for test: kms_chamelium_hpd
results: parsing output: 120/ for test: gem_lmem_swapping
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: gem_ctx_shared
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: i915_pciid
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: i915_suspend
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: perf
Done.