[58.381394] Initializing watchdogs
[58.381439]   /dev/watchdog0
[58.395770] [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]
[58.399918] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.402068] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.405522] [001/133] (960s left) gem_pxp (reject-modify-context-protection-on)
[58.559407] Starting subtest: reject-modify-context-protection-on
[58.561620] Subtest reject-modify-context-protection-on: SUCCESS (0.003s)
[58.698126] [002/133] (960s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[58.795702] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[59.186083] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[61.915964] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.719s)
[61.926037] Starting dynamic subtest: pipe-A-eDP-1-4
[64.098567] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.176s)
[64.107670] Starting dynamic subtest: pipe-A-eDP-1-4
[66.101970] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (1.999s)
[66.112247] Starting dynamic subtest: pipe-A-eDP-1-x
[68.285708] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.180s)
[68.647344] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[71.367419] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.720s)
[71.377214] Starting dynamic subtest: pipe-B-eDP-1-4
[73.545045] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.175s)
[73.554660] Starting dynamic subtest: pipe-B-eDP-1-4
[75.553780] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[75.563099] Starting dynamic subtest: pipe-B-eDP-1-x
[77.733715] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.179s)
[78.107403] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[80.898275] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[80.910274] Starting dynamic subtest: pipe-C-eDP-1-4
[83.074045] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[83.083779] Starting dynamic subtest: pipe-C-eDP-1-4
[85.083099] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[85.093602] Starting dynamic subtest: pipe-C-eDP-1-x
[87.274768] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[87.639621] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[90.421713] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[90.432199] Starting dynamic subtest: pipe-D-eDP-1-4
[92.597674] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[92.606936] Starting dynamic subtest: pipe-D-eDP-1-4
[94.606907] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[94.616596] Starting dynamic subtest: pipe-D-eDP-1-x
[96.787446] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[96.789448] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (37.952s)
[98.040900] [003/133] (920s left) i915_drm_fdinfo (basics)
[98.088188] Starting subtest: basics
[98.090540] Subtest basics: SUCCESS (0.000s)
[98.169934] [004/133] (920s left) kms_content_protection (dp-mst-lic-type-0)
[98.310596] Starting subtest: dp-mst-lic-type-0
[98.315977] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[98.461704] [005/133] (920s left) kms_big_fb (linear-16bpp-rotate-0)
[98.575240] Starting subtest: linear-16bpp-rotate-0
[100.019265] Subtest linear-16bpp-rotate-0: SUCCESS (1.444s)
[100.141719] [006/133] (918s left) syncobj_basic (test-valid-cycle)
[100.204630] Starting subtest: test-valid-cycle
[100.206391] Subtest test-valid-cycle: SUCCESS (0.000s)
[100.319833] [007/133] (918s left) sw_sync (timeline_closed_signaled)
[100.355451] Starting subtest: timeline_closed_signaled
[100.357261] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[100.425296] [008/133] (918s left) api_intel_bb (misplaced-blitter)
[100.472564] Starting subtest: misplaced-blitter
[100.480900] Subtest misplaced-blitter: SUCCESS (0.009s)
[100.624603] [009/133] (918s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[100.730047] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[100.741271] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[100.847037] [010/133] (918s left) gem_exec_balancer (full-late-pulse)
[100.911192] Starting subtest: full-late-pulse
[105.778875] Subtest full-late-pulse: SUCCESS (4.866s)
[106.119120] [011/133] (913s left) i915_drm_fdinfo (virtual-busy-idle)
[106.161722] Starting subtest: virtual-busy-idle
[106.166245] Subtest virtual-busy-idle: SKIP (0.000s)
[106.237174] [012/133] (913s left) gem_ctx_bad_destroy (double-destroy)
[106.301800] Starting subtest: double-destroy
[106.304106] Subtest double-destroy: SUCCESS (0.000s)
[106.398562] [013/133] (912s left) kms_plane_cursor (primary)
[106.505855] Starting subtest: primary
[106.510010] Starting dynamic subtest: pipe-A-eDP-1-size-64
[109.036185] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.530s)
[109.060506] Starting dynamic subtest: pipe-A-eDP-1-size-128
[111.637527] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[111.661290] Starting dynamic subtest: pipe-A-eDP-1-size-256
[114.193563] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[114.508576] Starting dynamic subtest: pipe-B-eDP-1-size-64
[117.798394] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.296s)
[117.821564] Starting dynamic subtest: pipe-B-eDP-1-size-128
[120.365229] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[120.391079] Starting dynamic subtest: pipe-B-eDP-1-size-256
[122.923243] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[123.241076] Starting dynamic subtest: pipe-C-eDP-1-size-64
[126.171145] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.941s)
[126.196828] Starting dynamic subtest: pipe-C-eDP-1-size-128
[128.360403] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.169s)
[128.384967] Starting dynamic subtest: pipe-C-eDP-1-size-256
[130.571305] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[130.892360] Starting dynamic subtest: pipe-D-eDP-1-size-64
[133.814476] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.929s)
[133.839691] Starting dynamic subtest: pipe-D-eDP-1-size-128
[136.003639] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s)
[136.028863] Starting dynamic subtest: pipe-D-eDP-1-size-256
[138.203243] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[138.511180] Subtest primary: SUCCESS (32.002s)
[139.363108] [014/133] (880s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[139.428578] Starting subtest: rel-constants-invalid-rel-gen5
[139.430977] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[139.552427] [015/133] (879s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[139.647975] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[139.652477] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[140.791847] [016/133] (878s left) syncobj_timeline (single-wait-available-submitted)
[140.845678] Starting subtest: single-wait-available-submitted
[140.847692] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[140.953938] [017/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[141.043523] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[148.287948] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.245s)
[148.454618] [018/133] (871s left) gem_ctx_engines (execute-oneforall)
[148.532529] Starting subtest: execute-oneforall
[149.066231] Subtest execute-oneforall: SUCCESS (0.533s)
[150.049370] [019/133] (869s left) kms_force_connector_basic (force-edid)
[150.126398] Starting subtest: force-edid
[150.496610] Subtest force-edid: SUCCESS (0.370s)
[150.654581] [020/133] (868s left) syncobj_wait (single-wait-submitted)
[150.714516] Starting subtest: single-wait-submitted
[150.816493] Subtest single-wait-submitted: SUCCESS (0.103s)
[150.900836] [021/133] (868s left) gem_mmap_gtt (cpuset-basic-small-copy)
[150.968162] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[151.031267] [022/133] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[151.131032] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[157.531941] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.403s)
[157.656162] [023/133] (862s left) kms_pm_lpsp (screens-disabled)
[158.761623] Starting subtest: screens-disabled
[158.765848] Subtest screens-disabled: SKIP (0.000s)
[158.843187] [024/133] (860s left) kms_plane (pixel-format-4-tiled-modifier)
[158.946228] Starting subtest: pixel-format-4-tiled-modifier
[158.974053] Starting dynamic subtest: pipe-A-plane-0
[159.606696] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[159.615079] Starting dynamic subtest: pipe-A-plane-3
[160.006745] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[160.014138] Starting dynamic subtest: pipe-A-plane-5
[160.017554] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[161.110153] Starting dynamic subtest: pipe-B-plane-0
[161.771357] Dynamic subtest pipe-B-plane-0: SUCCESS (0.667s)
[161.779106] Starting dynamic subtest: pipe-B-plane-3
[162.194696] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[162.202162] Starting dynamic subtest: pipe-B-plane-5
[162.205857] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[162.505083] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.559s)
[163.369613] [025/133] (856s left) kms_addfb_basic (bad-pitch-999)
[163.432212] Starting subtest: bad-pitch-999
[163.434388] Subtest bad-pitch-999: SUCCESS (0.000s)
[163.571122] [026/133] (856s left) perf_pmu (init-sema)
[163.610914] Starting subtest: init-sema
[163.613220] Starting dynamic subtest: rcs0
[163.615407] Dynamic subtest rcs0: SUCCESS (0.002s)
[163.623236] Starting dynamic subtest: bcs0
[163.625411] Dynamic subtest bcs0: SUCCESS (0.000s)
[163.633069] Starting dynamic subtest: vcs0
[163.635219] Dynamic subtest vcs0: SUCCESS (0.001s)
[163.642668] Starting dynamic subtest: vcs1
[163.644967] Dynamic subtest vcs1: SUCCESS (0.001s)
[163.652197] Starting dynamic subtest: vecs0
[163.654391] Dynamic subtest vecs0: SUCCESS (0.000s)
[163.661279] Starting dynamic subtest: ccs0
[163.663123] Dynamic subtest ccs0: SUCCESS (0.000s)
[163.664999] Subtest init-sema: SUCCESS (0.007s)
[163.708248] [027/133] (856s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[164.119748] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[164.932517] [028/133] (854s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[165.052275] Starting subtest: flip-vs-cursor-toggle
[173.499492] Subtest flip-vs-cursor-toggle: SUCCESS (8.446s)
[174.358122] [029/133] (845s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[174.424781] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[174.511709] [030/133] (845s left) kms_vblank (ts-continuation-idle-hang)
[174.598257] Starting subtest: ts-continuation-idle-hang
[174.600480] Starting dynamic subtest: pipe-A-eDP-1
[200.675622] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.076s)
[200.689141] Starting dynamic subtest: pipe-D-eDP-1
[215.643594] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.963s)
[215.646074] Subtest ts-continuation-idle-hang: SUCCESS (41.043s)
[216.460054] [031/133] (803s left) kms_cursor_crc (cursor-random-128x42)
[216.699156] Starting subtest: cursor-random-128x42
[216.744714] Subtest cursor-random-128x42: SKIP (0.043s)
[216.971908] [032/133] (803s left) kms_psr (psr-sprite-blt)
[217.076186] Starting subtest: psr-sprite-blt
[217.078502] Starting dynamic subtest: eDP-1
[218.845112] Dynamic subtest eDP-1: SUCCESS (1.769s)
[218.847257] Subtest psr-sprite-blt: SUCCESS (1.770s)
[219.664537] [033/133] (800s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[219.767678] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[219.772084] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[219.840364] [034/133] (800s left) gem_exec_reloc (basic-write-cpu-active)
[219.896205] Subtest basic-write-cpu-active: SKIP (0.000s)
[219.966666] [035/133] (800s left) syncobj_timeline (invalid-signal-illegal-point)
[220.034693] Starting subtest: invalid-signal-illegal-point
[220.036645] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[220.161266] [036/133] (800s left) gem_ctx_persistence (heartbeat-many)
[220.232981] Starting subtest: heartbeat-many
[220.237523] Subtest heartbeat-many: SKIP (0.000s)
[220.359922] [037/133] (799s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[220.453890] Starting subtest: primary-y-tiled-reflect-x-90
[220.458117] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[220.533283] [038/133] (799s left) kms_flip (blocking-absolute-wf_vblank)
[220.628688] Starting subtest: blocking-absolute-wf_vblank
[220.630475] Starting dynamic subtest: A-eDP1
[229.422540] Dynamic subtest A-eDP1: SUCCESS (8.756s)
[229.431687] Starting dynamic subtest: B-eDP1
[238.119719] Dynamic subtest B-eDP1: SUCCESS (8.694s)
[238.129752] Starting dynamic subtest: C-eDP1
[246.811810] Dynamic subtest C-eDP1: SUCCESS (8.680s)
[246.822072] Starting dynamic subtest: D-eDP1
[255.514954] Dynamic subtest D-eDP1: SUCCESS (8.698s)
[255.517953] Subtest blocking-absolute-wf_vblank: SUCCESS (34.841s)
[256.678142] [039/133] (763s left) i915_pm_rpm (system-suspend)
[258.208640] Starting subtest: system-suspend
[275.711678] Subtest system-suspend: SUCCESS (2.964s)
[276.126422] [040/133] (744s left) kms_cursor_legacy (forked-bo)
[276.261999] Starting subtest: forked-bo
[276.264055] Starting dynamic subtest: pipe-A
[281.871995] Dynamic subtest pipe-A: SUCCESS (5.467s)
[281.881697] Starting dynamic subtest: pipe-B
[287.381679] Dynamic subtest pipe-B: SUCCESS (5.468s)
[287.390899] Starting dynamic subtest: pipe-C
[292.873433] Dynamic subtest pipe-C: SUCCESS (5.465s)
[292.891518] Starting dynamic subtest: pipe-D
[298.353605] Dynamic subtest pipe-D: SUCCESS (5.465s)
[298.364266] Starting dynamic subtest: all-pipes
[303.834777] Dynamic subtest all-pipes: SUCCESS (5.474s)
[303.837173] Subtest forked-bo: SUCCESS (27.350s)
[303.953328] [041/133] (716s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[304.055140] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[304.057476] Starting dynamic subtest: pipe-A
[304.075728] Dynamic subtest pipe-A: SKIP (0.017s)
[304.085213] Starting dynamic subtest: pipe-B
[304.105990] Dynamic subtest pipe-B: SKIP (0.029s)
[304.114459] Starting dynamic subtest: pipe-C
[304.135456] Dynamic subtest pipe-C: SKIP (0.029s)
[304.143955] Starting dynamic subtest: pipe-D
[304.162042] Dynamic subtest pipe-D: SKIP (0.028s)
[304.165873] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.105s)
[304.298476] [042/133] (716s left) gem_render_copy_redux (flink)
[304.372800] Starting subtest: flink
[305.137004] Subtest flink: SUCCESS (0.764s)
[305.306904] [043/133] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[305.404891] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[305.408731] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.539290] [044/133] (715s left) prime_mmap (test_userptr)
[305.598540] Starting subtest: test_userptr
[305.600656] Starting dynamic subtest: test_userptr-smem
[305.602721] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[305.604716] Subtest test_userptr: SUCCESS (0.001s)
[305.737723] [045/133] (714s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[305.797280] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[305.903050] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[305.991662] [046/133] (714s left) core_auth (many-magics)
[306.042779] Starting subtest: many-magics
[306.839392] Subtest many-magics: SUCCESS (0.799s)
[307.070040] [047/133] (713s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[307.143460] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[307.246489] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[307.331687] [048/133] (713s left) kms_cursor_crc (cursor-sliding-max-size)
[307.638817] Starting subtest: cursor-sliding-max-size
[307.645648] Subtest cursor-sliding-max-size: SKIP (0.000s)
[307.823850] [049/133] (712s left) syncobj_wait (wait-all-for-submit-snapshot)
[307.892168] Starting subtest: wait-all-for-submit-snapshot
[307.971599] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[308.058185] [050/133] (712s left) kms_invalid_mode (zero-vdisplay)
[308.157815] Starting subtest: zero-vdisplay
[308.160183] Starting dynamic subtest: pipe-A-eDP-1
[308.451006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[308.460995] Starting dynamic subtest: pipe-B-eDP-1
[308.463359] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[308.471613] Starting dynamic subtest: pipe-C-eDP-1
[308.474044] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[308.481920] Starting dynamic subtest: pipe-D-eDP-1
[308.483954] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[308.485909] Subtest zero-vdisplay: SUCCESS (0.300s)
[309.252616] [051/133] (711s left) gem_userptr_blits (huge-split)
[309.326610] Starting subtest: huge-split
[309.330494] Subtest huge-split: SUCCESS (0.007s)
[309.489717] [052/133] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[309.589995] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[309.594211] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[309.708466] [053/133] (711s left) gem_ctx_create (basic)
[309.774977] Starting subtest: basic
[309.777471] Subtest basic: SUCCESS (0.000s)
[309.970738] [054/133] (711s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[310.072772] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[311.074182] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.000s)
[311.251469] [055/133] (709s left) kms_lease (setcrtc-implicit-plane)
[311.354812] Starting subtest: setcrtc-implicit-plane
[311.356776] Starting dynamic subtest: pipe-A-eDP-1
[311.836207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s)
[311.845573] Starting dynamic subtest: pipe-B-eDP-1
[312.956389] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.118s)
[312.970097] Starting dynamic subtest: pipe-C-eDP-1
[314.065008] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[314.074415] Starting dynamic subtest: pipe-D-eDP-1
[315.145755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.078s)
[315.148154] Subtest setcrtc-implicit-plane: SUCCESS (3.792s)
[315.961706] [056/133] (705s left) kms_psr (pr-sprite-mmap-cpu)
[316.061852] Starting subtest: pr-sprite-mmap-cpu
[316.066057] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[316.154313] [057/133] (704s left) perf (gen12-unprivileged-single-ctx-counters)
[316.275021] Starting subtest: gen12-unprivileged-single-ctx-counters
[316.276963] Starting dynamic subtest: rcs0
[316.310596] Dynamic subtest rcs0: SUCCESS (0.038s)
[316.312777] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.039s)
[316.368094] [058/133] (704s left) gem_lmem_swapping (heavy-verify-random)
[316.406267] Subtest heavy-verify-random: SKIP (0.000s)
[316.456870] [059/133] (704s left) gem_busy (close-race)
[316.558574] Starting subtest: close-race
[340.442069] Subtest close-race: SUCCESS (23.877s)
[340.843408] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[340.848723] [060/133] (680s left) gem_exec_balancer (parallel-out-fence)
[341.149141] Starting subtest: parallel-out-fence
[342.200187] Subtest parallel-out-fence: SUCCESS (1.050s)
[342.334995] [061/133] (678s left) gem_ctx_shared (q-smoketest-all)
[342.411008] Starting subtest: Q-smoketest-all
[374.811819] Subtest Q-smoketest-all: SUCCESS (32.343s)
[376.544100] [062/133] (644s left) kms_psr (fbc-pr-primary-blt)
[376.654950] Starting subtest: fbc-pr-primary-blt
[376.659101] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[376.739909] [063/133] (644s left) api_intel_allocator (fork-simple-once)
[376.805971] Starting subtest: fork-simple-once
[376.817648] Subtest fork-simple-once: SUCCESS (0.014s)
[376.951958] [064/133] (644s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[377.048323] Starting subtest: flip-vs-dpms-on-nop-interruptible
[377.050660] Starting dynamic subtest: A-eDP1
[378.921468] Dynamic subtest A-eDP1: SUCCESS (1.873s)
[378.936324] Starting dynamic subtest: B-eDP1
[380.731749] Dynamic subtest B-eDP1: SUCCESS (1.808s)
[380.741813] Starting dynamic subtest: C-eDP1
[382.615979] Dynamic subtest C-eDP1: SUCCESS (1.883s)
[382.627381] Starting dynamic subtest: D-eDP1
[384.404989] Dynamic subtest D-eDP1: SUCCESS (1.789s)
[384.409730] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.362s)
[385.691080] [065/133] (635s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[385.798332] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[385.802909] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[385.913719] [066/133] (635s left) kms_selftest (drm_format)
[385.957091] Starting subtest: drm_format
[386.001970] Starting dynamic subtest: drm_test_format_block_width_invalid
[386.134899] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.130s)
[386.144586] Starting dynamic subtest: drm_test_format_block_width_one_plane
[386.264985] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.128s)
[386.275036] Starting dynamic subtest: drm_test_format_block_width_two_plane
[386.413732] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.149s)
[386.423339] Starting dynamic subtest: drm_test_format_block_width_three_plane
[386.560992] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.145s)
[386.569690] Starting dynamic subtest: drm_test_format_block_width_tiled
[386.708688] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.147s)
[386.717529] Starting dynamic subtest: drm_test_format_block_height_invalid
[386.861993] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.153s)
[386.871018] Starting dynamic subtest: drm_test_format_block_height_one_plane
[386.973318] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.112s)
[386.982012] Starting dynamic subtest: drm_test_format_block_height_two_plane
[387.076809] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.102s)
[387.085811] Starting dynamic subtest: drm_test_format_block_height_three_plane
[387.177886] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.100s)
[387.186706] Starting dynamic subtest: drm_test_format_block_height_tiled
[387.328376] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.150s)
[387.337196] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[387.459094] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.128s)
[387.468194] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[387.610334] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.152s)
[387.619079] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[387.742710] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.132s)
[387.752284] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[387.830988] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.088s)
[387.840026] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[387.956555] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.125s)
[387.965305] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[388.044146] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.088s)
[388.052985] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[388.178635] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.130s)
[388.187649] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[388.302579] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.124s)
[388.304488] Subtest drm_format: SUCCESS (2.344s)
[388.516293] [067/133] (633s left) gem_exec_schedule (deep)
[388.705690] Starting subtest: deep
[388.708010] Starting dynamic subtest: rcs0
[394.820601] Dynamic subtest rcs0: SKIP (6.113s)
[394.831475] Starting dynamic subtest: vcs0
[404.878821] Dynamic subtest vcs0: SUCCESS (10.059s)
[404.889307] Starting dynamic subtest: vcs1
[416.000391] Dynamic subtest vcs1: SUCCESS (11.119s)
[416.012597] Starting dynamic subtest: vecs0
[426.778506] Dynamic subtest vecs0: SUCCESS (10.775s)
[426.789211] Starting dynamic subtest: ccs0
[439.077294] Dynamic subtest ccs0: SUCCESS (12.294s)
[439.079778] Subtest deep: SUCCESS (50.364s)
[440.965343] [068/133] (580s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[441.073764] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[441.075973] Starting dynamic subtest: pipe-A
[442.305490] Dynamic subtest pipe-A: SUCCESS (1.233s)
[442.314597] Starting dynamic subtest: pipe-B
[444.562744] Dynamic subtest pipe-B: SUCCESS (2.256s)
[444.572050] Starting dynamic subtest: pipe-C
[445.784157] Dynamic subtest pipe-C: SUCCESS (1.220s)
[445.794732] Starting dynamic subtest: pipe-D
[446.994656] Dynamic subtest pipe-D: SUCCESS (1.209s)
[446.996898] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.922s)
[448.166904] [069/133] (573s left) gem_exec_flush (basic-batch-kernel-default-wb)
[448.250341] Starting subtest: basic-batch-kernel-default-wb
[455.414682] Subtest basic-batch-kernel-default-wb: SUCCESS (7.163s)
[455.621430] [070/133] (566s left) gem_mmap_wc (bad-object)
[455.677313] Subtest bad-object: SKIP (0.000s)
[455.739790] [071/133] (565s left) gem_basic (create-close)
[455.799659] Starting subtest: create-close
[455.803907] Subtest create-close: SUCCESS (0.000s)
[455.921039] [072/133] (565s left) gem_mmap_offset (partial-unmap)
[455.980382] Starting subtest: partial-unmap
[455.982696] Starting dynamic subtest: smem0
[456.483571] Dynamic subtest smem0: SUCCESS (0.503s)
[456.486284] Subtest partial-unmap: SUCCESS (0.504s)
[456.617316] [073/133] (565s left) gem_bad_reloc (negative-reloc-lut)
[456.687861] Subtest negative-reloc-lut: SKIP (0.000s)
[456.750546] [074/133] (565s left) gem_tiled_partial_pwrite_pread (writes)
[456.817343] Subtest writes: SKIP (0.000s)
[456.907341] [075/133] (564s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[457.013644] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[463.641437] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.629s)
[463.767766] [076/133] (558s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[463.873735] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[463.877849] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[463.994691] [077/133] (557s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[464.085172] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[464.087188] Starting dynamic subtest: pipe-A-eDP-1
[464.229751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[464.242054] Starting dynamic subtest: pipe-B-eDP-1
[464.262089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[464.277004] Starting dynamic subtest: pipe-C-eDP-1
[464.296474] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[464.304943] Starting dynamic subtest: pipe-D-eDP-1
[464.324355] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[464.326282] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.168s)
[466.485818] [078/133] (555s left) kms_pm_rpm (modeset-stress-extra-wait)
[468.639408] Starting subtest: modeset-stress-extra-wait
[522.986188] Subtest modeset-stress-extra-wait: SUCCESS (54.294s)
[523.049708] [079/133] (498s left) kms_atomic (plane-immutable-zpos)
[523.131569] Starting subtest: plane-immutable-zpos
[523.134006] Starting dynamic subtest: pipe-A-eDP-1
[523.752955] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[523.755364] Subtest plane-immutable-zpos: SUCCESS (0.622s)
[524.564769] [080/133] (497s left) syncobj_timeline (reset-unsignaled)
[524.626707] Starting subtest: reset-unsignaled
[524.628891] Subtest reset-unsignaled: SUCCESS (0.000s)
[524.746584] [081/133] (497s left) kms_color (gamma)
[524.853135] Starting subtest: gamma
[524.855307] Starting dynamic subtest: pipe-A-eDP-1
[525.572329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[525.584009] Starting dynamic subtest: pipe-B-eDP-1
[527.028405] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.454s)
[527.038435] Starting dynamic subtest: pipe-C-eDP-1
[528.351541] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.325s)
[528.362173] Starting dynamic subtest: pipe-D-eDP-1
[529.645175] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s)
[529.647561] Subtest gamma: SUCCESS (4.793s)
[530.461399] [082/133] (491s left) gem_pipe_control_store_loop (reused-buffer)
[530.539138] Starting subtest: reused-buffer
[532.745614] Subtest reused-buffer: SUCCESS (2.152s)
[532.835629] [083/133] (489s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[533.424644] Starting subtest: syncobj-backward-timeline-chain-engines
[533.578369] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.154s)
[534.545798] [084/133] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[534.668189] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[534.672200] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[534.803896] [085/133] (487s left) kms_cursor_crc (cursor-dpms)
[534.930883] Starting subtest: cursor-dpms
[534.933004] Starting dynamic subtest: pipe-A-eDP-1
[537.960901] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.030s)
[537.973254] Starting dynamic subtest: pipe-D-eDP-1
[541.537598] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.574s)
[541.539968] Subtest cursor-dpms: SUCCESS (6.607s)
[542.360992] [086/133] (479s left) gen9_exec_parse (bb-oversize)
[542.433836] Subtest bb-oversize: SKIP (0.000s)
[542.503761] [087/133] (479s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[542.609016] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[542.611279] Starting dynamic subtest: pipe-A-eDP-1
[542.633916] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[542.645261] Starting dynamic subtest: pipe-B-eDP-1
[542.666518] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[542.675515] Starting dynamic subtest: pipe-C-eDP-1
[542.695995] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[542.704917] Starting dynamic subtest: pipe-D-eDP-1
[542.725543] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[542.729729] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[544.869768] [088/133] (477s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[544.976947] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[544.979219] Starting dynamic subtest: pipe-A-eDP-1
[545.040928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[545.336414] Starting dynamic subtest: pipe-B-eDP-1
[546.130238] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.805s)
[546.418369] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.439s)
[547.263911] [089/133] (475s left) gem_exec_whisper (basic-queues)
[547.331880] Starting subtest: basic-queues
[553.404226] Subtest basic-queues: SUCCESS (6.069s)
[553.604115] [090/133] (468s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[553.713038] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[553.860510] [091/133] (468s left) gem_eio (wait-immediate)
[554.084659] Starting subtest: wait-immediate
[554.469556] Subtest wait-immediate: SUCCESS (0.385s)
[554.653241] [092/133] (467s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[555.028154] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[555.827660] [093/133] (466s left) gem_spin_batch (spin-all-new)
[555.886784] Starting subtest: spin-all-new
[555.900136] Subtest spin-all-new: SUCCESS (0.014s)
[557.520529] [094/133] (465s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[557.622606] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[566.834997] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.214s)
[566.988176] [095/133] (455s left) kms_flip (dpms-off-confusion)
[567.076348] Starting subtest: dpms-off-confusion
[567.078754] Starting dynamic subtest: A-eDP1
[575.756228] Dynamic subtest A-eDP1: SUCCESS (8.646s)
[575.772988] Starting dynamic subtest: B-eDP1
[584.454631] Dynamic subtest B-eDP1: SUCCESS (8.696s)
[584.466231] Starting dynamic subtest: C-eDP1
[593.151512] Dynamic subtest C-eDP1: SUCCESS (8.684s)
[593.163755] Starting dynamic subtest: D-eDP1
[601.854409] Dynamic subtest D-eDP1: SUCCESS (8.695s)
[601.856818] Subtest dpms-off-confusion: SUCCESS (34.730s)
[603.072943] [096/133] (419s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[603.171153] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[603.175557] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[603.307146] [097/133] (419s left) gem_exec_schedule (noreorder-priority)
[603.480551] Starting subtest: noreorder-priority
[603.483007] Starting dynamic subtest: rcs0
[604.631174] Dynamic subtest rcs0: SUCCESS (1.151s)
[604.644791] Starting dynamic subtest: vcs0
[606.408767] Dynamic subtest vcs0: SUCCESS (1.774s)
[606.421878] Starting dynamic subtest: vcs1
[608.433362] Dynamic subtest vcs1: SUCCESS (2.022s)
[608.446041] Starting dynamic subtest: vecs0
[610.473612] Dynamic subtest vecs0: SUCCESS (2.037s)
[610.486756] Starting dynamic subtest: ccs0
[611.627814] Dynamic subtest ccs0: SUCCESS (1.153s)
[611.630522] Subtest noreorder-priority: SUCCESS (8.148s)
[611.839498] [098/133] (410s left) vgem_basic (bad-flag)
[611.891232] Starting subtest: bad-flag
[611.893169] Subtest bad-flag: SUCCESS (0.000s)
[611.959528] [099/133] (410s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[612.015032] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[612.017215] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[612.155474] [100/133] (410s left) kms_psr (fbc-psr-primary-mmap-gtt)
[612.258817] Starting subtest: fbc-psr-primary-mmap-gtt
[612.261110] Starting dynamic subtest: eDP-1
[612.265320] Dynamic subtest eDP-1: SKIP (0.000s)
[612.269576] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[612.360021] [101/133] (410s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[612.464619] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[612.468695] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[612.577430] [102/133] (410s left) gem_ringfill (basic-all)
[618.461952] Starting subtest: basic-all
[619.622503] Subtest basic-all: SUCCESS (1.160s)
[619.775152] [103/133] (403s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[619.877904] Starting subtest: x-tiled-32bpp-rotate-270
[619.897484] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[620.078813] [104/133] (403s left) prime_busy (before-wait)
[620.138241] Starting subtest: before-wait
[620.140542] Starting dynamic subtest: rcs0
[620.184277] Dynamic subtest rcs0: SUCCESS (0.046s)
[620.196385] Starting dynamic subtest: bcs0
[620.256958] Dynamic subtest bcs0: SUCCESS (0.071s)
[620.267778] Starting dynamic subtest: vcs0
[620.296704] Dynamic subtest vcs0: SUCCESS (0.039s)
[620.307656] Starting dynamic subtest: vcs1
[620.336619] Dynamic subtest vcs1: SUCCESS (0.039s)
[620.346556] Starting dynamic subtest: vecs0
[620.377164] Dynamic subtest vecs0: SUCCESS (0.040s)
[620.386809] Starting dynamic subtest: ccs0
[620.417500] Dynamic subtest ccs0: SUCCESS (0.039s)
[620.525324] Subtest before-wait: SUCCESS (0.388s)
[620.610591] [105/133] (402s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[620.722509] Starting subtest: cursorB-vs-flipB-varying-size
[620.727207] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[620.890258] [106/133] (402s left) drm_mm (drm_mm)
[620.929489] Starting subtest: drm_mm
[620.936855] Starting dynamic subtest: drm_test_mm_init
[621.022199] Dynamic subtest drm_test_mm_init: SUCCESS (0.085s)
[621.038828] Starting dynamic subtest: drm_test_mm_debug
[621.109193] Dynamic subtest drm_test_mm_debug: SUCCESS (0.087s)
[621.118740] Starting dynamic subtest: drm_test_mm_align32
[621.239275] Dynamic subtest drm_test_mm_align32: SUCCESS (0.129s)
[621.248401] Starting dynamic subtest: drm_test_mm_align64
[621.349409] Dynamic subtest drm_test_mm_align64: SUCCESS (0.109s)
[621.358589] Starting dynamic subtest: drm_test_mm_lowest
[621.480544] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.128s)
[621.489781] Starting dynamic subtest: drm_test_mm_highest
[621.581308] Dynamic subtest drm_test_mm_highest: SUCCESS (0.101s)
[621.583496] Subtest drm_mm: SUCCESS (0.651s)
[621.791170] [107/133] (401s left) i915_query (engine-info-invalid)
[621.852610] Starting subtest: engine-info-invalid
[621.854972] Subtest engine-info-invalid: SUCCESS (0.000s)
[621.974755] [108/133] (401s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[622.074604] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[628.462167] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.389s)
[628.623668] [109/133] (394s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[628.745204] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[629.705205] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.957s)
[630.558159] [110/133] (392s left) kms_feature_discovery (display-2x)
[630.660987] Starting subtest: display-2x
[630.665364] Subtest display-2x: SKIP (0.000s)
[630.748144] [111/133] (392s left) gem_ctx_isolation (dirty-create)
[630.803457] Starting subtest: dirty-create
[630.805812] Starting dynamic subtest: rcs0
[630.984754] Dynamic subtest rcs0: SUCCESS (0.181s)
[630.996068] Starting dynamic subtest: bcs0
[631.196640] Dynamic subtest bcs0: SUCCESS (0.210s)
[631.208513] Starting dynamic subtest: vcs0
[631.417195] Dynamic subtest vcs0: SUCCESS (0.220s)
[631.428649] Starting dynamic subtest: vcs1
[632.669868] Dynamic subtest vcs1: SUCCESS (1.252s)
[632.681322] Starting dynamic subtest: vecs0
[634.690523] Dynamic subtest vecs0: SUCCESS (2.019s)
[634.701356] Starting dynamic subtest: ccs0
[636.682471] Dynamic subtest ccs0: SUCCESS (1.991s)
[636.684928] Subtest dirty-create: SUCCESS (5.879s)
[636.963092] [112/133] (386s left) gem_tiled_wb
[637.092463] [113/133] (386s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[637.185887] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[637.189798] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[637.270317] [114/133] (386s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[637.356108] Starting subtest: crc-primary-suspend-y-tiled-ccs
[637.358317] Starting dynamic subtest: pipe-A-eDP-1
[637.367309] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[637.378226] Starting dynamic subtest: pipe-B-eDP-1
[637.387248] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[637.396963] Starting dynamic subtest: pipe-C-eDP-1
[637.405742] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[637.415196] Starting dynamic subtest: pipe-D-eDP-1
[637.423855] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[637.428135] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[639.555707] [115/133] (383s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[639.650524] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[639.654976] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[639.772783] [116/133] (383s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[639.871468] Starting subtest: pr-overlay-plane-move-continuous-sf
[639.875555] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[639.952540] [117/133] (383s left) gem_exec_flush (basic-wb-rw-default)
[640.015065] Starting subtest: basic-wb-rw-default
[645.501595] Subtest basic-wb-rw-default: SUCCESS (5.449s)
[645.670496] [118/133] (377s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[645.782814] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[645.786978] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[645.919130] [119/133] (377s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[646.039742] Starting subtest: cursor-vs-flip-atomic-transitions
[675.899799] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.854s)
[676.748510] [120/133] (346s left) gem_softpin (invalid)
[676.816123] Starting subtest: invalid
[676.823877] Subtest invalid: SUCCESS (0.006s)
[676.979624] [121/133] (346s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[677.078242] Starting subtest: stress-xrgb8888-4tiled
[682.863456] Subtest stress-xrgb8888-4tiled: SUCCESS (5.785s)
[682.914692] [122/133] (340s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[683.035895] Starting subtest: 2x-long-flip-vs-cursor-atomic
[683.039535] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[683.203907] [123/133] (340s left) sw_sync (sync_merge_same)
[683.237829] Starting subtest: sync_merge_same
[683.239592] Subtest sync_merge_same: SUCCESS (0.000s)
[683.312451] [124/133] (340s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[683.413042] Starting subtest: y-tiled-16bpp-rotate-90
[683.416678] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[683.543668] [125/133] (340s left) kms_chamelium_color (ctm-negative)
[683.635839] Subtest ctm-negative: SKIP (0.000s)
[683.679297] [126/133] (340s left) gem_exec_flush (basic-wb-prw-default)
[683.738384] Starting subtest: basic-wb-prw-default
[689.223923] Subtest basic-wb-prw-default: SUCCESS (5.474s)
[689.413987] [127/133] (334s left) kms_psr (fbc-psr2-primary-page-flip)
[689.514824] Starting subtest: fbc-psr2-primary-page-flip
[689.517000] Starting dynamic subtest: eDP-1
[689.521046] Dynamic subtest eDP-1: SKIP (0.000s)
[689.525041] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[689.607172] [128/133] (334s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[689.704126] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[696.455323] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.752s)
[696.615147] [129/133] (327s left) gem_exec_schedule (u-semaphore-codependency)
[696.696039] Starting subtest: u-semaphore-codependency
[696.701193] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[697.079667] [130/133] (327s left) gem_create (create-invalid-size)
[697.142790] Starting subtest: create-invalid-size
[697.144628] Subtest create-invalid-size: SUCCESS (0.000s)
[697.342777] [131/133] (326s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[697.447117] Starting subtest: yf-tiled-16bpp-rotate-90
[697.451625] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[697.582163] [132/133] (326s left) kms_psr (psr2-primary-render)
[697.671971] Starting subtest: psr2-primary-render
[697.674071] Starting dynamic subtest: eDP-1
[699.412217] Dynamic subtest eDP-1: SUCCESS (1.740s)
[699.414416] Subtest psr2-primary-render: SUCCESS (1.741s)
[700.266317] [133/133] (323s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[700.372676] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[700.377000] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[700.491602] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: kms_async_flips
results: parsing output: 2/ for test: i915_drm_fdinfo
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: syncobj_basic
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: api_intel_bb
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: gem_ctx_bad_destroy
results: parsing output: 12/ for test: kms_plane_cursor
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_ctx_engines
results: parsing output: 18/ for test: kms_force_connector_basic
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_pm_lpsp
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_fenced_exec_thrash
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: kms_rotation_crc
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: i915_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: gem_render_copy_redux
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: prime_mmap
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: core_auth
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_invalid_mode
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_ctx_create
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: gem_busy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: api_intel_allocator
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_selftest
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: gem_exec_flush
results: parsing output: 69/ for test: gem_mmap_wc
results: parsing output: 70/ for test: gem_basic
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: gem_bad_reloc
results: parsing output: 73/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_color
results: parsing output: 81/ for test: gem_pipe_control_store_loop
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gen9_exec_parse
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_atomic_transition
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ringfill
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: prime_busy
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: drm_mm
results: parsing output: 106/ for test: i915_query
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_feature_discovery
results: parsing output: 110/ for test: gem_ctx_isolation
results: parsing output: 111/ for test: gem_tiled_wb
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: gem_exec_flush
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: kms_pipe_stress
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: gem_exec_flush
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: gem_create
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_big_fb
Done.