[57.606433] Initializing watchdogs
[57.606480]   /dev/watchdog0
[57.621357] [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.625823] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.628131] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.631657] [001/134] (960s left) gem_ctx_persistence (engines-cleanup)
[57.712578] Starting subtest: engines-cleanup
[57.714990] Starting dynamic subtest: rcs0
[57.793840] Dynamic subtest rcs0: SUCCESS (0.081s)
[57.803349] Starting dynamic subtest: bcs0
[57.875259] Dynamic subtest bcs0: SUCCESS (0.080s)
[57.883486] Starting dynamic subtest: vcs0
[57.946099] Dynamic subtest vcs0: SUCCESS (0.070s)
[57.955718] Starting dynamic subtest: vcs1
[57.998552] Dynamic subtest vcs1: SUCCESS (0.052s)
[58.008119] Starting dynamic subtest: vecs0
[58.052960] Dynamic subtest vecs0: SUCCESS (0.053s)
[58.062512] Starting dynamic subtest: ccs0
[58.110899] Dynamic subtest ccs0: SUCCESS (0.057s)
[58.113667] Subtest engines-cleanup: SUCCESS (0.399s)
[58.201213] [002/134] (959s left) gem_exec_reloc (basic-write-gtt-noreloc)
[58.256456] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[58.338890] [003/134] (959s left) gem_eio (in-flight-1us)
[58.505527] Starting subtest: in-flight-1us
[65.770193] Subtest in-flight-1us: SUCCESS (7.265s)
[65.972399] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[65.975072] [004/134] (952s left) api_intel_allocator (reopen-fork)
[66.033571] Starting subtest: reopen-fork
[69.622883] Subtest reopen-fork: SUCCESS (3.590s)
[69.721646] [005/134] (948s left) kms_plane_scaling (planes-upscale-20x20)
[69.820920] Starting subtest: planes-upscale-20x20
[69.823202] Starting dynamic subtest: pipe-A
[69.904270] Dynamic subtest pipe-A: SUCCESS (0.086s)
[69.914642] Starting dynamic subtest: pipe-B
[71.040072] Dynamic subtest pipe-B: SUCCESS (1.135s)
[71.052562] Starting dynamic subtest: pipe-C
[72.145788] Dynamic subtest pipe-C: SUCCESS (1.105s)
[72.155637] Starting dynamic subtest: pipe-D
[73.278789] Dynamic subtest pipe-D: SUCCESS (1.133s)
[73.281192] Subtest planes-upscale-20x20: SUCCESS (3.462s)
[74.466125] [006/134] (943s left) kms_vblank (invalid)
[74.561871] Starting subtest: invalid
[74.563980] Starting dynamic subtest: pipe-A-eDP-1
[74.959390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[74.961369] Subtest invalid: SUCCESS (0.398s)
[75.787521] [007/134] (942s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[75.845710] Starting subtest: invalid-multi-wait-unsubmitted
[75.847595] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[75.990258] [008/134] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[76.093860] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[76.098155] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[76.214560] [009/134] (942s left) gem_pread (self)
[76.287363] Subtest self: SKIP (0.000s)
[76.354398] [010/134] (942s left) gem_mmap (bad-object)
[76.426141] Subtest bad-object: SKIP (0.000s)
[76.494717] [011/134] (942s left) gem_tiled_fence_blits (basic)
[76.561446] Subtest basic: SKIP (0.000s)
[76.649477] [012/134] (941s left) syncobj_timeline (single-wait-all-available-signaled)
[76.714467] Starting subtest: single-wait-all-available-signaled
[76.716434] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[76.838971] [013/134] (941s left) kms_atomic (plane-invalid-params)
[76.922957] Starting subtest: plane-invalid-params
[76.924952] Starting dynamic subtest: pipe-A-eDP-1
[77.348567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[77.350991] Subtest plane-invalid-params: SUCCESS (0.424s)
[78.227189] [014/134] (940s left) syncobj_timeline (wait-all-interrupted)
[78.290525] Starting subtest: wait-all-interrupted
[78.394427] Subtest wait-all-interrupted: SUCCESS (0.102s)
[78.477972] [015/134] (940s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[78.589501] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[78.593828] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[78.705566] [016/134] (940s left) gem_create (create-clear)
[78.770729] Starting subtest: create-clear
[78.772747] Starting dynamic subtest: smem0
[111.766502] Dynamic subtest smem0: SUCCESS (32.993s)
[111.768668] Subtest create-clear: SUCCESS (32.994s)
[111.966361] [017/134] (906s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[112.077559] Starting subtest: primary-x-tiled-reflect-x-0
[119.389461] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.312s)
[120.591164] [018/134] (898s left) kms_cursor_crc (cursor-onscreen-max-size)
[120.912920] Starting subtest: cursor-onscreen-max-size
[120.919763] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[121.071236] [019/134] (897s left) kms_invalid_mode (bad-vtotal)
[121.179032] Starting subtest: bad-vtotal
[121.181544] Starting dynamic subtest: pipe-A-eDP-1
[121.462124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[121.470747] Starting dynamic subtest: pipe-B-eDP-1
[121.472699] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[121.480057] Starting dynamic subtest: pipe-C-eDP-1
[121.482389] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[121.489857] Starting dynamic subtest: pipe-D-eDP-1
[121.492149] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[121.494366] Subtest bad-vtotal: SUCCESS (0.288s)
[122.319460] [020/134] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[122.429765] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[122.434251] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[122.544376] [021/134] (896s left) gem_mmap_offset (clear)
[122.591712] Starting subtest: clear
[122.595279] Starting dynamic subtest: smem0
[148.148597] Dynamic subtest smem0: SUCCESS (25.551s)
[148.151119] Subtest clear: SUCCESS (25.552s)
[148.305549] [022/134] (870s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[148.523447] Starting subtest: cursor-rapid-movement-32x10
[148.574873] Subtest cursor-rapid-movement-32x10: SKIP (0.045s)
[148.892511] [023/134] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[148.993623] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[148.998148] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[149.132145] [024/134] (869s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[149.234038] Starting subtest: fbcpsr-suspend
[189.875630] Subtest fbcpsr-suspend: SUCCESS (10.985s)
[195.024512] [025/134] (829s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[195.177028] Starting subtest: 2x-cursor-vs-flip-atomic
[195.181556] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[195.338911] [026/134] (828s left) kms_big_fb (linear-16bpp-rotate-0)
[195.445125] Starting subtest: linear-16bpp-rotate-0
[196.847333] Subtest linear-16bpp-rotate-0: SUCCESS (1.403s)
[197.021634] [027/134] (827s left) syncobj_wait (multi-wait-all-signaled)
[197.084966] Starting subtest: multi-wait-all-signaled
[197.086775] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[197.197951] [028/134] (827s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[197.300880] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[197.302667] Starting dynamic subtest: pipe-A-default-mode
[200.028474] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s)
[200.030514] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.724s)
[200.872439] [029/134] (823s left) gem_eio (create-ext)
[201.122080] Starting subtest: create-ext
[201.465805] Subtest create-ext: SUCCESS (0.342s)
[201.590881] [030/134] (822s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[201.685661] Starting subtest: yf-tiled-32bpp-rotate-0
[201.689829] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[201.804038] [031/134] (822s left) gem_eio (wait-1us)
[202.037156] Starting subtest: wait-1us
[202.394931] Subtest wait-1us: SUCCESS (0.360s)
[202.569514] [032/134] (821s left) kms_pm_rpm (modeset-lpsp-stress)
[204.719780] Starting subtest: modeset-lpsp-stress
[220.945415] Subtest modeset-lpsp-stress: SUCCESS (16.217s)
[221.045928] [033/134] (803s left) prime_mmap_kms (buffer-sharing)
[221.140458] Starting subtest: buffer-sharing
[221.584512] Subtest buffer-sharing: SUCCESS (0.444s)
[222.450153] [034/134] (802s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[222.547684] Starting subtest: fbc-rgb565-draw-mmap-cpu
[226.597175] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.054s)
[227.740144] [035/134] (796s left) kms_rotation_crc (primary-rotation-90)
[227.843654] Starting subtest: primary-rotation-90
[227.847682] Subtest primary-rotation-90: SKIP (0.001s)
[227.926164] [036/134] (796s left) perf_pmu (render-node-busy-idle)
[228.012683] Starting subtest: render-node-busy-idle
[228.015159] Starting dynamic subtest: rcs0
[228.728440] Dynamic subtest rcs0: SUCCESS (0.715s)
[228.740630] Starting dynamic subtest: bcs0
[229.401464] Dynamic subtest bcs0: SUCCESS (0.671s)
[229.413247] Starting dynamic subtest: vcs0
[230.576557] Dynamic subtest vcs0: SUCCESS (1.172s)
[230.587578] Starting dynamic subtest: vcs1
[232.561473] Dynamic subtest vcs1: SUCCESS (1.982s)
[232.577897] Starting dynamic subtest: vecs0
[234.545253] Dynamic subtest vecs0: SUCCESS (1.981s)
[234.557298] Starting dynamic subtest: ccs0
[235.218977] Dynamic subtest ccs0: SUCCESS (0.673s)
[235.221438] Subtest render-node-busy-idle: SUCCESS (7.206s)
[235.308772] [037/134] (789s left) sysfs_preempt_timeout (idempotent)
[235.379371] Starting subtest: idempotent
[235.381691] Starting dynamic subtest: vecs0
[235.384501] Dynamic subtest vecs0: SUCCESS (0.000s)
[235.396132] Starting dynamic subtest: ccs0
[235.397983] Dynamic subtest ccs0: SUCCESS (0.000s)
[235.406936] Starting dynamic subtest: vcs0
[235.408796] Dynamic subtest vcs0: SUCCESS (0.000s)
[235.417975] Starting dynamic subtest: bcs0
[235.419885] Dynamic subtest bcs0: SUCCESS (0.000s)
[235.429166] Starting dynamic subtest: rcs0
[235.431354] Dynamic subtest rcs0: SUCCESS (0.000s)
[235.440452] Starting dynamic subtest: vcs1
[235.442272] Dynamic subtest vcs1: SUCCESS (0.000s)
[235.444064] Subtest idempotent: SUCCESS (0.006s)
[235.518030] [038/134] (789s left) gem_exec_schedule (semaphore-power)
[235.715492] Subtest semaphore-power: SKIP (0.000s)
[235.913712] [039/134] (788s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[236.013785] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[236.016082] Starting dynamic subtest: pipe-A-eDP-1
[236.074792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[236.088650] Starting dynamic subtest: pipe-B-eDP-1
[236.139291] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.063s)
[236.149192] Starting dynamic subtest: pipe-C-eDP-1
[236.203919] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[236.213906] Starting dynamic subtest: pipe-D-eDP-1
[236.262764] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[236.265072] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.252s)
[238.523246] [040/134] (786s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[243.596251] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[243.598570] Starting dynamic subtest: pipe-A-eDP-1
[244.394747] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s)
[244.404524] Starting dynamic subtest: pipe-B-eDP-1
[245.535728] Dynamic subtest pipe-B-eDP-1: SKIP (1.139s)
[245.540265] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.939s)
[246.732306] [041/134] (778s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[246.826923] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[246.829196] Starting dynamic subtest: pipe-A-default-mode
[247.118212] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[247.122905] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.289s)
[247.964313] [042/134] (776s left) gem_exec_params (cliprects_ptr-dirt)
[248.025616] Starting subtest: cliprects_ptr-dirt
[248.027997] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[248.151379] [043/134] (776s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[248.258899] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[248.263506] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[248.392981] [044/134] (776s left) gem_wait (await)
[248.469432] Starting subtest: await
[248.471769] Starting dynamic subtest: all-engines
[249.616412] Dynamic subtest all-engines: SUCCESS (1.146s)
[249.632934] Starting dynamic subtest: rcs0
[250.675645] Dynamic subtest rcs0: SUCCESS (1.057s)
[250.692316] Starting dynamic subtest: bcs0
[251.740133] Dynamic subtest bcs0: SUCCESS (1.062s)
[251.757058] Starting dynamic subtest: vcs0
[252.793171] Dynamic subtest vcs0: SUCCESS (1.051s)
[252.810895] Starting dynamic subtest: vcs1
[253.847036] Dynamic subtest vcs1: SUCCESS (1.052s)
[253.865224] Starting dynamic subtest: vecs0
[254.901172] Dynamic subtest vecs0: SUCCESS (1.052s)
[254.918224] Starting dynamic subtest: ccs0
[255.958579] Dynamic subtest ccs0: SUCCESS (1.055s)
[255.961048] Subtest await: SUCCESS (7.489s)
[256.174259] [045/134] (768s left) gem_pxp (fail-invalid-protected-context)
[256.295630] Starting subtest: fail-invalid-protected-context
[256.298095] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[256.415688] [046/134] (768s left) gen9_exec_parse (bb-start-far)
[256.488161] Subtest bb-start-far: SKIP (0.000s)
[256.587913] [047/134] (768s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[256.695967] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[256.700512] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[257.807809] [048/134] (767s left) kms_psr (pr-dpms)
[257.924333] Starting subtest: pr-dpms
[257.928298] Subtest pr-dpms: SKIP (0.000s)
[258.012377] [049/134] (767s left) gem_userptr_blits (create-destroy-unsync)
[258.087831] Subtest create-destroy-unsync: SKIP (0.000s)
[258.245541] [050/134] (766s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[258.331664] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[258.358734] Starting dynamic subtest: pipe-A-plane-0
[258.363247] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[258.374879] Starting dynamic subtest: pipe-A-plane-3
[258.379122] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[258.388592] Starting dynamic subtest: pipe-A-plane-5
[258.393427] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[259.483225] Starting dynamic subtest: pipe-B-plane-0
[259.487516] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[259.499024] Starting dynamic subtest: pipe-B-plane-3
[259.503060] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[259.512563] Starting dynamic subtest: pipe-B-plane-5
[259.517069] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[259.786775] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (1.454s)
[260.664578] [051/134] (764s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[260.769957] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[261.959997] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.190s)
[262.121435] [052/134] (763s left) gem_exec_balancer (bonded-chain)
[262.188309] Starting subtest: bonded-chain
[269.178519] Subtest bonded-chain: SUCCESS (6.987s)
[269.537283] [053/134] (755s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[269.637827] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[269.640152] Starting dynamic subtest: pipe-A
[269.660339] Dynamic subtest pipe-A: SKIP (0.017s)
[269.670593] Starting dynamic subtest: pipe-B
[269.692915] Dynamic subtest pipe-B: SKIP (0.031s)
[269.702785] Starting dynamic subtest: pipe-C
[269.722070] Dynamic subtest pipe-C: SKIP (0.031s)
[269.731525] Starting dynamic subtest: pipe-D
[269.753796] Dynamic subtest pipe-D: SKIP (0.031s)
[269.758197] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.113s)
[269.892373] [054/134] (755s left) kms_dp_link_training (uhbr-mst)
[269.994265] Starting subtest: uhbr-mst
[270.003319] Subtest uhbr-mst: SKIP (0.000s)
[270.077810] [055/134] (755s left) kms_psr (psr2-suspend)
[270.181781] Starting subtest: psr2-suspend
[270.183972] Starting dynamic subtest: eDP-1
[288.633451] Dynamic subtest eDP-1: SUCCESS (3.314s)
[288.635762] Subtest psr2-suspend: SUCCESS (3.315s)
[293.538053] [056/134] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[293.648481] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[293.652830] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[293.775175] [057/134] (735s left) gem_mmap_gtt (big-copy)
[293.845310] Subtest big-copy: SKIP (0.000s)
[293.914271] [058/134] (735s left) kms_lease (lease-unleased-crtc)
[294.022355] Starting subtest: lease-unleased-crtc
[294.024699] Starting dynamic subtest: pipe-A-eDP-1
[294.309089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[294.320342] Starting dynamic subtest: pipe-B-eDP-1
[295.059268] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.746s)
[295.069059] Starting dynamic subtest: pipe-C-eDP-1
[295.071311] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[295.080968] Starting dynamic subtest: pipe-D-eDP-1
[295.083257] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[295.085408] Subtest lease-unleased-crtc: SUCCESS (1.052s)
[295.454377] [059/134] (734s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[295.559235] Starting subtest: psr-rgb101010-draw-mmap-wc
[302.633255] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.072s)
[302.784652] [060/134] (726s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[302.848904] Starting subtest: yf-tiled-to-vebox-y-tiled
[302.853298] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[303.063128] [061/134] (726s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[303.170953] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[303.174948] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[303.294278] [062/134] (726s left) kms_async_flips (alternate-sync-async-flip-atomic)
[303.387234] Starting subtest: alternate-sync-async-flip-atomic
[303.760850] Starting dynamic subtest: pipe-A-eDP-1
[306.532033] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.772s)
[306.931836] Starting dynamic subtest: pipe-B-eDP-1
[309.667280] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.744s)
[310.052608] Starting dynamic subtest: pipe-C-eDP-1
[312.805297] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[313.169070] Starting dynamic subtest: pipe-D-eDP-1
[315.937654] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[315.939746] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.550s)
[317.123808] [063/134] (712s left) perf (polling-small-buf)
[317.275224] Starting subtest: polling-small-buf
[317.367905] Subtest polling-small-buf: SUCCESS (0.091s)
[317.416217] [064/134] (712s left) kms_cursor_crc (cursor-sliding-32x32)
[317.568853] Starting subtest: cursor-sliding-32x32
[317.615773] Subtest cursor-sliding-32x32: SKIP (0.042s)
[317.927717] [065/134] (711s left) kms_setmode (clone-exclusive-crtc)
[317.991766] Starting subtest: clone-exclusive-crtc
[317.998402] Subtest clone-exclusive-crtc: SKIP (0.000s)
[318.119841] [066/134] (711s left) kms_psr (fbc-pr-cursor-render)
[318.211542] Starting subtest: fbc-pr-cursor-render
[318.214959] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[318.299822] [067/134] (711s left) perf_pmu (frequency)
[318.337170] Starting subtest: frequency
[318.340897] Starting dynamic subtest: gt0
[320.522936] Dynamic subtest gt0: SUCCESS (2.177s)
[320.535232] Starting dynamic subtest: idle-gt0
[321.028583] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[321.040918] Starting dynamic subtest: gt1
[325.741947] Dynamic subtest gt1: SUCCESS (4.707s)
[325.753933] Starting dynamic subtest: idle-gt1
[326.247434] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[326.250244] Subtest frequency: SUCCESS (7.910s)
[326.387257] [068/134] (703s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[326.506114] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[327.119243] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.614s)
[327.320569] [069/134] (702s left) gem_lmem_swapping (random-engines)
[327.365025] Subtest random-engines: SKIP (0.000s)
[327.412078] [070/134] (702s left) gem_exec_gttfill (engines)
[327.481260] Starting subtest: engines
[327.483612] Starting dynamic subtest: rcs0
[350.156938] Dynamic subtest rcs0: SUCCESS (22.670s)
[350.169858] Starting dynamic subtest: bcs0
[373.407556] Dynamic subtest bcs0: SUCCESS (23.244s)
[373.418349] Starting dynamic subtest: vcs0
[396.723062] Dynamic subtest vcs0: SUCCESS (23.311s)
[396.735366] Starting dynamic subtest: vcs1
[420.016488] Dynamic subtest vcs1: SUCCESS (23.293s)
[420.028048] Starting dynamic subtest: vecs0
[443.290721] Dynamic subtest vecs0: SUCCESS (23.271s)
[443.301508] Starting dynamic subtest: ccs0
[466.587585] Dynamic subtest ccs0: SUCCESS (23.292s)
[466.590051] Subtest engines: SUCCESS (139.094s)
[466.788601] [071/134] (563s left) kms_flip (2x-blocking-absolute-wf_vblank)
[466.939007] Starting subtest: 2x-blocking-absolute-wf_vblank
[466.948424] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[467.041753] [072/134] (563s left) kms_hdmi_inject (inject-audio)
[467.387440] Starting subtest: inject-audio
[467.668514] Subtest inject-audio: SUCCESS (0.283s)
[468.279089] [073/134] (561s left) gem_exec_flush (basic-uc-set-default)
[468.343757] Starting subtest: basic-uc-set-default
[473.798392] Subtest basic-uc-set-default: SUCCESS (5.456s)
[473.998606] [074/134] (556s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[474.100629] Starting subtest: stress-xrgb8888-4tiled
[480.054148] Subtest stress-xrgb8888-4tiled: SUCCESS (5.953s)
[480.108713] [075/134] (550s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[480.504485] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[481.313134] [076/134] (549s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[486.328379] Starting subtest: fbc-pr-cursor-plane-update-sf
[486.333067] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[487.151633] [077/134] (543s left) kms_flip (plain-flip-interruptible)
[487.257687] Starting subtest: plain-flip-interruptible
[487.260050] Starting dynamic subtest: A-eDP1
[488.907752] Dynamic subtest A-eDP1: SUCCESS (1.648s)
[488.919581] Starting dynamic subtest: B-eDP1
[490.522793] Dynamic subtest B-eDP1: SUCCESS (1.613s)
[490.535283] Starting dynamic subtest: C-eDP1
[492.187255] Dynamic subtest C-eDP1: SUCCESS (1.662s)
[492.198748] Starting dynamic subtest: D-eDP1
[493.792580] Dynamic subtest D-eDP1: SUCCESS (1.604s)
[493.798794] Subtest plain-flip-interruptible: SUCCESS (6.540s)
[495.066362] [078/134] (535s left) kms_content_protection (atomic)
[495.234861] Starting subtest: atomic
[495.238964] Subtest atomic: SKIP (0.000s)
[495.402740] [079/134] (535s left) i915_pm_rps (thresholds-park)
[495.472609] Starting subtest: thresholds-park
[495.476984] Subtest thresholds-park: SKIP (0.000s)
[495.610444] [080/134] (534s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[495.721054] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[495.723304] Starting dynamic subtest: pipe-A-eDP-1
[495.745201] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[495.755800] Starting dynamic subtest: pipe-B-eDP-1
[495.775643] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[495.785072] Starting dynamic subtest: pipe-C-eDP-1
[495.805392] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[495.814659] Starting dynamic subtest: pipe-D-eDP-1
[495.835630] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[495.839777] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[497.943741] [081/134] (532s left) kms_atomic_transition (plane-all-transition-fencing)
[498.037675] Starting subtest: plane-all-transition-fencing
[498.040034] Starting dynamic subtest: pipe-A-eDP-1
[500.545335] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.508s)
[500.867604] Starting dynamic subtest: pipe-B-eDP-1
[504.138017] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.285s)
[504.449436] Subtest plane-all-transition-fencing: SUCCESS (6.410s)
[505.249835] [082/134] (525s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[505.348056] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[505.350376] Starting dynamic subtest: pipe-A-eDP-1
[505.629239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.250s)
[505.640275] Starting dynamic subtest: pipe-B-eDP-1
[506.901657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.270s)
[506.912347] Starting dynamic subtest: pipe-C-eDP-1
[508.155979] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.252s)
[508.167454] Starting dynamic subtest: pipe-D-eDP-1
[509.346156] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.191s)
[509.348232] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.968s)
[510.563878] [083/134] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[510.669289] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[510.673261] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[510.806978] [084/134] (519s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[510.911632] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[518.548445] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.638s)
[518.674831] [085/134] (512s left) gem_lmem_swapping (heavy-verify-random-ccs)
[518.721979] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[518.778438] [086/134] (511s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[518.900749] Starting subtest: flip-vs-cursor-atomic
[525.966965] Subtest flip-vs-cursor-atomic: SUCCESS (7.069s)
[526.848443] [087/134] (503s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[526.947807] Starting subtest: y-tiled-64bpp-rotate-180
[526.952082] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[527.078592] [088/134] (503s left) gem_spin_batch (resubmit)
[527.162951] Starting subtest: resubmit
[527.165836] Starting dynamic subtest: rcs0
[527.171711] Dynamic subtest rcs0: SUCCESS (0.006s)
[527.182867] Starting dynamic subtest: bcs0
[527.185064] Dynamic subtest bcs0: SUCCESS (0.002s)
[527.195029] Starting dynamic subtest: vcs0
[527.197257] Dynamic subtest vcs0: SUCCESS (0.003s)
[527.206876] Starting dynamic subtest: vcs1
[527.209080] Dynamic subtest vcs1: SUCCESS (0.003s)
[527.218887] Starting dynamic subtest: vecs0
[527.221244] Dynamic subtest vecs0: SUCCESS (0.003s)
[527.232988] Starting dynamic subtest: ccs0
[527.235252] Dynamic subtest ccs0: SUCCESS (0.002s)
[527.237639] Subtest resubmit: SUCCESS (0.024s)
[527.453147] [089/134] (503s left) kms_psr (fbc-psr-sprite-blt)
[527.558015] Starting subtest: fbc-psr-sprite-blt
[527.560269] Starting dynamic subtest: eDP-1
[527.564592] Dynamic subtest eDP-1: SKIP (0.000s)
[527.568859] Subtest fbc-psr-sprite-blt: SKIP (0.002s)
[527.646518] [090/134] (503s left) fbdev (read)
[527.684748] Starting subtest: read
[528.214865] Subtest read: SUCCESS (0.528s)
[528.291589] [091/134] (502s left) gem_ctx_persistence (heartbeat-close)
[528.351445] Starting subtest: heartbeat-close
[528.356114] Subtest heartbeat-close: SKIP (0.000s)
[528.461878] [092/134] (502s left) gem_ctx_param (root-set)
[528.525612] Starting subtest: root-set
[528.528154] Subtest root-set: SUCCESS (0.001s)
[528.642261] [093/134] (502s left) kms_scaling_modes (scaling-mode-center)
[528.752756] Starting subtest: scaling-mode-center
[528.755077] Starting dynamic subtest: pipe-A-eDP-1
[528.851818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.100s)
[528.869561] Starting dynamic subtest: pipe-B-eDP-1
[530.029076] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.175s)
[530.040072] Starting dynamic subtest: pipe-C-eDP-1
[531.214752] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s)
[531.225067] Starting dynamic subtest: pipe-D-eDP-1
[532.407869] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s)
[532.410259] Subtest scaling-mode-center: SUCCESS (3.658s)
[533.644985] [094/134] (497s left) kms_flip (wf_vblank-ts-check-interruptible)
[533.757373] Starting subtest: wf_vblank-ts-check-interruptible
[533.759674] Starting dynamic subtest: A-eDP1
[542.639626] Dynamic subtest A-eDP1: SUCCESS (8.881s)
[542.652146] Starting dynamic subtest: B-eDP1
[551.545249] Dynamic subtest B-eDP1: SUCCESS (8.905s)
[551.557400] Starting dynamic subtest: C-eDP1
[560.427030] Dynamic subtest C-eDP1: SUCCESS (8.880s)
[560.437171] Starting dynamic subtest: D-eDP1
[569.325368] Dynamic subtest D-eDP1: SUCCESS (8.897s)
[569.327678] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.572s)
[570.532873] [095/134] (460s left) dmabuf (all-tests)
[570.572914] Starting subtest: all-tests
[570.575250] Starting dynamic subtest: sanitycheck
[570.786757] Dynamic subtest sanitycheck: SUCCESS (0.212s)
[570.799825] Starting dynamic subtest: dma_fence
[571.076785] Dynamic subtest dma_fence: SUCCESS (0.288s)
[571.091002] Starting dynamic subtest: dma_fence_chain
[579.603085] Dynamic subtest dma_fence_chain: SUCCESS (8.523s)
[579.615543] Starting dynamic subtest: dma_fence_unwrap
[579.743675] Dynamic subtest dma_fence_unwrap: SUCCESS (0.139s)
[579.756464] Starting dynamic subtest: dma_resv
[579.873769] Dynamic subtest dma_resv: SUCCESS (0.128s)
[579.876530] Subtest all-tests: SUCCESS (9.301s)
[579.954426] [096/134] (451s left) kms_chamelium_hpd (dp-hpd)
[580.346346] Subtest dp-hpd: SKIP (0.000s)
[581.205776] [097/134] (450s left) kms_flip (2x-flip-vs-dpms-on-nop)
[581.307451] Starting subtest: 2x-flip-vs-dpms-on-nop
[581.319376] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[581.470579] [098/134] (449s left) gem_exec_capture (capture)
[581.533254] Starting subtest: capture
[581.535583] Starting dynamic subtest: rcs0-smem
[582.371780] Dynamic subtest rcs0-smem: SUCCESS (0.838s)
[582.382967] Starting dynamic subtest: bcs0-smem
[583.696912] Dynamic subtest bcs0-smem: SUCCESS (1.324s)
[583.706506] Starting dynamic subtest: vcs0-smem
[584.526610] Dynamic subtest vcs0-smem: SUCCESS (0.829s)
[584.536266] Starting dynamic subtest: vcs1-smem
[585.355589] Dynamic subtest vcs1-smem: SUCCESS (0.829s)
[585.366238] Starting dynamic subtest: vecs0-smem
[586.754677] Dynamic subtest vecs0-smem: FAIL (1.340s)
[586.765058] Starting dynamic subtest: ccs0-smem
[588.017596] Dynamic subtest ccs0-smem: SUCCESS (1.321s)
[588.020040] Subtest capture: FAIL (6.485s)
[588.176726] [099/134] (443s left) perf (enable-disable)
[588.304595] Starting subtest: enable-disable
[588.307004] Starting dynamic subtest: 0-rcs0
[590.603268] Dynamic subtest 0-rcs0: SUCCESS (2.297s)
[590.615219] Starting dynamic subtest: 1-vcs1
[595.111296] Dynamic subtest 1-vcs1: SUCCESS (4.507s)
[595.114210] Subtest enable-disable: SUCCESS (6.806s)
[595.155916] [100/134] (436s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[595.265228] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[599.530488] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.268s)
[600.743709] [101/134] (430s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[600.852682] Starting subtest: fbcpsr-abgr161616f-draw-render
[600.856930] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[600.979894] [102/134] (430s left) i915_drm_fdinfo (virtual-busy-idle)
[601.026388] Starting subtest: virtual-busy-idle
[601.030813] Subtest virtual-busy-idle: SKIP (0.000s)
[601.116012] [103/134] (430s left) gem_wait (invalid-flags)
[601.172529] Starting subtest: invalid-flags
[601.174810] Subtest invalid-flags: SUCCESS (0.000s)
[601.447065] [104/134] (430s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[601.539794] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[601.544306] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[601.673295] [105/134] (429s left) gem_softpin (evict-snoop)
[601.729905] Starting subtest: evict-snoop
[601.734386] Subtest evict-snoop: SKIP (0.000s)
[601.892984] [106/134] (429s left) api_intel_bb (simple-bb)
[601.961408] Starting subtest: simple-bb
[601.966407] Subtest simple-bb: SUCCESS (0.006s)
[602.081349] [107/134] (429s left) syncobj_wait (invalid-signal-one-illegal-handle)
[602.150220] Starting subtest: invalid-signal-one-illegal-handle
[602.152867] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[602.274038] [108/134] (429s left) vgem_basic (dmabuf-fence-before)
[602.314876] Starting subtest: dmabuf-fence-before
[602.316542] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[602.385417] [109/134] (429s left) gem_eio (wait-immediate)
[602.617238] Starting subtest: wait-immediate
[602.984293] Subtest wait-immediate: SUCCESS (0.367s)
[603.182149] [110/134] (428s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[603.278659] Starting subtest: random-ccs-data-yf-tiled-ccs
[603.280542] Starting dynamic subtest: pipe-A-eDP-1
[603.301321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[603.313529] Starting dynamic subtest: pipe-B-eDP-1
[603.332976] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[603.342879] Starting dynamic subtest: pipe-C-eDP-1
[603.362511] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[603.372033] Starting dynamic subtest: pipe-D-eDP-1
[603.393327] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[603.397217] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[605.536342] [111/134] (426s left) kms_rotation_crc (exhaust-fences)
[605.657247] Starting subtest: exhaust-fences
[605.661434] Subtest exhaust-fences: SKIP (0.000s)
[605.757370] [112/134] (426s left) perf (non-zero-reason)
[605.852818] Starting subtest: non-zero-reason
[605.855256] Starting dynamic subtest: 0-rcs0
[611.331204] Dynamic subtest 0-rcs0: SUCCESS (5.476s)
[611.344076] Starting dynamic subtest: 1-vecs0
[615.263598] Dynamic subtest 1-vecs0: SUCCESS (3.931s)
[615.266528] Subtest non-zero-reason: SUCCESS (9.409s)
[615.314603] [113/134] (416s left) syncobj_eventfd (invalid-illegal-eventfd)
[615.376873] Starting subtest: invalid-illegal-eventfd
[615.379478] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[615.498311] [114/134] (416s left) kms_dsc (dsc-fractional-bpp)
[615.607286] Starting subtest: dsc-fractional-bpp
[615.620266] Subtest dsc-fractional-bpp: SKIP (0.000s)
[615.697957] [115/134] (416s left) kms_pm_dc (dc5-dpms-negative)
[616.793900] Starting subtest: dc5-dpms-negative
[616.798095] Subtest dc5-dpms-negative: SKIP (0.000s)
[616.892997] [116/134] (415s left) i915_pm_rpm (reg-read-ioctl)
[618.831233] Starting subtest: reg-read-ioctl
[621.135416] Subtest reg-read-ioctl: SUCCESS (2.303s)
[621.537560] [117/134] (410s left) kms_hdr (bpc-switch-dpms)
[621.645498] Starting subtest: bpc-switch-dpms
[622.676613] Starting dynamic subtest: pipe-A-eDP-1
[627.079729] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.405s)
[627.082077] Subtest bpc-switch-dpms: SUCCESS (5.437s)
[627.205866] [118/134] (404s left) gem_exec_schedule (preemptive-hang)
[627.384620] Starting subtest: preemptive-hang
[627.387076] Starting dynamic subtest: rcs0
[636.799271] Dynamic subtest rcs0: SUCCESS (9.415s)
[636.810959] Starting dynamic subtest: bcs0
[645.818863] Dynamic subtest bcs0: SUCCESS (9.018s)
[645.830773] Starting dynamic subtest: vcs0
[654.905571] Dynamic subtest vcs0: SUCCESS (9.087s)
[654.917920] Starting dynamic subtest: vcs1
[663.865628] Dynamic subtest vcs1: SUCCESS (8.957s)
[663.877856] Starting dynamic subtest: vecs0
[672.824032] Dynamic subtest vecs0: SUCCESS (8.955s)
[672.836012] Starting dynamic subtest: ccs0
[681.850149] Dynamic subtest ccs0: SUCCESS (9.024s)
[681.852894] Subtest preemptive-hang: SUCCESS (54.466s)
[682.124726] [119/134] (350s left) kms_vblank (wait-forked)
[682.226885] Starting subtest: wait-forked
[682.229110] Starting dynamic subtest: pipe-A-eDP-1
[684.022988] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.796s)
[684.038758] Starting dynamic subtest: pipe-D-eDP-1
[686.484088] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.458s)
[686.486464] Subtest wait-forked: SUCCESS (4.258s)
[687.321019] [120/134] (344s left) kms_draw_crc (fill-fb)
[687.434242] Starting subtest: fill-fb
[687.886961] Subtest fill-fb: SUCCESS (0.454s)
[688.016632] [121/134] (344s left) syncobj_timeline (invalid-wait-bad-flags)
[688.076550] Starting subtest: invalid-wait-bad-flags
[688.078811] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[688.204994] [122/134] (344s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[688.316223] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[688.319945] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[688.438420] [123/134] (343s left) syncobj_wait (wait-any-complex)
[688.503923] Starting subtest: wait-any-complex
[688.567778] Subtest wait-any-complex: SUCCESS (0.063s)
[688.658060] [124/134] (343s left) kms_psr (fbc-psr2-cursor-blt)
[688.764747] Starting subtest: fbc-psr2-cursor-blt
[688.766726] Starting dynamic subtest: eDP-1
[688.770237] Dynamic subtest eDP-1: SKIP (0.000s)
[688.773792] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[688.859443] [125/134] (343s left) kms_plane_lowres (tiling-none)
[688.982465] Starting subtest: tiling-none
[688.984293] Starting dynamic subtest: pipe-A-eDP-1
[688.988007] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[689.307082] Starting dynamic subtest: pipe-B-eDP-1
[689.311131] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[689.320901] Starting dynamic subtest: pipe-C-eDP-1
[689.325490] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[689.335025] Starting dynamic subtest: pipe-D-eDP-1
[689.339548] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[689.344091] Subtest tiling-none: SKIP (0.330s)
[690.153117] [126/134] (342s left) gem_exec_whisper (basic-fds-forked-all)
[690.222047] Starting subtest: basic-fds-forked-all
[712.278386] Subtest basic-fds-forked-all: SUCCESS (22.049s)
[712.480421] [127/134] (320s left) gem_workarounds (basic-read-fd)
[712.554912] Starting subtest: basic-read-fd
[712.572657] Subtest basic-read-fd: SUCCESS (0.017s)
[712.713582] [128/134] (319s left) gem_exec_fence (syncobj-channel)
[713.232528] Starting subtest: syncobj-channel
[714.252809] Subtest syncobj-channel: SUCCESS (1.016s)
[714.810081] [129/134] (317s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[714.867342] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[714.927207] [130/134] (317s left) kms_color (ctm-0-75)
[715.035966] Starting subtest: ctm-0-75
[715.037777] Starting dynamic subtest: pipe-A-eDP-1
[719.972903] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.934s)
[719.984682] Starting dynamic subtest: pipe-B-eDP-1
[725.581782] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.611s)
[725.594489] Starting dynamic subtest: pipe-C-eDP-1
[731.020629] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.437s)
[731.030857] Starting dynamic subtest: pipe-D-eDP-1
[736.440949] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.416s)
[736.443273] Subtest ctm-0-75: SUCCESS (21.402s)
[737.331329] [131/134] (295s left) i915_drm_fdinfo (memory-info-idle)
[737.382170] Starting subtest: memory-info-idle
[737.384559] Starting dynamic subtest: smem0
[737.468000] Dynamic subtest smem0: SUCCESS (0.088s)
[737.470996] Subtest memory-info-idle: SUCCESS (0.089s)
[737.555565] [132/134] (295s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[737.649280] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[745.122100] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.476s)
[745.258354] [133/134] (287s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[745.370174] Starting subtest: bad-aux-stride-y-tiled-ccs
[745.372446] Starting dynamic subtest: pipe-A-eDP-1
[745.394242] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[745.405537] Starting dynamic subtest: pipe-B-eDP-1
[745.425118] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[745.435860] Starting dynamic subtest: pipe-C-eDP-1
[745.457378] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[745.467348] Starting dynamic subtest: pipe-D-eDP-1
[745.489151] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[745.494653] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[747.635652] [134/134] (285s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[747.751035] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[747.761982] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[747.848140] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_pread
results: parsing output: 9/ for test: gem_mmap
results: parsing output: 10/ for test: gem_tiled_fence_blits
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_atomic
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_create
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_invalid_mode
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_offset
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: prime_mmap_kms
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: sysfs_preempt_timeout
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: gem_pxp
results: parsing output: 45/ for test: gen9_exec_parse
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_dp_link_training
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_setmode
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_lmem_swapping
results: parsing output: 69/ for test: gem_exec_gttfill
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_hdmi_inject
results: parsing output: 72/ for test: gem_exec_flush
results: parsing output: 73/ for test: kms_pipe_stress
results: parsing output: 74/ for test: kms_chamelium_frames
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_content_protection
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_atomic_transition
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_lmem_swapping
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_spin_batch
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: fbdev
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: gem_ctx_param
results: parsing output: 92/ for test: kms_scaling_modes
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: dmabuf
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_exec_capture
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: gem_wait
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: vgem_basic
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_rotation_crc
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: syncobj_eventfd
results: parsing output: 113/ for test: kms_dsc
results: parsing output: 114/ for test: kms_pm_dc
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: kms_hdr
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: kms_draw_crc
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_plane_lowres
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: gem_workarounds
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_color
results: parsing output: 130/ for test: i915_drm_fdinfo
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_ccs
results: parsing output: 133/ for test: kms_flip
Done.