[59.284149] Initializing watchdogs
[59.284284]   /dev/watchdog0
[59.299973] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[59.303849] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.305923] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.309200] [001/131] (960s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[59.408090] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[59.410474] Starting dynamic subtest: pipe-A-eDP-1
[59.841530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[59.849330] Starting dynamic subtest: pipe-B-eDP-1
[59.869366] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[59.877348] Starting dynamic subtest: pipe-C-eDP-1
[59.897683] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[59.906221] Starting dynamic subtest: pipe-D-eDP-1
[59.925333] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[59.927490] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.452s)
[62.136838] [002/131] (957s left) gem_ccs (ctrl-surf-copy-new-ctx)
[62.199763] Starting subtest: ctrl-surf-copy-new-ctx
[62.203937] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[62.297591] [003/131] (957s left) kms_vblank (wait-busy-hang)
[62.363090] Starting subtest: wait-busy-hang
[62.365470] Starting dynamic subtest: pipe-A-eDP-1
[88.687104] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.355s)
[88.700442] Starting dynamic subtest: pipe-D-eDP-1
[103.645268] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.953s)
[103.647800] Subtest wait-busy-hang: SUCCESS (41.312s)
[104.495071] [004/131] (915s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[104.601838] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[104.606427] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[104.687107] [005/131] (915s left) kms_color (deep-color)
[104.766486] Starting subtest: deep-color
[105.836708] Starting dynamic subtest: pipe-A-eDP-1-gamma
[106.635442] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.797s)
[106.643841] Starting dynamic subtest: pipe-A-eDP-1-degamma
[108.047072] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.412s)
[108.055024] Starting dynamic subtest: pipe-A-eDP-1-ctm
[109.450292] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.403s)
[110.237934] Starting dynamic subtest: pipe-B-eDP-1-gamma
[110.940400] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.704s)
[110.948641] Starting dynamic subtest: pipe-B-eDP-1-degamma
[112.428757] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.492s)
[112.438723] Starting dynamic subtest: pipe-B-eDP-1-ctm
[113.848552] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.419s)
[114.621238] Starting dynamic subtest: pipe-C-eDP-1-gamma
[115.299402] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.683s)
[115.307090] Starting dynamic subtest: pipe-C-eDP-1-degamma
[116.684731] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.384s)
[116.695118] Starting dynamic subtest: pipe-C-eDP-1-ctm
[118.106722] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.424s)
[118.911593] Starting dynamic subtest: pipe-D-eDP-1-gamma
[119.612408] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.707s)
[119.620288] Starting dynamic subtest: pipe-D-eDP-1-degamma
[121.080048] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.467s)
[121.089672] Starting dynamic subtest: pipe-D-eDP-1-ctm
[122.487312] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.407s)
[122.489668] Subtest deep-color: SUCCESS (17.721s)
[123.355243] [006/131] (896s left) sysfs_timeslice_duration (invalid)
[123.411480] Starting subtest: invalid
[123.413899] Starting dynamic subtest: vecs0
[123.416208] Dynamic subtest vecs0: SUCCESS (0.000s)
[123.423059] Starting dynamic subtest: ccs0
[123.424945] Dynamic subtest ccs0: SUCCESS (0.000s)
[123.431577] Starting dynamic subtest: vcs0
[123.433481] Dynamic subtest vcs0: SUCCESS (0.000s)
[123.439999] Starting dynamic subtest: bcs0
[123.442057] Dynamic subtest bcs0: SUCCESS (0.000s)
[123.448973] Starting dynamic subtest: rcs0
[123.451216] Dynamic subtest rcs0: SUCCESS (0.000s)
[123.458013] Starting dynamic subtest: vcs1
[123.460314] Dynamic subtest vcs1: SUCCESS (0.000s)
[123.462262] Subtest invalid: SUCCESS (0.003s)
[123.504915] [007/131] (896s left) kms_content_protection (mei-interface)
[123.634089] Starting subtest: mei-interface
[123.638809] Subtest mei-interface: SKIP (0.001s)
[123.754094] [008/131] (896s left) kms_cursor_crc (cursor-sliding-max-size)
[124.039462] Starting subtest: cursor-sliding-max-size
[124.045883] Subtest cursor-sliding-max-size: SKIP (0.000s)
[124.153277] [009/131] (895s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[124.254014] Starting subtest: cursorA-vs-flipA-atomic
[135.394466] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.139s)
[136.189502] [010/131] (883s left) prime_vgem (coherency-gtt)
[136.287367] Starting subtest: coherency-gtt
[136.292295] Subtest coherency-gtt: SKIP (0.000s)
[136.387458] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[136.390888] [011/131] (883s left) api_intel_bb (offset-control)
[136.446907] Starting subtest: offset-control
[136.454692] Subtest offset-control: SUCCESS (0.011s)
[136.564981] [012/131] (883s left) syncobj_wait (single-wait-for-submit-submitted)
[136.618903] Starting subtest: single-wait-for-submit-submitted
[136.725301] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[136.810416] [013/131] (883s left) kms_hdr (bpc-switch-dpms)
[136.884917] Starting subtest: bpc-switch-dpms
[136.898293] Starting dynamic subtest: pipe-A-eDP-1
[141.367708] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.469s)
[141.370100] Subtest bpc-switch-dpms: SUCCESS (4.485s)
[141.481408] [014/131] (878s left) i915_pm_rpm (sysfs-read)
[142.980773] Starting subtest: sysfs-read
[144.126813] Subtest sysfs-read: SUCCESS (1.142s)
[144.488959] [015/131] (875s left) perf (polling-small-buf)
[144.610849] Starting subtest: polling-small-buf
[144.704125] Subtest polling-small-buf: SUCCESS (0.091s)
[144.748670] [016/131] (875s left) gem_ppgtt (blt-vs-render-ctxn)
[144.807048] Starting subtest: blt-vs-render-ctxN
[177.688923] Subtest blt-vs-render-ctxN: SUCCESS (32.879s)
[177.805620] [017/131] (842s left) gem_fence_thrash (bo-copy)
[177.880820] Starting subtest: bo-copy
[177.896789] Subtest bo-copy: SKIP (0.014s)
[177.958874] [018/131] (842s left) api_intel_allocator (standalone)
[178.004371] Starting subtest: standalone
[178.019716] Subtest standalone: SUCCESS (0.015s)
[178.164229] [019/131] (842s left) kms_fbcon_fbt (fbc)
[178.214658] Starting subtest: fbc
[184.536507] Subtest fbc: SUCCESS (6.321s)
[185.618905] [020/131] (834s left) perf_pmu (interrupts-sync)
[185.664074] Starting subtest: interrupts-sync
[186.762470] Subtest interrupts-sync: SUCCESS (1.097s)
[186.872155] [021/131] (833s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[186.983831] Starting subtest: basic-busy-flip-before-cursor-legacy
[186.988622] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[187.131838] [022/131] (833s left) sw_sync (sync_busy_fork_unixsocket)
[187.170512] Starting subtest: sync_busy_fork_unixsocket
[187.178333] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[187.236277] [023/131] (833s left) gem_exec_whisper (basic-queues-priority)
[187.295780] Starting subtest: basic-queues-priority
[211.829683] Subtest basic-queues-priority: SUCCESS (24.530s)
[212.009795] [024/131] (808s left) kms_plane (plane-position-hole-dpms)
[212.097090] Starting subtest: plane-position-hole-dpms
[212.633601] Starting dynamic subtest: pipe-A-plane-1
[215.012420] Dynamic subtest pipe-A-plane-1: SUCCESS (2.379s)
[215.021095] Starting dynamic subtest: pipe-A-plane-2
[217.362620] Dynamic subtest pipe-A-plane-2: SUCCESS (2.349s)
[217.374194] Starting dynamic subtest: pipe-A-plane-3
[219.622550] Dynamic subtest pipe-A-plane-3: SUCCESS (2.258s)
[219.632137] Starting dynamic subtest: pipe-A-plane-4
[221.982469] Dynamic subtest pipe-A-plane-4: SUCCESS (2.359s)
[221.992468] Starting dynamic subtest: pipe-A-plane-5
[222.007477] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[223.154297] Starting dynamic subtest: pipe-B-plane-1
[225.596472] Dynamic subtest pipe-B-plane-1: SUCCESS (2.451s)
[225.607211] Starting dynamic subtest: pipe-B-plane-2
[227.943333] Dynamic subtest pipe-B-plane-2: SUCCESS (2.344s)
[227.952710] Starting dynamic subtest: pipe-B-plane-3
[230.311182] Dynamic subtest pipe-B-plane-3: SUCCESS (2.368s)
[230.320662] Starting dynamic subtest: pipe-B-plane-4
[232.682548] Dynamic subtest pipe-B-plane-4: SUCCESS (2.369s)
[232.691731] Starting dynamic subtest: pipe-B-plane-5
[232.707494] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[232.709871] Subtest plane-position-hole-dpms: SUCCESS (20.609s)
[233.489176] [025/131] (787s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[233.857204] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[234.685488] [026/131] (786s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[234.763761] Starting subtest: x-tiled-32bpp-rotate-90
[234.784109] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[234.897555] [027/131] (785s left) kms_cursor_crc (cursor-onscreen-128x128)
[235.095598] Starting subtest: cursor-onscreen-128x128
[235.097730] Starting dynamic subtest: pipe-A-eDP-1
[237.254626] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.157s)
[237.285869] Starting dynamic subtest: pipe-D-eDP-1
[239.984109] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.704s)
[239.986279] Subtest cursor-onscreen-128x128: SUCCESS (4.889s)
[240.776334] [028/131] (780s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[241.139656] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[241.980680] [029/131] (778s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[242.061159] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[242.063502] Starting dynamic subtest: pipe-A-eDP-1
[253.365813] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.309s)
[253.375018] Starting dynamic subtest: pipe-B-eDP-1
[265.407118] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.040s)
[265.409472] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.352s)
[266.246248] [030/131] (754s left) syncobj_timeline (etime-multi-wait-submitted)
[266.306044] Starting subtest: etime-multi-wait-submitted
[266.412829] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[266.486993] [031/131] (754s left) kms_properties (colorop-properties-legacy)
[266.571898] Starting subtest: colorop-properties-legacy
[266.574177] Starting dynamic subtest: pipe-A-eDP-1
[266.919828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.346s)
[266.928366] Starting dynamic subtest: pipe-B-eDP-1
[268.007259] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.086s)
[268.016711] Starting dynamic subtest: pipe-C-eDP-1
[269.022570] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.016s)
[269.032516] Starting dynamic subtest: pipe-D-eDP-1
[270.064851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.039s)
[270.067263] Subtest colorop-properties-legacy: SUCCESS (3.493s)
[270.884901] [032/131] (750s left) syncobj_timeline (single-wait-for-submit-signaled)
[270.947729] Starting subtest: single-wait-for-submit-signaled
[270.950544] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[271.035956] [033/131] (750s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[271.122643] Starting subtest: psr-rgb101010-draw-mmap-wc
[278.023907] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.904s)
[278.127024] [034/131] (743s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[278.206692] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[278.209026] Starting dynamic subtest: pipe-A-eDP-1
[278.227894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[278.237590] Starting dynamic subtest: pipe-B-eDP-1
[278.256086] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[278.265082] Starting dynamic subtest: pipe-C-eDP-1
[278.284299] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[278.293367] Starting dynamic subtest: pipe-D-eDP-1
[278.312386] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[278.314576] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[280.460182] [035/131] (740s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[280.551224] Starting subtest: y-tiled-32bpp-rotate-180
[280.555183] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[280.638808] [036/131] (740s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[280.874265] Starting subtest: cursor-rapid-movement-256x256
[280.879104] Starting dynamic subtest: pipe-A-eDP-1
[281.424772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[281.450003] Starting dynamic subtest: pipe-D-eDP-1
[282.660101] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[282.661981] Subtest cursor-rapid-movement-256x256: SUCCESS (1.783s)
[283.513033] [037/131] (737s left) gem_exec_schedule (preempt-other-chain)
[283.596410] Starting subtest: preempt-other-chain
[283.598599] Starting dynamic subtest: rcs0
[283.683111] Dynamic subtest rcs0: SUCCESS (0.087s)
[283.694279] Starting dynamic subtest: bcs0
[283.761324] Dynamic subtest bcs0: SUCCESS (0.078s)
[283.773703] Starting dynamic subtest: vcs0
[283.842938] Dynamic subtest vcs0: SUCCESS (0.081s)
[283.855108] Starting dynamic subtest: vcs1
[283.920744] Dynamic subtest vcs1: SUCCESS (0.077s)
[283.932232] Starting dynamic subtest: vecs0
[283.997574] Dynamic subtest vecs0: SUCCESS (0.076s)
[284.010737] Starting dynamic subtest: ccs0
[284.111205] Dynamic subtest ccs0: SUCCESS (0.113s)
[284.113754] Subtest preempt-other-chain: SUCCESS (0.517s)
[284.914166] [038/131] (736s left) kms_lease (lease-invalid-plane)
[284.999728] Starting subtest: lease-invalid-plane
[285.002050] Starting dynamic subtest: pipe-A-eDP-1
[285.004298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[285.013161] Starting dynamic subtest: pipe-B-eDP-1
[285.015130] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[285.023599] Starting dynamic subtest: pipe-C-eDP-1
[285.025747] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[285.034094] Starting dynamic subtest: pipe-D-eDP-1
[285.035966] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[285.037916] Subtest lease-invalid-plane: SUCCESS (0.004s)
[285.074449] [039/131] (736s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[285.138961] Starting subtest: framebuffer-vs-set-tiling
[285.143519] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[285.267983] [040/131] (736s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[285.329635] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[285.386732] [041/131] (736s left) kms_atomic_interruptible (legacy-dpms)
[285.453206] Starting subtest: legacy-dpms
[285.455302] Starting dynamic subtest: pipe-A-eDP-1
[292.853509] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.398s)
[292.855767] Subtest legacy-dpms: SUCCESS (7.399s)
[293.675728] [042/131] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[293.757217] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[293.761619] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[293.856791] [043/131] (727s left) gem_softpin (32b-excludes-last-page)
[293.909479] Starting subtest: 32b-excludes-last-page
[293.914298] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[294.036046] [044/131] (727s left) perf (gen12-oa-tlb-invalidate)
[294.128203] Starting subtest: gen12-oa-tlb-invalidate
[294.130590] Starting dynamic subtest: 0-rcs0
[304.182070] Dynamic subtest 0-rcs0: SUCCESS (10.052s)
[304.195929] Starting dynamic subtest: 1-vcs0
[314.232665] Dynamic subtest 1-vcs0: SUCCESS (10.049s)
[314.235233] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.104s)
[314.282505] [045/131] (707s left) gem_exec_balancer (hog)
[314.348174] Starting subtest: hog
[314.352629] Subtest hog: SKIP (0.000s)
[314.655057] [046/131] (706s left) gem_userptr_blits (map-fixed-invalidate-busy)
[314.718536] Starting subtest: map-fixed-invalidate-busy
[314.722821] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[314.853021] [047/131] (706s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[314.935394] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[314.939691] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[315.044852] [048/131] (706s left) gem_exec_fence (syncobj-timeline-export)
[315.609684] Starting subtest: syncobj-timeline-export
[315.612501] Subtest syncobj-timeline-export: SUCCESS (0.006s)
[316.879767] [049/131] (704s left) gem_caching (read-writes)
[316.940337] Subtest read-writes: SKIP (0.000s)
[317.020446] [050/131] (704s left) i915_selftest (perf)
[320.311518] Starting subtest: perf
[320.315063] Starting dynamic subtest: engine_cs
[323.085754] Dynamic subtest engine_cs: SUCCESS (2.773s)
[323.095217] Starting dynamic subtest: request
[328.420166] Dynamic subtest request: SUCCESS (5.332s)
[328.429823] Starting dynamic subtest: migrate
[331.188818] Dynamic subtest migrate: SUCCESS (2.767s)
[331.196061] Starting dynamic subtest: region
[336.851757] Dynamic subtest region: SUCCESS (5.660s)
[336.854334] Subtest perf: SUCCESS (16.541s)
[336.881975] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[336.882670] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[336.885635] [051/131] (684s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[338.349996] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[338.424467] [FACT gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[338.425600] [FACT gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)] new: kernel.kmod_is_loaded.i915: true
[338.429432] [052/131] (683s left) kms_big_fb (linear-64bpp-rotate-90)
[338.515852] Starting subtest: linear-64bpp-rotate-90
[338.554637] Subtest linear-64bpp-rotate-90: SKIP (0.035s)
[338.662452] [053/131] (683s left) kms_async_flips (invalid-async-flip)
[338.745381] Starting subtest: invalid-async-flip
[339.124113] Starting dynamic subtest: pipe-A-eDP-1
[339.952582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s)
[340.312876] Starting dynamic subtest: pipe-B-eDP-1
[341.088877] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s)
[341.453581] Starting dynamic subtest: pipe-C-eDP-1
[342.218181] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.772s)
[342.578367] Starting dynamic subtest: pipe-D-eDP-1
[343.358518] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.788s)
[343.360776] Subtest invalid-async-flip: SUCCESS (4.615s)
[344.503287] [054/131] (677s left) kms_chamelium_color (ctm-0-50)
[344.576914] Subtest ctm-0-50: SKIP (0.000s)
[344.620371] [055/131] (677s left) gem_exec_reloc (basic-write-wc)
[344.681469] Subtest basic-write-wc: SKIP (0.000s)
[344.783446] [056/131] (677s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[344.859106] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[351.407349] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.552s)
[351.519310] [057/131] (670s left) kms_vblank (accuracy-idle)
[351.596481] Starting subtest: accuracy-idle
[351.598702] Starting dynamic subtest: pipe-A-eDP-1
[353.364449] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.768s)
[353.378170] Starting dynamic subtest: pipe-D-eDP-1
[355.771994] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.403s)
[355.774509] Subtest accuracy-idle: SUCCESS (4.174s)
[356.610384] [058/131] (665s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[356.683997] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[364.594296] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.914s)
[364.719392] [059/131] (657s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[364.801719] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[364.804031] Starting dynamic subtest: pipe-A-eDP-1
[364.813194] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[364.822635] Starting dynamic subtest: pipe-B-eDP-1
[364.831501] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[364.840087] Starting dynamic subtest: pipe-C-eDP-1
[364.848553] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[364.856886] Starting dynamic subtest: pipe-D-eDP-1
[364.865354] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[364.869772] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[367.043200] [060/131] (655s left) kms_debugfs (display-off-read-all)
[367.109984] Starting subtest: display-off-read-all
[367.402078] Subtest display-off-read-all: SUCCESS (0.292s)
[368.274409] [061/131] (654s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[368.379068] Starting subtest: basic-flip-after-cursor-atomic
[369.292463] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.913s)
[370.105951] [062/131] (652s left) gem_exec_params (rel-constants-invalid-ring)
[370.176867] Starting subtest: rel-constants-invalid-ring
[370.179195] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[370.274930] [063/131] (652s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[370.322426] Starting subtest: multi-wait-all-for-submit-submitted
[370.428103] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[370.503841] [064/131] (651s left) gem_render_copy (yf-tiled-ccs-to-linear)
[370.572700] Starting subtest: yf-tiled-ccs-to-linear
[370.577373] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[370.757347] [065/131] (651s left) kms_draw_crc (draw-method-render)
[370.835925] Starting subtest: draw-method-render
[370.837807] Starting dynamic subtest: xrgb8888-untiled
[371.078060] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[371.086903] Starting dynamic subtest: rgb565-untiled
[371.334025] Dynamic subtest rgb565-untiled: SUCCESS (0.255s)
[371.342244] Starting dynamic subtest: xrgb2101010-untiled
[371.568611] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.231s)
[371.577806] Starting dynamic subtest: xbgr16161616f-untiled
[371.811416] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[371.819638] Starting dynamic subtest: xrgb8888-xtiled
[371.933599] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[371.941774] Starting dynamic subtest: rgb565-xtiled
[372.056033] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[372.065483] Starting dynamic subtest: xrgb2101010-xtiled
[372.178059] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[372.186535] Starting dynamic subtest: xbgr16161616f-xtiled
[372.312300] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[372.323251] Starting dynamic subtest: xrgb8888-4tiled
[372.433541] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[372.441782] Starting dynamic subtest: rgb565-4tiled
[372.545037] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[372.553221] Starting dynamic subtest: xrgb2101010-4tiled
[372.666996] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[372.675450] Starting dynamic subtest: xbgr16161616f-4tiled
[372.800063] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[372.802077] Subtest draw-method-render: SUCCESS (1.967s)
[372.902016] [066/131] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[372.989904] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[372.993392] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[373.127404] [067/131] (649s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[373.215954] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[373.219544] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[373.324994] [068/131] (649s left) gem_set_tiling_vs_gtt
[373.454716] [069/131] (649s left) kms_psr (fbc-psr-sprite-blt)
[373.526504] Starting subtest: fbc-psr-sprite-blt
[373.528231] Starting dynamic subtest: eDP-1
[373.531774] Dynamic subtest eDP-1: SKIP (0.000s)
[373.535261] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[373.606094] [070/131] (649s left) syncobj_timeline (multi-wait-all-available-submitted)
[373.664442] Starting subtest: multi-wait-all-available-submitted
[373.666407] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[373.779091] [071/131] (648s left) dumb_buffer (map-invalid-size)
[373.839160] Starting subtest: map-invalid-size
[373.841053] Subtest map-invalid-size: SUCCESS (0.000s)
[373.937897] [072/131] (648s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[374.023870] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[374.027243] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[374.115156] [073/131] (648s left) kms_psr (fbc-psr2-cursor-render)
[374.201101] Starting subtest: fbc-psr2-cursor-render
[374.202941] Starting dynamic subtest: eDP-1
[374.206423] Dynamic subtest eDP-1: SKIP (0.000s)
[374.209836] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[374.277772] [074/131] (648s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[374.362811] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[374.368760] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.007s)
[374.467074] [075/131] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[374.531164] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[374.534863] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[374.638230] [076/131] (648s left) gen3_render_linear_blits
[374.755919] [077/131] (648s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[374.820993] Starting subtest: multi-wait-for-submit-submitted-signaled
[374.822736] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[374.915447] [078/131] (648s left) perf (invalid-open-flags)
[375.024112] Starting subtest: invalid-open-flags
[375.025916] Subtest invalid-open-flags: SUCCESS (0.000s)
[375.066523] [079/131] (647s left) kms_psr (psr2-cursor-blt)
[375.144081] Starting subtest: psr2-cursor-blt
[375.146299] Starting dynamic subtest: eDP-1
[376.880079] Dynamic subtest eDP-1: SUCCESS (1.734s)
[376.882276] Subtest psr2-cursor-blt: SUCCESS (1.736s)
[377.674332] [080/131] (645s left) kms_pm_rpm (cursor-dpms)
[379.167543] Starting subtest: cursor-dpms
[379.173051] Subtest cursor-dpms: SKIP (0.000s)
[379.905373] [081/131] (643s left) gem_exec_fence (syncobj-timeline-unused-fence)
[380.465829] Starting subtest: syncobj-timeline-unused-fence
[380.472060] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[381.919043] [082/131] (641s left) kms_frontbuffer_tracking (psr-slowdraw)
[381.993600] Starting subtest: psr-slowdraw
[407.208169] Subtest psr-slowdraw: SUCCESS (25.216s)
[407.330729] [083/131] (615s left) syncobj_timeline (reset-multiple-signaled)
[407.393046] Starting subtest: reset-multiple-signaled
[407.395308] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[407.500945] [084/131] (615s left) gem_wait (busy)
[407.575598] Starting subtest: busy
[407.577588] Starting dynamic subtest: all-engines
[408.857246] Dynamic subtest all-engines: SUCCESS (1.282s)
[408.868960] Starting dynamic subtest: rcs0
[409.396864] Dynamic subtest rcs0: SUCCESS (0.539s)
[409.408451] Starting dynamic subtest: bcs0
[409.936688] Dynamic subtest bcs0: SUCCESS (0.539s)
[409.947368] Starting dynamic subtest: vcs0
[411.865335] Dynamic subtest vcs0: SUCCESS (1.926s)
[411.875908] Starting dynamic subtest: vcs1
[413.848559] Dynamic subtest vcs1: SUCCESS (1.981s)
[413.860062] Starting dynamic subtest: vecs0
[415.858453] Dynamic subtest vecs0: SUCCESS (1.982s)
[415.869128] Starting dynamic subtest: ccs0
[416.374698] Dynamic subtest ccs0: SUCCESS (0.541s)
[416.377253] Subtest busy: SUCCESS (8.802s)
[416.571429] [085/131] (606s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[416.652155] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[416.656155] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[416.721482] [086/131] (606s left) kms_psr (psr2-sprite-plane-onoff)
[416.807708] Starting subtest: psr2-sprite-plane-onoff
[416.810631] Starting dynamic subtest: eDP-1
[418.533930] Dynamic subtest eDP-1: SUCCESS (1.728s)
[418.536260] Subtest psr2-sprite-plane-onoff: SUCCESS (1.729s)
[419.384722] [087/131] (603s left) kms_psr (psr-no-drrs)
[419.460582] Starting subtest: psr-no-drrs
[419.462747] Starting dynamic subtest: eDP-1
[421.066055] Dynamic subtest eDP-1: SUCCESS (1.605s)
[421.068275] Subtest psr-no-drrs: SUCCESS (1.606s)
[421.934053] [088/131] (601s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[422.029771] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[422.033909] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[422.130347] [089/131] (601s left) perf_pmu (most-busy-check-all)
[422.169071] Starting subtest: most-busy-check-all
[422.171434] Starting dynamic subtest: rcs0
[423.833019] Dynamic subtest rcs0: SUCCESS (1.663s)
[423.845257] Starting dynamic subtest: bcs0
[425.881364] Dynamic subtest bcs0: SUCCESS (2.045s)
[425.893890] Starting dynamic subtest: vcs0
[427.865208] Dynamic subtest vcs0: SUCCESS (1.981s)
[427.877686] Starting dynamic subtest: vcs1
[429.849574] Dynamic subtest vcs1: SUCCESS (1.981s)
[429.861839] Starting dynamic subtest: vecs0
[431.833528] Dynamic subtest vecs0: SUCCESS (1.981s)
[431.853827] Starting dynamic subtest: ccs0
[433.881071] Dynamic subtest ccs0: SUCCESS (2.045s)
[433.884456] Subtest most-busy-check-all: SUCCESS (11.712s)
[433.979790] [090/131] (589s left) i915_drm_fdinfo (busy-idle)
[434.036789] Starting subtest: busy-idle
[434.039099] Starting dynamic subtest: rcs0
[434.055056] Dynamic subtest rcs0: SKIP (0.018s)
[434.065575] Starting dynamic subtest: bcs0
[434.069956] Dynamic subtest bcs0: SKIP (0.000s)
[434.078469] Starting dynamic subtest: vcs0
[434.082673] Dynamic subtest vcs0: SKIP (0.000s)
[434.091214] Starting dynamic subtest: vcs1
[434.095627] Dynamic subtest vcs1: SKIP (0.000s)
[434.103840] Starting dynamic subtest: vecs0
[434.108161] Dynamic subtest vecs0: SKIP (0.000s)
[434.116255] Starting dynamic subtest: ccs0
[434.120677] Dynamic subtest ccs0: SKIP (0.000s)
[434.125171] Subtest busy-idle: SKIP (0.023s)
[434.161465] [091/131] (589s left) kms_plane_alpha_blend (coverage-7efc)
[434.240304] Starting subtest: coverage-7efc
[434.518506] Starting dynamic subtest: pipe-A-eDP-1
[435.108281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[435.133558] Starting dynamic subtest: pipe-D-eDP-1
[436.453551] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[436.455812] Subtest coverage-7efc: SUCCESS (2.213s)
[437.291968] [092/131] (586s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[437.356908] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[437.361453] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[437.429712] [093/131] (586s left) gem_exec_schedule (u-submit-golden-slice)
[437.500204] Starting subtest: u-submit-golden-slice
[437.502267] Starting dynamic subtest: rcs0
[437.532314] Dynamic subtest rcs0: SUCCESS (0.034s)
[437.543497] Starting dynamic subtest: bcs0
[437.560309] Dynamic subtest bcs0: SUCCESS (0.027s)
[437.569264] Starting dynamic subtest: vcs0
[437.598456] Dynamic subtest vcs0: SUCCESS (0.037s)
[437.608319] Starting dynamic subtest: vcs1
[437.625655] Dynamic subtest vcs1: SUCCESS (0.027s)
[437.634584] Starting dynamic subtest: vecs0
[437.651994] Dynamic subtest vecs0: SUCCESS (0.026s)
[437.661154] Starting dynamic subtest: ccs0
[437.682109] Dynamic subtest ccs0: SUCCESS (0.029s)
[437.684409] Subtest u-submit-golden-slice: SUCCESS (0.184s)
[438.966395] [094/131] (584s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[439.053792] Starting subtest: pr-overlay-plane-update-continuous-sf
[439.057686] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[439.118668] [095/131] (584s left) kms_rmfb (close-fd)
[439.193948] Starting subtest: close-fd
[439.195916] Starting dynamic subtest: pipe-A-eDP-1
[439.302727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[439.315356] Starting dynamic subtest: pipe-B-eDP-1
[440.468179] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[440.477946] Starting dynamic subtest: pipe-C-eDP-1
[441.709232] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[441.718657] Starting dynamic subtest: pipe-D-eDP-1
[442.928531] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[442.930798] Subtest close-fd: SUCCESS (3.739s)
[444.122973] [096/131] (579s left) kms_invalid_mode (bad-hsync-start)
[444.207672] Starting subtest: bad-hsync-start
[444.210079] Starting dynamic subtest: pipe-A-eDP-1
[444.513050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[444.524290] Starting dynamic subtest: pipe-B-eDP-1
[444.526423] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[444.535569] Starting dynamic subtest: pipe-C-eDP-1
[444.537849] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[444.547096] Starting dynamic subtest: pipe-D-eDP-1
[444.549347] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[444.551565] Subtest bad-hsync-start: SUCCESS (0.310s)
[445.350369] [097/131] (578s left) kms_flip (2x-flip-vs-suspend)
[445.433223] Starting subtest: 2x-flip-vs-suspend
[445.442100] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[445.519859] [098/131] (578s left) gem_exec_fence (concurrent)
[445.692911] Starting subtest: concurrent
[445.698079] Subtest concurrent: SKIP (0.000s)
[447.917483] [099/131] (575s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[447.985131] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[448.012572] Starting dynamic subtest: pipe-A-plane-0
[448.301325] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[448.312200] Starting dynamic subtest: pipe-A-plane-3
[448.546596] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[449.629480] Starting dynamic subtest: pipe-B-plane-0
[449.931822] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[449.941079] Starting dynamic subtest: pipe-B-plane-3
[450.176423] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[450.488955] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.502s)
[451.301426] [100/131] (572s left) gem_ctx_exec (basic-invalid-context)
[451.363309] Starting subtest: basic-invalid-context
[451.368460] Subtest basic-invalid-context: SUCCESS (0.006s)
[451.488466] [101/131] (572s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[451.561990] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[455.727807] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.169s)
[456.900455] [102/131] (567s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[456.985908] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[456.990376] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[457.088227] [103/131] (566s left) gem_userptr_blits (process-exit)
[457.157779] Starting subtest: process-exit
[457.165662] Subtest process-exit: SUCCESS (0.011s)
[457.298244] [104/131] (566s left) gem_mmap_gtt (basic-small-bo-tiledy)
[457.355715] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[457.407341] [105/131] (566s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[457.487046] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[457.489324] Starting dynamic subtest: pipe-A
[457.555236] Dynamic subtest pipe-A: SUCCESS (0.069s)
[457.566045] Starting dynamic subtest: pipe-B
[458.718436] Dynamic subtest pipe-B: SUCCESS (1.161s)
[458.728567] Starting dynamic subtest: pipe-C
[459.827337] Dynamic subtest pipe-C: SUCCESS (1.107s)
[459.836658] Starting dynamic subtest: pipe-D
[460.955711] Dynamic subtest pipe-D: SUCCESS (1.128s)
[460.958092] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.470s)
[462.126644] [106/131] (561s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[462.214438] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[462.218529] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[462.315451] [107/131] (561s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[462.386709] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[462.389441] Starting dynamic subtest: pipe-A-eDP-1
[462.409703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[462.421695] Starting dynamic subtest: pipe-B-eDP-1
[462.441128] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[462.450398] Starting dynamic subtest: pipe-C-eDP-1
[462.469980] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[462.481708] Starting dynamic subtest: pipe-D-eDP-1
[462.500970] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[462.503208] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[464.677966] [108/131] (559s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[464.760718] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[464.764968] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[464.855323] [109/131] (559s left) gem_busy (close-race)
[464.927497] Starting subtest: close-race
[488.856865] Subtest close-race: SUCCESS (23.927s)
[489.238327] [110/131] (535s left) gem_exec_schedule (preempt-self)
[489.345388] Starting subtest: preempt-self
[489.347617] Starting dynamic subtest: rcs0
[489.376778] Dynamic subtest rcs0: SUCCESS (0.037s)
[489.387230] Starting dynamic subtest: bcs0
[489.408738] Dynamic subtest bcs0: SUCCESS (0.031s)
[489.418038] Starting dynamic subtest: vcs0
[489.437829] Dynamic subtest vcs0: SUCCESS (0.029s)
[489.446918] Starting dynamic subtest: vcs1
[489.467406] Dynamic subtest vcs1: SUCCESS (0.029s)
[489.476144] Starting dynamic subtest: vecs0
[489.495274] Dynamic subtest vecs0: SUCCESS (0.027s)
[489.504088] Starting dynamic subtest: ccs0
[489.524584] Dynamic subtest ccs0: SUCCESS (0.029s)
[489.526900] Subtest preempt-self: SUCCESS (0.185s)
[490.942971] [111/131] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[491.040480] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[500.325843] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.287s)
[500.489129] [112/131] (523s left) gen9_exec_parse (bb-start-out)
[500.542458] Subtest bb-start-out: SKIP (0.000s)
[500.614062] [113/131] (523s left) gem_mmap_gtt (basic-small-copy-xy)
[500.672786] Subtest basic-small-copy-XY: SKIP (0.000s)
[500.726484] [114/131] (523s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[500.823729] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[500.828200] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[500.942345] [115/131] (523s left) gem_ctx_persistence (legacy-engines-queued)
[501.011661] Starting subtest: legacy-engines-queued
[501.013643] Starting dynamic subtest: render
[501.091203] Dynamic subtest render: SUCCESS (0.082s)
[501.104084] Starting dynamic subtest: bsd1
[502.839990] Dynamic subtest bsd1: SUCCESS (1.744s)
[502.850493] Starting dynamic subtest: bsd2
[504.822387] Dynamic subtest bsd2: SUCCESS (1.978s)
[504.835096] Starting dynamic subtest: blt
[504.885397] Dynamic subtest blt: SUCCESS (0.062s)
[504.896372] Starting dynamic subtest: vebox
[506.807034] Dynamic subtest vebox: SUCCESS (1.917s)
[506.809826] Subtest legacy-engines-queued: SUCCESS (5.798s)
[506.887972] [116/131] (517s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[507.015969] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[507.156168] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.142s)
[507.271077] [117/131] (517s left) gem_mmap_offset (mmap-boundaries)
[507.318736] Starting subtest: mmap-boundaries
[507.321100] Starting dynamic subtest: smem0
[507.587059] Dynamic subtest smem0: SUCCESS (0.271s)
[507.589893] Subtest mmap-boundaries: SUCCESS (0.271s)
[507.712460] [118/131] (516s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[507.803582] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[508.449592] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[508.615169] [119/131] (516s left) gem_unfence_active_buffers
[508.781141] [120/131] (515s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[508.859876] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[508.868875] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.007s)
[508.980341] [121/131] (515s left) gem_readwrite (write-bad-handle)
[509.062092] Subtest write-bad-handle: SKIP (0.000s)
[509.130778] [122/131] (515s left) syncobj_eventfd (invalid-bad-flags)
[509.175450] Starting subtest: invalid-bad-flags
[509.177382] Subtest invalid-bad-flags: SUCCESS (0.000s)
[509.268530] [123/131] (515s left) i915_pciid
[509.419144] [124/131] (515s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[509.491583] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[516.843285] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.353s)
[516.989136] [125/131] (507s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[517.081966] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[517.862894] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.782s)
[518.029195] [126/131] (506s left) i915_query (query-topology-known-pci-ids)
[518.093474] Starting subtest: query-topology-known-pci-ids
[518.097721] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[518.188279] [127/131] (506s left) kms_addfb_basic (addfb25-4-tiled)
[518.262956] Starting subtest: addfb25-4-tiled
[518.265256] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[518.371743] [128/131] (506s left) kms_addfb_basic (addfb25-bad-modifier)
[518.441946] Starting subtest: addfb25-bad-modifier
[518.444275] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[518.523440] [129/131] (506s left) gem_ctx_persistence (engines-mixed)
[518.580478] Starting subtest: engines-mixed
[518.582904] Starting dynamic subtest: rcs0
[518.660709] Dynamic subtest rcs0: SUCCESS (0.080s)
[518.671921] Starting dynamic subtest: bcs0
[518.723995] Dynamic subtest bcs0: SUCCESS (0.061s)
[518.735683] Starting dynamic subtest: vcs0
[518.781211] Dynamic subtest vcs0: SUCCESS (0.056s)
[518.795752] Starting dynamic subtest: vcs1
[518.835582] Dynamic subtest vcs1: SUCCESS (0.052s)
[518.846955] Starting dynamic subtest: vecs0
[518.900488] Dynamic subtest vecs0: SUCCESS (0.063s)
[518.911561] Starting dynamic subtest: ccs0
[518.965478] Dynamic subtest ccs0: SUCCESS (0.063s)
[518.967649] Subtest engines-mixed: SUCCESS (0.387s)
[519.063041] [130/131] (506s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[519.133837] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[519.137604] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[519.226585] [131/131] (505s left) gem_spin_batch (user-each)
[519.285260] Starting subtest: user-each
[522.553869] Subtest user-each: SUCCESS (3.261s)
[522.919881] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_ccs
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_color
results: parsing output: 5/ for test: sysfs_timeslice_duration
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_hdr
results: parsing output: 13/ for test: i915_pm_rpm
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: gem_ppgtt
results: parsing output: 16/ for test: gem_fence_thrash
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: kms_fbcon_fbt
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_chamelium_hpd
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_properties
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_atomic_interruptible
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: gem_caching
results: parsing output: 49/ for test: i915_selftest
results: parsing output: 50/ for test: gem_fenced_exec_thrash
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_async_flips
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_debugfs
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_draw_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_set_tiling_vs_gtt
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: dumb_buffer
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gen3_render_linear_blits
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_pm_rpm
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_wait
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: kms_plane_alpha_blend
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_rmfb
results: parsing output: 95/ for test: kms_invalid_mode
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: gem_ctx_exec
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_busy
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gen9_exec_parse
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: gem_pxp
results: parsing output: 116/ for test: gem_mmap_offset
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_unfence_active_buffers
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_readwrite
results: parsing output: 121/ for test: syncobj_eventfd
results: parsing output: 122/ for test: i915_pciid
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_spin_batch
Done.