[58.746877] Initializing watchdogs
[58.746921]   /dev/watchdog0
[58.760395] [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.764816] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.766931] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.770247] [001/133] (960s left) gem_bad_reloc (negative-reloc)
[58.847363] Subtest negative-reloc: SKIP (0.000s)
[58.910995] [002/133] (960s left) gem_exec_fence (keep-in-fence)
[59.085214] Starting subtest: keep-in-fence
[59.087090] Starting dynamic subtest: rcs0
[59.143703] Dynamic subtest rcs0: SUCCESS (0.061s)
[59.152796] Starting dynamic subtest: bcs0
[59.198144] Dynamic subtest bcs0: SUCCESS (0.055s)
[59.208050] Starting dynamic subtest: vcs0
[60.885463] Dynamic subtest vcs0: SUCCESS (1.698s)
[60.895468] Starting dynamic subtest: vcs1
[62.933052] Dynamic subtest vcs1: SUCCESS (2.058s)
[62.940528] Starting dynamic subtest: vecs0
[64.918209] Dynamic subtest vecs0: SUCCESS (1.993s)
[64.929228] Starting dynamic subtest: ccs0
[65.157845] Dynamic subtest ccs0: SUCCESS (0.241s)
[65.160730] Subtest keep-in-fence: SUCCESS (6.111s)
[67.284689] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[67.287657] [003/133] (952s left) gem_eio (in-flight-immediate)
[67.629302] Starting subtest: in-flight-immediate
[75.200818] Subtest in-flight-immediate: SUCCESS (7.584s)
[75.377423] [004/133] (944s left) gem_exec_flush (basic-wb-pro-default)
[75.441659] Starting subtest: basic-wb-pro-default
[80.904570] Subtest basic-wb-pro-default: SUCCESS (5.465s)
[81.088850] [005/133] (938s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[81.186175] Starting subtest: yf-tiled-32bpp-rotate-270
[81.190562] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[81.281831] [006/133] (938s left) gem_mmap_gtt (close-race)
[81.335895] Subtest close-race: SKIP (0.000s)
[81.395333] [007/133] (938s left) gem_close_race (multigpu-basic-process)
[81.460223] Starting subtest: multigpu-basic-process
[81.464602] Subtest multigpu-basic-process: SKIP (0.000s)
[81.681412] [008/133] (937s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[81.785873] Starting subtest: flip-primary-invalidate-overlay
[93.417549] Subtest flip-primary-invalidate-overlay: SUCCESS (11.633s)
[93.545188] [009/133] (926s left) gem_eio (create-ext)
[93.749399] Starting subtest: create-ext
[94.048052] Subtest create-ext: SUCCESS (0.298s)
[94.168633] [010/133] (925s left) gem_ctx_persistence (legacy-engines-mixed-process)
[94.232148] Starting subtest: legacy-engines-mixed-process
[94.234195] Starting dynamic subtest: render
[95.893132] Dynamic subtest render: SUCCESS (1.660s)
[95.902728] Starting dynamic subtest: bsd1
[97.883686] Dynamic subtest bsd1: SUCCESS (1.989s)
[97.893830] Starting dynamic subtest: bsd2
[99.874919] Dynamic subtest bsd2: SUCCESS (1.990s)
[99.885489] Starting dynamic subtest: blt
[101.916926] Dynamic subtest blt: SUCCESS (2.040s)
[101.924514] Starting dynamic subtest: vebox
[103.905913] Dynamic subtest vebox: SUCCESS (1.987s)
[103.908435] Subtest legacy-engines-mixed-process: SUCCESS (9.673s)
[103.991650] [011/133] (915s left) gem_gpgpu_fill (basic)
[104.045867] Starting subtest: basic
[104.047949] Starting dynamic subtest: smem
[104.056392] Dynamic subtest smem: SUCCESS (0.013s)
[104.058706] Subtest basic: SUCCESS (0.013s)
[104.201219] [012/133] (915s left) api_intel_allocator (fork-simple-once)
[104.258924] Starting subtest: fork-simple-once
[104.280184] Subtest fork-simple-once: SUCCESS (0.022s)
[104.404831] [013/133] (915s left) syncobj_wait (single-wait-for-submit-signaled)
[104.475036] Starting subtest: single-wait-for-submit-signaled
[104.477366] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[104.579228] [014/133] (915s left) i915_drm_fdinfo (busy-idle-check-all)
[104.616012] Starting subtest: busy-idle-check-all
[104.618218] Starting dynamic subtest: rcs0
[104.622633] Dynamic subtest rcs0: SKIP (0.004s)
[104.635706] Starting dynamic subtest: bcs0
[104.640566] Dynamic subtest bcs0: SKIP (0.000s)
[104.647795] Starting dynamic subtest: vcs0
[104.651789] Dynamic subtest vcs0: SKIP (0.000s)
[104.658806] Starting dynamic subtest: vcs1
[104.662832] Dynamic subtest vcs1: SKIP (0.000s)
[104.670165] Starting dynamic subtest: vecs0
[104.674534] Dynamic subtest vecs0: SKIP (0.000s)
[104.682358] Starting dynamic subtest: ccs0
[104.686784] Dynamic subtest ccs0: SKIP (0.000s)
[104.691158] Subtest busy-idle-check-all: SKIP (0.006s)
[104.727504] [015/133] (915s left) syncobj_timeline (device-submit-unordered)
[104.773831] Starting subtest: device-submit-unordered
[104.776195] Subtest device-submit-unordered: SUCCESS (0.001s)
[104.897073] [016/133] (915s left) api_intel_bb (reset-bb)
[104.950096] Starting subtest: reset-bb
[104.957541] Subtest reset-bb: SUCCESS (0.008s)
[105.077721] [017/133] (914s left) kms_cursor_crc (cursor-suspend)
[105.207221] Starting subtest: cursor-suspend
[105.209166] Starting dynamic subtest: pipe-A-eDP-1
[138.612684] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.097s)
[138.624181] Starting dynamic subtest: pipe-D-eDP-1
[172.575314] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.817s)
[172.577682] Subtest cursor-suspend: SUCCESS (7.917s)
[173.357150] [018/133] (846s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[173.455545] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[173.459732] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[173.550965] [019/133] (846s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[173.651830] Starting subtest: x-tiled-64bpp-rotate-90
[173.671550] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[173.787655] [020/133] (846s left) gem_userptr_blits (unsync-overlap)
[173.859376] Subtest unsync-overlap: SKIP (0.000s)
[173.994235] [021/133] (846s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[174.082546] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[174.169416] [022/133] (845s left) gem_ctx_param (invalid-size-set)
[174.221097] Starting subtest: invalid-size-set
[174.223440] Subtest invalid-size-set: SUCCESS (0.001s)
[174.318851] [023/133] (845s left) kms_vblank (wait-forked-busy)
[174.410593] Starting subtest: wait-forked-busy
[174.412391] Starting dynamic subtest: pipe-A-eDP-1
[176.240571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[176.254029] Starting dynamic subtest: pipe-D-eDP-1
[178.766457] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.582s)
[178.768789] Subtest wait-forked-busy: SUCCESS (4.471s)
[179.554756] [024/133] (840s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[179.655451] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[179.659572] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[179.736074] [025/133] (840s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[179.843280] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[179.847122] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[179.940675] [026/133] (840s left) kms_addfb_basic (addfb25-bad-modifier)
[180.034424] Starting subtest: addfb25-bad-modifier
[180.036698] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[180.128664] [027/133] (840s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[180.256175] Starting subtest: cursor-vs-flip-varying-size
[211.209382] Subtest cursor-vs-flip-varying-size: SUCCESS (31.069s)
[212.052679] [028/133] (808s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[212.173939] Starting subtest: cursorA-vs-flipB-atomic-transitions
[212.178687] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[212.318641] [029/133] (808s left) gem_mmap_gtt (basic-read-write-distinct)
[212.385814] Subtest basic-read-write-distinct: SKIP (0.000s)
[212.450991] [030/133] (808s left) gem_madvise (dontneed-after-mmap)
[212.482125] Starting subtest: dontneed-after-mmap
[212.508467] Subtest dontneed-after-mmap: SUCCESS (0.027s)
[212.619175] [031/133] (807s left) kms_force_connector_basic (force-edid)
[212.700506] Starting subtest: force-edid
[213.066473] Subtest force-edid: SUCCESS (0.366s)
[213.204054] [032/133] (807s left) kms_prime (basic-crc-hybrid)
[213.293840] Subtest basic-crc-hybrid: SKIP (0.000s)
[213.395902] [033/133] (807s left) gem_exec_balancer (parallel-contexts)
[213.653222] Starting subtest: parallel-contexts
[216.282573] Subtest parallel-contexts: SUCCESS (2.629s)
[216.404912] [034/133] (804s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[216.465559] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[216.566312] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[216.645475] [035/133] (804s left) gen9_exec_parse (batch-zero-length)
[216.704948] Subtest batch-zero-length: SKIP (0.000s)
[216.776547] [036/133] (803s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[216.866335] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[216.870377] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[216.952564] [037/133] (803s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[217.056320] Starting subtest: psr-1p-pri-indfb-multidraw
[239.659984] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.613s)
[239.791379] [038/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[239.904762] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[248.437820] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.537s)
[248.574203] [039/133] (772s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[248.952906] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[249.732420] [040/133] (771s left) gem_reg_read (timestamp-moving)
[249.787504] Starting subtest: timestamp-moving
[250.787895] Subtest timestamp-moving: SUCCESS (1.001s)
[250.874495] [041/133] (770s left) perf (gen12-mi-rpc)
[250.995354] Starting subtest: gen12-mi-rpc
[250.997519] Starting dynamic subtest: rcs0
[251.013268] Dynamic subtest rcs0: SUCCESS (0.017s)
[251.015419] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[251.060963] [042/133] (769s left) gem_ctx_param (invalid-ctx-set)
[251.125310] Starting subtest: invalid-ctx-set
[251.127788] Subtest invalid-ctx-set: SUCCESS (0.002s)
[251.231760] [043/133] (769s left) perf_pmu (rc6)
[251.276196] Starting subtest: rc6
[251.278387] Starting dynamic subtest: gt0
[257.635078] Dynamic subtest gt0: SUCCESS (6.356s)
[257.645581] Starting dynamic subtest: runtime-pm-gt0
[265.403830] Dynamic subtest runtime-pm-gt0: SUCCESS (7.772s)
[265.415845] Starting dynamic subtest: runtime-pm-long-gt0
[277.898163] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.487s)
[277.910256] Starting dynamic subtest: other-idle-gt0
[284.243294] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[284.255664] Starting dynamic subtest: gt1
[290.585757] Dynamic subtest gt1: SUCCESS (6.339s)
[290.598677] Starting dynamic subtest: runtime-pm-gt1
[298.081740] Dynamic subtest runtime-pm-gt1: SUCCESS (7.492s)
[298.093700] Starting dynamic subtest: runtime-pm-long-gt1
[310.584096] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.499s)
[310.596268] Starting dynamic subtest: other-idle-gt1
[316.926985] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[316.929949] Subtest rc6: SUCCESS (65.646s)
[318.090764] [044/133] (702s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[318.205571] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[318.209664] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[318.263954] [045/133] (702s left) kms_invalid_mode (bad-vtotal)
[318.355073] Starting subtest: bad-vtotal
[318.356999] Starting dynamic subtest: pipe-A-eDP-1
[318.645478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[318.654857] Starting dynamic subtest: pipe-B-eDP-1
[318.657038] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[318.665888] Starting dynamic subtest: pipe-C-eDP-1
[318.667772] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[318.676050] Starting dynamic subtest: pipe-D-eDP-1
[318.677935] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[318.680127] Subtest bad-vtotal: SUCCESS (0.294s)
[319.440137] [046/133] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[319.528780] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[319.533182] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[319.603354] [047/133] (701s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[319.704476] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[320.452057] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.748s)
[320.579083] [048/133] (700s left) prime_busy (before-wait)
[320.625687] Starting subtest: before-wait
[320.630476] Starting dynamic subtest: rcs0
[320.654808] Dynamic subtest rcs0: SUCCESS (0.026s)
[320.664891] Starting dynamic subtest: bcs0
[320.705870] Dynamic subtest bcs0: SUCCESS (0.050s)
[320.715734] Starting dynamic subtest: vcs0
[320.746506] Dynamic subtest vcs0: SUCCESS (0.039s)
[320.755313] Starting dynamic subtest: vcs1
[320.788718] Dynamic subtest vcs1: SUCCESS (0.041s)
[320.797737] Starting dynamic subtest: vecs0
[320.829074] Dynamic subtest vecs0: SUCCESS (0.039s)
[320.837970] Starting dynamic subtest: ccs0
[320.870007] Dynamic subtest ccs0: SUCCESS (0.040s)
[320.979018] Subtest before-wait: SUCCESS (0.351s)
[321.030833] [049/133] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[321.144505] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[321.148464] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[321.213948] [050/133] (700s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[321.314576] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[321.316843] Starting dynamic subtest: pipe-A-eDP-1
[321.338578] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[321.348686] Starting dynamic subtest: pipe-B-eDP-1
[321.369035] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[321.377637] Starting dynamic subtest: pipe-C-eDP-1
[321.397749] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[321.406196] Starting dynamic subtest: pipe-D-eDP-1
[321.428541] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[321.433144] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[323.544340] [051/133] (697s left) prime_mmap (test_invalid_sync_flags)
[323.593841] Starting subtest: test_invalid_sync_flags
[323.596021] Starting dynamic subtest: test_invalid_sync_flags-smem
[323.598162] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[323.600277] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[323.664260] [052/133] (697s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[323.866232] Starting subtest: cursor-rapid-movement-128x128
[323.870926] Starting dynamic subtest: pipe-A-eDP-1
[324.426050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[324.452075] Starting dynamic subtest: pipe-D-eDP-1
[325.624244] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.179s)
[325.626570] Subtest cursor-rapid-movement-128x128: SUCCESS (1.760s)
[326.436781] [053/133] (694s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[326.837414] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[327.624329] [054/133] (693s left) kms_universal_plane (cursor-fb-leak)
[327.714606] Starting subtest: cursor-fb-leak
[327.716969] Starting dynamic subtest: pipe-A-eDP-1
[328.040068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.326s)
[328.051826] Starting dynamic subtest: pipe-B-eDP-1
[329.436039] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s)
[329.450445] Starting dynamic subtest: pipe-C-eDP-1
[330.831314] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[330.843337] Starting dynamic subtest: pipe-D-eDP-1
[332.218816] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s)
[332.221253] Subtest cursor-fb-leak: SUCCESS (4.507s)
[333.341376] [055/133] (688s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[333.403763] Starting subtest: y-tiled-to-vebox-y-tiled
[333.408400] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[333.565171] [056/133] (687s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[333.658247] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[333.662952] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[333.703891] [057/133] (687s left) kms_psr (fbc-psr-basic)
[333.795599] Starting subtest: fbc-psr-basic
[333.797765] Starting dynamic subtest: eDP-1
[333.801668] Dynamic subtest eDP-1: SKIP (0.000s)
[333.805660] Subtest fbc-psr-basic: SKIP (0.001s)
[333.844063] [058/133] (687s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[333.952323] Starting subtest: psr2-cursor-plane-update-sf
[333.954655] Starting dynamic subtest: pipe-A-eDP-1
[334.544973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[334.554830] Starting dynamic subtest: pipe-B-eDP-1
[335.815543] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.270s)
[335.817831] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.869s)
[336.628028] [059/133] (685s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[336.717366] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[336.719633] Starting dynamic subtest: pipe-A-eDP-1
[336.741309] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.752501] Starting dynamic subtest: pipe-B-eDP-1
[336.772788] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[336.781980] Starting dynamic subtest: pipe-C-eDP-1
[336.802584] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[336.810984] Starting dynamic subtest: pipe-D-eDP-1
[336.832526] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[336.836785] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[338.923217] [060/133] (682s left) kms_fbcon_fbt (fbc)
[338.983075] Starting subtest: fbc
[345.480821] Subtest fbc: SUCCESS (6.497s)
[346.630022] [061/133] (675s left) gem_pxp (display-protected-crc)
[346.751691] Starting subtest: display-protected-crc
[348.381409] Subtest display-protected-crc: SUCCESS (1.633s)
[348.477782] [062/133] (673s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[348.562702] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[348.565011] Starting dynamic subtest: pipe-A-eDP-1
[348.587545] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[348.603330] Starting dynamic subtest: pipe-B-eDP-1
[348.625362] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[348.635252] Starting dynamic subtest: pipe-C-eDP-1
[348.656782] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.667166] Starting dynamic subtest: pipe-D-eDP-1
[348.688768] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.693073] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[350.829359] [063/133] (670s left) syncobj_timeline (invalid-transfer-bad-pad)
[350.902531] Starting subtest: invalid-transfer-bad-pad
[350.905461] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[350.990498] [064/133] (670s left) kms_atomic (atomic-plane-damage)
[351.094815] Starting subtest: atomic-plane-damage
[351.143245] Starting dynamic subtest: pipe-A-eDP-1
[351.696349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[351.698660] Subtest atomic-plane-damage: SUCCESS (0.603s)
[352.520007] [065/133] (669s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[352.619170] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[352.623161] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[352.669142] [066/133] (669s left) sysfs_preempt_timeout (idempotent)
[352.719931] Starting subtest: idempotent
[352.722234] Starting dynamic subtest: vecs0
[352.724557] Dynamic subtest vecs0: SUCCESS (0.000s)
[352.734560] Starting dynamic subtest: ccs0
[352.736445] Dynamic subtest ccs0: SUCCESS (0.000s)
[352.745313] Starting dynamic subtest: vcs0
[352.747543] Dynamic subtest vcs0: SUCCESS (0.000s)
[352.755981] Starting dynamic subtest: bcs0
[352.758215] Dynamic subtest bcs0: SUCCESS (0.000s)
[352.766871] Starting dynamic subtest: rcs0
[352.768791] Dynamic subtest rcs0: SUCCESS (0.000s)
[352.777029] Starting dynamic subtest: vcs1
[352.778949] Dynamic subtest vcs1: SUCCESS (0.000s)
[352.780851] Subtest idempotent: SUCCESS (0.007s)
[352.817944] [067/133] (669s left) sw_sync (alloc_fence_invalid_timeline)
[352.853056] Starting subtest: alloc_fence_invalid_timeline
[352.855257] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[352.892441] [068/133] (669s left) gem_exec_params (rsvd2-dirt)
[352.953225] Starting subtest: rsvd2-dirt
[352.957787] Subtest rsvd2-dirt: SKIP (0.000s)
[353.030445] [069/133] (669s left) syncobj_timeline (reset-signaled)
[353.082899] Starting subtest: reset-signaled
[353.085197] Subtest reset-signaled: SUCCESS (0.000s)
[353.164252] [070/133] (668s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[353.265016] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[353.269237] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[353.313297] [071/133] (668s left) core_sysfs (read-all-entries)
[353.372429] Starting subtest: read-all-entries
[353.380233] Subtest read-all-entries: SUCCESS (0.010s)
[353.461516] [072/133] (668s left) kms_hdr (bpc-switch-dpms)
[353.561931] Starting subtest: bpc-switch-dpms
[354.585875] Starting dynamic subtest: pipe-A-eDP-1
[359.075647] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.491s)
[359.078029] Subtest bpc-switch-dpms: SUCCESS (5.517s)
[359.180319] [073/133] (663s left) gem_exec_schedule (u-semaphore-resolve)
[359.251967] Starting subtest: u-semaphore-resolve
[359.281702] Subtest u-semaphore-resolve: SUCCESS (0.039s)
[359.596624] [074/133] (662s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[359.721569] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[359.726188] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[359.843291] [075/133] (662s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[359.921533] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[359.990298] [076/133] (662s left) gem_exec_whisper (basic-fds-forked)
[360.039917] Starting subtest: basic-fds-forked
[384.195329] Subtest basic-fds-forked: SUCCESS (24.156s)
[384.354841] [077/133] (638s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[384.465153] Starting subtest: plane-lut1d-ctm3x4-lut1d
[384.591033] Starting dynamic subtest: pipe-A-plane-0
[384.757310] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[384.769462] Starting dynamic subtest: pipe-A-plane-1
[384.934671] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[384.949132] Starting dynamic subtest: pipe-A-plane-2
[385.112668] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[386.299966] Starting dynamic subtest: pipe-B-plane-0
[386.467957] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[386.478355] Starting dynamic subtest: pipe-B-plane-1
[386.655990] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[386.665397] Starting dynamic subtest: pipe-B-plane-2
[386.823965] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[387.996073] Starting dynamic subtest: pipe-C-plane-0
[388.152531] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[388.163317] Starting dynamic subtest: pipe-C-plane-1
[388.309181] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[388.323700] Starting dynamic subtest: pipe-C-plane-2
[388.452586] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[389.719338] Starting dynamic subtest: pipe-D-plane-0
[389.855343] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[389.866084] Starting dynamic subtest: pipe-D-plane-1
[390.021847] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[390.037188] Starting dynamic subtest: pipe-D-plane-2
[390.166649] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[390.454224] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.990s)
[391.309237] [078/133] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[391.420978] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[397.992666] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.575s)
[398.095873] [079/133] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[398.221849] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[398.226593] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[398.352124] [080/133] (624s left) kms_flip (nonblocking-read)
[398.465830] Starting subtest: nonblocking-read
[398.468025] Subtest nonblocking-read: SUCCESS (0.000s)
[398.532909] [081/133] (624s left) kms_frontbuffer_tracking (fbc-2p-rte)
[398.636106] Starting subtest: fbc-2p-rte
[398.640268] Subtest fbc-2p-rte: SKIP (0.000s)
[398.714286] [082/133] (623s left) kms_plane_scaling (invalid-parameters)
[398.801296] Starting subtest: invalid-parameters
[398.803581] Starting dynamic subtest: less-than-1-height-src
[398.815214] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[398.832357] Starting dynamic subtest: less-than-1-width-src
[398.834607] Dynamic subtest less-than-1-width-src: SUCCESS (0.016s)
[398.836674] Subtest invalid-parameters: SUCCESS (0.031s)
[398.900750] [083/133] (623s left) kms_draw_crc (draw-method-render)
[398.990222] Starting subtest: draw-method-render
[398.992088] Starting dynamic subtest: xrgb8888-untiled
[399.257327] Dynamic subtest xrgb8888-untiled: SUCCESS (0.268s)
[399.266535] Starting dynamic subtest: rgb565-untiled
[399.481853] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[399.494048] Starting dynamic subtest: xrgb2101010-untiled
[399.702235] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[399.713549] Starting dynamic subtest: xbgr16161616f-untiled
[399.924343] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[399.936101] Starting dynamic subtest: xrgb8888-xtiled
[400.049409] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.120s)
[400.059805] Starting dynamic subtest: rgb565-xtiled
[400.168773] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[400.180211] Starting dynamic subtest: xrgb2101010-xtiled
[400.292133] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[400.302236] Starting dynamic subtest: xbgr16161616f-xtiled
[400.424568] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[400.434346] Starting dynamic subtest: xrgb8888-4tiled
[400.557936] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[400.570389] Starting dynamic subtest: rgb565-4tiled
[400.680145] Dynamic subtest rgb565-4tiled: SUCCESS (0.120s)
[400.689399] Starting dynamic subtest: xrgb2101010-4tiled
[400.825050] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[400.838109] Starting dynamic subtest: xbgr16161616f-4tiled
[400.958058] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[400.960041] Subtest draw-method-render: SUCCESS (1.969s)
[401.051011] [084/133] (621s left) kms_plane_alpha_blend (constant-alpha-mid)
[401.152950] Starting subtest: constant-alpha-mid
[401.446170] Starting dynamic subtest: pipe-A-eDP-1
[402.342084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[402.351919] Starting dynamic subtest: pipe-D-eDP-1
[403.899654] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.558s)
[403.902826] Subtest constant-alpha-mid: SUCCESS (2.747s)
[404.737421] [085/133] (618s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[404.833147] Starting subtest: fbcpsr-shrfb-scaledprimary
[410.528953] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.697s)
[410.631456] [086/133] (612s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[410.701531] Subtest no-spare-fences-busy: SKIP (0.000s)
[410.770498] [087/133] (612s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[410.879463] Starting subtest: 4-tiled-32bpp-rotate-270
[410.898856] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[411.004713] [088/133] (611s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[411.102505] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[411.106559] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[411.175374] [089/133] (611s left) kms_content_protection (srm)
[411.318259] Starting subtest: srm
[411.325159] Subtest srm: SKIP (0.002s)
[411.430119] [090/133] (611s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[411.547608] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[411.551267] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[411.627364] [091/133] (611s left) kms_psr (psr2-no-drrs)
[411.716952] Starting subtest: psr2-no-drrs
[411.718887] Starting dynamic subtest: eDP-1
[413.366082] Dynamic subtest eDP-1: SUCCESS (1.647s)
[413.367940] Subtest psr2-no-drrs: SUCCESS (1.648s)
[414.213290] [092/133] (608s left) syncobj_timeline (single-wait-all-available-submitted)
[414.273975] Starting subtest: single-wait-all-available-submitted
[414.276272] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[414.341410] [093/133] (608s left) kms_dp_linktrain_fallback (dp-fallback)
[414.436564] Starting subtest: dp-fallback
[414.443075] Subtest dp-fallback: SKIP (0.000s)
[414.484027] [094/133] (608s left) gem_userptr_blits (readonly-pwrite-unsync)
[414.549324] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[414.647433] [095/133] (608s left) kms_addfb_basic (unused-modifier)
[414.702961] Starting subtest: unused-modifier
[414.704890] Subtest unused-modifier: SUCCESS (0.000s)
[414.817372] [096/133] (608s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[414.872868] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[414.938561] [097/133] (608s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[415.054835] Starting subtest: cursorB-vs-flipB-toggle
[415.059478] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[415.180776] [098/133] (608s left) kms_lease (cursor-implicit-plane)
[415.272552] Starting subtest: cursor-implicit-plane
[415.274388] Starting dynamic subtest: pipe-A-eDP-1
[415.742917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.469s)
[415.754325] Starting dynamic subtest: pipe-B-eDP-1
[416.813082] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.069s)
[416.824978] Starting dynamic subtest: pipe-C-eDP-1
[417.907212] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.093s)
[417.916996] Starting dynamic subtest: pipe-D-eDP-1
[418.994320] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.085s)
[418.996692] Subtest cursor-implicit-plane: SUCCESS (3.721s)
[419.804038] [099/133] (603s left) kms_psr (fbc-pr-primary-page-flip)
[419.897400] Starting subtest: fbc-pr-primary-page-flip
[419.901701] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[419.946637] [100/133] (603s left) i915_pm_freq_api (freq-basic-api)
[420.015258] Starting subtest: freq-basic-api
[420.017663] Starting dynamic subtest: gt0
[420.020060] Dynamic subtest gt0: SUCCESS (0.002s)
[420.032517] Starting dynamic subtest: gt1
[420.034459] Dynamic subtest gt1: SUCCESS (0.003s)
[420.036379] Subtest freq-basic-api: SUCCESS (0.007s)
[420.105206] [101/133] (603s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[420.202799] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[429.337320] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.136s)
[429.454405] [102/133] (593s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[429.537837] Starting subtest: plane-upscale-20x20-with-modifiers
[429.540116] Starting dynamic subtest: pipe-A
[429.873792] Dynamic subtest pipe-A: SUCCESS (0.338s)
[429.885009] Starting dynamic subtest: pipe-B
[431.295053] Dynamic subtest pipe-B: SUCCESS (1.420s)
[431.307287] Starting dynamic subtest: pipe-C
[432.706526] Dynamic subtest pipe-C: SUCCESS (1.411s)
[432.717044] Starting dynamic subtest: pipe-D
[434.091128] Dynamic subtest pipe-D: SUCCESS (1.384s)
[434.093278] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.556s)
[435.224335] [103/133] (588s left) kms_pm_dc (dc6-psr)
[436.333464] Starting subtest: dc6-psr
[439.318026] Subtest dc6-psr: SUCCESS (2.985s)
[440.101575] [104/133] (583s left) gem_exec_fence (syncobj-timeline-wait)
[440.682955] Starting subtest: syncobj-timeline-wait
[442.532760] Subtest syncobj-timeline-wait: SUCCESS (1.850s)
[444.577183] [105/133] (578s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[444.689540] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[444.691428] Starting dynamic subtest: pipe-A-eDP-1
[445.416357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[445.427333] Starting dynamic subtest: pipe-B-eDP-1
[447.217529] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.800s)
[447.227995] Starting dynamic subtest: pipe-C-eDP-1
[449.009406] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.791s)
[449.020314] Starting dynamic subtest: pipe-D-eDP-1
[450.822457] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.812s)
[450.824526] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.126s)
[452.015741] [106/133] (571s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[452.079037] Starting subtest: wait-all-for-submit-delayed-submit
[452.179524] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[452.237390] [107/133] (571s left) gem_sync (basic-all)
[452.306788] Starting subtest: basic-all
[455.467853] Subtest basic-all: SUCCESS (3.169s)
[455.631876] [108/133] (568s left) kms_flip (2x-flip-vs-fences)
[455.723694] Starting subtest: 2x-flip-vs-fences
[455.728298] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[455.804270] [109/133] (567s left) gem_wait (await)
[455.865134] Starting subtest: await
[455.867648] Starting dynamic subtest: all-engines
[456.965559] Dynamic subtest all-engines: SUCCESS (1.099s)
[456.982632] Starting dynamic subtest: rcs0
[458.022232] Dynamic subtest rcs0: SUCCESS (1.054s)
[458.041385] Starting dynamic subtest: bcs0
[459.080456] Dynamic subtest bcs0: SUCCESS (1.055s)
[459.096912] Starting dynamic subtest: vcs0
[460.135779] Dynamic subtest vcs0: SUCCESS (1.053s)
[460.152079] Starting dynamic subtest: vcs1
[461.190230] Dynamic subtest vcs1: SUCCESS (1.052s)
[461.207155] Starting dynamic subtest: vecs0
[462.244052] Dynamic subtest vecs0: SUCCESS (1.052s)
[462.260841] Starting dynamic subtest: ccs0
[463.305396] Dynamic subtest ccs0: SUCCESS (1.059s)
[463.308066] Subtest await: SUCCESS (7.441s)
[463.482767] [110/133] (560s left) gem_exec_balancer (parallel-bb-first)
[463.741027] Starting subtest: parallel-bb-first
[464.648924] Subtest parallel-bb-first: SUCCESS (0.909s)
[465.531959] [111/133] (558s left) kms_cursor_crc (cursor-offscreen-32x10)
[465.711006] Starting subtest: cursor-offscreen-32x10
[465.770253] Subtest cursor-offscreen-32x10: SKIP (0.054s)
[466.012091] [112/133] (557s left) perf_pmu (busy-hang)
[466.057943] Starting subtest: busy-hang
[466.060329] Starting dynamic subtest: rcs0
[467.314391] Dynamic subtest rcs0: SUCCESS (1.254s)
[467.323437] Starting dynamic subtest: bcs0
[468.530700] Dynamic subtest bcs0: SUCCESS (1.218s)
[468.542699] Starting dynamic subtest: vcs0
[471.022160] Dynamic subtest vcs0: SUCCESS (2.486s)
[471.033227] Starting dynamic subtest: vcs1
[473.010193] Dynamic subtest vcs1: SUCCESS (1.986s)
[473.021329] Starting dynamic subtest: vecs0
[474.989801] Dynamic subtest vecs0: SUCCESS (1.978s)
[474.999278] Starting dynamic subtest: ccs0
[476.213153] Dynamic subtest ccs0: SUCCESS (1.225s)
[476.215844] Subtest busy-hang: SUCCESS (10.158s)
[476.293198] [113/133] (547s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[476.392783] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[476.397562] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[477.512589] [114/133] (546s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[477.603405] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[477.607631] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[477.687062] [115/133] (546s left) kms_rotation_crc (exhaust-fences)
[477.783839] Starting subtest: exhaust-fences
[477.788205] Subtest exhaust-fences: SKIP (0.000s)
[477.837242] [116/133] (546s left) kms_flip (2x-flip-vs-rmfb)
[477.924947] Starting subtest: 2x-flip-vs-rmfb
[477.935921] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[477.997576] [117/133] (546s left) gem_exec_schedule (pi-distinct-iova)
[478.186834] Starting subtest: pi-distinct-iova
[478.188907] Starting dynamic subtest: rcs0
[478.271760] Dynamic subtest rcs0: SUCCESS (0.088s)
[478.283478] Starting dynamic subtest: vcs0
[478.342901] Dynamic subtest vcs0: SUCCESS (0.069s)
[478.356463] Starting dynamic subtest: vcs1
[478.396967] Dynamic subtest vcs1: SUCCESS (0.053s)
[478.410471] Starting dynamic subtest: vecs0
[478.451344] Dynamic subtest vecs0: SUCCESS (0.053s)
[478.463978] Starting dynamic subtest: ccs0
[478.525030] Dynamic subtest ccs0: SUCCESS (0.073s)
[478.527546] Subtest pi-distinct-iova: SUCCESS (0.342s)
[479.597847] [118/133] (544s left) gem_ctx_isolation (nonpriv-switch)
[479.675867] Starting subtest: nonpriv-switch
[479.678260] Starting dynamic subtest: rcs0
[479.958690] Dynamic subtest rcs0: SUCCESS (0.283s)
[479.970336] Starting dynamic subtest: bcs0
[480.239784] Dynamic subtest bcs0: SUCCESS (0.280s)
[480.251644] Starting dynamic subtest: vcs0
[480.546797] Dynamic subtest vcs0: SUCCESS (0.306s)
[480.558413] Starting dynamic subtest: vcs1
[481.848919] Dynamic subtest vcs1: SUCCESS (1.301s)
[481.860564] Starting dynamic subtest: vecs0
[483.828459] Dynamic subtest vecs0: SUCCESS (1.977s)
[483.838072] Starting dynamic subtest: ccs0
[485.797693] Dynamic subtest ccs0: SUCCESS (1.968s)
[485.800062] Subtest nonpriv-switch: SUCCESS (6.123s)
[486.027404] [119/133] (538s left) kms_addfb_basic (bad-pitch-65536)
[486.087264] Starting subtest: bad-pitch-65536
[486.089173] Subtest bad-pitch-65536: SUCCESS (0.000s)
[486.212937] [120/133] (537s left) gem_ppgtt (blt-vs-render-ctxn)
[486.263661] Starting subtest: blt-vs-render-ctxN
[519.201537] Subtest blt-vs-render-ctxN: SUCCESS (32.938s)
[519.298448] [121/133] (504s left) kms_psr (pr-sprite-plane-onoff)
[519.437335] Starting subtest: pr-sprite-plane-onoff
[519.441655] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[519.485510] [122/133] (504s left) gem_pread (display)
[519.534099] Subtest display: SKIP (0.000s)
[519.603805] [123/133] (504s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[519.696654] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[519.700636] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[519.768869] [124/133] (504s left) gem_mmap_offset (clear-via-pagefault)
[519.833175] Starting subtest: clear-via-pagefault
[519.835442] Starting dynamic subtest: smem0
[550.324698] Dynamic subtest smem0: SUCCESS (30.490s)
[550.326811] Subtest clear-via-pagefault: SUCCESS (30.491s)
[550.401613] [125/133] (473s left) kms_busy (basic)
[550.514579] Starting subtest: basic
[550.516894] Starting dynamic subtest: flip
[551.135623] Dynamic subtest flip: SUCCESS (0.621s)
[551.146125] Starting dynamic subtest: modeset
[554.537614] Dynamic subtest modeset: SUCCESS (3.402s)
[554.539946] Subtest basic: SUCCESS (4.026s)
[555.395593] [126/133] (469s left) i915_query (query-topology-garbage-items)
[555.461400] Starting subtest: query-topology-garbage-items
[555.463827] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[555.531646] [127/133] (468s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[555.592310] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[555.596573] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[555.750277] [128/133] (468s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[555.849781] Starting subtest: y-tiled-16bpp-rotate-0
[555.853902] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[555.914006] [129/133] (468s left) gem_softpin (allocator-basic)
[555.978718] Starting subtest: allocator-basic
[556.048809] Subtest allocator-basic: SUCCESS (0.069s)
[556.140707] [130/133] (468s left) kms_plane_multiple (2x-tiling-x)
[556.224584] Starting subtest: 2x-tiling-x
[556.228660] Subtest 2x-tiling-x: SKIP (0.000s)
[556.271882] [131/133] (468s left) gem_exec_params (secure-non-master)
[556.323810] Starting subtest: secure-non-master
[556.328287] Subtest secure-non-master: SKIP (0.000s)
[556.393460] [132/133] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[556.496688] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[556.500642] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[556.565693] [133/133] (468s left) i915_pm_rc6_residency (rc6-accuracy)
[556.633774] Starting subtest: rc6-accuracy
[556.635986] Starting dynamic subtest: gt0
[559.807238] Dynamic subtest gt0: SUCCESS (3.170s)
[559.820735] Starting dynamic subtest: gt1
[562.979327] Dynamic subtest gt1: SUCCESS (3.169s)
[562.982198] Subtest rc6-accuracy: SUCCESS (6.346s)
[563.028588] Closing watchdogs
results: parsing output: 0/ for test: gem_bad_reloc
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: gem_exec_flush
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: gem_close_race
results: parsing output: 7/ for test: kms_psr_stress_test
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: gem_gpgpu_fill
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: gem_madvise
results: parsing output: 30/ for test: kms_force_connector_basic
results: parsing output: 31/ for test: kms_prime
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gen9_exec_parse
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: gem_reg_read
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: gem_ctx_param
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: prime_busy
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: prime_mmap
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_chamelium_edid
results: parsing output: 53/ for test: kms_universal_plane
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_fbcon_fbt
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_atomic
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: sysfs_preempt_timeout
results: parsing output: 66/ for test: sw_sync
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: core_sysfs
results: parsing output: 71/ for test: kms_hdr
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gem_fenced_exec_thrash
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_color_pipeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: kms_draw_crc
results: parsing output: 83/ for test: kms_plane_alpha_blend
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_fenced_exec_thrash
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_content_protection
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_dp_linktrain_fallback
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: kms_pipe_b_c_ivb
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_lease
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: i915_pm_freq_api
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: kms_pm_dc
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_sync
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_wait
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: gem_ctx_isolation
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: gem_ppgtt
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gem_pread
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_mmap_offset
results: parsing output: 124/ for test: kms_busy
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: kms_plane_multiple
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: i915_pm_rc6_residency
Done.