[57.040803] Initializing watchdogs
[57.040850]   /dev/watchdog0
[57.055391] [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]
[57.059870] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.062016] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.065336] [001/132] (960s left) syncobj_wait (multi-wait-all-submitted)
[57.135827] Starting subtest: multi-wait-all-submitted
[57.242916] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[57.331739] [002/132] (960s left) gem_exec_reloc (basic-concurrent16)
[57.384536] Subtest basic-concurrent16: SKIP (0.000s)
[57.457735] [003/132] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[57.552212] Starting subtest: primary-yf-tiled-reflect-x-0
[57.635648] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.082s)
[57.734427] [004/132] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[57.827192] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[57.831325] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[57.914112] [005/132] (959s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[58.005631] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[58.032697] Starting dynamic subtest: pipe-A-plane-0
[58.651406] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[58.660850] Starting dynamic subtest: pipe-A-plane-3
[59.071050] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[60.169859] Starting dynamic subtest: pipe-B-plane-0
[60.849236] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[60.857587] Starting dynamic subtest: pipe-B-plane-3
[61.258581] Dynamic subtest pipe-B-plane-3: SUCCESS (0.411s)
[61.572100] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.584s)
[62.440391] [006/132] (955s left) kms_psr (fbc-pr-no-drrs)
[62.530214] Starting subtest: fbc-pr-no-drrs
[62.534398] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[62.611171] [007/132] (955s left) sw_sync (alloc_fence)
[62.649534] Starting subtest: alloc_fence
[62.651442] Subtest alloc_fence: SUCCESS (0.000s)
[62.704185] [008/132] (955s left) gem_eio (wait-10ms)
[62.923875] Starting subtest: wait-10ms
[63.255884] Subtest wait-10ms: SUCCESS (0.333s)
[63.393714] [009/132] (954s left) gem_wait (await)
[63.453073] Starting subtest: await
[63.455108] Starting dynamic subtest: all-engines
[64.591078] Dynamic subtest all-engines: SUCCESS (1.140s)
[64.606043] Starting dynamic subtest: rcs0
[65.646743] Dynamic subtest rcs0: SUCCESS (1.057s)
[65.661120] Starting dynamic subtest: bcs0
[66.703224] Dynamic subtest bcs0: SUCCESS (1.058s)
[66.720345] Starting dynamic subtest: vcs0
[67.849288] Dynamic subtest vcs0: SUCCESS (1.146s)
[67.864720] Starting dynamic subtest: vcs1
[68.903079] Dynamic subtest vcs1: SUCCESS (1.056s)
[68.918578] Starting dynamic subtest: vecs0
[69.961236] Dynamic subtest vecs0: SUCCESS (1.058s)
[69.975663] Starting dynamic subtest: ccs0
[71.018016] Dynamic subtest ccs0: SUCCESS (1.057s)
[71.020523] Subtest await: SUCCESS (7.578s)
[71.214655] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[71.217818] [010/132] (946s left) gem_exec_schedule (u-semaphore-user)
[71.299782] Starting subtest: u-semaphore-user
[71.354253] Subtest u-semaphore-user: SUCCESS (0.062s)
[73.006577] [011/132] (944s left) kms_getfb (getfb2-handle-not-fb)
[73.113149] Starting subtest: getfb2-handle-not-fb
[73.115583] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[73.224643] [012/132] (944s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[73.323384] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[73.325774] Starting dynamic subtest: pipe-A-eDP-1
[73.402894] Dynamic subtest pipe-A-eDP-1: SKIP (0.080s)
[73.412960] Starting dynamic subtest: pipe-B-eDP-1
[74.506924] Dynamic subtest pipe-B-eDP-1: SKIP (1.102s)
[74.511780] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.187s)
[75.712856] [013/132] (942s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[75.767181] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[75.874364] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[75.951599] [014/132] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[76.068268] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[76.072448] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[76.168379] [015/132] (942s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[76.275605] Starting subtest: pr-primary-plane-update-sf-dmg-area
[76.279618] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[76.350219] [016/132] (941s left) kms_properties (crtc-properties-legacy)
[76.454138] Starting subtest: crtc-properties-legacy
[76.456478] Starting dynamic subtest: pipe-A-eDP-1
[76.914706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[76.924411] Starting dynamic subtest: pipe-B-eDP-1
[78.048662] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[78.058122] Starting dynamic subtest: pipe-C-eDP-1
[79.163164] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[79.176299] Starting dynamic subtest: pipe-D-eDP-1
[80.298975] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[80.301519] Subtest crtc-properties-legacy: SUCCESS (3.847s)
[81.104478] [017/132] (937s left) kms_chamelium_frames (hdmi-aspect-ratio)
[81.507411] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[82.321258] [018/132] (935s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[82.427025] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[82.429301] Starting dynamic subtest: pipe-A-eDP-1
[82.450445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[82.460499] Starting dynamic subtest: pipe-B-eDP-1
[82.479819] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[82.487502] Starting dynamic subtest: pipe-C-eDP-1
[82.506281] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[82.513936] Starting dynamic subtest: pipe-D-eDP-1
[82.533155] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[82.535290] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[84.718940] [019/132] (933s left) gem_ctx_param (basic-default)
[84.767627] Starting subtest: basic-default
[84.769958] Subtest basic-default: SUCCESS (0.000s)
[84.839676] [020/132] (933s left) gem_exec_whisper (basic-queues-forked)
[84.897749] Starting subtest: basic-queues-forked
[108.041741] Subtest basic-queues-forked: SUCCESS (23.140s)
[108.220204] [021/132] (910s left) dmabuf_sync_file (import-basic)
[108.260667] Starting subtest: import-basic
[108.262632] Subtest import-basic: SUCCESS (0.002s)
[108.317128] [022/132] (910s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[108.424477] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[108.428627] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[108.543326] [023/132] (909s left) kms_addfb_basic (master-rmfb)
[108.603661] Starting subtest: master-rmfb
[108.606057] Subtest master-rmfb: SUCCESS (0.003s)
[108.764436] [024/132] (909s left) gem_ctx_exec (basic-norecovery)
[108.830942] Starting subtest: basic-norecovery
[109.168356] Subtest basic-norecovery: SUCCESS (0.339s)
[109.303458] [025/132] (909s left) i915_pm_rps (basic-api)
[109.365443] Starting subtest: basic-api
[109.369195] Subtest basic-api: SKIP (0.001s)
[109.468757] [026/132] (909s left) gem_ctx_param (set-priority-not-supported)
[109.530500] Starting subtest: set-priority-not-supported
[109.534155] Subtest set-priority-not-supported: SKIP (0.000s)
[109.618213] [027/132] (909s left) kms_rotation_crc (exhaust-fences)
[109.708097] Starting subtest: exhaust-fences
[109.711933] Subtest exhaust-fences: SKIP (0.000s)
[109.793922] [028/132] (908s left) kms_flip (flip-vs-blocking-wf-vblank)
[109.883238] Starting subtest: flip-vs-blocking-wf-vblank
[109.885125] Starting dynamic subtest: A-eDP1
[118.851689] Dynamic subtest A-eDP1: SUCCESS (8.970s)
[118.860061] Starting dynamic subtest: B-eDP1
[127.778080] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[127.788917] Starting dynamic subtest: C-eDP1
[136.702074] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[136.710634] Starting dynamic subtest: D-eDP1
[145.644823] Dynamic subtest D-eDP1: SUCCESS (8.941s)
[145.649630] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.768s)
[146.882982] [029/132] (871s left) kms_sequence (queue-idle)
[146.984444] Starting subtest: queue-idle
[146.986782] Starting dynamic subtest: pipe-A-eDP-1
[148.788674] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.805s)
[148.798679] Starting dynamic subtest: pipe-B-eDP-1
[151.240587] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.450s)
[151.250989] Starting dynamic subtest: pipe-C-eDP-1
[153.660953] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.421s)
[153.671749] Starting dynamic subtest: pipe-D-eDP-1
[156.102481] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.441s)
[156.104818] Subtest queue-idle: SUCCESS (9.120s)
[156.912075] [030/132] (861s left) kms_plane_multiple (2x-tiling-x)
[157.014132] Starting subtest: 2x-tiling-x
[157.018151] Subtest 2x-tiling-x: SKIP (0.000s)
[157.087670] [031/132] (861s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[157.134343] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[157.242937] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[157.315534] [032/132] (861s left) gem_exec_store (basic)
[157.381918] Starting subtest: basic
[157.491305] Subtest basic: SUCCESS (0.111s)
[157.689224] [033/132] (861s left) prime_vgem (fence-read-hang)
[157.779666] Subtest fence-read-hang: SKIP (0.000s)
[157.885995] [034/132] (861s left) kms_busy (extended-modeset-hang-newfb)
[157.982214] Starting subtest: extended-modeset-hang-newfb
[157.984468] Starting dynamic subtest: pipe-A
[192.866698] Dynamic subtest pipe-A: SUCCESS (34.882s)
[192.877431] Starting dynamic subtest: pipe-D
[215.781539] Dynamic subtest pipe-D: SUCCESS (22.912s)
[215.784020] Subtest extended-modeset-hang-newfb: SUCCESS (57.797s)
[216.593735] [035/132] (802s left) sysfs_heartbeat_interval (idempotent)
[216.651872] Starting subtest: idempotent
[216.654320] Starting dynamic subtest: vecs0
[216.656669] Dynamic subtest vecs0: SUCCESS (0.001s)
[216.666335] Starting dynamic subtest: ccs0
[216.668631] Dynamic subtest ccs0: SUCCESS (0.001s)
[216.676606] Starting dynamic subtest: vcs0
[216.678786] Dynamic subtest vcs0: SUCCESS (0.000s)
[216.686732] Starting dynamic subtest: bcs0
[216.688920] Dynamic subtest bcs0: SUCCESS (0.000s)
[216.696827] Starting dynamic subtest: rcs0
[216.699039] Dynamic subtest rcs0: SUCCESS (0.000s)
[216.707093] Starting dynamic subtest: vcs1
[216.708965] Dynamic subtest vcs1: SUCCESS (0.000s)
[216.710901] Subtest idempotent: SUCCESS (0.006s)
[216.763409] [036/132] (802s left) perf (invalid-oa-metric-set-id)
[216.884556] Starting subtest: invalid-oa-metric-set-id
[216.896212] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[216.944231] [037/132] (802s left) kms_cursor_crc (cursor-random-256x256)
[217.215041] Starting subtest: cursor-random-256x256
[217.217357] Starting dynamic subtest: pipe-A-eDP-1
[220.641284] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[220.672063] Starting dynamic subtest: pipe-D-eDP-1
[224.696547] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.032s)
[224.698896] Subtest cursor-random-256x256: SUCCESS (7.483s)
[225.538163] [038/132] (793s left) i915_query (query-regions-unallocated)
[225.591022] Starting subtest: query-regions-unallocated
[225.593314] Subtest query-regions-unallocated: SUCCESS (0.000s)
[225.683292] [039/132] (793s left) gem_pread (self)
[225.744419] Subtest self: SKIP (0.000s)
[225.811206] [040/132] (793s left) kms_cursor_legacy (single-move)
[225.920254] Starting subtest: single-move
[225.922121] Starting dynamic subtest: pipe-A
[231.302942] Dynamic subtest pipe-A: SUCCESS (5.379s)
[231.314423] Starting dynamic subtest: pipe-B
[236.685485] Dynamic subtest pipe-B: SUCCESS (5.381s)
[236.696883] Starting dynamic subtest: pipe-C
[242.068238] Dynamic subtest pipe-C: SUCCESS (5.381s)
[242.079345] Starting dynamic subtest: pipe-D
[247.450833] Dynamic subtest pipe-D: SUCCESS (5.381s)
[247.462266] Starting dynamic subtest: all-pipes
[252.839926] Dynamic subtest all-pipes: SUCCESS (5.388s)
[252.842593] Subtest single-move: SUCCESS (26.917s)
[252.984928] [041/132] (766s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[253.094146] Starting subtest: 4-tiled-32bpp-rotate-0
[254.550976] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.458s)
[254.684881] [042/132] (764s left) kms_pm_backlight (fade-with-suspend)
[254.788067] Starting subtest: fade-with-suspend
[271.210487] Starting dynamic subtest: eDP-1
[273.879728] Dynamic subtest eDP-1: SUCCESS (2.725s)
[273.881990] Subtest fade-with-suspend: SUCCESS (4.825s)
[274.752156] [043/132] (744s left) kms_flip (2x-flip-vs-expired-vblank)
[274.857096] Starting subtest: 2x-flip-vs-expired-vblank
[274.866190] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[274.945321] [044/132] (744s left) perf_pmu (most-busy-check-all)
[274.992336] Starting subtest: most-busy-check-all
[274.994265] Starting dynamic subtest: rcs0
[276.226215] Dynamic subtest rcs0: SUCCESS (1.251s)
[276.237712] Starting dynamic subtest: bcs0
[278.210377] Dynamic subtest bcs0: SUCCESS (2.005s)
[278.222742] Starting dynamic subtest: vcs0
[278.802122] Dynamic subtest vcs0: FAIL (0.535s)
[278.813310] Starting dynamic subtest: vcs1
[280.258328] Dynamic subtest vcs1: SUCCESS (1.529s)
[280.270691] Starting dynamic subtest: vecs0
[282.242915] Dynamic subtest vecs0: SUCCESS (1.996s)
[282.255247] Starting dynamic subtest: ccs0
[284.226407] Dynamic subtest ccs0: SUCCESS (1.992s)
[284.228968] Subtest most-busy-check-all: FAIL (9.318s)
[284.336266] [045/132] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[284.437190] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[290.912152] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.500s)
[292.041681] [046/132] (727s left) kms_hdr (static-toggle)
[292.139879] Starting subtest: static-toggle
[292.146544] Subtest static-toggle: SKIP (0.000s)
[292.215398] [047/132] (727s left) kms_big_fb (x-tiled-addfb-size-overflow)
[292.311164] Starting subtest: x-tiled-addfb-size-overflow
[292.313411] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[292.406847] [048/132] (727s left) gem_exec_balancer (bonded-chain)
[292.471732] Starting subtest: bonded-chain
[299.479488] Subtest bonded-chain: SUCCESS (7.016s)
[299.792728] [049/132] (719s left) gem_exec_reloc (basic-wc-cpu)
[299.846218] Subtest basic-wc-cpu: SKIP (0.000s)
[299.914030] [050/132] (719s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[300.013717] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[300.016020] Starting dynamic subtest: pipe-A-eDP-1
[300.076708] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[300.092947] Starting dynamic subtest: pipe-B-eDP-1
[300.150342] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[300.160954] Starting dynamic subtest: pipe-C-eDP-1
[300.217130] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[300.227020] Starting dynamic subtest: pipe-D-eDP-1
[300.283472] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[300.288027] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[302.275020] [051/132] (717s left) gem_userptr_blits (forbidden-operations)
[302.348765] Starting subtest: forbidden-operations
[302.353057] Subtest forbidden-operations: SKIP (0.000s)
[302.476775] [052/132] (717s left) perf_pmu (busy-accuracy-98)
[302.518955] Starting subtest: busy-accuracy-98
[302.521215] Starting dynamic subtest: rcs0
[305.552342] Dynamic subtest rcs0: SUCCESS (3.032s)
[305.562742] Starting dynamic subtest: bcs0
[308.602093] Dynamic subtest bcs0: SUCCESS (3.046s)
[308.612579] Starting dynamic subtest: vcs0
[311.646820] Dynamic subtest vcs0: SUCCESS (3.042s)
[311.657231] Starting dynamic subtest: vcs1
[314.686858] Dynamic subtest vcs1: SUCCESS (3.038s)
[314.697003] Starting dynamic subtest: vecs0
[317.728400] Dynamic subtest vecs0: SUCCESS (3.039s)
[317.738551] Starting dynamic subtest: ccs0
[320.774856] Dynamic subtest ccs0: SUCCESS (3.045s)
[320.777728] Subtest busy-accuracy-98: SUCCESS (18.255s)
[320.892932] [053/132] (698s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[321.023200] Starting subtest: cursorB-vs-flipA-varying-size
[321.027752] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[321.167903] [054/132] (698s left) gem_workarounds (suspend-resume-fd)
[321.241306] Starting subtest: suspend-resume-fd
[339.492667] Subtest suspend-resume-fd: SUCCESS (3.441s)
[347.646363] [055/132] (680s left) gem_mmap_offset (partial-remap)
[347.720228] Starting subtest: partial-remap
[347.722571] Starting dynamic subtest: smem0
[347.731346] Dynamic subtest smem0: SUCCESS (0.004s)
[347.733499] Subtest partial-remap: SUCCESS (0.004s)
[347.829108] [056/132] (680s left) gem_ctx_engines (execute-oneforall)
[347.894579] Starting subtest: execute-oneforall
[348.814517] Subtest execute-oneforall: SUCCESS (0.938s)
[350.149033] [057/132] (677s left) kms_plane (plane-panning-top-left)
[350.237918] Starting subtest: plane-panning-top-left
[350.240155] Starting dynamic subtest: pipe-A
[351.992134] Dynamic subtest pipe-A: SUCCESS (1.779s)
[352.002908] Starting dynamic subtest: pipe-B
[354.401502] Dynamic subtest pipe-B: SUCCESS (2.437s)
[354.403792] Subtest plane-panning-top-left: SUCCESS (4.218s)
[355.196915] [058/132] (672s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[355.295628] Starting subtest: yf-tiled-addfb-size-offset-overflow
[355.299752] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[355.400745] [059/132] (672s left) gem_ccs (block-multicopy-compressed)
[355.463971] Starting subtest: block-multicopy-compressed
[355.468016] Subtest block-multicopy-compressed: SKIP (0.000s)
[355.566939] [060/132] (672s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[355.658696] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[355.660972] Starting dynamic subtest: pipe-A-eDP-1
[355.669887] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.682099] Starting dynamic subtest: pipe-B-eDP-1
[355.691030] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.700525] Starting dynamic subtest: pipe-C-eDP-1
[355.709052] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.718013] Starting dynamic subtest: pipe-D-eDP-1
[355.726430] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.730766] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[357.953323] [061/132] (670s left) gen9_exec_parse (bb-start-far)
[358.016721] Subtest bb-start-far: SKIP (0.000s)
[358.099852] [062/132] (670s left) prime_vgem (basic-fence-flip)
[358.173476] Starting subtest: basic-fence-flip
[358.496740] Subtest basic-fence-flip: SUCCESS (0.325s)
[358.600025] [063/132] (669s left) syncobj_timeline (invalid-wait-bad-flags)
[358.666557] Starting subtest: invalid-wait-bad-flags
[358.668961] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[358.771977] [064/132] (669s left) kms_vblank (ts-continuation-dpms-suspend)
[358.857112] Starting subtest: ts-continuation-dpms-suspend
[358.859342] Starting dynamic subtest: pipe-A-eDP-1
[375.765893] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.847s)
[375.780570] Starting dynamic subtest: pipe-D-eDP-1
[393.763459] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.509s)
[393.765641] Subtest ts-continuation-dpms-suspend: SUCCESS (4.361s)
[394.546512] [065/132] (633s left) kms_draw_crc (draw-method-mmap-cpu)
[394.647103] Starting subtest: draw-method-mmap-cpu
[394.648962] Starting dynamic subtest: xrgb8888-untiled
[394.907814] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[394.918113] Starting dynamic subtest: rgb565-untiled
[395.146979] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[395.156842] Starting dynamic subtest: xrgb2101010-untiled
[395.365237] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[395.375086] Starting dynamic subtest: xbgr16161616f-untiled
[395.593696] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[395.603086] Starting dynamic subtest: xrgb8888-xtiled
[395.735843] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[395.746189] Starting dynamic subtest: rgb565-xtiled
[395.878357] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s)
[395.889873] Starting dynamic subtest: xrgb2101010-xtiled
[396.009323] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[396.021168] Starting dynamic subtest: xbgr16161616f-xtiled
[396.140581] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[396.152026] Starting dynamic subtest: xrgb8888-4tiled
[396.304568] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.164s)
[396.315815] Starting dynamic subtest: rgb565-4tiled
[396.468557] Dynamic subtest rgb565-4tiled: SUCCESS (0.164s)
[396.480166] Starting dynamic subtest: xrgb2101010-4tiled
[396.610729] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.142s)
[396.623310] Starting dynamic subtest: xbgr16161616f-4tiled
[396.764594] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s)
[396.766589] Subtest draw-method-mmap-cpu: SUCCESS (2.156s)
[396.890517] [066/132] (631s left) kms_lease (simple-lease)
[396.978311] Starting subtest: simple-lease
[396.980196] Starting dynamic subtest: pipe-A-eDP-1
[397.488103] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.516s)
[397.497822] Starting dynamic subtest: pipe-B-eDP-1
[398.941170] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.468s)
[398.950661] Starting dynamic subtest: pipe-C-eDP-1
[400.347766] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.420s)
[400.356891] Starting dynamic subtest: pipe-D-eDP-1
[401.744721] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[401.747121] Subtest simple-lease: SUCCESS (4.820s)
[402.554212] [067/132] (625s left) gem_exec_schedule (implicit-read-write)
[402.632865] Starting subtest: implicit-read-write
[402.635159] Starting dynamic subtest: rcs0
[402.731476] Dynamic subtest rcs0: SUCCESS (0.110s)
[402.743743] Starting dynamic subtest: vcs0
[402.813637] Dynamic subtest vcs0: SUCCESS (0.082s)
[402.826112] Starting dynamic subtest: vcs1
[402.889400] Dynamic subtest vcs1: SUCCESS (0.075s)
[402.902208] Starting dynamic subtest: vecs0
[402.960841] Dynamic subtest vecs0: SUCCESS (0.071s)
[402.972811] Starting dynamic subtest: ccs0
[403.050231] Dynamic subtest ccs0: SUCCESS (0.089s)
[403.052600] Subtest implicit-read-write: SUCCESS (0.432s)
[404.778365] [068/132] (623s left) prime_mmap (test_forked)
[404.832066] Starting subtest: test_forked
[404.834276] Starting dynamic subtest: test_forked-smem
[404.869543] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[404.871957] Subtest test_forked: SUCCESS (0.042s)
[405.019830] [069/132] (623s left) kms_frontbuffer_tracking (psr-2p-rte)
[405.132206] Starting subtest: psr-2p-rte
[405.136311] Subtest psr-2p-rte: SKIP (0.000s)
[405.279003] [070/132] (623s left) i915_drm_fdinfo (busy-idle)
[405.322223] Starting subtest: busy-idle
[405.324195] Starting dynamic subtest: rcs0
[405.342888] Dynamic subtest rcs0: SKIP (0.021s)
[405.354745] Starting dynamic subtest: bcs0
[405.358708] Dynamic subtest bcs0: SKIP (0.001s)
[405.368118] Starting dynamic subtest: vcs0
[405.372186] Dynamic subtest vcs0: SKIP (0.001s)
[405.381141] Starting dynamic subtest: vcs1
[405.385115] Dynamic subtest vcs1: SKIP (0.000s)
[405.393856] Starting dynamic subtest: vecs0
[405.397921] Dynamic subtest vecs0: SKIP (0.000s)
[405.406622] Starting dynamic subtest: ccs0
[405.410681] Dynamic subtest ccs0: SKIP (0.000s)
[405.414676] Subtest busy-idle: SKIP (0.029s)
[405.488802] [071/132] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[405.591725] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[412.182463] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.616s)
[412.296479] [072/132] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[412.401078] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[412.405105] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[412.492686] [073/132] (616s left) i915_module_load (reload)
[412.537421] Starting subtest: reload
[417.351384] Subtest reload: SUCCESS (4.825s)
[417.394670] [074/132] (611s left) api_intel_bb (object-reloc-purge-cache)
[418.580192] Starting subtest: object-reloc-purge-cache
[418.585085] Subtest object-reloc-purge-cache: SKIP (0.003s)
[418.702873] [075/132] (610s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[418.804543] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[418.808654] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[418.904031] [076/132] (610s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[419.001229] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[419.003424] Starting dynamic subtest: pipe-A-default-mode
[420.156001] Dynamic subtest pipe-A-default-mode: SKIP (1.155s)
[420.160323] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.156s)
[420.324313] [077/132] (608s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[420.426010] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[420.437309] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[420.525534] [078/132] (608s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[420.612387] Starting subtest: fbc-rgb565-draw-pwrite
[425.253462] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.645s)
[426.414427] [079/132] (602s left) gem_lmem_swapping (random-engines)
[426.472858] Subtest random-engines: SKIP (0.000s)
[426.520547] [080/132] (602s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[426.611692] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[426.615964] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[426.705337] [081/132] (602s left) syncobj_timeline (reset-signaled)
[426.755766] Starting subtest: reset-signaled
[426.757932] Subtest reset-signaled: SUCCESS (0.000s)
[426.843122] [082/132] (602s left) kms_pm_backlight (bad-brightness)
[426.935786] Starting subtest: bad-brightness
[426.989922] Starting dynamic subtest: eDP-1
[427.308811] Dynamic subtest eDP-1: SUCCESS (0.320s)
[427.311114] Subtest bad-brightness: SUCCESS (0.372s)
[428.150517] [083/132] (601s left) gem_exec_flush (basic-batch-kernel-default-uc)
[428.216375] Starting subtest: basic-batch-kernel-default-uc
[435.714999] Subtest basic-batch-kernel-default-uc: SUCCESS (7.494s)
[435.901193] [084/132] (593s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[436.004892] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[436.014349] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[436.097660] [085/132] (593s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[436.201003] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[436.205307] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[436.302346] [086/132] (593s left) kms_psr (fbc-psr-primary-blt)
[436.393980] Starting subtest: fbc-psr-primary-blt
[436.396111] Starting dynamic subtest: eDP-1
[436.400013] Dynamic subtest eDP-1: SKIP (0.000s)
[436.403881] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[436.465867] [087/132] (592s left) gem_render_copy (y-tiled-ccs-to-linear)
[436.523871] Starting subtest: y-tiled-ccs-to-linear
[436.528451] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[436.712718] [088/132] (592s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[436.803476] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[436.805716] Starting dynamic subtest: pipe-A-eDP-1
[438.084623] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.283s)
[438.094102] Starting dynamic subtest: pipe-B-eDP-1
[440.433865] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.347s)
[440.444580] Starting dynamic subtest: pipe-C-eDP-1
[442.745707] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.310s)
[442.760862] Starting dynamic subtest: pipe-D-eDP-1
[445.088974] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.341s)
[445.091339] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.288s)
[446.278542] [089/132] (583s left) gem_exec_create (legacy)
[446.335282] Starting subtest: legacy
[446.337471] Starting dynamic subtest: smem
[449.582890] Dynamic subtest smem: SUCCESS (3.246s)
[449.585817] Subtest legacy: SUCCESS (3.248s)
[449.769828] [090/132] (579s left) gem_mmap_gtt (basic-small-bo-tiledy)
[449.832641] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[449.895381] [091/132] (579s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[449.949992] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[450.057540] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[450.134835] [092/132] (579s left) gem_ctx_persistence (heartbeat-stop)
[450.197095] Starting subtest: heartbeat-stop
[450.201821] Subtest heartbeat-stop: SKIP (0.000s)
[450.314837] [093/132] (579s left) gem_spin_batch (user-each)
[450.380015] Starting subtest: user-each
[453.657197] Subtest user-each: SUCCESS (3.273s)
[455.674418] [094/132] (574s left) kms_chamelium_hpd (vga-hpd-fast)
[456.069683] Subtest vga-hpd-fast: SKIP (0.000s)
[456.893472] [095/132] (572s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[456.988462] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[460.717954] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.733s)
[461.941813] [096/132] (567s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[462.082529] Starting subtest: cursorA-vs-flipA-legacy
[473.204729] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.126s)
[474.036033] [097/132] (555s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[474.613693] Starting subtest: syncobj-timeline-multiple-ext-nodes
[474.615749] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[475.726600] [098/132] (554s left) sw_sync (sync_expired_merge)
[475.758271] Starting subtest: sync_expired_merge
[476.832206] Subtest sync_expired_merge: SUCCESS (1.074s)
[476.897095] [099/132] (552s left) kms_cursor_crc (cursor-offscreen-128x128)
[477.116253] Starting subtest: cursor-offscreen-128x128
[477.118540] Starting dynamic subtest: pipe-A-eDP-1
[479.077028] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.960s)
[479.109465] Starting dynamic subtest: pipe-D-eDP-1
[481.657279] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[481.659647] Subtest cursor-offscreen-128x128: SUCCESS (4.543s)
[482.509802] [100/132] (547s left) kms_big_fb (linear-16bpp-rotate-0)
[482.611894] Starting subtest: linear-16bpp-rotate-0
[483.945788] Subtest linear-16bpp-rotate-0: SUCCESS (1.334s)
[484.080939] [101/132] (545s left) kms_psr (fbc-psr2-primary-page-flip)
[484.188762] Starting subtest: fbc-psr2-primary-page-flip
[484.190741] Starting dynamic subtest: eDP-1
[484.194313] Dynamic subtest eDP-1: SKIP (0.000s)
[484.197841] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[484.258856] [102/132] (545s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[484.360965] Starting subtest: x-tiled-64bpp-rotate-270
[484.384478] Subtest x-tiled-64bpp-rotate-270: SKIP (0.023s)
[484.498523] [103/132] (545s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[484.627033] Starting subtest: 2x-long-flip-vs-cursor-atomic
[484.630477] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[484.772268] [104/132] (545s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[484.831227] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[484.834894] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[485.019769] [105/132] (545s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[485.126499] Starting subtest: y-tiled-8bpp-rotate-90
[485.130604] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[485.227335] [106/132] (544s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[485.318790] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[485.321113] Starting dynamic subtest: pipe-A-eDP-1
[487.566331] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.250s)
[487.575543] Starting dynamic subtest: pipe-B-eDP-1
[490.050585] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.482s)
[490.059856] Starting dynamic subtest: pipe-C-eDP-1
[492.219157] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.167s)
[492.228495] Starting dynamic subtest: pipe-D-eDP-1
[494.483240] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.261s)
[494.485155] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.166s)
[495.726765] [107/132] (534s left) vgem_basic (setversion)
[495.775038] Starting subtest: setversion
[495.779624] Subtest setversion: SUCCESS (0.000s)
[495.832535] [108/132] (534s left) kms_content_protection (uevent-hdcp14)
[495.992844] Starting subtest: uevent-hdcp14
[495.998395] Subtest uevent-hdcp14: SKIP (0.000s)
[496.110898] [109/132] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[496.216689] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[496.221025] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[496.328486] [110/132] (534s left) kms_psr (psr-sprite-blt)
[496.421473] Starting subtest: psr-sprite-blt
[496.423731] Starting dynamic subtest: eDP-1
[498.168016] Dynamic subtest eDP-1: SUCCESS (1.746s)
[498.170361] Subtest psr-sprite-blt: SUCCESS (1.747s)
[498.998493] [111/132] (531s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[499.075589] Starting subtest: y-tiled-to-vebox-y-tiled
[499.080130] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[499.259731] [112/132] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[499.366870] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[506.016523] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.650s)
[506.168534] [113/132] (524s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[506.248366] Starting subtest: modeset-transition-nonblocking-fencing
[506.250359] Starting dynamic subtest: 1x-outputs
[517.362317] Dynamic subtest 1x-outputs: SUCCESS (11.114s)
[517.365039] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.115s)
[518.227856] [114/132] (512s left) gem_eio (kms)
[518.501190] Starting subtest: kms
[538.293124] Subtest kms: SUCCESS (19.792s)
[539.470791] [115/132] (491s left) kms_psr (psr2-sprite-mmap-gtt)
[539.560121] Starting subtest: psr2-sprite-mmap-gtt
[539.562513] Starting dynamic subtest: eDP-1
[540.964022] Dynamic subtest eDP-1: SKIP (1.400s)
[540.968878] Subtest psr2-sprite-mmap-gtt: SKIP (1.402s)
[541.117019] [116/132] (489s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[541.211242] Starting subtest: nonblocking-crc-frame-sequence
[541.213481] Starting dynamic subtest: pipe-A-eDP-1
[541.956735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s)
[541.967822] Starting dynamic subtest: pipe-B-eDP-1
[543.403898] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[543.414565] Starting dynamic subtest: pipe-C-eDP-1
[544.815511] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.412s)
[544.826613] Starting dynamic subtest: pipe-D-eDP-1
[546.224769] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.407s)
[546.226833] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.014s)
[547.023093] [117/132] (483s left) gem_userptr_blits (access-control)
[547.094918] Starting subtest: access-control
[547.099149] Subtest access-control: SKIP (0.000s)
[547.213500] [118/132] (483s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[547.294363] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[547.298171] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[547.366522] [119/132] (483s left) kms_psr (psr2-cursor-blt)
[547.469041] Starting subtest: psr2-cursor-blt
[547.471345] Starting dynamic subtest: eDP-1
[549.181120] Dynamic subtest eDP-1: SUCCESS (1.713s)
[549.183370] Subtest psr2-cursor-blt: SUCCESS (1.715s)
[549.986505] [120/132] (480s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[550.091180] Starting subtest: fbcpsr-rgb565-draw-pwrite
[557.110515] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.022s)
[557.223462] [121/132] (473s left) vgem_basic (mmap)
[557.275878] Starting subtest: mmap
[557.281206] Subtest mmap: SUCCESS (0.007s)
[557.333841] [122/132] (473s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[557.432146] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[557.436386] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[557.531848] [123/132] (473s left) syncobj_timeline (wait-all-delayed-signal)
[557.584453] Starting subtest: wait-all-delayed-signal
[557.685782] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[557.778481] [124/132] (473s left) gem_userptr_blits (invalid-null-pointer)
[557.828772] Starting subtest: invalid-null-pointer
[557.831026] Subtest invalid-null-pointer: SUCCESS (0.001s)
[557.964472] [125/132] (473s left) kms_prime (basic-crc-hybrid)
[558.044536] Subtest basic-crc-hybrid: SKIP (0.000s)
[558.150875] [126/132] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[558.251542] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[558.254953] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[558.350311] [127/132] (472s left) gem_exec_reloc (basic-cpu-read-noreloc)
[558.409013] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[558.472548] [128/132] (472s left) prime_vgem (wait)
[558.552261] Starting subtest: wait
[558.554319] Starting dynamic subtest: rcs0
[558.592470] Dynamic subtest rcs0: SUCCESS (0.040s)
[558.602635] Starting dynamic subtest: bcs0
[558.649026] Dynamic subtest bcs0: SUCCESS (0.055s)
[558.658736] Starting dynamic subtest: vcs0
[558.693982] Dynamic subtest vcs0: SUCCESS (0.044s)
[558.703614] Starting dynamic subtest: vcs1
[558.742094] Dynamic subtest vcs1: SUCCESS (0.047s)
[558.751513] Starting dynamic subtest: vecs0
[558.785648] Dynamic subtest vecs0: SUCCESS (0.043s)
[558.795144] Starting dynamic subtest: ccs0
[558.834222] Dynamic subtest ccs0: SUCCESS (0.047s)
[558.836157] Subtest wait: SUCCESS (0.283s)
[558.969570] [129/132] (472s left) kms_cursor_crc (cursor-sliding-512x170)
[559.295577] Starting subtest: cursor-sliding-512x170
[559.299236] Subtest cursor-sliding-512x170: SKIP (0.001s)
[559.441668] [130/132] (471s left) kms_color (legacy-gamma-reset)
[559.524652] Starting subtest: legacy-gamma-reset
[559.526462] Starting dynamic subtest: pipe-A-eDP-1
[559.897107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s)
[559.907146] Starting dynamic subtest: pipe-B-eDP-1
[559.911847] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[559.921971] Starting dynamic subtest: pipe-C-eDP-1
[559.924298] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[559.934071] Starting dynamic subtest: pipe-D-eDP-1
[559.936674] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[559.939030] Subtest legacy-gamma-reset: SUCCESS (0.413s)
[560.744164] [131/132] (470s left) syncobj_wait (reset-multiple-signaled)
[560.810524] Starting subtest: reset-multiple-signaled
[560.812514] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[560.930456] [132/132] (470s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[561.026198] Starting subtest: psr-rgb101010-draw-pwrite
[568.756586] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.734s)
[568.880330] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: gem_wait
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_getfb
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: kms_chamelium_frames
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: gem_exec_whisper
results: parsing output: 20/ for test: dmabuf_sync_file
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: gem_ctx_exec
results: parsing output: 24/ for test: i915_pm_rps
results: parsing output: 25/ for test: gem_ctx_param
results: parsing output: 26/ for test: kms_rotation_crc
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_sequence
results: parsing output: 29/ for test: kms_plane_multiple
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_exec_store
results: parsing output: 32/ for test: prime_vgem
results: parsing output: 33/ for test: kms_busy
results: parsing output: 34/ for test: sysfs_heartbeat_interval
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: gem_pread
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_pm_backlight
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_hdr
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: gem_workarounds
results: parsing output: 54/ for test: gem_mmap_offset
results: parsing output: 55/ for test: gem_ctx_engines
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_ccs
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gen9_exec_parse
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_draw_crc
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: prime_mmap
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_module_load
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_pm_backlight
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: gem_exec_create
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: vgem_basic
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_atomic_transition
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_pipe_crc_basic
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_prime
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: prime_vgem
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_color
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.