[58.659811] Initializing watchdogs
[58.659860]   /dev/watchdog0
[58.675377] [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]
[58.680270] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.682549] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.685914] [001/132] (960s left) gem_exec_balancer (bonded-true-hang)
[58.983301] Starting subtest: bonded-true-hang
[58.987975] Subtest bonded-true-hang: SKIP (0.000s)
[59.075224] [002/132] (960s left) kms_chamelium_edid (dp-edid-resolution-list)
[59.474047] Subtest dp-edid-resolution-list: SKIP (0.000s)
[60.334840] [003/132] (958s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[60.432272] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[60.436902] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[60.501317] [004/132] (958s left) gem_pread (uncached)
[60.561662] Subtest uncached: SKIP (0.000s)
[60.619837] [005/132] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[60.715447] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[67.312958] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.603s)
[67.639846] [006/132] (951s left) gem_sync (basic-many-each)
[67.737082] Starting subtest: basic-many-each
[70.052679] Subtest basic-many-each: SUCCESS (2.325s)
[70.236377] [007/132] (949s left) syncobj_wait (wait-any-complex)
[70.294679] Starting subtest: wait-any-complex
[70.358485] Subtest wait-any-complex: SUCCESS (0.063s)
[70.438067] [008/132] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[70.546424] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[70.550518] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[70.640170] [009/132] (948s left) syncobj_timeline (invalid-signal-bad-pad)
[70.708126] Starting subtest: invalid-signal-bad-pad
[70.710523] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[70.815194] [010/132] (948s left) gem_spin_batch (legacy-resubmit)
[70.878760] Starting subtest: legacy-resubmit
[70.881160] Starting dynamic subtest: default
[70.883485] Dynamic subtest default: SUCCESS (0.006s)
[70.892732] Starting dynamic subtest: render
[70.895297] Dynamic subtest render: SUCCESS (0.001s)
[70.902907] Starting dynamic subtest: bsd
[70.905098] Dynamic subtest bsd: SUCCESS (0.002s)
[70.912049] Starting dynamic subtest: bsd1
[70.914186] Dynamic subtest bsd1: SUCCESS (0.002s)
[70.921122] Starting dynamic subtest: bsd2
[70.923208] Dynamic subtest bsd2: SUCCESS (0.002s)
[70.930163] Starting dynamic subtest: blt
[70.932256] Dynamic subtest blt: SUCCESS (0.002s)
[70.939137] Starting dynamic subtest: vebox
[70.941256] Dynamic subtest vebox: SUCCESS (0.003s)
[70.943376] Subtest legacy-resubmit: SUCCESS (0.020s)
[71.134295] [011/132] (948s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[71.235587] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[71.237611] Starting dynamic subtest: pipe-A-eDP-1
[71.313260] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[71.323189] Starting dynamic subtest: pipe-B-eDP-1
[72.465316] Dynamic subtest pipe-B-eDP-1: SKIP (1.148s)
[72.469971] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.230s)
[73.660636] [012/132] (945s left) gem_exec_params (invalid-bsd2-flag-on-render)
[73.718513] Starting subtest: invalid-bsd2-flag-on-render
[73.721047] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[73.810214] [013/132] (945s left) gem_ctx_shared (q-independent)
[73.873886] Starting subtest: Q-independent
[73.876394] Starting dynamic subtest: rcs0
[73.939080] Dynamic subtest rcs0: SUCCESS (0.065s)
[73.948059] Starting dynamic subtest: vcs0
[73.980530] Dynamic subtest vcs0: SUCCESS (0.041s)
[73.988991] Starting dynamic subtest: vcs1
[74.017997] Dynamic subtest vcs1: SUCCESS (0.037s)
[74.028126] Starting dynamic subtest: vecs0
[74.054901] Dynamic subtest vecs0: SUCCESS (0.036s)
[74.064100] Starting dynamic subtest: ccs0
[74.096852] Dynamic subtest ccs0: SUCCESS (0.042s)
[74.099461] Subtest Q-independent: SUCCESS (0.223s)
[76.010360] [014/132] (943s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[76.112912] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[76.115383] Starting dynamic subtest: pipe-A-eDP-1
[76.138598] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[76.147914] Starting dynamic subtest: pipe-B-eDP-1
[76.169746] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.176723] Starting dynamic subtest: pipe-C-eDP-1
[76.197311] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.204268] Starting dynamic subtest: pipe-D-eDP-1
[76.225707] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.230056] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[78.415665] [015/132] (941s left) syncobj_eventfd (binary-wait)
[78.472994] Starting subtest: binary-wait
[78.481719] Subtest binary-wait: SUCCESS (0.010s)
[78.553445] [016/132] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[78.659051] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[78.663343] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[78.755902] [017/132] (941s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[78.859825] Starting subtest: x-tiled-8bpp-rotate-90
[78.883429] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[78.981104] [018/132] (940s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[79.022733] Starting subtest: framebuffer-vs-set-tiling
[79.027349] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[79.145826] [019/132] (940s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[79.202590] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[79.204793] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[79.309316] [020/132] (940s left) syncobj_timeline (multi-wait-available-submitted)
[79.370528] Starting subtest: multi-wait-available-submitted
[79.372498] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[79.459686] [021/132] (940s left) i915_pm_rps (fence-order)
[79.514338] Starting subtest: fence-order
[83.044623] Subtest fence-order: SUCCESS (3.529s)
[83.171025] [022/132] (936s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[83.246074] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[83.319074] [023/132] (936s left) syncobj_wait (multi-wait-submitted)
[83.377582] Starting subtest: multi-wait-submitted
[83.480794] Subtest multi-wait-submitted: SUCCESS (0.103s)
[83.568707] [024/132] (936s left) kms_plane_cursor (primary)
[83.672220] Starting subtest: primary
[83.676924] Starting dynamic subtest: pipe-A-eDP-1-size-64
[86.256219] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.587s)
[86.279724] Starting dynamic subtest: pipe-A-eDP-1-size-128
[88.835585] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.561s)
[88.860342] Starting dynamic subtest: pipe-A-eDP-1-size-256
[91.447693] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.594s)
[91.768211] Starting dynamic subtest: pipe-B-eDP-1-size-64
[95.025964] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.267s)
[95.048235] Starting dynamic subtest: pipe-B-eDP-1-size-128
[97.659448] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.617s)
[97.685519] Starting dynamic subtest: pipe-B-eDP-1-size-256
[100.237451] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[100.557740] Starting dynamic subtest: pipe-C-eDP-1-size-64
[103.544115] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.996s)
[103.569917] Starting dynamic subtest: pipe-C-eDP-1-size-128
[105.766053] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[105.792238] Starting dynamic subtest: pipe-C-eDP-1-size-256
[107.966150] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[108.283908] Starting dynamic subtest: pipe-D-eDP-1-size-64
[111.207553] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.933s)
[111.233410] Starting dynamic subtest: pipe-D-eDP-1-size-128
[113.440893] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[113.466931] Starting dynamic subtest: pipe-D-eDP-1-size-256
[115.630897] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.170s)
[115.937137] Subtest primary: SUCCESS (32.266s)
[116.770581] [025/132] (903s left) kms_addfb_basic (bad-pitch-0)
[116.820236] Starting subtest: bad-pitch-0
[116.822638] Subtest bad-pitch-0: SUCCESS (0.000s)
[116.947783] [026/132] (903s left) gem_exec_fence (invalid-fence-array)
[117.448603] Starting subtest: invalid-fence-array
[117.450966] Subtest invalid-fence-array: SUCCESS (0.002s)
[118.937107] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[118.940856] [027/132] (901s left) kms_flip (2x-flip-vs-fences-interruptible)
[119.037309] Starting subtest: 2x-flip-vs-fences-interruptible
[119.041641] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[119.127102] [028/132] (901s left) kms_cursor_crc (cursor-random-128x42)
[119.369812] Starting subtest: cursor-random-128x42
[119.419315] Subtest cursor-random-128x42: SKIP (0.047s)
[119.641028] [029/132] (900s left) kms_busy (extended-modeset-hang-oldfb)
[119.742016] Starting subtest: extended-modeset-hang-oldfb
[119.744242] Starting dynamic subtest: pipe-A
[131.553459] Dynamic subtest pipe-A: SUCCESS (11.808s)
[131.562685] Starting dynamic subtest: pipe-D
[143.835264] Dynamic subtest pipe-D: SUCCESS (12.281s)
[143.837658] Subtest extended-modeset-hang-oldfb: SUCCESS (24.094s)
[144.631460] [030/132] (875s left) syncobj_timeline (single-wait-available-signaled)
[144.688953] Starting subtest: single-wait-available-signaled
[144.691483] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[144.778482] [031/132] (875s left) i915_query (query-regions-unallocated)
[144.837568] Starting subtest: query-regions-unallocated
[144.839758] Subtest query-regions-unallocated: SUCCESS (0.000s)
[144.948168] [032/132] (875s left) kms_rotation_crc (exhaust-fences)
[145.038196] Starting subtest: exhaust-fences
[145.042187] Subtest exhaust-fences: SKIP (0.000s)
[145.117256] [033/132] (875s left) gem_render_copy (yf-tiled-ccs-to-linear)
[145.174465] Starting subtest: yf-tiled-ccs-to-linear
[145.179075] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[145.361415] [034/132] (875s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[145.460362] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[145.464665] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[145.549840] [035/132] (875s left) perf_pmu (all-busy-check-all)
[145.590278] Starting subtest: all-busy-check-all
[146.902449] Subtest all-busy-check-all: SUCCESS (1.310s)
[147.007436] [036/132] (873s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[147.112009] Starting subtest: fbcpsr-tiling-y
[147.116184] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[147.206119] [037/132] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[147.307502] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[154.141566] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.836s)
[154.290705] [038/132] (866s left) api_intel_bb (intel-bb-blit-x)
[154.358540] Starting subtest: intel-bb-blit-x
[158.316100] Subtest intel-bb-blit-x: SUCCESS (3.958s)
[158.424183] [039/132] (862s left) gem_ctx_persistence (heartbeat-stop)
[158.485240] Starting subtest: heartbeat-stop
[158.489856] Subtest heartbeat-stop: SKIP (0.000s)
[158.586711] [040/132] (862s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[158.692156] Starting subtest: yf-tiled-32bpp-rotate-90
[158.696323] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[158.776353] [041/132] (862s left) kms_psr (psr2-primary-blt)
[158.875137] Starting subtest: psr2-primary-blt
[158.877286] Starting dynamic subtest: eDP-1
[160.667909] Dynamic subtest eDP-1: SUCCESS (1.794s)
[160.670080] Subtest psr2-primary-blt: SUCCESS (1.795s)
[161.545626] [042/132] (859s left) kms_big_fb (x-tiled-addfb-size-overflow)
[161.645980] Starting subtest: x-tiled-addfb-size-overflow
[161.648371] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[161.740246] [043/132] (859s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[161.841905] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[161.845980] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[161.952935] [044/132] (859s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[162.053765] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[162.058086] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[162.146955] [045/132] (858s left) api_intel_allocator (fork-simple-stress-signal)
[162.212600] Starting subtest: fork-simple-stress-signal
[167.624478] Subtest fork-simple-stress-signal: SUCCESS (5.412s)
[167.756375] [046/132] (853s left) prime_mmap (test_correct)
[167.812874] Starting subtest: test_correct
[167.815193] Starting dynamic subtest: test_correct-smem
[167.849920] Dynamic subtest test_correct-smem: SUCCESS (0.039s)
[167.852359] Subtest test_correct: SUCCESS (0.040s)
[167.956907] [047/132] (853s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[168.070808] Starting subtest: 4-tiled-64bpp-rotate-180
[169.818041] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.747s)
[169.983743] [048/132] (851s left) gem_ctx_isolation (preservation)
[170.049327] Starting subtest: preservation
[170.051521] Starting dynamic subtest: rcs0
[170.198837] Dynamic subtest rcs0: SUCCESS (0.149s)
[170.208104] Starting dynamic subtest: bcs0
[170.361818] Dynamic subtest bcs0: SUCCESS (0.161s)
[170.372548] Starting dynamic subtest: vcs0
[170.533416] Dynamic subtest vcs0: SUCCESS (0.170s)
[170.544724] Starting dynamic subtest: vcs1
[172.049195] Dynamic subtest vcs1: SUCCESS (1.515s)
[172.058579] Starting dynamic subtest: vecs0
[174.030171] Dynamic subtest vecs0: SUCCESS (1.980s)
[174.042274] Starting dynamic subtest: ccs0
[176.036683] Dynamic subtest ccs0: SUCCESS (2.005s)
[176.039401] Subtest preservation: SUCCESS (5.987s)
[176.275435] [049/132] (844s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[176.392505] Starting subtest: fbcpsr-rgb565-draw-pwrite
[183.472812] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.084s)
[183.595762] [050/132] (837s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[183.705700] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[184.784445] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.079s)
[184.938904] [051/132] (836s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[185.037535] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[185.041480] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[186.200921] [052/132] (835s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[186.288160] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[186.290296] Starting dynamic subtest: pipe-A-default-mode
[187.461588] Dynamic subtest pipe-A-default-mode: SKIP (1.170s)
[187.465738] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.172s)
[187.610063] [053/132] (833s left) kms_psr (psr-primary-render)
[187.706429] Starting subtest: psr-primary-render
[187.708652] Starting dynamic subtest: eDP-1
[189.448919] Dynamic subtest eDP-1: SUCCESS (1.743s)
[189.451267] Subtest psr-primary-render: SUCCESS (1.744s)
[190.291298] [054/132] (831s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[190.389836] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[190.394122] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[190.484429] [055/132] (830s left) gem_exec_params (cliprects-invalid)
[190.534626] Starting subtest: cliprects-invalid
[190.537026] Subtest cliprects-invalid: SUCCESS (0.000s)
[190.634752] [056/132] (830s left) kms_draw_crc (draw-method-mmap-cpu)
[190.723603] Starting subtest: draw-method-mmap-cpu
[190.725554] Starting dynamic subtest: xrgb8888-untiled
[190.977615] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[190.987300] Starting dynamic subtest: rgb565-untiled
[191.211105] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[191.219285] Starting dynamic subtest: xrgb2101010-untiled
[191.432930] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[191.443166] Starting dynamic subtest: xbgr16161616f-untiled
[191.655820] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.220s)
[191.665516] Starting dynamic subtest: xrgb8888-xtiled
[191.777203] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[191.785468] Starting dynamic subtest: rgb565-xtiled
[191.899488] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[191.907861] Starting dynamic subtest: xrgb2101010-xtiled
[192.021778] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[192.030899] Starting dynamic subtest: xbgr16161616f-xtiled
[192.155380] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[192.165476] Starting dynamic subtest: xrgb8888-4tiled
[192.299486] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[192.307666] Starting dynamic subtest: rgb565-4tiled
[192.444268] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[192.453140] Starting dynamic subtest: xrgb2101010-4tiled
[192.610669] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.166s)
[192.618680] Starting dynamic subtest: xbgr16161616f-4tiled
[192.855468] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.244s)
[192.857884] Subtest draw-method-mmap-cpu: SUCCESS (2.134s)
[192.950628] [057/132] (828s left) gem_ctx_engines (execute-oneforall)
[193.027356] Starting subtest: execute-oneforall
[193.549168] Subtest execute-oneforall: SUCCESS (0.525s)
[195.023089] [058/132] (826s left) kms_flip (flip-vs-wf_vblank-interruptible)
[195.115763] Starting subtest: flip-vs-wf_vblank-interruptible
[195.118040] Starting dynamic subtest: A-eDP1
[197.029195] Dynamic subtest A-eDP1: SUCCESS (1.912s)
[197.040084] Starting dynamic subtest: B-eDP1
[198.960670] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[198.971461] Starting dynamic subtest: C-eDP1
[200.876863] Dynamic subtest C-eDP1: SUCCESS (1.914s)
[200.886333] Starting dynamic subtest: D-eDP1
[202.811194] Dynamic subtest D-eDP1: SUCCESS (1.933s)
[202.813414] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.698s)
[204.043171] [059/132] (817s left) kms_lease (setcrtc-implicit-plane)
[204.139020] Starting subtest: setcrtc-implicit-plane
[204.141420] Starting dynamic subtest: pipe-A-eDP-1
[204.606513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s)
[204.615457] Starting dynamic subtest: pipe-B-eDP-1
[205.786643] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[205.795511] Starting dynamic subtest: pipe-C-eDP-1
[206.889544] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[206.902952] Starting dynamic subtest: pipe-D-eDP-1
[208.015060] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[208.017366] Subtest setcrtc-implicit-plane: SUCCESS (3.877s)
[208.855465] [060/132] (812s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[208.954795] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[208.959233] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[209.040239] [061/132] (812s left) kms_plane_alpha_blend (alpha-7efc)
[209.128164] Starting subtest: alpha-7efc
[209.411882] Starting dynamic subtest: pipe-A-eDP-1
[210.038084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[210.064587] Starting dynamic subtest: pipe-D-eDP-1
[211.362082] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s)
[211.364455] Subtest alpha-7efc: SUCCESS (2.236s)
[212.203937] [062/132] (809s left) perf_pmu (enable-race)
[212.242883] Starting subtest: enable-race
[212.245348] Starting dynamic subtest: rcs0
[225.008542] Dynamic subtest rcs0: SUCCESS (12.767s)
[225.019045] Starting dynamic subtest: bcs0
[237.753990] Dynamic subtest bcs0: SUCCESS (12.743s)
[237.765456] Starting dynamic subtest: vcs0
[252.885031] Dynamic subtest vcs0: SUCCESS (15.126s)
[252.896471] Starting dynamic subtest: vcs1
[268.884989] Dynamic subtest vcs1: SUCCESS (15.996s)
[268.896084] Starting dynamic subtest: vecs0
[284.884191] Dynamic subtest vecs0: SUCCESS (15.995s)
[284.896638] Starting dynamic subtest: ccs0
[297.632331] Dynamic subtest ccs0: SUCCESS (12.746s)
[297.635620] Subtest enable-race: SUCCESS (85.389s)
[297.747379] [063/132] (724s left) gem_ctx_param (set-priority-not-supported)
[297.802948] Starting subtest: set-priority-not-supported
[297.807598] Subtest set-priority-not-supported: SKIP (0.000s)
[297.881870] [064/132] (723s left) gem_lmem_swapping (basic)
[297.925030] Subtest basic: SKIP (0.000s)
[297.965113] [065/132] (723s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[298.068105] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[305.074527] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.008s)
[305.229174] [066/132] (716s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[305.357674] Starting subtest: cursorB-vs-flipB-atomic
[305.362317] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[305.505776] [067/132] (716s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[305.566320] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[305.672870] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[305.748652] [068/132] (716s left) fbdev (eof)
[305.790936] Starting subtest: eof
[305.793183] Subtest eof: SUCCESS (0.000s)
[305.868902] [069/132] (716s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[306.287682] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[307.067999] [070/132] (715s left) gem_flink_basic (double-flink)
[307.136662] Starting subtest: double-flink
[307.138980] Subtest double-flink: SUCCESS (0.000s)
[307.246260] [071/132] (714s left) kms_properties (get_properties-sanity-atomic)
[307.349970] Starting subtest: get_properties-sanity-atomic
[307.354348] Subtest get_properties-sanity-atomic: SUCCESS (0.005s)
[307.451896] [072/132] (714s left) gem_pxp (display-protected-crc)
[307.581058] Starting subtest: display-protected-crc
[309.256287] Subtest display-protected-crc: SUCCESS (1.678s)
[309.372871] [073/132] (712s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[309.471053] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[309.475408] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[309.545183] [074/132] (712s left) i915_hangman (engine-engine-error)
[309.621402] Starting subtest: engine-engine-error
[309.623746] Starting dynamic subtest: rcs0
[310.835075] Dynamic subtest rcs0: SUCCESS (1.213s)
[310.845952] Starting dynamic subtest: bcs0
[312.883549] Dynamic subtest bcs0: SUCCESS (2.045s)
[312.895407] Starting dynamic subtest: vcs0
[314.865720] Dynamic subtest vcs0: SUCCESS (1.980s)
[314.880424] Starting dynamic subtest: vcs1
[316.851204] Dynamic subtest vcs1: SUCCESS (1.982s)
[316.862930] Starting dynamic subtest: vecs0
[318.898873] Dynamic subtest vecs0: SUCCESS (2.045s)
[318.910630] Starting dynamic subtest: ccs0
[320.882783] Dynamic subtest ccs0: SUCCESS (1.981s)
[320.885679] Subtest engine-engine-error: SUCCESS (11.263s)
[321.034539] [075/132] (701s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[321.141142] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[321.145474] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[321.214834] [076/132] (701s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[321.320370] Starting subtest: psr2-overlay-plane-move-continuous-sf
[321.322654] Starting dynamic subtest: pipe-A-eDP-1
[327.287587] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.970s)
[327.301246] Starting dynamic subtest: pipe-B-eDP-1
[333.971341] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.682s)
[333.973689] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.657s)
[334.763852] [077/132] (687s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[334.872640] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[334.876797] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[334.963657] [078/132] (687s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[335.055192] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[335.057306] Starting dynamic subtest: pipe-A
[335.076774] Dynamic subtest pipe-A: SKIP (0.019s)
[335.085902] Starting dynamic subtest: pipe-B
[335.110636] Dynamic subtest pipe-B: SKIP (0.032s)
[335.119417] Starting dynamic subtest: pipe-C
[335.142632] Dynamic subtest pipe-C: SKIP (0.032s)
[335.151239] Starting dynamic subtest: pipe-D
[335.174321] Dynamic subtest pipe-D: SKIP (0.032s)
[335.178425] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.117s)
[335.303053] [079/132] (687s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[335.409831] Starting subtest: async-flip-with-page-flip-events-tiled
[335.797624] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[338.536677] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.738s)
[338.545221] Starting dynamic subtest: pipe-A-eDP-1-4
[340.711939] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[340.722977] Starting dynamic subtest: pipe-A-eDP-1-4
[342.721924] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[342.731552] Starting dynamic subtest: pipe-A-eDP-1-x
[344.900551] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[345.269183] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[348.062377] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[348.071467] Starting dynamic subtest: pipe-B-eDP-1-4
[350.234547] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.171s)
[350.243504] Starting dynamic subtest: pipe-B-eDP-1-4
[352.245268] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[352.254897] Starting dynamic subtest: pipe-B-eDP-1-x
[354.434606] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[354.798324] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[357.584975] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[357.594255] Starting dynamic subtest: pipe-C-eDP-1-4
[359.770048] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s)
[359.779262] Starting dynamic subtest: pipe-C-eDP-1-4
[361.781170] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[361.790601] Starting dynamic subtest: pipe-C-eDP-1-x
[363.959663] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[364.324074] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[367.113133] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[367.123129] Starting dynamic subtest: pipe-D-eDP-1-4
[369.276204] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s)
[369.284899] Starting dynamic subtest: pipe-D-eDP-1-4
[371.287033] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[371.296340] Starting dynamic subtest: pipe-D-eDP-1-x
[373.476773] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[373.479030] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.067s)
[374.690923] [080/132] (647s left) gem_mmap_wc (write-gtt-read-wc)
[374.750721] Subtest write-gtt-read-wc: SKIP (0.000s)
[374.811930] [081/132] (647s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[374.921651] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[379.302472] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.384s)
[380.493353] [082/132] (642s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[380.624630] Starting subtest: 4-tiled-16bpp-rotate-180
[381.904674] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.280s)
[382.028288] [083/132] (640s left) i915_drm_fdinfo (memory-info-active)
[382.070573] Starting subtest: memory-info-active
[382.072615] Starting dynamic subtest: smem0
[384.665384] Dynamic subtest smem0: SUCCESS (2.595s)
[384.667695] Subtest memory-info-active: SUCCESS (2.596s)
[384.739719] [084/132] (637s left) kms_joiner (basic-force-big-joiner)
[384.839325] Starting subtest: basic-force-big-joiner
[384.842646] Subtest basic-force-big-joiner: SKIP (0.000s)
[384.907314] [085/132] (637s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[385.001640] Starting subtest: fbc-psr-sprite-mmap-gtt
[385.003600] Starting dynamic subtest: eDP-1
[385.007130] Dynamic subtest eDP-1: SKIP (0.000s)
[385.010369] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.002s)
[385.074151] [086/132] (637s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[385.199453] Starting subtest: basic-busy-flip-before-cursor-atomic
[385.203172] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[385.352627] [087/132] (637s left) prime_mmap (test_userptr)
[385.401830] Starting subtest: test_userptr
[385.403753] Starting dynamic subtest: test_userptr-smem
[385.405357] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[385.406971] Subtest test_userptr: SUCCESS (0.001s)
[385.504955] [088/132] (637s left) gem_eio (hibernate)
[385.751333] Starting subtest: hibernate
[401.371153] Subtest hibernate: SUCCESS (15.619s)
[411.540924] [089/132] (621s left) kms_cursor_crc (cursor-alpha-transparent)
[411.673417] Starting subtest: cursor-alpha-transparent
[411.675659] Starting dynamic subtest: pipe-A-eDP-1
[412.290372] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.614s)
[412.300830] Starting dynamic subtest: pipe-D-eDP-1
[413.570522] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s)
[413.572643] Subtest cursor-alpha-transparent: SUCCESS (1.896s)
[414.366336] [090/132] (618s left) kms_vblank (accuracy-idle)
[414.472951] Starting subtest: accuracy-idle
[414.474748] Starting dynamic subtest: pipe-A-eDP-1
[416.225535] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[416.240791] Starting dynamic subtest: pipe-D-eDP-1
[418.702878] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.475s)
[418.705105] Subtest accuracy-idle: SUCCESS (4.231s)
[419.544838] [091/132] (613s left) perf (non-zero-reason)
[419.683891] Starting subtest: non-zero-reason
[419.686135] Starting dynamic subtest: 0-rcs0
[425.096742] Dynamic subtest 0-rcs0: SUCCESS (5.412s)
[425.109845] Starting dynamic subtest: 1-vcs1
[429.022096] Dynamic subtest 1-vcs1: SUCCESS (3.924s)
[429.025041] Subtest non-zero-reason: SUCCESS (9.338s)
[429.071302] [092/132] (604s left) kms_content_protection (dp-mst-type-0-hdcp14)
[429.221673] Starting subtest: dp-mst-type-0-hdcp14
[429.226223] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[429.347872] [093/132] (603s left) gem_lmem_swapping (parallel-random-verify-ccs)
[429.393414] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[429.440072] [094/132] (603s left) kms_debugfs (display-on-read-all)
[429.536985] Starting subtest: display-on-read-all
[429.701571] Subtest display-on-read-all: SUCCESS (0.166s)
[429.821242] [095/132] (603s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[429.933367] Starting subtest: 2x-long-cursor-vs-flip-legacy
[429.937749] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[430.078153] [096/132] (603s left) kms_psr (psr2-basic)
[430.173691] Starting subtest: psr2-basic
[430.175697] Starting dynamic subtest: eDP-1
[431.794749] Dynamic subtest eDP-1: SUCCESS (1.619s)
[431.797059] Subtest psr2-basic: SUCCESS (1.620s)
[432.595542] [097/132] (600s left) syncobj_timeline (wait-delayed-signal)
[432.656735] Starting subtest: wait-delayed-signal
[432.758055] Subtest wait-delayed-signal: SUCCESS (0.102s)
[432.852025] [098/132] (600s left) perf (blocking)
[432.937588] Starting subtest: blocking
[432.939935] Starting dynamic subtest: 0-rcs0
[442.953380] Dynamic subtest 0-rcs0: SUCCESS (10.013s)
[442.965468] Starting dynamic subtest: 1-vcs1
[452.977727] Dynamic subtest 1-vcs1: SUCCESS (10.022s)
[452.980147] Subtest blocking: SUCCESS (20.039s)
[453.030352] [099/132] (580s left) gen9_exec_parse (allowed-single)
[453.094054] Subtest allowed-single: SKIP (0.000s)
[453.173456] [100/132] (580s left) kms_psr (fbc-pr-primary-page-flip)
[453.275069] Starting subtest: fbc-pr-primary-page-flip
[453.279522] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[453.351693] [101/132] (580s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[453.451883] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[453.454311] Starting dynamic subtest: pipe-A-eDP-1
[453.550495] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[453.563355] Starting dynamic subtest: pipe-B-eDP-1
[454.671434] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[454.675652] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.222s)
[455.859454] [102/132] (577s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[455.948510] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[455.952632] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[456.075944] [103/132] (577s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[456.170580] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[456.174658] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[456.277256] [104/132] (577s left) kms_frontbuffer_tracking (psr-slowdraw)
[456.376806] Starting subtest: psr-slowdraw
[481.595196] Subtest psr-slowdraw: SUCCESS (25.221s)
[481.710304] [105/132] (551s left) gem_exec_schedule (pi-shared-iova)
[481.896632] Starting subtest: pi-shared-iova
[481.898801] Starting dynamic subtest: rcs0
[481.985316] Dynamic subtest rcs0: SUCCESS (0.090s)
[481.999987] Starting dynamic subtest: vcs0
[482.052430] Dynamic subtest vcs0: SUCCESS (0.066s)
[482.065845] Starting dynamic subtest: vcs1
[482.110939] Dynamic subtest vcs1: SUCCESS (0.058s)
[482.124114] Starting dynamic subtest: vecs0
[482.176947] Dynamic subtest vecs0: SUCCESS (0.065s)
[482.191135] Starting dynamic subtest: ccs0
[482.253410] Dynamic subtest ccs0: SUCCESS (0.076s)
[482.256329] Subtest pi-shared-iova: SUCCESS (0.359s)
[484.034804] [106/132] (549s left) gem_tiled_pread_pwrite
[484.148948] [107/132] (549s left) kms_vblank (wait-busy)
[484.250021] Starting subtest: wait-busy
[484.252186] Starting dynamic subtest: pipe-A-eDP-1
[486.123907] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[486.145998] Starting dynamic subtest: pipe-D-eDP-1
[488.747852] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[488.750196] Subtest wait-busy: SUCCESS (4.500s)
[489.555649] [108/132] (544s left) gem_exec_schedule (semaphore-noskip)
[489.622534] Starting subtest: semaphore-noskip
[490.045084] Subtest semaphore-noskip: SUCCESS (0.429s)
[490.392604] [109/132] (543s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[490.505787] Starting subtest: flip-vs-cursor-varying-size
[499.533753] Subtest flip-vs-cursor-varying-size: SUCCESS (9.028s)
[500.409814] [110/132] (533s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[500.516213] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[500.518502] Starting dynamic subtest: pipe-A-eDP-1
[500.576377] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[500.587713] Starting dynamic subtest: pipe-B-eDP-1
[500.645345] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[500.657345] Starting dynamic subtest: pipe-C-eDP-1
[500.713898] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[500.724403] Starting dynamic subtest: pipe-D-eDP-1
[500.781250] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[500.785422] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[502.773607] [111/132] (531s left) gem_vm_create (create-ext)
[502.843329] Starting subtest: create-ext
[502.849441] Subtest create-ext: SUCCESS (0.005s)
[502.958253] [112/132] (531s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[503.015762] Starting subtest: yf-tiled-ccs-to-y-tiled
[503.019906] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[503.223416] [113/132] (530s left) gem_exec_parallel (engines)
[503.285473] Starting subtest: engines
[503.287676] Starting dynamic subtest: basic
[504.757970] Dynamic subtest basic: SUCCESS (1.475s)
[504.771534] Starting dynamic subtest: contexts
[509.377831] Dynamic subtest contexts: SUCCESS (4.616s)
[509.390566] Starting dynamic subtest: fds
[513.193274] Dynamic subtest fds: SUCCESS (3.814s)
[513.208977] Starting dynamic subtest: userptr
[514.859060] Dynamic subtest userptr: SUCCESS (1.664s)
[514.862037] Subtest engines: SUCCESS (11.575s)
[515.050498] [114/132] (519s left) kms_plane (plane-position-hole)
[515.150765] Starting subtest: plane-position-hole
[515.667948] Starting dynamic subtest: pipe-A-plane-1
[516.978609] Dynamic subtest pipe-A-plane-1: SUCCESS (1.312s)
[516.990408] Starting dynamic subtest: pipe-A-plane-2
[518.321522] Dynamic subtest pipe-A-plane-2: SUCCESS (1.344s)
[518.332569] Starting dynamic subtest: pipe-A-plane-3
[519.629364] Dynamic subtest pipe-A-plane-3: SUCCESS (1.304s)
[519.640526] Starting dynamic subtest: pipe-A-plane-4
[520.969643] Dynamic subtest pipe-A-plane-4: SUCCESS (1.342s)
[520.980830] Starting dynamic subtest: pipe-A-plane-5
[520.999596] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[522.219505] Starting dynamic subtest: pipe-B-plane-1
[523.534046] Dynamic subtest pipe-B-plane-1: SUCCESS (1.320s)
[523.544985] Starting dynamic subtest: pipe-B-plane-2
[524.865969] Dynamic subtest pipe-B-plane-2: SUCCESS (1.332s)
[524.877459] Starting dynamic subtest: pipe-B-plane-3
[526.211508] Dynamic subtest pipe-B-plane-3: SUCCESS (1.343s)
[526.222746] Starting dynamic subtest: pipe-B-plane-4
[527.550900] Dynamic subtest pipe-B-plane-4: SUCCESS (1.340s)
[527.562471] Starting dynamic subtest: pipe-B-plane-5
[527.581874] Dynamic subtest pipe-B-plane-5: SUCCESS (0.029s)
[527.584168] Subtest plane-position-hole: SUCCESS (12.431s)
[528.404172] [115/132] (505s left) kms_cursor_edge_walk (128x128-top-bottom)
[528.493237] Starting subtest: 128x128-top-bottom
[528.495559] Starting dynamic subtest: pipe-A-eDP-1
[531.965228] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[531.977827] Starting dynamic subtest: pipe-D-eDP-1
[535.076450] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.108s)
[535.078729] Subtest 128x128-top-bottom: SUCCESS (6.584s)
[535.895611] [116/132] (498s left) gem_exec_reloc (basic-cpu-noreloc)
[535.951814] Subtest basic-cpu-noreloc: SKIP (0.000s)
[536.025321] [117/132] (498s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[536.122557] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[536.126656] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[536.217955] [118/132] (498s left) gem_exec_params (rsvd2-dirt)
[536.273123] Starting subtest: rsvd2-dirt
[536.277670] Subtest rsvd2-dirt: SKIP (0.000s)
[536.372115] [119/132] (497s left) kms_color (ctm-signed)
[536.464820] Starting subtest: ctm-signed
[536.466715] Starting dynamic subtest: pipe-A-eDP-1
[539.368047] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.898s)
[539.380205] Starting dynamic subtest: pipe-B-eDP-1
[541.677125] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.310s)
[541.687605] Starting dynamic subtest: pipe-C-eDP-1
[544.387919] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.711s)
[544.400035] Starting dynamic subtest: pipe-D-eDP-1
[547.059887] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.671s)
[547.062282] Subtest ctm-signed: SUCCESS (10.596s)
[547.898538] [120/132] (486s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[547.960812] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[548.036044] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.017s)
[548.076982] [121/132] (486s left) core_setmaster (master-drop-set-user)
[548.169126] Starting subtest: master-drop-set-user
[548.183770] Subtest master-drop-set-user: SUCCESS (0.015s)
[548.224676] [122/132] (486s left) gem_exec_balancer (sliced)
[548.286571] Starting subtest: sliced
[548.291236] Subtest sliced: SKIP (0.000s)
[548.581826] [123/132] (485s left) perf (invalid-oa-exponent)
[548.685725] Starting subtest: invalid-oa-exponent
[548.698577] Subtest invalid-oa-exponent: SUCCESS (0.012s)
[548.746711] [124/132] (485s left) gem_mmap_gtt (basic-small-bo-tiledx)
[548.805815] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[548.862258] [125/132] (485s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[548.962503] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[548.964789] Starting dynamic subtest: pipe-A-eDP-1
[548.983790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[548.994273] Starting dynamic subtest: pipe-B-eDP-1
[549.013102] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[549.022881] Starting dynamic subtest: pipe-C-eDP-1
[549.041456] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[549.050991] Starting dynamic subtest: pipe-D-eDP-1
[549.070091] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[549.071912] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[551.261179] [126/132] (483s left) kms_chamelium_audio (dp-audio-edid)
[551.664316] Subtest dp-audio-edid: SKIP (0.000s)
[552.476307] [127/132] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[552.589880] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[552.594076] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[552.710578] [128/132] (481s left) kms_pm_backlight (brightness-with-dpms)
[552.811165] Starting subtest: brightness-with-dpms
[552.858861] Starting dynamic subtest: eDP-1
[555.300208] Dynamic subtest eDP-1: SUCCESS (2.440s)
[555.302516] Subtest brightness-with-dpms: SUCCESS (2.490s)
[556.154667] [129/132] (478s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[556.261217] Starting subtest: y-tiled-64bpp-rotate-180
[556.265834] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[556.367301] [130/132] (478s left) prime_self_import (export-vs-gem_close-race)
[556.406098] Starting subtest: export-vs-gem_close-race
[561.508080] Subtest export-vs-gem_close-race: SUCCESS (5.100s)
[561.587167] [131/132] (473s left) gem_exec_whisper (basic-fds-priority-all)
[561.672900] Starting subtest: basic-fds-priority-all
[584.947052] Subtest basic-fds-priority-all: SUCCESS (23.269s)
[585.137226] [132/132] (449s left) gem_mmap_offset (mmap-boundaries)
[585.191723] Starting subtest: mmap-boundaries
[585.193823] Starting dynamic subtest: smem0
[585.478988] Dynamic subtest smem0: SUCCESS (0.288s)
[585.481899] Subtest mmap-boundaries: SUCCESS (0.289s)
[585.597988] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_chamelium_edid
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: gem_pread
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_sync
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: gem_spin_batch
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_ctx_shared
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: syncobj_eventfd
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_plane_cursor
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_busy
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: i915_query
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: api_intel_bb
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: prime_mmap
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_ctx_isolation
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_draw_crc
results: parsing output: 56/ for test: gem_ctx_engines
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_plane_alpha_blend
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: gem_lmem_swapping
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: fbdev
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: gem_flink_basic
results: parsing output: 70/ for test: kms_properties
results: parsing output: 71/ for test: gem_pxp
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: gem_mmap_wc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: i915_drm_fdinfo
results: parsing output: 83/ for test: kms_joiner
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: prime_mmap
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_content_protection
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_debugfs
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_tiled_pread_pwrite
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_vm_create
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: gem_exec_parallel
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_cursor_edge_walk
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: kms_color
results: parsing output: 119/ for test: sriov_basic
results: parsing output: 120/ for test: core_setmaster
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_chamelium_audio
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_pm_backlight
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: prime_self_import
results: parsing output: 130/ for test: gem_exec_whisper
results: parsing output: 131/ for test: gem_mmap_offset
Done.