[59.281591] Initializing watchdogs
[59.281639]   /dev/watchdog0
[59.297302] [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]
[59.301838] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.304206] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.307704] [001/132] (960s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[59.380677] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[59.490138] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[59.564485] [002/132] (960s left) i915_pm_rps (basic-api)
[59.621555] Starting subtest: basic-api
[59.626129] Subtest basic-api: SKIP (0.001s)
[59.728322] [003/132] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[59.822915] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[59.827110] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[59.888948] [004/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[59.988674] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[66.966896] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.962s)
[67.362256] [005/132] (952s left) drm_buddy (drm_buddy)
[67.413473] Starting subtest: drm_buddy
[67.418223] Subtest drm_buddy: SKIP (0.001s)
[67.507678] [006/132] (952s left) testdisplay
[68.033226] [007/132] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[68.197702] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[68.201974] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[68.337108] [008/132] (951s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[68.427594] Starting subtest: compare-crc-sanitycheck-nv12
[68.429929] Starting dynamic subtest: pipe-A-eDP-1
[69.124465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[69.135912] Starting dynamic subtest: pipe-B-eDP-1
[70.448509] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.321s)
[70.458695] Starting dynamic subtest: pipe-C-eDP-1
[71.715357] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.264s)
[71.725876] Starting dynamic subtest: pipe-D-eDP-1
[72.939152] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[72.941429] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.508s)
[73.788814] [009/132] (946s left) kms_vrr (seamless-rr-switch-virtual)
[73.884356] Starting subtest: seamless-rr-switch-virtual
[73.890802] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[73.957406] [010/132] (946s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[74.048274] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[74.052707] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[74.119989] [011/132] (946s left) perf (short-reads)
[74.250816] Starting subtest: short-reads
[74.262566] Subtest short-reads: SUCCESS (0.014s)
[74.310875] [012/132] (945s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[74.412037] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[74.416293] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[74.504329] [013/132] (945s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[74.612814] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[74.617339] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[74.727344] [014/132] (945s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[74.790963] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[74.794777] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[74.972033] [015/132] (945s left) kms_lease (lease-again)
[75.058915] Starting subtest: lease-again
[75.061623] Starting dynamic subtest: pipe-A-eDP-1
[75.064084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[75.074589] Starting dynamic subtest: pipe-B-eDP-1
[75.076455] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[75.083697] Starting dynamic subtest: pipe-C-eDP-1
[75.085608] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[75.092655] Starting dynamic subtest: pipe-D-eDP-1
[75.094511] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[75.096437] Subtest lease-again: SUCCESS (0.012s)
[75.162162] [016/132] (945s left) kms_plane (plane-position-hole)
[75.252978] Starting subtest: plane-position-hole
[75.790879] Starting dynamic subtest: pipe-A-plane-1
[77.071744] Dynamic subtest pipe-A-plane-1: SUCCESS (1.279s)
[77.080753] Starting dynamic subtest: pipe-A-plane-2
[78.381745] Dynamic subtest pipe-A-plane-2: SUCCESS (1.310s)
[78.391035] Starting dynamic subtest: pipe-A-plane-3
[79.649056] Dynamic subtest pipe-A-plane-3: SUCCESS (1.267s)
[79.657064] Starting dynamic subtest: pipe-A-plane-4
[80.955914] Dynamic subtest pipe-A-plane-4: SUCCESS (1.303s)
[80.965482] Starting dynamic subtest: pipe-A-plane-5
[80.978826] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[82.132716] Starting dynamic subtest: pipe-B-plane-1
[83.449771] Dynamic subtest pipe-B-plane-1: SUCCESS (1.321s)
[83.459096] Starting dynamic subtest: pipe-B-plane-2
[84.688699] Dynamic subtest pipe-B-plane-2: SUCCESS (1.238s)
[84.697888] Starting dynamic subtest: pipe-B-plane-3
[85.923021] Dynamic subtest pipe-B-plane-3: SUCCESS (1.235s)
[85.932172] Starting dynamic subtest: pipe-B-plane-4
[87.206966] Dynamic subtest pipe-B-plane-4: SUCCESS (1.283s)
[87.214977] Starting dynamic subtest: pipe-B-plane-5
[87.237118] Dynamic subtest pipe-B-plane-5: SUCCESS (0.028s)
[87.239367] Subtest plane-position-hole: SUCCESS (11.977s)
[88.063348] [017/132] (932s left) gem_fence_thrash (bo-write-verify-y)
[88.103102] Starting subtest: bo-write-verify-y
[88.117701] Subtest bo-write-verify-y: SKIP (0.012s)
[88.170660] [018/132] (932s left) gem_lmem_swapping (verify-random-ccs)
[88.224234] Subtest verify-random-ccs: SKIP (0.000s)
[88.270125] [019/132] (932s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[88.360908] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[88.363174] Starting dynamic subtest: pipe-A-eDP-1
[89.106827] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[89.114187] Starting dynamic subtest: pipe-B-eDP-1
[90.898984] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.791s)
[90.906875] Starting dynamic subtest: pipe-C-eDP-1
[92.720951] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.820s)
[92.729408] Starting dynamic subtest: pipe-D-eDP-1
[94.557183] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.835s)
[94.559062] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.188s)
[95.702415] [020/132] (924s left) gem_exec_reloc (basic-gtt-active)
[95.777518] Subtest basic-gtt-active: SKIP (0.000s)
[95.845150] [021/132] (924s left) gem_exec_async (concurrent-writes)
[95.906393] Starting subtest: concurrent-writes
[95.908815] Starting dynamic subtest: rcs0
[95.921789] Dynamic subtest rcs0: SUCCESS (0.015s)
[95.932988] Starting dynamic subtest: bcs0
[95.935309] Dynamic subtest bcs0: SUCCESS (0.005s)
[95.942815] Starting dynamic subtest: vcs0
[95.944710] Dynamic subtest vcs0: SUCCESS (0.005s)
[95.952557] Starting dynamic subtest: vcs1
[95.954425] Dynamic subtest vcs1: SUCCESS (0.005s)
[95.961294] Starting dynamic subtest: vecs0
[95.963093] Dynamic subtest vecs0: SUCCESS (0.007s)
[95.969958] Starting dynamic subtest: ccs0
[95.971815] Dynamic subtest ccs0: SUCCESS (0.005s)
[95.973684] Subtest concurrent-writes: SUCCESS (0.045s)
[96.186238] [022/132] (924s left) gem_exec_reloc (basic-wc-read-active)
[96.254816] Subtest basic-wc-read-active: SKIP (0.000s)
[96.323076] [023/132] (924s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[96.377989] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[96.483413] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[96.555881] [024/132] (924s left) gem_exec_whisper (basic-queues-priority)
[96.617303] Starting subtest: basic-queues-priority
[121.430037] Subtest basic-queues-priority: SUCCESS (24.805s)
[121.615370] [025/132] (899s left) gem_exec_balancer (hang)
[121.876783] Starting subtest: hang
[123.932209] Subtest hang: SUCCESS (2.055s)
[124.049300] [026/132] (896s left) gem_exec_whisper (basic-fds-priority)
[124.122764] Starting subtest: basic-fds-priority
[148.444681] Subtest basic-fds-priority: SUCCESS (24.319s)
[148.625447] [027/132] (872s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[148.683156] Starting subtest: etime-single-wait-all-for-submit-submitted
[148.793291] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[148.881630] [028/132] (872s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[148.979794] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[148.984060] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[149.075199] [029/132] (871s left) kms_joiner (basic-force-big-joiner)
[149.176274] Starting subtest: basic-force-big-joiner
[149.180184] Subtest basic-force-big-joiner: SKIP (0.000s)
[149.238672] [030/132] (871s left) kms_cursor_edge_walk (256x256-top-bottom)
[149.326940] Starting subtest: 256x256-top-bottom
[149.329462] Starting dynamic subtest: pipe-A-eDP-1
[152.752373] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[152.762016] Starting dynamic subtest: pipe-D-eDP-1
[155.874515] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[155.876975] Subtest 256x256-top-bottom: SUCCESS (6.549s)
[156.670961] [031/132] (864s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[156.774791] Starting subtest: psr-rgb101010-draw-mmap-wc
[163.882174] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.112s)
[163.986367] [032/132] (857s left) kms_vblank (ts-continuation-modeset-hang)
[164.088112] Starting subtest: ts-continuation-modeset-hang
[164.090405] Starting dynamic subtest: pipe-A-eDP-1
[191.635447] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.547s)
[191.649985] Starting dynamic subtest: pipe-D-eDP-1
[215.712346] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.071s)
[215.714777] Subtest ts-continuation-modeset-hang: SUCCESS (51.622s)
[216.529718] [033/132] (804s left) gem_ppgtt (shrink-vs-evict-pinned)
[216.592888] Starting subtest: shrink-vs-evict-pinned
[221.947948] Subtest shrink-vs-evict-pinned: SUCCESS (5.342s)
[222.023073] [034/132] (799s left) i915_suspend (fence-restore-tiled2untiled)
[222.080619] Starting subtest: fence-restore-tiled2untiled
[222.085315] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[222.170070] [035/132] (799s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[222.230304] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[222.303050] [036/132] (798s left) api_intel_allocator (reloc-allocator)
[222.357504] Starting subtest: reloc-allocator
[222.359797] Starting dynamic subtest: basic
[222.362134] Dynamic subtest basic: SUCCESS (0.006s)
[222.373659] Starting dynamic subtest: parallel-one
[222.376096] Dynamic subtest parallel-one: SUCCESS (0.007s)
[222.387963] Starting dynamic subtest: print
[222.390227] Dynamic subtest print: SUCCESS (0.000s)
[222.402227] Starting dynamic subtest: reuse
[222.404392] Dynamic subtest reuse: SUCCESS (0.000s)
[222.412791] Starting dynamic subtest: fork-reopen-allocator
[222.414996] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[222.417328] Subtest reloc-allocator: SUCCESS (0.026s)
[222.524601] [037/132] (798s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[222.624871] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[230.120297] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.498s)
[230.257528] [038/132] (791s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[230.360733] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[230.365192] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[230.458205] [039/132] (790s left) gem_wait (invalid-flags)
[230.525432] Starting subtest: invalid-flags
[230.527723] Subtest invalid-flags: SUCCESS (0.000s)
[230.759881] [040/132] (790s left) drm_read (empty-block)
[230.900157] Starting subtest: empty-block
[231.902468] Subtest empty-block: SUCCESS (1.001s)
[232.027564] [041/132] (789s left) kms_sequence (queue-busy)
[232.112075] Starting subtest: queue-busy
[232.114387] Starting dynamic subtest: pipe-A-eDP-1
[234.040057] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.928s)
[234.049544] Starting dynamic subtest: pipe-B-eDP-1
[236.664041] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.622s)
[236.674112] Starting dynamic subtest: pipe-C-eDP-1
[239.251426] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.587s)
[239.260666] Starting dynamic subtest: pipe-D-eDP-1
[241.775080] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.521s)
[241.776948] Subtest queue-busy: SUCCESS (9.663s)
[242.573939] [042/132] (778s left) kms_psr (psr2-primary-render)
[242.670711] Starting subtest: psr2-primary-render
[242.672860] Starting dynamic subtest: eDP-1
[244.366593] Dynamic subtest eDP-1: SUCCESS (1.696s)
[244.368757] Subtest psr2-primary-render: SUCCESS (1.697s)
[245.239988] [043/132] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[245.347725] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[245.352196] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[245.454629] [044/132] (776s left) gem_busy (parallel)
[245.631725] Starting subtest: parallel
[245.634083] Starting dynamic subtest: rcs0
[246.933897] Dynamic subtest rcs0: SUCCESS (1.301s)
[246.945501] Starting dynamic subtest: bcs0
[248.918040] Dynamic subtest bcs0: SUCCESS (1.981s)
[248.929646] Starting dynamic subtest: vcs0
[250.901774] Dynamic subtest vcs0: SUCCESS (1.981s)
[250.918174] Starting dynamic subtest: vcs1
[252.888105] Dynamic subtest vcs1: SUCCESS (1.983s)
[252.899198] Starting dynamic subtest: vecs0
[254.934305] Dynamic subtest vecs0: SUCCESS (2.043s)
[254.945928] Starting dynamic subtest: ccs0
[256.918643] Dynamic subtest ccs0: SUCCESS (1.981s)
[256.921408] Subtest parallel: SUCCESS (11.287s)
[257.139949] [045/132] (764s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[257.267420] Starting subtest: cursorB-vs-flipA-toggle
[257.272190] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[257.407844] [046/132] (764s left) kms_psr (fbc-psr2-cursor-render)
[257.507793] Starting subtest: fbc-psr2-cursor-render
[257.510053] Starting dynamic subtest: eDP-1
[257.514114] Dynamic subtest eDP-1: SKIP (0.000s)
[257.518724] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[257.581983] [047/132] (764s left) kms_psr (psr-suspend)
[257.673713] Starting subtest: psr-suspend
[257.676021] Starting dynamic subtest: eDP-1
[275.978018] Dynamic subtest eDP-1: SUCCESS (3.426s)
[275.980373] Subtest psr-suspend: SUCCESS (3.427s)
[286.862678] [048/132] (744s left) kms_flip (2x-modeset-vs-vblank-race)
[286.989922] Starting subtest: 2x-modeset-vs-vblank-race
[286.999628] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[287.082824] [049/132] (744s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[287.467778] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[288.268196] [050/132] (743s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[288.360705] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[288.363112] Starting dynamic subtest: pipe-A-eDP-1
[288.388113] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[288.400997] Starting dynamic subtest: pipe-B-eDP-1
[288.423011] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[288.432661] Starting dynamic subtest: pipe-C-eDP-1
[288.454454] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[288.463517] Starting dynamic subtest: pipe-D-eDP-1
[288.486178] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[288.490741] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[290.606619] [051/132] (741s left) sw_sync (sync_multi_producer_single_consumer)
[290.650760] Starting subtest: sync_multi_producer_single_consumer
[291.743391] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[291.816938] [052/132] (740s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[291.906202] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[291.995259] [053/132] (739s left) kms_flip (2x-wf_vblank-ts-check)
[292.098536] Starting subtest: 2x-wf_vblank-ts-check
[292.109832] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[292.200880] [054/132] (739s left) gem_partial_pwrite_pread (write-uncached)
[292.258653] Subtest write-uncached: SKIP (0.000s)
[292.327907] [055/132] (739s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[292.414914] Starting subtest: async-flip-with-page-flip-events-linear
[292.793643] Starting dynamic subtest: pipe-A-eDP-1
[295.520599] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.691s)
[295.893573] Starting dynamic subtest: pipe-B-eDP-1
[298.684420] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[299.069095] Starting dynamic subtest: pipe-C-eDP-1
[301.846156] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[302.206711] Starting dynamic subtest: pipe-D-eDP-1
[304.992421] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[304.994759] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.480s)
[306.188078] [056/132] (725s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[306.255745] Starting subtest: x-tiled-to-vebox-yf-tiled
[306.260180] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[306.441389] [057/132] (725s left) kms_properties (connector-properties-legacy)
[306.548987] Starting subtest: connector-properties-legacy
[306.550903] Starting dynamic subtest: pipe-A-eDP-1
[314.389126] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.830s)
[314.399315] Starting dynamic subtest: pipe-None-DP-1
[314.404072] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[314.413497] Starting dynamic subtest: pipe-None-HDMI-A-1
[314.417625] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[314.427143] Starting dynamic subtest: pipe-None-DP-2
[314.431572] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[314.440808] Starting dynamic subtest: pipe-None-HDMI-A-2
[314.445618] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[314.457381] Starting dynamic subtest: pipe-None-DP-3
[314.461943] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[314.471256] Starting dynamic subtest: pipe-None-DP-4
[314.475821] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[314.478136] Subtest connector-properties-legacy: SUCCESS (7.845s)
[315.258286] [058/132] (716s left) gem_mmap_offset (mmap-boundaries)
[315.315026] Starting subtest: mmap-boundaries
[315.317208] Starting dynamic subtest: smem0
[315.595362] Dynamic subtest smem0: SUCCESS (0.280s)
[315.597797] Subtest mmap-boundaries: SUCCESS (0.281s)
[315.730440] [059/132] (716s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[315.830208] Starting subtest: yf-tiled-addfb-size-overflow
[315.834755] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[315.917674] [060/132] (716s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[315.976417] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[315.978249] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[316.079630] [061/132] (716s left) gem_exec_flush (basic-uc-rw-default)
[316.141057] Starting subtest: basic-uc-rw-default
[321.607020] Subtest basic-uc-rw-default: SUCCESS (5.461s)
[321.803874] [062/132] (710s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[321.865731] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[321.867694] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[321.949876] [063/132] (710s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[322.059032] Starting subtest: fbcpsr-rgb101010-draw-render
[328.859850] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.799s)
[328.970894] [064/132] (703s left) gem_exec_schedule (reorder-wide)
[329.149115] Subtest reorder-wide: SKIP (0.000s)
[329.330710] [065/132] (703s left) prime_self_import (basic-with_two_bos)
[329.362282] Starting subtest: basic-with_two_bos
[329.381078] Subtest basic-with_two_bos: SUCCESS (0.018s)
[329.474358] [066/132] (703s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[329.572092] Starting subtest: x-tiled-32bpp-rotate-0
[331.019757] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.448s)
[331.167290] [067/132] (701s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[331.282145] Starting subtest: cursorA-vs-flipA-varying-size
[342.425021] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.135s)
[343.248960] [068/132] (689s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[343.358179] Starting subtest: plane-lut1d-ctm3x4
[343.482138] Starting dynamic subtest: pipe-A-plane-0
[343.648664] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[343.660415] Starting dynamic subtest: pipe-A-plane-1
[343.793514] Dynamic subtest pipe-A-plane-1: SUCCESS (0.143s)
[343.803111] Starting dynamic subtest: pipe-A-plane-2
[343.948503] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[345.149386] Starting dynamic subtest: pipe-B-plane-0
[345.294002] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[345.303726] Starting dynamic subtest: pipe-B-plane-1
[345.450155] Dynamic subtest pipe-B-plane-1: SUCCESS (0.154s)
[345.466766] Starting dynamic subtest: pipe-B-plane-2
[345.639225] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[346.812124] Starting dynamic subtest: pipe-C-plane-0
[346.945524] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[346.958024] Starting dynamic subtest: pipe-C-plane-1
[347.091207] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[347.101174] Starting dynamic subtest: pipe-C-plane-2
[347.235993] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[348.422577] Starting dynamic subtest: pipe-D-plane-0
[348.558106] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[348.567572] Starting dynamic subtest: pipe-D-plane-1
[348.702564] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[348.712255] Starting dynamic subtest: pipe-D-plane-2
[348.858272] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[349.154047] Subtest plane-lut1d-ctm3x4: SUCCESS (5.794s)
[349.995173] [069/132] (682s left) kms_force_connector_basic (force-connector-state)
[350.071780] Starting subtest: force-connector-state
[350.688418] Subtest force-connector-state: SUCCESS (0.614s)
[351.649698] [070/132] (680s left) syncobj_wait (wait-all-for-submit-snapshot)
[351.701509] Starting subtest: wait-all-for-submit-snapshot
[351.782803] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[351.860763] [071/132] (680s left) perf_pmu (event-wait)
[351.909369] Starting subtest: event-wait
[351.911688] Starting dynamic subtest: rcs0
[351.916240] Dynamic subtest rcs0: SKIP (0.000s)
[351.920680] Subtest event-wait: SKIP (0.001s)
[352.020850] [072/132] (680s left) prime_vgem (busy)
[352.197615] Starting subtest: busy
[352.199900] Starting dynamic subtest: rcs0
[352.244003] Dynamic subtest rcs0: SUCCESS (0.047s)
[352.253744] Starting dynamic subtest: bcs0
[352.296029] Dynamic subtest bcs0: SUCCESS (0.051s)
[352.306175] Starting dynamic subtest: vcs0
[352.344488] Dynamic subtest vcs0: SUCCESS (0.047s)
[352.354419] Starting dynamic subtest: vcs1
[352.388782] Dynamic subtest vcs1: SUCCESS (0.044s)
[352.398718] Starting dynamic subtest: vecs0
[352.434947] Dynamic subtest vecs0: SUCCESS (0.045s)
[352.444582] Starting dynamic subtest: ccs0
[352.480957] Dynamic subtest ccs0: SUCCESS (0.045s)
[352.483075] Subtest busy: SUCCESS (0.285s)
[352.606039] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[352.608962] [073/132] (680s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[352.689285] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[352.692793] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[352.774800] [074/132] (680s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[352.883267] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[353.642831] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.759s)
[353.822533] [075/132] (679s left) kms_frontbuffer_tracking (fbc-stridechange)
[353.920352] Starting subtest: fbc-stridechange
[357.153498] Subtest fbc-stridechange: SUCCESS (3.233s)
[358.347186] [076/132] (674s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[358.446809] Starting subtest: extended-pageflip-modeset-hang-oldfb
[358.449199] Starting dynamic subtest: pipe-A
[366.357396] Dynamic subtest pipe-A: SUCCESS (7.903s)
[366.368227] Starting dynamic subtest: pipe-D
[375.018310] Dynamic subtest pipe-D: SUCCESS (8.657s)
[375.020693] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.567s)
[375.826595] [077/132] (657s left) gem_exec_fence (basic-busy-all)
[375.888155] Starting subtest: basic-busy-all
[375.974013] Subtest basic-busy-all: SUCCESS (0.087s)
[377.836104] [078/132] (655s left) kms_cursor_crc (cursor-offscreen-512x170)
[378.129348] Starting subtest: cursor-offscreen-512x170
[378.133693] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[378.289299] [079/132] (654s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[378.382514] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[385.677799] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.301s)
[385.790832] [080/132] (647s left) gem_ctx_param (vm)
[385.851158] Starting subtest: vm
[385.903164] Subtest vm: SUCCESS (0.052s)
[386.024555] [081/132] (647s left) perf_pmu (rc6)
[386.067239] Starting subtest: rc6
[386.069488] Starting dynamic subtest: gt0
[392.432430] Dynamic subtest gt0: SUCCESS (6.366s)
[392.445137] Starting dynamic subtest: runtime-pm-gt0
[400.192580] Dynamic subtest runtime-pm-gt0: SUCCESS (7.758s)
[400.205212] Starting dynamic subtest: runtime-pm-long-gt0
[412.616770] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.421s)
[412.629771] Starting dynamic subtest: other-idle-gt0
[418.960014] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[418.973060] Starting dynamic subtest: gt1
[425.302089] Dynamic subtest gt1: SUCCESS (6.339s)
[425.314757] Starting dynamic subtest: runtime-pm-gt1
[432.798868] Dynamic subtest runtime-pm-gt1: SUCCESS (7.492s)
[432.811520] Starting dynamic subtest: runtime-pm-long-gt1
[445.299842] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.495s)
[445.313053] Starting dynamic subtest: other-idle-gt1
[451.643664] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[451.646531] Subtest rc6: SUCCESS (65.571s)
[452.798433] [082/132] (580s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[452.900049] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[459.838901] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.939s)
[459.947038] [083/132] (573s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[460.482280] Starting subtest: syncobj-stationary-timeline-chain-engines
[460.590753] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.109s)
[461.869950] [084/132] (571s left) kms_pm_rpm (cursor)
[463.904118] Starting subtest: cursor
[463.908888] Subtest cursor: SKIP (0.000s)
[464.253214] [085/132] (569s left) kms_atomic (plane-immutable-zpos)
[464.339077] Starting subtest: plane-immutable-zpos
[464.341226] Starting dynamic subtest: pipe-A-eDP-1
[464.984206] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s)
[464.986906] Subtest plane-immutable-zpos: SUCCESS (0.645s)
[465.825344] [086/132] (567s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[465.929827] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[465.931988] Starting dynamic subtest: pipe-A-eDP-1
[471.680270] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.754s)
[471.690858] Starting dynamic subtest: pipe-B-eDP-1
[478.186037] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.500s)
[478.188306] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.256s)
[479.014686] [087/132] (554s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[479.122324] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[479.126542] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[479.198376] [088/132] (554s left) gem_render_copy (linear)
[479.253794] Starting subtest: linear
[479.256194] Starting dynamic subtest: smem
[479.304002] Dynamic subtest smem: SUCCESS (0.049s)
[479.306690] Subtest linear: SUCCESS (0.050s)
[479.503432] [089/132] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[479.598883] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[483.266003] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.669s)
[484.444008] [090/132] (549s left) kms_plane_multiple (2x-tiling-yf)
[484.530528] Starting subtest: 2x-tiling-yf
[484.534829] Subtest 2x-tiling-yf: SKIP (0.000s)
[484.581844] [091/132] (548s left) gem_exec_fence (concurrent)
[484.761808] Starting subtest: concurrent
[484.766368] Subtest concurrent: SKIP (0.000s)
[486.833114] [092/132] (546s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[486.925212] Starting subtest: crc-primary-basic-y-tiled-ccs
[486.927528] Starting dynamic subtest: pipe-A-eDP-1
[486.950012] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.961889] Starting dynamic subtest: pipe-B-eDP-1
[486.982926] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[486.992494] Starting dynamic subtest: pipe-C-eDP-1
[487.013837] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[487.023335] Starting dynamic subtest: pipe-D-eDP-1
[487.044753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[487.049057] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[489.115856] [093/132] (544s left) kms_feature_discovery (display-4x)
[489.211646] Starting subtest: display-4x
[489.216060] Subtest display-4x: SKIP (0.000s)
[489.266120] [094/132] (544s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[489.321412] Starting subtest: single-wait-all-for-submit-signaled
[489.323706] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[489.395375] [095/132] (544s left) kms_cursor_crc (cursor-random-max-size)
[489.705813] Starting subtest: cursor-random-max-size
[489.712416] Subtest cursor-random-max-size: SKIP (0.000s)
[489.807934] [096/132] (543s left) kms_debugfs (display-on-read-all)
[489.898806] Starting subtest: display-on-read-all
[490.063688] Subtest display-on-read-all: SUCCESS (0.165s)
[490.165625] [097/132] (543s left) gem_exec_schedule (preempt-engines)
[490.232978] Starting subtest: preempt-engines
[490.234822] Starting dynamic subtest: rcs0
[492.496938] Dynamic subtest rcs0: SUCCESS (2.264s)
[492.508619] Starting dynamic subtest: bcs0
[494.731393] Dynamic subtest bcs0: SUCCESS (2.231s)
[494.747290] Starting dynamic subtest: vcs0
[497.015840] Dynamic subtest vcs0: SUCCESS (2.281s)
[497.026948] Starting dynamic subtest: vcs1
[499.317793] Dynamic subtest vcs1: SUCCESS (2.299s)
[499.330903] Starting dynamic subtest: vecs0
[501.586229] Dynamic subtest vecs0: SUCCESS (2.266s)
[501.599230] Starting dynamic subtest: ccs0
[503.897187] Dynamic subtest ccs0: SUCCESS (2.309s)
[503.900214] Subtest preempt-engines: SUCCESS (13.665s)
[504.177270] [098/132] (529s left) gen7_exec_parse (oacontrol-tracking)
[504.244779] Subtest oacontrol-tracking: SKIP (0.000s)
[504.316354] [099/132] (529s left) gem_create (hog-create)
[504.382495] Starting subtest: hog-create
[504.384662] Starting dynamic subtest: smem0
[537.781673] Dynamic subtest smem0: SUCCESS (33.407s)
[537.784301] Subtest hog-create: SUCCESS (33.409s)
[537.946959] [100/132] (495s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[538.040656] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[538.043010] Starting dynamic subtest: pipe-A-eDP-1
[538.102507] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[538.114496] Starting dynamic subtest: pipe-B-eDP-1
[538.171221] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[538.183091] Starting dynamic subtest: pipe-C-eDP-1
[538.239942] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[538.250995] Starting dynamic subtest: pipe-D-eDP-1
[538.308692] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[538.312828] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[540.321693] [101/132] (493s left) i915_pm_freq_api (freq-basic-api)
[540.389619] Starting subtest: freq-basic-api
[540.391905] Starting dynamic subtest: gt0
[540.394123] Dynamic subtest gt0: SUCCESS (0.003s)
[540.405099] Starting dynamic subtest: gt1
[540.407292] Dynamic subtest gt1: SUCCESS (0.003s)
[540.409402] Subtest freq-basic-api: SUCCESS (0.007s)
[540.473970] [102/132] (493s left) sysfs_preempt_timeout (invalid)
[540.545999] Starting subtest: invalid
[540.548343] Starting dynamic subtest: vecs0
[540.550734] Dynamic subtest vecs0: SUCCESS (0.000s)
[540.561889] Starting dynamic subtest: ccs0
[540.563739] Dynamic subtest ccs0: SUCCESS (0.000s)
[540.573138] Starting dynamic subtest: vcs0
[540.575015] Dynamic subtest vcs0: SUCCESS (0.000s)
[540.584266] Starting dynamic subtest: bcs0
[540.586155] Dynamic subtest bcs0: SUCCESS (0.000s)
[540.595552] Starting dynamic subtest: rcs0
[540.597411] Dynamic subtest rcs0: SUCCESS (0.000s)
[540.607306] Starting dynamic subtest: vcs1
[540.609473] Dynamic subtest vcs1: SUCCESS (0.000s)
[540.611535] Subtest invalid: SUCCESS (0.006s)
[540.649966] [103/132] (493s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[540.746634] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[540.750624] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[540.816806] [104/132] (493s left) gem_spin_batch (resubmit-new)
[540.882855] Starting subtest: resubmit-new
[540.884773] Starting dynamic subtest: rcs0
[540.890623] Dynamic subtest rcs0: SUCCESS (0.010s)
[540.901914] Starting dynamic subtest: bcs0
[540.903714] Dynamic subtest bcs0: SUCCESS (0.003s)
[540.913757] Starting dynamic subtest: vcs0
[540.915830] Dynamic subtest vcs0: SUCCESS (0.004s)
[540.925564] Starting dynamic subtest: vcs1
[540.927648] Dynamic subtest vcs1: SUCCESS (0.004s)
[540.937140] Starting dynamic subtest: vecs0
[540.939344] Dynamic subtest vecs0: SUCCESS (0.004s)
[540.949154] Starting dynamic subtest: ccs0
[540.951393] Dynamic subtest ccs0: SUCCESS (0.004s)
[540.953578] Subtest resubmit-new: SUCCESS (0.033s)
[542.789355] [105/132] (491s left) gem_exec_reloc (basic-write-cpu)
[542.842415] Subtest basic-write-cpu: SKIP (0.000s)
[542.923748] [106/132] (491s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[543.025598] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[543.044713] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.017s)
[543.102157] [107/132] (491s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[543.161019] Starting subtest: framebuffer-vs-set-tiling
[543.165757] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[543.269436] [108/132] (490s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[543.357015] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[543.361427] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[543.429881] [109/132] (490s left) kms_chamelium_hpd (dp-hpd-fast)
[543.820553] Subtest dp-hpd-fast: SKIP (0.000s)
[544.610996] [110/132] (489s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[544.672103] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[544.674494] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[544.741586] [111/132] (489s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[544.838410] Starting subtest: 4-tiled-16bpp-rotate-90
[544.858074] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[544.954565] [112/132] (489s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[545.048820] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[545.051181] Starting dynamic subtest: pipe-A-eDP-1
[545.072658] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[545.084213] Starting dynamic subtest: pipe-B-eDP-1
[545.104569] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[545.114024] Starting dynamic subtest: pipe-C-eDP-1
[545.134623] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[545.144133] Starting dynamic subtest: pipe-D-eDP-1
[545.165604] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[545.169863] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[547.305396] [113/132] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[547.402978] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[555.044380] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.647s)
[555.127498] [114/132] (479s left) gem_create (create-invalid-size)
[555.189417] Starting subtest: create-invalid-size
[555.191649] Subtest create-invalid-size: SUCCESS (0.000s)
[555.353111] [115/132] (479s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[555.422726] Starting subtest: multi-wait-all-for-submit-signaled
[555.424911] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[555.519043] [116/132] (479s left) kms_content_protection (lic-type-0)
[555.655634] Starting subtest: lic-type-0
[555.660045] Subtest lic-type-0: SKIP (0.000s)
[555.761473] [117/132] (478s left) kms_psr (fbc-psr2-sprite-plane-move)
[555.858125] Starting subtest: fbc-psr2-sprite-plane-move
[555.860184] Starting dynamic subtest: eDP-1
[555.864083] Dynamic subtest eDP-1: SKIP (0.000s)
[555.868036] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[555.909957] [118/132] (478s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[556.002370] Starting subtest: plane-upscale-factor-0-25-with-rotation
[556.004689] Starting dynamic subtest: pipe-A
[556.227255] Dynamic subtest pipe-A: SUCCESS (0.227s)
[556.238221] Starting dynamic subtest: pipe-B
[557.568412] Dynamic subtest pipe-B: SUCCESS (1.341s)
[557.580026] Starting dynamic subtest: pipe-C
[558.872531] Dynamic subtest pipe-C: SUCCESS (1.303s)
[558.883380] Starting dynamic subtest: pipe-D
[560.170094] Dynamic subtest pipe-D: SUCCESS (1.296s)
[560.172459] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.171s)
[561.304556] [119/132] (473s left) gen9_exec_parse (unaligned-jump)
[561.358911] Subtest unaligned-jump: SKIP (0.000s)
[561.435144] [120/132] (473s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[561.533841] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[561.537824] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[561.597919] [121/132] (473s left) kms_psr (pr-primary-mmap-cpu)
[561.688413] Starting subtest: pr-primary-mmap-cpu
[561.693024] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[561.742783] [122/132] (473s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[561.853637] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[561.855925] Starting dynamic subtest: pipe-A-eDP-1
[561.972038] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[561.983122] Starting dynamic subtest: pipe-B-eDP-1
[563.168468] Dynamic subtest pipe-B-eDP-1: SKIP (1.194s)
[563.173088] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.319s)
[564.405431] [123/132] (470s left) kms_frontbuffer_tracking (psr-suspend)
[564.503283] Starting subtest: psr-suspend
[603.081223] Subtest psr-suspend: SUCCESS (8.632s)
[613.219420] [124/132] (431s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[613.348672] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[614.375755] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.003s)
[614.477774] [125/132] (430s left) gem_ctx_persistence (process)
[614.541003] Starting subtest: process
[614.709509] Subtest process: SUCCESS (0.167s)
[614.774673] [126/132] (430s left) api_intel_bb (object-reloc-keep-cache)
[614.826623] Starting subtest: object-reloc-keep-cache
[614.830716] Subtest object-reloc-keep-cache: SKIP (0.002s)
[614.935798] [127/132] (430s left) syncobj_wait (invalid-wait-illegal-handle)
[614.992608] Starting subtest: invalid-wait-illegal-handle
[614.994540] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[615.065100] [128/132] (430s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[615.160703] Starting subtest: fbc-pr-cursor-plane-update-sf
[615.164082] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[615.211807] [129/132] (429s left) syncobj_wait (invalid-single-wait-unsubmitted)
[615.274942] Starting subtest: invalid-single-wait-unsubmitted
[615.276914] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[615.354736] [130/132] (429s left) gem_vm_create (isolation)
[615.403033] Starting subtest: isolation
[615.411115] Subtest isolation: SUCCESS (0.010s)
[615.512732] [131/132] (429s left) gem_exec_schedule (fifo)
[615.577235] Starting subtest: fifo
[615.579007] Starting dynamic subtest: rcs0
[615.674639] Dynamic subtest rcs0: SUCCESS (0.101s)
[615.687054] Starting dynamic subtest: vcs0
[615.759001] Dynamic subtest vcs0: SUCCESS (0.082s)
[615.768893] Starting dynamic subtest: vcs1
[615.838923] Dynamic subtest vcs1: SUCCESS (0.078s)
[615.849081] Starting dynamic subtest: vecs0
[615.920776] Dynamic subtest vecs0: SUCCESS (0.079s)
[615.933713] Starting dynamic subtest: ccs0
[616.005671] Dynamic subtest ccs0: SUCCESS (0.083s)
[616.007565] Subtest fifo: SUCCESS (0.427s)
[617.781900] [132/132] (427s left) kms_pm_rpm (system-suspend-modeset)
[619.808593] Starting subtest: system-suspend-modeset
[640.086922] Subtest system-suspend-modeset: SUCCESS (4.991s)
[643.456806] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: i915_pm_rps
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: drm_buddy
results: parsing output: 5/ for test: testdisplay
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_pipe_crc_basic
results: parsing output: 8/ for test: kms_vrr
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_lease
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: gem_fence_thrash
results: parsing output: 17/ for test: gem_lmem_swapping
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: gem_exec_async
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: gem_exec_whisper
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_joiner
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_vblank
results: parsing output: 32/ for test: gem_ppgtt
results: parsing output: 33/ for test: i915_suspend
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_wait
results: parsing output: 39/ for test: drm_read
results: parsing output: 40/ for test: kms_sequence
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_busy
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_chamelium_frames
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: sw_sync
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: gem_partial_pwrite_pread
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_properties
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_exec_flush
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: prime_self_import
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_color_pipeline
results: parsing output: 68/ for test: kms_force_connector_basic
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_busy
results: parsing output: 76/ for test: gem_exec_fence
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane_multiple
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_feature_discovery
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_debugfs
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gen7_exec_parse
results: parsing output: 98/ for test: gem_create
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: i915_pm_freq_api
results: parsing output: 101/ for test: sysfs_preempt_timeout
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_spin_batch
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_create
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_content_protection
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: api_intel_bb
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_vm_create
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: kms_pm_rpm
Done.