[57.389270] Initializing watchdogs
[57.389323]   /dev/watchdog0
[57.404211] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.408882] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.411447] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.414812] [001/132] (960s left) gem_partial_pwrite_pread (write-uncached)
[57.511391] Subtest write-uncached: SKIP (0.000s)
[57.577025] [002/132] (960s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[57.681723] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[57.683973] Starting dynamic subtest: pipe-A-eDP-1
[57.706890] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.716694] Starting dynamic subtest: pipe-B-eDP-1
[57.738385] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.745521] Starting dynamic subtest: pipe-C-eDP-1
[57.766594] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.773046] Starting dynamic subtest: pipe-D-eDP-1
[57.795917] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.800269] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[59.980460] [003/132] (958s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[60.074575] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[60.079070] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s)
[60.157349] [004/132] (957s left) gem_spin_batch (spin-all-new)
[60.223320] Starting subtest: spin-all-new
[60.238299] Subtest spin-all-new: SUCCESS (0.015s)
[61.946691] [005/132] (956s left) kms_atomic (plane-primary-legacy)
[62.034459] Starting subtest: plane-primary-legacy
[62.036774] Starting dynamic subtest: pipe-A-eDP-1
[62.512492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s)
[62.514895] Subtest plane-primary-legacy: SUCCESS (0.478s)
[63.315189] [006/132] (954s left) kms_scaling_modes (scaling-mode-none)
[63.406229] Starting subtest: scaling-mode-none
[63.408610] Starting dynamic subtest: pipe-A-eDP-1
[63.501870] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[63.512670] Starting dynamic subtest: pipe-B-eDP-1
[63.542287] Dynamic subtest pipe-B-eDP-1: SKIP (0.038s)
[63.551634] Starting dynamic subtest: pipe-C-eDP-1
[63.576643] Dynamic subtest pipe-C-eDP-1: SKIP (0.034s)
[63.584535] Starting dynamic subtest: pipe-D-eDP-1
[63.618309] Dynamic subtest pipe-D-eDP-1: SKIP (0.041s)
[63.622375] Subtest scaling-mode-none: SKIP (0.213s)
[63.749053] [007/132] (954s left) api_intel_allocator (fork-simple-once)
[63.806845] Starting subtest: fork-simple-once
[63.820725] Subtest fork-simple-once: SUCCESS (0.015s)
[63.950530] [008/132] (954s left) syncobj_timeline (signal-point-0)
[64.019871] Starting subtest: signal-point-0
[64.021902] Subtest signal-point-0: SUCCESS (0.000s)
[64.123639] [009/132] (954s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[64.217918] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[64.220316] Starting dynamic subtest: pipe-A-eDP-1
[64.241442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[64.248516] Starting dynamic subtest: pipe-B-eDP-1
[64.264740] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[64.271400] Starting dynamic subtest: pipe-C-eDP-1
[64.287499] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[64.293873] Starting dynamic subtest: pipe-D-eDP-1
[64.309714] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[64.311520] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[66.454123] [010/132] (951s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[66.552399] Starting subtest: x-tiled-8bpp-rotate-180
[67.809446] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.258s)
[68.021964] [011/132] (950s left) perf (gen12-group-exclusive-stream-sample-oa)
[68.143673] Starting subtest: gen12-group-exclusive-stream-sample-oa
[68.167439] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.022s)
[68.206558] [012/132] (950s left) kms_addfb_basic (legacy-format)
[68.309281] Starting subtest: legacy-format
[68.333560] Subtest legacy-format: SUCCESS (0.023s)
[68.478156] [013/132] (949s left) kms_psr2_su (page_flip-xrgb8888)
[68.542867] Subtest page_flip-XRGB8888: SKIP (0.000s)
[68.603085] [014/132] (949s left) template (b)
[68.652101] Starting subtest: B
[68.653687] Subtest B: SUCCESS (0.000s)
[68.748538] [015/132] (949s left) i915_pm_rps (engine-order)
[68.801184] Starting subtest: engine-order
[75.213188] Subtest engine-order: SUCCESS (6.410s)
[75.327782] [016/132] (943s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[75.437570] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[79.047798] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.614s)
[80.190704] [017/132] (938s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[80.279172] Starting subtest: plane-upscale-20x20-with-modifiers
[80.281548] Starting dynamic subtest: pipe-A
[80.614651] Dynamic subtest pipe-A: SUCCESS (0.338s)
[80.623215] Starting dynamic subtest: pipe-B
[82.068088] Dynamic subtest pipe-B: SUCCESS (1.453s)
[82.076019] Starting dynamic subtest: pipe-C
[83.498870] Dynamic subtest pipe-C: SUCCESS (1.430s)
[83.507134] Starting dynamic subtest: pipe-D
[84.934213] Dynamic subtest pipe-D: SUCCESS (1.434s)
[84.936479] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.659s)
[86.113278] [018/132] (932s left) kms_sequence (get-idle)
[86.220361] Starting subtest: get-idle
[86.222700] Starting dynamic subtest: pipe-A-eDP-1
[88.044071] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s)
[88.053250] Starting dynamic subtest: pipe-B-eDP-1
[90.496230] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.450s)
[90.504194] Starting dynamic subtest: pipe-C-eDP-1
[92.999174] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.500s)
[93.008071] Starting dynamic subtest: pipe-D-eDP-1
[95.431992] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.435s)
[95.434583] Subtest get-idle: SUCCESS (9.214s)
[96.228346] [019/132] (922s left) gem_exec_params (cliprects-invalid)
[96.307787] Starting subtest: cliprects-invalid
[96.310514] Subtest cliprects-invalid: SUCCESS (0.000s)
[96.405772] [020/132] (922s left) kms_pipe_crc_basic (hang-read-crc)
[96.501965] Starting subtest: hang-read-crc
[96.504376] Starting dynamic subtest: pipe-A-eDP-1
[98.610593] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[98.620183] Starting dynamic subtest: pipe-B-eDP-1
[101.480805] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.868s)
[101.489844] Starting dynamic subtest: pipe-C-eDP-1
[104.187286] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.707s)
[104.195665] Starting dynamic subtest: pipe-D-eDP-1
[106.846089] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.659s)
[106.848295] Subtest hang-read-crc: SUCCESS (10.347s)
[107.676145] [021/132] (911s left) gem_lmem_swapping (random-engines)
[107.720607] Subtest random-engines: SKIP (0.000s)
[107.759494] [022/132] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[107.856144] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[107.860418] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[107.952945] [023/132] (910s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[108.077276] Starting subtest: cursor-vs-flip-legacy
[137.410846] Subtest cursor-vs-flip-legacy: SUCCESS (29.334s)
[138.208576] [024/132] (880s left) kms_frontbuffer_tracking (psr-1p-rte)
[138.319074] Starting subtest: psr-1p-rte
[143.703591] Subtest psr-1p-rte: SUCCESS (5.387s)
[143.848135] [025/132] (875s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[143.945128] Starting subtest: plane-ctm3x4-lut1d
[144.091854] Starting dynamic subtest: pipe-A-plane-0
[144.432779] Dynamic subtest pipe-A-plane-0: FAIL (0.175s)
[144.440678] Starting dynamic subtest: pipe-A-plane-1
[144.648732] Dynamic subtest pipe-A-plane-1: FAIL (0.166s)
[144.657752] Starting dynamic subtest: pipe-A-plane-2
[144.855271] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[145.823217] Starting dynamic subtest: pipe-B-plane-0
[146.244221] Dynamic subtest pipe-B-plane-0: FAIL (0.167s)
[146.252997] Starting dynamic subtest: pipe-B-plane-1
[146.558345] Dynamic subtest pipe-B-plane-1: FAIL (0.185s)
[146.567470] Starting dynamic subtest: pipe-B-plane-2
[146.871997] Dynamic subtest pipe-B-plane-2: FAIL (0.187s)
[147.559615] Starting dynamic subtest: pipe-C-plane-0
[148.053689] Dynamic subtest pipe-C-plane-0: FAIL (0.143s)
[148.061346] Starting dynamic subtest: pipe-C-plane-1
[148.456061] Dynamic subtest pipe-C-plane-1: FAIL (0.162s)
[148.465555] Starting dynamic subtest: pipe-C-plane-2
[148.821869] Dynamic subtest pipe-C-plane-2: FAIL (0.626s)
[149.680701] Starting dynamic subtest: pipe-D-plane-0
[150.276043] Dynamic subtest pipe-D-plane-0: FAIL (0.157s)
[150.286368] Starting dynamic subtest: pipe-D-plane-1
[150.732993] Dynamic subtest pipe-D-plane-1: FAIL (0.621s)
[150.741876] Starting dynamic subtest: pipe-D-plane-2
[151.162571] Dynamic subtest pipe-D-plane-2: FAIL (0.532s)
[151.289885] Subtest plane-ctm3x4-lut1d: FAIL (7.345s)
[152.163381] [026/132] (866s left) gem_mmap_gtt (hang-busy)
[152.217063] Subtest hang-busy: SKIP (0.000s)
[152.282270] [027/132] (866s left) gem_readwrite (beyond-eob)
[152.336600] Subtest beyond-EOB: SKIP (0.000s)
[152.391360] [028/132] (866s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[152.482110] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[159.350426] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.869s)
[159.473334] [029/132] (859s left) gem_busy (extended)
[159.664037] Starting subtest: extended
[159.666282] Starting dynamic subtest: rcs0
[159.748035] Dynamic subtest rcs0: SUCCESS (0.086s)
[159.758898] Starting dynamic subtest: bcs0
[159.789044] Dynamic subtest bcs0: SUCCESS (0.039s)
[159.798907] Starting dynamic subtest: vcs0
[160.917863] Dynamic subtest vcs0: SUCCESS (1.125s)
[160.929505] Starting dynamic subtest: vcs1
[162.901990] Dynamic subtest vcs1: SUCCESS (1.981s)
[162.913334] Starting dynamic subtest: vecs0
[164.887356] Dynamic subtest vecs0: SUCCESS (1.982s)
[164.898565] Starting dynamic subtest: ccs0
[164.931320] Dynamic subtest ccs0: SUCCESS (0.043s)
[164.933884] Subtest extended: SUCCESS (5.271s)
[165.192642] [030/132] (853s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[165.289857] Starting subtest: random-ccs-data-yf-tiled-ccs
[165.291986] Starting dynamic subtest: pipe-A-eDP-1
[165.315349] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[165.324636] Starting dynamic subtest: pipe-B-eDP-1
[165.347094] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[165.354637] Starting dynamic subtest: pipe-C-eDP-1
[165.376867] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[165.384389] Starting dynamic subtest: pipe-D-eDP-1
[165.415995] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[165.420132] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[167.533909] [031/132] (851s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[167.634961] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[167.637223] Starting dynamic subtest: pipe-A-eDP-1
[167.659897] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[167.671246] Starting dynamic subtest: pipe-B-eDP-1
[167.691386] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[167.699833] Starting dynamic subtest: pipe-C-eDP-1
[167.720902] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[167.728869] Starting dynamic subtest: pipe-D-eDP-1
[167.750754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[167.754941] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.008s)
[169.906896] [032/132] (849s left) prime_mmap_coherency (write)
[169.968635] Starting subtest: write
[175.350832] Subtest write: SUCCESS (5.380s)
[175.484855] [033/132] (843s left) gem_exec_fence (nb-await)
[175.665538] Starting subtest: nb-await
[175.668285] Starting dynamic subtest: rcs0
[175.741959] Dynamic subtest rcs0: SUCCESS (0.076s)
[175.753130] Starting dynamic subtest: bcs0
[175.801502] Dynamic subtest bcs0: SUCCESS (0.058s)
[175.812586] Starting dynamic subtest: vcs0
[175.862835] Dynamic subtest vcs0: SUCCESS (0.059s)
[175.872871] Starting dynamic subtest: vcs1
[175.924759] Dynamic subtest vcs1: SUCCESS (0.060s)
[175.934569] Starting dynamic subtest: vecs0
[175.988119] Dynamic subtest vecs0: SUCCESS (0.061s)
[175.999623] Starting dynamic subtest: ccs0
[176.051371] Dynamic subtest ccs0: SUCCESS (0.061s)
[176.053957] Subtest nb-await: SUCCESS (0.387s)
[177.938968] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[177.942363] [034/132] (841s left) gem_tiled_partial_pwrite_pread (writes)
[178.013986] Subtest writes: SKIP (0.000s)
[178.085054] [035/132] (841s left) kms_feature_discovery (psr1)
[178.176765] Starting subtest: psr1
[178.179036] Subtest psr1: SUCCESS (0.000s)
[178.266451] [036/132] (841s left) gem_create (create-ext-cpu-access-sanity-check)
[178.434960] Starting subtest: create-ext-cpu-access-sanity-check
[178.440073] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[178.527675] [037/132] (840s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[178.589354] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[178.591783] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[178.676601] [038/132] (840s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[178.726896] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[178.729127] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[178.816758] [039/132] (840s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[178.879539] Subtest writes-after-reads-uncached: SKIP (0.000s)
[178.949853] [040/132] (840s left) prime_self_import (basic-llseek-size)
[178.983422] Starting subtest: basic-llseek-size
[179.003472] Subtest basic-llseek-size: SUCCESS (0.022s)
[179.096942] [041/132] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[179.196174] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[179.200223] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[179.292138] [042/132] (840s left) prime_mmap_coherency (read)
[179.363537] Starting subtest: read
[184.733596] Subtest read: SUCCESS (5.376s)
[184.860666] [043/132] (834s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[184.918710] Starting subtest: single-wait-for-submit-unsubmitted
[185.025045] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[185.115472] [044/132] (834s left) kms_dp_aux_dev
[185.451732] [045/132] (834s left) vgem_basic (setversion)
[185.493704] Starting subtest: setversion
[185.498066] Subtest setversion: SUCCESS (0.000s)
[185.565372] [046/132] (834s left) gem_eio (in-flight-external)
[185.799388] Starting subtest: in-flight-external
[186.968907] Subtest in-flight-external: SUCCESS (1.171s)
[187.127917] [047/132] (832s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[187.227246] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[187.231189] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[187.297167] [048/132] (832s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[187.389857] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[193.982412] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.597s)
[194.106114] [049/132] (825s left) kms_lease (invalid-create-leases)
[194.213078] Starting subtest: invalid-create-leases
[194.217882] Subtest invalid-create-leases: SUCCESS (0.006s)
[194.323908] [050/132] (825s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[194.419055] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[194.423372] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[194.518411] [051/132] (825s left) gem_exec_params (batch-first)
[194.572448] Starting subtest: batch-first
[194.577262] Subtest batch-first: SUCCESS (0.005s)
[194.706034] [052/132] (825s left) gem_exec_schedule (semaphore-power)
[194.882919] Subtest semaphore-power: SKIP (0.000s)
[195.060494] [053/132] (824s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[195.172537] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[195.176496] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[195.272386] [054/132] (824s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[195.362850] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[195.365139] Starting dynamic subtest: pipe-A-eDP-1
[195.447990] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[195.456753] Starting dynamic subtest: pipe-B-eDP-1
[196.602218] Dynamic subtest pipe-B-eDP-1: SKIP (1.152s)
[196.606396] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.244s)
[197.804398] [055/132] (822s left) kms_psr (pr-dpms)
[197.900285] Starting subtest: pr-dpms
[197.904658] Subtest pr-dpms: SKIP (0.000s)
[197.971607] [056/132] (822s left) kms_vblank (wait-busy-hang)
[198.059105] Starting subtest: wait-busy-hang
[198.061023] Starting dynamic subtest: pipe-A-eDP-1
[224.792755] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.732s)
[224.813660] Starting dynamic subtest: pipe-D-eDP-1
[249.678708] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.882s)
[249.680621] Subtest wait-busy-hang: SUCCESS (51.619s)
[250.492499] [057/132] (769s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[250.580565] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[250.584897] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[250.677408] [058/132] (769s left) gem_unref_active_buffers
[250.870886] [059/132] (769s left) kms_big_fb (linear-32bpp-rotate-90)
[250.973178] Starting subtest: linear-32bpp-rotate-90
[251.006524] Subtest linear-32bpp-rotate-90: SKIP (0.029s)
[251.116436] [060/132] (769s left) i915_getparams_basic (basic-eu-total)
[251.180327] Starting subtest: basic-eu-total
[251.184519] Subtest basic-eu-total: SUCCESS (0.000s)
[251.278680] [061/132] (769s left) syncobj_wait (invalid-wait-illegal-handle)
[251.328213] Starting subtest: invalid-wait-illegal-handle
[251.330271] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[251.419990] [062/132] (768s left) gem_gpgpu_fill (offset-16x16)
[251.471266] Starting subtest: offset-16x16
[251.477221] Subtest offset-16x16: SUCCESS (0.007s)
[251.604030] [063/132] (768s left) kms_content_protection (atomic-dpms)
[251.747912] Starting subtest: atomic-dpms
[251.751730] Subtest atomic-dpms: SKIP (0.000s)
[251.868880] [064/132] (768s left) gem_exec_schedule (out-order)
[251.929742] Starting subtest: out-order
[251.931492] Starting dynamic subtest: rcs0
[252.049887] Dynamic subtest rcs0: SUCCESS (0.125s)
[252.063342] Starting dynamic subtest: vcs0
[252.140033] Dynamic subtest vcs0: SUCCESS (0.086s)
[252.150742] Starting dynamic subtest: vcs1
[252.221093] Dynamic subtest vcs1: SUCCESS (0.079s)
[252.233905] Starting dynamic subtest: vecs0
[252.301113] Dynamic subtest vecs0: SUCCESS (0.079s)
[252.310388] Starting dynamic subtest: ccs0
[252.398316] Dynamic subtest ccs0: SUCCESS (0.096s)
[252.400236] Subtest out-order: SUCCESS (0.475s)
[253.992198] [065/132] (766s left) gem_linear_blits (interruptible)
[254.472145] Starting subtest: interruptible
[259.817082] Subtest interruptible: SUCCESS (5.344s)
[259.938730] [066/132] (760s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[260.062884] Starting subtest: plane-downscale-factor-0-75-with-rotation
[260.065344] Starting dynamic subtest: pipe-A
[260.292479] Dynamic subtest pipe-A: SUCCESS (0.231s)
[260.301840] Starting dynamic subtest: pipe-B
[261.567030] Dynamic subtest pipe-B: SUCCESS (1.274s)
[261.580032] Starting dynamic subtest: pipe-C
[262.943385] Dynamic subtest pipe-C: SUCCESS (1.376s)
[262.953245] Starting dynamic subtest: pipe-D
[264.228857] Dynamic subtest pipe-D: SUCCESS (1.284s)
[264.231173] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.168s)
[265.406176] [067/132] (755s left) syncobj_basic (bad-destroy-pad)
[265.462542] Starting subtest: bad-destroy-pad
[265.464820] Subtest bad-destroy-pad: SUCCESS (0.000s)
[265.581783] [068/132] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[265.688941] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[265.693100] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[265.790098] [069/132] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[265.879958] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[265.883933] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[265.964767] [070/132] (754s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[266.080154] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[266.084139] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[266.146791] [071/132] (754s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[266.251212] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[266.255792] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[266.349989] [072/132] (754s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[266.442438] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[266.444260] Starting dynamic subtest: pipe-A-eDP-1
[266.462781] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.472056] Starting dynamic subtest: pipe-B-eDP-1
[266.489914] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.498535] Starting dynamic subtest: pipe-C-eDP-1
[266.515919] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.523766] Starting dynamic subtest: pipe-D-eDP-1
[266.542042] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.545946] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[268.690352] [073/132] (752s left) gem_mmap_wc (write-read-distinct)
[268.746626] Subtest write-read-distinct: SKIP (0.000s)
[268.817410] [074/132] (752s left) sysfs_timeslice_duration (timeout)
[268.875407] Starting subtest: timeout
[268.877640] Starting dynamic subtest: vecs0
[278.934246] Dynamic subtest vecs0: SUCCESS (10.055s)
[278.948618] Starting dynamic subtest: ccs0
[280.270581] Dynamic subtest ccs0: SUCCESS (1.337s)
[280.279651] Starting dynamic subtest: vcs0
[289.874244] Dynamic subtest vcs0: SUCCESS (9.598s)
[289.884337] Starting dynamic subtest: bcs0
[290.499331] Dynamic subtest bcs0: SUCCESS (0.624s)
[290.510581] Starting dynamic subtest: rcs0
[291.737771] Dynamic subtest rcs0: SUCCESS (1.236s)
[291.748259] Starting dynamic subtest: vcs1
[300.884074] Dynamic subtest vcs1: SUCCESS (9.144s)
[300.886600] Subtest timeout: SUCCESS (32.005s)
[300.961955] [075/132] (719s left) gem_exec_reloc (basic-cpu-active)
[301.033531] Subtest basic-cpu-active: SKIP (0.000s)
[301.101914] [076/132] (719s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[301.177955] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[301.281881] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s)
[301.365794] [077/132] (719s left) gem_exec_flush (basic-wb-pro-default)
[301.427434] Starting subtest: basic-wb-pro-default
[306.899178] Subtest basic-wb-pro-default: SUCCESS (5.471s)
[307.091157] [078/132] (713s left) i915_suspend (forcewake)
[307.143842] Starting subtest: forcewake
[340.041700] Subtest forcewake: SUCCESS (3.904s)
[346.135487] [079/132] (681s left) gem_tiled_blits (basic)
[346.228484] Subtest basic: SKIP (0.000s)
[346.299415] [080/132] (680s left) i915_drm_fdinfo (busy-hang)
[346.340048] Starting subtest: busy-hang
[346.342006] Starting dynamic subtest: rcs0
[346.369102] Dynamic subtest rcs0: SKIP (0.029s)
[346.380181] Starting dynamic subtest: bcs0
[346.384234] Dynamic subtest bcs0: SKIP (0.001s)
[346.393706] Starting dynamic subtest: vcs0
[346.397907] Dynamic subtest vcs0: SKIP (0.000s)
[346.406722] Starting dynamic subtest: vcs1
[346.410677] Dynamic subtest vcs1: SKIP (0.000s)
[346.419630] Starting dynamic subtest: vecs0
[346.427880] Dynamic subtest vecs0: SKIP (0.000s)
[346.436936] Starting dynamic subtest: ccs0
[346.441260] Dynamic subtest ccs0: SKIP (0.001s)
[346.445424] Subtest busy-hang: SKIP (0.035s)
[346.484563] [081/132] (680s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[346.582812] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[346.586872] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[346.684555] [082/132] (680s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[346.743958] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[346.823953] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.027s)
[346.864074] [083/132] (680s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[346.927159] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[346.931556] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[347.110580] [084/132] (680s left) gem_ctx_param (invalid-ctx-set)
[347.160037] Starting subtest: invalid-ctx-set
[347.162411] Subtest invalid-ctx-set: SUCCESS (0.001s)
[347.255750] [085/132] (680s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[347.629736] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[348.444385] [086/132] (678s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[348.539376] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[348.543848] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[348.629374] [087/132] (678s left) gem_exec_whisper (basic-normal)
[348.695366] Starting subtest: basic-normal
[351.931818] Subtest basic-normal: SUCCESS (3.234s)
[352.130832] [088/132] (675s left) gem_mmap_wc (bad-size)
[352.200284] Subtest bad-size: SKIP (0.000s)
[352.271120] [089/132] (675s left) kms_cursor_crc (cursor-onscreen-128x42)
[352.500380] Starting subtest: cursor-onscreen-128x42
[352.545913] Subtest cursor-onscreen-128x42: SKIP (0.044s)
[352.729697] [090/132] (674s left) kms_hdr (static-toggle)
[352.825328] Starting subtest: static-toggle
[352.831409] Subtest static-toggle: SKIP (0.000s)
[352.899231] [091/132] (674s left) perf_pmu (faulting-read)
[352.946429] Starting subtest: faulting-read
[352.948746] Starting dynamic subtest: wb
[352.951082] Dynamic subtest wb: SUCCESS (0.001s)
[352.961815] Starting dynamic subtest: wc
[352.964003] Dynamic subtest wc: SUCCESS (0.000s)
[352.973232] Starting dynamic subtest: uc
[352.975433] Dynamic subtest uc: SUCCESS (0.000s)
[352.977572] Subtest faulting-read: SUCCESS (0.003s)
[353.049610] [092/132] (674s left) syncobj_wait (wait-all-snapshot)
[353.093893] Starting subtest: wait-all-snapshot
[353.176993] Subtest wait-all-snapshot: SUCCESS (0.082s)
[353.254037] [093/132] (674s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[353.307447] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[353.368032] [094/132] (674s left) api_intel_bb (reset-flags)
[353.428863] Starting subtest: reset-flags
[353.434399] Subtest reset-flags: SUCCESS (0.008s)
[353.561037] [095/132] (674s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[353.647576] Starting subtest: pixel-format-y-tiled-ccs-modifier
[353.650955] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[353.722492] [096/132] (674s left) kms_cursor_crc (cursor-size-hints)
[353.881653] Starting subtest: cursor-size-hints
[353.883632] Starting dynamic subtest: pipe-A-eDP-1
[354.527662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.646s)
[354.537398] Starting dynamic subtest: pipe-D-eDP-1
[355.823992] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[355.826263] Subtest cursor-size-hints: SUCCESS (1.943s)
[356.638736] [097/132] (671s left) gem_exec_big (single)
[356.714391] Starting subtest: single
[360.081916] Subtest single: FAIL (3.307s)
[360.123863] [098/132] (667s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[360.264259] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[360.268181] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[360.336977] [099/132] (667s left) gen9_exec_parse (batch-invalid-length)
[360.411465] Subtest batch-invalid-length: SKIP (0.000s)
[360.485605] [100/132] (667s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[360.537961] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[360.542343] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[360.732201] [101/132] (667s left) syncobj_timeline (etime-single-wait-all-submitted)
[360.803727] Starting subtest: etime-single-wait-all-submitted
[360.911020] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[361.003345] [102/132] (667s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[361.112466] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[361.116788] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[361.218295] [103/132] (666s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[361.336920] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[361.972614] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[362.134878] [104/132] (666s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[362.230965] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[362.235130] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[362.323767] [105/132] (665s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[362.445190] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[362.449307] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[362.541602] [106/132] (665s left) kms_psr (fbc-psr-primary-page-flip)
[362.641766] Starting subtest: fbc-psr-primary-page-flip
[362.644057] Starting dynamic subtest: eDP-1
[362.648225] Dynamic subtest eDP-1: SKIP (0.000s)
[362.652359] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[362.714575] [107/132] (665s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[362.804337] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[362.808838] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[362.879095] [108/132] (665s left) gem_exec_balancer (fairslice)
[362.937602] Starting subtest: fairslice
[365.867885] Subtest fairslice: SUCCESS (2.927s)
[366.193885] [109/132] (662s left) gem_ctx_persistence (engines-persistence)
[366.262194] Starting subtest: engines-persistence
[366.264041] Starting dynamic subtest: rcs0
[367.077324] Dynamic subtest rcs0: SUCCESS (0.817s)
[367.093092] Starting dynamic subtest: bcs0
[367.830023] Dynamic subtest bcs0: SUCCESS (0.749s)
[367.842601] Starting dynamic subtest: vcs0
[368.593895] Dynamic subtest vcs0: SUCCESS (0.762s)
[368.606180] Starting dynamic subtest: vcs1
[369.371156] Dynamic subtest vcs1: SUCCESS (0.776s)
[369.386364] Starting dynamic subtest: vecs0
[370.119065] Dynamic subtest vecs0: SUCCESS (0.745s)
[370.134708] Starting dynamic subtest: ccs0
[370.874409] Dynamic subtest ccs0: SUCCESS (0.752s)
[370.877026] Subtest engines-persistence: SUCCESS (4.615s)
[371.004969] [110/132] (657s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[371.110252] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[371.114947] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[371.199197] [111/132] (657s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[371.262705] Starting subtest: invalid-signal-one-illegal-handle
[371.264679] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[371.374005] [112/132] (657s left) perf (i915-ref-count)
[371.467616] Starting subtest: i915-ref-count
[371.511651] Subtest i915-ref-count: SUCCESS (0.040s)
[371.569868] [113/132] (657s left) syncobj_wait (wait-for-submit-complex)
[371.624036] Starting subtest: wait-for-submit-complex
[371.685488] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[371.763189] [114/132] (656s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[371.874897] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[372.699428] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[372.864561] [115/132] (655s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[372.957256] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[372.961561] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[373.038023] [116/132] (655s left) syncobj_wait (multi-wait-submitted-signaled)
[373.098626] Starting subtest: multi-wait-submitted-signaled
[373.100854] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[373.221745] [117/132] (655s left) core_getversion (basic)
[373.272676] Starting subtest: basic
[373.276759] Subtest basic: SUCCESS (0.000s)
[373.345235] [118/132] (655s left) kms_cursor_crc (cursor-sliding-32x32)
[373.489897] Starting subtest: cursor-sliding-32x32
[373.533332] Subtest cursor-sliding-32x32: SKIP (0.042s)
[373.809512] [119/132] (655s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[373.895839] Starting subtest: psr-1p-pri-indfb-multidraw
[396.835541] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.943s)
[396.951699] [120/132] (631s left) kms_pm_backlight (brightness-with-dpms)
[397.058515] Starting subtest: brightness-with-dpms
[397.108430] Starting dynamic subtest: eDP-1
[399.665134] Dynamic subtest eDP-1: SUCCESS (2.555s)
[399.668238] Subtest brightness-with-dpms: SUCCESS (2.607s)
[400.530926] [121/132] (628s left) gem_wait (wait)
[400.590456] Starting subtest: wait
[400.592667] Starting dynamic subtest: all-engines
[401.875189] Dynamic subtest all-engines: SUCCESS (1.285s)
[401.888213] Starting dynamic subtest: rcs0
[402.921561] Dynamic subtest rcs0: SUCCESS (1.045s)
[402.934205] Starting dynamic subtest: bcs0
[403.972072] Dynamic subtest bcs0: SUCCESS (1.048s)
[403.984851] Starting dynamic subtest: vcs0
[405.017090] Dynamic subtest vcs0: SUCCESS (1.043s)
[405.028434] Starting dynamic subtest: vcs1
[406.062106] Dynamic subtest vcs1: SUCCESS (1.043s)
[406.074123] Starting dynamic subtest: vecs0
[407.107753] Dynamic subtest vecs0: SUCCESS (1.043s)
[407.119844] Starting dynamic subtest: ccs0
[408.155568] Dynamic subtest ccs0: SUCCESS (1.045s)
[408.158656] Subtest wait: SUCCESS (7.568s)
[408.354542] [122/132] (620s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[408.446620] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[408.458787] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[408.536617] [123/132] (620s left) gem_exec_params (invalid-fence-in-submit)
[408.593822] Starting subtest: invalid-fence-in-submit
[408.598900] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[408.721231] [124/132] (620s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[408.840191] Starting subtest: basic-flip-before-cursor-legacy
[409.764821] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.924s)
[410.561076] [125/132] (618s left) gem_ctx_persistence (hostile)
[410.614478] Starting subtest: hostile
[420.118375] Subtest hostile: SUCCESS (9.498s)
[420.250226] [126/132] (608s left) kms_pm_rpm (pm-caching)
[422.087217] Starting subtest: pm-caching
[422.092383] Subtest pm-caching: SKIP (0.000s)
[422.508683] [127/132] (606s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[422.892288] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[423.698578] [128/132] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[423.806693] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[423.810903] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[423.900774] [129/132] (605s left) kms_flip (modeset-vs-vblank-race)
[423.999023] Starting subtest: modeset-vs-vblank-race
[424.001147] Starting dynamic subtest: A-eDP1
[428.743187] Dynamic subtest A-eDP1: SUCCESS (4.745s)
[428.754588] Starting dynamic subtest: B-eDP1
[433.456434] Dynamic subtest B-eDP1: SUCCESS (4.710s)
[433.472075] Starting dynamic subtest: C-eDP1
[437.992223] Dynamic subtest C-eDP1: SUCCESS (4.533s)
[438.004817] Starting dynamic subtest: D-eDP1
[442.541819] Dynamic subtest D-eDP1: SUCCESS (4.547s)
[442.547224] Subtest modeset-vs-vblank-race: SUCCESS (18.548s)
[443.725477] [130/132] (585s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[443.831362] Starting subtest: fbc-psr2-cursor-mmap-cpu
[443.833668] Starting dynamic subtest: eDP-1
[443.837740] Dynamic subtest eDP-1: SKIP (0.000s)
[443.841829] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[443.906682] [131/132] (585s left) gem_ctx_shared (exec-single-timeline)
[443.964719] Starting subtest: exec-single-timeline
[443.967055] Starting dynamic subtest: rcs0
[445.039532] Dynamic subtest rcs0: SUCCESS (1.073s)
[445.052521] Starting dynamic subtest: bcs0
[446.063464] Dynamic subtest bcs0: SUCCESS (1.021s)
[446.076605] Starting dynamic subtest: vcs0
[447.154219] Dynamic subtest vcs0: SUCCESS (1.088s)
[447.167341] Starting dynamic subtest: vcs1
[448.239815] Dynamic subtest vcs1: SUCCESS (1.083s)
[448.253446] Starting dynamic subtest: vecs0
[449.328214] Dynamic subtest vecs0: SUCCESS (1.085s)
[449.341281] Starting dynamic subtest: ccs0
[450.442503] Dynamic subtest ccs0: SUCCESS (1.085s)
[450.446926] Subtest exec-single-timeline: SUCCESS (6.450s)
[450.967890] [132/132] (578s left) kms_psr (psr-cursor-blt)
[451.058151] Starting subtest: psr-cursor-blt
[451.060512] Starting dynamic subtest: eDP-1
[452.811350] Dynamic subtest eDP-1: SUCCESS (1.751s)
[452.813707] Subtest psr-cursor-blt: SUCCESS (1.752s)
[453.674839] Closing watchdogs
results: parsing output: 0/ for test: gem_partial_pwrite_pread
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_spin_batch
results: parsing output: 4/ for test: kms_atomic
results: parsing output: 5/ for test: kms_scaling_modes
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: kms_psr2_su
results: parsing output: 13/ for test: template
results: parsing output: 14/ for test: i915_pm_rps
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: kms_sequence
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_pipe_crc_basic
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_color_pipeline
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_readwrite
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_busy
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: prime_mmap_coherency
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 34/ for test: kms_feature_discovery
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: gem_partial_pwrite_pread
results: parsing output: 39/ for test: prime_self_import
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: prime_mmap_coherency
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_dp_aux_dev
results: parsing output: 44/ for test: vgem_basic
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_lease
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_unref_active_buffers
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: i915_getparams_basic
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_gpgpu_fill
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: gem_linear_blits
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: syncobj_basic
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_mmap_wc
results: parsing output: 73/ for test: sysfs_timeslice_duration
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_exec_flush
results: parsing output: 77/ for test: i915_suspend
results: parsing output: 78/ for test: gem_tiled_blits
results: parsing output: 79/ for test: i915_drm_fdinfo
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: sriov_basic
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: kms_chamelium_edid
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_hdr
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_pipe_b_c_ivb
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: gem_exec_big
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: core_getversion
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_pm_backlight
results: parsing output: 120/ for test: gem_wait
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: kms_pm_rpm
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_ctx_shared
results: parsing output: 131/ for test: kms_psr
Done.