[58.446601] Initializing watchdogs
[58.446655]   /dev/watchdog0
[58.460689] [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.465599] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.467909] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.471347] [001/133] (960s left) kms_scaling_modes (scaling-mode-center)
[58.592213] Starting subtest: scaling-mode-center
[58.594601] Starting dynamic subtest: pipe-A-eDP-1
[58.711893] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.122s)
[58.721812] Starting dynamic subtest: pipe-B-eDP-1
[59.855412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[59.864789] Starting dynamic subtest: pipe-C-eDP-1
[61.059694] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[61.069328] Starting dynamic subtest: pipe-D-eDP-1
[62.412680] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[62.415101] Subtest scaling-mode-center: SUCCESS (3.819s)
[63.809604] [002/133] (955s left) gem_exec_gttfill (engines)
[63.883621] Starting subtest: engines
[63.886124] Starting dynamic subtest: rcs0
[86.627516] Dynamic subtest rcs0: SUCCESS (22.737s)
[86.636040] Starting dynamic subtest: bcs0
[109.884604] Dynamic subtest bcs0: SUCCESS (23.254s)
[109.892059] Starting dynamic subtest: vcs0
[133.186833] Dynamic subtest vcs0: SUCCESS (23.299s)
[133.195205] Starting dynamic subtest: vcs1
[156.458321] Dynamic subtest vcs1: SUCCESS (23.271s)
[156.468663] Starting dynamic subtest: vecs0
[179.771393] Dynamic subtest vecs0: SUCCESS (23.311s)
[179.781726] Starting dynamic subtest: ccs0
[203.068454] Dynamic subtest ccs0: SUCCESS (23.295s)
[203.071101] Subtest engines: SUCCESS (139.172s)
[203.254222] [003/133] (815s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[203.399898] Starting subtest: plane-primary-overlay-mutable-zpos
[206.830644] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.428s)
[208.019728] [004/133] (811s left) gem_partial_pwrite_pread (write-snoop)
[208.072356] Subtest write-snoop: SKIP (0.000s)
[208.133543] [005/133] (810s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[208.432522] Starting subtest: cursor-rapid-movement-512x170
[208.436292] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[208.555411] [006/133] (810s left) kms_plane_scaling (planes-upscale-20x20)
[208.642937] Starting subtest: planes-upscale-20x20
[208.645264] Starting dynamic subtest: pipe-A
[208.702998] Dynamic subtest pipe-A: SUCCESS (0.062s)
[208.712965] Starting dynamic subtest: pipe-B
[209.839782] Dynamic subtest pipe-B: SUCCESS (1.136s)
[209.850049] Starting dynamic subtest: pipe-C
[210.953437] Dynamic subtest pipe-C: SUCCESS (1.113s)
[210.962879] Starting dynamic subtest: pipe-D
[212.067311] Dynamic subtest pipe-D: SUCCESS (1.114s)
[212.069662] Subtest planes-upscale-20x20: SUCCESS (3.427s)
[213.232742] [007/133] (805s left) kms_cursor_crc (cursor-offscreen-32x32)
[213.374185] Starting subtest: cursor-offscreen-32x32
[213.419467] Subtest cursor-offscreen-32x32: SKIP (0.041s)
[213.704673] [008/133] (805s left) syncobj_wait (invalid-reset-illegal-handle)
[213.764251] Starting subtest: invalid-reset-illegal-handle
[213.766582] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[213.844639] [009/133] (805s left) gen9_exec_parse (basic-rejected)
[213.906738] Subtest basic-rejected: SKIP (0.000s)
[213.970113] [010/133] (805s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[214.028841] Starting subtest: single-wait-all-for-submit-available-submitted
[214.030798] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[214.121967] [011/133] (805s left) gem_pwrite_snooped
[214.241657] [012/133] (805s left) kms_color (ctm-0-25)
[214.337815] Starting subtest: ctm-0-25
[214.339659] Starting dynamic subtest: pipe-A-eDP-1
[217.878239] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.540s)
[217.887591] Starting dynamic subtest: pipe-B-eDP-1
[222.155534] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.277s)
[222.164879] Starting dynamic subtest: pipe-C-eDP-1
[226.182994] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.026s)
[226.192042] Starting dynamic subtest: pipe-D-eDP-1
[230.269653] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.085s)
[230.272216] Subtest ctm-0-25: SUCCESS (15.929s)
[231.091758] [013/133] (788s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[231.476286] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[232.303427] [014/133] (787s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[232.389728] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[232.392185] Starting dynamic subtest: pipe-A-eDP-1
[232.418862] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.428419] Starting dynamic subtest: pipe-B-eDP-1
[232.452779] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.460545] Starting dynamic subtest: pipe-C-eDP-1
[232.485032] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.492848] Starting dynamic subtest: pipe-D-eDP-1
[232.517788] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.521902] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[234.692383] [015/133] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[234.790853] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[239.230862] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.444s)
[240.388963] [016/133] (779s left) gem_exec_schedule (promotion)
[240.470323] Starting subtest: promotion
[240.472694] Starting dynamic subtest: rcs0
[240.565221] Dynamic subtest rcs0: SUCCESS (0.104s)
[240.576059] Starting dynamic subtest: vcs0
[240.661237] Dynamic subtest vcs0: SUCCESS (0.094s)
[240.672090] Starting dynamic subtest: vcs1
[240.741947] Dynamic subtest vcs1: SUCCESS (0.082s)
[240.752893] Starting dynamic subtest: vecs0
[240.816816] Dynamic subtest vecs0: SUCCESS (0.074s)
[240.828198] Starting dynamic subtest: ccs0
[240.906825] Dynamic subtest ccs0: SUCCESS (0.090s)
[240.909350] Subtest promotion: SUCCESS (0.446s)
[241.976180] [017/133] (777s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[242.031602] Starting subtest: yf-tiled-to-vebox-y-tiled
[242.036512] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[242.213653] [018/133] (777s left) gem_mmap_gtt (big-copy-xy)
[242.265636] Subtest big-copy-XY: SKIP (0.000s)
[242.323919] [019/133] (777s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[242.383305] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[242.490331] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[242.563962] [020/133] (777s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[242.664335] Starting subtest: psr-rgb565-draw-pwrite
[249.647305] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.987s)
[249.758645] [021/133] (769s left) kms_flip (plain-flip-ts-check-interruptible)
[249.871585] Starting subtest: plain-flip-ts-check-interruptible
[249.873970] Starting dynamic subtest: A-eDP1
[258.675688] Dynamic subtest A-eDP1: SUCCESS (8.803s)
[258.687233] Starting dynamic subtest: B-eDP1
[267.506288] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[267.518960] Starting dynamic subtest: C-eDP1
[276.332867] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[276.342472] Starting dynamic subtest: D-eDP1
[285.171736] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[285.176777] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.304s)
[286.367885] [022/133] (733s left) kms_flip (flip-vs-rmfb-interruptible)
[286.458370] Starting subtest: flip-vs-rmfb-interruptible
[286.460597] Starting dynamic subtest: A-eDP1
[295.142934] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[295.153975] Starting dynamic subtest: B-eDP1
[303.776175] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[303.783898] Starting dynamic subtest: C-eDP1
[312.397395] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[312.407876] Starting dynamic subtest: D-eDP1
[321.024332] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[321.028678] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.569s)
[322.207612] [023/133] (697s left) i915_pm_rps (reset)
[322.281391] Starting subtest: reset
[330.738248] Subtest reset: SUCCESS (8.457s)
[330.857236] [024/133] (688s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[330.952735] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[330.954939] Starting dynamic subtest: pipe-A-eDP-1
[330.974467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[330.984553] Starting dynamic subtest: pipe-B-eDP-1
[331.002516] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[331.010472] Starting dynamic subtest: pipe-C-eDP-1
[331.028783] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[331.038082] Starting dynamic subtest: pipe-D-eDP-1
[331.056959] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[331.058880] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[333.261514] [025/133] (686s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[333.325696] Starting subtest: basic-batch-kernel-default-cmd
[333.330238] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[333.521259] [026/133] (686s left) sysfs_heartbeat_interval (idempotent)
[333.584419] Starting subtest: idempotent
[333.586662] Starting dynamic subtest: vecs0
[333.588947] Dynamic subtest vecs0: SUCCESS (0.001s)
[333.597607] Starting dynamic subtest: ccs0
[333.599445] Dynamic subtest ccs0: SUCCESS (0.001s)
[333.606794] Starting dynamic subtest: vcs0
[333.608593] Dynamic subtest vcs0: SUCCESS (0.000s)
[333.616075] Starting dynamic subtest: bcs0
[333.617881] Dynamic subtest bcs0: SUCCESS (0.001s)
[333.625328] Starting dynamic subtest: rcs0
[333.627152] Dynamic subtest rcs0: SUCCESS (0.000s)
[333.634801] Starting dynamic subtest: vcs1
[333.636862] Dynamic subtest vcs1: SUCCESS (0.000s)
[333.638964] Subtest idempotent: SUCCESS (0.008s)
[333.688327] [027/133] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[333.787047] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[340.682404] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.897s)
[340.831351] [028/133] (679s left) gem_mmap_gtt (close-race)
[340.903193] Subtest close-race: SKIP (0.000s)
[340.963487] [029/133] (679s left) perf (invalid-remove-userspace-config)
[341.117874] Starting subtest: invalid-remove-userspace-config
[341.125366] Subtest invalid-remove-userspace-config: SUCCESS (0.007s)
[341.162840] [030/133] (678s left) gem_ccs (suspend-resume)
[341.224774] Starting subtest: suspend-resume
[341.229076] Subtest suspend-resume: SKIP (0.000s)
[341.350600] [031/133] (678s left) kms_chamelium_color (ctm-red-to-blue)
[341.446559] Subtest ctm-red-to-blue: SKIP (0.000s)
[341.502199] [032/133] (678s left) gem_mmap_gtt (big-bo-tiledy)
[341.569756] Subtest big-bo-tiledY: SKIP (0.000s)
[341.636377] [033/133] (678s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[341.737026] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[341.738984] Starting dynamic subtest: pipe-A-eDP-1
[347.611147] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.877s)
[347.619496] Starting dynamic subtest: pipe-B-eDP-1
[354.255896] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.642s)
[354.258101] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.521s)
[355.141193] [034/133] (665s left) kms_draw_crc (draw-method-blt)
[355.237178] Starting subtest: draw-method-blt
[355.239341] Starting dynamic subtest: xrgb8888-untiled
[355.456467] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[355.466762] Starting dynamic subtest: rgb565-untiled
[355.656355] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[355.665209] Starting dynamic subtest: xrgb2101010-untiled
[355.878570] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[355.887473] Starting dynamic subtest: xbgr16161616f-untiled
[356.089235] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.209s)
[356.099455] Starting dynamic subtest: xrgb8888-xtiled
[356.201255] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[356.209106] Starting dynamic subtest: rgb565-xtiled
[356.322936] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[356.333031] Starting dynamic subtest: xrgb2101010-xtiled
[356.433840] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.108s)
[356.444471] Starting dynamic subtest: xbgr16161616f-xtiled
[356.544964] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.108s)
[356.555543] Starting dynamic subtest: xrgb8888-4tiled
[356.667221] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[356.675156] Starting dynamic subtest: rgb565-4tiled
[356.800362] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[356.808461] Starting dynamic subtest: xrgb2101010-4tiled
[356.922808] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[356.933100] Starting dynamic subtest: xbgr16161616f-4tiled
[357.056049] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[357.058056] Subtest draw-method-blt: SUCCESS (1.822s)
[357.156277] [035/133] (663s left) kms_psr (fbc-psr-no-drrs)
[357.269692] Starting subtest: fbc-psr-no-drrs
[357.271717] Starting dynamic subtest: eDP-1
[357.275418] Dynamic subtest eDP-1: SKIP (0.000s)
[357.279052] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[357.350382] [036/133] (662s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[357.414737] Subtest untiled-to-tiled: SKIP (0.000s)
[357.477503] [037/133] (662s left) gem_ctx_param (invalid-get-no-zeromap)
[357.530767] Starting subtest: invalid-get-no-zeromap
[357.532976] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[357.621162] [038/133] (662s left) i915_drm_fdinfo (virtual-busy-hang-all)
[357.668849] Starting subtest: virtual-busy-hang-all
[357.672357] Subtest virtual-busy-hang-all: SKIP (0.000s)
[357.734754] [039/133] (662s left) syncobj_timeline (invalid-signal-zero-handles)
[357.787129] Starting subtest: invalid-signal-zero-handles
[357.789184] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[357.881961] [040/133] (662s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[357.974305] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[357.976263] Starting dynamic subtest: A-eDP1
[361.546395] Dynamic subtest A-eDP1: SUCCESS (3.570s)
[361.554921] Starting dynamic subtest: B-eDP1
[364.751171] Dynamic subtest B-eDP1: SUCCESS (3.201s)
[364.760045] Starting dynamic subtest: C-eDP1
[367.844187] Dynamic subtest C-eDP1: SUCCESS (3.095s)
[367.854507] Starting dynamic subtest: D-eDP1
[370.966413] Dynamic subtest D-eDP1: SUCCESS (3.121s)
[370.971351] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.995s)
[371.767088] [041/133] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[371.862367] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[371.866434] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.965210] [042/133] (648s left) perf_pmu (most-busy-idle-check-all)
[372.008306] Starting subtest: most-busy-idle-check-all
[372.010320] Starting dynamic subtest: rcs0
[373.911472] Dynamic subtest rcs0: SUCCESS (1.902s)
[373.922804] Starting dynamic subtest: bcs0
[375.896200] Dynamic subtest bcs0: SUCCESS (1.980s)
[375.907635] Starting dynamic subtest: vcs0
[377.879112] Dynamic subtest vcs0: SUCCESS (1.980s)
[377.890892] Starting dynamic subtest: vcs1
[379.927333] Dynamic subtest vcs1: SUCCESS (2.045s)
[379.936846] Starting dynamic subtest: vecs0
[381.910565] Dynamic subtest vecs0: SUCCESS (1.980s)
[381.922700] Starting dynamic subtest: ccs0
[383.895981] Dynamic subtest ccs0: SUCCESS (1.981s)
[383.899208] Subtest most-busy-idle-check-all: SUCCESS (11.888s)
[383.990433] [043/133] (636s left) gem_eio (in-flight-contexts-10ms)
[384.197144] Starting subtest: in-flight-contexts-10ms
[397.922686] Subtest in-flight-contexts-10ms: SUCCESS (13.724s)
[398.097509] [044/133] (622s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[398.197674] Starting subtest: psr-rgb565-draw-mmap-cpu
[404.912973] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.718s)
[405.023050] [045/133] (615s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[405.122956] Starting subtest: fbc-farfromfence-mmap-gtt
[405.127291] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[405.211659] [046/133] (615s left) gem_busy (busy)
[405.277590] Starting subtest: busy
[405.279854] Starting dynamic subtest: all-engines
[405.323663] Dynamic subtest all-engines: SUCCESS (0.049s)
[405.335062] Starting dynamic subtest: rcs0
[406.878982] Dynamic subtest rcs0: SUCCESS (1.554s)
[406.889576] Starting dynamic subtest: bcs0
[406.919250] Dynamic subtest bcs0: SUCCESS (0.038s)
[406.928498] Starting dynamic subtest: vcs0
[406.960243] Dynamic subtest vcs0: SUCCESS (0.040s)
[406.969483] Starting dynamic subtest: vcs1
[408.925600] Dynamic subtest vcs1: SUCCESS (1.961s)
[408.936069] Starting dynamic subtest: vecs0
[410.908675] Dynamic subtest vecs0: SUCCESS (1.982s)
[410.919042] Starting dynamic subtest: ccs0
[412.894421] Dynamic subtest ccs0: SUCCESS (1.985s)
[412.896659] Subtest busy: SUCCESS (7.617s)
[413.252077] [047/133] (607s left) gem_spin_batch (legacy-resubmit)
[413.314739] Starting subtest: legacy-resubmit
[413.317206] Starting dynamic subtest: default
[413.328582] Dynamic subtest default: SUCCESS (0.013s)
[413.344509] Starting dynamic subtest: render
[413.346878] Dynamic subtest render: SUCCESS (0.004s)
[413.356180] Starting dynamic subtest: bsd
[413.358454] Dynamic subtest bsd: SUCCESS (0.005s)
[413.367039] Starting dynamic subtest: bsd1
[413.369326] Dynamic subtest bsd1: SUCCESS (0.001s)
[413.377680] Starting dynamic subtest: bsd2
[413.379813] Dynamic subtest bsd2: SUCCESS (0.003s)
[413.387778] Starting dynamic subtest: blt
[413.389864] Dynamic subtest blt: SUCCESS (0.004s)
[413.398196] Starting dynamic subtest: vebox
[413.400770] Dynamic subtest vebox: SUCCESS (0.004s)
[413.403204] Subtest legacy-resubmit: SUCCESS (0.042s)
[413.575361] [048/133] (607s left) gem_vm_create (invalid-destroy)
[413.638363] Starting subtest: invalid-destroy
[413.640570] Subtest invalid-destroy: SUCCESS (0.002s)
[413.742332] [049/133] (607s left) vgem_basic (setversion)
[413.848558] Starting subtest: setversion
[413.852762] Subtest setversion: SUCCESS (0.000s)
[413.901612] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[413.905292] [050/133] (606s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[414.002980] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[414.005212] Starting dynamic subtest: pipe-A-eDP-1
[414.014307] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[414.030604] Starting dynamic subtest: pipe-B-eDP-1
[414.040290] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[414.058138] Starting dynamic subtest: pipe-C-eDP-1
[414.067224] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[414.085787] Starting dynamic subtest: pipe-D-eDP-1
[414.094990] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[414.099457] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[416.250248] [051/133] (604s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[416.354945] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[416.359258] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[416.450561] [052/133] (604s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[416.585666] Starting subtest: dp-mst-lic-type-0-hdcp14
[416.590449] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[416.712374] [053/133] (604s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[416.802423] Starting subtest: fbc-psr2-cursor-mmap-cpu
[416.804327] Starting dynamic subtest: eDP-1
[416.808526] Dynamic subtest eDP-1: SKIP (0.000s)
[416.812726] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[416.878139] [054/133] (604s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[416.980433] Starting subtest: yf-tiled-addfb-size-offset-overflow
[416.984781] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[417.093440] [055/133] (603s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[417.193455] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[417.196753] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[417.277706] [056/133] (603s left) dumb_buffer (invalid-bpp)
[417.327901] Starting subtest: invalid-bpp
[417.329789] Subtest invalid-bpp: SUCCESS (0.000s)
[417.436123] [057/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[417.523535] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[417.527200] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[417.617819] [058/133] (603s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[417.676306] Starting subtest: etime-single-wait-all-available-unsubmitted
[417.777502] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[417.850547] [059/133] (603s left) gem_reg_read (bad-register)
[417.920663] Starting subtest: bad-register
[417.923073] Subtest bad-register: SUCCESS (0.000s)
[418.024251] [060/133] (603s left) gem_ctx_persistence (legacy-engines-cleanup)
[418.083450] Starting subtest: legacy-engines-cleanup
[418.085760] Starting dynamic subtest: render
[418.166557] Dynamic subtest render: SUCCESS (0.082s)
[418.179695] Starting dynamic subtest: bsd1
[418.221571] Dynamic subtest bsd1: SUCCESS (0.052s)
[418.237901] Starting dynamic subtest: bsd2
[418.268501] Dynamic subtest bsd2: SUCCESS (0.045s)
[418.282033] Starting dynamic subtest: blt
[418.318738] Dynamic subtest blt: SUCCESS (0.047s)
[418.332212] Starting dynamic subtest: vebox
[418.348339] Dynamic subtest vebox: SUCCESS (0.027s)
[418.350583] Subtest legacy-engines-cleanup: SUCCESS (0.266s)
[418.477368] [061/133] (602s left) gem_ctx_shared (q-in-order)
[418.549338] Starting subtest: Q-in-order
[418.551752] Starting dynamic subtest: rcs0
[418.645689] Dynamic subtest rcs0: SUCCESS (0.096s)
[418.662075] Starting dynamic subtest: vcs0
[418.721766] Dynamic subtest vcs0: SUCCESS (0.076s)
[418.738541] Starting dynamic subtest: vcs1
[418.796701] Dynamic subtest vcs1: SUCCESS (0.074s)
[418.813358] Starting dynamic subtest: vecs0
[418.876851] Dynamic subtest vecs0: SUCCESS (0.080s)
[418.890862] Starting dynamic subtest: ccs0
[418.968719] Dynamic subtest ccs0: SUCCESS (0.091s)
[418.970848] Subtest Q-in-order: SUCCESS (0.422s)
[420.008726] [062/133] (601s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[420.128422] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[420.132978] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[420.242959] [063/133] (601s left) kms_properties (connector-properties-legacy)
[420.331750] Starting subtest: connector-properties-legacy
[420.334056] Starting dynamic subtest: pipe-A-eDP-1
[428.232819] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.903s)
[428.243074] Starting dynamic subtest: pipe-None-DP-1
[428.247782] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[428.256693] Starting dynamic subtest: pipe-None-HDMI-A-1
[428.261145] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[428.269892] Starting dynamic subtest: pipe-None-DP-2
[428.274033] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[428.282592] Starting dynamic subtest: pipe-None-HDMI-A-2
[428.286673] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[428.295432] Starting dynamic subtest: pipe-None-DP-3
[428.299993] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[428.308885] Starting dynamic subtest: pipe-None-DP-4
[428.313393] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[428.315666] Subtest connector-properties-legacy: SUCCESS (7.914s)
[429.101732] [064/133] (592s left) kms_dp_link_training (non-uhbr-sst)
[429.195131] Starting subtest: non-uhbr-sst
[429.203582] Subtest non-uhbr-sst: SKIP (0.000s)
[429.274134] [065/133] (592s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[429.372117] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[429.376304] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[429.442189] [066/133] (592s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[429.527120] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[429.529032] Starting dynamic subtest: pipe-A
[429.863459] Dynamic subtest pipe-A: SUCCESS (0.338s)
[429.873079] Starting dynamic subtest: pipe-B
[431.294106] Dynamic subtest pipe-B: SUCCESS (1.430s)
[431.303958] Starting dynamic subtest: pipe-C
[432.734958] Dynamic subtest pipe-C: SUCCESS (1.440s)
[432.746561] Starting dynamic subtest: pipe-D
[434.169124] Dynamic subtest pipe-D: SUCCESS (1.433s)
[434.171545] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.644s)
[435.329984] [067/133] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[435.440586] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[435.444659] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[435.546279] [068/133] (586s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[435.632926] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[435.637176] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[436.763286] [069/133] (584s left) gem_exec_schedule (u-submit-golden-slice)
[436.845264] Starting subtest: u-submit-golden-slice
[436.847462] Starting dynamic subtest: rcs0
[436.873338] Dynamic subtest rcs0: SUCCESS (0.035s)
[436.883873] Starting dynamic subtest: bcs0
[436.905697] Dynamic subtest bcs0: SUCCESS (0.032s)
[436.915890] Starting dynamic subtest: vcs0
[436.941046] Dynamic subtest vcs0: SUCCESS (0.034s)
[436.950519] Starting dynamic subtest: vcs1
[436.977476] Dynamic subtest vcs1: SUCCESS (0.036s)
[436.986085] Starting dynamic subtest: vecs0
[437.012796] Dynamic subtest vecs0: SUCCESS (0.034s)
[437.027261] Starting dynamic subtest: ccs0
[437.066737] Dynamic subtest ccs0: SUCCESS (0.053s)
[437.069119] Subtest u-submit-golden-slice: SUCCESS (0.229s)
[438.957181] [070/133] (582s left) kms_prime (basic-crc-hybrid)
[439.047225] Subtest basic-crc-hybrid: SKIP (0.000s)
[439.146928] [071/133] (582s left) kms_psr (pr-primary-mmap-gtt)
[439.245088] Starting subtest: pr-primary-mmap-gtt
[439.249144] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[439.330589] [072/133] (582s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[439.392935] Starting subtest: multi-wait-available-unsubmitted-signaled
[439.395288] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[439.490617] [073/133] (582s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[439.598230] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[439.602113] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[439.690677] [074/133] (582s left) gem_exec_flush (basic-wb-ro-before-default)
[439.752924] Starting subtest: basic-wb-ro-before-default
[445.209523] Subtest basic-wb-ro-before-default: SUCCESS (5.459s)
[445.396293] [075/133] (576s left) gem_userptr_blits (dmabuf-unsync)
[445.470313] Subtest dmabuf-unsync: SKIP (0.000s)
[445.604372] [076/133] (576s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[445.724473] Starting subtest: verify-pxp-stale-buf-optout-execution
[446.790602] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.067s)
[446.932642] [077/133] (575s left) prime_self_import (basic-llseek-bad)
[446.965474] Starting subtest: basic-llseek-bad
[446.988582] Subtest basic-llseek-bad: SUCCESS (0.022s)
[447.082100] [078/133] (574s left) kms_plane_multiple (tiling-4)
[447.186990] Starting subtest: tiling-4
[447.189301] Starting dynamic subtest: pipe-A-eDP-1
[450.925196] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.737s)
[450.935193] Starting dynamic subtest: pipe-B-eDP-1
[455.323281] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.396s)
[455.332240] Starting dynamic subtest: pipe-C-eDP-1
[459.668516] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.344s)
[459.679633] Starting dynamic subtest: pipe-D-eDP-1
[463.987169] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.318s)
[463.989409] Subtest tiling-4: SUCCESS (16.802s)
[464.806206] [079/133] (557s left) kms_pipe_crc_basic (read-crc)
[464.913336] Starting subtest: read-crc
[464.915563] Starting dynamic subtest: pipe-A-eDP-1
[465.627555] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[465.637499] Starting dynamic subtest: pipe-B-eDP-1
[466.974660] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s)
[466.985099] Starting dynamic subtest: pipe-C-eDP-1
[468.269083] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.291s)
[468.279162] Starting dynamic subtest: pipe-D-eDP-1
[469.603198] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[469.605600] Subtest read-crc: SUCCESS (4.693s)
[470.451800] [080/133] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[470.555039] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[477.879743] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.328s)
[478.007080] [081/133] (544s left) gem_exec_reloc (basic-wc-gtt)
[478.073183] Subtest basic-wc-gtt: SKIP (0.000s)
[478.152323] [082/133] (544s left) gem_ppgtt (shrink-vs-evict-pinned)
[478.210071] Starting subtest: shrink-vs-evict-pinned
[483.888671] Subtest shrink-vs-evict-pinned: SUCCESS (5.676s)
[483.976203] [083/133] (538s left) gem_exec_fence (basic-busy)
[484.156774] Starting subtest: basic-busy
[484.159052] Starting dynamic subtest: rcs0
[484.246088] Dynamic subtest rcs0: SUCCESS (0.092s)
[484.257880] Starting dynamic subtest: bcs0
[484.308060] Dynamic subtest bcs0: SUCCESS (0.060s)
[484.319422] Starting dynamic subtest: vcs0
[484.370947] Dynamic subtest vcs0: SUCCESS (0.061s)
[484.382547] Starting dynamic subtest: vcs1
[484.434032] Dynamic subtest vcs1: SUCCESS (0.061s)
[484.445537] Starting dynamic subtest: vecs0
[484.504238] Dynamic subtest vecs0: SUCCESS (0.068s)
[484.515832] Starting dynamic subtest: ccs0
[484.570963] Dynamic subtest ccs0: SUCCESS (0.065s)
[484.573619] Subtest basic-busy: SUCCESS (0.419s)
[486.006920] [084/133] (536s left) kms_invalid_mode (bad-vtotal)
[486.100622] Starting subtest: bad-vtotal
[486.102922] Starting dynamic subtest: pipe-A-eDP-1
[486.391050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[486.400164] Starting dynamic subtest: pipe-B-eDP-1
[486.402300] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[486.410632] Starting dynamic subtest: pipe-C-eDP-1
[486.412788] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[486.421192] Starting dynamic subtest: pipe-D-eDP-1
[486.423337] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[486.425442] Subtest bad-vtotal: SUCCESS (0.295s)
[487.192779] [085/133] (535s left) kms_vblank (query-idle)
[487.281847] Starting subtest: query-idle
[487.283703] Starting dynamic subtest: pipe-A-eDP-1
[489.027574] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.745s)
[489.041060] Starting dynamic subtest: pipe-D-eDP-1
[491.426080] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.395s)
[491.427903] Subtest query-idle: SUCCESS (4.144s)
[492.250024] [086/133] (530s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[492.356531] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[492.358954] Starting dynamic subtest: pipe-A-eDP-1
[492.384258] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[492.394739] Starting dynamic subtest: pipe-B-eDP-1
[492.418694] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[492.427067] Starting dynamic subtest: pipe-C-eDP-1
[492.449570] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.458180] Starting dynamic subtest: pipe-D-eDP-1
[492.481288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.485236] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[494.625554] [087/133] (527s left) sw_sync (sync_multi_consumer)
[494.675069] Starting subtest: sync_multi_consumer
[495.107604] Subtest sync_multi_consumer: SUCCESS (0.432s)
[495.167683] [088/133] (527s left) gem_exec_fence (long-history)
[495.568059] Starting subtest: long-history
[502.592788] Subtest long-history: SUCCESS (7.025s)
[503.440342] [089/133] (519s left) gem_eio (wait-10ms)
[503.683167] Starting subtest: wait-10ms
[504.086647] Subtest wait-10ms: SUCCESS (0.406s)
[504.237826] [090/133] (518s left) gem_exec_reloc (basic-cpu-read-active)
[504.290854] Subtest basic-cpu-read-active: SKIP (0.000s)
[504.355716] [091/133] (518s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[504.446929] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[504.450833] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[504.557587] [092/133] (518s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[504.628814] Starting subtest: invalid-single-wait-all-unsubmitted
[504.631159] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[504.749512] [093/133] (517s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[504.832289] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[504.835719] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[504.910251] [094/133] (517s left) api_intel_bb (crc32)
[504.967785] Starting subtest: crc32
[504.969448] Starting dynamic subtest: rcs0-smem0
[505.247026] Dynamic subtest rcs0-smem0: SUCCESS (0.278s)
[505.259726] Starting dynamic subtest: bcs0-smem0
[505.581693] Dynamic subtest bcs0-smem0: SUCCESS (0.332s)
[505.591940] Starting dynamic subtest: vcs0-smem0
[505.918903] Dynamic subtest vcs0-smem0: SUCCESS (0.336s)
[505.929750] Starting dynamic subtest: vcs1-smem0
[506.290996] Dynamic subtest vcs1-smem0: SUCCESS (0.368s)
[506.302972] Starting dynamic subtest: vecs0-smem0
[506.666654] Dynamic subtest vecs0-smem0: SUCCESS (0.373s)
[506.678846] Starting dynamic subtest: ccs0-smem0
[506.994558] Dynamic subtest ccs0-smem0: SUCCESS (0.325s)
[506.997228] Subtest crc32: SUCCESS (2.029s)
[507.134344] [095/133] (515s left) kms_psr (psr2-dpms)
[507.226783] Starting subtest: psr2-dpms
[507.229055] Starting dynamic subtest: eDP-1
[510.065659] Dynamic subtest eDP-1: SUCCESS (2.838s)
[510.067968] Subtest psr2-dpms: SUCCESS (2.840s)
[510.928740] [096/133] (511s left) kms_cursor_edge_walk (64x64-top-bottom)
[511.018794] Starting subtest: 64x64-top-bottom
[511.020977] Starting dynamic subtest: pipe-A-eDP-1
[514.490142] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[514.500096] Starting dynamic subtest: pipe-D-eDP-1
[517.593863] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.104s)
[517.596063] Subtest 64x64-top-bottom: SUCCESS (6.576s)
[518.406392] [097/133] (504s left) syncobj_wait (wait-for-submit-delayed-submit)
[518.456044] Starting subtest: wait-for-submit-delayed-submit
[518.557616] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[518.635882] [098/133] (504s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[518.690644] Starting subtest: invalid-bsd1-flag-on-blt
[518.693085] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[518.793631] [099/133] (504s left) perf (whitelisted-registers-userspace-config)
[518.890964] Starting subtest: whitelisted-registers-userspace-config
[518.893352] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[518.934465] [100/133] (503s left) api_intel_bb (delta-check)
[518.987446] Starting subtest: delta-check
[518.989632] Subtest delta-check: SUCCESS (0.005s)
[519.099136] [101/133] (503s left) kms_flip (flip-vs-panning-vs-hang)
[519.198096] Starting subtest: flip-vs-panning-vs-hang
[519.200364] Starting dynamic subtest: A-eDP1
[570.368267] Dynamic subtest A-eDP1: SUCCESS (51.168s)
[570.379158] Starting dynamic subtest: D-eDP1
[620.413105] Dynamic subtest D-eDP1: SUCCESS (50.042s)
[620.417654] Subtest flip-vs-panning-vs-hang: SUCCESS (101.216s)
[621.594874] [102/133] (401s left) kms_rotation_crc (primary-rotation-270)
[621.692881] Starting subtest: primary-rotation-270
[621.697317] Subtest primary-rotation-270: SKIP (0.001s)
[621.764785] [103/133] (401s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[621.855693] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[622.479571] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[622.661871] [104/133] (400s left) kms_sequence (queue-busy)
[622.757450] Starting subtest: queue-busy
[622.759378] Starting dynamic subtest: pipe-A-eDP-1
[624.694639] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[624.704602] Starting dynamic subtest: pipe-B-eDP-1
[627.302174] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.604s)
[627.312338] Starting dynamic subtest: pipe-C-eDP-1
[629.891792] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.590s)
[629.901849] Starting dynamic subtest: pipe-D-eDP-1
[632.462765] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.569s)
[632.465052] Subtest queue-busy: SUCCESS (9.707s)
[633.327433] [105/133] (389s left) i915_drm_fdinfo (virtual-busy-all)
[633.382090] Starting subtest: virtual-busy-all
[633.387671] Subtest virtual-busy-all: SKIP (0.000s)
[633.457768] [106/133] (389s left) gem_exec_whisper (basic-sync-all)
[633.528334] Starting subtest: basic-sync-all
[641.241518] Subtest basic-sync-all: SUCCESS (7.713s)
[641.425307] [107/133] (381s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[641.519767] Starting subtest: pr-cursor-plane-update-sf
[641.523788] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[641.592167] [108/133] (381s left) prime_vgem (sync)
[641.674557] Starting subtest: sync
[641.676560] Starting dynamic subtest: rcs0
[641.722394] Dynamic subtest rcs0: SUCCESS (0.048s)
[641.731777] Starting dynamic subtest: bcs0
[641.792200] Dynamic subtest bcs0: SUCCESS (0.069s)
[641.801268] Starting dynamic subtest: vcs0
[641.840403] Dynamic subtest vcs0: SUCCESS (0.046s)
[641.849830] Starting dynamic subtest: vcs1
[641.885382] Dynamic subtest vcs1: SUCCESS (0.044s)
[641.895078] Starting dynamic subtest: vecs0
[641.931638] Dynamic subtest vecs0: SUCCESS (0.045s)
[641.941026] Starting dynamic subtest: ccs0
[641.977507] Dynamic subtest ccs0: SUCCESS (0.045s)
[641.979673] Subtest sync: SUCCESS (0.304s)
[642.107464] [109/133] (381s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[642.208697] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[642.212804] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[642.318925] [110/133] (380s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[642.410942] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[642.415116] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[642.499999] [111/133] (380s left) gem_exec_schedule (preemptive-hang)
[642.671696] Starting subtest: preemptive-hang
[642.674042] Starting dynamic subtest: rcs0
[652.034857] Dynamic subtest rcs0: SUCCESS (9.366s)
[652.045106] Starting dynamic subtest: bcs0
[661.058218] Dynamic subtest bcs0: SUCCESS (9.017s)
[661.078803] Starting dynamic subtest: vcs0
[670.013181] Dynamic subtest vcs0: SUCCESS (8.954s)
[670.038499] Starting dynamic subtest: vcs1
[679.039119] Dynamic subtest vcs1: SUCCESS (9.026s)
[679.055689] Starting dynamic subtest: vecs0
[687.996802] Dynamic subtest vecs0: SUCCESS (8.956s)
[688.006198] Starting dynamic subtest: ccs0
[697.090402] Dynamic subtest ccs0: SUCCESS (9.092s)
[697.092855] Subtest preemptive-hang: SUCCESS (54.420s)
[697.322441] [112/133] (326s left) gem_exec_suspend (basic-s4-devices)
[697.382634] Starting subtest: basic-S4-devices
[697.384641] Starting dynamic subtest: smem
[709.912102] Dynamic subtest smem: SUCCESS (12.529s)
[709.916427] Subtest basic-S4-devices: SUCCESS (12.531s)
[716.108627] [113/133] (313s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[716.254422] Starting subtest: y-tiled-8bpp-rotate-90
[716.259165] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[716.340774] [114/133] (313s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[716.397219] Starting subtest: single-wait-all-for-submit-unsubmitted
[716.497493] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[716.590944] [115/133] (312s left) perf (gen12-mi-rpc)
[716.681893] Starting subtest: gen12-mi-rpc
[716.684309] Starting dynamic subtest: rcs0
[716.713110] Dynamic subtest rcs0: SUCCESS (0.025s)
[716.715469] Subtest gen12-mi-rpc: SUCCESS (0.026s)
[716.760259] [116/133] (312s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[716.852756] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[720.681230] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.832s)
[721.826475] [117/133] (307s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[724.055647] Starting subtest: dpms-mode-unset-non-lpsp
[725.222884] Subtest dpms-mode-unset-non-lpsp: SKIP (1.167s)
[725.618433] [118/133] (304s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[725.721646] Starting subtest: addfb25-yf-tiled-legacy
[725.723901] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[725.818202] [119/133] (303s left) kms_big_fb (x-tiled-addfb-size-overflow)
[725.916478] Starting subtest: x-tiled-addfb-size-overflow
[725.918824] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[726.010762] [120/133] (303s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[726.109706] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[726.113833] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[726.204439] [121/133] (303s left) kms_big_fb (linear-32bpp-rotate-90)
[726.300322] Starting subtest: linear-32bpp-rotate-90
[726.319663] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[726.429892] [122/133] (303s left) syncobj_wait (single-wait-all-submitted)
[726.481537] Starting subtest: single-wait-all-submitted
[726.587617] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[726.667531] [123/133] (303s left) gem_exec_balancer (full-late)
[726.727810] Starting subtest: full-late
[731.800882] Subtest full-late: SUCCESS (5.073s)
[732.119259] [124/133] (297s left) gem_mmap_gtt (ptrace)
[732.173434] Subtest ptrace: SKIP (0.000s)
[732.237531] [125/133] (297s left) i915_pm_rps (waitboost)
[732.293224] Starting subtest: waitboost
[738.642588] Subtest waitboost: SUCCESS (6.347s)
[738.735466] [126/133] (291s left) prime_vgem (basic-gtt)
[738.794267] Starting subtest: basic-gtt
[738.798447] Subtest basic-gtt: SKIP (0.000s)
[738.890857] [127/133] (291s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[738.997208] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[739.001211] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[739.100717] [128/133] (290s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[739.195288] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[745.718319] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.527s)
[745.842433] [129/133] (284s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[745.940449] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[752.851371] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.912s)
[752.980544] [130/133] (277s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[753.076429] Starting subtest: fbcpsr-slowdraw
[778.270061] Subtest fbcpsr-slowdraw: SUCCESS (25.196s)
[778.417472] [131/133] (251s left) kms_lease (lease-get)
[778.526146] Starting subtest: lease-get
[778.528471] Starting dynamic subtest: pipe-A-eDP-1
[778.530799] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[778.542287] Starting dynamic subtest: pipe-B-eDP-1
[778.544483] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[778.555521] Starting dynamic subtest: pipe-C-eDP-1
[778.557726] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[778.568179] Starting dynamic subtest: pipe-D-eDP-1
[778.570608] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[778.572995] Subtest lease-get: SUCCESS (0.009s)
[778.649330] [132/133] (251s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[778.740910] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[778.746057] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[778.816093] [133/133] (251s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[778.903902] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[778.907757] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[779.006902] Closing watchdogs
results: parsing output: 0/ for test: kms_scaling_modes
results: parsing output: 1/ for test: gem_exec_gttfill
results: parsing output: 2/ for test: kms_atomic
results: parsing output: 3/ for test: gem_partial_pwrite_pread
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pwrite_snooped
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: i915_pm_rps
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: sysfs_heartbeat_interval
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: kms_chamelium_color
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_draw_crc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_set_tiling_vs_blt
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_busy
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: gem_vm_create
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: dumb_buffer
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_reg_read
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_properties
results: parsing output: 63/ for test: kms_dp_link_training
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_prime
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: prime_self_import
results: parsing output: 77/ for test: kms_plane_multiple
results: parsing output: 78/ for test: kms_pipe_crc_basic
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: gem_ppgtt
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_invalid_mode
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: sw_sync
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_cursor_edge_walk
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_sequence
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: gem_exec_suspend
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_lease
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_flip_scaled_crc
Done.