[57.667194] Initializing watchdogs
[57.667243]   /dev/watchdog0
[57.681702] [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.686650] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.688841] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.692168] [001/131] (960s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[57.805823] Starting subtest: async-flip-with-page-flip-events-tiled
[58.190584] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[60.975119] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[60.983182] Starting dynamic subtest: pipe-A-eDP-1-4
[63.146051] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.191s)
[63.156443] Starting dynamic subtest: pipe-A-eDP-1-4
[65.097256] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.016s)
[65.107444] Starting dynamic subtest: pipe-A-eDP-1-x
[67.324063] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.186s)
[67.634095] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[70.375677] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.756s)
[70.383439] Starting dynamic subtest: pipe-B-eDP-1-4
[72.607218] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[72.617602] Starting dynamic subtest: pipe-B-eDP-1-4
[74.559920] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[74.567159] Starting dynamic subtest: pipe-B-eDP-1-x
[76.798289] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[77.106860] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[79.944050] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[79.951749] Starting dynamic subtest: pipe-C-eDP-1-4
[82.127745] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[82.135066] Starting dynamic subtest: pipe-C-eDP-1-4
[84.084247] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[84.091772] Starting dynamic subtest: pipe-C-eDP-1-x
[86.313252] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[86.624221] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[89.422239] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.804s)
[89.430807] Starting dynamic subtest: pipe-D-eDP-1-4
[91.662094] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.186s)
[91.672079] Starting dynamic subtest: pipe-D-eDP-1-4
[93.619058] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[93.627685] Starting dynamic subtest: pipe-D-eDP-1-x
[95.850148] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.179s)
[95.852577] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.106s)
[97.018922] [002/131] (921s left) kms_vblank (ts-continuation-modeset-hang)
[97.112322] Starting subtest: ts-continuation-modeset-hang
[97.114657] Starting dynamic subtest: pipe-A-eDP-1
[123.684373] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.569s)
[123.695736] Starting dynamic subtest: pipe-D-eDP-1
[148.687669] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.000s)
[148.689652] Subtest ts-continuation-modeset-hang: SUCCESS (51.574s)
[149.551725] [003/131] (868s left) kms_psr (fbc-psr2-sprite-blt)
[149.645046] Starting subtest: fbc-psr2-sprite-blt
[149.647430] Starting dynamic subtest: eDP-1
[149.651965] Dynamic subtest eDP-1: SKIP (0.000s)
[149.656527] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[149.726649] [004/131] (868s left) kms_color (invalid-ctm-matrix-sizes)
[149.828176] Starting subtest: invalid-ctm-matrix-sizes
[149.830372] Starting dynamic subtest: pipe-A
[149.832247] Dynamic subtest pipe-A: SUCCESS (0.002s)
[149.839344] Starting dynamic subtest: pipe-B
[149.841600] Dynamic subtest pipe-B: SUCCESS (0.003s)
[149.848655] Starting dynamic subtest: pipe-C
[149.850878] Dynamic subtest pipe-C: SUCCESS (0.004s)
[149.857888] Starting dynamic subtest: pipe-D
[149.859827] Dynamic subtest pipe-D: SUCCESS (0.004s)
[149.861777] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[149.921073] [005/131] (868s left) kms_dsc (dsc-with-output-formats)
[150.021167] Starting subtest: dsc-with-output-formats
[150.043874] Subtest dsc-with-output-formats: SKIP (0.001s)
[150.113410] [006/131] (868s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[150.228911] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[159.107113] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.876s)
[159.973907] [007/131] (858s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[160.069919] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[161.059220] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.990s)
[161.203487] [008/131] (857s left) gem_ctx_shared (create-shared-gtt)
[161.270703] Starting subtest: create-shared-gtt
[163.477300] Subtest create-shared-gtt: SUCCESS (2.151s)
[163.786410] [009/131] (854s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[163.886097] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[170.860323] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.977s)
[171.018824] [010/131] (847s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[171.086792] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[171.089305] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[171.218127] [011/131] (847s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[171.323422] Starting subtest: psr-rgb565-draw-mmap-wc
[178.003656] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.682s)
[178.105253] [012/131] (840s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[178.201133] Starting subtest: primary-4-tiled-reflect-x-180
[185.232648] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.033s)
[186.470133] [013/131] (832s left) gem_exec_balancer (bonded-semaphore)
[186.531532] Starting subtest: bonded-semaphore
[186.536191] Subtest bonded-semaphore: SKIP (0.000s)
[186.867258] [014/131] (831s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[186.973761] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[186.978306] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[187.090340] [015/131] (831s left) syncobj_wait (multi-wait-for-submit-signaled)
[187.139792] Starting subtest: multi-wait-for-submit-signaled
[187.142160] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[187.246809] [016/131] (831s left) gem_pread (exhaustion)
[187.305591] Subtest exhaustion: SKIP (0.000s)
[187.367068] [017/131] (831s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[187.423474] Starting subtest: multi-wait-all-available-submitted-signaled
[187.425801] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[187.514242] [018/131] (831s left) gem_exec_params (no-blt)
[187.573429] Starting subtest: no-blt
[187.575755] Subtest no-blt: SUCCESS (0.002s)
[187.703256] [019/131] (831s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[187.792283] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[187.795520] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[187.912082] [020/131] (831s left) gem_eio (wait-10ms)
[188.142406] Starting subtest: wait-10ms
[188.524688] Subtest wait-10ms: SUCCESS (0.381s)
[188.668628] [021/131] (830s left) gem_pread (snoop)
[188.720477] Subtest snoop: SKIP (0.000s)
[188.779100] [022/131] (830s left) kms_tiled_display (basic-test-pattern)
[188.886812] Subtest basic-test-pattern: SKIP (0.000s)
[188.931036] [023/131] (830s left) kms_cursor_crc (cursor-random-64x64)
[189.115759] Starting subtest: cursor-random-64x64
[189.118196] Starting dynamic subtest: pipe-A-eDP-1
[192.459650] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.341s)
[192.490663] Starting dynamic subtest: pipe-D-eDP-1
[196.430048] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.952s)
[196.432395] Subtest cursor-random-64x64: SUCCESS (7.317s)
[197.335712] [024/131] (821s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[197.431450] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[197.435604] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[197.565256] [025/131] (821s left) i915_pm_rc6_residency (media-rc6-accuracy)
[197.613325] Starting subtest: media-rc6-accuracy
[197.617599] Subtest media-rc6-accuracy: SKIP (0.000s)
[197.735906] [026/131] (821s left) gem_flink_basic (basic)
[197.792851] Starting subtest: basic
[197.794962] Subtest basic: SUCCESS (0.000s)
[197.903844] [027/131] (821s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[198.003935] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[201.693767] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.696s)
[202.851321] [028/131] (816s left) gem_create (create-massive)
[202.907583] Starting subtest: create-massive
[202.909892] Subtest create-massive: SUCCESS (0.000s)
[203.118704] [029/131] (816s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[203.215785] Starting subtest: y-tiled-32bpp-rotate-90
[203.220288] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[203.344312] [030/131] (815s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[203.440421] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[203.444635] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[203.544641] [031/131] (815s left) gem_exec_fence (expired-history)
[204.009555] Starting subtest: expired-history
[210.605040] Subtest expired-history: SUCCESS (6.595s)
[211.210876] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[211.214096] [032/131] (808s left) syncobj_wait (wait-for-submit-delayed-submit)
[211.265574] Starting subtest: wait-for-submit-delayed-submit
[211.367388] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[211.453096] [033/131] (807s left) gem_eio (hibernate)
[211.695417] Starting subtest: hibernate
[226.511176] Subtest hibernate: SUCCESS (14.815s)
[233.659144] [034/131] (792s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[233.785632] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[237.744207] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.964s)
[238.889872] [035/131] (787s left) perf_pmu (all-busy-idle-check-all)
[238.927715] Starting subtest: all-busy-idle-check-all
[240.920390] Subtest all-busy-idle-check-all: SUCCESS (1.992s)
[241.056368] [036/131] (785s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[241.150158] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[241.152425] Starting dynamic subtest: pipe-A-eDP-1
[241.938560] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.779s)
[241.949540] Starting dynamic subtest: pipe-B-eDP-1
[243.475827] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.537s)
[243.486054] Starting dynamic subtest: pipe-C-eDP-1
[244.964439] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[244.975204] Starting dynamic subtest: pipe-D-eDP-1
[246.520217] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.554s)
[246.522490] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.363s)
[247.703872] [037/131] (778s left) drm_read (empty-block)
[247.854858] Starting subtest: empty-block
[248.855262] Subtest empty-block: SUCCESS (1.000s)
[249.035887] [038/131] (777s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[249.123142] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[249.125454] Starting dynamic subtest: pipe-A-eDP-1
[249.147960] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[249.158550] Starting dynamic subtest: pipe-B-eDP-1
[249.180120] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[249.188834] Starting dynamic subtest: pipe-C-eDP-1
[249.210146] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[249.219073] Starting dynamic subtest: pipe-D-eDP-1
[249.241420] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[249.246093] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[251.314762] [039/131] (775s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[251.717908] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[252.502340] [040/131] (774s left) kms_writeback (writeback-fb-id)
[252.600401] Subtest writeback-fb-id: SKIP (0.000s)
[252.648052] [041/131] (774s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[252.720459] Starting subtest: yf-tiled-ccs-to-y-tiled
[252.725033] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[252.927780] [042/131] (773s left) fbdev (eof)
[252.973584] Starting subtest: eof
[252.976087] Subtest eof: SUCCESS (0.000s)
[253.068978] [043/131] (773s left) kms_getfb (getfb2-handle-protection)
[253.166273] Starting subtest: getfb2-handle-protection
[253.188516] Subtest getfb2-handle-protection: SUCCESS (0.023s)
[253.338823] [044/131] (773s left) gem_exec_params (invalid-ring)
[253.396370] Starting subtest: invalid-ring
[253.398803] Subtest invalid-ring: SUCCESS (0.000s)
[253.539728] [045/131] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[253.625183] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[253.629088] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[253.739488] [046/131] (773s left) kms_flip (dpms-off-confusion-interruptible)
[253.829378] Starting subtest: dpms-off-confusion-interruptible
[253.831703] Starting dynamic subtest: A-eDP1
[262.555509] Dynamic subtest A-eDP1: SUCCESS (8.692s)
[262.572399] Starting dynamic subtest: B-eDP1
[271.194188] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[271.203965] Starting dynamic subtest: C-eDP1
[279.816905] Dynamic subtest C-eDP1: SUCCESS (8.609s)
[279.828826] Starting dynamic subtest: D-eDP1
[288.444211] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[288.446959] Subtest dpms-off-confusion-interruptible: SUCCESS (34.571s)
[289.580938] [047/131] (737s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[289.676470] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[289.678910] Starting dynamic subtest: pipe-A
[289.697213] Dynamic subtest pipe-A: SKIP (0.018s)
[289.709351] Starting dynamic subtest: pipe-B
[289.729577] Dynamic subtest pipe-B: SKIP (0.031s)
[289.739544] Starting dynamic subtest: pipe-C
[289.761712] Dynamic subtest pipe-C: SKIP (0.031s)
[289.771046] Starting dynamic subtest: pipe-D
[289.793561] Dynamic subtest pipe-D: SKIP (0.032s)
[289.797339] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.113s)
[289.909149] [048/131] (737s left) gem_ctx_persistence (userptr)
[289.975820] Starting subtest: userptr
[290.193666] Subtest userptr: SUCCESS (0.218s)
[290.293530] [049/131] (736s left) kms_atomic_transition (modeset-transition-nonblocking)
[290.399048] Starting subtest: modeset-transition-nonblocking
[290.401566] Starting dynamic subtest: 1x-outputs
[300.997937] Dynamic subtest 1x-outputs: SUCCESS (10.599s)
[301.266410] Subtest modeset-transition-nonblocking: SUCCESS (10.869s)
[302.156162] [050/131] (724s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[302.264952] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[302.269388] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[302.403577] [051/131] (724s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[302.511903] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[302.515875] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[302.640480] [052/131] (724s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[303.033791] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[303.855143] [053/131] (723s left) syncobj_timeline (wait-for-submit-snapshot)
[303.917809] Starting subtest: wait-for-submit-snapshot
[303.997993] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[304.085380] [054/131] (723s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[304.181043] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[304.183374] Starting dynamic subtest: pipe-A
[304.303973] Dynamic subtest pipe-A: SKIP (0.119s)
[304.314477] Starting dynamic subtest: pipe-B
[305.441620] Dynamic subtest pipe-B: SKIP (1.134s)
[305.452926] Starting dynamic subtest: pipe-C
[306.572380] Dynamic subtest pipe-C: SUCCESS (1.137s)
[306.582332] Starting dynamic subtest: pipe-D
[307.723456] Dynamic subtest pipe-D: SUCCESS (1.150s)
[307.725812] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.544s)
[308.941883] [055/131] (718s left) gem_mmap_offset (basic-uaf)
[309.002572] Starting subtest: basic-uaf
[309.004879] Subtest basic-uaf: SUCCESS (0.001s)
[309.129037] [056/131] (718s left) gem_exec_schedule (u-submit-golden-slice)
[309.195622] Starting subtest: u-submit-golden-slice
[309.197938] Starting dynamic subtest: rcs0
[309.229789] Dynamic subtest rcs0: SUCCESS (0.039s)
[309.242153] Starting dynamic subtest: bcs0
[309.264297] Dynamic subtest bcs0: SUCCESS (0.034s)
[309.274380] Starting dynamic subtest: vcs0
[309.296853] Dynamic subtest vcs0: SUCCESS (0.032s)
[309.306840] Starting dynamic subtest: vcs1
[309.335446] Dynamic subtest vcs1: SUCCESS (0.037s)
[309.346654] Starting dynamic subtest: vecs0
[309.375658] Dynamic subtest vecs0: SUCCESS (0.038s)
[309.385771] Starting dynamic subtest: ccs0
[309.419407] Dynamic subtest ccs0: SUCCESS (0.043s)
[309.421776] Subtest u-submit-golden-slice: SUCCESS (0.229s)
[311.004565] [057/131] (716s left) gem_pxp (hw-rejects-pxp-context)
[311.144860] Starting subtest: hw-rejects-pxp-context
[311.149428] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[311.291951] [058/131] (716s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[316.298770] Starting subtest: psr2-cursor-plane-update-sf
[316.300876] Starting dynamic subtest: pipe-A-eDP-1
[317.588677] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.289s)
[317.599803] Starting dynamic subtest: pipe-B-eDP-1
[318.933955] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.343s)
[318.936402] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.638s)
[319.822799] [059/131] (707s left) kms_busy (extended-pageflip-hang-oldfb)
[319.925054] Starting subtest: extended-pageflip-hang-oldfb
[319.927327] Starting dynamic subtest: pipe-A
[320.322216] Dynamic subtest pipe-A: SUCCESS (0.396s)
[320.333226] Starting dynamic subtest: pipe-D
[321.418899] Dynamic subtest pipe-D: SUCCESS (1.095s)
[321.421326] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.496s)
[322.296250] [060/131] (705s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[322.369786] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[322.443831] [061/131] (705s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[322.538217] Starting subtest: disable-crc-after-crtc
[322.540512] Starting dynamic subtest: pipe-A-eDP-1
[324.208763] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.669s)
[324.219479] Starting dynamic subtest: pipe-B-eDP-1
[326.458378] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.250s)
[326.469175] Starting dynamic subtest: pipe-C-eDP-1
[328.730388] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.271s)
[328.741274] Starting dynamic subtest: pipe-D-eDP-1
[330.986964] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s)
[330.989317] Subtest disable-crc-after-crtc: SUCCESS (8.451s)
[331.831512] [062/131] (695s left) gem_bad_reloc (negative-reloc-bltcopy)
[331.900176] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[331.982865] [063/131] (695s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[332.079247] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[332.081451] Starting dynamic subtest: pipe-A-default-mode
[332.372253] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[332.376775] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.291s)
[333.255736] [064/131] (694s left) i915_drm_fdinfo (busy-check-all)
[333.300514] Starting subtest: busy-check-all
[333.302556] Starting dynamic subtest: rcs0
[333.307008] Dynamic subtest rcs0: SKIP (0.004s)
[333.316982] Starting dynamic subtest: bcs0
[333.321203] Dynamic subtest bcs0: SKIP (0.000s)
[333.332278] Starting dynamic subtest: vcs0
[333.336580] Dynamic subtest vcs0: SKIP (0.000s)
[333.345719] Starting dynamic subtest: vcs1
[333.349718] Dynamic subtest vcs1: SKIP (0.000s)
[333.358978] Starting dynamic subtest: vecs0
[333.363045] Dynamic subtest vecs0: SKIP (0.000s)
[333.371630] Starting dynamic subtest: ccs0
[333.375682] Dynamic subtest ccs0: SKIP (0.000s)
[333.379801] Subtest busy-check-all: SKIP (0.009s)
[333.417878] [065/131] (694s left) kms_pm_rpm (dpms-lpsp)
[335.142972] Starting subtest: dpms-lpsp
[335.621959] Subtest dpms-lpsp: SUCCESS (0.484s)
[335.736284] [066/131] (692s left) gem_ctx_param (set-priority-not-supported)
[335.792075] Starting subtest: set-priority-not-supported
[335.796512] Subtest set-priority-not-supported: SKIP (0.000s)
[335.879946] [067/131] (691s left) gem_mmap (short-mmap)
[335.924229] Subtest short-mmap: SKIP (0.000s)
[336.018850] [068/131] (691s left) kms_invalid_mode (zero-vdisplay)
[336.118288] Starting subtest: zero-vdisplay
[336.120615] Starting dynamic subtest: pipe-A-eDP-1
[336.406454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[336.416486] Starting dynamic subtest: pipe-B-eDP-1
[336.418773] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[336.428330] Starting dynamic subtest: pipe-C-eDP-1
[336.430285] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[336.439229] Starting dynamic subtest: pipe-D-eDP-1
[336.441151] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[336.443076] Subtest zero-vdisplay: SUCCESS (0.294s)
[337.217999] [069/131] (690s left) gen9_exec_parse (allowed-all)
[337.285897] Subtest allowed-all: SKIP (0.000s)
[337.371142] [070/131] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[337.474888] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[337.479196] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[337.580938] [071/131] (690s left) gem_exec_schedule (u-lateslice)
[337.645279] Starting subtest: u-lateslice
[337.647295] Starting dynamic subtest: rcs0
[337.655030] Dynamic subtest rcs0: SUCCESS (0.021s)
[337.666645] Starting dynamic subtest: bcs0
[337.671452] Dynamic subtest bcs0: SUCCESS (0.016s)
[337.681231] Starting dynamic subtest: vcs0
[337.689488] Dynamic subtest vcs0: SUCCESS (0.018s)
[337.699886] Starting dynamic subtest: vcs1
[337.709332] Dynamic subtest vcs1: SUCCESS (0.019s)
[337.718771] Starting dynamic subtest: vecs0
[337.728918] Dynamic subtest vecs0: SUCCESS (0.019s)
[337.738532] Starting dynamic subtest: ccs0
[337.746903] Dynamic subtest ccs0: SUCCESS (0.017s)
[337.749231] Subtest u-lateslice: SUCCESS (0.114s)
[339.053136] [072/131] (689s left) gem_exec_reloc (basic-range)
[339.121992] Subtest basic-range: SKIP (0.000s)
[339.208940] [073/131] (688s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[339.331713] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[339.336210] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[339.504555] [074/131] (688s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[339.613669] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[340.715140] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.100s)
[340.882014] [075/131] (687s left) kms_psr (fbc-psr-primary-blt)
[340.978403] Starting subtest: fbc-psr-primary-blt
[340.980336] Starting dynamic subtest: eDP-1
[340.983808] Dynamic subtest eDP-1: SKIP (0.000s)
[340.987470] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[341.079703] [076/131] (687s left) kms_lease (atomic-implicit-crtc)
[341.174386] Starting subtest: atomic-implicit-crtc
[341.176393] Starting dynamic subtest: pipe-A-eDP-1
[341.186072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[341.196172] Starting dynamic subtest: pipe-B-eDP-1
[341.205599] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[341.214865] Starting dynamic subtest: pipe-C-eDP-1
[341.223508] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[341.232703] Starting dynamic subtest: pipe-D-eDP-1
[341.241534] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[341.243327] Subtest atomic-implicit-crtc: SUCCESS (0.032s)
[341.348479] [077/131] (686s left) kms_psr (psr2-sprite-mmap-gtt)
[341.431240] Starting subtest: psr2-sprite-mmap-gtt
[341.433057] Starting dynamic subtest: eDP-1
[342.894194] Dynamic subtest eDP-1: SKIP (1.459s)
[342.898677] Subtest psr2-sprite-mmap-gtt: SKIP (1.461s)
[343.063140] [078/131] (685s left) gem_exec_fence (syncobj-unused-fence)
[343.498475] Starting subtest: syncobj-unused-fence
[343.500443] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[345.029390] [079/131] (683s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[345.135080] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[345.139702] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[345.267481] [080/131] (683s left) gem_softpin (overlap)
[345.331702] Starting subtest: overlap
[346.304399] Subtest overlap: SUCCESS (0.971s)
[346.469660] [081/131] (682s left) gem_exec_flush (basic-wb-pro-default)
[346.532267] Starting subtest: basic-wb-pro-default
[352.018411] Subtest basic-wb-pro-default: SUCCESS (5.457s)
[352.192926] [082/131] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[352.306734] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[361.631782] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.328s)
[361.773562] [083/131] (666s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[361.877958] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[361.882265] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[362.021090] [084/131] (666s left) i915_hangman (engine-error-state-capture)
[362.089572] Starting subtest: engine-error-state-capture
[362.092043] Starting dynamic subtest: rcs0
[365.878233] Dynamic subtest rcs0: SUCCESS (3.787s)
[365.891845] Starting dynamic subtest: bcs0
[371.892589] Dynamic subtest bcs0: SUCCESS (6.011s)
[371.905301] Starting dynamic subtest: vcs0
[377.845037] Dynamic subtest vcs0: SUCCESS (5.950s)
[377.857305] Starting dynamic subtest: vcs1
[383.861107] Dynamic subtest vcs1: SUCCESS (6.013s)
[383.873479] Starting dynamic subtest: vecs0
[389.876983] Dynamic subtest vecs0: SUCCESS (6.013s)
[389.889806] Starting dynamic subtest: ccs0
[395.893201] Dynamic subtest ccs0: SUCCESS (6.013s)
[395.896047] Subtest engine-error-state-capture: SUCCESS (33.803s)
[396.000286] [085/131] (632s left) kms_addfb_basic (no-handle)
[396.059086] Starting subtest: no-handle
[396.061319] Subtest no-handle: SUCCESS (0.000s)
[396.235397] [086/131] (632s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[396.342479] Starting subtest: cursorA-vs-flipB-legacy
[396.346856] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[396.499878] [087/131] (632s left) i915_selftest (live)
[400.177070] Starting subtest: live
[400.182249] Starting dynamic subtest: sanitycheck
[404.702089] Dynamic subtest sanitycheck: SUCCESS (4.529s)
[404.711869] Starting dynamic subtest: uncore
[409.225638] Dynamic subtest uncore: SUCCESS (4.521s)
[409.236393] Starting dynamic subtest: workarounds
[427.062243] Dynamic subtest workarounds: FAIL (17.254s)
[427.070581] Starting dynamic subtest: gt_engines
[431.263045] Dynamic subtest gt_engines: SUCCESS (4.779s)
[431.273264] Starting dynamic subtest: gt_timelines
[447.137969] Dynamic subtest gt_timelines: SUCCESS (15.872s)
[447.148263] Starting dynamic subtest: gt_contexts
[451.686672] Dynamic subtest gt_contexts: SUCCESS (4.546s)
[451.697050] Starting dynamic subtest: gt_lrc
[457.966672] Dynamic subtest gt_lrc: SUCCESS (6.278s)
[457.976411] Starting dynamic subtest: gt_mocs
[462.586260] Dynamic subtest gt_mocs: SUCCESS (4.617s)
[462.601966] Starting dynamic subtest: gt_pm
[469.561397] Dynamic subtest gt_pm: SUCCESS (6.972s)
[469.572051] Starting dynamic subtest: gt_heartbeat
[474.020564] Dynamic subtest gt_heartbeat: SUCCESS (4.454s)
[474.030437] Starting dynamic subtest: gt_tlb
[483.522460] Dynamic subtest gt_tlb: SUCCESS (9.503s)
[483.532184] Starting dynamic subtest: requests
[497.453330] Dynamic subtest requests: SUCCESS (13.928s)
[497.466691] Starting dynamic subtest: migrate
[505.565177] Dynamic subtest migrate: SUCCESS (8.110s)
[505.575861] Starting dynamic subtest: active
[510.085367] Dynamic subtest active: SUCCESS (4.518s)
[510.095854] Starting dynamic subtest: objects
[514.983517] Dynamic subtest objects: SUCCESS (4.896s)
[514.994020] Starting dynamic subtest: mman
[520.093049] Dynamic subtest mman: SUCCESS (5.107s)
[520.103322] Starting dynamic subtest: dmabuf
[524.648082] Dynamic subtest dmabuf: SUCCESS (4.554s)
[524.657828] Starting dynamic subtest: vma
[529.197943] Dynamic subtest vma: SUCCESS (4.547s)
[529.208253] Starting dynamic subtest: coherency
[532.919990] Dynamic subtest coherency: SUCCESS (3.720s)
[532.929875] Starting dynamic subtest: gtt
[545.162357] Dynamic subtest gtt: SUCCESS (12.240s)
[545.178454] Starting dynamic subtest: gem
[550.888900] Dynamic subtest gem: SUCCESS (5.724s)
[550.900106] Starting dynamic subtest: evict
[556.441335] Dynamic subtest evict: SUCCESS (5.550s)
[556.451557] Starting dynamic subtest: hugepages
[567.629639] Dynamic subtest hugepages: SUCCESS (11.186s)
[567.640213] Starting dynamic subtest: gem_contexts
[596.734399] Dynamic subtest gem_contexts: SUCCESS (29.103s)
[596.745206] Starting dynamic subtest: client
[601.275968] Dynamic subtest client: SUCCESS (4.541s)
[601.285715] Starting dynamic subtest: gem_migrate
[605.809697] Dynamic subtest gem_migrate: SUCCESS (4.532s)
[605.819933] Starting dynamic subtest: reset
[610.328559] Dynamic subtest reset: SUCCESS (4.517s)
[610.344285] Starting dynamic subtest: memory_region
[614.891716] Dynamic subtest memory_region: SUCCESS (4.561s)
[614.902130] Starting dynamic subtest: hangcheck
[628.819045] Dynamic subtest hangcheck: SUCCESS (13.924s)
[628.829238] Starting dynamic subtest: execlists
[633.349589] Dynamic subtest execlists: SUCCESS (4.528s)
[633.359719] Starting dynamic subtest: ring_submission
[637.940801] Dynamic subtest ring_submission: SUCCESS (4.589s)
[637.957353] Starting dynamic subtest: perf
[640.957406] Dynamic subtest perf: SUCCESS (3.014s)
[640.967615] Starting dynamic subtest: slpc
[655.200318] Dynamic subtest slpc: SUCCESS (14.240s)
[655.210813] Starting dynamic subtest: guc
[659.340248] Dynamic subtest guc: SUCCESS (4.138s)
[659.354813] Starting dynamic subtest: guc_multi_lrc
[663.858377] Dynamic subtest guc_multi_lrc: SUCCESS (4.515s)
[663.869075] Starting dynamic subtest: guc_hang
[668.865229] Dynamic subtest guc_hang: SUCCESS (5.004s)
[668.875422] Starting dynamic subtest: late_gt_pm
[673.305742] Dynamic subtest late_gt_pm: SUCCESS (4.438s)
[673.308409] Subtest live: FAIL (273.125s)
[673.337608] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[673.338368] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[673.341488] [088/131] (355s left) prime_busy (hang)
[674.864256] Starting subtest: hang
[674.869026] Starting dynamic subtest: rcs0
[701.434630] Dynamic subtest rcs0: SUCCESS (26.552s)
[701.445856] Starting dynamic subtest: bcs0
[708.589367] Dynamic subtest bcs0: SUCCESS (7.155s)
[708.600666] Starting dynamic subtest: vcs0
[715.563060] Dynamic subtest vcs0: SUCCESS (6.976s)
[715.571832] Starting dynamic subtest: vcs1
[722.595225] Dynamic subtest vcs1: SUCCESS (7.035s)
[722.605855] Starting dynamic subtest: vecs0
[729.579260] Dynamic subtest vecs0: SUCCESS (6.975s)
[729.590532] Starting dynamic subtest: ccs0
[743.415578] Dynamic subtest ccs0: SUCCESS (13.835s)
[743.417941] Subtest hang: SUCCESS (68.539s)
[743.526585] [FACT prime_busy (hang)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[743.527900] [FACT prime_busy (hang)] new: kernel.kmod_is_loaded.i915: true
[743.532018] [089/131] (285s left) gen7_exec_parse (basic-allocation)
[743.600943] Subtest basic-allocation: SKIP (0.000s)
[743.670393] [090/131] (285s left) kms_prop_blob (invalid-set-prop-any)
[743.727143] Starting subtest: invalid-set-prop-any
[743.729023] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[743.851133] [091/131] (285s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[743.907558] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[744.009065] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[744.118190] [092/131] (284s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[744.182710] Starting subtest: multi-wait-for-submit-submitted-signaled
[744.185070] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[744.316470] [093/131] (284s left) gem_ctx_persistence (engines-hang)
[744.378348] Starting subtest: engines-hang
[744.380721] Starting dynamic subtest: rcs0
[744.487584] Dynamic subtest rcs0: SUCCESS (0.109s)
[744.499675] Starting dynamic subtest: bcs0
[744.585207] Dynamic subtest bcs0: SUCCESS (0.096s)
[744.595754] Starting dynamic subtest: vcs0
[744.703247] Dynamic subtest vcs0: SUCCESS (0.116s)
[744.715609] Starting dynamic subtest: vcs1
[744.783221] Dynamic subtest vcs1: SUCCESS (0.078s)
[744.793120] Starting dynamic subtest: vecs0
[744.936717] Dynamic subtest vecs0: SUCCESS (0.151s)
[744.948608] Starting dynamic subtest: ccs0
[745.018307] Dynamic subtest ccs0: SUCCESS (0.080s)
[745.020371] Subtest engines-hang: SUCCESS (0.641s)
[745.169094] [094/131] (283s left) kms_cursor_crc (cursor-offscreen-32x10)
[745.336190] Starting subtest: cursor-offscreen-32x10
[745.385359] Subtest cursor-offscreen-32x10: SKIP (0.046s)
[745.662126] [095/131] (283s left) gem_mmap_gtt (big-copy-xy)
[745.719874] Subtest big-copy-XY: SKIP (0.000s)
[745.776780] [096/131] (283s left) dmabuf (all-tests)
[745.816223] Starting subtest: all-tests
[745.818263] Starting dynamic subtest: sanitycheck
[745.939491] Dynamic subtest sanitycheck: SUCCESS (0.121s)
[745.952300] Starting dynamic subtest: dma_fence
[746.237466] Dynamic subtest dma_fence: SUCCESS (0.296s)
[746.249592] Starting dynamic subtest: dma_fence_chain
[754.956318] Dynamic subtest dma_fence_chain: SUCCESS (8.715s)
[754.967693] Starting dynamic subtest: dma_fence_unwrap
[755.098466] Dynamic subtest dma_fence_unwrap: SUCCESS (0.140s)
[755.110567] Starting dynamic subtest: dma_resv
[755.224357] Dynamic subtest dma_resv: SUCCESS (0.124s)
[755.227080] Subtest all-tests: SUCCESS (9.407s)
[755.305624] [097/131] (273s left) gem_mmap_wc (read-write-distinct)
[755.361772] Subtest read-write-distinct: SKIP (0.000s)
[755.428449] [098/131] (273s left) api_intel_allocator (two-level-inception)
[755.486274] Starting subtest: two-level-inception
[760.937519] Subtest two-level-inception: SUCCESS (5.400s)
[761.029517] [099/131] (268s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[761.134939] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[761.137197] Starting dynamic subtest: pipe-A-eDP-1
[761.162189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[761.174247] Starting dynamic subtest: pipe-B-eDP-1
[761.198181] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[761.208188] Starting dynamic subtest: pipe-C-eDP-1
[761.233054] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[761.243756] Starting dynamic subtest: pipe-D-eDP-1
[761.267203] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[761.271188] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[763.370131] [100/131] (265s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[763.485609] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[764.288324] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.804s)
[764.474811] [101/131] (264s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[764.532851] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[764.601923] [102/131] (264s left) gem_huc_copy (huc-copy)
[764.664150] Starting subtest: huc-copy
[764.668915] Subtest huc-copy: SUCCESS (0.003s)
[764.804624] [103/131] (264s left) kms_addfb_basic (bo-too-small)
[764.902916] Starting subtest: bo-too-small
[764.905227] Subtest bo-too-small: SUCCESS (0.000s)
[765.041512] [104/131] (264s left) kms_fbcon_fbt (fbc-suspend)
[765.103669] Starting subtest: fbc-suspend
[813.215496] Subtest fbc-suspend: SUCCESS (18.874s)
[814.316136] [105/131] (215s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[814.436738] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[814.439028] Starting dynamic subtest: pipe-A-eDP-1
[814.463763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[814.475634] Starting dynamic subtest: pipe-B-eDP-1
[814.498230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[814.507631] Starting dynamic subtest: pipe-C-eDP-1
[814.530498] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[814.539736] Starting dynamic subtest: pipe-D-eDP-1
[814.563248] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[814.567078] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[816.896524] [106/131] (212s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[816.983063] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[816.985372] Starting dynamic subtest: pipe-A-eDP-1
[817.007977] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[817.020163] Starting dynamic subtest: pipe-B-eDP-1
[817.041308] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[817.050602] Starting dynamic subtest: pipe-C-eDP-1
[817.072192] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[817.080840] Starting dynamic subtest: pipe-D-eDP-1
[817.103122] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[817.107559] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[819.463496] [107/131] (210s left) kms_psr (psr2-cursor-blt)
[819.564856] Starting subtest: psr2-cursor-blt
[819.567272] Starting dynamic subtest: eDP-1
[821.222128] Dynamic subtest eDP-1: SUCCESS (1.657s)
[821.224595] Subtest psr2-cursor-blt: SUCCESS (1.658s)
[822.033662] [108/131] (207s left) kms_psr2_su (page_flip-xrgb8888)
[822.088045] Subtest page_flip-XRGB8888: SKIP (0.000s)
[822.151579] [109/131] (207s left) kms_flip (2x-nonexisting-fb-interruptible)
[822.253288] Starting subtest: 2x-nonexisting-fb-interruptible
[822.264384] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[822.353863] [110/131] (207s left) kms_flip (blocking-absolute-wf_vblank)
[822.449714] Starting subtest: blocking-absolute-wf_vblank
[822.452023] Starting dynamic subtest: A-eDP1
[831.214337] Dynamic subtest A-eDP1: SUCCESS (8.730s)
[831.224951] Starting dynamic subtest: B-eDP1
[839.941473] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[839.953017] Starting dynamic subtest: C-eDP1
[848.674594] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[848.686273] Starting dynamic subtest: D-eDP1
[857.402309] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[857.404721] Subtest blocking-absolute-wf_vblank: SUCCESS (34.910s)
[858.592913] [111/131] (171s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[858.699448] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[859.700891] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.000s)
[859.868948] [112/131] (169s left) syncobj_basic (bad-pad-fd-to-handle)
[859.927042] Starting subtest: bad-pad-fd-to-handle
[859.929129] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[860.041236] [113/131] (169s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[860.132156] Starting subtest: flip-vs-dpms-on-nop-interruptible
[860.134026] Starting dynamic subtest: A-eDP1
[861.966340] Dynamic subtest A-eDP1: SUCCESS (1.832s)
[861.979040] Starting dynamic subtest: B-eDP1
[863.793415] Dynamic subtest B-eDP1: SUCCESS (1.824s)
[863.805612] Starting dynamic subtest: C-eDP1
[865.610208] Dynamic subtest C-eDP1: SUCCESS (1.815s)
[865.620621] Starting dynamic subtest: D-eDP1
[867.445310] Dynamic subtest D-eDP1: SUCCESS (1.834s)
[867.447638] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.315s)
[868.640618] [114/131] (161s left) perf_pmu (init-sema)
[868.685805] Starting subtest: init-sema
[868.688379] Starting dynamic subtest: rcs0
[868.690874] Dynamic subtest rcs0: SUCCESS (0.002s)
[868.702377] Starting dynamic subtest: bcs0
[868.704359] Dynamic subtest bcs0: SUCCESS (0.000s)
[868.713577] Starting dynamic subtest: vcs0
[868.715541] Dynamic subtest vcs0: SUCCESS (0.001s)
[868.724428] Starting dynamic subtest: vcs1
[868.726424] Dynamic subtest vcs1: SUCCESS (0.000s)
[868.735456] Starting dynamic subtest: vecs0
[868.737419] Dynamic subtest vecs0: SUCCESS (0.000s)
[868.746319] Starting dynamic subtest: ccs0
[868.748299] Dynamic subtest ccs0: SUCCESS (0.000s)
[868.750635] Subtest init-sema: SUCCESS (0.008s)
[868.825485] [115/131] (161s left) gem_exec_balancer (parallel-keep-in-fence)
[869.095133] Starting subtest: parallel-keep-in-fence
[870.244183] Subtest parallel-keep-in-fence: SUCCESS (1.149s)
[870.369807] [116/131] (159s left) syncobj_wait (single-wait-for-submit-signaled)
[870.416696] Starting subtest: single-wait-for-submit-signaled
[870.418933] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[870.530681] [117/131] (159s left) gem_spin_batch (spin-all-new)
[870.600241] Starting subtest: spin-all-new
[870.613025] Subtest spin-all-new: SUCCESS (0.014s)
[872.206674] [118/131] (157s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[872.308396] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[872.312674] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[872.429994] [119/131] (157s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[872.536286] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[879.827014] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.295s)
[879.992416] [120/131] (150s left) syncobj_timeline (multi-wait-available-submitted)
[880.050833] Starting subtest: multi-wait-available-submitted
[880.053138] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[880.158928] [121/131] (150s left) api_intel_bb (render-ccs)
[880.216220] Starting subtest: render-ccs
[880.567031] Subtest render-ccs: SUCCESS (0.352s)
[880.675247] [122/131] (149s left) perf (buffer-fill)
[880.802165] Starting subtest: buffer-fill
[880.804125] Starting dynamic subtest: 0-rcs0
[883.055069] Dynamic subtest 0-rcs0: SUCCESS (2.253s)
[883.066251] Starting dynamic subtest: 1-vcs1
[887.494625] Dynamic subtest 1-vcs1: SUCCESS (4.438s)
[887.497299] Subtest buffer-fill: SUCCESS (6.693s)
[887.545362] [123/131] (142s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[887.669622] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[887.674154] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[887.839168] [124/131] (142s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[887.887380] Starting subtest: single-wait-all-for-submit-available-submitted
[887.889554] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[888.031035] [125/131] (142s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[888.130920] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[895.097871] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.969s)
[895.275543] [126/131] (135s left) kms_cursor_edge_walk (64x64-right-edge)
[895.383803] Starting subtest: 64x64-right-edge
[895.386084] Starting dynamic subtest: pipe-A-eDP-1
[898.841624] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[898.852339] Starting dynamic subtest: pipe-D-eDP-1
[901.966904] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[901.969366] Subtest 64x64-right-edge: SUCCESS (6.583s)
[902.788625] [127/131] (127s left) gem_exec_schedule (in-order)
[902.870292] Starting subtest: in-order
[902.872316] Starting dynamic subtest: rcs0
[902.963858] Dynamic subtest rcs0: SUCCESS (0.100s)
[902.976635] Starting dynamic subtest: vcs0
[903.045563] Dynamic subtest vcs0: SUCCESS (0.081s)
[903.057403] Starting dynamic subtest: vcs1
[903.124577] Dynamic subtest vcs1: SUCCESS (0.078s)
[903.136932] Starting dynamic subtest: vecs0
[903.202737] Dynamic subtest vecs0: SUCCESS (0.077s)
[903.215660] Starting dynamic subtest: ccs0
[903.282159] Dynamic subtest ccs0: SUCCESS (0.078s)
[903.285021] Subtest in-order: SUCCESS (0.420s)
[904.260819] [128/131] (126s left) gem_pipe_control_store_loop (reused-buffer)
[904.325398] Starting subtest: reused-buffer
[906.477430] Subtest reused-buffer: SUCCESS (2.151s)
[906.631833] [129/131] (123s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[906.742391] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[910.740545] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.002s)
[911.908721] [130/131] (118s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[916.859641] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[916.864035] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[917.717948] [131/131] (112s left) kms_plane_multiple (2x-tiling-4)
[917.806259] Starting subtest: 2x-tiling-4
[917.810222] Subtest 2x-tiling-4: SKIP (0.000s)
[917.886721] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_color
results: parsing output: 4/ for test: kms_dsc
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_ctx_shared
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: gem_pread
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: gem_pread
results: parsing output: 21/ for test: kms_tiled_display
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_pm_rc6_residency
results: parsing output: 25/ for test: gem_flink_basic
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: drm_read
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: kms_writeback
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: fbdev
results: parsing output: 42/ for test: kms_getfb
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: kms_atomic_transition
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: gem_mmap_offset
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: gem_pxp
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_busy
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_pipe_crc_basic
results: parsing output: 61/ for test: gem_bad_reloc
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: gem_ctx_param
results: parsing output: 66/ for test: gem_mmap
results: parsing output: 67/ for test: kms_invalid_mode
results: parsing output: 68/ for test: gen9_exec_parse
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: i915_hangman
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: i915_selftest
results: parsing output: 87/ for test: prime_busy
results: parsing output: 88/ for test: gen7_exec_parse
results: parsing output: 89/ for test: kms_prop_blob
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: dmabuf
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: api_intel_allocator
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: gem_huc_copy
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: kms_fbcon_fbt
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_psr2_su
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: syncobj_basic
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: gem_spin_batch
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_cursor_edge_walk
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_pipe_control_store_loop
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_plane_multiple
Done.