[145.770352] Initializing watchdogs
[145.770400]   /dev/watchdog0
[145.785467] [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]
[145.789824] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[145.792830] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[145.796253] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[145.925580] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[154.582920] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.660s)
[154.695927] [002/133] (951s left) gem_lmem_swapping (verify)
[154.739098] Subtest verify: SKIP (0.000s)
[154.777554] [003/133] (951s left) perf_pmu (init-busy)
[154.818504] Starting subtest: init-busy
[154.821039] Starting dynamic subtest: rcs0
[154.823588] Dynamic subtest rcs0: SUCCESS (0.002s)
[154.833057] Starting dynamic subtest: bcs0
[154.834972] Dynamic subtest bcs0: SUCCESS (0.001s)
[154.841984] Starting dynamic subtest: vcs0
[154.843912] Dynamic subtest vcs0: SUCCESS (0.001s)
[154.851049] Starting dynamic subtest: vcs1
[154.853034] Dynamic subtest vcs1: SUCCESS (0.000s)
[154.860236] Starting dynamic subtest: vecs0
[154.862128] Dynamic subtest vecs0: SUCCESS (0.001s)
[154.872333] Starting dynamic subtest: ccs0
[154.874600] Dynamic subtest ccs0: SUCCESS (0.001s)
[154.876813] Subtest init-busy: SUCCESS (0.006s)
[154.932169] [004/133] (951s left) gem_ctx_param (vm)
[154.985714] Starting subtest: vm
[155.032828] Subtest vm: SUCCESS (0.046s)
[155.156804] [005/133] (951s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[155.256105] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[155.258428] Starting dynamic subtest: pipe-A-eDP-1
[155.281744] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[155.290548] Starting dynamic subtest: pipe-B-eDP-1
[155.311635] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[155.319056] Starting dynamic subtest: pipe-C-eDP-1
[155.340056] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[155.347253] Starting dynamic subtest: pipe-D-eDP-1
[155.368760] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[155.373123] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[157.496796] [006/133] (948s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[157.621287] Starting subtest: cursorA-vs-flipB-legacy
[157.625923] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[157.780488] [007/133] (948s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[157.871909] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[157.876503] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[157.956872] [008/133] (948s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[158.046515] Starting subtest: dsc-fractional-bpp-with-bpc
[158.077444] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[158.118178] [009/133] (948s left) gem_ctx_param (non-root-set)
[158.184794] Starting subtest: non-root-set
[158.207618] Subtest non-root-set: SUCCESS (0.023s)
[158.291071] [010/133] (948s left) perf (enable-disable)
[158.410054] Starting subtest: enable-disable
[158.412232] Starting dynamic subtest: 0-rcs0
[160.679388] Dynamic subtest 0-rcs0: SUCCESS (2.268s)
[160.688676] Starting dynamic subtest: 1-vecs0
[165.174798] Dynamic subtest 1-vecs0: SUCCESS (4.495s)
[165.177332] Subtest enable-disable: SUCCESS (6.763s)
[165.221994] [011/133] (941s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[165.330027] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[165.334204] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[165.413965] [012/133] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[165.507955] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[172.601954] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.100s)
[172.725294] [013/133] (934s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[172.825433] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[172.829463] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[172.925008] [014/133] (933s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[173.031106] Starting subtest: 4-tiled-16bpp-rotate-90
[173.050130] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[173.151715] [015/133] (933s left) kms_color (ctm-red-to-blue)
[173.241720] Starting subtest: ctm-red-to-blue
[173.243602] Starting dynamic subtest: pipe-A-eDP-1
[173.951066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[173.960332] Starting dynamic subtest: pipe-B-eDP-1
[175.338242] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[175.347653] Starting dynamic subtest: pipe-C-eDP-1
[176.718974] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[176.726859] Starting dynamic subtest: pipe-D-eDP-1
[178.047628] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[178.049641] Subtest ctm-red-to-blue: SUCCESS (4.805s)
[178.845123] [016/133] (928s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[178.914872] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[178.919203] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[179.105700] [017/133] (927s left) gem_exec_flush (basic-wb-set-default)
[179.182541] Starting subtest: basic-wb-set-default
[184.666618] Subtest basic-wb-set-default: SUCCESS (5.466s)
[184.826644] [018/133] (922s left) gem_flink_basic (double-flink)
[184.882883] Starting subtest: double-flink
[184.885208] Subtest double-flink: SUCCESS (0.001s)
[184.982999] [019/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[185.091914] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[185.096069] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[185.200485] [020/133] (921s left) syncobj_wait (wait-zero-handles)
[185.266148] Starting subtest: wait-zero-handles
[185.268147] Subtest wait-zero-handles: SUCCESS (0.000s)
[185.375855] [021/133] (921s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[185.467562] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[185.472189] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[186.840772] [022/133] (920s left) gem_flink_basic (bad-flink)
[186.898850] Starting subtest: bad-flink
[186.900723] Subtest bad-flink: SUCCESS (0.000s)
[186.996555] [023/133] (920s left) kms_flip (2x-flip-vs-panning-interruptible)
[187.078775] Starting subtest: 2x-flip-vs-panning-interruptible
[187.090172] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[187.161051] [024/133] (920s left) kms_chamelium_hpd (dp-hpd-storm)
[187.544174] Subtest dp-hpd-storm: SKIP (0.000s)
[188.333016] [025/133] (918s left) gem_exec_schedule (noreorder-corked)
[188.507326] Starting subtest: noreorder-corked
[188.509689] Starting dynamic subtest: rcs0
[189.639468] Dynamic subtest rcs0: SUCCESS (1.132s)
[189.651080] Starting dynamic subtest: vcs0
[190.932871] Dynamic subtest vcs0: SUCCESS (1.292s)
[190.942150] Starting dynamic subtest: vcs1
[192.915385] Dynamic subtest vcs1: SUCCESS (1.981s)
[192.927034] Starting dynamic subtest: vecs0
[194.908383] Dynamic subtest vecs0: SUCCESS (1.992s)
[194.918672] Starting dynamic subtest: ccs0
[196.052978] Dynamic subtest ccs0: SUCCESS (1.145s)
[196.055822] Subtest noreorder-corked: SUCCESS (7.547s)
[196.234487] [026/133] (911s left) gem_mmap_gtt (flink-race)
[196.283882] Subtest flink-race: SKIP (0.000s)
[196.336554] [027/133] (910s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[196.431787] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[196.434142] Starting dynamic subtest: pipe-A-default-mode
[199.222086] Dynamic subtest pipe-A-default-mode: SUCCESS (2.789s)
[199.224867] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.790s)
[200.044487] [028/133] (907s left) gen9_exec_parse (bb-start-far)
[200.096996] Subtest bb-start-far: SKIP (0.000s)
[200.164297] [029/133] (907s left) gem_exec_fence (invalid-timeline-fence-array)
[200.720795] Starting subtest: invalid-timeline-fence-array
[200.726833] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[202.011401] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[202.014584] [030/133] (905s left) gem_mmap_gtt (basic-read)
[202.074062] Subtest basic-read: SKIP (0.000s)
[202.134246] [031/133] (905s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[202.236145] Starting subtest: psr-farfromfence-mmap-gtt
[202.240374] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[202.365176] [032/133] (905s left) gem_tiled_pread_pwrite
[202.480452] [033/133] (905s left) perf (non-zero-reason)
[202.581640] Starting subtest: non-zero-reason
[202.583516] Starting dynamic subtest: 0-rcs0
[208.032902] Dynamic subtest 0-rcs0: SUCCESS (5.399s)
[208.042634] Starting dynamic subtest: 1-vecs0
[211.874946] Dynamic subtest 1-vecs0: SUCCESS (3.893s)
[211.877996] Subtest non-zero-reason: SUCCESS (9.294s)
[211.921615] [034/133] (895s left) kms_legacy_colorkey (basic)
[212.038995] Starting subtest: basic
[212.041296] Starting dynamic subtest: pipe-A
[212.083054] Dynamic subtest pipe-A: SUCCESS (0.045s)
[212.093798] Starting dynamic subtest: pipe-B
[212.096212] Dynamic subtest pipe-B: SUCCESS (0.001s)
[212.104030] Starting dynamic subtest: pipe-C
[212.106553] Dynamic subtest pipe-C: SUCCESS (0.001s)
[212.114089] Starting dynamic subtest: pipe-D
[212.116151] Dynamic subtest pipe-D: SUCCESS (0.000s)
[212.118110] Subtest basic: SUCCESS (0.049s)
[212.155609] [035/133] (895s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[212.300621] Starting subtest: dp-mst-type-0-suspend-resume
[212.305168] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[212.427348] [036/133] (895s left) api_intel_allocator (simple-allocator)
[212.483079] Starting subtest: simple-allocator
[212.485092] Starting dynamic subtest: basic
[212.487565] Dynamic subtest basic: SUCCESS (0.004s)
[212.500486] Starting dynamic subtest: parallel-one
[212.673053] Dynamic subtest parallel-one: SUCCESS (0.186s)
[212.682274] Starting dynamic subtest: print
[212.684561] Dynamic subtest print: SUCCESS (0.000s)
[212.692844] Starting dynamic subtest: reuse
[212.695111] Dynamic subtest reuse: SUCCESS (0.000s)
[212.703084] Starting dynamic subtest: reserve
[212.705290] Dynamic subtest reserve: SUCCESS (0.000s)
[212.713229] Starting dynamic subtest: fork-reopen-allocator
[212.715484] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[212.717764] Subtest simple-allocator: SUCCESS (0.207s)
[212.819441] [037/133] (894s left) kms_big_fb (linear-16bpp-rotate-270)
[212.931211] Starting subtest: linear-16bpp-rotate-270
[212.949615] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[213.062847] [038/133] (894s left) gem_tiled_pread_basic (basic)
[213.118847] Subtest basic: SKIP (0.000s)
[213.184976] [039/133] (894s left) gem_busy (close-race)
[213.248400] Starting subtest: close-race
[236.893565] Subtest close-race: SUCCESS (23.644s)
[237.300832] [040/133] (870s left) gem_exec_flush (basic-batch-kernel-default-wb)
[237.418125] Starting subtest: basic-batch-kernel-default-wb
[244.148149] Subtest basic-batch-kernel-default-wb: SUCCESS (6.732s)
[244.335427] [041/133] (863s left) kms_plane_multiple (2x-tiling-none)
[244.440653] Starting subtest: 2x-tiling-none
[244.444967] Subtest 2x-tiling-none: SKIP (0.000s)
[244.508949] [042/133] (863s left) kms_psr (psr-primary-mmap-gtt)
[244.598593] Starting subtest: psr-primary-mmap-gtt
[244.600789] Starting dynamic subtest: eDP-1
[246.051571] Dynamic subtest eDP-1: SKIP (1.449s)
[246.055868] Subtest psr-primary-mmap-gtt: SKIP (1.450s)
[246.200918] [043/133] (861s left) kms_vblank (ts-continuation-idle-hang)
[246.290911] Starting subtest: ts-continuation-idle-hang
[246.293150] Starting dynamic subtest: pipe-A-eDP-1
[272.667582] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.373s)
[272.688131] Starting dynamic subtest: pipe-D-eDP-1
[287.645777] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s)
[287.648574] Subtest ts-continuation-idle-hang: SUCCESS (41.351s)
[288.440858] [044/133] (819s left) syncobj_timeline (host-signal-ordered)
[288.500522] Starting subtest: host-signal-ordered
[288.502972] Subtest host-signal-ordered: SUCCESS (0.001s)
[288.593912] [045/133] (819s left) gem_mmap_wc (write-prefaulted)
[288.654443] Subtest write-prefaulted: SKIP (0.000s)
[288.716978] [046/133] (819s left) gem_mmap_gtt (big-bo-tiledy)
[288.774066] Subtest big-bo-tiledY: SKIP (0.000s)
[288.833278] [047/133] (819s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[288.929919] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[288.932389] Starting dynamic subtest: pipe-A-eDP-1
[294.833650] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.908s)
[294.845187] Starting dynamic subtest: pipe-B-eDP-1
[301.468284] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.629s)
[301.470510] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.543s)
[302.336738] [048/133] (805s left) gem_exec_balancer (bonded-sync)
[302.416082] Starting subtest: bonded-sync
[302.420762] Subtest bonded-sync: SKIP (0.000s)
[302.710393] [049/133] (805s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[302.761494] Starting subtest: multi-wait-for-submit-unsubmitted
[302.867066] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[302.943189] [050/133] (805s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[303.047297] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[307.678239] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.634s)
[308.838313] [051/133] (799s left) gem_busy (parallel)
[309.027365] Starting subtest: parallel
[309.029588] Starting dynamic subtest: rcs0
[310.936389] Dynamic subtest rcs0: SUCCESS (1.909s)
[310.954621] Starting dynamic subtest: bcs0
[312.855061] Dynamic subtest bcs0: SUCCESS (1.916s)
[312.865500] Starting dynamic subtest: vcs0
[314.955775] Dynamic subtest vcs0: SUCCESS (2.046s)
[314.968183] Starting dynamic subtest: vcs1
[316.888333] Dynamic subtest vcs1: SUCCESS (1.983s)
[316.899645] Starting dynamic subtest: vecs0
[318.988044] Dynamic subtest vecs0: SUCCESS (2.045s)
[318.998767] Starting dynamic subtest: ccs0
[320.920023] Dynamic subtest ccs0: SUCCESS (1.982s)
[320.923052] Subtest parallel: SUCCESS (11.895s)
[321.163866] [052/133] (787s left) gem_exec_reloc (basic-write-read-noreloc)
[321.225468] Subtest basic-write-read-noreloc: SKIP (0.000s)
[321.293657] [053/133] (787s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[321.388740] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[321.391016] Starting dynamic subtest: pipe-A-eDP-1
[332.373649] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.986s)
[332.383874] Starting dynamic subtest: pipe-B-eDP-1
[344.052083] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.679s)
[344.054366] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.667s)
[344.902813] [054/133] (763s left) kms_properties (colorop-properties-atomic)
[344.987150] Starting subtest: colorop-properties-atomic
[344.989488] Starting dynamic subtest: pipe-A-eDP-1
[345.349840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[345.359452] Starting dynamic subtest: pipe-B-eDP-1
[346.446657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.097s)
[346.458335] Starting dynamic subtest: pipe-C-eDP-1
[347.481972] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.035s)
[347.492549] Starting dynamic subtest: pipe-D-eDP-1
[348.522630] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.038s)
[348.525024] Subtest colorop-properties-atomic: SUCCESS (3.537s)
[349.315898] [055/133] (759s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[349.418609] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[356.420584] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (7.004s)
[356.534536] [056/133] (751s left) gem_render_copy (x-tiled)
[356.599461] Starting subtest: x-tiled
[356.601723] Starting dynamic subtest: smem
[356.641887] Dynamic subtest smem: SUCCESS (0.042s)
[356.644438] Subtest x-tiled: SUCCESS (0.043s)
[356.877103] [057/133] (751s left) gem_exec_reloc (basic-wc-gtt-active)
[356.939762] Subtest basic-wc-gtt-active: SKIP (0.000s)
[357.011982] [058/133] (751s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[357.115882] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[357.120303] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[357.223353] [059/133] (751s left) gem_render_linear_blits (basic)
[357.285769] Starting subtest: basic
[357.303717] Subtest basic: SUCCESS (0.021s)
[357.392893] [060/133] (751s left) syncobj_timeline (multi-wait-for-submit-signaled)
[357.450873] Starting subtest: multi-wait-for-submit-signaled
[357.453073] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[357.548947] [061/133] (751s left) kms_psr (pr-sprite-plane-onoff)
[357.651350] Starting subtest: pr-sprite-plane-onoff
[357.655769] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[357.724104] [062/133] (751s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[357.826584] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[361.840425] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.016s)
[362.981512] [063/133] (745s left) gem_ppgtt (flink-and-close-vma-leak)
[363.034791] Starting subtest: flink-and-close-vma-leak
[363.077772] Subtest flink-and-close-vma-leak: SUCCESS (0.043s)
[363.223499] [064/133] (745s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[363.339777] Starting subtest: 2x-flip-vs-cursor-legacy
[363.344565] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[363.486670] [065/133] (745s left) vgem_basic (sysfs)
[363.535822] Starting subtest: sysfs
[363.538052] Subtest sysfs: SUCCESS (0.000s)
[363.597782] [066/133] (745s left) kms_psr (fbc-pr-primary-mmap-gtt)
[363.693328] Starting subtest: fbc-pr-primary-mmap-gtt
[363.697416] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[363.779835] [067/133] (745s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[363.845312] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[363.847614] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[363.936034] [068/133] (745s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[364.037470] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[364.039374] Starting dynamic subtest: pipe-A-eDP-1
[364.058344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[364.067239] Starting dynamic subtest: pipe-B-eDP-1
[364.085367] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[364.093542] Starting dynamic subtest: pipe-C-eDP-1
[364.111212] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[364.120806] Starting dynamic subtest: pipe-D-eDP-1
[364.139057] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[364.142470] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[366.332438] [069/133] (742s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[366.432044] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[366.552797] [070/133] (742s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[366.609456] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[366.691984] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.029s)
[366.732937] [071/133] (742s left) syncobj_wait (reset-multiple-signaled)
[366.793332] Starting subtest: reset-multiple-signaled
[366.795274] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[366.887819] [072/133] (742s left) gem_exec_schedule (semaphore-codependency)
[366.950858] Starting subtest: semaphore-codependency
[366.955578] Subtest semaphore-codependency: SUCCESS (0.013s)
[367.290548] [073/133] (741s left) drm_read (invalid-buffer)
[367.438049] Starting subtest: invalid-buffer
[367.440123] Subtest invalid-buffer: SUCCESS (0.000s)
[367.566353] [074/133] (741s left) gem_mmap_gtt (basic-write-gtt)
[367.619491] Subtest basic-write-gtt: SKIP (0.000s)
[367.684539] [075/133] (741s left) gem_exec_balancer (sliced)
[367.755942] Starting subtest: sliced
[367.760334] Subtest sliced: SKIP (0.000s)
[368.062934] [076/133] (741s left) syncobj_timeline (wait-any-interrupted)
[368.122353] Starting subtest: wait-any-interrupted
[368.228227] Subtest wait-any-interrupted: SUCCESS (0.104s)
[368.315671] [077/133] (741s left) kms_chamelium_color (ctm-0-50)
[368.411541] Subtest ctm-0-50: SKIP (0.000s)
[368.455462] [078/133] (740s left) gem_exec_store (cachelines)
[368.519575] Starting subtest: cachelines
[368.521538] Starting dynamic subtest: rcs0
[368.599784] Dynamic subtest rcs0: SUCCESS (0.082s)
[368.611249] Starting dynamic subtest: bcs0
[368.660447] Dynamic subtest bcs0: SUCCESS (0.058s)
[368.671162] Starting dynamic subtest: vcs0
[368.717230] Dynamic subtest vcs0: SUCCESS (0.055s)
[368.729932] Starting dynamic subtest: vcs1
[368.785410] Dynamic subtest vcs1: SUCCESS (0.066s)
[368.796767] Starting dynamic subtest: vecs0
[368.856034] Dynamic subtest vecs0: SUCCESS (0.068s)
[368.867328] Starting dynamic subtest: ccs0
[368.915477] Dynamic subtest ccs0: SUCCESS (0.058s)
[368.917845] Subtest cachelines: SUCCESS (0.399s)
[369.100781] [079/133] (740s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[369.358596] Starting subtest: cursor-rapid-movement-256x256
[369.363411] Starting dynamic subtest: pipe-A-eDP-1
[369.930407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[369.961706] Starting dynamic subtest: pipe-D-eDP-1
[371.126629] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.173s)
[371.128968] Subtest cursor-rapid-movement-256x256: SUCCESS (1.768s)
[371.966499] [080/133] (737s left) perf_pmu (frequency)
[372.010744] Starting subtest: frequency
[372.016634] Starting dynamic subtest: gt0
[374.198980] Dynamic subtest gt0: SUCCESS (2.179s)
[374.210147] Starting dynamic subtest: idle-gt0
[374.704631] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[374.716601] Starting dynamic subtest: gt1
[378.879752] Dynamic subtest gt1: SUCCESS (4.170s)
[378.889354] Starting dynamic subtest: idle-gt1
[379.417336] Dynamic subtest idle-gt1: SUCCESS (0.537s)
[379.420076] Subtest frequency: SUCCESS (7.407s)
[379.521019] [081/133] (730s left) kms_big_fb (x-tiled-addfb)
[379.642659] Starting subtest: x-tiled-addfb
[379.645065] Subtest x-tiled-addfb: SUCCESS (0.000s)
[379.746627] [082/133] (729s left) gem_ctx_shared (q-independent)
[379.805382] Starting subtest: Q-independent
[379.807716] Starting dynamic subtest: rcs0
[379.874574] Dynamic subtest rcs0: SUCCESS (0.068s)
[379.885509] Starting dynamic subtest: vcs0
[379.917156] Dynamic subtest vcs0: SUCCESS (0.042s)
[379.932180] Starting dynamic subtest: vcs1
[379.954760] Dynamic subtest vcs1: SUCCESS (0.037s)
[379.966621] Starting dynamic subtest: vecs0
[379.993471] Dynamic subtest vecs0: SUCCESS (0.038s)
[380.003634] Starting dynamic subtest: ccs0
[380.047620] Dynamic subtest ccs0: SUCCESS (0.053s)
[380.050194] Subtest Q-independent: SUCCESS (0.242s)
[381.997268] [083/133] (727s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[382.085890] Starting subtest: compare-crc-sanitycheck-xr24
[382.087828] Starting dynamic subtest: pipe-A-eDP-1
[382.712704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[382.722125] Starting dynamic subtest: pipe-B-eDP-1
[383.972287] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[383.981407] Starting dynamic subtest: pipe-C-eDP-1
[385.250472] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.276s)
[385.261080] Starting dynamic subtest: pipe-D-eDP-1
[386.481094] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[386.483369] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.397s)
[387.317860] [084/133] (722s left) kms_cursor_edge_walk (128x128-left-edge)
[387.409760] Starting subtest: 128x128-left-edge
[387.411975] Starting dynamic subtest: pipe-A-eDP-1
[390.867938] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.457s)
[390.877943] Starting dynamic subtest: pipe-D-eDP-1
[393.990238] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[393.992545] Subtest 128x128-left-edge: SUCCESS (6.583s)
[394.801510] [085/133] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[394.914629] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[394.919045] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[395.021929] [086/133] (714s left) gem_exec_flush (basic-wb-ro-before-default)
[395.082758] Starting subtest: basic-wb-ro-before-default
[400.565172] Subtest basic-wb-ro-before-default: SUCCESS (5.462s)
[400.733420] [087/133] (709s left) kms_psr (psr2-cursor-mmap-cpu)
[400.829813] Starting subtest: psr2-cursor-mmap-cpu
[400.832082] Starting dynamic subtest: eDP-1
[402.610786] Dynamic subtest eDP-1: SUCCESS (1.782s)
[402.613062] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.783s)
[403.474185] [088/133] (706s left) i915_selftest (perf)
[405.265373] Starting subtest: perf
[405.268032] Starting dynamic subtest: engine_cs
[409.729029] Dynamic subtest engine_cs: SUCCESS (4.462s)
[409.738548] Starting dynamic subtest: request
[417.002854] Dynamic subtest request: SUCCESS (7.272s)
[417.013249] Starting dynamic subtest: migrate
[421.339037] Dynamic subtest migrate: SUCCESS (4.335s)
[421.348755] Starting dynamic subtest: region
[427.074373] Dynamic subtest region: SUCCESS (5.735s)
[427.077239] Subtest perf: SUCCESS (21.809s)
[427.106233] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[427.106974] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[427.110073] [089/133] (682s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[428.714398] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[428.718689] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[428.814410] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[428.816153] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[428.819999] [090/133] (681s left) dumb_buffer (map-invalid-size)
[428.891741] Starting subtest: map-invalid-size
[428.894031] Subtest map-invalid-size: SUCCESS (0.000s)
[429.000275] [091/133] (680s left) kms_chamelium_frames (hdmi-frame-dump)
[429.401472] Subtest hdmi-frame-dump: SKIP (0.000s)
[430.238119] [092/133] (679s left) syncobj_wait (invalid-reset-zero-handles)
[430.305184] Starting subtest: invalid-reset-zero-handles
[430.307523] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[430.417221] [093/133] (679s left) gem_tiled_swapping (non-threaded)
[430.475328] Subtest non-threaded: SKIP (0.000s)
[430.540448] [094/133] (679s left) prime_vgem (basic-fence-read)
[430.614522] Starting subtest: basic-fence-read
[430.622318] Subtest basic-fence-read: SKIP (0.005s)
[430.744355] [095/133] (679s left) gem_pxp (hw-rejects-pxp-buffer)
[430.876848] Starting subtest: hw-rejects-pxp-buffer
[430.881532] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[430.982906] [096/133] (679s left) kms_plane (plane-position-hole-dpms)
[431.078125] Starting subtest: plane-position-hole-dpms
[431.597855] Starting dynamic subtest: pipe-A-plane-1
[433.971055] Dynamic subtest pipe-A-plane-1: SUCCESS (2.373s)
[433.980146] Starting dynamic subtest: pipe-A-plane-2
[436.422824] Dynamic subtest pipe-A-plane-2: SUCCESS (2.454s)
[436.432651] Starting dynamic subtest: pipe-A-plane-3
[438.865481] Dynamic subtest pipe-A-plane-3: SUCCESS (2.439s)
[438.874927] Starting dynamic subtest: pipe-A-plane-4
[441.209519] Dynamic subtest pipe-A-plane-4: SUCCESS (2.342s)
[441.219098] Starting dynamic subtest: pipe-A-plane-5
[441.233224] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[442.414918] Starting dynamic subtest: pipe-B-plane-1
[444.828670] Dynamic subtest pipe-B-plane-1: SUCCESS (2.420s)
[444.838056] Starting dynamic subtest: pipe-B-plane-2
[447.184952] Dynamic subtest pipe-B-plane-2: SUCCESS (2.356s)
[447.195843] Starting dynamic subtest: pipe-B-plane-3
[449.561898] Dynamic subtest pipe-B-plane-3: SUCCESS (2.374s)
[449.570897] Starting dynamic subtest: pipe-B-plane-4
[451.939911] Dynamic subtest pipe-B-plane-4: SUCCESS (2.379s)
[451.951576] Starting dynamic subtest: pipe-B-plane-5
[451.966103] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[451.968344] Subtest plane-position-hole-dpms: SUCCESS (20.888s)
[452.741596] [097/133] (657s left) gem_basic (create-close)
[452.807020] Starting subtest: create-close
[452.811505] Subtest create-close: SUCCESS (0.000s)
[452.912279] [098/133] (657s left) kms_flip (2x-flip-vs-dpms-on-nop)
[453.007073] Starting subtest: 2x-flip-vs-dpms-on-nop
[453.016286] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[453.105653] [099/133] (657s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[453.204576] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[453.208710] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[453.301798] [100/133] (657s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[455.148722] Starting subtest: dpms-mode-unset-non-lpsp
[456.298949] Subtest dpms-mode-unset-non-lpsp: SKIP (1.154s)
[456.681482] [101/133] (653s left) gem_madvise (dontneed-after-mmap)
[456.721783] Starting subtest: dontneed-after-mmap
[456.738563] Subtest dontneed-after-mmap: SUCCESS (0.020s)
[456.838594] [102/133] (653s left) gem_cs_tlb (engines)
[456.892981] Starting subtest: engines
[456.895706] Starting dynamic subtest: rcs0
[459.048700] Dynamic subtest rcs0: SUCCESS (2.152s)
[459.060060] Starting dynamic subtest: bcs0
[461.253786] Dynamic subtest bcs0: SUCCESS (2.151s)
[461.263497] Starting dynamic subtest: vcs0
[463.404902] Dynamic subtest vcs0: SUCCESS (2.152s)
[463.418060] Starting dynamic subtest: vcs1
[465.558069] Dynamic subtest vcs1: SUCCESS (2.152s)
[465.569722] Starting dynamic subtest: vecs0
[467.711913] Dynamic subtest vecs0: SUCCESS (2.152s)
[467.723682] Starting dynamic subtest: ccs0
[469.865107] Dynamic subtest ccs0: SUCCESS (2.152s)
[469.867638] Subtest engines: SUCCESS (12.916s)
[469.937516] [103/133] (640s left) kms_pm_rpm (system-suspend-idle)
[472.066886] Starting subtest: system-suspend-idle
[491.499038] Subtest system-suspend-idle: SUCCESS (4.625s)
[491.895392] [104/133] (618s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[492.006470] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[492.008786] Starting dynamic subtest: pipe-A-eDP-1
[492.018188] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[492.033484] Starting dynamic subtest: pipe-B-eDP-1
[492.042966] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[492.052303] Starting dynamic subtest: pipe-C-eDP-1
[492.060948] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.070225] Starting dynamic subtest: pipe-D-eDP-1
[492.078904] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.083186] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[494.246309] [105/133] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[494.343261] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[494.348008] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[494.443679] [106/133] (616s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[494.560572] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[499.292593] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.727s)
[500.462260] [107/133] (610s left) gem_ctx_persistence (many-contexts)
[500.543007] Starting subtest: many-contexts
[538.226651] Subtest many-contexts: SUCCESS (37.669s)
[538.309989] [108/133] (572s left) kms_invalid_mode (bad-hsync-end)
[538.408822] Starting subtest: bad-hsync-end
[538.411105] Starting dynamic subtest: pipe-A-eDP-1
[538.691022] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[538.701866] Starting dynamic subtest: pipe-B-eDP-1
[538.703825] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[538.712971] Starting dynamic subtest: pipe-C-eDP-1
[538.715213] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[538.724266] Starting dynamic subtest: pipe-D-eDP-1
[538.726452] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[538.728744] Subtest bad-hsync-end: SUCCESS (0.291s)
[539.574591] [109/133] (571s left) syncobj_timeline (device-submit-unordered)
[539.634356] Starting subtest: device-submit-unordered
[539.636813] Subtest device-submit-unordered: SUCCESS (0.001s)
[539.740889] [110/133] (571s left) kms_atomic (atomic-plane-damage)
[539.830370] Starting subtest: atomic-plane-damage
[539.880676] Starting dynamic subtest: pipe-A-eDP-1
[540.453842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[540.456079] Subtest atomic-plane-damage: SUCCESS (0.624s)
[541.308717] [111/133] (569s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[541.442039] Starting subtest: 2x-long-cursor-vs-flip-atomic
[541.446382] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[541.600224] [112/133] (569s left) gem_exec_params (invalid-batch-start-offset)
[541.657201] Starting subtest: invalid-batch-start-offset
[541.662241] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[541.770549] [113/133] (569s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[541.823535] Starting subtest: multi-wait-all-for-submit-signaled
[541.825793] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[541.925896] [114/133] (569s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[542.018689] Starting subtest: drrs-dirtyfb-ioctl
[542.031429] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[542.123793] [115/133] (568s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[542.223895] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[542.227965] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[542.321318] [116/133] (568s left) kms_vblank (invalid)
[542.413169] Starting subtest: invalid
[542.414907] Starting dynamic subtest: pipe-A-eDP-1
[542.823184] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[542.825101] Subtest invalid: SUCCESS (0.409s)
[543.637771] [117/133] (567s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[543.744346] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[544.379929] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[544.551598] [118/133] (566s left) gem_partial_pwrite_pread (reads-snoop)
[544.621856] Subtest reads-snoop: SKIP (0.000s)
[544.693872] [119/133] (566s left) kms_properties (get_properties-sanity-non-atomic)
[544.802376] Starting subtest: get_properties-sanity-non-atomic
[544.804666] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[544.879754] [120/133] (566s left) syncobj_wait (single-wait-all-for-submit-signaled)
[544.945700] Starting subtest: single-wait-all-for-submit-signaled
[544.947872] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[545.055122] [121/133] (566s left) gem_spin_batch (resubmit-all)
[545.124473] Starting subtest: resubmit-all
[545.126768] Starting dynamic subtest: rcs0
[545.135206] Dynamic subtest rcs0: SUCCESS (0.011s)
[545.146935] Starting dynamic subtest: bcs0
[545.149064] Dynamic subtest bcs0: SUCCESS (0.002s)
[545.158526] Starting dynamic subtest: vcs0
[545.160702] Dynamic subtest vcs0: SUCCESS (0.002s)
[545.170097] Starting dynamic subtest: vcs1
[545.172261] Dynamic subtest vcs1: SUCCESS (0.002s)
[545.181631] Starting dynamic subtest: vecs0
[545.184074] Dynamic subtest vecs0: SUCCESS (0.002s)
[545.193375] Starting dynamic subtest: ccs0
[545.195698] Dynamic subtest ccs0: SUCCESS (0.002s)
[545.197840] Subtest resubmit-all: SUCCESS (0.025s)
[546.769260] [122/133] (564s left) kms_rotation_crc (sprite-rotation-180)
[546.857546] Starting subtest: sprite-rotation-180
[553.667684] Subtest sprite-rotation-180: SUCCESS (6.811s)
[554.896383] [123/133] (556s left) kms_psr (fbc-psr-cursor-plane-onoff)
[554.999676] Starting subtest: fbc-psr-cursor-plane-onoff
[555.001823] Starting dynamic subtest: eDP-1
[555.005737] Dynamic subtest eDP-1: SKIP (0.000s)
[555.009690] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[555.088572] [124/133] (556s left) gem_exec_whisper (basic-queues-priority-all)
[555.148727] Starting subtest: basic-queues-priority-all
[574.949470] Subtest basic-queues-priority-all: SUCCESS (19.791s)
[575.142128] [125/133] (536s left) i915_hangman (engine-engine-hang)
[575.208936] Starting subtest: engine-engine-hang
[575.211772] Starting dynamic subtest: rcs0
[576.646553] Dynamic subtest rcs0: SUCCESS (1.437s)
[576.657908] Starting dynamic subtest: bcs0
[578.694021] Dynamic subtest bcs0: SUCCESS (2.043s)
[578.708001] Starting dynamic subtest: vcs0
[580.677651] Dynamic subtest vcs0: SUCCESS (1.980s)
[580.690634] Starting dynamic subtest: vcs1
[582.661520] Dynamic subtest vcs1: SUCCESS (1.980s)
[582.674915] Starting dynamic subtest: vecs0
[584.645436] Dynamic subtest vecs0: SUCCESS (1.981s)
[584.662311] Starting dynamic subtest: ccs0
[586.693577] Dynamic subtest ccs0: SUCCESS (2.046s)
[586.696317] Subtest engine-engine-hang: SUCCESS (11.485s)
[586.776657] [126/133] (524s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[586.877768] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[586.880156] Starting dynamic subtest: pipe-A
[587.105026] Dynamic subtest pipe-A: SUCCESS (0.229s)
[587.115496] Starting dynamic subtest: pipe-B
[588.413106] Dynamic subtest pipe-B: SUCCESS (1.308s)
[588.423570] Starting dynamic subtest: pipe-C
[589.715094] Dynamic subtest pipe-C: SUCCESS (1.301s)
[589.725100] Starting dynamic subtest: pipe-D
[591.038114] Dynamic subtest pipe-D: SUCCESS (1.321s)
[591.040973] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.165s)
[592.238274] [127/133] (519s left) i915_pm_rpm (sysfs-read)
[593.769539] Starting subtest: sysfs-read
[594.928865] Subtest sysfs-read: SUCCESS (1.157s)
[595.314166] [128/133] (516s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[595.417334] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[602.324667] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.912s)
[602.454010] [129/133] (509s left) kms_cursor_crc (cursor-offscreen-256x85)
[602.696535] Starting subtest: cursor-offscreen-256x85
[602.744087] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[602.907004] [130/133] (508s left) api_intel_bb (object-reloc-purge-cache)
[602.956777] Starting subtest: object-reloc-purge-cache
[602.961245] Subtest object-reloc-purge-cache: SKIP (0.002s)
[603.061550] [131/133] (508s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[603.160537] Starting subtest: y-tiled-64bpp-rotate-270
[603.165036] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[603.264142] [132/133] (508s left) prime_udl
[603.362014] [133/133] (508s left) i915_drm_fdinfo (virtual-busy-all)
[603.401254] Starting subtest: virtual-busy-all
[603.404855] Subtest virtual-busy-all: SKIP (0.000s)
[603.488490] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_lmem_swapping
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: kms_dsc
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: perf
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_color
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: gem_exec_flush
results: parsing output: 17/ for test: gem_flink_basic
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_flink_basic
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_chamelium_hpd
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_tiled_pread_pwrite
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: kms_legacy_colorkey
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_tiled_pread_basic
results: parsing output: 38/ for test: gem_busy
results: parsing output: 39/ for test: gem_exec_flush
results: parsing output: 40/ for test: kms_plane_multiple
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_mmap_wc
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_busy
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_properties
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_render_linear_blits
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ppgtt
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: vgem_basic
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: sriov_basic
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: drm_read
results: parsing output: 73/ for test: gem_mmap_gtt
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_chamelium_color
results: parsing output: 77/ for test: gem_exec_store
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: kms_pipe_crc_basic
results: parsing output: 83/ for test: kms_cursor_edge_walk
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: i915_selftest
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: dumb_buffer
results: parsing output: 90/ for test: kms_chamelium_frames
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_tiled_swapping
results: parsing output: 93/ for test: prime_vgem
results: parsing output: 94/ for test: gem_pxp
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: gem_basic
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_pm_rpm
results: parsing output: 100/ for test: gem_madvise
results: parsing output: 101/ for test: gem_cs_tlb
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: kms_invalid_mode
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_atomic
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_exec_params
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_dirtyfb
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_partial_pwrite_pread
results: parsing output: 118/ for test: kms_properties
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: gem_spin_batch
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_exec_whisper
results: parsing output: 124/ for test: i915_hangman
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: api_intel_bb
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: prime_udl
results: parsing output: 132/ for test: i915_drm_fdinfo
Done.