[56.987253] Initializing watchdogs
[56.987338]   /dev/watchdog0
[57.000912] [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.005055] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.007164] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.010256] [001/133] (960s left) gem_pxp (reject-modify-context-protection-on)
[57.164037] Starting subtest: reject-modify-context-protection-on
[57.166398] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[57.265184] [002/133] (960s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[57.359158] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[57.730915] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[60.581122] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.812s)
[60.591807] Starting dynamic subtest: pipe-A-eDP-1-4
[62.754234] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.183s)
[62.765763] Starting dynamic subtest: pipe-A-eDP-1-4
[64.715262] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.018s)
[64.722969] Starting dynamic subtest: pipe-A-eDP-1-x
[66.939146] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[67.274422] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[70.071810] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.756s)
[70.081788] Starting dynamic subtest: pipe-B-eDP-1-4
[72.191815] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[72.198915] Starting dynamic subtest: pipe-B-eDP-1-4
[74.199914] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[74.212527] Starting dynamic subtest: pipe-B-eDP-1-x
[76.439881] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[76.748789] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[79.587827] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[79.597926] Starting dynamic subtest: pipe-C-eDP-1-4
[81.751979] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.164s)
[81.763215] Starting dynamic subtest: pipe-C-eDP-1-4
[83.711969] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[83.721821] Starting dynamic subtest: pipe-C-eDP-1-x
[85.941159] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[86.261662] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[89.062035] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.807s)
[89.072263] Starting dynamic subtest: pipe-D-eDP-1-4
[91.290487] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[91.302981] Starting dynamic subtest: pipe-D-eDP-1-4
[93.247828] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[93.258224] Starting dynamic subtest: pipe-D-eDP-1-x
[95.478659] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.179s)
[95.481698] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.109s)
[96.660066] [003/133] (920s left) i915_drm_fdinfo (basics)
[96.708476] Starting subtest: basics
[96.710478] Subtest basics: SUCCESS (0.000s)
[96.785397] [004/133] (920s left) kms_content_protection (dp-mst-lic-type-0)
[96.928976] Starting subtest: dp-mst-lic-type-0
[96.933689] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[97.082212] [005/133] (920s left) kms_big_fb (linear-16bpp-rotate-0)
[97.185595] Starting subtest: linear-16bpp-rotate-0
[98.519551] Subtest linear-16bpp-rotate-0: SUCCESS (1.334s)
[98.637971] [006/133] (919s left) syncobj_basic (test-valid-cycle)
[98.704343] Starting subtest: test-valid-cycle
[98.706249] Subtest test-valid-cycle: SUCCESS (0.000s)
[98.806917] [007/133] (918s left) sw_sync (timeline_closed_signaled)
[98.845387] Starting subtest: timeline_closed_signaled
[98.846915] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[98.900915] [008/133] (918s left) api_intel_bb (misplaced-blitter)
[98.957965] Starting subtest: misplaced-blitter
[98.962366] Subtest misplaced-blitter: SUCCESS (0.006s)
[99.091014] [009/133] (918s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[99.188286] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[99.199545] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[99.330596] [010/133] (918s left) gem_exec_balancer (full-late-pulse)
[99.395563] Starting subtest: full-late-pulse
[103.787857] Subtest full-late-pulse: SUCCESS (4.391s)
[104.138178] [011/133] (913s left) i915_drm_fdinfo (virtual-busy-idle)
[104.176317] Starting subtest: virtual-busy-idle
[104.180440] Subtest virtual-busy-idle: SKIP (0.000s)
[104.250102] [012/133] (913s left) gem_ctx_bad_destroy (double-destroy)
[104.303636] Starting subtest: double-destroy
[104.306041] Subtest double-destroy: SUCCESS (0.000s)
[104.398963] [013/133] (913s left) kms_plane_cursor (primary)
[104.481832] Starting subtest: primary
[104.486502] Starting dynamic subtest: pipe-A-eDP-1-size-64
[107.023324] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.541s)
[107.048297] Starting dynamic subtest: pipe-A-eDP-1-size-128
[109.613025] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[109.641629] Starting dynamic subtest: pipe-A-eDP-1-size-256
[112.169587] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[112.485418] Starting dynamic subtest: pipe-B-eDP-1-size-64
[115.747740] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.272s)
[115.771136] Starting dynamic subtest: pipe-B-eDP-1-size-128
[118.316049] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.551s)
[118.339519] Starting dynamic subtest: pipe-B-eDP-1-size-256
[120.984016] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.649s)
[121.311532] Starting dynamic subtest: pipe-C-eDP-1-size-64
[124.179648] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.877s)
[124.206208] Starting dynamic subtest: pipe-C-eDP-1-size-128
[126.346193] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[126.372063] Starting dynamic subtest: pipe-C-eDP-1-size-256
[128.546062] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[128.865852] Starting dynamic subtest: pipe-D-eDP-1-size-64
[131.775272] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.918s)
[131.798529] Starting dynamic subtest: pipe-D-eDP-1-size-128
[133.984830] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[134.010343] Starting dynamic subtest: pipe-D-eDP-1-size-256
[136.184471] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[136.491911] Subtest primary: SUCCESS (32.007s)
[137.296871] [014/133] (880s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[137.361879] Starting subtest: rel-constants-invalid-rel-gen5
[137.364287] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[137.488302] [015/133] (880s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[137.591790] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[137.596180] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[138.744243] [016/133] (879s left) syncobj_timeline (single-wait-available-submitted)
[138.811418] Starting subtest: single-wait-available-submitted
[138.813320] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[138.927256] [017/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[139.021125] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[146.309593] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.290s)
[146.476954] [018/133] (871s left) gem_ctx_engines (execute-oneforall)
[146.536195] Starting subtest: execute-oneforall
[147.058517] Subtest execute-oneforall: SUCCESS (0.523s)
[148.061521] [019/133] (870s left) kms_force_connector_basic (force-edid)
[148.140849] Starting subtest: force-edid
[148.505383] Subtest force-edid: SUCCESS (0.364s)
[148.652916] [020/133] (869s left) syncobj_wait (single-wait-submitted)
[148.719052] Starting subtest: single-wait-submitted
[148.825355] Subtest single-wait-submitted: SUCCESS (0.105s)
[148.909184] [021/133] (869s left) gem_mmap_gtt (cpuset-basic-small-copy)
[148.957689] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[149.019092] [022/133] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[149.129274] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[155.523338] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.396s)
[155.645289] [023/133] (862s left) kms_pm_lpsp (screens-disabled)
[156.763677] Starting subtest: screens-disabled
[156.767894] Subtest screens-disabled: SKIP (0.000s)
[156.844084] [024/133] (861s left) kms_plane (pixel-format-4-tiled-modifier)
[156.942821] Starting subtest: pixel-format-4-tiled-modifier
[156.969236] Starting dynamic subtest: pipe-A-plane-0
[157.613577] Dynamic subtest pipe-A-plane-0: SUCCESS (0.645s)
[157.621467] Starting dynamic subtest: pipe-A-plane-3
[158.047320] Dynamic subtest pipe-A-plane-3: SUCCESS (0.431s)
[158.055126] Starting dynamic subtest: pipe-A-plane-5
[158.058884] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[159.130582] Starting dynamic subtest: pipe-B-plane-0
[159.755711] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[159.764088] Starting dynamic subtest: pipe-B-plane-3
[160.155207] Dynamic subtest pipe-B-plane-3: SUCCESS (0.398s)
[160.170037] Starting dynamic subtest: pipe-B-plane-5
[160.173851] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[160.483066] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.542s)
[161.308309] [025/133] (857s left) kms_addfb_basic (bad-pitch-999)
[161.371378] Starting subtest: bad-pitch-999
[161.373300] Subtest bad-pitch-999: SUCCESS (0.000s)
[161.514300] [026/133] (856s left) perf_pmu (init-sema)
[161.557621] Starting subtest: init-sema
[161.559992] Starting dynamic subtest: rcs0
[161.562431] Dynamic subtest rcs0: SUCCESS (0.002s)
[161.575598] Starting dynamic subtest: bcs0
[161.577536] Dynamic subtest bcs0: SUCCESS (0.001s)
[161.589035] Starting dynamic subtest: vcs0
[161.591369] Dynamic subtest vcs0: SUCCESS (0.001s)
[161.601125] Starting dynamic subtest: vcs1
[161.603089] Dynamic subtest vcs1: SUCCESS (0.001s)
[161.612040] Starting dynamic subtest: vecs0
[161.613935] Dynamic subtest vecs0: SUCCESS (0.001s)
[161.621247] Starting dynamic subtest: ccs0
[161.623380] Dynamic subtest ccs0: SUCCESS (0.000s)
[161.625583] Subtest init-sema: SUCCESS (0.008s)
[161.689026] [027/133] (856s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[162.079236] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[162.853972] [028/133] (855s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[162.984502] Starting subtest: flip-vs-cursor-toggle
[171.489240] Subtest flip-vs-cursor-toggle: SUCCESS (8.503s)
[172.283694] [029/133] (846s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[172.356398] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[172.439309] [030/133] (846s left) kms_vblank (ts-continuation-idle-hang)
[172.535411] Starting subtest: ts-continuation-idle-hang
[172.537633] Starting dynamic subtest: pipe-A-eDP-1
[198.672076] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.135s)
[198.685643] Starting dynamic subtest: pipe-D-eDP-1
[223.656948] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.979s)
[223.659166] Subtest ts-continuation-idle-hang: SUCCESS (51.119s)
[224.484869] [031/133] (794s left) kms_cursor_crc (cursor-random-128x42)
[224.699471] Starting subtest: cursor-random-128x42
[224.745293] Subtest cursor-random-128x42: SKIP (0.040s)
[224.969048] [032/133] (793s left) kms_psr (psr-sprite-blt)
[225.070850] Starting subtest: psr-sprite-blt
[225.072971] Starting dynamic subtest: eDP-1
[226.854160] Dynamic subtest eDP-1: SUCCESS (1.784s)
[226.856338] Subtest psr-sprite-blt: SUCCESS (1.785s)
[227.693256] [033/133] (791s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[227.806495] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[227.810532] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[227.884762] [034/133] (790s left) gem_exec_reloc (basic-write-cpu-active)
[227.958109] Subtest basic-write-cpu-active: SKIP (0.000s)
[228.041336] [035/133] (790s left) syncobj_timeline (invalid-signal-illegal-point)
[228.097625] Starting subtest: invalid-signal-illegal-point
[228.099597] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[228.229176] [036/133] (790s left) gem_ctx_persistence (heartbeat-many)
[228.300411] Starting subtest: heartbeat-many
[228.304898] Subtest heartbeat-many: SKIP (0.000s)
[228.446078] [037/133] (790s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[228.553777] Starting subtest: primary-y-tiled-reflect-x-90
[228.558184] Subtest primary-y-tiled-reflect-x-90: SKIP (0.002s)
[228.649268] [038/133] (790s left) kms_flip (blocking-absolute-wf_vblank)
[228.755659] Starting subtest: blocking-absolute-wf_vblank
[228.757495] Starting dynamic subtest: A-eDP1
[237.530426] Dynamic subtest A-eDP1: SUCCESS (8.739s)
[237.540259] Starting dynamic subtest: B-eDP1
[246.241612] Dynamic subtest B-eDP1: SUCCESS (8.709s)
[246.252478] Starting dynamic subtest: C-eDP1
[254.944162] Dynamic subtest C-eDP1: SUCCESS (8.690s)
[254.951860] Starting dynamic subtest: D-eDP1
[263.726953] Dynamic subtest D-eDP1: SUCCESS (8.778s)
[263.729472] Subtest blocking-absolute-wf_vblank: SUCCESS (34.927s)
[264.883159] [039/133] (754s left) i915_pm_rpm (system-suspend)
[267.041619] Starting subtest: system-suspend
[285.666594] Subtest system-suspend: SUCCESS (2.995s)
[286.062395] [040/133] (732s left) kms_cursor_legacy (forked-bo)
[286.186145] Starting subtest: forked-bo
[286.188210] Starting dynamic subtest: pipe-A
[291.578575] Dynamic subtest pipe-A: SUCCESS (5.448s)
[291.587737] Starting dynamic subtest: pipe-B
[296.991308] Dynamic subtest pipe-B: SUCCESS (5.468s)
[297.000137] Starting dynamic subtest: pipe-C
[302.432465] Dynamic subtest pipe-C: SUCCESS (5.464s)
[302.441709] Starting dynamic subtest: pipe-D
[307.895032] Dynamic subtest pipe-D: SUCCESS (5.477s)
[307.906990] Starting dynamic subtest: all-pipes
[313.407090] Dynamic subtest all-pipes: SUCCESS (5.520s)
[313.409543] Subtest forked-bo: SUCCESS (27.389s)
[313.527086] [041/133] (705s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[313.633339] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[313.635433] Starting dynamic subtest: pipe-A
[313.652712] Dynamic subtest pipe-A: SKIP (0.017s)
[313.663703] Starting dynamic subtest: pipe-B
[313.687443] Dynamic subtest pipe-B: SKIP (0.032s)
[313.697297] Starting dynamic subtest: pipe-C
[313.720789] Dynamic subtest pipe-C: SKIP (0.033s)
[313.730744] Starting dynamic subtest: pipe-D
[313.751660] Dynamic subtest pipe-D: SKIP (0.032s)
[313.755814] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.117s)
[313.873805] [042/133] (705s left) gem_render_copy_redux (flink)
[313.945813] Starting subtest: flink
[314.711138] Subtest flink: SUCCESS (0.767s)
[314.848347] [043/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[314.958000] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[314.961280] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[315.071563] [044/133] (704s left) prime_mmap (test_userptr)
[315.129062] Starting subtest: test_userptr
[315.131125] Starting dynamic subtest: test_userptr-smem
[315.132952] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[315.134817] Subtest test_userptr: SUCCESS (0.001s)
[315.251937] [045/133] (703s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[315.308045] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[315.413415] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[315.499614] [046/133] (703s left) core_auth (many-magics)
[315.577800] Starting subtest: many-magics
[316.409094] Subtest many-magics: SUCCESS (0.833s)
[316.556419] [047/133] (702s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[316.613498] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[316.717906] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[316.800311] [048/133] (702s left) kms_cursor_crc (cursor-sliding-max-size)
[317.103798] Starting subtest: cursor-sliding-max-size
[317.110416] Subtest cursor-sliding-max-size: SKIP (0.000s)
[317.270864] [049/133] (702s left) syncobj_wait (wait-all-for-submit-snapshot)
[317.335894] Starting subtest: wait-all-for-submit-snapshot
[317.418057] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[317.516058] [050/133] (701s left) kms_invalid_mode (zero-vdisplay)
[317.615589] Starting subtest: zero-vdisplay
[317.617904] Starting dynamic subtest: pipe-A-eDP-1
[317.897927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[317.907464] Starting dynamic subtest: pipe-B-eDP-1
[317.909718] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[317.918506] Starting dynamic subtest: pipe-C-eDP-1
[317.920401] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[317.928118] Starting dynamic subtest: pipe-D-eDP-1
[317.930039] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[317.931987] Subtest zero-vdisplay: SUCCESS (0.288s)
[318.760718] [051/133] (700s left) gem_userptr_blits (huge-split)
[318.837947] Starting subtest: huge-split
[318.844827] Subtest huge-split: SUCCESS (0.007s)
[319.003218] [052/133] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[319.111594] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[319.115598] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[319.246645] [053/133] (700s left) gem_ctx_create (basic)
[319.309096] Starting subtest: basic
[319.311496] Subtest basic: SUCCESS (0.000s)
[319.502826] [054/133] (700s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[319.619023] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[320.608467] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.989s)
[320.774599] [055/133] (698s left) kms_lease (setcrtc-implicit-plane)
[320.870665] Starting subtest: setcrtc-implicit-plane
[320.872634] Starting dynamic subtest: pipe-A-eDP-1
[321.351237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s)
[321.360987] Starting dynamic subtest: pipe-B-eDP-1
[322.439264] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.083s)
[322.448848] Starting dynamic subtest: pipe-C-eDP-1
[323.530377] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.092s)
[323.541394] Starting dynamic subtest: pipe-D-eDP-1
[324.626592] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.093s)
[324.628546] Subtest setcrtc-implicit-plane: SUCCESS (3.755s)
[325.458254] [056/133] (694s left) kms_psr (pr-sprite-mmap-cpu)
[325.562475] Starting subtest: pr-sprite-mmap-cpu
[325.566869] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[325.645158] [057/133] (694s left) perf (gen12-unprivileged-single-ctx-counters)
[325.776926] Starting subtest: gen12-unprivileged-single-ctx-counters
[325.779065] Starting dynamic subtest: rcs0
[325.887669] Dynamic subtest rcs0: SUCCESS (0.112s)
[325.890085] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.114s)
[325.938138] [058/133] (693s left) gem_lmem_swapping (heavy-verify-random)
[325.979424] Subtest heavy-verify-random: SKIP (0.000s)
[326.020081] [059/133] (693s left) gem_busy (close-race)
[326.111556] Starting subtest: close-race
[349.553091] Subtest close-race: SUCCESS (23.441s)
[349.952134] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[349.957592] [060/133] (669s left) gem_exec_balancer (parallel-out-fence)
[350.242815] Starting subtest: parallel-out-fence
[351.289045] Subtest parallel-out-fence: SUCCESS (1.046s)
[351.434332] [061/133] (668s left) gem_ctx_shared (q-smoketest-all)
[351.506860] Starting subtest: Q-smoketest-all
[383.899999] Subtest Q-smoketest-all: SUCCESS (32.342s)
[385.581868] [062/133] (634s left) kms_psr (fbc-pr-primary-blt)
[385.695237] Starting subtest: fbc-pr-primary-blt
[385.699556] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[385.777604] [063/133] (634s left) api_intel_allocator (fork-simple-once)
[385.849442] Starting subtest: fork-simple-once
[385.862287] Subtest fork-simple-once: SUCCESS (0.015s)
[385.990628] [064/133] (633s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[386.096100] Starting subtest: flip-vs-dpms-on-nop-interruptible
[386.098267] Starting dynamic subtest: A-eDP1
[387.994589] Dynamic subtest A-eDP1: SUCCESS (1.897s)
[388.006135] Starting dynamic subtest: B-eDP1
[389.802659] Dynamic subtest B-eDP1: SUCCESS (1.806s)
[389.813090] Starting dynamic subtest: C-eDP1
[391.597522] Dynamic subtest C-eDP1: SUCCESS (1.794s)
[391.610525] Starting dynamic subtest: D-eDP1
[393.394089] Dynamic subtest D-eDP1: SUCCESS (1.794s)
[393.399413] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.300s)
[394.635420] [065/133] (625s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[394.745443] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[394.749730] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[394.863623] [066/133] (625s left) kms_selftest (drm_format)
[394.917735] Starting subtest: drm_format
[394.961350] Starting dynamic subtest: drm_test_format_block_width_invalid
[395.119265] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.155s)
[395.128211] Starting dynamic subtest: drm_test_format_block_width_one_plane
[395.236249] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.116s)
[395.244888] Starting dynamic subtest: drm_test_format_block_width_two_plane
[395.374705] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.138s)
[395.383544] Starting dynamic subtest: drm_test_format_block_width_three_plane
[395.518415] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.142s)
[395.527718] Starting dynamic subtest: drm_test_format_block_width_tiled
[395.663227] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.144s)
[395.671891] Starting dynamic subtest: drm_test_format_block_height_invalid
[395.807531] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.144s)
[395.816224] Starting dynamic subtest: drm_test_format_block_height_one_plane
[395.962839] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.152s)
[395.971905] Starting dynamic subtest: drm_test_format_block_height_two_plane
[396.099223] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.137s)
[396.108543] Starting dynamic subtest: drm_test_format_block_height_three_plane
[396.227464] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.125s)
[396.242023] Starting dynamic subtest: drm_test_format_block_height_tiled
[396.340966] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.115s)
[396.349718] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[396.477998] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.134s)
[396.486853] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[396.611688] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.134s)
[396.620220] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[396.758947] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.147s)
[396.767543] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[396.900559] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.138s)
[396.910924] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[397.049125] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.150s)
[397.058937] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[397.184892] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.134s)
[397.193796] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[397.309457] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.124s)
[397.319788] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[397.403133] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.092s)
[397.405428] Subtest drm_format: SUCCESS (2.486s)
[397.595749] [067/133] (622s left) gem_exec_schedule (deep)
[397.786690] Starting subtest: deep
[397.789096] Starting dynamic subtest: rcs0
[403.850660] Dynamic subtest rcs0: SKIP (6.064s)
[403.861949] Starting dynamic subtest: vcs0
[413.950511] Dynamic subtest vcs0: SUCCESS (10.100s)
[413.963108] Starting dynamic subtest: vcs1
[425.605616] Dynamic subtest vcs1: SUCCESS (11.655s)
[425.621030] Starting dynamic subtest: vecs0
[436.082685] Dynamic subtest vecs0: SUCCESS (10.478s)
[436.095393] Starting dynamic subtest: ccs0
[448.130800] Dynamic subtest ccs0: SUCCESS (12.050s)
[448.133646] Subtest deep: SUCCESS (50.351s)
[449.429107] [068/133] (570s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[449.527068] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[449.529317] Starting dynamic subtest: pipe-A
[450.702903] Dynamic subtest pipe-A: SUCCESS (1.178s)
[450.712535] Starting dynamic subtest: pipe-B
[452.945078] Dynamic subtest pipe-B: SUCCESS (2.242s)
[452.956361] Starting dynamic subtest: pipe-C
[454.161782] Dynamic subtest pipe-C: SUCCESS (1.215s)
[454.172972] Starting dynamic subtest: pipe-D
[455.373673] Dynamic subtest pipe-D: SUCCESS (1.211s)
[455.376038] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.850s)
[456.553652] [069/133] (563s left) gem_exec_flush (basic-batch-kernel-default-wb)
[456.629565] Starting subtest: basic-batch-kernel-default-wb
[463.712436] Subtest basic-batch-kernel-default-wb: SUCCESS (7.086s)
[463.911317] [070/133] (556s left) gem_mmap_wc (bad-object)
[463.975991] Subtest bad-object: SKIP (0.000s)
[464.044198] [071/133] (556s left) gem_basic (create-close)
[464.103640] Starting subtest: create-close
[464.108243] Subtest create-close: SUCCESS (0.000s)
[464.221624] [072/133] (556s left) gem_mmap_offset (partial-unmap)
[464.284145] Starting subtest: partial-unmap
[464.286526] Starting dynamic subtest: smem0
[464.689598] Dynamic subtest smem0: SUCCESS (0.406s)
[464.692264] Subtest partial-unmap: SUCCESS (0.407s)
[464.851677] [073/133] (555s left) gem_bad_reloc (negative-reloc-lut)
[464.914228] Subtest negative-reloc-lut: SKIP (0.000s)
[464.997377] [074/133] (555s left) gem_tiled_partial_pwrite_pread (writes)
[465.050984] Subtest writes: SKIP (0.000s)
[465.136427] [075/133] (555s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[465.232753] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[471.794230] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.565s)
[471.960996] [076/133] (548s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[472.056329] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[472.060355] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[472.169401] [077/133] (548s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[472.268225] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[472.270186] Starting dynamic subtest: pipe-A-eDP-1
[472.411201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[472.422341] Starting dynamic subtest: pipe-B-eDP-1
[472.441477] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[472.451363] Starting dynamic subtest: pipe-C-eDP-1
[472.469322] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[472.478266] Starting dynamic subtest: pipe-D-eDP-1
[472.496773] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[472.498604] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.169s)
[474.723572] [078/133] (545s left) kms_pm_rpm (modeset-stress-extra-wait)
[476.652196] Starting subtest: modeset-stress-extra-wait
[530.963645] Subtest modeset-stress-extra-wait: SUCCESS (54.263s)
[531.012902] [079/133] (489s left) kms_atomic (plane-immutable-zpos)
[531.116062] Starting subtest: plane-immutable-zpos
[531.118443] Starting dynamic subtest: pipe-A-eDP-1
[531.754806] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.637s)
[531.757212] Subtest plane-immutable-zpos: SUCCESS (0.639s)
[532.615992] [080/133] (487s left) syncobj_timeline (reset-unsignaled)
[532.679029] Starting subtest: reset-unsignaled
[532.681087] Subtest reset-unsignaled: SUCCESS (0.000s)
[532.801310] [081/133] (487s left) kms_color (gamma)
[532.890368] Starting subtest: gamma
[532.892213] Starting dynamic subtest: pipe-A-eDP-1
[533.635182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[533.645392] Starting dynamic subtest: pipe-B-eDP-1
[535.099945] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s)
[535.110698] Starting dynamic subtest: pipe-C-eDP-1
[536.407997] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.307s)
[536.418208] Starting dynamic subtest: pipe-D-eDP-1
[537.709341] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[537.711236] Subtest gamma: SUCCESS (4.818s)
[538.518423] [082/133] (482s left) gem_pipe_control_store_loop (reused-buffer)
[538.582808] Starting subtest: reused-buffer
[540.790127] Subtest reused-buffer: SUCCESS (2.153s)
[540.893258] [083/133] (479s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[541.501025] Starting subtest: syncobj-backward-timeline-chain-engines
[541.665325] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.167s)
[542.705762] [084/133] (478s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[542.800001] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[542.804371] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[542.935573] [085/133] (477s left) kms_cursor_crc (cursor-dpms)
[543.080315] Starting subtest: cursor-dpms
[543.082383] Starting dynamic subtest: pipe-A-eDP-1
[546.123587] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.042s)
[546.133893] Starting dynamic subtest: pipe-D-eDP-1
[549.803695] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.678s)
[549.806026] Subtest cursor-dpms: SUCCESS (6.723s)
[550.617413] [086/133] (470s left) gen9_exec_parse (bb-oversize)
[550.680755] Subtest bb-oversize: SKIP (0.000s)
[550.746464] [087/133] (470s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[550.837155] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[550.839372] Starting dynamic subtest: pipe-A-eDP-1
[550.861852] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[550.873223] Starting dynamic subtest: pipe-B-eDP-1
[550.894411] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[550.903673] Starting dynamic subtest: pipe-C-eDP-1
[550.924598] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[550.933666] Starting dynamic subtest: pipe-D-eDP-1
[550.955418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[550.959402] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[553.108406] [088/133] (467s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[553.201233] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[553.203517] Starting dynamic subtest: pipe-A-eDP-1
[553.261863] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[553.578621] Starting dynamic subtest: pipe-B-eDP-1
[554.372628] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.803s)
[554.658396] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.456s)
[555.499501] [089/133] (465s left) gem_exec_whisper (basic-queues)
[555.567753] Starting subtest: basic-queues
[560.873142] Subtest basic-queues: SUCCESS (5.305s)
[561.066131] [090/133] (459s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[561.171701] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[561.277331] [091/133] (459s left) gem_eio (wait-immediate)
[561.524920] Starting subtest: wait-immediate
[561.936203] Subtest wait-immediate: SUCCESS (0.411s)
[562.059393] [092/133] (459s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[562.440885] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[563.275258] [093/133] (457s left) gem_spin_batch (spin-all-new)
[563.342682] Starting subtest: spin-all-new
[563.356713] Subtest spin-all-new: SUCCESS (0.013s)
[564.577608] [094/133] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[564.674595] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[573.716943] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.044s)
[573.865835] [095/133] (447s left) kms_flip (dpms-off-confusion)
[573.964494] Starting subtest: dpms-off-confusion
[573.966727] Starting dynamic subtest: A-eDP1
[582.710430] Dynamic subtest A-eDP1: SUCCESS (8.710s)
[582.722935] Starting dynamic subtest: B-eDP1
[591.379017] Dynamic subtest B-eDP1: SUCCESS (8.701s)
[591.391149] Starting dynamic subtest: C-eDP1
[600.122782] Dynamic subtest C-eDP1: SUCCESS (8.698s)
[600.134881] Starting dynamic subtest: D-eDP1
[608.810835] Dynamic subtest D-eDP1: SUCCESS (8.685s)
[608.812969] Subtest dpms-off-confusion: SUCCESS (34.807s)
[610.004705] [096/133] (411s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[610.111762] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[610.116330] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[610.247415] [097/133] (411s left) gem_exec_schedule (noreorder-priority)
[610.437224] Starting subtest: noreorder-priority
[610.439990] Starting dynamic subtest: rcs0
[611.575374] Dynamic subtest rcs0: SUCCESS (1.138s)
[611.589946] Starting dynamic subtest: vcs0
[613.580400] Dynamic subtest vcs0: SUCCESS (2.003s)
[613.599342] Starting dynamic subtest: vcs1
[615.560711] Dynamic subtest vcs1: SUCCESS (1.977s)
[615.578224] Starting dynamic subtest: vecs0
[617.545015] Dynamic subtest vecs0: SUCCESS (1.981s)
[617.557834] Starting dynamic subtest: ccs0
[618.723225] Dynamic subtest ccs0: SUCCESS (1.177s)
[618.725960] Subtest noreorder-priority: SUCCESS (8.289s)
[618.930566] [098/133] (402s left) vgem_basic (bad-flag)
[618.985881] Starting subtest: bad-flag
[618.987822] Subtest bad-flag: SUCCESS (0.000s)
[619.054872] [099/133] (402s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[619.122896] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[619.125221] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[619.258071] [100/133] (402s left) kms_psr (fbc-psr-primary-mmap-gtt)
[619.364047] Starting subtest: fbc-psr-primary-mmap-gtt
[619.366247] Starting dynamic subtest: eDP-1
[619.370244] Dynamic subtest eDP-1: SKIP (0.000s)
[619.374328] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[619.450770] [101/133] (402s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[619.551736] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[619.555863] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[619.685886] [102/133] (401s left) gem_ringfill (basic-all)
[625.590831] Starting subtest: basic-all
[626.770920] Subtest basic-all: SUCCESS (1.161s)
[626.913919] [103/133] (394s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[627.017017] Starting subtest: x-tiled-32bpp-rotate-270
[627.036090] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[627.199014] [104/133] (394s left) prime_busy (before-wait)
[627.267030] Starting subtest: before-wait
[627.271831] Starting dynamic subtest: rcs0
[627.299303] Dynamic subtest rcs0: SUCCESS (0.028s)
[627.309410] Starting dynamic subtest: bcs0
[627.360024] Dynamic subtest bcs0: SUCCESS (0.060s)
[627.370526] Starting dynamic subtest: vcs0
[627.400741] Dynamic subtest vcs0: SUCCESS (0.040s)
[627.410448] Starting dynamic subtest: vcs1
[627.446094] Dynamic subtest vcs1: SUCCESS (0.044s)
[627.455922] Starting dynamic subtest: vecs0
[627.486974] Dynamic subtest vecs0: SUCCESS (0.039s)
[627.497426] Starting dynamic subtest: ccs0
[627.528577] Dynamic subtest ccs0: SUCCESS (0.041s)
[627.637524] Subtest before-wait: SUCCESS (0.368s)
[627.723125] [105/133] (393s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[627.845906] Starting subtest: cursorB-vs-flipB-varying-size
[627.850364] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[628.000798] [106/133] (393s left) drm_mm (drm_mm)
[628.042863] Starting subtest: drm_mm
[628.049431] Starting dynamic subtest: drm_test_mm_init
[628.202238] Dynamic subtest drm_test_mm_init: SUCCESS (0.151s)
[628.212953] Starting dynamic subtest: drm_test_mm_debug
[628.343016] Dynamic subtest drm_test_mm_debug: SUCCESS (0.140s)
[628.352509] Starting dynamic subtest: drm_test_mm_align32
[628.476768] Dynamic subtest drm_test_mm_align32: SUCCESS (0.133s)
[628.486458] Starting dynamic subtest: drm_test_mm_align64
[628.593142] Dynamic subtest drm_test_mm_align64: SUCCESS (0.116s)
[628.602307] Starting dynamic subtest: drm_test_mm_lowest
[628.715272] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.120s)
[628.724799] Starting dynamic subtest: drm_test_mm_highest
[628.842592] Dynamic subtest drm_test_mm_highest: SUCCESS (0.127s)
[628.844815] Subtest drm_mm: SUCCESS (0.801s)
[628.994212] [107/133] (392s left) i915_query (engine-info-invalid)
[629.056209] Starting subtest: engine-info-invalid
[629.058451] Subtest engine-info-invalid: SUCCESS (0.000s)
[629.184903] [108/133] (392s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[629.287441] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[635.744714] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.460s)
[635.903880] [109/133] (385s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[636.020618] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[636.971478] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.952s)
[637.797055] [110/133] (384s left) kms_feature_discovery (display-2x)
[637.887466] Starting subtest: display-2x
[637.891843] Subtest display-2x: SKIP (0.000s)
[637.970730] [111/133] (383s left) gem_ctx_isolation (dirty-create)
[638.042239] Starting subtest: dirty-create
[638.044654] Starting dynamic subtest: rcs0
[638.235547] Dynamic subtest rcs0: SUCCESS (0.193s)
[638.247578] Starting dynamic subtest: bcs0
[638.469011] Dynamic subtest bcs0: SUCCESS (0.233s)
[638.478643] Starting dynamic subtest: vcs0
[638.718411] Dynamic subtest vcs0: SUCCESS (0.248s)
[638.728197] Starting dynamic subtest: vcs1
[640.776475] Dynamic subtest vcs1: SUCCESS (2.057s)
[640.786564] Starting dynamic subtest: vecs0
[642.773069] Dynamic subtest vecs0: SUCCESS (1.996s)
[642.784933] Starting dynamic subtest: ccs0
[644.763222] Dynamic subtest ccs0: SUCCESS (1.989s)
[644.765563] Subtest dirty-create: SUCCESS (6.722s)
[645.029238] [112/133] (376s left) gem_tiled_wb
[645.154380] [113/133] (376s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[645.260204] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[645.264610] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[645.361012] [114/133] (376s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[645.456212] Starting subtest: crc-primary-suspend-y-tiled-ccs
[645.458470] Starting dynamic subtest: pipe-A-eDP-1
[645.467553] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[645.478465] Starting dynamic subtest: pipe-B-eDP-1
[645.487700] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[645.497796] Starting dynamic subtest: pipe-C-eDP-1
[645.506663] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[645.516119] Starting dynamic subtest: pipe-D-eDP-1
[645.524302] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[645.528541] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[647.699838] [115/133] (374s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[647.797441] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[647.801353] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[647.914190] [116/133] (374s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[648.012963] Starting subtest: pr-overlay-plane-move-continuous-sf
[648.017362] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[648.109689] [117/133] (374s left) gem_exec_flush (basic-wb-rw-default)
[648.164422] Starting subtest: basic-wb-rw-default
[653.652446] Subtest basic-wb-rw-default: SUCCESS (5.458s)
[653.832452] [118/133] (368s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[653.954283] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[653.958251] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[654.090107] [119/133] (368s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[654.212479] Starting subtest: cursor-vs-flip-atomic-transitions
[683.991603] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.781s)
[684.793813] [120/133] (337s left) gem_softpin (invalid)
[684.866965] Starting subtest: invalid
[684.875352] Subtest invalid: SUCCESS (0.006s)
[685.017144] [121/133] (337s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[685.124116] Starting subtest: stress-xrgb8888-4tiled
[691.051483] Subtest stress-xrgb8888-4tiled: SUCCESS (5.932s)
[691.103624] [122/133] (331s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[691.221394] Starting subtest: 2x-long-flip-vs-cursor-atomic
[691.225273] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[691.395423] [123/133] (330s left) sw_sync (sync_merge_same)
[691.434137] Starting subtest: sync_merge_same
[691.436123] Subtest sync_merge_same: SUCCESS (0.000s)
[691.502902] [124/133] (330s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[691.604430] Starting subtest: y-tiled-16bpp-rotate-90
[691.608154] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[691.729836] [125/133] (330s left) kms_chamelium_color (ctm-negative)
[691.828596] Subtest ctm-negative: SKIP (0.000s)
[691.876561] [126/133] (330s left) gem_exec_flush (basic-wb-prw-default)
[691.941800] Starting subtest: basic-wb-prw-default
[697.426427] Subtest basic-wb-prw-default: SUCCESS (5.465s)
[697.613622] [127/133] (324s left) kms_psr (fbc-psr2-primary-page-flip)
[697.714841] Starting subtest: fbc-psr2-primary-page-flip
[697.716958] Starting dynamic subtest: eDP-1
[697.720794] Dynamic subtest eDP-1: SKIP (0.000s)
[697.724686] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[697.797335] [128/133] (324s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[697.900221] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[704.640116] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.744s)
[704.776262] [129/133] (317s left) gem_exec_schedule (u-semaphore-codependency)
[704.858584] Starting subtest: u-semaphore-codependency
[704.867655] Subtest u-semaphore-codependency: SUCCESS (0.016s)
[705.244736] [130/133] (317s left) gem_create (create-invalid-size)
[705.298728] Starting subtest: create-invalid-size
[705.300969] Subtest create-invalid-size: SUCCESS (0.000s)
[705.497510] [131/133] (317s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[705.604550] Starting subtest: yf-tiled-16bpp-rotate-90
[705.608845] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[705.744225] [132/133] (316s left) kms_psr (psr2-primary-render)
[705.831454] Starting subtest: psr2-primary-render
[705.833715] Starting dynamic subtest: eDP-1
[707.538454] Dynamic subtest eDP-1: SUCCESS (1.707s)
[707.540691] Subtest psr2-primary-render: SUCCESS (1.708s)
[708.385549] [133/133] (314s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[708.493395] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[708.497442] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[708.599792] 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.