[56.557832] Initializing watchdogs
[56.557882]   /dev/watchdog0
[56.572265] [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]
[56.576813] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.578881] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.580680] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-128x42)
[56.798084] Starting subtest: cursor-offscreen-128x42
[56.842794] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[57.053256] [002/134] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[57.149786] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[58.165348] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.000s)
[58.303724] [003/134] (958s left) gem_exec_reloc (basic-write-gtt-active)
[58.361938] Subtest basic-write-gtt-active: SKIP (0.000s)
[58.441764] [004/134] (958s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[58.529505] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[58.530512] Starting dynamic subtest: pipe-A-eDP-1
[58.539757] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.546649] Starting dynamic subtest: pipe-B-eDP-1
[58.555562] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.561957] Starting dynamic subtest: pipe-C-eDP-1
[58.570817] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.576151] Starting dynamic subtest: pipe-D-eDP-1
[58.584847] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.586610] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.003s)
[60.705460] [005/134] (956s left) kms_psr (psr2-cursor-blt)
[60.796489] Starting subtest: psr2-cursor-blt
[60.797449] Starting dynamic subtest: eDP-1
[62.490065] Dynamic subtest eDP-1: SUCCESS (1.678s)
[62.490954] Subtest psr2-cursor-blt: SUCCESS (1.679s)
[63.289373] [006/134] (953s left) i915_query (engine-info-invalid)
[63.337425] Starting subtest: engine-info-invalid
[63.338553] Subtest engine-info-invalid: SUCCESS (0.000s)
[63.460117] [007/134] (953s left) core_hotunplug (unbind-rebind)
[63.546334] Starting subtest: unbind-rebind
[69.474039] Subtest unbind-rebind: SUCCESS (5.897s)
[69.502586] [008/134] (947s left) kms_psr (psr-primary-render)
[70.941119] Starting subtest: psr-primary-render
[70.942053] Starting dynamic subtest: eDP-1
[72.663087] Dynamic subtest eDP-1: SUCCESS (1.717s)
[72.664047] Subtest psr-primary-render: SUCCESS (1.717s)
[73.535596] [009/134] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[73.643808] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[73.645979] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[73.761297] [010/134] (943s left) sysfs_timeslice_duration (idempotent)
[73.814584] Starting subtest: idempotent
[73.815755] Starting dynamic subtest: vecs0
[73.816789] Dynamic subtest vecs0: SUCCESS (0.000s)
[73.823736] Starting dynamic subtest: ccs0
[73.824733] Dynamic subtest ccs0: SUCCESS (0.000s)
[73.830703] Starting dynamic subtest: vcs0
[73.831640] Dynamic subtest vcs0: SUCCESS (0.000s)
[73.837586] Starting dynamic subtest: bcs0
[73.838572] Dynamic subtest bcs0: SUCCESS (0.000s)
[73.844411] Starting dynamic subtest: rcs0
[73.845369] Dynamic subtest rcs0: SUCCESS (0.000s)
[73.851270] Starting dynamic subtest: vcs1
[73.852180] Dynamic subtest vcs1: SUCCESS (0.000s)
[73.853079] Subtest idempotent: SUCCESS (0.004s)
[73.951055] [011/134] (943s left) gem_gpgpu_fill (offset-16x16)
[74.004764] Starting subtest: offset-16x16
[74.011884] Subtest offset-16x16: SUCCESS (0.007s)
[74.159085] [012/134] (943s left) gem_readwrite (read-bad-handle)
[74.211849] Subtest read-bad-handle: SKIP (0.000s)
[74.268682] [013/134] (943s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[74.352408] Starting subtest: 2x-flip-vs-modeset-vs-hang
[74.362843] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[74.478877] [014/134] (942s left) gem_mmap_gtt (fault-concurrent)
[74.524910] Subtest fault-concurrent: SKIP (0.000s)
[74.581006] [015/134] (942s left) syncobj_timeline (invalid-signal-bad-pad)
[74.618358] Starting subtest: invalid-signal-bad-pad
[74.619526] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[74.728713] [016/134] (942s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[74.771376] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[74.833063] [017/134] (942s left) kms_chamelium_color (ctm-green-to-red)
[74.920589] Subtest ctm-green-to-red: SKIP (0.000s)
[74.956757] [018/134] (942s left) perf_pmu (multi-client)
[74.992107] Starting subtest: multi-client
[74.993090] Starting dynamic subtest: rcs0
[76.043634] Dynamic subtest rcs0: SUCCESS (1.049s)
[76.052029] Starting dynamic subtest: bcs0
[77.096862] Dynamic subtest bcs0: SUCCESS (1.049s)
[77.106061] Starting dynamic subtest: vcs0
[78.150388] Dynamic subtest vcs0: SUCCESS (1.050s)
[78.158968] Starting dynamic subtest: vcs1
[79.953939] Dynamic subtest vcs1: SUCCESS (1.801s)
[79.962662] Starting dynamic subtest: vecs0
[81.933962] Dynamic subtest vecs0: SUCCESS (1.978s)
[81.942548] Starting dynamic subtest: ccs0
[83.919463] Dynamic subtest ccs0: SUCCESS (1.983s)
[83.920716] Subtest multi-client: SUCCESS (8.917s)
[84.074832] [019/134] (933s left) gem_reg_read (timestamp-monotonic)
[84.125149] Starting subtest: timestamp-monotonic
[88.751673] Subtest timestamp-monotonic: SUCCESS (4.621s)
[88.824046] [020/134] (928s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[88.922280] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[88.923983] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[89.044411] [021/134] (928s left) kms_atomic (atomic-invalid-params)
[89.137203] Starting subtest: atomic-invalid-params
[89.138029] Starting dynamic subtest: pipe-A-eDP-1
[89.516812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.379s)
[89.517887] Subtest atomic-invalid-params: SUCCESS (0.380s)
[90.389000] [022/134] (927s left) gem_userptr_blits (userfault)
[90.451800] Starting subtest: userfault
[90.456085] Subtest userfault: SUCCESS (0.006s)
[90.630013] [023/134] (927s left) prime_mmap (test_forked_cpu_write)
[90.674142] Starting subtest: test_forked_cpu_write
[90.675096] Starting dynamic subtest: test_forked_cpu_write-smem
[90.680619] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[90.681791] Subtest test_forked_cpu_write: SUCCESS (0.007s)
[90.785837] [024/134] (926s left) gem_flink_basic (basic)
[90.833588] Starting subtest: basic
[90.834630] Subtest basic: SUCCESS (0.000s)
[90.933132] [025/134] (926s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[91.027267] Starting subtest: fbcpsr-rgb565-draw-pwrite
[97.977302] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.948s)
[98.119772] [026/134] (919s left) kms_psr (fbc-psr2-suspend)
[98.205118] Starting subtest: fbc-psr2-suspend
[98.206039] Starting dynamic subtest: eDP-1
[98.207824] Dynamic subtest eDP-1: SKIP (0.000s)
[98.209571] Subtest fbc-psr2-suspend: SKIP (0.001s)
[98.294092] [027/134] (919s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[98.552985] Starting subtest: parallel-dmabuf-import-out-fence
[99.597876] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.044s)
[99.696310] [028/134] (918s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[99.783801] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[107.156517] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.371s)
[107.298407] [029/134] (910s left) kms_setmode (clone-exclusive-crtc)
[107.339301] Starting subtest: clone-exclusive-crtc
[107.342104] Subtest clone-exclusive-crtc: SKIP (0.000s)
[107.474345] [030/134] (910s left) kms_vrr (flip-basic)
[107.570711] Starting subtest: flip-basic
[107.573256] Subtest flip-basic: SKIP (0.000s)
[107.650995] [031/134] (910s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[107.734866] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[107.735865] Starting dynamic subtest: pipe-A-default-mode
[108.027810] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[108.029553] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.294s)
[108.865766] [032/134] (909s left) gem_mmap (bad-offset)
[108.917302] Subtest bad-offset: SKIP (0.000s)
[108.973249] [033/134] (909s left) syncobj_basic (bad-destroy)
[109.023596] Starting subtest: bad-destroy
[109.024599] Subtest bad-destroy: SUCCESS (0.000s)
[109.124684] [034/134] (908s left) api_intel_allocator (simple-allocator)
[109.165595] Starting subtest: simple-allocator
[109.166579] Starting dynamic subtest: basic
[109.168036] Dynamic subtest basic: SUCCESS (0.004s)
[109.176444] Starting dynamic subtest: parallel-one
[109.341906] Dynamic subtest parallel-one: SUCCESS (0.173s)
[109.351459] Starting dynamic subtest: print
[109.352357] Dynamic subtest print: SUCCESS (0.000s)
[109.359352] Starting dynamic subtest: reuse
[109.360146] Dynamic subtest reuse: SUCCESS (0.000s)
[109.366195] Starting dynamic subtest: reserve
[109.367105] Dynamic subtest reserve: SUCCESS (0.000s)
[109.373333] Starting dynamic subtest: fork-reopen-allocator
[109.374128] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[109.374938] Subtest simple-allocator: SUCCESS (0.192s)
[109.492407] [035/134] (908s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[109.587247] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[109.588135] Starting dynamic subtest: pipe-A-default-mode
[109.873893] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[109.875961] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.285s)
[110.694683] [036/134] (907s left) syncobj_eventfd (invalid-illegal-handle)
[110.755369] Starting subtest: invalid-illegal-handle
[110.756453] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[110.854493] [037/134] (907s left) kms_cursor_edge_walk (64x64-top-edge)
[110.945048] Starting subtest: 64x64-top-edge
[110.946809] Starting dynamic subtest: pipe-A-eDP-1
[114.372995] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[114.380066] Starting dynamic subtest: pipe-D-eDP-1
[117.490357] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[117.491418] Subtest 64x64-top-edge: SUCCESS (6.544s)
[118.299219] [038/134] (899s left) gem_exec_reloc (basic-wc-cpu)
[118.351209] Subtest basic-wc-cpu: SKIP (0.000s)
[118.432333] [039/134] (899s left) kms_colorop (plane-xr30-xr30-srgb_eotf)
[118.547453] Subtest plane-XR30-XR30-srgb_eotf: SKIP (0.000s)
[118.637542] [040/134] (899s left) gem_userptr_blits (stress-mm-invalidate-close)
[118.700525] Starting subtest: stress-mm-invalidate-close
[120.850755] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[121.001269] [041/134] (897s left) gem_partial_pwrite_pread (reads-uncached)
[121.050503] Subtest reads-uncached: SKIP (0.000s)
[121.121005] [042/134] (897s left) kms_flip (flip-vs-expired-vblank-interruptible)
[121.218893] Starting subtest: flip-vs-expired-vblank-interruptible
[121.220998] Starting dynamic subtest: A-eDP1
[129.904075] Dynamic subtest A-eDP1: SUCCESS (8.681s)
[129.913045] Starting dynamic subtest: B-eDP1
[138.537193] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[138.546307] Starting dynamic subtest: C-eDP1
[147.162483] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[147.169616] Starting dynamic subtest: D-eDP1
[155.799814] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[155.802701] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.580s)
[156.961347] [043/134] (861s left) api_intel_bb (object-noreloc-keep-cache-simple)
[157.015424] Starting subtest: object-noreloc-keep-cache-simple
[157.021322] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[157.172331] [044/134] (861s left) kms_colorop (plane-xr24-xr24-gamma_2_2_inv_oetf)
[157.300102] Subtest plane-XR24-XR24-gamma_2_2_inv_oetf: SKIP (0.000s)
[157.386719] [045/134] (861s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[157.476408] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[157.478173] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[157.605482] [046/134] (860s left) perf (polling)
[157.730966] Starting subtest: polling
[157.731830] Starting dynamic subtest: 0-rcs0
[167.769125] Dynamic subtest 0-rcs0: SUCCESS (10.037s)
[167.776319] Starting dynamic subtest: 1-vcs1
[177.791363] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[177.792500] Subtest polling: SUCCESS (20.059s)
[177.830553] [047/134] (840s left) syncobj_wait (wait-all-snapshot)
[177.882915] Starting subtest: wait-all-snapshot
[177.964980] Subtest wait-all-snapshot: SUCCESS (0.081s)
[178.047848] [048/134] (840s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[178.142969] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[178.143788] Starting dynamic subtest: pipe-A-eDP-1
[178.165104] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[178.171963] Starting dynamic subtest: pipe-B-eDP-1
[178.193159] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[178.199544] Starting dynamic subtest: pipe-C-eDP-1
[178.220488] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[178.226786] Starting dynamic subtest: pipe-D-eDP-1
[178.248199] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[178.249848] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[180.338285] [049/134] (838s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[180.426127] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[180.428406] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[180.568490] [050/134] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[180.657634] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[187.357836] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.700s)
[187.520409] [051/134] (831s left) gem_mmap_offset (partial-remap)
[187.569640] Starting subtest: partial-remap
[187.570534] Starting dynamic subtest: smem0
[187.575065] Dynamic subtest smem0: SUCCESS (0.004s)
[187.575872] Subtest partial-remap: SUCCESS (0.005s)
[187.706881] [052/134] (830s left) kms_cursor_crc (cursor-random-128x128)
[187.893234] Starting subtest: cursor-random-128x128
[187.896477] Starting dynamic subtest: pipe-A-eDP-1
[191.225300] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.330s)
[191.252506] Starting dynamic subtest: pipe-D-eDP-1
[195.213729] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.967s)
[195.214694] Subtest cursor-random-128x128: SUCCESS (7.320s)
[196.107167] [053/134] (822s left) gem_render_copy_redux (interruptible)
[196.169958] Starting subtest: interruptible
[196.418372] Subtest interruptible: SUCCESS (0.248s)
[196.528435] [054/134] (822s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[196.625527] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[196.627191] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[196.762579] [055/134] (821s left) dumb_buffer (map-uaf)
[196.813777] Starting subtest: map-uaf
[196.817434] Subtest map-uaf: SUCCESS (0.005s)
[196.934445] [056/134] (821s left) kms_flip (2x-flip-vs-panning)
[197.022515] Starting subtest: 2x-flip-vs-panning
[197.034066] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[197.129386] [057/134] (821s left) perf (create-destroy-userspace-config)
[197.225131] Starting subtest: create-destroy-userspace-config
[197.239367] Subtest create-destroy-userspace-config: SUCCESS (0.014s)
[197.268531] [058/134] (821s left) gem_ctx_persistence (heartbeat-hang)
[197.317230] Starting subtest: heartbeat-hang
[197.319220] Subtest heartbeat-hang: SKIP (0.000s)
[197.443179] [059/134] (821s left) kms_dsc (dsc-with-output-formats)
[197.534266] Starting subtest: dsc-with-output-formats
[197.542471] Subtest dsc-with-output-formats: SKIP (0.001s)
[197.610590] [060/134] (821s left) i915_pm_rps (engine-order)
[197.661226] Starting subtest: engine-order
[203.845886] Subtest engine-order: SUCCESS (6.184s)
[203.992851] [061/134] (814s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[204.033785] Starting subtest: multi-wait-for-submit-submitted-signaled
[204.034648] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[204.152030] [062/134] (814s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[204.231049] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[204.231905] Starting dynamic subtest: pipe-A
[204.339798] Dynamic subtest pipe-A: SKIP (0.106s)
[204.347498] Starting dynamic subtest: pipe-B
[205.544900] Dynamic subtest pipe-B: SKIP (1.205s)
[205.552057] Starting dynamic subtest: pipe-C
[206.693987] Dynamic subtest pipe-C: SUCCESS (1.151s)
[206.701744] Starting dynamic subtest: pipe-D
[207.845555] Dynamic subtest pipe-D: SUCCESS (1.151s)
[207.846453] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.615s)
[209.059372] [063/134] (809s left) syncobj_wait (wait-all-interrupted)
[209.106715] Starting subtest: wait-all-interrupted
[209.210038] Subtest wait-all-interrupted: SUCCESS (0.103s)
[209.290156] [064/134] (809s left) gem_exec_schedule (u-submit-early-slice)
[209.346280] Starting subtest: u-submit-early-slice
[209.347233] Starting dynamic subtest: rcs0
[209.389198] Dynamic subtest rcs0: SUCCESS (0.043s)
[209.397633] Starting dynamic subtest: bcs0
[209.428868] Dynamic subtest bcs0: SUCCESS (0.039s)
[209.436346] Starting dynamic subtest: vcs0
[209.475692] Dynamic subtest vcs0: SUCCESS (0.046s)
[209.486708] Starting dynamic subtest: vcs1
[209.511107] Dynamic subtest vcs1: SUCCESS (0.034s)
[209.520483] Starting dynamic subtest: vecs0
[209.539915] Dynamic subtest vecs0: SUCCESS (0.028s)
[209.546952] Starting dynamic subtest: ccs0
[209.579514] Dynamic subtest ccs0: SUCCESS (0.039s)
[209.580652] Subtest u-submit-early-slice: SUCCESS (0.233s)
[210.990253] [065/134] (808s left) kms_cursor_crc (cursor-sliding-32x32)
[211.121528] Starting subtest: cursor-sliding-32x32
[211.161063] Subtest cursor-sliding-32x32: SKIP (0.038s)
[211.454996] [066/134] (807s left) gem_exec_parallel (fds)
[211.520864] Starting subtest: fds
[211.521906] Starting dynamic subtest: rcs0
[214.289361] Dynamic subtest rcs0: SUCCESS (2.767s)
[214.299945] Starting dynamic subtest: bcs0
[217.569808] Dynamic subtest bcs0: SUCCESS (3.280s)
[217.577768] Starting dynamic subtest: vcs0
[221.225534] Dynamic subtest vcs0: SUCCESS (3.653s)
[221.235533] Starting dynamic subtest: vcs1
[225.236346] Dynamic subtest vcs1: SUCCESS (4.008s)
[225.244077] Starting dynamic subtest: vecs0
[229.161743] Dynamic subtest vecs0: SUCCESS (3.924s)
[229.171483] Starting dynamic subtest: ccs0
[232.511365] Dynamic subtest ccs0: SUCCESS (3.347s)
[232.512697] Subtest fds: SUCCESS (20.990s)
[232.706410] [067/134] (786s left) kms_sequence (queue-busy)
[232.793454] Starting subtest: queue-busy
[232.794348] Starting dynamic subtest: pipe-A-eDP-1
[234.721859] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.928s)
[234.729217] Starting dynamic subtest: pipe-B-eDP-1
[237.318893] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.595s)
[237.326220] Starting dynamic subtest: pipe-C-eDP-1
[239.940215] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s)
[239.947606] Starting dynamic subtest: pipe-D-eDP-1
[242.477059] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s)
[242.478081] Subtest queue-busy: SUCCESS (9.683s)
[243.361984] [068/134] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[243.451860] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[243.453743] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[243.586135] [069/134] (775s left) kms_big_fb (y-tiled-addfb-size-overflow)
[243.685925] Starting subtest: y-tiled-addfb-size-overflow
[243.687936] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[243.812862] [070/134] (775s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[243.903393] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[243.905220] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[244.039602] [071/134] (775s left) kms_colorop (plane-xr24-xr24-ctm_3x4_overdrive)
[244.172521] Subtest plane-XR24-XR24-ctm_3x4_overdrive: SKIP (0.000s)
[244.258388] [072/134] (774s left) gem_eio (in-flight-immediate)
[244.493979] Starting subtest: in-flight-immediate
[253.029443] Subtest in-flight-immediate: SUCCESS (8.534s)
[253.214867] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[253.216700] [073/134] (766s left) i915_drm_fdinfo (virtual-busy-idle-all)
[253.248302] Starting subtest: virtual-busy-idle-all
[253.250789] Subtest virtual-busy-idle-all: SKIP (0.000s)
[253.335811] [074/134] (765s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[253.432672] Starting subtest: x-tiled-8bpp-rotate-180
[254.524126] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.092s)
[254.698899] [075/134] (764s left) gen3_render_mixed_blits
[254.819679] [076/134] (764s left) kms_invalid_mode (overflow-vrefresh)
[254.898543] Starting subtest: overflow-vrefresh
[254.899586] Starting dynamic subtest: pipe-A-eDP-1
[255.182075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[255.191510] Starting dynamic subtest: pipe-B-eDP-1
[255.192375] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[255.199602] Starting dynamic subtest: pipe-C-eDP-1
[255.200496] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[255.207677] Starting dynamic subtest: pipe-D-eDP-1
[255.208544] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[255.209398] Subtest overflow-vrefresh: SUCCESS (0.290s)
[256.013758] [077/134] (763s left) gem_softpin (allocator-nopin-reserve)
[256.065454] Starting subtest: allocator-nopin-reserve
[256.178797] Subtest allocator-nopin-reserve: SUCCESS (0.111s)
[256.310939] [078/134] (763s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[256.400409] Starting subtest: plane-downscale-factor-0-5-with-rotation
[256.401372] Starting dynamic subtest: pipe-A
[256.416687] Dynamic subtest pipe-A: SKIP (0.015s)
[256.424653] Starting dynamic subtest: pipe-B
[256.443300] Dynamic subtest pipe-B: SKIP (0.026s)
[256.450923] Starting dynamic subtest: pipe-C
[256.470421] Dynamic subtest pipe-C: SKIP (0.027s)
[256.477819] Starting dynamic subtest: pipe-D
[256.498867] Dynamic subtest pipe-D: SKIP (0.028s)
[256.500522] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.098s)
[256.621258] [079/134] (762s left) gem_exec_params (invalid-fence-in-submit)
[256.677195] Starting subtest: invalid-fence-in-submit
[256.681375] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[256.827383] [080/134] (762s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[261.902315] Starting subtest: pr-overlay-plane-update-continuous-sf
[261.906235] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[262.737139] [081/134] (756s left) kms_flip (2x-plain-flip-interruptible)
[262.838612] Starting subtest: 2x-plain-flip-interruptible
[262.849642] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[262.987195] [082/134] (756s left) kms_async_flips (async-flip-dpms)
[263.082259] Starting subtest: async-flip-dpms
[263.452065] Starting dynamic subtest: pipe-A-eDP-1
[264.386899] Dynamic subtest pipe-A-eDP-1: FAIL (0.761s)
[264.596466] Starting dynamic subtest: pipe-B-eDP-1
[265.436720] Dynamic subtest pipe-B-eDP-1: FAIL (0.751s)
[265.718175] Starting dynamic subtest: pipe-C-eDP-1
[269.519458] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.808s)
[269.893387] Starting dynamic subtest: pipe-D-eDP-1
[272.685074] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.798s)
[272.686044] Subtest async-flip-dpms: FAIL (9.604s)
[273.903121] [083/134] (745s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[273.947697] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[274.050974] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[274.142022] [084/134] (745s left) kms_big_fb (linear-32bpp-rotate-270)
[274.244585] Starting subtest: linear-32bpp-rotate-270
[274.264380] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[274.434903] [085/134] (745s left) gem_exec_reloc (basic-write-read-active)
[274.493724] Subtest basic-write-read-active: SKIP (0.000s)
[274.570197] [086/134] (745s left) gem_exec_schedule (preempt-queue-contexts-chain)
[274.634172] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[274.934319] [087/134] (744s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[275.030056] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[275.032034] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[275.144260] [088/134] (744s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[275.234922] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[275.236574] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[275.359809] [089/134] (744s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[275.455893] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[275.457597] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[275.589809] [090/134] (744s left) kms_setmode (invalid-clone-single-crtc-stealing)
[275.641312] Starting subtest: invalid-clone-single-crtc-stealing
[275.644064] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[275.770259] [091/134] (744s left) kms_getfb (getfb2-handle-not-fb)
[275.862315] Starting subtest: getfb2-handle-not-fb
[275.863237] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[275.984887] [092/134] (743s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[276.074396] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[276.086042] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[276.223646] [093/134] (743s left) kms_chamelium_frames (hdmi-crc-fast)
[276.592291] Subtest hdmi-crc-fast: SKIP (0.000s)
[277.378274] [094/134] (742s left) kms_psr (fbc-psr2-cursor-blt)
[277.466075] Starting subtest: fbc-psr2-cursor-blt
[277.467016] Starting dynamic subtest: eDP-1
[277.468704] Dynamic subtest eDP-1: SKIP (0.000s)
[277.470483] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[277.555787] [095/134] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[277.647882] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[277.649663] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[277.771894] [096/134] (742s left) kms_draw_crc (draw-method-blt)
[277.860581] Starting subtest: draw-method-blt
[277.861569] Starting dynamic subtest: xrgb8888-untiled
[278.093518] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[278.102242] Starting dynamic subtest: rgb565-untiled
[278.316235] Dynamic subtest rgb565-untiled: SUCCESS (0.220s)
[278.324053] Starting dynamic subtest: xrgb2101010-untiled
[278.515862] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[278.525548] Starting dynamic subtest: xbgr16161616f-untiled
[278.726953] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[278.735317] Starting dynamic subtest: xrgb8888-xtiled
[278.838114] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[278.846468] Starting dynamic subtest: rgb565-xtiled
[278.960953] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[278.970860] Starting dynamic subtest: xrgb2101010-xtiled
[279.071270] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[279.079100] Starting dynamic subtest: xbgr16161616f-xtiled
[279.171383] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[279.178930] Starting dynamic subtest: xrgb8888-4tiled
[279.282501] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[279.289952] Starting dynamic subtest: rgb565-4tiled
[279.382478] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[279.390232] Starting dynamic subtest: xrgb2101010-4tiled
[279.471498] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.088s)
[279.481591] Starting dynamic subtest: xbgr16161616f-4tiled
[279.571487] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.098s)
[279.573843] Subtest draw-method-blt: SUCCESS (1.713s)
[279.730141] [097/134] (740s left) kms_psr (fbc-pr-cursor-blt)
[279.813101] Starting subtest: fbc-pr-cursor-blt
[279.814932] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[279.906880] [098/134] (740s left) sw_sync (sync_multi_timeline_wait)
[279.935410] Starting subtest: sync_multi_timeline_wait
[279.936447] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[280.014029] [099/134] (740s left) gem_create (create-ext-placement-sanity-check)
[280.178631] Starting subtest: create-ext-placement-sanity-check
[280.183409] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[280.307857] [100/134] (739s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[280.367173] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[280.368173] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[280.504045] [101/134] (739s left) gem_exec_fence (syncobj-channel)
[280.914215] Starting subtest: syncobj-channel
[281.933774] Subtest syncobj-channel: SUCCESS (1.017s)
[282.247421] [102/134] (737s left) syncobj_basic (bad-pad-fd-to-handle)
[282.301053] Starting subtest: bad-pad-fd-to-handle
[282.301976] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[282.440074] [103/134] (737s left) gem_eio (kms)
[282.709545] Starting subtest: kms
[303.319242] Subtest kms: SUCCESS (20.607s)
[304.513072] [104/134] (715s left) kms_plane_cursor (viewport)
[304.607345] Starting subtest: viewport
[304.611391] Starting dynamic subtest: pipe-A-eDP-1-size-64
[307.329937] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.723s)
[307.392031] Starting dynamic subtest: pipe-A-eDP-1-size-128
[310.164644] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.781s)
[310.227415] Starting dynamic subtest: pipe-A-eDP-1-size-256
[313.010683] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.793s)
[313.360941] Starting dynamic subtest: pipe-B-eDP-1-size-64
[316.786426] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.436s)
[316.848059] Starting dynamic subtest: pipe-B-eDP-1-size-128
[319.588022] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.748s)
[319.649409] Starting dynamic subtest: pipe-B-eDP-1-size-256
[322.366943] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.726s)
[322.713964] Starting dynamic subtest: pipe-C-eDP-1-size-64
[325.862274] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.156s)
[325.907542] Starting dynamic subtest: pipe-C-eDP-1-size-128
[328.284604] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.390s)
[328.323102] Starting dynamic subtest: pipe-C-eDP-1-size-256
[330.684776] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.369s)
[331.007907] Starting dynamic subtest: pipe-D-eDP-1-size-64
[334.091157] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.091s)
[334.129909] Starting dynamic subtest: pipe-D-eDP-1-size-128
[336.524684] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.402s)
[336.563056] Starting dynamic subtest: pipe-D-eDP-1-size-256
[338.924534] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.369s)
[339.243236] Subtest viewport: SUCCESS (34.633s)
[340.057318] [105/134] (680s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[340.115044] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[340.115967] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[340.248236] [106/134] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[340.349036] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[340.350784] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[340.472836] [107/134] (679s left) kms_lease (master-vs-lease)
[340.563358] Starting subtest: master-vs-lease
[340.564284] Subtest master-vs-lease: SUCCESS (0.002s)
[340.695946] [108/134] (679s left) gem_ctx_isolation (preservation)
[340.753215] Starting subtest: preservation
[340.754273] Starting dynamic subtest: rcs0
[340.900565] Dynamic subtest rcs0: SUCCESS (0.147s)
[340.909540] Starting dynamic subtest: bcs0
[341.062247] Dynamic subtest bcs0: SUCCESS (0.161s)
[341.070887] Starting dynamic subtest: vcs0
[341.231779] Dynamic subtest vcs0: SUCCESS (0.169s)
[341.241115] Starting dynamic subtest: vcs1
[343.048956] Dynamic subtest vcs1: SUCCESS (1.816s)
[343.060013] Starting dynamic subtest: vecs0
[345.059452] Dynamic subtest vecs0: SUCCESS (2.009s)
[345.073466] Starting dynamic subtest: ccs0
[347.054920] Dynamic subtest ccs0: SUCCESS (1.993s)
[347.056660] Subtest preservation: SUCCESS (6.301s)
[347.310220] [109/134] (673s left) gem_ringfill (basic-all)
[352.923171] Starting subtest: basic-all
[354.079408] Subtest basic-all: SUCCESS (1.155s)
[354.218550] [110/134] (666s left) gem_exec_schedule (pi-distinct-iova)
[354.390956] Starting subtest: pi-distinct-iova
[354.392353] Starting dynamic subtest: rcs0
[354.542988] Dynamic subtest rcs0: SUCCESS (0.152s)
[354.558501] Starting dynamic subtest: vcs0
[354.628604] Dynamic subtest vcs0: SUCCESS (0.086s)
[354.640626] Starting dynamic subtest: vcs1
[354.713787] Dynamic subtest vcs1: SUCCESS (0.082s)
[354.725906] Starting dynamic subtest: vecs0
[354.803332] Dynamic subtest vecs0: SUCCESS (0.087s)
[354.816864] Starting dynamic subtest: ccs0
[354.920801] Dynamic subtest ccs0: SUCCESS (0.114s)
[354.921907] Subtest pi-distinct-iova: SUCCESS (0.531s)
[356.028392] [111/134] (664s left) syncobj_timeline (wait-all-delayed-signal)
[356.070471] Starting subtest: wait-all-delayed-signal
[356.176098] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[356.271904] [112/134] (664s left) gen9_exec_parse (bb-chained)
[356.327176] Subtest bb-chained: SKIP (0.000s)
[356.408839] [113/134] (664s left) kms_psr (pr-sprite-mmap-gtt)
[356.500124] Starting subtest: pr-sprite-mmap-gtt
[356.501940] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[356.593285] [114/134] (664s left) gem_eio (in-flight-internal-immediate)
[356.820222] Starting subtest: in-flight-internal-immediate
[357.982982] Subtest in-flight-internal-immediate: SUCCESS (1.162s)
[358.101287] [115/134] (662s left) kms_vblank (query-idle-hang)
[358.192581] Starting subtest: query-idle-hang
[358.193551] Starting dynamic subtest: pipe-A-eDP-1
[359.982230] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.789s)
[359.991545] Starting dynamic subtest: pipe-D-eDP-1
[362.528705] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[362.529592] Subtest query-idle-hang: SUCCESS (4.338s)
[363.409328] [116/134] (657s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[368.387383] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[368.390471] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[369.227755] [117/134] (651s left) kms_frontbuffer_tracking (fbc-1p-rte)
[369.329672] Starting subtest: fbc-1p-rte
[374.843429] Subtest fbc-1p-rte: SUCCESS (5.514s)
[376.053751] [118/134] (644s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[376.141326] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[376.142344] Starting dynamic subtest: pipe-A-eDP-1
[376.151354] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[376.160563] Starting dynamic subtest: pipe-B-eDP-1
[376.168877] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[376.177047] Starting dynamic subtest: pipe-C-eDP-1
[376.185088] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[376.192421] Starting dynamic subtest: pipe-D-eDP-1
[376.200683] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[376.202312] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[378.399258] [119/134] (642s left) prime_mmap (test_userptr)
[378.449629] Starting subtest: test_userptr
[378.450746] Starting dynamic subtest: test_userptr-smem
[378.451819] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[378.452808] Subtest test_userptr: SUCCESS (0.002s)
[378.547390] [120/134] (642s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[378.651411] Starting subtest: 4-tiled-32bpp-rotate-180
[379.985608] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.335s)
[380.136759] [121/134] (640s left) gem_exec_balancer (bonded-chain)
[380.194843] Starting subtest: bonded-chain
[387.170639] Subtest bonded-chain: SUCCESS (6.976s)
[387.526580] [122/134] (633s left) kms_color (ctm-blue-to-red)
[387.618387] Starting subtest: ctm-blue-to-red
[387.619375] Starting dynamic subtest: pipe-A-eDP-1
[388.293467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s)
[388.301070] Starting dynamic subtest: pipe-B-eDP-1
[389.654040] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.361s)
[389.662049] Starting dynamic subtest: pipe-C-eDP-1
[390.923810] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.269s)
[390.931868] Starting dynamic subtest: pipe-D-eDP-1
[392.320594] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s)
[392.321686] Subtest ctm-blue-to-red: SUCCESS (4.703s)
[393.159978] [123/134] (627s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[393.256179] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[393.257045] Starting dynamic subtest: pipe-A-eDP-1
[393.679734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[393.690519] Starting dynamic subtest: pipe-B-eDP-1
[393.698768] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[393.707759] Starting dynamic subtest: pipe-C-eDP-1
[393.715374] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[393.723110] Starting dynamic subtest: pipe-D-eDP-1
[393.730585] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[393.731416] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.438s)
[395.971560] [124/134] (625s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[396.060963] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[403.022926] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.962s)
[403.153866] [125/134] (617s left) gem_exec_gttfill (basic)
[403.220151] Starting subtest: basic
[405.970944] Subtest basic: SUCCESS (2.750s)
[406.168583] [126/134] (614s left) perf_pmu (enable-race)
[406.239638] Starting subtest: enable-race
[406.240772] Starting dynamic subtest: rcs0
[419.017561] Dynamic subtest rcs0: SUCCESS (12.776s)
[419.028091] Starting dynamic subtest: bcs0
[431.760384] Dynamic subtest bcs0: SUCCESS (12.739s)
[431.770397] Starting dynamic subtest: vcs0
[446.934325] Dynamic subtest vcs0: SUCCESS (15.168s)
[446.945599] Starting dynamic subtest: vcs1
[462.935258] Dynamic subtest vcs1: SUCCESS (15.996s)
[462.944425] Starting dynamic subtest: vecs0
[478.934895] Dynamic subtest vecs0: SUCCESS (15.996s)
[478.945243] Starting dynamic subtest: ccs0
[491.702797] Dynamic subtest ccs0: SUCCESS (12.767s)
[491.704124] Subtest enable-race: SUCCESS (85.458s)
[491.819336] [127/134] (529s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[491.921028] Starting subtest: psr-rgb565-draw-mmap-gtt
[491.922897] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[492.058111] [128/134] (529s left) kms_addfb_basic (too-high)
[492.144433] Starting subtest: too-high
[492.145408] Subtest too-high: SUCCESS (0.000s)
[492.265096] [129/134] (528s left) kms_pm_rpm (fences)
[494.096526] Starting subtest: fences
[494.099575] Subtest fences: SKIP (0.000s)
[494.531594] [130/134] (526s left) gem_mmap (pf-nonblock)
[494.596950] Subtest pf-nonblock: SKIP (0.000s)
[494.657417] [131/134] (526s left) i915_drm_fdinfo (memory-info-idle)
[494.690820] Starting subtest: memory-info-idle
[494.691786] Starting dynamic subtest: smem0
[494.765551] Dynamic subtest smem0: SUCCESS (0.074s)
[494.766581] Subtest memory-info-idle: SUCCESS (0.075s)
[494.845423] [132/134] (526s left) gem_pxp (hw-rejects-pxp-buffer)
[494.962543] Starting subtest: hw-rejects-pxp-buffer
[494.964991] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[495.076958] [133/134] (526s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[495.160136] Starting subtest: fbc-rgb101010-draw-mmap-wc
[499.729942] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.569s)
[500.940219] [134/134] (520s left) kms_pm_backlight (fade-with-dpms)
[501.031395] Starting subtest: fade-with-dpms
[503.377154] Starting dynamic subtest: eDP-1
[506.069452] Dynamic subtest eDP-1: SUCCESS (2.692s)
[506.072301] Subtest fade-with-dpms: SUCCESS (5.040s)
[506.869658] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: i915_query
results: parsing output: 6/ for test: core_hotunplug
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: sysfs_timeslice_duration
results: parsing output: 10/ for test: gem_gpgpu_fill
results: parsing output: 11/ for test: gem_readwrite
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_pipe_b_c_ivb
results: parsing output: 16/ for test: kms_chamelium_color
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: gem_reg_read
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_atomic
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: prime_mmap
results: parsing output: 23/ for test: gem_flink_basic
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_setmode
results: parsing output: 29/ for test: kms_vrr
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: gem_mmap
results: parsing output: 32/ for test: syncobj_basic
results: parsing output: 33/ for test: api_intel_allocator
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: syncobj_eventfd
results: parsing output: 36/ for test: kms_cursor_edge_walk
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_colorop
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: kms_colorop
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: gem_render_copy_redux
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: dumb_buffer
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_dsc
results: parsing output: 59/ for test: i915_pm_rps
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: gem_exec_parallel
results: parsing output: 66/ for test: kms_sequence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_colorop
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gen3_render_mixed_blits
results: parsing output: 75/ for test: kms_invalid_mode
results: parsing output: 76/ for test: gem_softpin
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_setmode
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_chamelium_frames
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_draw_crc
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: gem_create
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: syncobj_basic
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: kms_plane_cursor
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: gem_ctx_isolation
results: parsing output: 108/ for test: gem_ringfill
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gen9_exec_parse
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: prime_mmap
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: kms_color
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_gttfill
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: gem_mmap
results: parsing output: 130/ for test: i915_drm_fdinfo
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_pm_backlight
Done.