[62.817667] Initializing watchdogs
[62.817757]   /dev/watchdog0
[62.832560] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[62.837035] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.839268] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.842772] [001/133] (960s left) vgem_basic (second-client)
[62.927887] Starting subtest: second-client
[62.947626] Subtest second-client: SUCCESS (0.021s)
[63.000242] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[63.003471] [002/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[63.108144] Starting subtest: cursorA-vs-flipB-atomic-transitions
[63.112936] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[63.247823] [003/133] (960s left) syncobj_timeline (multi-wait-available-submitted)
[63.302340] Starting subtest: multi-wait-available-submitted
[63.304750] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[63.395812] [004/133] (960s left) kms_invalid_mode (bad-vsync-end)
[63.474613] Starting subtest: bad-vsync-end
[63.477050] Starting dynamic subtest: pipe-A-eDP-1
[63.763405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[63.771045] Starting dynamic subtest: pipe-B-eDP-1
[63.773199] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[63.779702] Starting dynamic subtest: pipe-C-eDP-1
[63.781662] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[63.788525] Starting dynamic subtest: pipe-D-eDP-1
[63.790809] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[63.793058] Subtest bad-vsync-end: SUCCESS (0.294s)
[64.632464] [005/133] (958s left) kms_pm_backlight (fade-with-dpms)
[64.707910] Starting subtest: fade-with-dpms
[66.912080] Starting dynamic subtest: eDP-1
[69.393933] Dynamic subtest eDP-1: SUCCESS (2.481s)
[69.396349] Subtest fade-with-dpms: SUCCESS (4.682s)
[70.215372] [006/133] (953s left) kms_flip (bo-too-big-interruptible)
[70.290467] Starting subtest: bo-too-big-interruptible
[70.292835] Starting dynamic subtest: A-eDP1
[71.550468] Dynamic subtest A-eDP1: SUCCESS (1.258s)
[71.560895] Starting dynamic subtest: B-eDP1
[72.783727] Dynamic subtest B-eDP1: SUCCESS (1.232s)
[72.791092] Starting dynamic subtest: C-eDP1
[74.020723] Dynamic subtest C-eDP1: SUCCESS (1.235s)
[74.033100] Starting dynamic subtest: D-eDP1
[75.261044] Dynamic subtest D-eDP1: SUCCESS (1.238s)
[75.266295] Subtest bo-too-big-interruptible: SUCCESS (4.973s)
[76.485910] [007/133] (947s left) gem_mmap_gtt (basic-read)
[76.538589] Subtest basic-read: SKIP (0.000s)
[76.596481] [008/133] (947s left) gem_softpin (allocator-evict)
[76.657572] Starting subtest: allocator-evict
[76.660275] Starting dynamic subtest: rcs0
[100.005515] Dynamic subtest rcs0: SUCCESS (23.338s)
[100.016652] Starting dynamic subtest: bcs0
[124.058892] Dynamic subtest bcs0: SUCCESS (24.050s)
[124.067349] Starting dynamic subtest: vcs0
[147.600421] Dynamic subtest vcs0: SUCCESS (23.539s)
[147.610389] Starting dynamic subtest: vcs1
[171.167986] Dynamic subtest vcs1: SUCCESS (23.566s)
[171.177712] Starting dynamic subtest: vecs0
[195.077151] Dynamic subtest vecs0: SUCCESS (23.905s)
[195.087122] Starting dynamic subtest: ccs0
[219.126211] Dynamic subtest ccs0: SUCCESS (24.047s)
[219.128667] Subtest allocator-evict: SUCCESS (142.451s)
[219.207839] [009/133] (804s left) gem_render_linear_blits (basic)
[219.300906] Starting subtest: basic
[219.337948] Subtest basic: SUCCESS (0.037s)
[219.420205] [010/133] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[219.506538] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[219.510759] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[219.605654] [011/133] (804s left) kms_psr (psr-primary-mmap-cpu)
[219.684089] Starting subtest: psr-primary-mmap-cpu
[219.686371] Starting dynamic subtest: eDP-1
[221.381585] Dynamic subtest eDP-1: SUCCESS (1.697s)
[221.384050] Subtest psr-primary-mmap-cpu: SUCCESS (1.698s)
[222.246949] [012/133] (801s left) kms_chamelium_edid (hdmi-mode-timings)
[222.630365] Subtest hdmi-mode-timings: SKIP (0.000s)
[223.447223] [013/133] (800s left) gen7_exec_parse (load-register-reg)
[223.506285] Subtest load-register-reg: SKIP (0.000s)
[223.587216] [014/133] (800s left) syncobj_eventfd (invalid-bad-flags)
[223.643215] Starting subtest: invalid-bad-flags
[223.645490] Subtest invalid-bad-flags: SUCCESS (0.000s)
[223.739439] [015/133] (800s left) gem_ctx_exec (basic-invalid-context)
[223.801849] Starting subtest: basic-invalid-context
[223.806438] Subtest basic-invalid-context: SUCCESS (0.006s)
[223.959865] [016/133] (799s left) gem_exec_reloc (basic-write-read-active)
[224.019193] Subtest basic-write-read-active: SKIP (0.000s)
[224.098495] [017/133] (799s left) kms_vblank (wait-busy-hang)
[224.179173] Starting subtest: wait-busy-hang
[224.181442] Starting dynamic subtest: pipe-A-eDP-1
[250.609813] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.429s)
[250.624263] Starting dynamic subtest: pipe-D-eDP-1
[265.635664] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.019s)
[265.637857] Subtest wait-busy-hang: SUCCESS (41.455s)
[266.424644] [018/133] (757s left) kms_chamelium_color (ctm-0-50)
[266.519336] Subtest ctm-0-50: SKIP (0.000s)
[266.564222] [019/133] (757s left) gem_exec_flush (basic-uc-prw-default)
[266.617341] Starting subtest: basic-uc-prw-default
[272.089025] Subtest basic-uc-prw-default: SUCCESS (5.473s)
[272.275883] [020/133] (751s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[272.367098] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[278.915678] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.551s)
[279.029844] [021/133] (745s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[279.106660] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[279.110940] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[279.191977] [022/133] (744s left) kms_plane_scaling (planes-upscale-factor-0-25)
[279.267992] Starting subtest: planes-upscale-factor-0-25
[279.270355] Starting dynamic subtest: pipe-A
[279.329369] Dynamic subtest pipe-A: SUCCESS (0.063s)
[279.340428] Starting dynamic subtest: pipe-B
[280.459064] Dynamic subtest pipe-B: SUCCESS (1.129s)
[280.469941] Starting dynamic subtest: pipe-C
[281.564167] Dynamic subtest pipe-C: SUCCESS (1.104s)
[281.574154] Starting dynamic subtest: pipe-D
[282.690249] Dynamic subtest pipe-D: SUCCESS (1.126s)
[282.692530] Subtest planes-upscale-factor-0-25: SUCCESS (3.425s)
[283.846744] [023/133] (740s left) i915_selftest (perf)
[285.596609] Starting subtest: perf
[285.599826] Starting dynamic subtest: engine_cs
[289.936884] Dynamic subtest engine_cs: SUCCESS (4.339s)
[289.948635] Starting dynamic subtest: request
[295.309199] Dynamic subtest request: SUCCESS (5.371s)
[295.318771] Starting dynamic subtest: migrate
[298.095417] Dynamic subtest migrate: SUCCESS (2.785s)
[298.105062] Starting dynamic subtest: region
[303.688068] Dynamic subtest region: SUCCESS (5.591s)
[303.690743] Subtest perf: SUCCESS (18.091s)
[303.717499] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[303.718257] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[303.721434] [024/133] (720s left) kms_color (legacy-gamma)
[305.186024] Starting subtest: legacy-gamma
[305.188427] Starting dynamic subtest: pipe-A-eDP-1
[305.902631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[305.911652] Starting dynamic subtest: pipe-B-eDP-1
[307.336172] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[307.345204] Starting dynamic subtest: pipe-C-eDP-1
[308.725041] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[308.741684] Starting dynamic subtest: pipe-D-eDP-1
[310.072704] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[310.075078] Subtest legacy-gamma: SUCCESS (4.887s)
[310.899662] [FACT kms_color (legacy-gamma)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[310.901261] [FACT kms_color (legacy-gamma)] new: kernel.kmod_is_loaded.i915: true
[310.904878] [025/133] (713s left) perf (gen12-mi-rpc)
[311.056553] Starting subtest: gen12-mi-rpc
[311.058387] Starting dynamic subtest: rcs0
[311.073927] Dynamic subtest rcs0: SUCCESS (0.018s)
[311.075733] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[311.132695] [026/133] (713s left) syncobj_timeline (invalid-wait-bad-flags)
[311.220922] Starting subtest: invalid-wait-bad-flags
[311.223404] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[311.306700] [027/133] (713s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[311.416668] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[311.422755] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[311.559281] [028/133] (712s left) gem_eio (kms)
[311.736814] Starting subtest: kms
[327.242234] Subtest kms: SUCCESS (15.504s)
[328.437842] [029/133] (696s left) gem_exec_fence (long-history)
[328.846590] Starting subtest: long-history
[335.597649] Subtest long-history: SUCCESS (6.751s)
[336.428024] [030/133] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[336.521105] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[336.525248] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[336.614332] [031/133] (687s left) gem_render_copy (y-tiled)
[336.685767] Starting subtest: y-tiled
[336.690279] Subtest y-tiled: SKIP (0.000s)
[336.863792] [032/133] (687s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[336.937031] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[336.939455] Starting dynamic subtest: pipe-A-default-mode
[338.089416] Dynamic subtest pipe-A-default-mode: SKIP (1.149s)
[338.093662] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.150s)
[338.227696] [033/133] (686s left) sw_sync (sync_multi_consumer)
[338.272459] Starting subtest: sync_multi_consumer
[338.706207] Subtest sync_multi_consumer: SUCCESS (0.436s)
[338.767350] [034/133] (685s left) gem_exec_schedule (noreorder-priority)
[338.953253] Starting subtest: noreorder-priority
[338.955741] Starting dynamic subtest: rcs0
[340.079918] Dynamic subtest rcs0: SUCCESS (1.126s)
[340.092569] Starting dynamic subtest: vcs0
[341.847280] Dynamic subtest vcs0: SUCCESS (1.765s)
[341.864320] Starting dynamic subtest: vcs1
[343.830898] Dynamic subtest vcs1: SUCCESS (1.982s)
[343.842093] Starting dynamic subtest: vecs0
[345.820231] Dynamic subtest vecs0: SUCCESS (1.987s)
[345.840510] Starting dynamic subtest: ccs0
[346.967573] Dynamic subtest ccs0: SUCCESS (1.147s)
[346.969925] Subtest noreorder-priority: SUCCESS (8.015s)
[347.157125] [035/133] (677s left) gem_tiled_fence_blits (basic)
[347.220283] Subtest basic: SKIP (0.000s)
[347.296500] [036/133] (677s left) i915_pm_rpm (gem-execbuf-stress)
[349.000270] Starting subtest: gem-execbuf-stress
[349.003110] Starting dynamic subtest: smem0
[361.613767] Dynamic subtest smem0: SUCCESS (12.613s)
[361.625406] Starting dynamic subtest: extra-wait-smem0
[423.442441] Dynamic subtest extra-wait-smem0: SUCCESS (61.822s)
[423.444982] Subtest gem-execbuf-stress: SUCCESS (74.439s)
[423.803413] [037/133] (600s left) kms_addfb_basic (basic-y-tiled-legacy)
[423.868964] Starting subtest: basic-y-tiled-legacy
[423.873612] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[423.994512] [038/133] (600s left) kms_concurrent (multi-plane-atomic-lowres)
[424.066899] Starting subtest: multi-plane-atomic-lowres
[424.069209] Starting dynamic subtest: pipe-A-eDP-1
[424.584256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.515s)
[424.594255] Starting dynamic subtest: pipe-B-eDP-1
[425.838654] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.254s)
[425.848162] Starting dynamic subtest: pipe-C-eDP-1
[427.081328] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s)
[427.091059] Starting dynamic subtest: pipe-D-eDP-1
[428.296527] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[428.298949] Subtest multi-plane-atomic-lowres: SUCCESS (4.229s)
[429.130143] [039/133] (595s left) gem_exec_balancer (bonded-true-hang)
[429.392475] Starting subtest: bonded-true-hang
[429.397747] Subtest bonded-true-hang: SKIP (0.000s)
[429.500653] [040/133] (595s left) prime_self_import (basic-with_two_bos)
[429.540712] Starting subtest: basic-with_two_bos
[429.551698] Subtest basic-with_two_bos: SUCCESS (0.015s)
[429.653909] [041/133] (595s left) gem_partial_pwrite_pread (reads)
[429.709415] Subtest reads: SKIP (0.000s)
[429.780296] [042/133] (595s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[429.831927] Starting subtest: invalid-multi-wait-unsubmitted
[429.833778] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[429.919673] [043/133] (595s left) sysfs_timeslice_duration (idempotent)
[429.979158] Starting subtest: idempotent
[429.981555] Starting dynamic subtest: vecs0
[429.983794] Dynamic subtest vecs0: SUCCESS (0.000s)
[429.995459] Starting dynamic subtest: ccs0
[429.997761] Dynamic subtest ccs0: SUCCESS (0.000s)
[430.006508] Starting dynamic subtest: vcs0
[430.008726] Dynamic subtest vcs0: SUCCESS (0.000s)
[430.017636] Starting dynamic subtest: bcs0
[430.019478] Dynamic subtest bcs0: SUCCESS (0.000s)
[430.027604] Starting dynamic subtest: rcs0
[430.029461] Dynamic subtest rcs0: SUCCESS (0.000s)
[430.037519] Starting dynamic subtest: vcs1
[430.039349] Dynamic subtest vcs1: SUCCESS (0.000s)
[430.041171] Subtest idempotent: SUCCESS (0.005s)
[430.092538] [044/133] (595s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[430.171299] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[430.175587] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[430.268361] [045/133] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[430.346562] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[437.384239] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.039s)
[437.509401] [046/133] (587s left) kms_vblank (query-busy)
[437.587506] Starting subtest: query-busy
[437.589838] Starting dynamic subtest: pipe-A-eDP-1
[439.466249] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[439.483912] Starting dynamic subtest: pipe-D-eDP-1
[442.012018] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[442.014321] Subtest query-busy: SUCCESS (4.427s)
[442.812508] [047/133] (582s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[442.877675] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[442.880167] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[442.982253] [048/133] (582s left) gem_render_copy (y-tiled-to-vebox-linear)
[443.032994] Starting subtest: y-tiled-to-vebox-linear
[443.037649] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[443.244712] [049/133] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[443.322226] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[443.326527] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[443.418060] [050/133] (581s left) perf_pmu (interrupts)
[443.463521] Starting subtest: interrupts
[444.540339] Subtest interrupts: SUCCESS (1.077s)
[444.665517] [051/133] (580s left) gem_mmap (basic)
[444.727777] Subtest basic: SKIP (0.000s)
[444.792790] [052/133] (580s left) syncobj_timeline (single-wait-all-available-submitted)
[444.841872] Starting subtest: single-wait-all-available-submitted
[444.844059] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[444.935150] [053/133] (580s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[447.044030] Starting subtest: modeset-lpsp-stress-no-wait
[456.669043] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.623s)
[456.745428] [054/133] (568s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[456.815055] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[456.889917] [055/133] (568s left) gem_exec_fence (syncobj-unused-fence)
[457.309871] Starting subtest: syncobj-unused-fence
[457.315075] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[458.910962] [056/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[458.984056] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[458.988315] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[459.080788] [057/133] (566s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[459.164414] Starting subtest: yf-tiled-16bpp-rotate-270
[459.168524] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[459.264338] [058/133] (566s left) gem_exec_fence (basic-wait)
[459.449842] Starting subtest: basic-wait
[459.452096] Starting dynamic subtest: rcs0
[459.524305] Dynamic subtest rcs0: SUCCESS (0.074s)
[459.535602] Starting dynamic subtest: bcs0
[459.578513] Dynamic subtest bcs0: SUCCESS (0.052s)
[459.589712] Starting dynamic subtest: vcs0
[459.631825] Dynamic subtest vcs0: SUCCESS (0.051s)
[459.643778] Starting dynamic subtest: vcs1
[459.687031] Dynamic subtest vcs1: SUCCESS (0.053s)
[459.698078] Starting dynamic subtest: vecs0
[459.741646] Dynamic subtest vecs0: SUCCESS (0.053s)
[459.752717] Starting dynamic subtest: ccs0
[459.794037] Dynamic subtest ccs0: SUCCESS (0.050s)
[459.796813] Subtest basic-wait: SUCCESS (0.345s)
[461.942163] [059/133] (563s left) prime_mmap_coherency (ioctl-errors)
[462.019407] Starting subtest: ioctl-errors
[481.041681] Subtest ioctl-errors: SUCCESS (19.021s)
[481.186049] [060/133] (544s left) kms_busy (basic)
[481.309512] Starting subtest: basic
[481.311454] Starting dynamic subtest: flip
[481.945819] Dynamic subtest flip: SUCCESS (0.634s)
[481.956948] Starting dynamic subtest: modeset
[485.600828] Dynamic subtest modeset: SUCCESS (3.655s)
[485.603261] Subtest basic: SUCCESS (4.292s)
[486.404992] [061/133] (539s left) gem_exec_store (cachelines)
[486.468806] Starting subtest: cachelines
[486.471117] Starting dynamic subtest: rcs0
[486.543534] Dynamic subtest rcs0: SUCCESS (0.074s)
[486.556343] Starting dynamic subtest: bcs0
[486.605530] Dynamic subtest bcs0: SUCCESS (0.060s)
[486.617074] Starting dynamic subtest: vcs0
[486.665895] Dynamic subtest vcs0: SUCCESS (0.059s)
[486.677224] Starting dynamic subtest: vcs1
[486.720339] Dynamic subtest vcs1: SUCCESS (0.052s)
[486.731176] Starting dynamic subtest: vecs0
[486.773696] Dynamic subtest vecs0: SUCCESS (0.051s)
[486.785573] Starting dynamic subtest: ccs0
[486.830056] Dynamic subtest ccs0: SUCCESS (0.054s)
[486.832937] Subtest cachelines: SUCCESS (0.362s)
[487.027888] [062/133] (538s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[487.107726] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[488.076584] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.969s)
[488.196655] [063/133] (537s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[488.283563] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[488.285771] Starting dynamic subtest: pipe-A-eDP-1
[488.307895] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[488.319041] Starting dynamic subtest: pipe-B-eDP-1
[488.340588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[488.350213] Starting dynamic subtest: pipe-C-eDP-1
[488.371847] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[488.380831] Starting dynamic subtest: pipe-D-eDP-1
[488.399174] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[488.402492] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[490.551950] [064/133] (535s left) prime_busy (hang-wait)
[490.608368] Starting subtest: hang-wait
[490.610803] Starting dynamic subtest: rcs0
[516.354647] Dynamic subtest rcs0: SUCCESS (25.742s)
[516.364261] Starting dynamic subtest: bcs0
[523.504828] Dynamic subtest bcs0: SUCCESS (7.145s)
[523.516161] Starting dynamic subtest: vcs0
[530.483490] Dynamic subtest vcs0: SUCCESS (6.977s)
[530.494619] Starting dynamic subtest: vcs1
[537.513066] Dynamic subtest vcs1: SUCCESS (7.029s)
[537.524169] Starting dynamic subtest: vecs0
[544.444366] Dynamic subtest vecs0: SUCCESS (6.929s)
[544.455980] Starting dynamic subtest: ccs0
[558.324958] Dynamic subtest ccs0: SUCCESS (13.878s)
[558.327724] Subtest hang-wait: SUCCESS (67.713s)
[558.486266] [065/133] (467s left) kms_flip (flip-vs-panning-vs-hang)
[558.573819] Starting subtest: flip-vs-panning-vs-hang
[558.576221] Starting dynamic subtest: A-eDP1
[609.345875] Dynamic subtest A-eDP1: SUCCESS (50.772s)
[609.358870] Starting dynamic subtest: D-eDP1
[649.382438] Dynamic subtest D-eDP1: SUCCESS (40.034s)
[649.384614] Subtest flip-vs-panning-vs-hang: SUCCESS (90.813s)
[650.560992] [066/133] (375s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[650.645193] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[650.647587] Starting dynamic subtest: pipe-A-eDP-1
[650.959202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[650.971729] Starting dynamic subtest: pipe-B-eDP-1
[652.212975] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.250s)
[652.223207] Starting dynamic subtest: pipe-C-eDP-1
[653.416066] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[653.427845] Starting dynamic subtest: pipe-D-eDP-1
[654.649849] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[654.652486] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.977s)
[655.780069] [067/133] (370s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[655.846831] Subtest tiled-to-tiled: SKIP (0.000s)
[655.921360] [068/133] (370s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[655.998667] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[656.003068] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[656.091058] [069/133] (370s left) gem_ctx_isolation (clean)
[656.147276] Starting subtest: clean
[656.149608] Starting dynamic subtest: rcs0
[656.195460] Dynamic subtest rcs0: SUCCESS (0.048s)
[656.207663] Starting dynamic subtest: bcs0
[656.267135] Dynamic subtest bcs0: SUCCESS (0.071s)
[656.278742] Starting dynamic subtest: vcs0
[656.325857] Dynamic subtest vcs0: SUCCESS (0.058s)
[656.337719] Starting dynamic subtest: vcs1
[657.813808] Dynamic subtest vcs1: SUCCESS (1.487s)
[657.826760] Starting dynamic subtest: vecs0
[659.865757] Dynamic subtest vecs0: SUCCESS (2.051s)
[659.877950] Starting dynamic subtest: ccs0
[661.876408] Dynamic subtest ccs0: SUCCESS (2.010s)
[661.878938] Subtest clean: SUCCESS (5.729s)
[662.067345] [070/133] (364s left) perf_pmu (init-sema)
[662.114910] Starting subtest: init-sema
[662.117126] Starting dynamic subtest: rcs0
[662.119396] Dynamic subtest rcs0: SUCCESS (0.001s)
[662.131731] Starting dynamic subtest: bcs0
[662.133629] Dynamic subtest bcs0: SUCCESS (0.000s)
[662.143295] Starting dynamic subtest: vcs0
[662.145634] Dynamic subtest vcs0: SUCCESS (0.001s)
[662.155458] Starting dynamic subtest: vcs1
[662.157702] Dynamic subtest vcs1: SUCCESS (0.001s)
[662.167225] Starting dynamic subtest: vecs0
[662.169549] Dynamic subtest vecs0: SUCCESS (0.000s)
[662.179720] Starting dynamic subtest: ccs0
[662.182067] Dynamic subtest ccs0: SUCCESS (0.000s)
[662.184363] Subtest init-sema: SUCCESS (0.007s)
[662.244406] [071/133] (364s left) kms_force_connector_basic (prune-stale-modes)
[662.305813] Subtest prune-stale-modes: SKIP (0.000s)
[662.363720] [072/133] (363s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[662.428297] Subtest no-spare-fences-busy: SKIP (0.000s)
[662.507475] [073/133] (363s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[662.595300] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[662.599901] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[663.699416] [074/133] (362s left) i915_pm_freq_api (freq-suspend)
[663.772565] Starting subtest: freq-suspend
[663.775030] Starting dynamic subtest: gt0
[680.074294] Dynamic subtest gt0: SUCCESS (1.368s)
[680.085601] Starting dynamic subtest: gt1
[696.107387] Dynamic subtest gt1: SUCCESS (1.254s)
[696.109773] Subtest freq-suspend: SUCCESS (2.625s)
[696.187399] [075/133] (330s left) kms_cursor_edge_walk (256x256-top-bottom)
[696.272139] Starting subtest: 256x256-top-bottom
[696.274466] Starting dynamic subtest: pipe-A-eDP-1
[699.769636] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s)
[699.781424] Starting dynamic subtest: pipe-D-eDP-1
[702.914031] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[702.916349] Subtest 256x256-top-bottom: SUCCESS (6.557s)
[703.724802] [076/133] (322s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[703.815221] Starting subtest: psr-rgb565-draw-pwrite
[710.864046] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.015s)
[710.994358] [077/133] (315s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[711.149525] Starting subtest: cursor-rapid-movement-64x64
[711.151615] Starting dynamic subtest: pipe-A-eDP-1
[711.706292] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[711.737088] Starting dynamic subtest: pipe-D-eDP-1
[712.889891] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.158s)
[712.892007] Subtest cursor-rapid-movement-64x64: SUCCESS (1.734s)
[713.765503] [078/133] (312s left) gem_ctx_persistence (legacy-engines-queued)
[713.822759] Starting subtest: legacy-engines-queued
[713.824679] Starting dynamic subtest: render
[713.888652] Dynamic subtest render: SUCCESS (0.067s)
[713.901754] Starting dynamic subtest: bsd1
[715.514836] Dynamic subtest bsd1: SUCCESS (1.619s)
[715.528866] Starting dynamic subtest: bsd2
[717.497427] Dynamic subtest bsd2: SUCCESS (1.975s)
[717.511357] Starting dynamic subtest: blt
[717.531369] Dynamic subtest blt: SUCCESS (0.034s)
[717.541648] Starting dynamic subtest: vebox
[719.545270] Dynamic subtest vebox: SUCCESS (2.008s)
[719.548332] Subtest legacy-engines-queued: SUCCESS (5.714s)
[719.639377] [079/133] (306s left) kms_flip (2x-flip-vs-fences-interruptible)
[719.725163] Starting subtest: 2x-flip-vs-fences-interruptible
[719.729683] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[719.830015] [080/133] (306s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[719.925729] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[719.928032] Starting dynamic subtest: pipe-A-eDP-1
[720.022765] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[720.036422] Starting dynamic subtest: pipe-B-eDP-1
[721.150033] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[721.154668] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.227s)
[722.457576] [081/133] (304s left) syncobj_timeline (etime-multi-wait-submitted)
[722.524817] Starting subtest: etime-multi-wait-submitted
[722.631804] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[722.708913] [082/133] (304s left) gem_render_copy (linear-to-vebox-yf-tiled)
[722.758175] Starting subtest: linear-to-vebox-yf-tiled
[722.762992] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[722.946621] [083/133] (303s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[723.026316] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[723.028163] Starting dynamic subtest: pipe-A-eDP-1
[723.048404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[723.061811] Starting dynamic subtest: pipe-B-eDP-1
[723.082418] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[723.093843] Starting dynamic subtest: pipe-C-eDP-1
[723.114288] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[723.125521] Starting dynamic subtest: pipe-D-eDP-1
[723.146230] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[723.148627] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s)
[725.335777] [084/133] (301s left) kms_psr (psr-cursor-render)
[725.417032] Starting subtest: psr-cursor-render
[725.419662] Starting dynamic subtest: eDP-1
[727.126814] Dynamic subtest eDP-1: SUCCESS (1.710s)
[727.129164] Subtest psr-cursor-render: SUCCESS (1.711s)
[727.980415] [085/133] (298s left) kms_atomic (atomic-invalid-params)
[728.046767] Starting subtest: atomic-invalid-params
[728.049012] Starting dynamic subtest: pipe-A-eDP-1
[728.439462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.391s)
[728.441702] Subtest atomic-invalid-params: SUCCESS (0.393s)
[729.315260] [086/133] (297s left) gem_exec_schedule (semaphore-power)
[729.504240] Subtest semaphore-power: SKIP (0.000s)
[729.685865] [087/133] (297s left) api_intel_allocator (default-alignment)
[729.735304] Starting subtest: default-alignment
[729.737613] Subtest default-alignment: SUCCESS (0.004s)
[729.846268] [088/133] (297s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[729.923323] Starting subtest: yf-tiled-32bpp-rotate-90
[729.927534] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[730.015482] [089/133] (297s left) gem_mmap_wc (copy)
[730.076331] Subtest copy: SKIP (0.000s)
[730.132321] [090/133] (296s left) gem_exec_whisper (basic-queues-forked-all)
[730.194118] Starting subtest: basic-queues-forked-all
[750.148897] Subtest basic-queues-forked-all: SUCCESS (19.947s)
[750.351988] [091/133] (276s left) kms_plane_scaling (intel-max-src-size)
[750.426096] Starting subtest: intel-max-src-size
[750.432739] Subtest intel-max-src-size: SKIP (0.000s)
[750.521241] [092/133] (276s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[750.597362] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[757.703059] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.106s)
[757.875484] [093/133] (269s left) kms_psr (fbc-psr2-sprite-render)
[757.946878] Starting subtest: fbc-psr2-sprite-render
[757.949224] Starting dynamic subtest: eDP-1
[757.953524] Dynamic subtest eDP-1: SKIP (0.000s)
[757.957913] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[758.023169] [094/133] (269s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[758.106119] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[758.110190] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[758.204171] [095/133] (269s left) gem_pread (self)
[758.260179] Subtest self: SKIP (0.000s)
[758.320913] [096/133] (269s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[758.408265] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[758.412378] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[758.512745] [097/133] (268s left) kms_prop_blob (invalid-set-prop)
[758.578108] Starting subtest: invalid-set-prop
[758.580438] Subtest invalid-set-prop: SUCCESS (0.000s)
[758.692051] [098/133] (268s left) fbdev (unaligned-write)
[758.739826] Starting subtest: unaligned-write
[758.845737] Subtest unaligned-write: SUCCESS (0.104s)
[758.899858] [099/133] (268s left) kms_plane (pixel-format-x-tiled-modifier)
[758.981423] Starting subtest: pixel-format-x-tiled-modifier
[759.007663] Starting dynamic subtest: pipe-A-plane-0
[759.663114] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[759.675700] Starting dynamic subtest: pipe-A-plane-3
[760.085506] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[760.096143] Starting dynamic subtest: pipe-A-plane-5
[760.099852] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[761.213013] Starting dynamic subtest: pipe-B-plane-0
[761.847826] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[761.858485] Starting dynamic subtest: pipe-B-plane-3
[762.303168] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[762.316018] Starting dynamic subtest: pipe-B-plane-5
[762.319808] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[762.621383] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.639s)
[763.490829] [100/133] (264s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[763.552024] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[763.624936] [101/133] (263s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[763.695702] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[767.451934] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.758s)
[768.603843] [102/133] (259s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[768.687772] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[768.697039] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.008s)
[768.800725] [103/133] (258s left) core_getversion (all-cards)
[768.832703] Starting subtest: all-cards
[768.844040] Subtest all-cards: SUCCESS (0.014s)
[768.883985] [104/133] (258s left) gem_exec_reloc (basic-wc-read-noreloc)
[768.939339] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[769.026752] [105/133] (258s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[769.107442] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[769.112207] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[769.193414] [106/133] (258s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[769.287222] Starting subtest: x-tiled-16bpp-rotate-90
[769.307680] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[769.410124] [107/133] (258s left) kms_feature_discovery (display-1x)
[769.498137] Starting subtest: display-1x
[769.500454] Subtest display-1x: SUCCESS (0.000s)
[769.575091] [108/133] (258s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[769.663106] Starting subtest: cursorA-vs-flipB-varying-size
[769.666749] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[769.808313] [109/133] (258s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[769.877942] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[769.881395] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[769.957284] [110/133] (257s left) kms_psr2_su (page_flip-xrgb8888)
[770.014659] Subtest page_flip-XRGB8888: SKIP (0.000s)
[770.079234] [111/133] (257s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[770.160022] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[770.163508] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[770.265574] [112/133] (257s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[770.348723] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[774.786624] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.440s)
[775.931178] [113/133] (252s left) i915_drm_fdinfo (isolation)
[775.975185] Starting subtest: isolation
[775.977147] Starting dynamic subtest: rcs0
[775.996659] Dynamic subtest rcs0: SKIP (0.021s)
[776.010488] Starting dynamic subtest: bcs0
[776.014565] Dynamic subtest bcs0: SKIP (0.000s)
[776.025097] Starting dynamic subtest: vcs0
[776.029027] Dynamic subtest vcs0: SKIP (0.000s)
[776.039066] Starting dynamic subtest: vcs1
[776.042994] Dynamic subtest vcs1: SKIP (0.000s)
[776.053250] Starting dynamic subtest: vecs0
[776.057255] Dynamic subtest vecs0: SKIP (0.000s)
[776.066900] Starting dynamic subtest: ccs0
[776.070749] Dynamic subtest ccs0: SKIP (0.000s)
[776.074607] Subtest isolation: SKIP (0.026s)
[776.114297] [114/133] (251s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[776.197020] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[776.201327] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[776.291386] [115/133] (251s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[776.380982] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[780.839984] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.460s)
[782.011254] [116/133] (246s left) kms_big_fb (4-tiled-addfb)
[782.100945] Starting subtest: 4-tiled-addfb
[782.103509] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[782.213392] [117/133] (246s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[782.287870] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[782.292062] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[782.376407] [118/133] (245s left) kms_cursor_crc (cursor-offscreen-512x512)
[782.649912] Starting subtest: cursor-offscreen-512x512
[782.653796] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[782.813030] [119/133] (245s left) gem_mmap (bad-size)
[782.873515] Subtest bad-size: SKIP (0.000s)
[782.943228] [120/133] (245s left) gem_mmap_offset (blt-coherency)
[782.996188] Starting subtest: blt-coherency
[783.002720] Subtest blt-coherency: SUCCESS (0.009s)
[783.114638] [121/133] (245s left) api_intel_bb (simple-bb-ctx)
[783.169167] Starting subtest: simple-bb-ctx
[783.175990] Subtest simple-bb-ctx: SUCCESS (0.009s)
[783.312872] [122/133] (245s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[783.387030] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[783.390444] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[783.480870] [123/133] (245s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[783.577552] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[783.581106] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[783.651478] [124/133] (244s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[783.716445] Starting subtest: fbc-pr-sprite-mmap-gtt
[783.720107] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[783.801819] [125/133] (244s left) kms_psr (pr-primary-mmap-gtt)
[783.869119] Starting subtest: pr-primary-mmap-gtt
[783.872665] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[783.947934] [126/133] (244s left) kms_pipe_crc_basic (suspend-read-crc)
[784.024350] Starting subtest: suspend-read-crc
[784.026351] Starting dynamic subtest: pipe-A-eDP-1
[802.031132] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.588s)
[802.042797] Starting dynamic subtest: pipe-B-eDP-1
[820.020091] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.235s)
[820.031621] Starting dynamic subtest: pipe-C-eDP-1
[837.965510] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.022s)
[837.977379] Starting dynamic subtest: pipe-D-eDP-1
[855.971119] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.100s)
[855.973108] Subtest suspend-read-crc: SUCCESS (11.951s)
[856.822357] [127/133] (171s left) kms_chamelium_hpd (hdmi-hpd-storm)
[857.193310] Subtest hdmi-hpd-storm: SKIP (0.000s)
[858.036696] [128/133] (170s left) gem_wait (write-busy)
[858.102818] Starting subtest: write-busy
[858.104968] Starting dynamic subtest: all-engines
[858.706499] Dynamic subtest all-engines: SUCCESS (0.603s)
[858.726169] Starting dynamic subtest: rcs0
[859.261342] Dynamic subtest rcs0: SUCCESS (0.551s)
[859.281116] Starting dynamic subtest: bcs0
[859.812188] Dynamic subtest bcs0: SUCCESS (0.548s)
[859.831049] Starting dynamic subtest: vcs0
[861.494864] Dynamic subtest vcs0: SUCCESS (1.674s)
[861.514128] Starting dynamic subtest: vcs1
[863.478903] Dynamic subtest vcs1: SUCCESS (1.975s)
[863.498237] Starting dynamic subtest: vecs0
[865.462399] Dynamic subtest vecs0: SUCCESS (1.976s)
[865.483187] Starting dynamic subtest: ccs0
[866.014908] Dynamic subtest ccs0: SUCCESS (0.550s)
[866.017322] Subtest write-busy: SUCCESS (7.888s)
[866.219857] [129/133] (162s left) gem_userptr_blits (relocations)
[866.299501] Starting subtest: relocations
[866.303990] Subtest relocations: SKIP (0.001s)
[866.428838] [130/133] (162s left) gem_eio (wait-immediate)
[866.628995] Starting subtest: wait-immediate
[866.981717] Subtest wait-immediate: SUCCESS (0.351s)
[867.112412] [131/133] (161s left) gem_userptr_blits (create-destroy-unsync)
[867.175718] Subtest create-destroy-unsync: SKIP (0.000s)
[867.308727] [132/133] (161s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[867.379704] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[874.653236] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.267s)
[874.767216] [133/133] (154s left) gem_exec_reloc (basic-wc)
[874.825825] Subtest basic-wc: SKIP (0.000s)
[874.891342] Closing watchdogs
results: parsing output: 0/ for test: vgem_basic
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_invalid_mode
results: parsing output: 4/ for test: kms_pm_backlight
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: gem_render_linear_blits
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_chamelium_edid
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: syncobj_eventfd
results: parsing output: 14/ for test: gem_ctx_exec
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: kms_chamelium_color
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: i915_selftest
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_tiled_fence_blits
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_concurrent
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: prime_self_import
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: sysfs_timeslice_duration
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_mmap
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: prime_mmap_coherency
results: parsing output: 59/ for test: kms_busy
results: parsing output: 60/ for test: gem_exec_store
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: prime_busy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_set_tiling_vs_blt
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: gem_ctx_isolation
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_force_connector_basic
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: i915_pm_freq_api
results: parsing output: 74/ for test: kms_cursor_edge_walk
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_pread
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_prop_blob
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: core_getversion
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_feature_discovery
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_psr2_su
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: gem_mmap
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_joiner
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: gem_wait
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_reloc
Done.