[58.139411] Initializing watchdogs
[58.139460]   /dev/watchdog0
[58.154723] [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]
[58.159203] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.162045] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.165307] [001/156] (960s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[58.280910] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[58.318285] Starting dynamic subtest: pipe-A-plane-0
[58.631703] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s)
[58.642032] Starting dynamic subtest: pipe-A-plane-3
[58.867590] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[58.875348] Starting dynamic subtest: pipe-A-plane-5
[58.881618] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[59.981972] Starting dynamic subtest: pipe-B-plane-0
[60.274304] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[60.284912] Starting dynamic subtest: pipe-B-plane-3
[60.508885] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[60.517769] Starting dynamic subtest: pipe-B-plane-5
[60.522063] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[60.824760] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.531s)
[61.666354] [002/156] (957s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[61.757300] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[61.759610] Starting dynamic subtest: pipe-A
[62.097027] Dynamic subtest pipe-A: SUCCESS (0.338s)
[62.110959] Starting dynamic subtest: pipe-B
[63.560983] Dynamic subtest pipe-B: SUCCESS (1.457s)
[63.570159] Starting dynamic subtest: pipe-C
[64.986045] Dynamic subtest pipe-C: SUCCESS (1.421s)
[64.995042] Starting dynamic subtest: pipe-D
[66.420504] Dynamic subtest pipe-D: SUCCESS (1.431s)
[66.422794] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.650s)
[67.590951] [003/156] (951s left) core_sysfs (read-all-entries)
[67.647854] Starting subtest: read-all-entries
[67.652589] Subtest read-all-entries: SUCCESS (0.003s)
[67.768180] [004/156] (951s left) kms_pm_dc (dc5-dpms)
[68.867443] Starting subtest: dc5-dpms
[70.961225] Subtest dc5-dpms: SUCCESS (2.091s)
[71.040059] [005/156] (947s left) gem_exec_params (mmapped)
[71.104555] Starting subtest: mmapped
[71.106926] Subtest mmapped: SUCCESS (0.002s)
[71.233608] [006/156] (947s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[71.336950] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[71.341453] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[71.422878] [007/156] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[71.523186] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[71.527725] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[71.625833] [008/156] (947s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[71.682524] Starting subtest: multi-wait-all-for-submit-available-signaled
[71.684387] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[71.793840] [009/156] (947s left) perf_pmu (busy-accuracy-2)
[71.832517] Starting subtest: busy-accuracy-2
[71.834961] Starting dynamic subtest: rcs0
[74.873755] Dynamic subtest rcs0: SUCCESS (3.037s)
[74.882785] Starting dynamic subtest: bcs0
[77.993648] Dynamic subtest bcs0: SUCCESS (3.061s)
[78.002806] Starting dynamic subtest: vcs0
[81.033281] Dynamic subtest vcs0: SUCCESS (3.044s)
[81.042450] Starting dynamic subtest: vcs1
[84.079889] Dynamic subtest vcs1: SUCCESS (3.046s)
[84.091016] Starting dynamic subtest: vecs0
[87.125075] Dynamic subtest vecs0: SUCCESS (3.043s)
[87.133582] Starting dynamic subtest: ccs0
[90.184720] Dynamic subtest ccs0: SUCCESS (3.059s)
[90.187048] Subtest busy-accuracy-2: SUCCESS (18.296s)
[90.247914] [010/156] (928s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt)
[90.352293] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt
[90.356935] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[90.452965] [011/156] (928s left) gem_ctx_engines (execute-oneforall)
[90.510226] Starting subtest: execute-oneforall
[91.067952] Subtest execute-oneforall: SUCCESS (0.557s)
[92.419205] [012/156] (926s left) kms_flip (wf_vblank-ts-check-interruptible)
[92.520652] Starting subtest: wf_vblank-ts-check-interruptible
[92.522881] Starting dynamic subtest: A-eDP1
[101.506067] Dynamic subtest A-eDP1: SUCCESS (8.951s)
[101.514525] Starting dynamic subtest: B-eDP1
[110.440558] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[110.451310] Starting dynamic subtest: C-eDP1
[119.376740] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[119.386418] Starting dynamic subtest: D-eDP1
[128.307908] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[128.310421] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.745s)
[129.498351] [013/156] (889s left) gem_ppgtt (shrink-vs-evict-pinned)
[129.552514] Starting subtest: shrink-vs-evict-pinned
[135.334378] Subtest shrink-vs-evict-pinned: SUCCESS (5.730s)
[135.372434] [014/156] (883s left) gem_exec_balancer (semaphore)
[135.447441] Starting subtest: semaphore
[137.314403] Subtest semaphore: SUCCESS (1.865s)
[137.643229] [015/156] (881s left) prime_vgem (sync)
[137.750731] Starting subtest: sync
[137.753195] Starting dynamic subtest: rcs0
[137.794795] Dynamic subtest rcs0: SUCCESS (0.044s)
[137.803550] Starting dynamic subtest: bcs0
[137.859075] Dynamic subtest bcs0: SUCCESS (0.063s)
[137.867658] Starting dynamic subtest: vcs0
[137.910813] Dynamic subtest vcs0: SUCCESS (0.051s)
[137.920084] Starting dynamic subtest: vcs1
[137.959314] Dynamic subtest vcs1: SUCCESS (0.048s)
[137.967863] Starting dynamic subtest: vecs0
[138.008354] Dynamic subtest vecs0: SUCCESS (0.049s)
[138.016872] Starting dynamic subtest: ccs0
[138.057202] Dynamic subtest ccs0: SUCCESS (0.048s)
[138.059399] Subtest sync: SUCCESS (0.307s)
[138.166490] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[138.169487] [016/156] (881s left) kms_panel_fitting (legacy)
[138.269577] Starting subtest: legacy
[138.271724] Starting dynamic subtest: pipe-A-eDP-1
[138.800434] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.533s)
[138.828113] Starting dynamic subtest: pipe-B-eDP-1
[140.336626] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.517s)
[140.364610] Starting dynamic subtest: pipe-C-eDP-1
[141.840152] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.484s)
[141.865716] Starting dynamic subtest: pipe-D-eDP-1
[143.370406] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.510s)
[143.372802] Subtest legacy: SUCCESS (5.102s)
[144.637405] [017/156] (874s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[144.739182] Starting subtest: psr-farfromfence-mmap-gtt
[144.743363] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[144.840751] [018/156] (874s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[144.947687] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[144.952126] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[145.041948] [019/156] (874s left) sysfs_preempt_timeout (idempotent)
[145.100930] Starting subtest: idempotent
[145.103232] Starting dynamic subtest: vecs0
[145.105589] Dynamic subtest vecs0: SUCCESS (0.000s)
[145.115788] Starting dynamic subtest: ccs0
[145.117641] Dynamic subtest ccs0: SUCCESS (0.000s)
[145.125656] Starting dynamic subtest: vcs0
[145.127553] Dynamic subtest vcs0: SUCCESS (0.000s)
[145.135635] Starting dynamic subtest: bcs0
[145.137530] Dynamic subtest bcs0: SUCCESS (0.000s)
[145.146942] Starting dynamic subtest: rcs0
[145.149193] Dynamic subtest rcs0: SUCCESS (0.000s)
[145.157197] Starting dynamic subtest: vcs1
[145.159072] Dynamic subtest vcs1: SUCCESS (0.000s)
[145.161034] Subtest idempotent: SUCCESS (0.005s)
[145.202258] [020/156] (874s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[145.297534] Starting subtest: plane-all-transition-nonblocking-fencing
[145.299972] Starting dynamic subtest: pipe-A-eDP-1
[147.795668] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[148.103680] Starting dynamic subtest: pipe-B-eDP-1
[151.368260] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.273s)
[151.678555] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.379s)
[152.510968] [021/156] (866s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[152.614699] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[152.619079] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[152.725385] [022/156] (866s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[152.778232] Starting subtest: yf-tiled-to-vebox-yf-tiled
[152.782373] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[152.966100] [023/156] (866s left) gem_mmap_gtt (big-copy-odd)
[153.017241] Subtest big-copy-odd: SKIP (0.000s)
[153.074767] [024/156] (866s left) gem_eio (in-flight-contexts-10ms)
[153.290817] Starting subtest: in-flight-contexts-10ms
[167.341554] Subtest in-flight-contexts-10ms: SUCCESS (14.051s)
[167.477456] [025/156] (852s left) kms_cursor_edge_walk (256x256-top-bottom)
[167.578245] Starting subtest: 256x256-top-bottom
[167.580573] Starting dynamic subtest: pipe-A-eDP-1
[171.073328] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[171.082866] Starting dynamic subtest: pipe-D-eDP-1
[174.291401] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.215s)
[174.293602] Subtest 256x256-top-bottom: SUCCESS (6.713s)
[175.106418] [026/156] (844s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[175.479932] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[176.315697] [027/156] (843s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[176.417118] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[176.421260] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[176.524402] [028/156] (843s left) gem_exec_fence (submit)
[176.700956] Starting subtest: submit
[176.706446] Subtest submit: SKIP (0.000s)
[178.414409] [029/156] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[178.510461] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[178.514629] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[178.601295] [030/156] (841s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[178.689266] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[178.691179] Starting dynamic subtest: pipe-A-eDP-1
[179.589168] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[179.598564] Starting dynamic subtest: pipe-B-eDP-1
[181.305826] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.714s)
[181.316846] Starting dynamic subtest: pipe-C-eDP-1
[182.867452] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.559s)
[182.877981] Starting dynamic subtest: pipe-D-eDP-1
[184.456543] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.590s)
[184.458696] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.761s)
[185.689236] [031/156] (834s left) gem_ctx_sseu (mmap-args)
[185.767829] Subtest mmap-args: SKIP (0.000s)
[185.852260] [032/156] (834s left) syncobj_wait (multi-wait-signaled)
[185.899989] Starting subtest: multi-wait-signaled
[185.902480] Subtest multi-wait-signaled: SUCCESS (0.000s)
[185.995027] [033/156] (834s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[186.094787] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[186.098887] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[186.195818] [034/156] (833s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[186.297703] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[186.301921] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[186.399872] [035/156] (833s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[186.447184] Starting subtest: wait-all-for-submit-delayed-submit
[186.551850] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[186.644521] [036/156] (833s left) kms_psr (psr2-sprite-mmap-gtt)
[186.734209] Starting subtest: psr2-sprite-mmap-gtt
[186.736523] Starting dynamic subtest: eDP-1
[188.188579] Dynamic subtest eDP-1: SKIP (1.451s)
[188.193334] Subtest psr2-sprite-mmap-gtt: SKIP (1.453s)
[188.353184] [037/156] (831s left) gem_ctx_param (invalid-get-ringsize)
[188.408580] Starting subtest: invalid-get-ringsize
[188.411052] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[188.517020] [038/156] (831s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[188.618376] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[189.498216] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.881s)
[189.661993] [039/156] (830s left) i915_getparams_basic (basic-eu-total)
[189.723133] Starting subtest: basic-eu-total
[189.727626] Subtest basic-eu-total: SUCCESS (0.000s)
[189.810140] [040/156] (830s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[189.907835] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[189.912027] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[190.019971] [041/156] (830s left) kms_plane_multiple (2x-tiling-x)
[190.117261] Starting subtest: 2x-tiling-x
[190.121312] Subtest 2x-tiling-x: SKIP (0.000s)
[190.201789] [042/156] (830s left) api_intel_allocator (reloc-allocator)
[190.251608] Starting subtest: reloc-allocator
[190.254085] Starting dynamic subtest: basic
[190.256356] Dynamic subtest basic: SUCCESS (0.003s)
[190.266386] Starting dynamic subtest: parallel-one
[190.269099] Dynamic subtest parallel-one: SUCCESS (0.008s)
[190.278085] Starting dynamic subtest: print
[190.280219] Dynamic subtest print: SUCCESS (0.000s)
[190.288614] Starting dynamic subtest: reuse
[190.290593] Dynamic subtest reuse: SUCCESS (0.000s)
[190.299062] Starting dynamic subtest: fork-reopen-allocator
[190.300940] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[190.302820] Subtest reloc-allocator: SUCCESS (0.027s)
[190.396121] [043/156] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[190.487158] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[197.907070] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.423s)
[198.054643] [044/156] (822s left) api_intel_bb (object-reloc-keep-cache)
[198.120596] Starting subtest: object-reloc-keep-cache
[198.125261] Subtest object-reloc-keep-cache: SKIP (0.002s)
[198.239275] [045/156] (822s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[198.340208] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[198.349335] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[198.442769] [046/156] (822s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[198.577474] Starting subtest: basic-flip-after-cursor-legacy
[199.505206] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.926s)
[200.375788] [047/156] (820s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[200.445554] Starting subtest: invalid-bsd2-flag-on-blt
[200.447814] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[200.551189] [048/156] (820s left) gem_madvise (dontneed-before-mmap)
[200.587021] Starting subtest: dontneed-before-mmap
[200.615278] Subtest dontneed-before-mmap: SUCCESS (0.030s)
[200.714555] [049/156] (819s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[200.822687] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[200.826765] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[200.928232] [050/156] (819s left) gem_ctx_param (invalid-size-get)
[200.976328] Starting subtest: invalid-size-get
[200.978535] Subtest invalid-size-get: SUCCESS (0.001s)
[201.084957] [051/156] (819s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[201.177338] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[201.180087] Starting dynamic subtest: pipe-A-eDP-1
[201.466971] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.263s)
[201.478071] Starting dynamic subtest: pipe-B-eDP-1
[202.763647] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s)
[202.773240] Starting dynamic subtest: pipe-C-eDP-1
[204.050277] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.288s)
[204.059766] Starting dynamic subtest: pipe-D-eDP-1
[205.296927] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[205.298896] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.091s)
[206.504450] [052/156] (814s left) kms_prime (basic-crc-vgem)
[206.594872] Starting subtest: basic-crc-vgem
[206.596870] Starting dynamic subtest: second-to-first
[207.578350] Dynamic subtest second-to-first: SUCCESS (0.987s)
[207.580331] Subtest basic-crc-vgem: SUCCESS (0.988s)
[207.683966] [053/156] (813s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[207.806227] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[207.809481] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[207.907219] [054/156] (813s left) perf_pmu (most-busy-idle-check-all)
[207.946272] Starting subtest: most-busy-idle-check-all
[207.948115] Starting dynamic subtest: rcs0
[209.312663] Dynamic subtest rcs0: SUCCESS (1.364s)
[209.325084] Starting dynamic subtest: bcs0
[211.360574] Dynamic subtest bcs0: SUCCESS (2.045s)
[211.372810] Starting dynamic subtest: vcs0
[213.343445] Dynamic subtest vcs0: SUCCESS (1.980s)
[213.359434] Starting dynamic subtest: vcs1
[215.328869] Dynamic subtest vcs1: SUCCESS (1.982s)
[215.341892] Starting dynamic subtest: vecs0
[217.312108] Dynamic subtest vecs0: SUCCESS (1.980s)
[217.324059] Starting dynamic subtest: ccs0
[219.360549] Dynamic subtest ccs0: SUCCESS (2.046s)
[219.363534] Subtest most-busy-idle-check-all: SUCCESS (11.414s)
[219.473043] [055/156] (801s left) gem_exec_params (sol-reset-not-gen7)
[219.534318] Starting subtest: sol-reset-not-gen7
[219.543497] Subtest sol-reset-not-gen7: SUCCESS (0.006s)
[219.652131] [056/156] (801s left) gem_pxp (reject-modify-context-protection-off-1)
[219.769968] Starting subtest: reject-modify-context-protection-off-1
[219.772783] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[219.891078] [057/156] (801s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[219.950190] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[220.023880] [058/156] (801s left) kms_addfb_basic (unused-pitches)
[220.081817] Starting subtest: unused-pitches
[220.084105] Subtest unused-pitches: SUCCESS (0.000s)
[220.230332] [059/156] (800s left) gem_ctx_persistence (processes)
[220.293615] Starting subtest: processes
[222.321719] Subtest processes: SUCCESS (2.028s)
[222.400957] [060/156] (798s left) syncobj_wait (wait-all-for-submit-complex)
[222.450618] Starting subtest: wait-all-for-submit-complex
[222.662886] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[222.742989] [061/156] (798s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[222.838835] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[222.843356] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[222.931510] [062/156] (798s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[223.030140] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[223.032436] Starting dynamic subtest: pipe-A
[224.156843] Dynamic subtest pipe-A: SUCCESS (1.130s)
[224.166515] Starting dynamic subtest: pipe-B
[226.383782] Dynamic subtest pipe-B: SUCCESS (2.226s)
[226.392877] Starting dynamic subtest: pipe-C
[227.601392] Dynamic subtest pipe-C: SUCCESS (1.216s)
[227.611057] Starting dynamic subtest: pipe-D
[228.831542] Dynamic subtest pipe-D: SUCCESS (1.229s)
[228.833986] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.805s)
[230.026319] [063/156] (791s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu)
[230.125276] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu
[230.129844] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[230.227285] [064/156] (791s left) gem_exec_params (dr4-dirt)
[230.281645] Starting subtest: DR4-dirt
[230.283944] Subtest DR4-dirt: SUCCESS (0.000s)
[230.375346] [065/156] (791s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[230.466807] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[230.470919] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[230.549611] [066/156] (790s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[230.639672] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[230.651711] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[230.744326] [067/156] (790s left) kms_rotation_crc (bad-tiling)
[230.837249] Starting subtest: bad-tiling
[230.841701] Subtest bad-tiling: SKIP (0.001s)
[230.935080] [068/156] (790s left) prime_mmap (test_correct_cpu_write)
[230.986264] Starting subtest: test_correct_cpu_write
[230.987808] Starting dynamic subtest: test_correct_cpu_write-smem
[230.989393] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[230.990992] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[231.083467] [069/156] (790s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[231.168519] Starting subtest: crc-primary-suspend-y-tiled-ccs
[231.170510] Starting dynamic subtest: pipe-A-eDP-1
[231.178143] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.187978] Starting dynamic subtest: pipe-B-eDP-1
[231.195752] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.204982] Starting dynamic subtest: pipe-C-eDP-1
[231.212223] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.220938] Starting dynamic subtest: pipe-D-eDP-1
[231.228324] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.231832] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[233.516605] [070/156] (788s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[233.617186] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[233.621376] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[233.709415] [071/156] (787s left) fbdev (read)
[233.753494] Starting subtest: read
[234.279756] Subtest read: SUCCESS (0.527s)
[234.343310] [072/156] (787s left) kms_psr (psr-sprite-mmap-gtt)
[234.426142] Starting subtest: psr-sprite-mmap-gtt
[234.428615] Starting dynamic subtest: eDP-1
[235.909696] Dynamic subtest eDP-1: SKIP (1.480s)
[235.914379] Subtest psr-sprite-mmap-gtt: SKIP (1.483s)
[236.089069] [073/156] (785s left) gem_exec_suspend (basic-s4-devices)
[236.146775] Starting subtest: basic-S4-devices
[236.149128] Starting dynamic subtest: smem
[247.328754] Dynamic subtest smem: SUCCESS (11.179s)
[247.331930] Subtest basic-S4-devices: SUCCESS (11.182s)
[256.542102] [074/156] (774s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-onoff)
[256.674031] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-onoff
[256.678534] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[256.771192] [075/156] (774s left) sw_sync (sync_random_merge)
[256.806741] Starting subtest: sync_random_merge
[256.852426] Subtest sync_random_merge: SUCCESS (0.049s)
[256.916711] [076/156] (773s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[257.042415] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[257.046976] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[257.189041] [077/156] (773s left) gem_exec_schedule (preempt-other-chain)
[257.260027] Starting subtest: preempt-other-chain
[257.262212] Starting dynamic subtest: rcs0
[257.342487] Dynamic subtest rcs0: SUCCESS (0.087s)
[257.356984] Starting dynamic subtest: bcs0
[257.426453] Dynamic subtest bcs0: SUCCESS (0.082s)
[257.440503] Starting dynamic subtest: vcs0
[257.503381] Dynamic subtest vcs0: SUCCESS (0.078s)
[257.514716] Starting dynamic subtest: vcs1
[257.582585] Dynamic subtest vcs1: SUCCESS (0.078s)
[257.595939] Starting dynamic subtest: vecs0
[257.661083] Dynamic subtest vecs0: SUCCESS (0.078s)
[257.675328] Starting dynamic subtest: ccs0
[257.742366] Dynamic subtest ccs0: SUCCESS (0.081s)
[257.744312] Subtest preempt-other-chain: SUCCESS (0.489s)
[259.446094] [078/156] (771s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[259.538756] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[265.884235] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.349s)
[267.038301] [079/156] (763s left) gen7_exec_parse (basic-allowed)
[267.098299] Subtest basic-allowed: SKIP (0.000s)
[267.175326] [080/156] (763s left) kms_rotation_crc (exhaust-fences)
[267.274152] Starting subtest: exhaust-fences
[267.278219] Subtest exhaust-fences: SKIP (0.000s)
[267.348363] [081/156] (763s left) prime_self_import (basic-with_two_bos)
[267.385342] Starting subtest: basic-with_two_bos
[267.411583] Subtest basic-with_two_bos: SUCCESS (0.025s)
[267.521800] [082/156] (763s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[267.612616] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[267.616642] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[267.706311] [083/156] (763s left) gem_exec_schedule (u-semaphore-resolve)
[267.782052] Starting subtest: u-semaphore-resolve
[267.810489] Subtest u-semaphore-resolve: SUCCESS (0.035s)
[268.165263] [084/156] (763s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[268.268247] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[268.272615] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[268.373225] [085/156] (762s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[268.467104] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[268.469333] Starting dynamic subtest: pipe-A-default-mode
[269.600802] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[269.605262] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.131s)
[269.780931] [086/156] (761s left) kms_joiner (basic-max-non-joiner)
[269.885668] Starting subtest: basic-max-non-joiner
[269.889818] Subtest basic-max-non-joiner: SKIP (0.000s)
[269.957118] [087/156] (761s left) kms_psr (pr-sprite-plane-onoff)
[270.057321] Starting subtest: pr-sprite-plane-onoff
[270.061611] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[270.134870] [088/156] (761s left) gem_exec_params (invalid-ring)
[270.186079] Starting subtest: invalid-ring
[270.188463] Subtest invalid-ring: SUCCESS (0.000s)
[270.294922] [089/156] (761s left) kms_psr (pr-cursor-mmap-cpu)
[270.379047] Starting subtest: pr-cursor-mmap-cpu
[270.383583] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[270.452108] [090/156] (761s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[270.546456] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[270.550016] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[270.656599] [091/156] (760s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[270.751112] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[270.754644] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[270.848666] [092/156] (760s left) gem_create (create-valid-nonaligned)
[270.899169] Starting subtest: create-valid-nonaligned
[270.900888] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[271.087671] [093/156] (760s left) gen9_exec_parse (batch-zero-length)
[271.144282] Subtest batch-zero-length: SKIP (0.000s)
[271.230768] [094/156] (760s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[271.333654] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[271.337815] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[271.432757] [095/156] (760s left) gem_exec_balancer (parallel-contexts)
[271.696945] Starting subtest: parallel-contexts
[274.473345] Subtest parallel-contexts: SUCCESS (2.780s)
[275.352665] [096/156] (756s left) gem_workarounds (suspend-resume)
[275.416900] Starting subtest: suspend-resume
[291.852351] Subtest suspend-resume: SUCCESS (1.611s)
[303.059948] [097/156] (739s left) kms_vblank (wait-forked)
[303.186877] Starting subtest: wait-forked
[303.189206] Starting dynamic subtest: pipe-A-eDP-1
[304.995184] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[305.011373] Starting dynamic subtest: pipe-D-eDP-1
[307.516627] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.516s)
[307.518648] Subtest wait-forked: SUCCESS (4.328s)
[308.385225] [098/156] (734s left) i915_drm_fdinfo (all-busy-check-all)
[308.428805] Starting subtest: all-busy-check-all
[308.435679] Subtest all-busy-check-all: SKIP (0.004s)
[308.506390] [099/156] (734s left) gem_lmem_swapping (parallel-random)
[308.547447] Subtest parallel-random: SKIP (0.000s)
[308.591787] [100/156] (734s left) kms_dsc (dsc-fractional-bpp)
[308.700089] Starting subtest: dsc-fractional-bpp
[308.712779] Subtest dsc-fractional-bpp: SKIP (0.001s)
[308.788886] [101/156] (734s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[308.846999] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[308.849323] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[308.964363] [102/156] (734s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[309.063041] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[316.457096] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.329s)
[316.576746] [103/156] (726s left) kms_prop_blob (invalid-set-prop-any)
[316.646926] Starting subtest: invalid-set-prop-any
[316.649264] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[316.767675] [104/156] (726s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[316.868108] Starting subtest: fbchdr-tiling-4
[316.872297] Subtest fbchdr-tiling-4: SKIP (0.000s)
[316.961225] [105/156] (726s left) kms_lease (invalid-create-leases)
[317.063158] Starting subtest: invalid-create-leases
[317.068095] Subtest invalid-create-leases: SUCCESS (0.006s)
[317.172212] [106/156] (726s left) kms_color (ctm-max)
[317.278310] Starting subtest: ctm-max
[317.280453] Starting dynamic subtest: pipe-A-eDP-1
[318.011435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s)
[318.023423] Starting dynamic subtest: pipe-B-eDP-1
[319.405105] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s)
[319.419834] Starting dynamic subtest: pipe-C-eDP-1
[320.792608] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[320.804720] Starting dynamic subtest: pipe-D-eDP-1
[322.139686] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[322.141643] Subtest ctm-max: SUCCESS (4.842s)
[322.950349] [107/156] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[323.047523] Starting subtest: psr-1p-primscrn-spr-indfb-move
[330.505016] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.449s)
[330.632299] [108/156] (712s left) kms_sequence (queue-idle)
[330.716715] Starting subtest: queue-idle
[330.718592] Starting dynamic subtest: pipe-A-eDP-1
[332.529531] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[332.541895] Starting dynamic subtest: pipe-B-eDP-1
[334.968287] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.434s)
[334.979655] Starting dynamic subtest: pipe-C-eDP-1
[337.485553] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.515s)
[337.497985] Starting dynamic subtest: pipe-D-eDP-1
[339.923470] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.434s)
[339.925851] Subtest queue-idle: SUCCESS (9.198s)
[340.741021] [109/156] (702s left) kms_cursor_crc (cursor-random-128x42)
[340.964324] Starting subtest: cursor-random-128x42
[341.012769] Subtest cursor-random-128x42: SKIP (0.044s)
[341.210462] [110/156] (702s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[341.303388] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[341.307564] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[341.376699] [111/156] (702s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[341.463918] Starting subtest: modeset-transition-nonblocking-fencing
[341.466085] Starting dynamic subtest: 1x-outputs
[352.584857] Dynamic subtest 1x-outputs: SUCCESS (11.113s)
[352.587532] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.114s)
[353.465318] [112/156] (690s left) gem_exec_reloc (basic-gtt-cpu-active)
[353.529027] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[353.595166] [113/156] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[353.692600] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[353.696999] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[353.783852] [114/156] (689s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[353.881183] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[353.885378] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[353.982062] [115/156] (689s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[354.084067] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[354.086297] Starting dynamic subtest: pipe-A-eDP-1
[354.829288] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[354.840308] Starting dynamic subtest: pipe-B-eDP-1
[356.706214] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.875s)
[356.718432] Starting dynamic subtest: pipe-C-eDP-1
[358.533566] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.825s)
[358.544362] Starting dynamic subtest: pipe-D-eDP-1
[360.366842] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.830s)
[360.368891] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.273s)
[361.507684] [116/156] (682s left) i915_pm_rpm (gem-idle)
[363.338273] Starting subtest: gem-idle
[369.567844] Subtest gem-idle: SUCCESS (6.217s)
[369.907815] [117/156] (673s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[371.115423] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[371.118021] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[371.239960] [118/156] (672s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt)
[371.349065] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt
[371.353455] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[371.440935] [119/156] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[371.537239] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[371.541482] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[371.661299] [120/156] (672s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[371.759449] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[371.763593] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[371.857307] [121/156] (672s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[371.951580] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[373.086298] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.135s)
[373.201272] [122/156] (670s left) kms_content_protection (content-type-change)
[373.338372] Starting subtest: content-type-change
[373.342117] Subtest content-type-change: SKIP (0.000s)
[373.457109] [123/156] (670s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[373.551594] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[373.554862] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[373.644493] [124/156] (670s left) kms_rotation_crc (primary-rotation-180)
[373.730770] Starting subtest: primary-rotation-180
[380.702249] Subtest primary-rotation-180: SUCCESS (6.970s)
[381.891388] [125/156] (662s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[382.018365] Starting subtest: 2x-long-flip-vs-cursor-atomic
[382.023254] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[382.162861] [126/156] (661s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[382.265902] Starting subtest: 4-tiled-32bpp-rotate-90
[382.286517] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[382.404867] [127/156] (661s left) syncobj_eventfd (invalid-illegal-handle)
[382.451101] Starting subtest: invalid-illegal-handle
[382.452994] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[382.571687] [128/156] (661s left) gem_exec_params (invalid-flag)
[382.629402] Starting subtest: invalid-flag
[382.631856] Subtest invalid-flag: SUCCESS (0.000s)
[382.725128] [129/156] (661s left) prime_vgem (basic-fence-flip)
[382.805663] Starting subtest: basic-fence-flip
[383.120358] Subtest basic-fence-flip: SUCCESS (0.317s)
[383.226386] [130/156] (661s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[383.321035] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[383.325174] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[383.431241] [131/156] (660s left) gem_spin_batch (user-each)
[383.481442] Starting subtest: user-each
[386.754715] Subtest user-each: SUCCESS (3.264s)
[387.238662] [132/156] (657s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[387.336560] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[387.340535] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[387.436522] [133/156] (656s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[387.542626] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[387.544935] Starting dynamic subtest: pipe-A-eDP-1
[387.629569] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[387.641393] Starting dynamic subtest: pipe-B-eDP-1
[388.768045] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[388.772779] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.228s)
[389.970600] [134/156] (654s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[390.070608] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[390.075412] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[390.188163] [135/156] (654s left) gem_mmap_gtt (coherency)
[390.240609] Subtest coherency: SKIP (0.000s)
[390.308388] [136/156] (654s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[390.414804] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[390.419225] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[390.523675] [137/156] (654s left) kms_hdr (static-toggle-dpms)
[390.615142] Starting subtest: static-toggle-dpms
[390.621774] Subtest static-toggle-dpms: SKIP (0.000s)
[390.688044] [138/156] (653s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[390.782123] Starting subtest: fbc-pr-sprite-mmap-cpu
[390.786172] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[390.868373] [139/156] (653s left) gem_exec_whisper (basic-forked)
[390.930189] Starting subtest: basic-forked
[398.150105] Subtest basic-forked: SUCCESS (7.217s)
[398.342538] [140/156] (646s left) kms_frontbuffer_tracking (psrhdr-2p-rte)
[398.445991] Starting subtest: psrhdr-2p-rte
[398.450575] Subtest psrhdr-2p-rte: SKIP (0.000s)
[398.555287] [141/156] (646s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[398.649929] Starting subtest: addfb25-yf-tiled-legacy
[398.651821] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[398.741333] [142/156] (646s left) i915_suspend (fence-restore-tiled2untiled)
[398.792843] Starting subtest: fence-restore-tiled2untiled
[398.797671] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[398.896757] [143/156] (645s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[398.999890] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[403.455920] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.460s)
[404.656070] [144/156] (640s left) kms_psr (fbc-pr-sprite-plane-onoff)
[404.748882] Starting subtest: fbc-pr-sprite-plane-onoff
[404.753204] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[404.823435] [145/156] (640s left) kms_plane_cursor (viewport)
[404.914091] Starting subtest: viewport
[404.918534] Starting dynamic subtest: pipe-A-eDP-1-size-64
[407.497997] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.588s)
[407.561679] Starting dynamic subtest: pipe-A-eDP-1-size-128
[410.108401] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.562s)
[410.171018] Starting dynamic subtest: pipe-A-eDP-1-size-256
[412.740504] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[413.095078] Starting dynamic subtest: pipe-B-eDP-1-size-64
[416.398739] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.319s)
[416.462876] Starting dynamic subtest: pipe-B-eDP-1-size-128
[419.031315] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.582s)
[419.094108] Starting dynamic subtest: pipe-B-eDP-1-size-256
[421.664180] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[422.015532] Starting dynamic subtest: pipe-C-eDP-1-size-64
[424.979642] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.979s)
[425.018962] Starting dynamic subtest: pipe-C-eDP-1-size-128
[427.222237] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[427.262161] Starting dynamic subtest: pipe-C-eDP-1-size-256
[429.443873] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[429.776771] Starting dynamic subtest: pipe-D-eDP-1-size-64
[432.677190] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.917s)
[432.722500] Starting dynamic subtest: pipe-D-eDP-1-size-128
[434.899241] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.192s)
[434.939718] Starting dynamic subtest: pipe-D-eDP-1-size-256
[437.188319] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.259s)
[437.512392] Subtest viewport: SUCCESS (32.615s)
[438.341989] [146/156] (606s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[438.458149] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[438.462329] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[438.532786] [147/156] (606s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[438.634671] Starting subtest: x-tiled-16bpp-rotate-180
[439.902136] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.268s)
[440.021647] [148/156] (605s left) kms_cursor_crc (cursor-offscreen-128x42)
[440.251411] Starting subtest: cursor-offscreen-128x42
[440.298577] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[440.517610] [149/156] (604s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[440.613247] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[440.615222] Starting dynamic subtest: pipe-A-eDP-1
[440.634547] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[440.645672] Starting dynamic subtest: pipe-B-eDP-1
[440.663999] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[440.674440] Starting dynamic subtest: pipe-C-eDP-1
[440.692746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[440.702865] Starting dynamic subtest: pipe-D-eDP-1
[440.720890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[440.724498] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[442.910873] [150/156] (602s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[443.018422] Starting subtest: y-tiled-8bpp-rotate-90
[443.022930] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[443.128768] [151/156] (602s left) gem_mmap_offset (partial-remap)
[443.188037] Starting subtest: partial-remap
[443.190366] Starting dynamic subtest: smem0
[443.199286] Dynamic subtest smem0: SUCCESS (0.004s)
[443.201254] Subtest partial-remap: SUCCESS (0.004s)
[443.317955] [152/156] (601s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[443.428484] Starting subtest: yf-tiled-8bpp-rotate-90
[443.433061] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[443.522612] [153/156] (601s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[443.624754] Starting subtest: fbc-rgb565-draw-mmap-wc
[447.706531] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.086s)
[448.911534] [154/156] (596s left) kms_chamelium_edid (hdmi-mode-timings)
[449.286939] Subtest hdmi-mode-timings: SKIP (0.000s)
[450.120210] [155/156] (595s left) gem_workarounds (basic-read-context)
[450.181928] Starting subtest: basic-read-context
[450.194599] Subtest basic-read-context: SUCCESS (0.015s)
[450.330981] [156/156] (595s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move)
[450.426658] Starting subtest: hdr-1p-primscrn-cur-indfb-move
[450.430920] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[450.523764] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: core_sysfs
results: parsing output: 3/ for test: kms_pm_dc
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_ctx_engines
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_ppgtt
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_panel_fitting
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: sysfs_preempt_timeout
results: parsing output: 19/ for test: kms_atomic_transition
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: kms_cursor_edge_walk
results: parsing output: 25/ for test: kms_chamelium_hpd
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_ctx_sseu
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: i915_getparams_basic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_plane_multiple
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: api_intel_bb
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: gem_exec_params
results: parsing output: 47/ for test: gem_madvise
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_ctx_param
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_prime
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_rotation_crc
results: parsing output: 67/ for test: prime_mmap
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: fbdev
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_exec_suspend
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gen7_exec_parse
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: prime_self_import
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_joiner
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_create
results: parsing output: 92/ for test: gen9_exec_parse
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: gem_workarounds
results: parsing output: 96/ for test: kms_vblank
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: gem_lmem_swapping
results: parsing output: 99/ for test: kms_dsc
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_prop_blob
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_lease
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_sequence
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: kms_atomic_transition
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_content_protection
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_rotation_crc
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: syncobj_eventfd
results: parsing output: 127/ for test: gem_exec_params
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_spin_batch
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr2_sf
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_mmap_gtt
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_hdr
results: parsing output: 137/ for test: kms_psr
results: parsing output: 138/ for test: gem_exec_whisper
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_addfb_basic
results: parsing output: 141/ for test: i915_suspend
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_psr
results: parsing output: 144/ for test: kms_plane_cursor
results: parsing output: 145/ for test: kms_flip_scaled_crc
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: kms_cursor_crc
results: parsing output: 148/ for test: kms_ccs
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: gem_mmap_offset
results: parsing output: 151/ for test: kms_big_fb
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_chamelium_edid
results: parsing output: 154/ for test: gem_workarounds
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.