[58.971180] Initializing watchdogs
[58.971225]   /dev/watchdog0
[58.986755] [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.991518] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.994080] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.997541] [001/133] (960s left) gem_tiled_blits (interruptible)
[59.094705] Subtest interruptible: SKIP (0.000s)
[59.176974] [002/133] (960s left) perf_pmu (interrupts-sync)
[59.217060] Starting subtest: interrupts-sync
[60.349887] Subtest interrupts-sync: SUCCESS (1.133s)
[60.468424] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[60.471493] [003/133] (959s left) kms_content_protection (atomic-hdcp14)
[60.645335] Starting subtest: atomic-hdcp14
[60.649771] Subtest atomic-hdcp14: SKIP (0.000s)
[60.813557] [004/133] (958s left) gem_ctx_persistence (legacy-engines-hostile)
[60.885344] Starting subtest: legacy-engines-hostile
[60.887250] Starting dynamic subtest: render
[61.049420] Dynamic subtest render: SUCCESS (0.165s)
[61.060084] Starting dynamic subtest: bsd1
[61.157994] Dynamic subtest bsd1: SUCCESS (0.107s)
[61.168234] Starting dynamic subtest: bsd2
[61.279947] Dynamic subtest bsd2: SUCCESS (0.121s)
[61.290920] Starting dynamic subtest: blt
[61.394883] Dynamic subtest blt: SUCCESS (0.114s)
[61.404713] Starting dynamic subtest: vebox
[61.516688] Dynamic subtest vebox: SUCCESS (0.121s)
[61.519248] Subtest legacy-engines-hostile: SUCCESS (0.635s)
[61.604599] [005/133] (958s left) kms_pipe_crc_basic (read-crc)
[61.695221] Starting subtest: read-crc
[61.696954] Starting dynamic subtest: pipe-A-eDP-1
[62.431487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[62.445523] Starting dynamic subtest: pipe-B-eDP-1
[63.865493] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.433s)
[63.874981] Starting dynamic subtest: pipe-C-eDP-1
[65.239421] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[65.248112] Starting dynamic subtest: pipe-D-eDP-1
[66.555972] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[66.558518] Subtest read-crc: SUCCESS (4.866s)
[67.401409] [006/133] (952s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[67.591154] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[67.593517] Starting dynamic subtest: pipe-A
[67.615321] Dynamic subtest pipe-A: SKIP (0.019s)
[67.623963] Starting dynamic subtest: pipe-B
[67.647600] Dynamic subtest pipe-B: SKIP (0.033s)
[67.655479] Starting dynamic subtest: pipe-C
[67.681350] Dynamic subtest pipe-C: SKIP (0.033s)
[67.689399] Starting dynamic subtest: pipe-D
[67.714731] Dynamic subtest pipe-D: SKIP (0.034s)
[67.719141] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.121s)
[67.982712] [007/133] (951s left) syncobj_eventfd (invalid-illegal-handle)
[68.064846] Starting subtest: invalid-illegal-handle
[68.066809] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[68.237181] [008/133] (951s left) kms_atomic (plane-primary-legacy)
[68.341929] Starting subtest: plane-primary-legacy
[68.344402] Starting dynamic subtest: pipe-A-eDP-1
[68.821166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s)
[68.823602] Subtest plane-primary-legacy: SUCCESS (0.482s)
[69.638843] [009/133] (950s left) gem_eio (wait-10ms)
[69.820567] Starting subtest: wait-10ms
[70.082865] Subtest wait-10ms: SUCCESS (0.263s)
[70.243488] [010/133] (949s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[70.348354] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[70.352168] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[70.432602] [011/133] (949s left) perf (unprivileged-single-ctx-counters)
[70.554594] Starting subtest: unprivileged-single-ctx-counters
[70.558233] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[70.601309] [012/133] (949s left) gem_mmap_gtt (basic-read-write-distinct)
[70.668982] Subtest basic-read-write-distinct: SKIP (0.000s)
[70.742465] [013/133] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[70.838387] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[70.841944] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.954400] [014/133] (949s left) kms_prime (basic-crc-vgem)
[71.034777] Starting subtest: basic-crc-vgem
[71.036472] Starting dynamic subtest: second-to-first
[71.979145] Dynamic subtest second-to-first: SUCCESS (0.948s)
[71.981142] Subtest basic-crc-vgem: SUCCESS (0.948s)
[72.086070] [015/133] (948s left) gen7_exec_parse (bitmasks)
[72.191905] Subtest bitmasks: SKIP (0.000s)
[72.276719] [016/133] (947s left) gem_create (create-ext-set-pat)
[72.444918] Starting subtest: create-ext-set-pat
[72.447099] Subtest create-ext-set-pat: SUCCESS (0.001s)
[72.570038] [017/133] (947s left) kms_lease (possible-crtcs-filtering)
[72.668673] Starting subtest: possible-crtcs-filtering
[72.673388] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[72.820951] [018/133] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[72.926066] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[79.632586] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.711s)
[79.791196] [019/133] (940s left) vgem_basic (dmabuf-mmap)
[79.832952] Starting subtest: dmabuf-mmap
[79.837723] Subtest dmabuf-mmap: SUCCESS (0.007s)
[79.899417] [020/133] (940s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[80.002237] Starting subtest: 2x-flip-vs-rmfb-interruptible
[80.013385] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[80.148084] [021/133] (940s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[80.257702] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[87.278968] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.025s)
[87.418679] [022/133] (932s left) kms_vblank (ts-continuation-modeset-hang)
[87.530918] Starting subtest: ts-continuation-modeset-hang
[87.533338] Starting dynamic subtest: pipe-A-eDP-1
[113.695614] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.167s)
[113.713608] Starting dynamic subtest: pipe-D-eDP-1
[138.739657] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.041s)
[138.741978] Subtest ts-continuation-modeset-hang: SUCCESS (51.211s)
[139.647099] [023/133] (880s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[139.762955] Starting subtest: yf-tiled-8bpp-rotate-0
[139.767527] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[139.875794] [024/133] (880s left) kms_chamelium_edid (dp-edid-read)
[140.255063] Subtest dp-edid-read: SKIP (0.000s)
[141.111750] [025/133] (879s left) gem_eio (context-create)
[141.292882] Starting subtest: context-create
[141.549031] Subtest context-create: SUCCESS (0.257s)
[141.728830] [026/133] (878s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[141.858550] Starting subtest: flip-vs-cursor-atomic
[148.993051] Subtest flip-vs-cursor-atomic: SUCCESS (7.134s)
[149.873313] [027/133] (870s left) i915_query (query-topology-coherent-slice-mask)
[149.936057] Starting subtest: query-topology-coherent-slice-mask
[149.940556] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[150.048444] [028/133] (870s left) gem_softpin (allocator-evict)
[150.094384] Starting subtest: allocator-evict
[150.096709] Starting dynamic subtest: rcs0
[173.978553] Dynamic subtest rcs0: SUCCESS (23.881s)
[173.990128] Starting dynamic subtest: bcs0
[198.280344] Dynamic subtest bcs0: SUCCESS (24.299s)
[198.290323] Starting dynamic subtest: vcs0
[221.895214] Dynamic subtest vcs0: SUCCESS (23.613s)
[221.906581] Starting dynamic subtest: vcs1
[245.754735] Dynamic subtest vcs1: SUCCESS (23.858s)
[245.763542] Starting dynamic subtest: vecs0
[269.378329] Dynamic subtest vecs0: SUCCESS (23.622s)
[269.387546] Starting dynamic subtest: ccs0
[293.758386] Dynamic subtest ccs0: SUCCESS (24.376s)
[293.761327] Subtest allocator-evict: SUCCESS (143.656s)
[293.863894] [029/133] (726s left) gem_lmem_swapping (verify)
[293.955973] Subtest verify: SKIP (0.000s)
[294.003951] [030/133] (726s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[294.062781] Starting subtest: yf-tiled-to-vebox-x-tiled
[294.067238] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[294.263441] [031/133] (726s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[294.368834] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[294.395238] Starting dynamic subtest: pipe-A-plane-0
[294.399796] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[294.410253] Starting dynamic subtest: pipe-A-plane-3
[294.414769] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[294.423276] Starting dynamic subtest: pipe-A-plane-5
[294.428218] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[295.542587] Starting dynamic subtest: pipe-B-plane-0
[295.546656] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[295.554976] Starting dynamic subtest: pipe-B-plane-3
[295.559598] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[295.567933] Starting dynamic subtest: pipe-B-plane-5
[295.571957] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[295.849658] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (1.478s)
[296.729421] [032/133] (724s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[296.838715] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[296.842909] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[296.953949] [033/133] (723s left) i915_query (test-query-geometry-subslices)
[297.015816] Starting subtest: test-query-geometry-subslices
[297.017997] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[297.115054] [034/133] (723s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[297.218398] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[297.222785] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[297.332703] [035/133] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[297.434402] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[297.438457] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[297.547463] [036/133] (723s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[297.651249] Starting subtest: psr2-overlay-plane-update-continuous-sf
[297.653100] Starting dynamic subtest: pipe-A-eDP-1
[298.765735] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.118s)
[298.776767] Starting dynamic subtest: pipe-B-eDP-1
[300.469780] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.702s)
[300.471675] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.822s)
[301.299855] [037/133] (719s left) kms_getfb (getfb-handle-protection)
[301.409972] Starting subtest: getfb-handle-protection
[301.431031] Subtest getfb-handle-protection: SUCCESS (0.022s)
[301.593838] [038/133] (719s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[301.690017] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[301.702439] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[301.786796] [039/133] (719s left) api_intel_bb (blit-reloc-keep-cache)
[301.860041] Starting subtest: blit-reloc-keep-cache
[301.864528] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[302.012633] [040/133] (719s left) kms_color (ctm-signed)
[302.110653] Starting subtest: ctm-signed
[302.112520] Starting dynamic subtest: pipe-A-eDP-1
[304.176462] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.064s)
[304.189267] Starting dynamic subtest: pipe-B-eDP-1
[307.044891] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.868s)
[307.054831] Starting dynamic subtest: pipe-C-eDP-1
[309.687482] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.644s)
[309.697126] Starting dynamic subtest: pipe-D-eDP-1
[312.391097] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.702s)
[312.392894] Subtest ctm-signed: SUCCESS (10.280s)
[313.212815] [041/133] (707s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[313.319413] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[313.323571] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[313.444070] [042/133] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[313.540192] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[313.544153] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[313.663343] [043/133] (707s left) gem_mmap_gtt (basic-write)
[313.725617] Subtest basic-write: SKIP (0.000s)
[313.786963] [044/133] (707s left) syncobj_basic (bad-handle-to-fd)
[313.845373] Starting subtest: bad-handle-to-fd
[313.847579] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[313.962755] [045/133] (707s left) kms_properties (get_properties-sanity-non-atomic)
[314.063204] Starting subtest: get_properties-sanity-non-atomic
[314.065536] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[314.150823] [046/133] (707s left) gem_exec_schedule (pi-userfault)
[314.333062] Starting subtest: pi-userfault
[314.335065] Starting dynamic subtest: rcs0
[314.342478] Dynamic subtest rcs0: SUCCESS (0.012s)
[314.351746] Starting dynamic subtest: bcs0
[314.353824] Dynamic subtest bcs0: SUCCESS (0.007s)
[314.362796] Starting dynamic subtest: vcs0
[314.364666] Dynamic subtest vcs0: SUCCESS (0.007s)
[314.373137] Starting dynamic subtest: vcs1
[314.375231] Dynamic subtest vcs1: SUCCESS (0.008s)
[314.383559] Starting dynamic subtest: vecs0
[314.385539] Dynamic subtest vecs0: SUCCESS (0.009s)
[314.394314] Starting dynamic subtest: ccs0
[314.396494] Dynamic subtest ccs0: SUCCESS (0.008s)
[314.398643] Subtest pi-userfault: SUCCESS (0.055s)
[314.578447] [047/133] (706s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[314.964834] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[315.802044] [048/133] (705s left) gem_mmap_wc (close)
[315.865449] Subtest close: SKIP (0.000s)
[315.921104] [049/133] (705s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[316.022364] Starting subtest: fbc-pr-sprite-mmap-cpu
[316.026694] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[316.120332] [050/133] (705s left) device_reset (cold-reset-bound)
[316.173213] Starting subtest: cold-reset-bound
[316.177729] Subtest cold-reset-bound: SKIP (0.000s)
[316.257368] [051/133] (705s left) gem_softpin (evict-active)
[316.326923] Starting subtest: evict-active
[316.333225] Subtest evict-active: SUCCESS (0.006s)
[316.490741] [052/133] (705s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[316.547255] Starting subtest: etime-multi-wait-all-submitted-signaled
[316.651078] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[316.741564] [053/133] (704s left) gem_exec_schedule (u-lateslice)
[316.819389] Starting subtest: u-lateslice
[316.821603] Starting dynamic subtest: rcs0
[316.830887] Dynamic subtest rcs0: SUCCESS (0.022s)
[316.841554] Starting dynamic subtest: bcs0
[316.848421] Dynamic subtest bcs0: SUCCESS (0.017s)
[316.857130] Starting dynamic subtest: vcs0
[316.867665] Dynamic subtest vcs0: SUCCESS (0.019s)
[316.876073] Starting dynamic subtest: vcs1
[316.886624] Dynamic subtest vcs1: SUCCESS (0.019s)
[316.895168] Starting dynamic subtest: vecs0
[316.904983] Dynamic subtest vecs0: SUCCESS (0.018s)
[316.913513] Starting dynamic subtest: ccs0
[316.923053] Dynamic subtest ccs0: SUCCESS (0.017s)
[316.925281] Subtest u-lateslice: SUCCESS (0.115s)
[319.031194] [054/133] (702s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[319.134059] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[319.136411] Starting dynamic subtest: pipe-A
[319.471736] Dynamic subtest pipe-A: SUCCESS (0.340s)
[319.480580] Starting dynamic subtest: pipe-B
[320.938764] Dynamic subtest pipe-B: SUCCESS (1.466s)
[320.951193] Starting dynamic subtest: pipe-C
[322.337475] Dynamic subtest pipe-C: SUCCESS (1.398s)
[322.346662] Starting dynamic subtest: pipe-D
[323.771157] Dynamic subtest pipe-D: SUCCESS (1.433s)
[323.773487] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.640s)
[324.957590] [055/133] (696s left) sw_sync (sync_merge_same)
[324.999466] Starting subtest: sync_merge_same
[325.001617] Subtest sync_merge_same: SUCCESS (0.000s)
[325.063908] [056/133] (696s left) gem_ppgtt (shrink-vs-evict-any)
[325.120659] Starting subtest: shrink-vs-evict-any
[332.884661] Subtest shrink-vs-evict-any: SUCCESS (7.762s)
[332.992280] [057/133] (688s left) syncobj_timeline (wait-delayed-signal)
[333.048814] Starting subtest: wait-delayed-signal
[333.151770] Subtest wait-delayed-signal: SUCCESS (0.103s)
[333.241571] [058/133] (688s left) kms_big_fb (linear-64bpp-rotate-270)
[333.346210] Starting subtest: linear-64bpp-rotate-270
[333.365135] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[333.516695] [059/133] (688s left) sw_sync (timeline_closed)
[333.551837] Starting subtest: timeline_closed
[333.554514] Subtest timeline_closed: SUCCESS (0.000s)
[333.611968] [060/133] (688s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[333.705865] Starting subtest: primary-yf-tiled-reflect-x-270
[333.710165] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[333.795040] [061/133] (688s left) kms_pm_rpm (drm-resources-equal)
[336.047893] Starting subtest: drm-resources-equal
[341.051880] Subtest drm-resources-equal: SUCCESS (5.006s)
[341.166592] [062/133] (680s left) syncobj_wait (wait-all-complex)
[341.226336] Starting subtest: wait-all-complex
[341.441054] Subtest wait-all-complex: SUCCESS (0.214s)
[341.529067] [063/133] (680s left) gem_exec_params (invalid-bsd2-flag-on-render)
[341.587509] Starting subtest: invalid-bsd2-flag-on-render
[341.589726] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[341.716507] [064/133] (680s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[341.849822] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[341.854414] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[342.018400] [065/133] (680s left) kms_flip (2x-nonexisting-fb-interruptible)
[342.107066] Starting subtest: 2x-nonexisting-fb-interruptible
[342.118915] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[342.224150] [066/133] (679s left) gem_exec_store (cachelines)
[342.287074] Starting subtest: cachelines
[342.289284] Starting dynamic subtest: rcs0
[342.375925] Dynamic subtest rcs0: SUCCESS (0.089s)
[342.386994] Starting dynamic subtest: bcs0
[342.445376] Dynamic subtest bcs0: SUCCESS (0.068s)
[342.456232] Starting dynamic subtest: vcs0
[342.501282] Dynamic subtest vcs0: SUCCESS (0.055s)
[342.512202] Starting dynamic subtest: vcs1
[342.554710] Dynamic subtest vcs1: SUCCESS (0.052s)
[342.567483] Starting dynamic subtest: vecs0
[342.618686] Dynamic subtest vecs0: SUCCESS (0.063s)
[342.629637] Starting dynamic subtest: ccs0
[342.684197] Dynamic subtest ccs0: SUCCESS (0.063s)
[342.686331] Subtest cachelines: SUCCESS (0.399s)
[342.884121] [067/133] (679s left) gem_userptr_blits (sd-probe)
[342.950567] Starting subtest: sd-probe
[342.952592] Subtest sd-probe: SUCCESS (0.000s)
[343.098157] [068/133] (679s left) core_auth (getclient-simple)
[343.144037] Starting subtest: getclient-simple
[343.165404] Subtest getclient-simple: SUCCESS (0.021s)
[343.304450] [069/133] (679s left) kms_selftest (drm_dp_mst_helper)
[343.341870] Starting subtest: drm_dp_mst_helper
[343.386996] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[343.506890] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.120s)
[343.516816] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[343.651142] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.143s)
[343.664880] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[343.776285] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.125s)
[343.778528] Subtest drm_dp_mst_helper: SUCCESS (0.434s)
[343.978674] [070/133] (678s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[344.073380] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[344.075608] Starting dynamic subtest: pipe-A-eDP-1
[344.853652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.771s)
[344.863889] Starting dynamic subtest: pipe-B-eDP-1
[346.475816] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.620s)
[346.485619] Starting dynamic subtest: pipe-C-eDP-1
[347.976102] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.500s)
[347.985066] Starting dynamic subtest: pipe-D-eDP-1
[349.501702] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.521s)
[349.504042] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.418s)
[350.724720] [071/133] (671s left) perf_pmu (render-node-busy)
[350.810268] Starting subtest: render-node-busy
[350.812668] Starting dynamic subtest: rcs0
[351.398275] Dynamic subtest rcs0: SUCCESS (0.590s)
[351.409944] Starting dynamic subtest: bcs0
[351.959668] Dynamic subtest bcs0: SUCCESS (0.560s)
[351.970666] Starting dynamic subtest: vcs0
[353.878586] Dynamic subtest vcs0: SUCCESS (1.915s)
[353.890640] Starting dynamic subtest: vcs1
[355.927060] Dynamic subtest vcs1: SUCCESS (2.046s)
[355.938859] Starting dynamic subtest: vecs0
[357.911489] Dynamic subtest vecs0: SUCCESS (1.982s)
[357.926746] Starting dynamic subtest: ccs0
[358.482291] Dynamic subtest ccs0: SUCCESS (0.569s)
[358.484647] Subtest render-node-busy: SUCCESS (7.675s)
[358.580835] [072/133] (663s left) gem_exec_schedule (fairslice)
[358.645798] Starting subtest: fairslice
[358.648305] Starting dynamic subtest: rcs0
[360.669974] Dynamic subtest rcs0: SUCCESS (2.031s)
[360.679828] Starting dynamic subtest: bcs0
[362.693193] Dynamic subtest bcs0: SUCCESS (2.025s)
[362.703118] Starting dynamic subtest: vcs0
[364.716872] Dynamic subtest vcs0: SUCCESS (2.020s)
[364.726704] Starting dynamic subtest: vcs1
[366.736551] Dynamic subtest vcs1: SUCCESS (2.019s)
[366.746276] Starting dynamic subtest: vecs0
[368.755388] Dynamic subtest vecs0: SUCCESS (2.017s)
[368.765629] Starting dynamic subtest: ccs0
[370.782229] Dynamic subtest ccs0: SUCCESS (2.028s)
[370.784413] Subtest fairslice: SUCCESS (12.144s)
[371.103082] [073/133] (651s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[371.216978] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[371.219313] Starting dynamic subtest: pipe-A-default-mode
[373.968554] Dynamic subtest pipe-A-default-mode: SUCCESS (2.751s)
[373.970905] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.753s)
[374.818546] [074/133] (647s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[374.930929] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[374.933207] Starting dynamic subtest: pipe-A-eDP-1
[374.955491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[374.969658] Starting dynamic subtest: pipe-B-eDP-1
[374.992230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[375.000893] Starting dynamic subtest: pipe-C-eDP-1
[375.021911] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[375.030635] Starting dynamic subtest: pipe-D-eDP-1
[375.052046] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[375.056265] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[377.084371] [075/133] (645s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[377.194136] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[377.198430] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[377.279126] [076/133] (645s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[377.366431] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[377.368339] Starting dynamic subtest: pipe-A-eDP-1
[377.507837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.133s)
[377.518967] Starting dynamic subtest: pipe-B-eDP-1
[377.538042] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[377.546387] Starting dynamic subtest: pipe-C-eDP-1
[377.564886] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[377.573433] Starting dynamic subtest: pipe-D-eDP-1
[377.592796] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[377.594717] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.142s)
[379.767969] [077/133] (642s left) kms_cursor_crc (cursor-onscreen-32x10)
[379.936957] Starting subtest: cursor-onscreen-32x10
[379.987436] Subtest cursor-onscreen-32x10: SKIP (0.046s)
[380.272873] [078/133] (642s left) gem_tiled_fence_blits (basic)
[380.337447] Subtest basic: SKIP (0.000s)
[380.440402] [079/133] (642s left) i915_drm_fdinfo (all-busy-check-all)
[380.476651] Starting subtest: all-busy-check-all
[380.481393] Subtest all-busy-check-all: SKIP (0.003s)
[380.550869] [080/133] (642s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[380.703640] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[385.259772] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.556s)
[386.397810] [081/133] (636s left) perf_pmu (busy-accuracy-98)
[386.443396] Starting subtest: busy-accuracy-98
[386.445543] Starting dynamic subtest: rcs0
[389.480769] Dynamic subtest rcs0: SUCCESS (3.035s)
[389.490277] Starting dynamic subtest: bcs0
[392.537034] Dynamic subtest bcs0: SUCCESS (3.054s)
[392.546046] Starting dynamic subtest: vcs0
[395.580127] Dynamic subtest vcs0: SUCCESS (3.040s)
[395.591429] Starting dynamic subtest: vcs1
[398.624910] Dynamic subtest vcs1: SUCCESS (3.043s)
[398.636751] Starting dynamic subtest: vecs0
[401.669084] Dynamic subtest vecs0: SUCCESS (3.042s)
[401.680755] Starting dynamic subtest: ccs0
[404.721621] Dynamic subtest ccs0: SUCCESS (3.051s)
[404.724072] Subtest busy-accuracy-98: SUCCESS (18.277s)
[404.887833] [082/133] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[404.992255] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[404.996287] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[405.123056] [083/133] (617s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[405.186021] Starting subtest: x-tiled-to-vebox-yf-tiled
[405.190445] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[405.376841] [084/133] (617s left) kms_psr (psr-cursor-mmap-cpu)
[405.467497] Starting subtest: psr-cursor-mmap-cpu
[405.469882] Starting dynamic subtest: eDP-1
[407.152683] Dynamic subtest eDP-1: SUCCESS (1.684s)
[407.154537] Subtest psr-cursor-mmap-cpu: SUCCESS (1.685s)
[408.027862] [085/133] (614s left) kms_big_fb (x-tiled-addfb-size-overflow)
[408.133847] Starting subtest: x-tiled-addfb-size-overflow
[408.136041] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[408.258438] [086/133] (614s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[408.355930] Starting subtest: random-ccs-data-yf-tiled-ccs
[408.358276] Starting dynamic subtest: pipe-A-eDP-1
[408.383325] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.394523] Starting dynamic subtest: pipe-B-eDP-1
[408.417076] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.425522] Starting dynamic subtest: pipe-C-eDP-1
[408.448640] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.457377] Starting dynamic subtest: pipe-D-eDP-1
[408.481279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.485236] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[410.606407] [087/133] (612s left) kms_cursor_edge_walk (128x128-top-bottom)
[410.710581] Starting subtest: 128x128-top-bottom
[410.712829] Starting dynamic subtest: pipe-A-eDP-1
[414.182330] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[414.192843] Starting dynamic subtest: pipe-D-eDP-1
[417.291840] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[417.294114] Subtest 128x128-top-bottom: SUCCESS (6.583s)
[418.120317] [088/133] (605s left) gem_exec_flush (basic-wb-ro-default)
[418.193598] Starting subtest: basic-wb-ro-default
[423.651882] Subtest basic-wb-ro-default: SUCCESS (5.458s)
[423.845234] [089/133] (599s left) gem_exec_params (sol-reset-invalid)
[423.899830] Starting subtest: sol-reset-invalid
[423.905896] Subtest sol-reset-invalid: SUCCESS (0.004s)
[425.948052] [090/133] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[426.052260] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[433.566895] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.518s)
[433.746488] [091/133] (589s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[433.854396] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[433.858306] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[433.987817] [092/133] (589s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[434.090513] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[434.094488] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[434.172649] [093/133] (589s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[434.279689] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[441.454061] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.179s)
[441.624939] [094/133] (581s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[441.735580] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[449.117162] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.386s)
[449.287213] [095/133] (574s left) gem_busy (semaphore)
[449.483698] Subtest semaphore: SKIP (0.000s)
[449.742090] [096/133] (573s left) gem_exec_nop (basic-series)
[449.833607] Starting subtest: basic-series
[465.945870] Subtest basic-series: SUCCESS (16.119s)
[466.204149] [097/133] (557s left) kms_addfb_basic (basic-x-tiled-legacy)
[466.268643] Starting subtest: basic-x-tiled-legacy
[466.272775] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[466.421136] [098/133] (557s left) i915_pm_rpm (system-suspend-devices)
[468.047752] Starting subtest: system-suspend-devices
[475.832816] Subtest system-suspend-devices: SUCCESS (7.785s)
[485.250234] [099/133] (547s left) kms_big_fb (4-tiled-addfb-size-overflow)
[485.403704] Starting subtest: 4-tiled-addfb-size-overflow
[485.405981] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[485.535280] [100/133] (547s left) gem_exec_fence (syncobj-repeat)
[485.968413] Starting subtest: syncobj-repeat
[486.146069] Subtest syncobj-repeat: SUCCESS (0.179s)
[487.968230] [101/133] (544s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[488.115417] Starting subtest: cursorA-vs-flipB-atomic
[488.119754] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[488.296874] [102/133] (544s left) perf (polling-parameterized)
[488.420697] Starting subtest: polling-parameterized
[508.444139] Subtest polling-parameterized: SUCCESS (20.021s)
[508.496303] [103/133] (524s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[508.710518] Starting subtest: cursor-rapid-movement-128x42
[508.757283] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[508.995437] [104/133] (523s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[509.099765] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[517.781445] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.684s)
[517.908930] [105/133] (514s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[518.018831] Starting subtest: x-tiled-8bpp-rotate-0
[519.231592] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.213s)
[519.401620] [106/133] (513s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[519.503068] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[519.506477] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[519.634264] [107/133] (513s left) i915_drm_fdinfo (virtual-busy-hang-all)
[519.671918] Starting subtest: virtual-busy-hang-all
[519.675708] Subtest virtual-busy-hang-all: SKIP (0.000s)
[519.757818] [108/133] (513s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[519.859141] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[519.862669] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[519.979710] [109/133] (513s left) gem_exec_capture (capture-invisible)
[520.045504] Starting subtest: capture-invisible
[520.047418] Starting dynamic subtest: smem0
[520.050819] Dynamic subtest smem0: SKIP (0.000s)
[520.054226] Subtest capture-invisible: SKIP (0.001s)
[520.173821] [110/133] (512s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[520.278774] Starting subtest: psr-2p-primscrn-spr-indfb-move
[520.282267] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[520.436481] [111/133] (512s left) kms_psr (pr-primary-page-flip)
[520.517333] Starting subtest: pr-primary-page-flip
[520.521165] Subtest pr-primary-page-flip: SKIP (0.000s)
[520.603987] [112/133] (512s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[520.708218] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[520.711761] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[520.846739] [113/133] (512s left) gem_tiled_fence_blits (normal)
[520.896309] Subtest normal: SKIP (0.000s)
[520.958344] [114/133] (512s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[521.046308] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[521.048193] Starting dynamic subtest: pipe-A-eDP-1
[521.094821] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[521.103946] Starting dynamic subtest: pipe-B-eDP-1
[521.148796] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[521.158515] Starting dynamic subtest: pipe-C-eDP-1
[521.204417] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[521.214155] Starting dynamic subtest: pipe-D-eDP-1
[521.260074] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[521.263679] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.010s)
[523.328102] [115/133] (509s left) kms_psr (psr-primary-mmap-gtt)
[523.423948] Starting subtest: psr-primary-mmap-gtt
[523.426228] Starting dynamic subtest: eDP-1
[524.807280] Dynamic subtest eDP-1: SKIP (1.382s)
[524.812070] Subtest psr-primary-mmap-gtt: SKIP (1.384s)
[525.002964] [116/133] (508s left) gem_mmap_gtt (zero-extend)
[525.066241] Subtest zero-extend: SKIP (0.000s)
[525.137584] [117/133] (508s left) gem_mmap_gtt (basic-small-copy-xy)
[525.207772] Subtest basic-small-copy-XY: SKIP (0.000s)
[525.273303] [118/133] (508s left) syncobj_timeline (wait-all-complex)
[525.339593] Starting subtest: wait-all-complex
[525.551646] Subtest wait-all-complex: SUCCESS (0.212s)
[525.641061] [119/133] (507s left) gem_mmap_gtt (basic-short)
[525.700296] Subtest basic-short: SKIP (0.000s)
[525.777463] [120/133] (507s left) kms_invalid_mode (zero-clock)
[525.883244] Starting subtest: zero-clock
[525.885509] Starting dynamic subtest: pipe-A-eDP-1
[526.173499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[526.183540] Starting dynamic subtest: pipe-B-eDP-1
[526.185388] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[526.194607] Starting dynamic subtest: pipe-C-eDP-1
[526.196846] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[526.206114] Starting dynamic subtest: pipe-D-eDP-1
[526.208302] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[526.210389] Subtest zero-clock: SUCCESS (0.297s)
[526.987312] [121/133] (506s left) gem_exec_balancer (nop)
[527.050284] Starting subtest: nop
[573.791766] Subtest nop: SUCCESS (46.739s)
[574.104420] [122/133] (459s left) gem_ctx_isolation (dirty-create)
[574.182112] Starting subtest: dirty-create
[574.184382] Starting dynamic subtest: rcs0
[574.386564] Dynamic subtest rcs0: SUCCESS (0.205s)
[574.396571] Starting dynamic subtest: bcs0
[574.642808] Dynamic subtest bcs0: SUCCESS (0.255s)
[574.652539] Starting dynamic subtest: vcs0
[574.910059] Dynamic subtest vcs0: SUCCESS (0.266s)
[574.919799] Starting dynamic subtest: vcs1
[576.121296] Dynamic subtest vcs1: SUCCESS (1.209s)
[576.131558] Starting dynamic subtest: vecs0
[578.095442] Dynamic subtest vecs0: SUCCESS (1.974s)
[578.105943] Starting dynamic subtest: ccs0
[580.155619] Dynamic subtest ccs0: SUCCESS (2.059s)
[580.158078] Subtest dirty-create: SUCCESS (5.974s)
[580.416162] [123/133] (453s left) gem_exec_parallel (fds)
[580.481321] Starting subtest: fds
[580.483767] Starting dynamic subtest: rcs0
[584.132553] Dynamic subtest rcs0: SUCCESS (3.626s)
[584.147276] Starting dynamic subtest: bcs0
[587.376296] Dynamic subtest bcs0: SUCCESS (3.264s)
[587.389269] Starting dynamic subtest: vcs0
[591.161356] Dynamic subtest vcs0: SUCCESS (3.781s)
[591.171605] Starting dynamic subtest: vcs1
[595.177293] Dynamic subtest vcs1: SUCCESS (4.013s)
[595.190367] Starting dynamic subtest: vecs0
[599.168316] Dynamic subtest vecs0: SUCCESS (3.964s)
[599.180065] Starting dynamic subtest: ccs0
[602.511326] Dynamic subtest ccs0: SUCCESS (3.366s)
[602.514356] Subtest fds: SUCCESS (22.028s)
[602.721636] [124/133] (430s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[602.846029] Starting subtest: fbc-psr-sprite-mmap-gtt
[602.848282] Starting dynamic subtest: eDP-1
[602.852533] Dynamic subtest eDP-1: SKIP (0.000s)
[602.856787] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[602.951420] [125/133] (430s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[603.006980] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[603.009117] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[603.139384] [126/133] (430s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[603.246903] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[603.251310] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[603.378519] [127/133] (430s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[603.443424] Starting subtest: multi-wait-available-unsubmitted-signaled
[603.445593] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[603.576192] [128/133] (430s left) kms_feature_discovery (chamelium)
[603.667818] Starting subtest: chamelium
[603.671389] Subtest chamelium: SKIP (0.000s)
[603.754410] [129/133] (430s left) kms_flip (dpms-off-confusion)
[603.845388] Starting subtest: dpms-off-confusion
[603.847039] Starting dynamic subtest: A-eDP1
[612.570155] Dynamic subtest A-eDP1: SUCCESS (8.725s)
[612.583590] Starting dynamic subtest: B-eDP1
[621.305052] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[621.319754] Starting dynamic subtest: C-eDP1
[629.932891] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[629.943963] Starting dynamic subtest: D-eDP1
[638.573040] Dynamic subtest D-eDP1: SUCCESS (8.639s)
[638.577645] Subtest dpms-off-confusion: SUCCESS (34.734s)
[639.770153] [130/133] (394s left) gem_lmem_swapping (heavy-verify-random)
[639.820606] Subtest heavy-verify-random: SKIP (0.000s)
[639.871443] [131/133] (394s left) kms_plane_multiple (tiling-4)
[639.962066] Starting subtest: tiling-4
[639.964207] Starting dynamic subtest: pipe-A-eDP-1
[643.692948] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.729s)
[643.703728] Starting dynamic subtest: pipe-B-eDP-1
[648.036695] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.344s)
[648.047454] Starting dynamic subtest: pipe-C-eDP-1
[652.367958] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.330s)
[652.378184] Starting dynamic subtest: pipe-D-eDP-1
[656.709199] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.340s)
[656.711520] Subtest tiling-4: SUCCESS (16.748s)
[657.532538] [132/133] (376s left) vgem_slow (nohang)
[657.584311] Starting subtest: nohang
[667.764343] Subtest nohang: SUCCESS (10.179s)
[667.842773] [133/133] (366s left) gem_eio (wait-1us)
[668.097885] Starting subtest: wait-1us
[668.475855] Subtest wait-1us: SUCCESS (0.380s)
[668.659738] Closing watchdogs
results: parsing output: 0/ for test: gem_tiled_blits
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: kms_pipe_crc_basic
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: syncobj_eventfd
results: parsing output: 7/ for test: kms_atomic
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_prime
results: parsing output: 14/ for test: gen7_exec_parse
results: parsing output: 15/ for test: gem_create
results: parsing output: 16/ for test: kms_lease
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: vgem_basic
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_chamelium_edid
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: i915_query
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: gem_lmem_swapping
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_query
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_getfb
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: syncobj_basic
results: parsing output: 44/ for test: kms_properties
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: device_reset
results: parsing output: 50/ for test: gem_softpin
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: gem_ppgtt
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: kms_rotation_crc
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_store
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: core_auth
results: parsing output: 68/ for test: kms_selftest
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_tiled_fence_blits
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_cursor_edge_walk
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_busy
results: parsing output: 95/ for test: gem_exec_nop
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: i915_pm_rpm
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_capture
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_tiled_fence_blits
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_invalid_mode
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: gem_exec_parallel
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_feature_discovery
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: kms_plane_multiple
results: parsing output: 131/ for test: vgem_slow
results: parsing output: 132/ for test: gem_eio
Done.