[59.011477] Initializing watchdogs
[59.011541]   /dev/watchdog0
[59.026594] [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]
[59.031113] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.033479] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.036686] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[59.164705] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[63.182673] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.019s)
[64.320810] [002/133] (955s left) gem_readwrite (beyond-eob)
[64.374401] Subtest beyond-EOB: SKIP (0.000s)
[64.425802] [003/133] (955s left) kms_addfb_basic (too-high)
[64.517592] Starting subtest: too-high
[64.519783] Subtest too-high: SUCCESS (0.001s)
[64.623664] [004/133] (955s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[64.709816] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[64.712239] Starting dynamic subtest: pipe-A-eDP-1
[64.733459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[64.748081] Starting dynamic subtest: pipe-B-eDP-1
[64.768431] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[64.777683] Starting dynamic subtest: pipe-C-eDP-1
[64.797242] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[64.806365] Starting dynamic subtest: pipe-D-eDP-1
[64.826117] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[64.828330] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[66.955876] [005/133] (952s left) gem_lmem_swapping (parallel-random-verify)
[67.001810] Subtest parallel-random-verify: SKIP (0.000s)
[67.037406] [006/133] (952s left) kms_chamelium_audio (dp-audio-edid)
[67.419740] Subtest dp-audio-edid: SKIP (0.000s)
[68.265014] [007/133] (951s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[68.412476] Starting subtest: dp-mst-type-1-suspend-resume
[68.417110] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[68.539619] [008/133] (951s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[68.664059] Starting subtest: short-busy-flip-before-cursor-toggle
[68.668665] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[68.807661] [009/133] (951s left) kms_lease (setcrtc-implicit-plane)
[68.890742] Starting subtest: setcrtc-implicit-plane
[68.893068] Starting dynamic subtest: pipe-A-eDP-1
[69.361445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.471s)
[69.368725] Starting dynamic subtest: pipe-B-eDP-1
[70.523251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s)
[70.530436] Starting dynamic subtest: pipe-C-eDP-1
[71.635482] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[71.647912] Starting dynamic subtest: pipe-D-eDP-1
[72.772645] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[72.775137] Subtest setcrtc-implicit-plane: SUCCESS (3.882s)
[73.626897] [010/133] (946s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[73.721366] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[73.725493] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[73.824645] [011/133] (946s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[73.914354] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[73.918704] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[73.993604] [012/133] (945s left) kms_addfb_basic (bad-pitch-63)
[74.050920] Starting subtest: bad-pitch-63
[74.053281] Subtest bad-pitch-63: SUCCESS (0.000s)
[74.188313] [013/133] (945s left) gem_userptr_blits (unsync-overlap)
[74.249555] Subtest unsync-overlap: SKIP (0.000s)
[74.369597] [014/133] (945s left) gem_exec_balancer (full-late)
[74.432262] Starting subtest: full-late
[79.108548] Subtest full-late: SUCCESS (4.675s)
[79.427192] [015/133] (940s left) kms_flip (dpms-off-confusion-interruptible)
[79.520965] Starting subtest: dpms-off-confusion-interruptible
[79.523477] Starting dynamic subtest: A-eDP1
[88.221083] Dynamic subtest A-eDP1: SUCCESS (8.698s)
[88.232054] Starting dynamic subtest: B-eDP1
[96.859640] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[96.870101] Starting dynamic subtest: C-eDP1
[105.480368] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[105.489752] Starting dynamic subtest: D-eDP1
[114.112375] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[114.114886] Subtest dpms-off-confusion-interruptible: SUCCESS (34.592s)
[115.332940] [016/133] (904s left) gem_ctx_persistence (heartbeat-hostile)
[115.396054] Starting subtest: heartbeat-hostile
[115.400769] Subtest heartbeat-hostile: SKIP (0.000s)
[115.494953] [017/133] (904s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[115.605858] Starting subtest: flip-vs-cursor-atomic-transitions
[123.438215] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.831s)
[124.237564] [018/133] (896s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[124.343167] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[125.144683] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s)
[125.315013] [019/133] (894s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[125.418497] Starting subtest: fbcpsr-rgb565-draw-render
[132.445183] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.030s)
[132.567330] [020/133] (887s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[132.633956] Starting subtest: single-wait-for-submit-unsubmitted
[132.738129] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[132.808050] [021/133] (887s left) gem_exec_reloc (basic-concurrent16)
[132.875627] Subtest basic-concurrent16: SKIP (0.000s)
[132.948146] [022/133] (887s left) kms_sequence (get-forked-busy)
[133.043992] Starting subtest: get-forked-busy
[133.046334] Starting dynamic subtest: pipe-A-eDP-1
[134.987393] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[134.996376] Starting dynamic subtest: pipe-B-eDP-1
[137.568281] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.580s)
[137.578060] Starting dynamic subtest: pipe-C-eDP-1
[140.194058] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.626s)
[140.202758] Starting dynamic subtest: pipe-D-eDP-1
[142.802073] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s)
[142.804536] Subtest get-forked-busy: SUCCESS (9.760s)
[143.601113] [023/133] (876s left) gem_exec_params (no-bsd)
[143.660463] Starting subtest: no-bsd
[143.662996] Subtest no-bsd: SUCCESS (0.003s)
[145.341988] [024/133] (875s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[145.439155] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[145.441403] Starting dynamic subtest: pipe-A
[145.670726] Dynamic subtest pipe-A: SUCCESS (0.229s)
[145.680760] Starting dynamic subtest: pipe-B
[146.983490] Dynamic subtest pipe-B: SUCCESS (1.314s)
[146.991675] Starting dynamic subtest: pipe-C
[148.303078] Dynamic subtest pipe-C: SUCCESS (1.319s)
[148.312452] Starting dynamic subtest: pipe-D
[149.631171] Dynamic subtest pipe-D: SUCCESS (1.327s)
[149.633648] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.192s)
[150.820854] [025/133] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[150.912669] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[150.917106] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[150.999330] [026/133] (869s left) kms_hdr (bpc-switch)
[151.087463] Starting subtest: bpc-switch
[152.192680] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[155.596187] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (3.405s)
[156.642559] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[160.121536] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (3.488s)
[160.123887] Subtest bpc-switch: SUCCESS (9.037s)
[160.222888] [027/133] (860s left) kms_invalid_mode (overflow-vrefresh)
[160.311289] Starting subtest: overflow-vrefresh
[160.313647] Starting dynamic subtest: pipe-A-eDP-1
[160.607850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[160.617272] Starting dynamic subtest: pipe-B-eDP-1
[160.619477] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[160.627317] Starting dynamic subtest: pipe-C-eDP-1
[160.629622] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[160.637517] Starting dynamic subtest: pipe-D-eDP-1
[160.639916] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[160.642241] Subtest overflow-vrefresh: SUCCESS (0.300s)
[161.416263] [028/133] (859s left) i915_pm_rpm (sysfs-read)
[163.439684] Starting subtest: sysfs-read
[164.602592] Subtest sysfs-read: SUCCESS (1.158s)
[164.962688] [029/133] (855s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[165.020331] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[165.024709] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[165.204388] [030/133] (855s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[165.317193] Starting subtest: fbc-psr2-sprite-mmap-gtt
[165.319488] Starting dynamic subtest: eDP-1
[165.323585] Dynamic subtest eDP-1: SKIP (0.000s)
[165.327700] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[165.384334] [031/133] (855s left) gem_fence_thrash (bo-write-verify-threaded-none)
[165.424321] Starting subtest: bo-write-verify-threaded-none
[165.436319] Subtest bo-write-verify-threaded-none: SKIP (0.012s)
[165.496085] [032/133] (855s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[165.605386] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[166.605436] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.001s)
[166.717360] [033/133] (854s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[166.825797] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[166.828082] Starting dynamic subtest: pipe-A-eDP-1
[166.836813] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[166.845610] Starting dynamic subtest: pipe-B-eDP-1
[166.854285] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[166.862318] Starting dynamic subtest: pipe-C-eDP-1
[166.869718] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[166.876839] Starting dynamic subtest: pipe-D-eDP-1
[166.883723] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.887176] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[169.028434] [034/133] (851s left) gem_exec_suspend (basic-s0)
[169.081214] Starting subtest: basic-S0
[169.083519] Starting dynamic subtest: smem
[188.748396] Dynamic subtest smem: SUCCESS (6.188s)
[188.751195] Subtest basic-S0: SUCCESS (6.190s)
[188.931377] [035/133] (831s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[189.040094] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[189.042019] Starting dynamic subtest: pipe-A-eDP-1
[189.469937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[189.482020] Starting dynamic subtest: pipe-B-eDP-1
[189.502601] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[189.512172] Starting dynamic subtest: pipe-C-eDP-1
[189.532289] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[189.543077] Starting dynamic subtest: pipe-D-eDP-1
[189.562700] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[189.564949] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.438s)
[191.769573] [036/133] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[191.874735] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[191.879216] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[191.974832] [037/133] (828s left) gem_exec_fence (syncobj-repeat)
[192.474622] Starting subtest: syncobj-repeat
[192.665022] Subtest syncobj-repeat: SUCCESS (0.190s)
[193.824171] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[193.827579] [038/133] (827s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[193.937632] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[193.942192] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[194.038738] [039/133] (827s left) gem_mmap_wc (coherency)
[194.101285] Subtest coherency: SKIP (0.000s)
[194.169250] [040/133] (826s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[194.281437] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[194.285616] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[194.399057] [041/133] (826s left) perf_pmu (busy-accuracy-50)
[194.440684] Starting subtest: busy-accuracy-50
[194.442717] Starting dynamic subtest: rcs0
[195.981031] Dynamic subtest rcs0: SUCCESS (1.527s)
[195.992628] Starting dynamic subtest: bcs0
[197.531627] Dynamic subtest bcs0: SUCCESS (1.540s)
[197.543603] Starting dynamic subtest: vcs0
[199.073444] Dynamic subtest vcs0: SUCCESS (1.533s)
[199.085939] Starting dynamic subtest: vcs1
[200.620553] Dynamic subtest vcs1: SUCCESS (1.539s)
[200.632245] Starting dynamic subtest: vecs0
[202.164512] Dynamic subtest vecs0: SUCCESS (1.537s)
[202.176098] Starting dynamic subtest: ccs0
[203.716530] Dynamic subtest ccs0: SUCCESS (1.546s)
[203.718556] Subtest busy-accuracy-50: SUCCESS (9.231s)
[203.830504] [042/133] (817s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[203.944312] Starting subtest: x-tiled-8bpp-rotate-180
[205.103522] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.157s)
[205.228779] [043/133] (815s left) gem_mmap_wc (write-gtt-read-wc)
[205.281356] Subtest write-gtt-read-wc: SKIP (0.000s)
[205.347292] [044/133] (815s left) gem_userptr_blits (create-destroy-sync)
[205.411831] Starting subtest: create-destroy-sync
[210.420077] Subtest create-destroy-sync: SUCCESS (4.999s)
[210.537645] [045/133] (810s left) i915_drm_fdinfo (virtual-busy-all)
[210.580553] Starting subtest: virtual-busy-all
[210.585537] Subtest virtual-busy-all: SKIP (0.000s)
[210.652760] [046/133] (810s left) gem_partial_pwrite_pread (write)
[210.710266] Subtest write: SKIP (0.000s)
[210.794336] [047/133] (810s left) kms_pm_rpm (cursor-dpms)
[212.926348] Starting subtest: cursor-dpms
[212.931858] Subtest cursor-dpms: SKIP (0.000s)
[213.322218] [048/133] (808s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[213.702548] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[214.519147] [049/133] (806s left) kms_vblank (query-forked-busy-hang)
[214.612825] Starting subtest: query-forked-busy-hang
[214.615017] Starting dynamic subtest: pipe-A-eDP-1
[241.491936] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.875s)
[241.507296] Starting dynamic subtest: pipe-D-eDP-1
[266.513167] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.011s)
[266.515400] Subtest query-forked-busy-hang: SUCCESS (51.890s)
[267.318727] [050/133] (754s left) gem_exec_balancer (persistence)
[267.580273] Starting subtest: persistence
[268.538752] Subtest persistence: SUCCESS (0.958s)
[268.660767] [051/133] (752s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[268.729347] Starting subtest: x-tiled-to-vebox-yf-tiled
[268.733588] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[268.913446] [052/133] (752s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[269.002275] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[269.004632] Starting dynamic subtest: pipe-A
[269.124519] Dynamic subtest pipe-A: SKIP (0.118s)
[269.135240] Starting dynamic subtest: pipe-B
[270.276187] Dynamic subtest pipe-B: SKIP (1.151s)
[270.285938] Starting dynamic subtest: pipe-C
[271.412414] Dynamic subtest pipe-C: SUCCESS (1.141s)
[271.423017] Starting dynamic subtest: pipe-D
[272.547904] Dynamic subtest pipe-D: SUCCESS (1.134s)
[272.550263] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.547s)
[273.751233] [053/133] (747s left) gem_exec_reloc (basic-wc-cpu)
[273.811826] Subtest basic-wc-cpu: SKIP (0.000s)
[273.886841] [054/133] (747s left) kms_addfb_basic (bo-too-small)
[273.986918] Starting subtest: bo-too-small
[273.989328] Subtest bo-too-small: SUCCESS (0.000s)
[274.095271] [055/133] (747s left) gem_softpin (reverse)
[274.156571] Starting subtest: reverse
[274.161971] Subtest reverse: SUCCESS (0.005s)
[274.299193] [056/133] (747s left) gem_exec_gttfill (basic)
[274.366469] Starting subtest: basic
[276.894118] Subtest basic: SUCCESS (2.529s)
[277.089778] [057/133] (744s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[277.247763] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[277.252175] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[277.326222] [058/133] (744s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[277.416273] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[277.442163] Starting dynamic subtest: pipe-A-plane-0
[277.886434] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[277.897163] Starting dynamic subtest: pipe-A-plane-3
[278.152876] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s)
[278.165098] Starting dynamic subtest: pipe-A-plane-5
[278.168975] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[279.238534] Starting dynamic subtest: pipe-B-plane-0
[279.685862] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[279.697840] Starting dynamic subtest: pipe-B-plane-3
[279.953050] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[279.964741] Starting dynamic subtest: pipe-B-plane-5
[279.969384] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[280.272670] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.857s)
[281.123126] [059/133] (740s left) kms_busy (extended-modeset-hang-newfb)
[281.234015] Starting subtest: extended-modeset-hang-newfb
[281.236327] Starting dynamic subtest: pipe-A
[316.404135] Dynamic subtest pipe-A: SUCCESS (35.171s)
[316.414841] Starting dynamic subtest: pipe-D
[339.665129] Dynamic subtest pipe-D: SUCCESS (23.257s)
[339.667488] Subtest extended-modeset-hang-newfb: SUCCESS (58.432s)
[340.559551] [060/133] (681s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[340.663498] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[340.667767] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[340.759138] [061/133] (681s left) api_intel_allocator (open-vm)
[340.815812] Starting subtest: open-vm
[340.818102] Subtest open-vm: SUCCESS (0.003s)
[340.938429] [062/133] (681s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[341.041855] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[341.427850] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[344.244391] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.815s)
[344.257002] Starting dynamic subtest: pipe-A-eDP-1-4
[346.430352] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[346.445140] Starting dynamic subtest: pipe-A-eDP-1-4
[348.440028] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[348.449393] Starting dynamic subtest: pipe-A-eDP-1-x
[350.630843] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[351.002026] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[353.767183] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[353.779796] Starting dynamic subtest: pipe-B-eDP-1-4
[355.952310] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[355.964235] Starting dynamic subtest: pipe-B-eDP-1-4
[357.963000] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[357.976416] Starting dynamic subtest: pipe-B-eDP-1-x
[360.153766] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[360.521641] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[363.291447] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[363.302875] Starting dynamic subtest: pipe-C-eDP-1-4
[365.466699] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[365.481230] Starting dynamic subtest: pipe-C-eDP-1-4
[367.477366] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[367.493259] Starting dynamic subtest: pipe-C-eDP-1-x
[369.645729] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[370.015073] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[372.732672] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.724s)
[372.742293] Starting dynamic subtest: pipe-D-eDP-1-4
[374.918829] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[374.934661] Starting dynamic subtest: pipe-D-eDP-1-4
[376.929764] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.007s)
[376.945510] Starting dynamic subtest: pipe-D-eDP-1-x
[379.098431] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.166s)
[379.101005] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.048s)
[380.323496] [063/133] (641s left) drm_read (short-buffer-wakeup)
[380.468291] Starting subtest: short-buffer-wakeup
[412.689369] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[412.846035] [064/133] (609s left) kms_prop_blob (blob-prop-core)
[412.906668] Starting subtest: blob-prop-core
[412.908582] Subtest blob-prop-core: SUCCESS (0.000s)
[413.031504] [065/133] (609s left) kms_atomic (plane-invalid-params)
[413.133617] Starting subtest: plane-invalid-params
[413.135970] Starting dynamic subtest: pipe-A-eDP-1
[413.536836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.403s)
[413.539438] Subtest plane-invalid-params: SUCCESS (0.404s)
[414.347367] [066/133] (607s left) kms_cursor_crc (cursor-offscreen-max-size)
[414.642738] Starting subtest: cursor-offscreen-max-size
[414.649197] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[414.768428] [067/133] (607s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[414.820957] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[414.823258] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[414.920147] [068/133] (607s left) gem_vm_create (execbuf)
[414.977347] Starting subtest: execbuf
[414.984834] Subtest execbuf: SUCCESS (0.009s)
[415.105775] [069/133] (607s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[415.210725] Starting subtest: cursorA-vs-flipB-varying-size
[415.214413] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[415.365406] [070/133] (606s left) kms_psr (fbc-pr-cursor-blt)
[415.455229] Starting subtest: fbc-pr-cursor-blt
[415.458988] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[415.530243] [071/133] (606s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[415.619750] Starting subtest: plane-lut1d-ctm3x4-lut1d
[415.758389] Starting dynamic subtest: pipe-A-plane-0
[415.901039] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[415.910682] Starting dynamic subtest: pipe-A-plane-1
[416.045695] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[416.058221] Starting dynamic subtest: pipe-A-plane-2
[416.190136] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s)
[417.341451] Starting dynamic subtest: pipe-B-plane-0
[417.477672] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[417.487586] Starting dynamic subtest: pipe-B-plane-1
[417.664915] Dynamic subtest pipe-B-plane-1: SUCCESS (0.187s)
[417.674949] Starting dynamic subtest: pipe-B-plane-2
[417.798585] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[418.975379] Starting dynamic subtest: pipe-C-plane-0
[419.098338] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[419.108699] Starting dynamic subtest: pipe-C-plane-1
[419.232486] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[419.247575] Starting dynamic subtest: pipe-C-plane-2
[419.399169] Dynamic subtest pipe-C-plane-2: SUCCESS (0.163s)
[420.628553] Starting dynamic subtest: pipe-D-plane-0
[420.753930] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[420.764139] Starting dynamic subtest: pipe-D-plane-1
[420.898337] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[420.908084] Starting dynamic subtest: pipe-D-plane-2
[421.042655] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[421.329777] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.710s)
[422.191808] [072/133] (600s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[422.256467] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[422.320363] [073/133] (600s left) gem_mmap_gtt (zero-extend)
[422.383231] Subtest zero-extend: SKIP (0.000s)
[422.445759] [074/133] (600s left) gem_ctx_param (invalid-set-no-zeromap)
[422.491679] Starting subtest: invalid-set-no-zeromap
[422.494012] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[422.557084] [075/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[422.655611] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[422.659727] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[422.757107] [076/133] (599s left) gem_exec_params (sol-reset-not-gen7)
[422.811439] Starting subtest: sol-reset-not-gen7
[422.813734] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[422.942191] [077/133] (599s left) gem_mmap_wc (fault-concurrent)
[422.990176] Subtest fault-concurrent: SKIP (0.000s)
[423.043335] [078/133] (599s left) syncobj_eventfd (invalid-bad-flags)
[423.088990] Starting subtest: invalid-bad-flags
[423.091256] Subtest invalid-bad-flags: SUCCESS (0.000s)
[423.177205] [079/133] (599s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[423.268737] Starting subtest: 4-tiled-8bpp-rotate-0
[424.483036] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.215s)
[424.606770] [080/133] (598s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[424.699305] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[424.703019] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[424.776424] [081/133] (598s left) core_getclient (basic)
[424.822371] Starting subtest: basic
[424.824212] Subtest basic: SUCCESS (0.000s)
[424.934259] [082/133] (597s left) kms_addfb_basic (unused-offsets)
[424.988798] Starting subtest: unused-offsets
[424.990400] Subtest unused-offsets: SUCCESS (0.000s)
[425.127952] [083/133] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[425.223743] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[425.227709] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[425.318394] [084/133] (597s left) gem_exec_schedule (lateslice)
[425.391442] Starting subtest: lateslice
[425.393141] Starting dynamic subtest: rcs0
[425.411689] Dynamic subtest rcs0: SUCCESS (0.023s)
[425.423657] Starting dynamic subtest: bcs0
[425.434187] Dynamic subtest bcs0: SUCCESS (0.022s)
[425.443069] Starting dynamic subtest: vcs0
[425.454231] Dynamic subtest vcs0: SUCCESS (0.019s)
[425.463026] Starting dynamic subtest: vcs1
[425.470901] Dynamic subtest vcs1: SUCCESS (0.016s)
[425.479829] Starting dynamic subtest: vecs0
[425.489851] Dynamic subtest vecs0: SUCCESS (0.018s)
[425.502409] Starting dynamic subtest: ccs0
[425.507463] Dynamic subtest ccs0: SUCCESS (0.017s)
[425.509312] Subtest lateslice: SUCCESS (0.120s)
[426.839798] [085/133] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[426.945197] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[426.949332] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[427.056840] [086/133] (595s left) kms_scaling_modes (scaling-mode-full)
[427.155255] Starting subtest: scaling-mode-full
[427.157514] Starting dynamic subtest: pipe-A-eDP-1
[427.246549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[427.258905] Starting dynamic subtest: pipe-B-eDP-1
[428.400216] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[428.410670] Starting dynamic subtest: pipe-C-eDP-1
[429.519238] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[429.529455] Starting dynamic subtest: pipe-D-eDP-1
[430.653343] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[430.655587] Subtest scaling-mode-full: SUCCESS (3.501s)
[431.822267] [087/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[431.918167] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[431.922129] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[432.013398] [088/133] (591s left) fbdev (nullptr)
[432.067887] Starting subtest: nullptr
[432.069805] Subtest nullptr: SUCCESS (0.000s)
[432.120913] [089/133] (590s left) gem_exec_schedule (u-semaphore-resolve)
[432.191808] Starting subtest: u-semaphore-resolve
[432.230023] Subtest u-semaphore-resolve: SUCCESS (0.047s)
[432.576687] [090/133] (590s left) kms_pm_rpm (modeset-lpsp-stress)
[434.095471] Starting subtest: modeset-lpsp-stress
[450.577033] Subtest modeset-lpsp-stress: SUCCESS (16.487s)
[450.666105] [091/133] (572s left) kms_flip (blocking-absolute-wf_vblank)
[450.764774] Starting subtest: blocking-absolute-wf_vblank
[450.767309] Starting dynamic subtest: A-eDP1
[459.494923] Dynamic subtest A-eDP1: SUCCESS (8.733s)
[459.507654] Starting dynamic subtest: B-eDP1
[468.229900] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[468.242823] Starting dynamic subtest: C-eDP1
[476.948434] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[476.960838] Starting dynamic subtest: D-eDP1
[485.679653] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[485.681875] Subtest blocking-absolute-wf_vblank: SUCCESS (34.922s)
[486.904061] [092/133] (536s left) i915_pm_rps (thresholds)
[486.977065] Starting subtest: thresholds
[486.981272] Subtest thresholds: SKIP (0.001s)
[487.051008] [093/133] (536s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[487.151447] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[493.622744] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.474s)
[493.754408] [094/133] (529s left) kms_psr (psr-basic)
[493.850179] Starting subtest: psr-basic
[493.852511] Starting dynamic subtest: eDP-1
[495.507675] Dynamic subtest eDP-1: SUCCESS (1.657s)
[495.509762] Subtest psr-basic: SUCCESS (1.658s)
[496.388512] [095/133] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[496.474450] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[496.478348] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[496.566122] [096/133] (526s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[496.610986] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[496.682228] [097/133] (526s left) syncobj_timeline (wait-for-submit-delayed-submit)
[496.737376] Starting subtest: wait-for-submit-delayed-submit
[496.840987] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[496.933612] [098/133] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[497.040633] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[497.044715] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[497.140789] [099/133] (526s left) kms_psr (fbc-pr-primary-render)
[497.239345] Starting subtest: fbc-pr-primary-render
[497.243573] Subtest fbc-pr-primary-render: SKIP (0.000s)
[497.310828] [100/133] (526s left) gem_pwrite (basic-self)
[497.372930] Subtest basic-self: SKIP (0.000s)
[497.446408] [101/133] (526s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[497.541654] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[497.544002] Starting dynamic subtest: pipe-A-eDP-1
[508.234394] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.695s)
[508.244521] Starting dynamic subtest: pipe-B-eDP-1
[519.610779] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.372s)
[519.613187] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.070s)
[520.467688] [102/133] (503s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[520.572712] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[529.801228] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.230s)
[529.929143] [103/133] (493s left) gem_eio (throttle)
[530.165058] Starting subtest: throttle
[530.484864] Subtest throttle: SUCCESS (0.320s)
[530.596758] [104/133] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[530.691780] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[530.695908] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[530.796418] [105/133] (492s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[530.902419] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[537.941884] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.040s)
[538.088881] [106/133] (485s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[538.189394] Starting subtest: fbc-modesetfrombusy
[541.980583] Subtest fbc-modesetfrombusy: SUCCESS (3.795s)
[543.157945] [107/133] (480s left) prime_mmap_kms (buffer-sharing)
[543.257261] Starting subtest: buffer-sharing
[543.702458] Subtest buffer-sharing: SUCCESS (0.446s)
[544.579891] [108/133] (479s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[544.635674] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[544.717077] [109/133] (479s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[544.818882] Starting subtest: dsc-fractional-bpp-with-bpc
[544.848476] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[544.891874] [110/133] (479s left) kms_cursor_crc (cursor-random-128x42)
[545.113384] Starting subtest: cursor-random-128x42
[545.158044] Subtest cursor-random-128x42: SKIP (0.038s)
[545.389194] [111/133] (478s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[545.449378] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[545.558202] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[545.646536] [112/133] (478s left) i915_module_load (reload-no-display)
[545.685349] Starting subtest: reload-no-display
[553.160147] Subtest reload-no-display: SUCCESS (7.477s)
[553.190532] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[553.191256] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[553.194650] [113/133] (470s left) gen7_exec_parse (load-register-reg)
[554.711150] Subtest load-register-reg: SKIP (0.000s)
[554.748004] [FACT gen7_exec_parse (load-register-reg)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[554.749196] [FACT gen7_exec_parse (load-register-reg)] new: kernel.kmod_is_loaded.i915: true
[554.752774] [114/133] (469s left) kms_psr (pr-primary-mmap-gtt)
[554.863219] Starting subtest: pr-primary-mmap-gtt
[554.867555] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[554.938276] [115/133] (469s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[554.995369] Starting subtest: single-wait-all-for-submit-available-signaled
[554.997635] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[555.111055] [116/133] (469s left) kms_chamelium_hpd (hdmi-hpd-fast)
[555.524182] Subtest hdmi-hpd-fast: SKIP (0.000s)
[556.301042] [117/133] (467s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[556.389980] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[556.392316] Starting dynamic subtest: pipe-A-default-mode
[557.583006] Dynamic subtest pipe-A-default-mode: SKIP (1.191s)
[557.587569] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.192s)
[557.746426] [118/133] (466s left) perf_pmu (rc6-suspend)
[557.790067] Starting subtest: rc6-suspend
[580.097141] Subtest rc6-suspend: SUCCESS (7.465s)
[581.122496] [119/133] (443s left) syncobj_timeline (invalid-transfer-non-existent-point)
[581.179229] Starting subtest: invalid-transfer-non-existent-point
[581.181717] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[581.272871] [120/133] (443s left) kms_plane_multiple (tiling-none)
[581.374822] Starting subtest: tiling-none
[581.376746] Starting dynamic subtest: pipe-A-eDP-1
[585.078472] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.671s)
[585.089831] Starting dynamic subtest: pipe-B-eDP-1
[589.440873] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.341s)
[589.456991] Starting dynamic subtest: pipe-C-eDP-1
[593.794298] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.338s)
[593.803966] Starting dynamic subtest: pipe-D-eDP-1
[598.235603] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.430s)
[598.237572] Subtest tiling-none: SUCCESS (16.785s)
[599.055264] [121/133] (425s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[599.162534] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[599.167669] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[599.253769] [122/133] (425s left) gem_lmem_swapping (basic)
[599.304251] Subtest basic: SKIP (0.000s)
[599.352848] [123/133] (425s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[599.450980] Starting subtest: coverage-vs-premult-vs-constant
[599.748563] Starting dynamic subtest: pipe-A-eDP-1
[600.344855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[600.355029] Starting dynamic subtest: pipe-D-eDP-1
[601.663999] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[601.666853] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.213s)
[602.512478] [124/133] (422s left) gem_ctx_shared (q-in-order)
[602.579396] Starting subtest: Q-in-order
[602.581972] Starting dynamic subtest: rcs0
[602.686814] Dynamic subtest rcs0: SUCCESS (0.110s)
[602.705347] Starting dynamic subtest: vcs0
[602.773143] Dynamic subtest vcs0: SUCCESS (0.086s)
[602.790647] Starting dynamic subtest: vcs1
[602.851411] Dynamic subtest vcs1: SUCCESS (0.076s)
[602.868753] Starting dynamic subtest: vecs0
[602.932216] Dynamic subtest vecs0: SUCCESS (0.080s)
[602.950474] Starting dynamic subtest: ccs0
[603.022462] Dynamic subtest ccs0: SUCCESS (0.089s)
[603.025130] Subtest Q-in-order: SUCCESS (0.446s)
[604.638358] [125/133] (419s left) gem_exec_params (batch-first)
[604.698078] Starting subtest: batch-first
[604.704667] Subtest batch-first: SUCCESS (0.007s)
[604.824452] [126/133] (419s left) gem_mmap_gtt (basic-small-copy)
[604.875572] Subtest basic-small-copy: SKIP (0.000s)
[604.938210] [127/133] (419s left) gem_ctx_engines (execute-allforone)
[605.001555] Starting subtest: execute-allforone
[605.028422] Subtest execute-allforone: SUCCESS (0.027s)
[606.626411] [128/133] (418s left) kms_cursor_edge_walk (256x256-right-edge)
[606.725151] Starting subtest: 256x256-right-edge
[606.727563] Starting dynamic subtest: pipe-A-eDP-1
[610.199980] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[610.211085] Starting dynamic subtest: pipe-D-eDP-1
[613.327985] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[613.330380] Subtest 256x256-right-edge: SUCCESS (6.605s)
[614.130551] [129/133] (410s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[614.225653] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[614.227910] Starting dynamic subtest: pipe-A-eDP-1
[614.291294] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[614.301528] Starting dynamic subtest: pipe-B-eDP-1
[614.370128] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[614.380683] Starting dynamic subtest: pipe-C-eDP-1
[614.447085] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[614.456858] Starting dynamic subtest: pipe-D-eDP-1
[614.520892] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[614.525708] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[616.497101] [130/133] (408s left) prime_busy (after)
[616.552986] Starting subtest: after
[616.555972] Starting dynamic subtest: rcs0
[616.587071] Dynamic subtest rcs0: SUCCESS (0.034s)
[616.598862] Starting dynamic subtest: bcs0
[616.639752] Dynamic subtest bcs0: SUCCESS (0.052s)
[616.650947] Starting dynamic subtest: vcs0
[616.683738] Dynamic subtest vcs0: SUCCESS (0.043s)
[616.694029] Starting dynamic subtest: vcs1
[616.726442] Dynamic subtest vcs1: SUCCESS (0.042s)
[616.736167] Starting dynamic subtest: vecs0
[616.765907] Dynamic subtest vecs0: SUCCESS (0.039s)
[616.775315] Starting dynamic subtest: ccs0
[616.810401] Dynamic subtest ccs0: SUCCESS (0.044s)
[616.919275] Subtest after: SUCCESS (0.368s)
[616.998128] [131/133] (407s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[617.096348] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[617.101572] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[617.189708] [132/133] (407s left) kms_addfb_basic (invalid-set-prop-any)
[617.258509] Starting subtest: invalid-set-prop-any
[617.260769] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[617.384597] [133/133] (407s left) gem_tiled_pread_pwrite
[617.514394] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_readwrite
results: parsing output: 2/ for test: kms_addfb_basic
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_lmem_swapping
results: parsing output: 5/ for test: kms_chamelium_audio
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_lease
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_sequence
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_hdr
results: parsing output: 26/ for test: kms_invalid_mode
results: parsing output: 27/ for test: i915_pm_rpm
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_fence_thrash
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_exec_suspend
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: i915_drm_fdinfo
results: parsing output: 45/ for test: gem_partial_pwrite_pread
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: kms_chamelium_edid
results: parsing output: 48/ for test: kms_vblank
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: gem_exec_gttfill
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: kms_busy
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: api_intel_allocator
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: drm_read
results: parsing output: 63/ for test: kms_prop_blob
results: parsing output: 64/ for test: kms_atomic
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_vm_create
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_color_pipeline
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: gem_ctx_param
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: gem_mmap_wc
results: parsing output: 77/ for test: syncobj_eventfd
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: core_getclient
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_scaling_modes
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: fbdev
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: i915_pm_rps
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_pipe_b_c_ivb
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_pwrite
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: prime_mmap_kms
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_dsc
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_module_load
results: parsing output: 112/ for test: gen7_exec_parse
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_chamelium_hpd
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_plane_multiple
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_lmem_swapping
results: parsing output: 122/ for test: kms_plane_alpha_blend
results: parsing output: 123/ for test: gem_ctx_shared
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_ctx_engines
results: parsing output: 127/ for test: kms_cursor_edge_walk
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: prime_busy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_addfb_basic
results: parsing output: 132/ for test: gem_tiled_pread_pwrite
Done.