[57.947637] Initializing watchdogs
[57.947697]   /dev/watchdog0
[57.962152] [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.966559] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.968901] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.972185] [001/133] (960s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[58.107468] Starting subtest: 4-tiled-16bpp-rotate-90
[58.140278] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.032s)
[58.269749] [002/133] (960s left) gem_exec_fence (basic-busy)
[58.442890] Starting subtest: basic-busy
[58.445550] Starting dynamic subtest: rcs0
[58.547864] Dynamic subtest rcs0: SUCCESS (0.105s)
[58.557702] Starting dynamic subtest: bcs0
[58.600769] Dynamic subtest bcs0: SUCCESS (0.052s)
[58.610159] Starting dynamic subtest: vcs0
[58.651322] Dynamic subtest vcs0: SUCCESS (0.050s)
[58.663452] Starting dynamic subtest: vcs1
[58.714249] Dynamic subtest vcs1: SUCCESS (0.061s)
[58.723789] Starting dynamic subtest: vecs0
[58.780971] Dynamic subtest vecs0: SUCCESS (0.066s)
[58.790027] Starting dynamic subtest: ccs0
[58.838406] Dynamic subtest ccs0: SUCCESS (0.057s)
[58.840880] Subtest basic-busy: SUCCESS (0.397s)
[61.000563] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[61.003584] [003/133] (957s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[63.086692] Starting subtest: modeset-lpsp-stress-no-wait
[72.809481] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.724s)
[72.898995] [004/133] (945s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[72.997044] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[72.999434] Starting dynamic subtest: pipe-A-default-mode
[74.134289] Dynamic subtest pipe-A-default-mode: SKIP (1.132s)
[74.139376] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.133s)
[74.302033] [005/133] (944s left) syncobj_timeline (invalid-query-zero-handles)
[74.368036] Starting subtest: invalid-query-zero-handles
[74.370375] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[74.502970] [006/133] (944s left) kms_rmfb (close-fd)
[74.607105] Starting subtest: close-fd
[74.609362] Starting dynamic subtest: pipe-A-eDP-1
[74.714687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[74.723745] Starting dynamic subtest: pipe-B-eDP-1
[75.860603] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[75.869668] Starting dynamic subtest: pipe-C-eDP-1
[77.000591] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.139s)
[77.009183] Starting dynamic subtest: pipe-D-eDP-1
[78.127024] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[78.129422] Subtest close-fd: SUCCESS (3.521s)
[79.355547] [007/133] (939s left) gem_spin_batch (spin-all)
[79.416313] Starting subtest: spin-all
[79.431885] Subtest spin-all: SUCCESS (0.015s)
[80.967333] [008/133] (937s left) gem_exec_fence (keep-in-fence)
[81.149347] Starting subtest: keep-in-fence
[81.151730] Starting dynamic subtest: rcs0
[81.236683] Dynamic subtest rcs0: SUCCESS (0.090s)
[81.247177] Starting dynamic subtest: bcs0
[81.292037] Dynamic subtest bcs0: SUCCESS (0.055s)
[81.301739] Starting dynamic subtest: vcs0
[82.899844] Dynamic subtest vcs0: SUCCESS (1.605s)
[82.910537] Starting dynamic subtest: vcs1
[84.885772] Dynamic subtest vcs1: SUCCESS (1.985s)
[84.894344] Starting dynamic subtest: vecs0
[86.933543] Dynamic subtest vecs0: SUCCESS (2.047s)
[86.944696] Starting dynamic subtest: ccs0
[87.163096] Dynamic subtest ccs0: SUCCESS (0.230s)
[87.166059] Subtest keep-in-fence: SUCCESS (6.016s)
[88.987062] [009/133] (929s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[89.097127] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[89.101101] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[89.215521] [010/133] (929s left) kms_psr (fbc-psr-dpms)
[89.300773] Starting subtest: fbc-psr-dpms
[89.303044] Starting dynamic subtest: eDP-1
[89.307183] Dynamic subtest eDP-1: SKIP (0.000s)
[89.311276] Subtest fbc-psr-dpms: SKIP (0.000s)
[89.385330] [011/133] (929s left) syncobj_timeline (multi-wait-signaled)
[89.441742] Starting subtest: multi-wait-signaled
[89.444066] Subtest multi-wait-signaled: SUCCESS (0.001s)
[89.578689] [012/133] (929s left) kms_flip (blocking-wf_vblank)
[89.684145] Starting subtest: blocking-wf_vblank
[89.686266] Starting dynamic subtest: A-eDP1
[98.619228] Dynamic subtest A-eDP1: SUCCESS (8.902s)
[98.630896] Starting dynamic subtest: B-eDP1
[107.548070] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[107.562227] Starting dynamic subtest: C-eDP1
[116.472620] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[116.482339] Starting dynamic subtest: D-eDP1
[125.405749] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[125.407984] Subtest blocking-wf_vblank: SUCCESS (35.683s)
[126.582576] [013/133] (892s left) kms_dsc (dsc-with-output-formats)
[126.684141] Starting subtest: dsc-with-output-formats
[126.706865] Subtest dsc-with-output-formats: SKIP (0.001s)
[126.765088] [014/133] (892s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[126.864604] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[126.868945] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[126.963832] [015/133] (892s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[127.071391] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[134.413055] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.344s)
[134.561762] [016/133] (884s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[134.679254] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[134.683773] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[134.803938] [017/133] (884s left) gem_lmem_swapping (parallel-random-engines)
[134.847984] Subtest parallel-random-engines: SKIP (0.000s)
[134.916945] [018/133] (884s left) gem_exec_reloc (basic-wc-cpu-active)
[134.995680] Subtest basic-wc-cpu-active: SKIP (0.000s)
[135.093633] [019/133] (884s left) gem_ctx_isolation (clean)
[135.157064] Starting subtest: clean
[135.159215] Starting dynamic subtest: rcs0
[135.206492] Dynamic subtest rcs0: SUCCESS (0.052s)
[135.216429] Starting dynamic subtest: bcs0
[135.277771] Dynamic subtest bcs0: SUCCESS (0.071s)
[135.287644] Starting dynamic subtest: vcs0
[135.355153] Dynamic subtest vcs0: SUCCESS (0.077s)
[135.363578] Starting dynamic subtest: vcs1
[136.949416] Dynamic subtest vcs1: SUCCESS (1.593s)
[136.958705] Starting dynamic subtest: vecs0
[138.926585] Dynamic subtest vecs0: SUCCESS (1.977s)
[138.935794] Starting dynamic subtest: ccs0
[140.929591] Dynamic subtest ccs0: SUCCESS (2.003s)
[140.932083] Subtest clean: SUCCESS (5.775s)
[141.198255] [020/133] (878s left) kms_rotation_crc (sprite-rotation-90)
[141.295680] Starting subtest: sprite-rotation-90
[141.300059] Subtest sprite-rotation-90: SKIP (0.001s)
[141.381715] [021/133] (877s left) gem_ctx_engines (invalid-engines)
[141.464234] Starting subtest: invalid-engines
[141.480163] Subtest invalid-engines: SUCCESS (0.019s)
[141.753053] [022/133] (877s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[141.857623] Starting subtest: psr-farfromfence-mmap-gtt
[141.861818] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[141.996838] [023/133] (877s left) kms_big_fb (linear-32bpp-rotate-180)
[142.102185] Starting subtest: linear-32bpp-rotate-180
[143.669761] Subtest linear-32bpp-rotate-180: SUCCESS (1.567s)
[143.837137] [024/133] (875s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[143.902461] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[143.906194] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[144.092094] [025/133] (875s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[144.198434] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[144.200757] Starting dynamic subtest: pipe-A-eDP-1
[144.260798] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[144.270340] Starting dynamic subtest: pipe-B-eDP-1
[144.328264] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[144.337379] Starting dynamic subtest: pipe-C-eDP-1
[144.393867] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[144.403079] Starting dynamic subtest: pipe-D-eDP-1
[144.459686] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[144.464078] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[146.383583] [026/133] (873s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[146.491189] Starting subtest: compare-crc-sanitycheck-nv12
[146.493634] Starting dynamic subtest: pipe-A-eDP-1
[147.204511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[147.213521] Starting dynamic subtest: pipe-B-eDP-1
[148.459708] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s)
[148.468594] Starting dynamic subtest: pipe-C-eDP-1
[149.720478] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.260s)
[149.731754] Starting dynamic subtest: pipe-D-eDP-1
[150.955359] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[150.957659] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.466s)
[151.802351] [027/133] (867s left) kms_invalid_mode (uint-max-clock)
[151.904036] Starting subtest: uint-max-clock
[151.906162] Starting dynamic subtest: pipe-A-eDP-1
[152.187683] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[152.195889] Starting dynamic subtest: pipe-B-eDP-1
[152.198017] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[152.205075] Starting dynamic subtest: pipe-C-eDP-1
[152.207204] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[152.214146] Starting dynamic subtest: pipe-D-eDP-1
[152.215996] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[152.217856] Subtest uint-max-clock: SUCCESS (0.291s)
[153.025768] [028/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[153.127022] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[153.131219] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[153.273517] [029/133] (866s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[153.378685] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[153.404773] Starting dynamic subtest: pipe-A-plane-0
[153.694162] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[153.702559] Starting dynamic subtest: pipe-A-plane-3
[153.927250] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[153.935947] Starting dynamic subtest: pipe-A-plane-5
[153.940121] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[155.003426] Starting dynamic subtest: pipe-B-plane-0
[155.308528] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[155.316980] Starting dynamic subtest: pipe-B-plane-3
[155.541938] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[155.550655] Starting dynamic subtest: pipe-B-plane-5
[155.554710] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[155.855088] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.475s)
[156.679028] [030/133] (862s left) gem_exec_schedule (semaphore-codependency)
[156.759312] Starting subtest: semaphore-codependency
[156.768727] Subtest semaphore-codependency: SUCCESS (0.016s)
[157.143551] [031/133] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[157.240335] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[164.734792] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.498s)
[164.920367] [032/133] (854s left) gem_exec_params (sol-reset-not-gen7)
[164.993466] Starting subtest: sol-reset-not-gen7
[164.998650] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[165.142205] [033/133] (854s left) gem_exec_balancer (bonded-false-hang)
[165.396525] Starting subtest: bonded-false-hang
[165.401067] Subtest bonded-false-hang: SKIP (0.000s)
[165.502200] [034/133] (854s left) gen9_exec_parse (allowed-all)
[165.563566] Subtest allowed-all: SKIP (0.000s)
[165.642357] [035/133] (854s left) gem_ccs (block-multicopy-compressed)
[165.708063] Starting subtest: block-multicopy-compressed
[165.712537] Subtest block-multicopy-compressed: SKIP (0.000s)
[165.821737] [036/133] (854s left) gem_ctx_bad_destroy (invalid-pad)
[165.882971] Starting subtest: invalid-pad
[165.885284] Subtest invalid-pad: SUCCESS (0.000s)
[165.980189] [037/133] (853s left) kms_async_flips (invalid-async-flip-atomic)
[166.076085] Starting subtest: invalid-async-flip-atomic
[166.480713] Starting dynamic subtest: pipe-A-eDP-1
[167.304260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[167.663193] Starting dynamic subtest: pipe-B-eDP-1
[168.449676] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.793s)
[168.804601] Starting dynamic subtest: pipe-C-eDP-1
[169.562850] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[169.921729] Starting dynamic subtest: pipe-D-eDP-1
[170.695261] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.785s)
[170.697457] Subtest invalid-async-flip-atomic: SUCCESS (4.622s)
[171.854813] [038/133] (848s left) vgem_slow (nohang)
[171.898479] Starting subtest: nohang
[182.385589] Subtest nohang: SUCCESS (10.490s)
[182.478333] [039/133] (837s left) kms_chamelium_hpd (hdmi-hpd)
[182.870167] Subtest hdmi-hpd: SKIP (0.000s)
[183.649307] [040/133] (836s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[183.752407] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[193.084511] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.334s)
[193.261094] [041/133] (826s left) kms_addfb_basic (unused-offsets)
[193.319049] Starting subtest: unused-offsets
[193.321294] Subtest unused-offsets: SUCCESS (0.000s)
[193.485209] [042/133] (826s left) prime_udl
[193.565110] [043/133] (826s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[193.692676] Starting subtest: 2x-cursor-vs-flip-atomic
[193.697019] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[193.847579] [044/133] (826s left) kms_lease (empty-lease)
[193.938178] Starting subtest: empty-lease
[193.940478] Starting dynamic subtest: pipe-A-eDP-1
[193.943949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[193.951734] Starting dynamic subtest: pipe-B-eDP-1
[193.953920] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[193.961470] Starting dynamic subtest: pipe-C-eDP-1
[193.963608] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[193.971019] Starting dynamic subtest: pipe-D-eDP-1
[193.973135] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[193.975228] Subtest empty-lease: SUCCESS (0.009s)
[194.083546] [045/133] (826s left) gen3_render_tiledy_blits
[194.215315] [046/133] (826s left) kms_cursor_crc (cursor-onscreen-128x128)
[194.427292] Starting subtest: cursor-onscreen-128x128
[194.431479] Starting dynamic subtest: pipe-A-eDP-1
[196.542139] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[196.568082] Starting dynamic subtest: pipe-D-eDP-1
[199.373693] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.812s)
[199.375824] Subtest cursor-onscreen-128x128: SUCCESS (4.946s)
[200.247740] [047/133] (820s left) gem_ctx_shared (q-smoketest-all)
[200.323427] Starting subtest: Q-smoketest-all
[232.720134] Subtest Q-smoketest-all: SUCCESS (32.346s)
[233.935604] [048/133] (786s left) gem_mmap_gtt (basic-write-read-distinct)
[233.983487] Subtest basic-write-read-distinct: SKIP (0.000s)
[234.046124] [049/133] (786s left) kms_frontbuffer_tracking (fbc-stridechange)
[234.166665] Starting subtest: fbc-stridechange
[237.472226] Subtest fbc-stridechange: SUCCESS (3.308s)
[238.640598] [050/133] (781s left) kms_plane (planar-pixel-format-settings)
[238.746195] Starting subtest: planar-pixel-format-settings
[238.811886] Subtest planar-pixel-format-settings: SUCCESS (0.067s)
[238.972783] [051/133] (781s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[239.079232] Starting subtest: plane-upscale-20x20-with-rotation
[239.081582] Starting dynamic subtest: pipe-A
[239.303326] Dynamic subtest pipe-A: SUCCESS (0.226s)
[239.311182] Starting dynamic subtest: pipe-B
[240.596896] Dynamic subtest pipe-B: SUCCESS (1.293s)
[240.605375] Starting dynamic subtest: pipe-C
[241.926631] Dynamic subtest pipe-C: SUCCESS (1.329s)
[241.936744] Starting dynamic subtest: pipe-D
[243.252394] Dynamic subtest pipe-D: SUCCESS (1.325s)
[243.254735] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.176s)
[244.440469] [052/133] (776s left) i915_pm_rps (engine-order)
[244.507999] Starting subtest: engine-order
[249.549150] Subtest engine-order: SUCCESS (5.041s)
[249.701945] [053/133] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[249.802599] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[249.807009] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[249.915032] [054/133] (770s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[250.024969] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[250.027266] Starting dynamic subtest: pipe-A-eDP-1
[250.047641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[250.057589] Starting dynamic subtest: pipe-B-eDP-1
[250.076967] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[250.085237] Starting dynamic subtest: pipe-C-eDP-1
[250.104722] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[250.113517] Starting dynamic subtest: pipe-D-eDP-1
[250.132777] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[250.134980] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[252.230674] [055/133] (768s left) gem_mmap (short-mmap)
[252.304902] Subtest short-mmap: SKIP (0.000s)
[252.373462] [056/133] (768s left) gem_partial_pwrite_pread (reads-uncached)
[252.432606] Subtest reads-uncached: SKIP (0.000s)
[252.508559] [057/133] (768s left) syncobj_wait (wait-all-delayed-signal)
[252.562586] Starting subtest: wait-all-delayed-signal
[252.663740] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[252.750027] [058/133] (768s left) gem_mmap_offset (mmap-boundaries)
[252.801510] Starting subtest: mmap-boundaries
[252.803941] Starting dynamic subtest: smem0
[253.078694] Dynamic subtest smem0: SUCCESS (0.279s)
[253.081718] Subtest mmap-boundaries: SUCCESS (0.280s)
[253.228864] [059/133] (767s left) syncobj_timeline (wait-for-submit-snapshot)
[253.293622] Starting subtest: wait-for-submit-snapshot
[253.373379] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[253.476413] [060/133] (767s left) kms_chamelium_color (ctm-negative)
[253.580063] Subtest ctm-negative: SKIP (0.000s)
[253.624043] [061/133] (767s left) device_reset (cold-reset-bound)
[253.673246] Starting subtest: cold-reset-bound
[253.677784] Subtest cold-reset-bound: SKIP (0.000s)
[253.747311] [062/133] (767s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[253.841028] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[253.843323] Starting dynamic subtest: A-eDP1
[257.442509] Dynamic subtest A-eDP1: SUCCESS (3.599s)
[257.451492] Starting dynamic subtest: B-eDP1
[260.650138] Dynamic subtest B-eDP1: SUCCESS (3.204s)
[260.659368] Starting dynamic subtest: C-eDP1
[263.751235] Dynamic subtest C-eDP1: SUCCESS (3.102s)
[263.760601] Starting dynamic subtest: D-eDP1
[266.867225] Dynamic subtest D-eDP1: SUCCESS (3.114s)
[266.869523] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.028s)
[267.680656] [063/133] (753s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[267.785528] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[267.789971] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[267.883903] [064/133] (753s left) gem_exec_params (invalid-ring2)
[267.939519] Starting subtest: invalid-ring2
[267.941732] Subtest invalid-ring2: SUCCESS (0.000s)
[268.056973] [065/133] (753s left) gem_userptr_blits (process-exit-busy)
[268.130253] Starting subtest: process-exit-busy
[268.142298] Subtest process-exit-busy: SUCCESS (0.014s)
[268.289406] [066/133] (752s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[268.383070] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[272.296594] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.916s)
[273.500275] [067/133] (747s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[273.608619] Starting subtest: fbc-pr-cursor-mmap-gtt
[273.612765] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[273.706122] [068/133] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[273.809631] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[273.813642] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[273.936664] [069/133] (747s left) api_intel_allocator (simple-allocator)
[273.999249] Starting subtest: simple-allocator
[274.001573] Starting dynamic subtest: basic
[274.003712] Dynamic subtest basic: SUCCESS (0.003s)
[274.014097] Starting dynamic subtest: parallel-one
[274.191821] Dynamic subtest parallel-one: SUCCESS (0.190s)
[274.199654] Starting dynamic subtest: print
[274.201819] Dynamic subtest print: SUCCESS (0.000s)
[274.209550] Starting dynamic subtest: reuse
[274.211759] Dynamic subtest reuse: SUCCESS (0.000s)
[274.219639] Starting dynamic subtest: reserve
[274.221801] Dynamic subtest reserve: SUCCESS (0.000s)
[274.229640] Starting dynamic subtest: fork-reopen-allocator
[274.231799] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[274.233914] Subtest simple-allocator: SUCCESS (0.213s)
[274.354762] [070/133] (746s left) syncobj_timeline (etime-multi-wait-submitted)
[274.418048] Starting subtest: etime-multi-wait-submitted
[274.519292] Subtest etime-multi-wait-submitted: SUCCESS (0.102s)
[274.608041] [071/133] (746s left) kms_chamelium_edid (dp-edid-read)
[274.997251] Subtest dp-edid-read: SKIP (0.000s)
[275.859222] [072/133] (745s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[275.963383] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[275.974991] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[276.062385] [073/133] (745s left) gem_exec_whisper (basic-contexts)
[276.123788] Starting subtest: basic-contexts
[281.844891] Subtest basic-contexts: SUCCESS (5.716s)
[282.048231] [074/133] (739s left) gem_pwrite (basic-self)
[282.116212] Subtest basic-self: SKIP (0.000s)
[282.188356] [075/133] (739s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[282.291261] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[282.295246] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[282.419650] [076/133] (739s left) kms_cursor_legacy (single-bo)
[282.541698] Starting subtest: single-bo
[282.543989] Starting dynamic subtest: pipe-A
[287.986270] Dynamic subtest pipe-A: SUCCESS (5.378s)
[287.997058] Starting dynamic subtest: pipe-B
[293.357815] Dynamic subtest pipe-B: SUCCESS (5.379s)
[293.368253] Starting dynamic subtest: pipe-C
[298.739561] Dynamic subtest pipe-C: SUCCESS (5.378s)
[298.750324] Starting dynamic subtest: pipe-D
[304.120624] Dynamic subtest pipe-D: SUCCESS (5.378s)
[304.131535] Starting dynamic subtest: all-pipes
[309.511693] Dynamic subtest all-pipes: SUCCESS (5.388s)
[309.513873] Subtest single-bo: SUCCESS (26.914s)
[309.629230] [077/133] (711s left) syncobj_timeline (wait-any-interrupted)
[309.685664] Starting subtest: wait-any-interrupted
[309.793223] Subtest wait-any-interrupted: SUCCESS (0.107s)
[309.879217] [078/133] (711s left) i915_suspend (sysfs-reader)
[309.944198] Starting subtest: sysfs-reader
[328.416378] Subtest sysfs-reader: SUCCESS (3.954s)
[328.507866] [079/133] (693s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[328.616098] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[328.618059] Starting dynamic subtest: pipe-A-eDP-1
[328.637584] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.647759] Starting dynamic subtest: pipe-B-eDP-1
[328.666261] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.674613] Starting dynamic subtest: pipe-C-eDP-1
[328.692375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.700363] Starting dynamic subtest: pipe-D-eDP-1
[328.718370] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.722172] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[330.864948] [080/133] (690s left) kms_plane_multiple (2x-tiling-x)
[330.962616] Starting subtest: 2x-tiling-x
[330.966886] Subtest 2x-tiling-x: SKIP (0.000s)
[331.046941] [081/133] (690s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[331.140095] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[338.028883] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.887s)
[338.181483] [082/133] (683s left) perf_pmu (semaphore-busy)
[338.230991] Starting subtest: semaphore-busy
[338.233198] Starting dynamic subtest: rcs0
[339.887768] Dynamic subtest rcs0: SUCCESS (1.651s)
[339.897808] Starting dynamic subtest: bcs0
[340.510157] Dynamic subtest bcs0: FAIL (0.563s)
[340.520881] Starting dynamic subtest: vcs0
[341.071713] Dynamic subtest vcs0: FAIL (0.549s)
[341.082372] Starting dynamic subtest: vcs1
[342.995671] Dynamic subtest vcs1: FAIL (1.923s)
[343.006342] Starting dynamic subtest: vecs0
[345.039702] Dynamic subtest vecs0: FAIL (2.047s)
[345.050039] Starting dynamic subtest: ccs0
[347.024689] Dynamic subtest ccs0: FAIL (1.984s)
[347.026636] Subtest semaphore-busy: FAIL (8.725s)
[347.099535] [083/133] (674s left) kms_cursor_crc (cursor-random-64x21)
[347.287342] Starting subtest: cursor-random-64x21
[347.332756] Subtest cursor-random-64x21: SKIP (0.042s)
[347.594831] [084/133] (674s left) kms_psr (pr-cursor-mmap-gtt)
[347.687542] Starting subtest: pr-cursor-mmap-gtt
[347.691920] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[347.788018] [085/133] (674s left) kms_vblank (ts-continuation-idle-hang)
[347.881708] Starting subtest: ts-continuation-idle-hang
[347.883842] Starting dynamic subtest: pipe-A-eDP-1
[375.190435] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.303s)
[375.205651] Starting dynamic subtest: pipe-D-eDP-1
[390.164958] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s)
[390.167342] Subtest ts-continuation-idle-hang: SUCCESS (42.281s)
[390.978796] [086/133] (631s left) syncobj_wait (multi-wait-submitted-signaled)
[391.043125] Starting subtest: multi-wait-submitted-signaled
[391.045339] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[391.164486] [087/133] (630s left) kms_color (degamma)
[391.263472] Starting subtest: degamma
[391.265638] Starting dynamic subtest: pipe-A-eDP-1
[391.969461] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[391.979381] Starting dynamic subtest: pipe-B-eDP-1
[393.402112] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[393.411450] Starting dynamic subtest: pipe-C-eDP-1
[394.763872] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[394.774208] Starting dynamic subtest: pipe-D-eDP-1
[396.099091] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[396.101223] Subtest degamma: SUCCESS (4.835s)
[396.910131] [088/133] (625s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[396.971024] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[397.036759] [089/133] (625s left) kms_pm_rpm (cursor)
[398.551644] Starting subtest: cursor
[398.556967] Subtest cursor: SKIP (0.000s)
[399.358385] [090/133] (622s left) gem_exec_schedule (lateslice)
[399.442031] Starting subtest: lateslice
[399.444002] Starting dynamic subtest: rcs0
[399.457170] Dynamic subtest rcs0: SUCCESS (0.019s)
[399.467557] Starting dynamic subtest: bcs0
[399.474851] Dynamic subtest bcs0: SUCCESS (0.017s)
[399.483846] Starting dynamic subtest: vcs0
[399.491716] Dynamic subtest vcs0: SUCCESS (0.016s)
[399.502002] Starting dynamic subtest: vcs1
[399.508787] Dynamic subtest vcs1: SUCCESS (0.016s)
[399.517668] Starting dynamic subtest: vecs0
[399.525200] Dynamic subtest vecs0: SUCCESS (0.016s)
[399.534088] Starting dynamic subtest: ccs0
[399.542070] Dynamic subtest ccs0: SUCCESS (0.016s)
[399.544263] Subtest lateslice: SUCCESS (0.104s)
[401.524321] [091/133] (620s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[401.620265] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[401.624704] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[401.752257] [092/133] (620s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[401.867374] Starting subtest: x-tiled-8bpp-rotate-270
[401.890071] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[402.038099] [093/133] (620s left) gem_wait (await)
[402.109765] Starting subtest: await
[402.112127] Starting dynamic subtest: all-engines
[403.229942] Dynamic subtest all-engines: SUCCESS (1.119s)
[403.240274] Starting dynamic subtest: rcs0
[404.291796] Dynamic subtest rcs0: SUCCESS (1.060s)
[404.309069] Starting dynamic subtest: bcs0
[405.356877] Dynamic subtest bcs0: SUCCESS (1.063s)
[405.373636] Starting dynamic subtest: vcs0
[406.412124] Dynamic subtest vcs0: SUCCESS (1.053s)
[406.428605] Starting dynamic subtest: vcs1
[407.464857] Dynamic subtest vcs1: SUCCESS (1.050s)
[407.481748] Starting dynamic subtest: vecs0
[408.517813] Dynamic subtest vecs0: SUCCESS (1.051s)
[408.534473] Starting dynamic subtest: ccs0
[409.575707] Dynamic subtest ccs0: SUCCESS (1.056s)
[409.578154] Subtest await: SUCCESS (7.466s)
[409.790527] [094/133] (612s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[409.901012] Starting subtest: pr-overlay-plane-update-continuous-sf
[409.905306] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[409.980420] [095/133] (612s left) kms_cursor_crc (cursor-tearing-position-change)
[410.084336] Starting subtest: cursor-tearing-position-change
[410.086494] Starting dynamic subtest: pipe-A-eDP-1
[410.650637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[410.661208] Starting dynamic subtest: pipe-D-eDP-1
[411.849561] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.194s)
[411.851731] Subtest cursor-tearing-position-change: SUCCESS (1.762s)
[412.702199] [096/133] (609s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[412.804547] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[413.175330] Starting dynamic subtest: pipe-A-eDP-1
[415.944835] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.768s)
[416.316911] Starting dynamic subtest: pipe-B-eDP-1
[419.079048] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[419.441958] Starting dynamic subtest: pipe-C-eDP-1
[422.199974] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[422.565731] Starting dynamic subtest: pipe-D-eDP-1
[425.324229] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[425.326864] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.521s)
[426.531494] [097/133] (595s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[426.674212] Starting subtest: cursorB-vs-flipB-atomic-transitions
[426.678778] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[426.847231] [098/133] (595s left) perf_pmu (busy-accuracy-98)
[426.890393] Starting subtest: busy-accuracy-98
[426.892311] Starting dynamic subtest: rcs0
[429.927712] Dynamic subtest rcs0: SUCCESS (3.036s)
[429.938240] Starting dynamic subtest: bcs0
[433.026954] Dynamic subtest bcs0: SUCCESS (3.048s)
[433.036605] Starting dynamic subtest: vcs0
[436.073744] Dynamic subtest vcs0: SUCCESS (3.040s)
[436.086413] Starting dynamic subtest: vcs1
[439.117248] Dynamic subtest vcs1: SUCCESS (3.043s)
[439.127443] Starting dynamic subtest: vecs0
[442.162395] Dynamic subtest vecs0: SUCCESS (3.044s)
[442.171606] Starting dynamic subtest: ccs0
[445.206337] Dynamic subtest ccs0: SUCCESS (3.044s)
[445.208402] Subtest busy-accuracy-98: SUCCESS (18.272s)
[445.319842] [099/133] (577s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[445.430954] Starting subtest: yf-tiled-16bpp-rotate-270
[445.435175] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[445.547259] [100/133] (577s left) kms_prop_blob (invalid-set-prop)
[445.604353] Starting subtest: invalid-set-prop
[445.606770] Subtest invalid-set-prop: SUCCESS (0.000s)
[445.733768] [101/133] (576s left) gem_exec_params (cliprects-invalid)
[445.797392] Starting subtest: cliprects-invalid
[445.799626] Subtest cliprects-invalid: SUCCESS (0.000s)
[445.930808] [102/133] (576s left) sriov_basic (enable-vfs-bind-unbind-each)
[445.982338] Starting subtest: enable-vfs-bind-unbind-each
[445.984613] Starting dynamic subtest: numvfs-1
[446.057428] Dynamic subtest numvfs-1: FAIL (0.005s)
[446.068677] Starting dynamic subtest: numvfs-2
[446.142297] Dynamic subtest numvfs-2: FAIL (0.004s)
[446.153013] Starting dynamic subtest: numvfs-3
[446.216739] Dynamic subtest numvfs-3: FAIL (0.004s)
[446.226884] Starting dynamic subtest: numvfs-4
[446.285822] Dynamic subtest numvfs-4: FAIL (0.004s)
[446.297751] Starting dynamic subtest: numvfs-5
[446.364781] Dynamic subtest numvfs-5: FAIL (0.004s)
[446.373298] Starting dynamic subtest: numvfs-6
[446.432380] Dynamic subtest numvfs-6: FAIL (0.004s)
[446.443292] Starting dynamic subtest: numvfs-7
[446.501882] Dynamic subtest numvfs-7: FAIL (0.004s)
[446.511331] Starting dynamic subtest: numvfs-random
[446.570266] Dynamic subtest numvfs-random: FAIL (0.004s)
[446.572019] Subtest enable-vfs-bind-unbind-each: FAIL (0.036s)
[446.610072] [103/133] (576s left) gem_exec_flush (basic-uc-pro-default)
[446.669096] Starting subtest: basic-uc-pro-default
[452.163186] Subtest basic-uc-pro-default: SUCCESS (5.495s)
[452.361738] [104/133] (570s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[452.467847] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[452.472148] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[452.593373] [105/133] (570s left) kms_pipe_crc_basic (bad-source)
[452.698722] Starting subtest: bad-source
[452.700935] Subtest bad-source: SUCCESS (0.000s)
[452.798896] [106/133] (570s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[452.894836] Starting subtest: plane-primary-toggle-with-vblank-wait
[452.897146] Starting dynamic subtest: pipe-A-eDP-1
[453.067739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[453.375527] Starting dynamic subtest: pipe-B-eDP-1
[454.310787] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.946s)
[454.611309] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.717s)
[455.473500] [107/133] (567s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[455.567795] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[455.570208] Starting dynamic subtest: pipe-A-eDP-1
[455.593831] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[455.605670] Starting dynamic subtest: pipe-B-eDP-1
[455.627230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[455.636302] Starting dynamic subtest: pipe-C-eDP-1
[455.657382] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[455.666274] Starting dynamic subtest: pipe-D-eDP-1
[455.688603] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[455.693186] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[457.817942] [108/133] (565s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[457.921223] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[464.806386] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.890s)
[464.946422] [109/133] (558s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[465.060322] Starting subtest: y-tiled-16bpp-rotate-270
[465.064975] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[465.195211] [110/133] (557s left) syncobj_eventfd (invalid-bad-pad)
[465.255494] Starting subtest: invalid-bad-pad
[465.257758] Subtest invalid-bad-pad: SUCCESS (0.000s)
[465.401068] [111/133] (557s left) gem_exec_params (larger-than-life-batch)
[465.477005] Starting subtest: larger-than-life-batch
[467.730603] Subtest larger-than-life-batch: SUCCESS (2.254s)
[468.492240] [112/133] (554s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[468.646733] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[468.650690] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[468.774988] [113/133] (554s left) kms_psr (psr-cursor-mmap-cpu)
[468.867697] Starting subtest: psr-cursor-mmap-cpu
[468.869963] Starting dynamic subtest: eDP-1
[470.542837] Dynamic subtest eDP-1: SUCCESS (1.676s)
[470.545191] Subtest psr-cursor-mmap-cpu: SUCCESS (1.678s)
[471.419291] [114/133] (551s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[471.522515] Starting subtest: yf-tiled-64bpp-rotate-90
[471.526911] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[471.645246] [115/133] (551s left) gem_workarounds (suspend-resume)
[471.703514] Starting subtest: suspend-resume
[487.428841] Subtest suspend-resume: SUCCESS (1.185s)
[487.592486] [116/133] (535s left) gem_ctx_persistence (smoketest)
[487.660996] Starting subtest: smoketest
[527.860917] Subtest smoketest: SUCCESS (40.193s)
[527.952622] [117/133] (495s left) kms_flip (2x-flip-vs-suspend)
[528.059766] Starting subtest: 2x-flip-vs-suspend
[528.070927] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[528.161480] [118/133] (495s left) gem_exec_reloc (basic-gtt-cpu)
[528.222550] Subtest basic-gtt-cpu: SKIP (0.000s)
[528.316199] [119/133] (495s left) i915_drm_fdinfo (all-busy-idle-check-all)
[528.364398] Starting subtest: all-busy-idle-check-all
[528.371747] Subtest all-busy-idle-check-all: SKIP (0.005s)
[528.453840] [120/133] (494s left) core_auth (getclient-master-drop)
[528.485020] Starting subtest: getclient-master-drop
[528.535819] Subtest getclient-master-drop: SUCCESS (0.051s)
[528.672767] [121/133] (494s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[528.773436] Starting subtest: fbc-psr2-cursor-plane-onoff
[528.775740] Starting dynamic subtest: eDP-1
[528.779748] Dynamic subtest eDP-1: SKIP (0.000s)
[528.783789] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[528.861633] [122/133] (494s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[528.965591] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[528.968979] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[529.097393] [123/133] (494s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[529.201450] Starting subtest: primary-4-tiled-reflect-x-180
[536.398984] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.199s)
[537.598210] [124/133] (485s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[537.702910] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[537.707267] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[537.830950] [125/133] (485s left) gem_mmap_wc (set-cache-level)
[537.886785] Subtest set-cache-level: SKIP (0.000s)
[537.956283] [126/133] (485s left) prime_mmap_coherency (write)
[538.012386] Starting subtest: write
[543.442677] Subtest write: SUCCESS (5.375s)
[543.573429] [127/133] (480s left) i915_hangman (engine-engine-hang)
[543.654269] Starting subtest: engine-engine-hang
[543.656455] Starting dynamic subtest: rcs0
[544.951095] Dynamic subtest rcs0: SUCCESS (1.296s)
[544.963400] Starting dynamic subtest: bcs0
[546.931454] Dynamic subtest bcs0: SUCCESS (1.979s)
[546.943694] Starting dynamic subtest: vcs0
[548.852583] Dynamic subtest vcs0: SUCCESS (1.917s)
[548.866104] Starting dynamic subtest: vcs1
[549.941097] Dynamic subtest vcs1: SUCCESS (1.085s)
[549.953784] Starting dynamic subtest: vecs0
[551.925181] Dynamic subtest vecs0: SUCCESS (1.981s)
[551.938125] Starting dynamic subtest: ccs0
[553.908834] Dynamic subtest ccs0: SUCCESS (1.981s)
[553.912122] Subtest engine-engine-hang: SUCCESS (10.257s)
[554.003966] [128/133] (469s left) gem_softpin (overlap)
[554.081242] Starting subtest: overlap
[554.914425] Subtest overlap: SUCCESS (0.832s)
[555.061021] [129/133] (468s left) kms_sequence (get-forked)
[555.174460] Starting subtest: get-forked
[555.176801] Starting dynamic subtest: pipe-A-eDP-1
[557.046766] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.871s)
[557.057732] Starting dynamic subtest: pipe-B-eDP-1
[559.610600] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.564s)
[559.621110] Starting dynamic subtest: pipe-C-eDP-1
[562.121454] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.507s)
[562.132302] Starting dynamic subtest: pipe-D-eDP-1
[564.644453] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[564.646897] Subtest get-forked: SUCCESS (9.472s)
[565.508888] [130/133] (458s left) kms_content_protection (uevent)
[565.667708] Starting subtest: uevent
[565.672111] Subtest uevent: SKIP (0.000s)
[565.825651] [131/133] (458s left) gem_ctx_create (basic)
[565.890152] Starting subtest: basic
[565.892587] Subtest basic: SUCCESS (0.000s)
[566.086941] [132/133] (457s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[566.214868] Starting subtest: protected-encrypted-src-copy-not-readible
[566.327013] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[566.482781] [133/133] (457s left) gem_ppgtt (blt-vs-render-ctxn)
[566.543364] Starting subtest: blt-vs-render-ctxN
[599.397492] Subtest blt-vs-render-ctxN: SUCCESS (32.852s)
[599.561827] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_rmfb
results: parsing output: 6/ for test: gem_spin_batch
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_dsc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: gem_ctx_isolation
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: gem_ctx_engines
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_pipe_crc_basic
results: parsing output: 26/ for test: kms_invalid_mode
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_params
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_ccs
results: parsing output: 35/ for test: gem_ctx_bad_destroy
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: vgem_slow
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: prime_udl
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_lease
results: parsing output: 44/ for test: gen3_render_tiledy_blits
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_ctx_shared
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: i915_pm_rps
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_mmap
results: parsing output: 55/ for test: gem_partial_pwrite_pread
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: device_reset
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: api_intel_allocator
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_chamelium_edid
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: gem_pwrite
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: i915_suspend
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_plane_multiple
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf_pmu
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_color
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_wait
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_async_flips
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_prop_blob
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: sriov_basic
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_eventfd
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_workarounds
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: i915_drm_fdinfo
results: parsing output: 119/ for test: core_auth
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: prime_mmap_coherency
results: parsing output: 126/ for test: i915_hangman
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_sequence
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: gem_ctx_create
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: gem_ppgtt
Done.