[57.375619] Initializing watchdogs
[57.375708]   /dev/watchdog0
[57.390796] [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.395350] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.398068] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.401439] [001/133] (960s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[57.799296] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[58.572364] [002/133] (959s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[58.628819] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[58.684379] [003/133] (959s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[58.783507] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[58.787793] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[58.873735] [004/133] (959s left) gem_softpin (evict-snoop-interruptible)
[58.942101] Starting subtest: evict-snoop-interruptible
[58.946347] Subtest evict-snoop-interruptible: SKIP (0.000s)
[59.068715] [005/133] (958s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[59.113803] Starting subtest: multi-wait-available-unsubmitted-submitted
[59.116102] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[59.232576] [006/133] (958s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[59.312882] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[59.317095] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[59.381084] [007/133] (958s left) drm_read (empty-block)
[59.549071] Starting subtest: empty-block
[60.550591] Subtest empty-block: SUCCESS (1.002s)
[60.681597] [008/133] (957s left) kms_vblank (query-busy-hang)
[60.777100] Starting subtest: query-busy-hang
[60.779436] Starting dynamic subtest: pipe-A-eDP-1
[87.715035] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.944s)
[87.726708] Starting dynamic subtest: pipe-D-eDP-1
[112.743507] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[112.745607] Subtest query-busy-hang: SUCCESS (51.975s)
[113.542683] [009/133] (904s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[113.653325] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[113.657514] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[113.747983] [010/133] (904s left) kms_big_fb (y-tiled-addfb)
[113.874249] Starting subtest: y-tiled-addfb
[113.878326] Subtest y-tiled-addfb: SKIP (0.000s)
[113.963454] [011/133] (904s left) syncobj_wait (multi-wait-signaled)
[114.029358] Starting subtest: multi-wait-signaled
[114.031704] Subtest multi-wait-signaled: SUCCESS (0.000s)
[114.134925] [012/133] (904s left) gem_lmem_evict (dontneed-evict-race)
[114.180169] Subtest dontneed-evict-race: SKIP (0.000s)
[114.220341] [013/133] (904s left) gem_set_tiling_vs_pwrite
[114.332099] [014/133] (904s left) syncobj_timeline (invalid-signal-bad-pad)
[114.383678] Starting subtest: invalid-signal-bad-pad
[114.385584] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[114.468388] [015/133] (903s left) kms_big_fb (linear-8bpp-rotate-270)
[114.573095] Starting subtest: linear-8bpp-rotate-270
[114.595606] Subtest linear-8bpp-rotate-270: SKIP (0.022s)
[114.717947] [016/133] (903s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[114.961628] Starting subtest: cursor-rapid-movement-256x256
[114.965799] Starting dynamic subtest: pipe-A-eDP-1
[115.508824] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[115.535882] Starting dynamic subtest: pipe-D-eDP-1
[116.771292] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[116.773739] Subtest cursor-rapid-movement-256x256: SUCCESS (1.808s)
[117.611930] [017/133] (900s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[117.672100] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[117.734842] [018/133] (900s left) gen9_exec_parse (unaligned-jump)
[117.813473] Subtest unaligned-jump: SKIP (0.000s)
[117.879814] [019/133] (900s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[117.985652] Starting subtest: 4-tiled-8bpp-rotate-0
[119.201209] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.216s)
[119.355211] [020/133] (899s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[119.446966] Starting subtest: 2x-absolute-wf_vblank-interruptible
[119.461155] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.013s)
[119.549954] [021/133] (899s left) gem_ctx_param (invalid-ctx-set)
[119.603071] Starting subtest: invalid-ctx-set
[119.605023] Subtest invalid-ctx-set: SUCCESS (0.001s)
[119.693539] [022/133] (898s left) kms_atomic_interruptible (legacy-dpms)
[119.787344] Starting subtest: legacy-dpms
[119.789387] Starting dynamic subtest: pipe-A-eDP-1
[127.245294] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.457s)
[127.247661] Subtest legacy-dpms: SUCCESS (7.458s)
[128.080766] [023/133] (890s left) gem_spin_batch (resubmit-new-all)
[128.141535] Starting subtest: resubmit-new-all
[128.143809] Starting dynamic subtest: rcs0
[128.155388] Dynamic subtest rcs0: SUCCESS (0.014s)
[128.164686] Starting dynamic subtest: bcs0
[128.168808] Dynamic subtest bcs0: SUCCESS (0.012s)
[128.176078] Starting dynamic subtest: vcs0
[128.181403] Dynamic subtest vcs0: SUCCESS (0.013s)
[128.191157] Starting dynamic subtest: vcs1
[128.192994] Dynamic subtest vcs1: SUCCESS (0.008s)
[128.200695] Starting dynamic subtest: vecs0
[128.203550] Dynamic subtest vecs0: SUCCESS (0.009s)
[128.213533] Starting dynamic subtest: ccs0
[128.215560] Dynamic subtest ccs0: SUCCESS (0.009s)
[128.217588] Subtest resubmit-new-all: SUCCESS (0.067s)
[129.912357] [024/133] (888s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[130.006313] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[137.440056] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.438s)
[137.590255] [025/133] (881s left) gem_ctx_shared (q-independent)
[137.650806] Starting subtest: Q-independent
[137.653270] Starting dynamic subtest: rcs0
[137.718066] Dynamic subtest rcs0: SUCCESS (0.067s)
[137.726849] Starting dynamic subtest: vcs0
[137.772066] Dynamic subtest vcs0: SUCCESS (0.053s)
[137.783255] Starting dynamic subtest: vcs1
[137.815985] Dynamic subtest vcs1: SUCCESS (0.044s)
[137.824900] Starting dynamic subtest: vecs0
[137.859948] Dynamic subtest vecs0: SUCCESS (0.044s)
[137.868188] Starting dynamic subtest: ccs0
[137.911984] Dynamic subtest ccs0: SUCCESS (0.052s)
[137.914731] Subtest Q-independent: SUCCESS (0.261s)
[138.994955] [026/133] (879s left) kms_psr (pr-primary-render)
[139.093962] Starting subtest: pr-primary-render
[139.098245] Subtest pr-primary-render: SKIP (0.000s)
[139.162777] [027/133] (879s left) kms_cursor_crc (cursor-offscreen-128x128)
[139.372702] Starting subtest: cursor-offscreen-128x128
[139.375057] Starting dynamic subtest: pipe-A-eDP-1
[141.318179] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[141.345343] Starting dynamic subtest: pipe-D-eDP-1
[143.897202] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[143.899131] Subtest cursor-offscreen-128x128: SUCCESS (4.524s)
[144.771659] [028/133] (874s left) kms_pm_rpm (dpms-non-lpsp)
[147.013195] Starting subtest: dpms-non-lpsp
[147.017958] Subtest dpms-non-lpsp: SKIP (0.001s)
[147.384888] [029/133] (871s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[147.966208] Starting subtest: syncobj-backward-timeline-chain-engines
[148.071688] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.106s)
[148.967818] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[148.971407] [030/133] (870s left) prime_vgem (basic-gtt)
[149.056351] Starting subtest: basic-gtt
[149.060941] Subtest basic-gtt: SKIP (0.000s)
[149.172949] [031/133] (869s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[149.271614] Starting subtest: x-tiled-64bpp-rotate-90
[149.291267] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[149.402492] [032/133] (869s left) kms_cursor_legacy (single-bo)
[149.518355] Starting subtest: single-bo
[149.520582] Starting dynamic subtest: pipe-A
[154.900554] Dynamic subtest pipe-A: SUCCESS (5.379s)
[154.911333] Starting dynamic subtest: pipe-B
[160.283797] Dynamic subtest pipe-B: SUCCESS (5.381s)
[160.294067] Starting dynamic subtest: pipe-C
[165.665916] Dynamic subtest pipe-C: SUCCESS (5.380s)
[165.675990] Starting dynamic subtest: pipe-D
[171.047900] Dynamic subtest pipe-D: SUCCESS (5.380s)
[171.058639] Starting dynamic subtest: all-pipes
[176.438067] Dynamic subtest all-pipes: SUCCESS (5.388s)
[176.440830] Subtest single-bo: SUCCESS (26.915s)
[176.580924] [033/133] (842s left) api_intel_bb (crc32)
[176.630405] Starting subtest: crc32
[176.632763] Starting dynamic subtest: rcs0-smem0
[176.974038] Dynamic subtest rcs0-smem0: SUCCESS (0.340s)
[176.984908] Starting dynamic subtest: bcs0-smem0
[177.319478] Dynamic subtest bcs0-smem0: SUCCESS (0.345s)
[177.330532] Starting dynamic subtest: vcs0-smem0
[177.757386] Dynamic subtest vcs0-smem0: SUCCESS (0.436s)
[177.769163] Starting dynamic subtest: vcs1-smem0
[178.132049] Dynamic subtest vcs1-smem0: SUCCESS (0.374s)
[178.142847] Starting dynamic subtest: vecs0-smem0
[178.503247] Dynamic subtest vecs0-smem0: SUCCESS (0.370s)
[178.514431] Starting dynamic subtest: ccs0-smem0
[178.863214] Dynamic subtest ccs0-smem0: SUCCESS (0.359s)
[178.865985] Subtest crc32: SUCCESS (2.232s)
[178.993690] [034/133] (840s left) prime_mmap_kms (buffer-sharing)
[179.093760] Starting subtest: buffer-sharing
[179.539515] Subtest buffer-sharing: SUCCESS (0.445s)
[180.410631] [035/133] (838s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[180.510423] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[187.306698] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.800s)
[187.435424] [036/133] (831s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[187.556419] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[187.560951] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[187.658563] [037/133] (831s left) gem_exec_schedule (semaphore-resolve)
[187.734133] Starting subtest: semaphore-resolve
[187.767227] Subtest semaphore-resolve: SUCCESS (0.037s)
[188.100519] [038/133] (831s left) api_intel_bb (simple-bb-ctx)
[188.161812] Starting subtest: simple-bb-ctx
[188.170782] Subtest simple-bb-ctx: SUCCESS (0.010s)
[188.302583] [039/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[188.404023] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[188.408152] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[188.513898] [040/133] (830s left) fbdev (eof)
[188.558979] Starting subtest: eof
[188.561424] Subtest eof: SUCCESS (0.000s)
[188.629854] [041/133] (830s left) kms_psr (fbc-pr-suspend)
[188.711740] Starting subtest: fbc-pr-suspend
[188.715932] Subtest fbc-pr-suspend: SKIP (0.000s)
[188.784854] [042/133] (830s left) kms_color_pipeline (plane-lut1d-lut1d)
[188.873631] Starting subtest: plane-lut1d-lut1d
[189.053170] Starting dynamic subtest: pipe-A-plane-0
[189.361893] Dynamic subtest pipe-A-plane-0: FAIL (0.170s)
[189.371552] Starting dynamic subtest: pipe-A-plane-1
[189.571718] Dynamic subtest pipe-A-plane-1: FAIL (0.171s)
[189.583870] Starting dynamic subtest: pipe-A-plane-2
[189.796038] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[190.843803] Starting dynamic subtest: pipe-B-plane-0
[191.321503] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[191.337063] Starting dynamic subtest: pipe-B-plane-1
[191.649637] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[191.659520] Starting dynamic subtest: pipe-B-plane-2
[191.953793] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[192.583158] Starting dynamic subtest: pipe-C-plane-0
[193.088596] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[193.097278] Starting dynamic subtest: pipe-C-plane-1
[193.483439] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[193.492708] Starting dynamic subtest: pipe-C-plane-2
[193.861213] Dynamic subtest pipe-C-plane-2: FAIL (0.170s)
[194.729632] Starting dynamic subtest: pipe-D-plane-0
[195.318356] Dynamic subtest pipe-D-plane-0: FAIL (0.141s)
[195.334919] Starting dynamic subtest: pipe-D-plane-1
[195.796804] Dynamic subtest pipe-D-plane-1: FAIL (0.632s)
[195.805305] Starting dynamic subtest: pipe-D-plane-2
[196.247905] Dynamic subtest pipe-D-plane-2: FAIL (0.567s)
[196.372644] Subtest plane-lut1d-lut1d: FAIL (7.499s)
[197.185236] [043/133] (822s left) perf (gen12-oa-tlb-invalidate)
[197.309788] Starting subtest: gen12-oa-tlb-invalidate
[197.311893] Starting dynamic subtest: 0-rcs0
[207.348826] Dynamic subtest 0-rcs0: SUCCESS (10.038s)
[207.357092] Starting dynamic subtest: 1-vcs0
[217.397365] Dynamic subtest 1-vcs0: SUCCESS (10.047s)
[217.399723] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.087s)
[217.444796] [044/133] (802s left) kms_plane_scaling (planes-scaler-unity-scaling)
[217.548273] Starting subtest: planes-scaler-unity-scaling
[217.550600] Starting dynamic subtest: pipe-A
[217.610065] Dynamic subtest pipe-A: SUCCESS (0.064s)
[217.619584] Starting dynamic subtest: pipe-B
[218.800763] Dynamic subtest pipe-B: SUCCESS (1.189s)
[218.813668] Starting dynamic subtest: pipe-C
[219.933917] Dynamic subtest pipe-C: SUCCESS (1.132s)
[219.941622] Starting dynamic subtest: pipe-D
[221.055238] Dynamic subtest pipe-D: SUCCESS (1.121s)
[221.057444] Subtest planes-scaler-unity-scaling: SUCCESS (3.510s)
[222.227123] [045/133] (797s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[222.339868] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[222.344067] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[222.433277] [046/133] (797s left) gem_exec_schedule (preempt-other-chain)
[222.500341] Starting subtest: preempt-other-chain
[222.502448] Starting dynamic subtest: rcs0
[222.575920] Dynamic subtest rcs0: SUCCESS (0.083s)
[222.586067] Starting dynamic subtest: bcs0
[222.684372] Dynamic subtest bcs0: SUCCESS (0.108s)
[222.696671] Starting dynamic subtest: vcs0
[222.762119] Dynamic subtest vcs0: SUCCESS (0.077s)
[222.770926] Starting dynamic subtest: vcs1
[222.846704] Dynamic subtest vcs1: SUCCESS (0.084s)
[222.858115] Starting dynamic subtest: vecs0
[222.925153] Dynamic subtest vecs0: SUCCESS (0.077s)
[222.936936] Starting dynamic subtest: ccs0
[223.003108] Dynamic subtest ccs0: SUCCESS (0.077s)
[223.005776] Subtest preempt-other-chain: SUCCESS (0.511s)
[223.988072] [047/133] (795s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[224.047988] Starting subtest: map-fixed-invalidate-overlap
[224.052470] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[224.155190] [048/133] (795s left) gem_mmap_gtt (basic-write)
[224.218190] Subtest basic-write: SKIP (0.000s)
[224.280326] [049/133] (795s left) gem_exec_basic (basic)
[224.333272] Starting subtest: basic
[224.335419] Starting dynamic subtest: rcs0-smem
[224.337632] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[224.346353] Starting dynamic subtest: bcs0-smem
[224.348653] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[224.356050] Starting dynamic subtest: vcs0-smem
[224.358188] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[224.365367] Starting dynamic subtest: vcs1-smem
[224.367503] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[224.374688] Starting dynamic subtest: vecs0-smem
[224.376767] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[224.384196] Starting dynamic subtest: ccs0-smem
[224.386366] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[224.388513] Subtest basic: SUCCESS (0.013s)
[225.981879] [050/133] (793s left) kms_fence_pin_leak
[226.146941] [051/133] (793s left) kms_chamelium_hpd (hdmi-hpd-fast)
[226.535604] Subtest hdmi-hpd-fast: SKIP (0.000s)
[227.354750] [052/133] (792s left) i915_hangman (engine-error-state-capture)
[227.412995] Starting subtest: engine-error-state-capture
[227.415181] Starting dynamic subtest: rcs0
[230.899890] Dynamic subtest rcs0: SUCCESS (3.486s)
[230.911106] Starting dynamic subtest: bcs0
[236.851995] Dynamic subtest bcs0: SUCCESS (5.950s)
[236.862939] Starting dynamic subtest: vcs0
[242.868047] Dynamic subtest vcs0: SUCCESS (6.014s)
[242.879650] Starting dynamic subtest: vcs1
[247.859444] Dynamic subtest vcs1: SUCCESS (4.989s)
[247.870663] Starting dynamic subtest: vecs0
[253.877075] Dynamic subtest vecs0: SUCCESS (6.016s)
[253.887825] Starting dynamic subtest: ccs0
[259.892000] Dynamic subtest ccs0: SUCCESS (6.013s)
[259.894895] Subtest engine-error-state-capture: SUCCESS (32.479s)
[259.976818] [053/133] (760s left) kms_lease (simple-lease)
[260.076811] Starting subtest: simple-lease
[260.081782] Starting dynamic subtest: pipe-A-eDP-1
[260.583632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.505s)
[260.592553] Starting dynamic subtest: pipe-B-eDP-1
[261.987585] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[261.995473] Starting dynamic subtest: pipe-C-eDP-1
[263.381949] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[263.390080] Starting dynamic subtest: pipe-D-eDP-1
[264.788229] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.405s)
[264.790678] Subtest simple-lease: SUCCESS (4.711s)
[265.605597] [054/133] (754s left) kms_content_protection (lic-type-0)
[265.750856] Starting subtest: lic-type-0
[265.755620] Subtest lic-type-0: SKIP (0.000s)
[265.868078] [055/133] (754s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[265.984136] Starting subtest: cursorA-vs-flipB-legacy
[265.988581] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[266.151335] [056/133] (753s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[266.243803] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[270.643181] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.403s)
[271.825487] [057/133] (748s left) gem_mmap_offset (perf)
[271.871778] Starting subtest: perf
[271.873642] Starting dynamic subtest: smem0
[272.239506] Dynamic subtest smem0: SUCCESS (0.367s)
[272.241888] Subtest perf: SUCCESS (0.368s)
[272.340761] [058/133] (747s left) gem_exec_balancer (indices)
[272.408903] Starting subtest: indices
[274.867506] Subtest indices: SUCCESS (2.456s)
[275.182458] [059/133] (745s left) gem_mmap_gtt (big-bo-tiledy)
[275.247481] Subtest big-bo-tiledY: SKIP (0.000s)
[275.311739] [060/133] (744s left) kms_psr (psr2-primary-mmap-gtt)
[275.420931] Starting subtest: psr2-primary-mmap-gtt
[275.423251] Starting dynamic subtest: eDP-1
[276.880906] Dynamic subtest eDP-1: SKIP (1.456s)
[276.885909] Subtest psr2-primary-mmap-gtt: SKIP (1.458s)
[277.022370] [061/133] (743s left) kms_flip (plain-flip-fb-recreate-interruptible)
[277.119916] Starting subtest: plain-flip-fb-recreate-interruptible
[277.122233] Starting dynamic subtest: A-eDP1
[285.998906] Dynamic subtest A-eDP1: SUCCESS (8.877s)
[286.010601] Starting dynamic subtest: B-eDP1
[294.828376] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[294.842067] Starting dynamic subtest: C-eDP1
[303.645735] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[303.659316] Starting dynamic subtest: D-eDP1
[312.480730] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[312.485678] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.365s)
[313.665843] [062/133] (706s left) gem_exec_reloc (basic-gtt-wc)
[313.729606] Subtest basic-gtt-wc: SKIP (0.000s)
[313.801466] [063/133] (706s left) kms_invalid_mode (bad-hsync-end)
[313.896183] Starting subtest: bad-hsync-end
[313.898376] Starting dynamic subtest: pipe-A-eDP-1
[314.177046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[314.189215] Starting dynamic subtest: pipe-B-eDP-1
[314.191337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[314.199251] Starting dynamic subtest: pipe-C-eDP-1
[314.201754] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[314.217689] Starting dynamic subtest: pipe-D-eDP-1
[314.220067] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[314.222495] Subtest bad-hsync-end: SUCCESS (0.287s)
[315.008090] [064/133] (705s left) kms_vblank (query-forked-hang)
[315.104354] Starting subtest: query-forked-hang
[315.106683] Starting dynamic subtest: pipe-A-eDP-1
[341.720109] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.612s)
[341.733597] Starting dynamic subtest: pipe-D-eDP-1
[366.758044] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.033s)
[366.760300] Subtest query-forked-hang: SUCCESS (51.650s)
[367.567664] [065/133] (652s left) gem_flink_basic (flink-lifetime)
[367.620622] Starting subtest: flink-lifetime
[367.622941] Subtest flink-lifetime: SUCCESS (0.002s)
[367.716387] [066/133] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[367.804264] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[367.808497] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[367.909389] [067/133] (652s left) gem_ppgtt (flink-and-close-vma-leak)
[367.961804] Starting subtest: flink-and-close-vma-leak
[368.002837] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[368.120650] [068/133] (652s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[368.206957] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[368.209287] Starting dynamic subtest: pipe-A-eDP-1
[368.231299] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[368.240263] Starting dynamic subtest: pipe-B-eDP-1
[368.262157] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[368.270168] Starting dynamic subtest: pipe-C-eDP-1
[368.290662] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[368.298214] Starting dynamic subtest: pipe-D-eDP-1
[368.319579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[368.323588] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[370.532976] [069/133] (650s left) gem_ctx_persistence (engines-mixed)
[370.588372] Starting subtest: engines-mixed
[370.590647] Starting dynamic subtest: rcs0
[370.659682] Dynamic subtest rcs0: SUCCESS (0.070s)
[370.670700] Starting dynamic subtest: bcs0
[370.722902] Dynamic subtest bcs0: SUCCESS (0.061s)
[370.733743] Starting dynamic subtest: vcs0
[370.765870] Dynamic subtest vcs0: SUCCESS (0.041s)
[370.775681] Starting dynamic subtest: vcs1
[370.805486] Dynamic subtest vcs1: SUCCESS (0.038s)
[370.813693] Starting dynamic subtest: vecs0
[370.846587] Dynamic subtest vecs0: SUCCESS (0.040s)
[370.855973] Starting dynamic subtest: ccs0
[370.893804] Dynamic subtest ccs0: SUCCESS (0.045s)
[370.896388] Subtest engines-mixed: SUCCESS (0.307s)
[370.988658] [070/133] (649s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[371.082243] Starting subtest: psr-rgb101010-draw-blt
[378.391214] Subtest psr-rgb101010-draw-blt: SUCCESS (7.310s)
[378.520552] [071/133] (642s left) kms_chamelium_audio (hdmi-audio-edid)
[378.914575] Subtest hdmi-audio-edid: SKIP (0.000s)
[379.761628] [072/133] (641s left) gem_ctx_persistence (many-contexts)
[379.824041] Starting subtest: many-contexts
[425.017274] Subtest many-contexts: SUCCESS (45.191s)
[425.111658] [073/133] (595s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[425.218158] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[425.229999] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[425.329520] [074/133] (595s left) kms_dsc (dsc-with-bpc)
[425.418141] Starting subtest: dsc-with-bpc
[425.447738] Subtest dsc-with-bpc: SKIP (0.001s)
[425.489881] [075/133] (595s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[425.549997] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[425.552284] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[425.664508] [076/133] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[425.776614] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[425.781019] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[425.874623] [077/133] (595s left) kms_prime (basic-crc-vgem)
[425.963120] Starting subtest: basic-crc-vgem
[425.965312] Starting dynamic subtest: second-to-first
[426.963810] Dynamic subtest second-to-first: SUCCESS (1.004s)
[426.965835] Subtest basic-crc-vgem: SUCCESS (1.006s)
[427.059453] [078/133] (593s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[427.180142] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[427.972195] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.793s)
[428.182417] [079/133] (592s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[428.289436] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[432.775562] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.488s)
[433.975894] [080/133] (587s left) kms_rotation_crc (sprite-rotation-270)
[434.074026] Starting subtest: sprite-rotation-270
[434.078302] Subtest sprite-rotation-270: SKIP (0.001s)
[434.149847] [081/133] (587s left) gen9_exec_parse (batch-without-end)
[434.217175] Subtest batch-without-end: SKIP (0.000s)
[434.276211] [082/133] (586s left) gem_wait (await)
[434.333675] Starting subtest: await
[434.336080] Starting dynamic subtest: all-engines
[435.436152] Dynamic subtest all-engines: SUCCESS (1.101s)
[435.453419] Starting dynamic subtest: rcs0
[436.492912] Dynamic subtest rcs0: SUCCESS (1.055s)
[436.509086] Starting dynamic subtest: bcs0
[437.550527] Dynamic subtest bcs0: SUCCESS (1.056s)
[437.566555] Starting dynamic subtest: vcs0
[438.604391] Dynamic subtest vcs0: SUCCESS (1.052s)
[438.619829] Starting dynamic subtest: vcs1
[439.659875] Dynamic subtest vcs1: SUCCESS (1.053s)
[439.675813] Starting dynamic subtest: vecs0
[440.713878] Dynamic subtest vecs0: SUCCESS (1.051s)
[440.730046] Starting dynamic subtest: ccs0
[441.772030] Dynamic subtest ccs0: SUCCESS (1.055s)
[441.775046] Subtest await: SUCCESS (7.438s)
[441.971124] [083/133] (579s left) gem_mmap_wc (write-read-distinct)
[442.034503] Subtest write-read-distinct: SKIP (0.000s)
[442.097383] [084/133] (579s left) kms_psr2_su (page_flip-nv12)
[442.158567] Subtest page_flip-NV12: SKIP (0.000s)
[442.219442] [085/133] (579s left) kms_properties (plane-properties-legacy)
[442.313069] Starting subtest: plane-properties-legacy
[442.315435] Starting dynamic subtest: pipe-A-eDP-1
[442.859189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[442.868635] Starting dynamic subtest: pipe-B-eDP-1
[444.125573] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s)
[444.133578] Starting dynamic subtest: pipe-C-eDP-1
[445.355028] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[445.363162] Starting dynamic subtest: pipe-D-eDP-1
[446.581763] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[446.584183] Subtest plane-properties-legacy: SUCCESS (4.270s)
[447.386937] [086/133] (573s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[447.489891] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[447.494147] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[447.596664] [087/133] (573s left) drm_read (fault-buffer)
[447.741098] Starting subtest: fault-buffer
[447.743470] Subtest fault-buffer: SUCCESS (0.000s)
[447.854499] [088/133] (573s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[447.919560] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[448.026407] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[448.117195] [089/133] (573s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[448.170392] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[448.274200] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[448.377303] [090/133] (573s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[448.438148] Starting subtest: y-tiled-to-vebox-yf-tiled
[448.442438] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[448.621316] [091/133] (572s left) kms_addfb_basic (invalid-get-prop)
[448.675070] Starting subtest: invalid-get-prop
[448.677401] Subtest invalid-get-prop: SUCCESS (0.000s)
[448.810993] [092/133] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[448.905276] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[455.697770] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.796s)
[455.846071] [093/133] (565s left) kms_mmap_write_crc (main)
[455.938601] Starting subtest: main
[455.941030] Starting dynamic subtest: pipe-A-eDP-1
[459.533482] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.590s)
[459.535704] Subtest main: SUCCESS (3.592s)
[460.357012] [094/133] (561s left) i915_suspend (fence-restore-tiled2untiled)
[460.421626] Starting subtest: fence-restore-tiled2untiled
[460.426253] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[460.532285] [095/133] (561s left) perf_pmu (busy-idle)
[460.568609] Starting subtest: busy-idle
[460.570899] Starting dynamic subtest: rcs0
[461.260209] Dynamic subtest rcs0: SUCCESS (0.692s)
[461.272049] Starting dynamic subtest: bcs0
[461.923771] Dynamic subtest bcs0: SUCCESS (0.661s)
[461.935084] Starting dynamic subtest: vcs0
[463.893700] Dynamic subtest vcs0: SUCCESS (1.966s)
[463.904792] Starting dynamic subtest: vcs1
[465.941997] Dynamic subtest vcs1: SUCCESS (2.045s)
[465.953333] Starting dynamic subtest: vecs0
[467.925948] Dynamic subtest vecs0: SUCCESS (1.981s)
[467.937063] Starting dynamic subtest: ccs0
[468.594330] Dynamic subtest ccs0: SUCCESS (0.667s)
[468.596971] Subtest busy-idle: SUCCESS (8.028s)
[468.714565] [096/133] (553s left) testdisplay
[469.048299] [097/133] (552s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[469.179681] Starting subtest: 2x-cursor-vs-flip-atomic
[469.184243] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[469.336454] [098/133] (552s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[469.427948] Starting subtest: psr2-cursor-plane-move-continuous-sf
[469.430342] Starting dynamic subtest: pipe-A-eDP-1
[479.770026] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.346s)
[479.779578] Starting dynamic subtest: pipe-B-eDP-1
[490.839225] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.070s)
[490.841594] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.419s)
[491.651574] [099/133] (530s left) prime_mmap (test_reprime)
[491.714572] Starting subtest: test_reprime
[491.716570] Starting dynamic subtest: test_reprime-smem
[491.746295] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[491.748798] Subtest test_reprime: SUCCESS (0.035s)
[491.851598] [100/133] (530s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[491.948167] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[491.952358] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[492.035029] [101/133] (529s left) kms_async_flips (async-flip-hang)
[492.132321] Starting subtest: async-flip-hang
[492.504504] Starting dynamic subtest: pipe-A-eDP-1
[507.440032] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.933s)
[507.834693] Starting dynamic subtest: pipe-B-eDP-1
[523.445916] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.613s)
[523.820131] Starting dynamic subtest: pipe-C-eDP-1
[539.374067] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.556s)
[539.761628] Starting dynamic subtest: pipe-D-eDP-1
[555.375188] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.616s)
[555.377459] Subtest async-flip-hang: SUCCESS (63.239s)
[556.624730] [102/133] (465s left) kms_cursor_edge_walk (64x64-right-edge)
[556.722602] Starting subtest: 64x64-right-edge
[556.724871] Starting dynamic subtest: pipe-A-eDP-1
[560.177179] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[560.185736] Starting dynamic subtest: pipe-D-eDP-1
[563.297967] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[563.300732] Subtest 64x64-right-edge: SUCCESS (6.578s)
[564.112439] [103/133] (457s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[564.205667] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[564.210057] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[564.306461] [104/133] (457s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[564.409737] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[564.412453] Starting dynamic subtest: pipe-A-eDP-1
[564.435165] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[564.444318] Starting dynamic subtest: pipe-B-eDP-1
[564.466077] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[564.474279] Starting dynamic subtest: pipe-C-eDP-1
[564.495987] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[564.505050] Starting dynamic subtest: pipe-D-eDP-1
[564.528489] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[564.532759] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[566.579667] [105/133] (455s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[566.665424] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[566.669402] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[566.740638] [106/133] (455s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[566.842202] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[566.844402] Starting dynamic subtest: pipe-A-default-mode
[568.041951] Dynamic subtest pipe-A-default-mode: SKIP (1.194s)
[568.046043] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.196s)
[568.215697] [107/133] (454s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[568.308589] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[568.312692] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[568.408405] [108/133] (453s left) gem_fence_thrash (bo-write-verify-threaded-none)
[568.450118] Starting subtest: bo-write-verify-threaded-none
[568.471284] Subtest bo-write-verify-threaded-none: SKIP (0.020s)
[568.532315] [109/133] (453s left) gem_exec_store (basic)
[568.601818] Starting subtest: basic
[568.695068] Subtest basic: SUCCESS (0.095s)
[568.874226] [110/133] (453s left) gem_userptr_blits (create-destroy-sync)
[568.931085] Starting subtest: create-destroy-sync
[573.941230] Subtest create-destroy-sync: SUCCESS (5.010s)
[574.074854] [111/133] (448s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[574.190944] Starting subtest: psr-2p-primscrn-cur-indfb-move
[574.195211] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[574.306379] [112/133] (448s left) kms_plane_multiple (2x-tiling-4)
[574.407716] Starting subtest: 2x-tiling-4
[574.412067] Subtest 2x-tiling-4: SKIP (0.000s)
[574.480412] [113/133] (448s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[574.589996] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[574.594101] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[574.698365] [114/133] (447s left) perf_pmu (semaphore-wait-idle)
[574.744482] Starting subtest: semaphore-wait-idle
[574.746811] Starting dynamic subtest: rcs0
[575.259544] Dynamic subtest rcs0: SUCCESS (0.513s)
[575.272278] Starting dynamic subtest: bcs0
[575.773535] Dynamic subtest bcs0: SUCCESS (0.511s)
[575.783827] Starting dynamic subtest: vcs0
[576.286443] Dynamic subtest vcs0: SUCCESS (0.510s)
[576.296810] Starting dynamic subtest: vcs1
[576.800061] Dynamic subtest vcs1: SUCCESS (0.511s)
[576.810650] Starting dynamic subtest: vecs0
[577.313431] Dynamic subtest vecs0: SUCCESS (0.510s)
[577.325083] Starting dynamic subtest: ccs0
[577.829382] Dynamic subtest ccs0: SUCCESS (0.513s)
[577.832244] Subtest semaphore-wait-idle: SUCCESS (3.085s)
[578.928119] [115/133] (443s left) sysfs_defaults (readonly)
[578.995422] Starting subtest: readonly
[578.997875] Starting dynamic subtest: vecs0
[579.000317] Dynamic subtest vecs0: SUCCESS (0.000s)
[579.010887] Starting dynamic subtest: ccs0
[579.013132] Dynamic subtest ccs0: SUCCESS (0.000s)
[579.020983] Starting dynamic subtest: vcs0
[579.023300] Dynamic subtest vcs0: SUCCESS (0.000s)
[579.030817] Starting dynamic subtest: bcs0
[579.032817] Dynamic subtest bcs0: SUCCESS (0.000s)
[579.040687] Starting dynamic subtest: rcs0
[579.042858] Dynamic subtest rcs0: SUCCESS (0.000s)
[579.050824] Starting dynamic subtest: vcs1
[579.052686] Dynamic subtest vcs1: SUCCESS (0.000s)
[579.054580] Subtest readonly: SUCCESS (0.006s)
[579.103917] [116/133] (443s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[579.203888] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[579.206169] Starting dynamic subtest: pipe-A-eDP-1
[579.284982] Dynamic subtest pipe-A-eDP-1: SKIP (0.082s)
[579.295453] Starting dynamic subtest: pipe-B-eDP-1
[580.402483] Dynamic subtest pipe-B-eDP-1: SKIP (1.115s)
[580.406984] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.199s)
[581.586531] [117/133] (441s left) gem_mmap_gtt (cpuset-big-copy-xy)
[581.652957] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[581.718865] [118/133] (441s left) drm_read (short-buffer-block)
[581.857104] Starting subtest: short-buffer-block
[581.859561] Subtest short-buffer-block: SUCCESS (0.000s)
[581.984946] [119/133] (440s left) perf (sysctl-defaults)
[582.054380] Starting subtest: sysctl-defaults
[582.056752] Subtest sysctl-defaults: SUCCESS (0.000s)
[582.128201] [120/133] (440s left) gem_mmap (pf-nonblock)
[582.175709] Subtest pf-nonblock: SKIP (0.000s)
[582.235424] [121/133] (440s left) kms_psr (psr-sprite-blt)
[582.317990] Starting subtest: psr-sprite-blt
[582.320308] Starting dynamic subtest: eDP-1
[584.109389] Dynamic subtest eDP-1: SUCCESS (1.789s)
[584.111346] Subtest psr-sprite-blt: SUCCESS (1.790s)
[584.951416] [122/133] (437s left) core_sysfs (read-all-entries)
[585.013665] Starting subtest: read-all-entries
[585.019841] Subtest read-all-entries: SUCCESS (0.008s)
[585.123140] [123/133] (437s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[585.209347] Starting subtest: fbc-psr-sprite-mmap-gtt
[585.211597] Starting dynamic subtest: eDP-1
[585.215687] Dynamic subtest eDP-1: SKIP (0.000s)
[585.219749] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[585.285446] [124/133] (437s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[585.338996] Starting subtest: wait-all-for-submit-delayed-submit
[585.444621] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[585.533655] [125/133] (437s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[585.637417] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[585.641762] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[585.735458] [126/133] (437s left) kms_async_flips (test-time-stamp-atomic)
[585.829144] Starting subtest: test-time-stamp-atomic
[586.213373] Starting dynamic subtest: pipe-A-eDP-1
[587.061713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s)
[587.442679] Starting dynamic subtest: pipe-B-eDP-1
[588.197823] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[588.566688] Starting dynamic subtest: pipe-C-eDP-1
[589.329064] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[589.701302] Starting dynamic subtest: pipe-D-eDP-1
[590.453306] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.756s)
[590.455605] Subtest test-time-stamp-atomic: SUCCESS (4.624s)
[591.613043] [127/133] (431s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[591.700033] Starting subtest: plane-downscale-factor-0-5-with-rotation
[591.702319] Starting dynamic subtest: pipe-A
[591.725087] Dynamic subtest pipe-A: SKIP (0.020s)
[591.733889] Starting dynamic subtest: pipe-B
[591.757320] Dynamic subtest pipe-B: SKIP (0.031s)
[591.766316] Starting dynamic subtest: pipe-C
[591.787177] Dynamic subtest pipe-C: SKIP (0.031s)
[591.795549] Starting dynamic subtest: pipe-D
[591.818602] Dynamic subtest pipe-D: SKIP (0.031s)
[591.822223] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.116s)
[591.936294] [128/133] (431s left) i915_pm_rps (reset)
[591.992256] Starting subtest: reset
[600.423241] Subtest reset: SUCCESS (8.430s)
[600.544215] [129/133] (422s left) gem_render_copy (yf-tiled)
[600.597233] Starting subtest: yf-tiled
[600.601869] Subtest yf-tiled: SKIP (0.000s)
[600.788585] [130/133] (422s left) gem_ctx_engines (independent)
[600.855502] Starting subtest: independent
[600.857968] Starting dynamic subtest: rcs0
[601.112965] Dynamic subtest rcs0: SUCCESS (0.255s)
[601.124876] Starting dynamic subtest: bcs0
[601.379710] Dynamic subtest bcs0: SUCCESS (0.266s)
[601.391804] Starting dynamic subtest: vcs0
[601.650608] Dynamic subtest vcs0: SUCCESS (0.270s)
[601.659569] Starting dynamic subtest: vcs1
[601.944934] Dynamic subtest vcs1: SUCCESS (0.293s)
[601.955484] Starting dynamic subtest: vecs0
[602.231344] Dynamic subtest vecs0: SUCCESS (0.286s)
[602.240276] Starting dynamic subtest: ccs0
[602.545340] Dynamic subtest ccs0: SUCCESS (0.312s)
[602.556588] Starting dynamic subtest: all-engines
[603.853474] Dynamic subtest all-engines: SUCCESS (1.307s)
[603.856056] Subtest independent: SUCCESS (2.996s)
[604.952686] [131/133] (418s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[605.052913] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[605.055379] Starting dynamic subtest: pipe-A-eDP-1
[605.118560] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[605.129607] Starting dynamic subtest: pipe-B-eDP-1
[605.188416] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[605.198977] Starting dynamic subtest: pipe-C-eDP-1
[605.254951] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[605.264195] Starting dynamic subtest: pipe-D-eDP-1
[605.321701] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[605.326218] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[607.371199] [132/133] (415s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[607.455962] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[607.458786] Starting dynamic subtest: pipe-A-eDP-1
[608.378785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.917s)
[608.388368] Starting dynamic subtest: pipe-B-eDP-1
[610.021270] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.638s)
[610.031411] Starting dynamic subtest: pipe-C-eDP-1
[611.579054] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.557s)
[611.589108] Starting dynamic subtest: pipe-D-eDP-1
[613.029395] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.449s)
[613.031600] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.565s)
[614.220979] [133/133] (409s left) gem_exec_reloc (basic-scanout)
[614.278227] Subtest basic-scanout: SKIP (0.000s)
[614.358345] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_edid
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_softpin
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: drm_read
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: gem_lmem_evict
results: parsing output: 12/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_pipe_b_c_ivb
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_ctx_param
results: parsing output: 21/ for test: kms_atomic_interruptible
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_ctx_shared
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_pm_rpm
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: prime_vgem
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: prime_mmap_kms
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: api_intel_bb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: fbdev
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_color_pipeline
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: gem_exec_basic
results: parsing output: 49/ for test: kms_fence_pin_leak
results: parsing output: 50/ for test: kms_chamelium_hpd
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_invalid_mode
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: gem_flink_basic
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ppgtt
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_chamelium_audio
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_dsc
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_prime
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: gen9_exec_parse
results: parsing output: 81/ for test: gem_wait
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: kms_psr2_su
results: parsing output: 84/ for test: kms_properties
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: drm_read
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_mmap_write_crc
results: parsing output: 93/ for test: i915_suspend
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: testdisplay
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: kms_cursor_edge_walk
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_fence_thrash
results: parsing output: 108/ for test: gem_exec_store
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane_multiple
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: sysfs_defaults
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: drm_read
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: gem_mmap
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: core_sysfs
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: i915_pm_rps
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: gem_exec_reloc
Done.