[59.512075] Initializing watchdogs
[59.512129]   /dev/watchdog0
[59.527120] [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.531466] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.533751] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.537203] [001/133] (960s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[59.944080] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[60.738940] [002/133] (959s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[60.804035] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[60.875699] [003/133] (959s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[60.976068] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[60.980202] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[61.064893] [004/133] (959s left) gem_softpin (evict-snoop-interruptible)
[61.120853] Starting subtest: evict-snoop-interruptible
[61.125303] Subtest evict-snoop-interruptible: SKIP (0.000s)
[61.223205] [005/133] (958s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[61.268535] Starting subtest: multi-wait-available-unsubmitted-submitted
[61.270764] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[61.358228] [006/133] (958s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[61.441625] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[61.445657] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[61.513387] [007/133] (958s left) drm_read (empty-block)
[61.687965] Starting subtest: empty-block
[62.689903] Subtest empty-block: SUCCESS (1.000s)
[62.823814] [008/133] (957s left) kms_vblank (query-busy-hang)
[62.925194] Starting subtest: query-busy-hang
[62.927579] Starting dynamic subtest: pipe-A-eDP-1
[89.697695] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.769s)
[89.709382] Starting dynamic subtest: pipe-D-eDP-1
[114.710650] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.011s)
[114.712637] Subtest query-busy-hang: SUCCESS (51.783s)
[115.519393] [009/133] (904s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[115.610779] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[115.614983] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[115.738652] [010/133] (904s left) kms_big_fb (y-tiled-addfb)
[115.846638] Starting subtest: y-tiled-addfb
[115.850881] Subtest y-tiled-addfb: SKIP (0.000s)
[115.946998] [011/133] (904s left) syncobj_wait (multi-wait-signaled)
[116.002604] Starting subtest: multi-wait-signaled
[116.004722] Subtest multi-wait-signaled: SUCCESS (0.000s)
[116.093256] [012/133] (904s left) gem_lmem_evict (dontneed-evict-race)
[116.141229] Subtest dontneed-evict-race: SKIP (0.000s)
[116.185258] [013/133] (904s left) gem_set_tiling_vs_pwrite
[116.294635] [014/133] (904s left) syncobj_timeline (invalid-signal-bad-pad)
[116.363384] Starting subtest: invalid-signal-bad-pad
[116.365361] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[116.478821] [015/133] (904s left) kms_big_fb (linear-8bpp-rotate-270)
[116.576781] Starting subtest: linear-8bpp-rotate-270
[116.597100] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[116.697102] [016/133] (903s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[116.931022] Starting subtest: cursor-rapid-movement-256x256
[116.933038] Starting dynamic subtest: pipe-A-eDP-1
[117.479841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[117.508159] Starting dynamic subtest: pipe-D-eDP-1
[118.758077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.255s)
[118.760307] Subtest cursor-rapid-movement-256x256: SUCCESS (1.827s)
[119.611968] [017/133] (901s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[119.667705] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[119.725976] [018/133] (900s left) gen9_exec_parse (unaligned-jump)
[119.776714] Subtest unaligned-jump: SKIP (0.000s)
[119.830594] [019/133] (900s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[119.924478] Starting subtest: 4-tiled-8bpp-rotate-0
[121.138106] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.214s)
[121.279812] [020/133] (899s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[121.373164] Starting subtest: 2x-absolute-wf_vblank-interruptible
[121.385839] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[121.459226] [021/133] (899s left) gem_ctx_param (invalid-ctx-set)
[121.522196] Starting subtest: invalid-ctx-set
[121.526014] Subtest invalid-ctx-set: SUCCESS (0.002s)
[121.644739] [022/133] (899s left) kms_atomic_interruptible (legacy-dpms)
[121.740160] Starting subtest: legacy-dpms
[121.741969] Starting dynamic subtest: pipe-A-eDP-1
[129.115255] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.373s)
[129.117476] Subtest legacy-dpms: SUCCESS (7.374s)
[129.949718] [023/133] (890s left) gem_spin_batch (resubmit-new-all)
[130.009665] Starting subtest: resubmit-new-all
[130.012074] Starting dynamic subtest: rcs0
[130.023359] Dynamic subtest rcs0: SUCCESS (0.014s)
[130.034487] Starting dynamic subtest: bcs0
[130.036695] Dynamic subtest bcs0: SUCCESS (0.009s)
[130.044081] Starting dynamic subtest: vcs0
[130.046213] Dynamic subtest vcs0: SUCCESS (0.009s)
[130.053307] Starting dynamic subtest: vcs1
[130.055559] Dynamic subtest vcs1: SUCCESS (0.011s)
[130.063312] Starting dynamic subtest: vecs0
[130.065614] Dynamic subtest vecs0: SUCCESS (0.010s)
[130.073651] Starting dynamic subtest: ccs0
[130.075899] Dynamic subtest ccs0: SUCCESS (0.009s)
[130.077789] Subtest resubmit-new-all: SUCCESS (0.064s)
[131.964670] [024/133] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[132.063063] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[139.496025] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.436s)
[139.617532] [025/133] (881s left) gem_ctx_shared (q-independent)
[139.681961] Starting subtest: Q-independent
[139.684268] Starting dynamic subtest: rcs0
[139.749264] Dynamic subtest rcs0: SUCCESS (0.069s)
[139.759193] Starting dynamic subtest: vcs0
[139.794477] Dynamic subtest vcs0: SUCCESS (0.045s)
[139.803756] Starting dynamic subtest: vcs1
[139.836242] Dynamic subtest vcs1: SUCCESS (0.041s)
[139.845399] Starting dynamic subtest: vecs0
[139.879690] Dynamic subtest vecs0: SUCCESS (0.043s)
[139.889125] Starting dynamic subtest: ccs0
[139.920412] Dynamic subtest ccs0: SUCCESS (0.040s)
[139.922734] Subtest Q-independent: SUCCESS (0.241s)
[140.961970] [026/133] (880s left) kms_psr (pr-primary-render)
[141.057681] Starting subtest: pr-primary-render
[141.061725] Subtest pr-primary-render: SKIP (0.000s)
[141.143352] [027/133] (879s left) kms_cursor_crc (cursor-offscreen-128x128)
[141.350787] Starting subtest: cursor-offscreen-128x128
[141.353148] Starting dynamic subtest: pipe-A-eDP-1
[143.283535] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[143.311260] Starting dynamic subtest: pipe-D-eDP-1
[145.870549] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.564s)
[145.872905] Subtest cursor-offscreen-128x128: SUCCESS (4.519s)
[146.729542] [028/133] (874s left) kms_pm_rpm (dpms-non-lpsp)
[148.271649] Starting subtest: dpms-non-lpsp
[148.276370] Subtest dpms-non-lpsp: SKIP (0.001s)
[148.978697] [029/133] (872s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[149.553798] Starting subtest: syncobj-backward-timeline-chain-engines
[149.657815] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.104s)
[151.026265] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[151.029586] [030/133] (870s left) prime_vgem (basic-gtt)
[151.108341] Starting subtest: basic-gtt
[151.112635] Subtest basic-gtt: SKIP (0.000s)
[151.223292] [031/133] (870s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[151.335260] Starting subtest: x-tiled-64bpp-rotate-90
[151.355373] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[151.480687] [032/133] (869s left) kms_cursor_legacy (single-bo)
[151.595814] Starting subtest: single-bo
[151.597675] Starting dynamic subtest: pipe-A
[156.977750] Dynamic subtest pipe-A: SUCCESS (5.379s)
[156.986805] Starting dynamic subtest: pipe-B
[162.360988] Dynamic subtest pipe-B: SUCCESS (5.381s)
[162.370398] Starting dynamic subtest: pipe-C
[167.742785] Dynamic subtest pipe-C: SUCCESS (5.380s)
[167.751507] Starting dynamic subtest: pipe-D
[173.124272] Dynamic subtest pipe-D: SUCCESS (5.380s)
[173.132476] Starting dynamic subtest: all-pipes
[178.513026] Dynamic subtest all-pipes: SUCCESS (5.387s)
[178.515442] Subtest single-bo: SUCCESS (26.913s)
[178.656629] [033/133] (842s left) api_intel_bb (crc32)
[178.717112] Starting subtest: crc32
[178.719079] Starting dynamic subtest: rcs0-smem0
[179.030328] Dynamic subtest rcs0-smem0: SUCCESS (0.314s)
[179.041319] Starting dynamic subtest: bcs0-smem0
[179.380088] Dynamic subtest bcs0-smem0: SUCCESS (0.348s)
[179.390151] Starting dynamic subtest: vcs0-smem0
[179.767980] Dynamic subtest vcs0-smem0: SUCCESS (0.386s)
[179.779270] Starting dynamic subtest: vcs1-smem0
[180.130025] Dynamic subtest vcs1-smem0: SUCCESS (0.343s)
[180.141433] Starting dynamic subtest: vecs0-smem0
[180.498066] Dynamic subtest vecs0-smem0: SUCCESS (0.385s)
[180.509785] Starting dynamic subtest: ccs0-smem0
[180.848663] Dynamic subtest ccs0-smem0: SUCCESS (0.349s)
[180.851533] Subtest crc32: SUCCESS (2.133s)
[180.959250] [034/133] (840s left) prime_mmap_kms (buffer-sharing)
[181.057084] Starting subtest: buffer-sharing
[181.502848] Subtest buffer-sharing: SUCCESS (0.446s)
[182.301651] [035/133] (839s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[182.396633] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[189.206888] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.813s)
[189.326418] [036/133] (832s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[189.427060] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[189.431589] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[189.526551] [037/133] (831s left) gem_exec_schedule (semaphore-resolve)
[189.599715] Starting subtest: semaphore-resolve
[189.640764] Subtest semaphore-resolve: SUCCESS (0.047s)
[189.986845] [038/133] (831s left) api_intel_bb (simple-bb-ctx)
[190.041983] Starting subtest: simple-bb-ctx
[190.047915] Subtest simple-bb-ctx: SUCCESS (0.007s)
[190.168614] [039/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[190.268312] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[190.272548] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[190.359074] [040/133] (831s left) fbdev (eof)
[190.408581] Starting subtest: eof
[190.410891] Subtest eof: SUCCESS (0.000s)
[190.508364] [041/133] (831s left) kms_psr (fbc-pr-suspend)
[190.594204] Starting subtest: fbc-pr-suspend
[190.598189] Subtest fbc-pr-suspend: SKIP (0.000s)
[190.667282] [042/133] (831s left) kms_color_pipeline (plane-lut1d-lut1d)
[190.752952] Starting subtest: plane-lut1d-lut1d
[190.898811] Starting dynamic subtest: pipe-A-plane-0
[191.247426] Dynamic subtest pipe-A-plane-0: FAIL (0.215s)
[191.257204] Starting dynamic subtest: pipe-A-plane-1
[191.456123] Dynamic subtest pipe-A-plane-1: FAIL (0.170s)
[191.463455] Starting dynamic subtest: pipe-A-plane-2
[191.664856] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[192.653042] Starting dynamic subtest: pipe-B-plane-0
[193.117874] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[193.126216] Starting dynamic subtest: pipe-B-plane-1
[193.435055] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[193.444523] Starting dynamic subtest: pipe-B-plane-2
[193.745361] Dynamic subtest pipe-B-plane-2: FAIL (0.191s)
[194.458804] Starting dynamic subtest: pipe-C-plane-0
[194.968098] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[194.977915] Starting dynamic subtest: pipe-C-plane-1
[195.375807] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[195.389030] Starting dynamic subtest: pipe-C-plane-2
[195.763480] Dynamic subtest pipe-C-plane-2: FAIL (0.173s)
[196.612745] Starting dynamic subtest: pipe-D-plane-0
[197.225619] Dynamic subtest pipe-D-plane-0: FAIL (0.162s)
[197.238448] Starting dynamic subtest: pipe-D-plane-1
[197.680910] Dynamic subtest pipe-D-plane-1: FAIL (0.640s)
[197.690680] Starting dynamic subtest: pipe-D-plane-2
[198.126611] Dynamic subtest pipe-D-plane-2: FAIL (0.565s)
[198.274535] Subtest plane-lut1d-lut1d: FAIL (7.524s)
[199.089765] [043/133] (822s left) perf (gen12-oa-tlb-invalidate)
[199.234690] Starting subtest: gen12-oa-tlb-invalidate
[199.236824] Starting dynamic subtest: 0-rcs0
[209.287658] Dynamic subtest 0-rcs0: SUCCESS (10.052s)
[209.299501] Starting dynamic subtest: 1-vcs1
[219.335041] Dynamic subtest 1-vcs1: SUCCESS (10.047s)
[219.337510] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.101s)
[219.379676] [044/133] (802s left) kms_plane_scaling (planes-scaler-unity-scaling)
[219.485793] Starting subtest: planes-scaler-unity-scaling
[219.490378] Starting dynamic subtest: pipe-A
[219.550553] Dynamic subtest pipe-A: SUCCESS (0.066s)
[219.562785] Starting dynamic subtest: pipe-B
[220.704459] Dynamic subtest pipe-B: SUCCESS (1.153s)
[220.713823] Starting dynamic subtest: pipe-C
[221.826450] Dynamic subtest pipe-C: SUCCESS (1.121s)
[221.836945] Starting dynamic subtest: pipe-D
[222.944319] Dynamic subtest pipe-D: SUCCESS (1.116s)
[222.946688] Subtest planes-scaler-unity-scaling: SUCCESS (3.460s)
[224.115978] [045/133] (797s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[224.223115] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[224.227681] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[224.313917] [046/133] (797s left) gem_exec_schedule (preempt-other-chain)
[224.391525] Starting subtest: preempt-other-chain
[224.393489] Starting dynamic subtest: rcs0
[224.472647] Dynamic subtest rcs0: SUCCESS (0.087s)
[224.485465] Starting dynamic subtest: bcs0
[224.554396] Dynamic subtest bcs0: SUCCESS (0.081s)
[224.568769] Starting dynamic subtest: vcs0
[224.641234] Dynamic subtest vcs0: SUCCESS (0.085s)
[224.657269] Starting dynamic subtest: vcs1
[224.726100] Dynamic subtest vcs1: SUCCESS (0.085s)
[224.739693] Starting dynamic subtest: vecs0
[224.810800] Dynamic subtest vecs0: SUCCESS (0.084s)
[224.821817] Starting dynamic subtest: ccs0
[224.893788] Dynamic subtest ccs0: SUCCESS (0.083s)
[224.896078] Subtest preempt-other-chain: SUCCESS (0.509s)
[225.963908] [047/133] (796s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[226.031358] Starting subtest: map-fixed-invalidate-overlap
[226.035615] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[226.145298] [048/133] (795s left) gem_mmap_gtt (basic-write)
[226.204828] Subtest basic-write: SKIP (0.000s)
[226.268423] [049/133] (795s left) gem_exec_basic (basic)
[226.343997] Starting subtest: basic
[226.346310] Starting dynamic subtest: rcs0-smem
[226.348521] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[226.357829] Starting dynamic subtest: bcs0-smem
[226.359943] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[226.367507] Starting dynamic subtest: vcs0-smem
[226.369626] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[226.377052] Starting dynamic subtest: vcs1-smem
[226.379155] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[226.386634] Starting dynamic subtest: vecs0-smem
[226.388736] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[226.396599] Starting dynamic subtest: ccs0-smem
[226.398654] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[226.401054] Subtest basic: SUCCESS (0.013s)
[227.968160] [050/133] (794s left) kms_fence_pin_leak
[228.139743] [051/133] (793s left) kms_chamelium_hpd (hdmi-hpd-fast)
[228.511082] Subtest hdmi-hpd-fast: SKIP (0.000s)
[229.312816] [052/133] (792s left) i915_hangman (engine-error-state-capture)
[229.388304] Starting subtest: engine-error-state-capture
[229.390513] Starting dynamic subtest: rcs0
[232.884075] Dynamic subtest rcs0: SUCCESS (3.495s)
[232.894788] Starting dynamic subtest: bcs0
[238.901331] Dynamic subtest bcs0: SUCCESS (6.015s)
[238.912717] Starting dynamic subtest: vcs0
[244.852790] Dynamic subtest vcs0: SUCCESS (5.949s)
[244.863808] Starting dynamic subtest: vcs1
[250.868825] Dynamic subtest vcs1: SUCCESS (6.014s)
[250.879305] Starting dynamic subtest: vecs0
[256.820391] Dynamic subtest vecs0: SUCCESS (5.949s)
[256.831983] Starting dynamic subtest: ccs0
[261.876473] Dynamic subtest ccs0: SUCCESS (5.053s)
[261.879772] Subtest engine-error-state-capture: SUCCESS (32.489s)
[261.960116] [053/133] (760s left) kms_lease (simple-lease)
[262.049144] Starting subtest: simple-lease
[262.051493] Starting dynamic subtest: pipe-A-eDP-1
[262.549145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.501s)
[262.557763] Starting dynamic subtest: pipe-B-eDP-1
[263.968413] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.415s)
[263.977259] Starting dynamic subtest: pipe-C-eDP-1
[265.369073] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[265.377042] Starting dynamic subtest: pipe-D-eDP-1
[266.767534] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.397s)
[266.769875] Subtest simple-lease: SUCCESS (4.720s)
[267.572651] [054/133] (754s left) kms_content_protection (lic-type-0)
[267.713729] Starting subtest: lic-type-0
[267.718350] Subtest lic-type-0: SKIP (0.000s)
[267.824977] [055/133] (754s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[267.945322] Starting subtest: cursorA-vs-flipB-legacy
[267.949851] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[268.088667] [056/133] (754s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[268.181156] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[272.633740] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.456s)
[273.782627] [057/133] (748s left) gem_mmap_offset (perf)
[273.843067] Starting subtest: perf
[273.845177] Starting dynamic subtest: smem0
[274.195363] Dynamic subtest smem0: SUCCESS (0.352s)
[274.197864] Subtest perf: SUCCESS (0.353s)
[274.316423] [058/133] (748s left) gem_exec_balancer (indices)
[274.394620] Starting subtest: indices
[276.851755] Subtest indices: SUCCESS (2.455s)
[277.166646] [059/133] (745s left) gem_mmap_gtt (big-bo-tiledy)
[277.221384] Subtest big-bo-tiledY: SKIP (0.000s)
[277.285091] [060/133] (745s left) kms_psr (psr2-primary-mmap-gtt)
[277.377854] Starting subtest: psr2-primary-mmap-gtt
[277.380151] Starting dynamic subtest: eDP-1
[278.789917] Dynamic subtest eDP-1: SKIP (1.408s)
[278.794537] Subtest psr2-primary-mmap-gtt: SKIP (1.410s)
[278.940753] [061/133] (743s left) kms_flip (plain-flip-fb-recreate-interruptible)
[279.036306] Starting subtest: plain-flip-fb-recreate-interruptible
[279.038546] Starting dynamic subtest: A-eDP1
[287.911991] Dynamic subtest A-eDP1: SUCCESS (8.874s)
[287.926686] Starting dynamic subtest: B-eDP1
[296.744470] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[296.756247] Starting dynamic subtest: C-eDP1
[305.563505] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[305.571455] Starting dynamic subtest: D-eDP1
[314.395388] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[314.399527] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.362s)
[315.571199] [062/133] (707s left) gem_exec_reloc (basic-gtt-wc)
[315.636841] Subtest basic-gtt-wc: SKIP (0.000s)
[315.707798] [063/133] (706s left) kms_invalid_mode (bad-hsync-end)
[315.800089] Starting subtest: bad-hsync-end
[315.802304] Starting dynamic subtest: pipe-A-eDP-1
[316.085040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[316.094046] Starting dynamic subtest: pipe-B-eDP-1
[316.096059] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[316.103760] Starting dynamic subtest: pipe-C-eDP-1
[316.105738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[316.122876] Starting dynamic subtest: pipe-D-eDP-1
[316.125672] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[316.128441] Subtest bad-hsync-end: SUCCESS (0.294s)
[316.921814] [064/133] (705s left) kms_vblank (query-forked-hang)
[317.013489] Starting subtest: query-forked-hang
[317.015815] Starting dynamic subtest: pipe-A-eDP-1
[343.702680] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.688s)
[343.716188] Starting dynamic subtest: pipe-D-eDP-1
[368.670158] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.963s)
[368.672316] Subtest query-forked-hang: SUCCESS (51.655s)
[369.484071] [065/133] (653s left) gem_flink_basic (flink-lifetime)
[369.552524] Starting subtest: flink-lifetime
[369.555045] Subtest flink-lifetime: SUCCESS (0.002s)
[369.673246] [066/133] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[369.767293] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[369.771480] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[369.871634] [067/133] (652s left) gem_ppgtt (flink-and-close-vma-leak)
[369.929406] Starting subtest: flink-and-close-vma-leak
[369.972298] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[370.099817] [068/133] (652s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[370.182231] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[370.184389] Starting dynamic subtest: pipe-A-eDP-1
[370.205587] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[370.217996] Starting dynamic subtest: pipe-B-eDP-1
[370.239293] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[370.247899] Starting dynamic subtest: pipe-C-eDP-1
[370.268636] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[370.276644] Starting dynamic subtest: pipe-D-eDP-1
[370.298171] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[370.302448] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[372.438651] [069/133] (650s left) gem_ctx_persistence (engines-mixed)
[372.492251] Starting subtest: engines-mixed
[372.494451] Starting dynamic subtest: rcs0
[372.558482] Dynamic subtest rcs0: SUCCESS (0.066s)
[372.569578] Starting dynamic subtest: bcs0
[372.603989] Dynamic subtest bcs0: SUCCESS (0.043s)
[372.613940] Starting dynamic subtest: vcs0
[372.653934] Dynamic subtest vcs0: SUCCESS (0.047s)
[372.663830] Starting dynamic subtest: vcs1
[372.695536] Dynamic subtest vcs1: SUCCESS (0.040s)
[372.705420] Starting dynamic subtest: vecs0
[372.744071] Dynamic subtest vecs0: SUCCESS (0.047s)
[372.754162] Starting dynamic subtest: ccs0
[372.792615] Dynamic subtest ccs0: SUCCESS (0.047s)
[372.795146] Subtest engines-mixed: SUCCESS (0.302s)
[372.872874] [070/133] (650s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[372.982842] Starting subtest: psr-rgb101010-draw-blt
[380.318762] Subtest psr-rgb101010-draw-blt: SUCCESS (7.339s)
[380.442940] [071/133] (642s left) kms_chamelium_audio (hdmi-audio-edid)
[380.825660] Subtest hdmi-audio-edid: SKIP (0.000s)
[381.682887] [072/133] (641s left) gem_ctx_persistence (many-contexts)
[381.739320] Starting subtest: many-contexts
[419.413642] Subtest many-contexts: SUCCESS (37.673s)
[419.505127] [073/133] (603s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[419.606820] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[419.618485] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[419.693748] [074/133] (603s left) kms_dsc (dsc-with-bpc)
[419.784107] Starting subtest: dsc-with-bpc
[419.813513] Subtest dsc-with-bpc: SKIP (0.001s)
[419.854659] [075/133] (603s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[419.909388] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[419.911583] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[419.994161] [076/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[420.086695] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[420.091190] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[420.184839] [077/133] (603s left) kms_prime (basic-crc-vgem)
[420.268487] Starting subtest: basic-crc-vgem
[420.270691] Starting dynamic subtest: second-to-first
[421.262182] Dynamic subtest second-to-first: SUCCESS (0.998s)
[421.264279] Subtest basic-crc-vgem: SUCCESS (0.999s)
[421.356590] [078/133] (601s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[421.483829] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[422.309344] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[422.499777] [079/133] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[422.611044] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[427.123824] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.516s)
[428.318901] [080/133] (595s left) kms_rotation_crc (sprite-rotation-270)
[428.431304] Starting subtest: sprite-rotation-270
[428.435699] Subtest sprite-rotation-270: SKIP (0.001s)
[428.502855] [081/133] (594s left) gen9_exec_parse (batch-without-end)
[428.578160] Subtest batch-without-end: SKIP (0.000s)
[428.651995] [082/133] (594s left) gem_wait (await)
[428.726752] Starting subtest: await
[428.729226] Starting dynamic subtest: all-engines
[429.832621] Dynamic subtest all-engines: SUCCESS (1.105s)
[429.850411] Starting dynamic subtest: rcs0
[430.890683] Dynamic subtest rcs0: SUCCESS (1.056s)
[430.904890] Starting dynamic subtest: bcs0
[431.952838] Dynamic subtest bcs0: SUCCESS (1.059s)
[431.970041] Starting dynamic subtest: vcs0
[433.007850] Dynamic subtest vcs0: SUCCESS (1.053s)
[433.023093] Starting dynamic subtest: vcs1
[434.060295] Dynamic subtest vcs1: SUCCESS (1.051s)
[434.076044] Starting dynamic subtest: vecs0
[435.114025] Dynamic subtest vecs0: SUCCESS (1.052s)
[435.129905] Starting dynamic subtest: ccs0
[436.171392] Dynamic subtest ccs0: SUCCESS (1.055s)
[436.173841] Subtest await: SUCCESS (7.445s)
[436.373599] [083/133] (587s left) gem_mmap_wc (write-read-distinct)
[436.450138] Subtest write-read-distinct: SKIP (0.000s)
[436.512307] [084/133] (587s left) kms_psr2_su (page_flip-nv12)
[436.573907] Subtest page_flip-NV12: SKIP (0.000s)
[436.635476] [085/133] (586s left) kms_properties (plane-properties-legacy)
[436.740252] Starting subtest: plane-properties-legacy
[436.742563] Starting dynamic subtest: pipe-A-eDP-1
[437.294727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[437.304164] Starting dynamic subtest: pipe-B-eDP-1
[438.581561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[438.590047] Starting dynamic subtest: pipe-C-eDP-1
[439.897064] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.314s)
[439.905669] Starting dynamic subtest: pipe-D-eDP-1
[441.130603] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[441.133077] Subtest plane-properties-legacy: SUCCESS (4.392s)
[441.937121] [086/133] (581s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[442.042165] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[442.046501] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[442.141659] [087/133] (581s left) drm_read (fault-buffer)
[442.299257] Starting subtest: fault-buffer
[442.301608] Subtest fault-buffer: SUCCESS (0.001s)
[442.417535] [088/133] (581s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[442.472316] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[442.577662] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[442.654062] [089/133] (581s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[442.704841] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[442.810453] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[442.899707] [090/133] (580s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[442.961966] Starting subtest: y-tiled-to-vebox-yf-tiled
[442.967224] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[443.146560] [091/133] (580s left) kms_addfb_basic (invalid-get-prop)
[443.209286] Starting subtest: invalid-get-prop
[443.211540] Subtest invalid-get-prop: SUCCESS (0.000s)
[443.348540] [092/133] (580s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[443.443837] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[450.252236] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.812s)
[450.394280] [093/133] (573s left) kms_mmap_write_crc (main)
[450.501103] Starting subtest: main
[450.503437] Starting dynamic subtest: pipe-A-eDP-1
[454.051739] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.546s)
[454.054254] Subtest main: SUCCESS (3.548s)
[454.890617] [094/133] (569s left) i915_suspend (fence-restore-tiled2untiled)
[454.947089] Starting subtest: fence-restore-tiled2untiled
[454.950827] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[455.049437] [095/133] (568s left) perf_pmu (busy-idle)
[455.092923] Starting subtest: busy-idle
[455.095294] Starting dynamic subtest: rcs0
[455.794243] Dynamic subtest rcs0: SUCCESS (0.701s)
[455.808050] Starting dynamic subtest: bcs0
[456.468092] Dynamic subtest bcs0: SUCCESS (0.671s)
[456.479314] Starting dynamic subtest: vcs0
[457.877853] Dynamic subtest vcs0: SUCCESS (1.406s)
[457.889620] Starting dynamic subtest: vcs1
[459.925501] Dynamic subtest vcs1: SUCCESS (2.045s)
[459.935381] Starting dynamic subtest: vecs0
[461.909525] Dynamic subtest vecs0: SUCCESS (1.982s)
[461.920849] Starting dynamic subtest: ccs0
[462.575839] Dynamic subtest ccs0: SUCCESS (0.665s)
[462.578525] Subtest busy-idle: SUCCESS (7.484s)
[462.669455] [096/133] (561s left) testdisplay
[462.995300] [097/133] (561s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[463.118277] Starting subtest: 2x-cursor-vs-flip-atomic
[463.122741] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[463.262388] [098/133] (560s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[463.370380] Starting subtest: psr2-cursor-plane-move-continuous-sf
[463.372594] Starting dynamic subtest: pipe-A-eDP-1
[473.754069] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.387s)
[473.771907] Starting dynamic subtest: pipe-B-eDP-1
[484.865899] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.111s)
[484.868173] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.501s)
[485.670826] [099/133] (538s left) prime_mmap (test_reprime)
[485.723486] Starting subtest: test_reprime
[485.725960] Starting dynamic subtest: test_reprime-smem
[485.752298] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[485.754826] Subtest test_reprime: SUCCESS (0.033s)
[485.851784] [100/133] (538s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[485.954213] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[485.958115] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[486.063762] [101/133] (538s left) kms_async_flips (async-flip-hang)
[486.164047] Starting subtest: async-flip-hang
[486.536582] Starting dynamic subtest: pipe-A-eDP-1
[502.448397] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.909s)
[502.841593] Starting dynamic subtest: pipe-B-eDP-1
[518.383458] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.546s)
[518.766449] Starting dynamic subtest: pipe-C-eDP-1
[534.445792] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.681s)
[534.822679] Starting dynamic subtest: pipe-D-eDP-1
[550.388902] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.569s)
[550.391689] Subtest async-flip-hang: SUCCESS (64.222s)
[551.606315] [102/133] (472s left) kms_cursor_edge_walk (64x64-right-edge)
[551.702234] Starting subtest: 64x64-right-edge
[551.704578] Starting dynamic subtest: pipe-A-eDP-1
[555.162063] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[555.170995] Starting dynamic subtest: pipe-D-eDP-1
[558.297409] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[558.299320] Subtest 64x64-right-edge: SUCCESS (6.594s)
[559.106300] [103/133] (465s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[559.211603] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[559.215792] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[559.310419] [104/133] (465s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[559.407781] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[559.410057] Starting dynamic subtest: pipe-A-eDP-1
[559.431919] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[559.442648] Starting dynamic subtest: pipe-B-eDP-1
[559.462798] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[559.471063] Starting dynamic subtest: pipe-C-eDP-1
[559.491809] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[559.499940] Starting dynamic subtest: pipe-D-eDP-1
[559.522195] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[559.526591] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[561.652701] [105/133] (462s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[561.737999] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[561.742159] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[561.820203] [106/133] (462s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[561.908459] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[561.910605] Starting dynamic subtest: pipe-A-default-mode
[563.122452] Dynamic subtest pipe-A-default-mode: SKIP (1.212s)
[563.126764] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.214s)
[563.291101] [107/133] (461s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[563.389384] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[563.393632] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[563.494850] [108/133] (461s left) gem_fence_thrash (bo-write-verify-threaded-none)
[563.535925] Starting subtest: bo-write-verify-threaded-none
[563.550891] Subtest bo-write-verify-threaded-none: SKIP (0.013s)
[563.608716] [109/133] (460s left) gem_exec_store (basic)
[563.665870] Starting subtest: basic
[563.761613] Subtest basic: SUCCESS (0.098s)
[563.966577] [110/133] (460s left) gem_userptr_blits (create-destroy-sync)
[564.025992] Starting subtest: create-destroy-sync
[569.041918] Subtest create-destroy-sync: SUCCESS (5.016s)
[569.170497] [111/133] (455s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[569.271076] Starting subtest: psr-2p-primscrn-cur-indfb-move
[569.275100] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[569.367421] [112/133] (455s left) kms_plane_multiple (2x-tiling-4)
[569.462965] Starting subtest: 2x-tiling-4
[569.466938] Subtest 2x-tiling-4: SKIP (0.000s)
[569.534681] [113/133] (455s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[569.623141] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[569.627038] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[569.714374] [114/133] (455s left) perf_pmu (semaphore-wait-idle)
[569.754097] Starting subtest: semaphore-wait-idle
[569.755991] Starting dynamic subtest: rcs0
[570.269177] Dynamic subtest rcs0: SUCCESS (0.514s)
[570.284185] Starting dynamic subtest: bcs0
[570.783261] Dynamic subtest bcs0: SUCCESS (0.511s)
[570.798957] Starting dynamic subtest: vcs0
[571.296321] Dynamic subtest vcs0: SUCCESS (0.510s)
[571.307856] Starting dynamic subtest: vcs1
[571.810133] Dynamic subtest vcs1: SUCCESS (0.511s)
[571.821605] Starting dynamic subtest: vecs0
[572.323568] Dynamic subtest vecs0: SUCCESS (0.510s)
[572.335187] Starting dynamic subtest: ccs0
[572.838958] Dynamic subtest ccs0: SUCCESS (0.512s)
[572.841900] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[573.998307] [115/133] (450s left) sysfs_defaults (readonly)
[574.051781] Starting subtest: readonly
[574.054010] Starting dynamic subtest: vecs0
[574.056130] Dynamic subtest vecs0: SUCCESS (0.000s)
[574.066131] Starting dynamic subtest: ccs0
[574.068248] Dynamic subtest ccs0: SUCCESS (0.000s)
[574.076675] Starting dynamic subtest: vcs0
[574.078546] Dynamic subtest vcs0: SUCCESS (0.000s)
[574.086740] Starting dynamic subtest: bcs0
[574.088851] Dynamic subtest bcs0: SUCCESS (0.000s)
[574.096989] Starting dynamic subtest: rcs0
[574.099199] Dynamic subtest rcs0: SUCCESS (0.000s)
[574.107210] Starting dynamic subtest: vcs1
[574.109369] Dynamic subtest vcs1: SUCCESS (0.000s)
[574.111613] Subtest readonly: SUCCESS (0.006s)
[574.154813] [116/133] (450s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[574.259739] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[574.262119] Starting dynamic subtest: pipe-A-eDP-1
[574.337423] Dynamic subtest pipe-A-eDP-1: SKIP (0.082s)
[574.346654] Starting dynamic subtest: pipe-B-eDP-1
[575.471393] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[575.475769] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.216s)
[576.664073] [117/133] (448s left) gem_mmap_gtt (cpuset-big-copy-xy)
[576.734591] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[576.789595] [118/133] (448s left) drm_read (short-buffer-block)
[576.932197] Starting subtest: short-buffer-block
[576.934594] Subtest short-buffer-block: SUCCESS (0.000s)
[577.070394] [119/133] (447s left) perf (sysctl-defaults)
[577.140780] Starting subtest: sysctl-defaults
[577.143188] Subtest sysctl-defaults: SUCCESS (0.000s)
[577.221287] [120/133] (447s left) gem_mmap (pf-nonblock)
[577.268159] Subtest pf-nonblock: SKIP (0.000s)
[577.329927] [121/133] (447s left) kms_psr (psr-sprite-blt)
[577.417315] Starting subtest: psr-sprite-blt
[577.419453] Starting dynamic subtest: eDP-1
[579.192566] Dynamic subtest eDP-1: SUCCESS (1.774s)
[579.194740] Subtest psr-sprite-blt: SUCCESS (1.775s)
[580.015953] [122/133] (445s left) core_sysfs (read-all-entries)
[580.071244] Starting subtest: read-all-entries
[580.079503] Subtest read-all-entries: SUCCESS (0.011s)
[580.154289] [123/133] (445s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[580.251155] Starting subtest: fbc-psr-sprite-mmap-gtt
[580.253467] Starting dynamic subtest: eDP-1
[580.257649] Dynamic subtest eDP-1: SKIP (0.000s)
[580.261845] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[580.324380] [124/133] (444s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[580.378076] Starting subtest: wait-all-for-submit-delayed-submit
[580.481288] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[580.569539] [125/133] (444s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[580.659819] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[580.663817] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[580.758657] [126/133] (444s left) kms_async_flips (test-time-stamp-atomic)
[580.844912] Starting subtest: test-time-stamp-atomic
[581.227516] Starting dynamic subtest: pipe-A-eDP-1
[582.015652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[582.407580] Starting dynamic subtest: pipe-B-eDP-1
[583.165961] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[583.549019] Starting dynamic subtest: pipe-C-eDP-1
[584.311428] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[584.684392] Starting dynamic subtest: pipe-D-eDP-1
[585.443077] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[585.445457] Subtest test-time-stamp-atomic: SUCCESS (4.598s)
[586.616720] [127/133] (438s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[586.726142] Starting subtest: plane-downscale-factor-0-5-with-rotation
[586.728420] Starting dynamic subtest: pipe-A
[586.746210] Dynamic subtest pipe-A: SKIP (0.017s)
[586.755310] Starting dynamic subtest: pipe-B
[586.777312] Dynamic subtest pipe-B: SKIP (0.030s)
[586.786141] Starting dynamic subtest: pipe-C
[586.808064] Dynamic subtest pipe-C: SKIP (0.030s)
[586.816223] Starting dynamic subtest: pipe-D
[586.840667] Dynamic subtest pipe-D: SKIP (0.030s)
[586.844819] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.111s)
[586.947413] [128/133] (438s left) i915_pm_rps (reset)
[587.012326] Starting subtest: reset
[595.470500] Subtest reset: SUCCESS (8.456s)
[595.587924] [129/133] (429s left) gem_render_copy (yf-tiled)
[595.646062] Starting subtest: yf-tiled
[595.650694] Subtest yf-tiled: SKIP (0.000s)
[595.848630] [130/133] (429s left) gem_ctx_engines (independent)
[595.905905] Starting subtest: independent
[595.908638] Starting dynamic subtest: rcs0
[596.165223] Dynamic subtest rcs0: SUCCESS (0.257s)
[596.177590] Starting dynamic subtest: bcs0
[596.443873] Dynamic subtest bcs0: SUCCESS (0.277s)
[596.455900] Starting dynamic subtest: vcs0
[596.708044] Dynamic subtest vcs0: SUCCESS (0.263s)
[596.719965] Starting dynamic subtest: vcs1
[596.999576] Dynamic subtest vcs1: SUCCESS (0.291s)
[597.009468] Starting dynamic subtest: vecs0
[597.297451] Dynamic subtest vecs0: SUCCESS (0.297s)
[597.308716] Starting dynamic subtest: ccs0
[597.604834] Dynamic subtest ccs0: SUCCESS (0.307s)
[597.616681] Starting dynamic subtest: all-engines
[598.843262] Dynamic subtest all-engines: SUCCESS (1.237s)
[598.845949] Subtest independent: SUCCESS (2.937s)
[599.948963] [131/133] (425s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[600.052076] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[600.054331] Starting dynamic subtest: pipe-A-eDP-1
[600.112306] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[600.126161] Starting dynamic subtest: pipe-B-eDP-1
[600.182560] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[600.195934] Starting dynamic subtest: pipe-C-eDP-1
[600.252577] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[600.266994] Starting dynamic subtest: pipe-D-eDP-1
[600.325210] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[600.329658] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[602.301237] [132/133] (423s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[602.412203] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[602.414370] Starting dynamic subtest: pipe-A-eDP-1
[603.289249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s)
[603.298463] Starting dynamic subtest: pipe-B-eDP-1
[604.918066] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.624s)
[604.928433] Starting dynamic subtest: pipe-C-eDP-1
[606.438522] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.521s)
[606.448196] Starting dynamic subtest: pipe-D-eDP-1
[607.987929] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s)
[607.990255] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.569s)
[609.132442] [133/133] (416s left) gem_exec_reloc (basic-scanout)
[609.185544] Subtest basic-scanout: SKIP (0.000s)
[609.245887] 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.