[59.219879] Initializing watchdogs
[59.219925]   /dev/watchdog0
[59.234953] [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]
[59.239485] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.241800] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.243630] [001/133] (960s left) vgem_basic (second-client)
[59.308432] Starting subtest: second-client
[59.330877] Subtest second-client: SUCCESS (0.022s)
[59.393695] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[59.395137] [002/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[59.522518] Starting subtest: cursorA-vs-flipB-atomic-transitions
[59.524250] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[59.673864] [003/133] (960s left) syncobj_timeline (multi-wait-available-submitted)
[59.728759] Starting subtest: multi-wait-available-submitted
[59.729772] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[59.844617] [004/133] (959s left) kms_invalid_mode (bad-vsync-end)
[59.935865] Starting subtest: bad-vsync-end
[59.936912] Starting dynamic subtest: pipe-A-eDP-1
[60.230061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[60.236165] Starting dynamic subtest: pipe-B-eDP-1
[60.236960] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[60.242200] Starting dynamic subtest: pipe-C-eDP-1
[60.243018] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[60.248342] Starting dynamic subtest: pipe-D-eDP-1
[60.249148] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[60.249943] Subtest bad-vsync-end: SUCCESS (0.300s)
[61.112124] [005/133] (958s left) kms_pm_backlight (fade-with-dpms)
[61.198515] Starting subtest: fade-with-dpms
[63.375022] Starting dynamic subtest: eDP-1
[65.868041] Dynamic subtest eDP-1: SUCCESS (2.495s)
[65.869758] Subtest fade-with-dpms: SUCCESS (4.675s)
[66.669125] [006/133] (953s left) kms_flip (bo-too-big-interruptible)
[66.805912] Starting subtest: bo-too-big-interruptible
[66.808112] Starting dynamic subtest: A-eDP1
[68.127679] Dynamic subtest A-eDP1: SUCCESS (1.319s)
[68.139638] Starting dynamic subtest: B-eDP1
[69.444641] Dynamic subtest B-eDP1: SUCCESS (1.318s)
[69.451364] Starting dynamic subtest: C-eDP1
[70.683359] Dynamic subtest C-eDP1: SUCCESS (1.240s)
[70.689407] Starting dynamic subtest: D-eDP1
[71.930262] Dynamic subtest D-eDP1: SUCCESS (1.246s)
[71.933327] Subtest bo-too-big-interruptible: SUCCESS (5.131s)
[73.142745] [007/133] (946s left) gem_mmap_gtt (basic-read)
[73.197287] Subtest basic-read: SKIP (0.000s)
[73.251536] [008/133] (946s left) gem_softpin (allocator-evict)
[73.320754] Starting subtest: allocator-evict
[73.321843] Starting dynamic subtest: rcs0
[96.881605] Dynamic subtest rcs0: SUCCESS (23.561s)
[96.888323] Starting dynamic subtest: bcs0
[120.819157] Dynamic subtest bcs0: SUCCESS (23.937s)
[120.826787] Starting dynamic subtest: vcs0
[144.723424] Dynamic subtest vcs0: SUCCESS (23.904s)
[144.730025] Starting dynamic subtest: vcs1
[168.630586] Dynamic subtest vcs1: SUCCESS (23.905s)
[168.639164] Starting dynamic subtest: vecs0
[192.339711] Dynamic subtest vecs0: SUCCESS (23.708s)
[192.348637] Starting dynamic subtest: ccs0
[216.283255] Dynamic subtest ccs0: SUCCESS (23.942s)
[216.284431] Subtest allocator-evict: SUCCESS (142.960s)
[216.360188] [009/133] (803s left) gem_render_linear_blits (basic)
[216.455878] Starting subtest: basic
[216.487532] Subtest basic: SUCCESS (0.032s)
[216.568443] [010/133] (803s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[216.673193] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[216.675079] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[216.788464] [011/133] (803s left) kms_psr (psr-primary-mmap-cpu)
[216.891231] Starting subtest: psr-primary-mmap-cpu
[216.892156] Starting dynamic subtest: eDP-1
[218.617070] Dynamic subtest eDP-1: SUCCESS (1.733s)
[218.617952] Subtest psr-primary-mmap-cpu: SUCCESS (1.734s)
[219.487984] [012/133] (800s left) kms_chamelium_edid (hdmi-mode-timings)
[219.858025] Subtest hdmi-mode-timings: SKIP (0.000s)
[220.691786] [013/133] (799s left) gen7_exec_parse (load-register-reg)
[220.742698] Subtest load-register-reg: SKIP (0.000s)
[220.799099] [014/133] (799s left) syncobj_eventfd (invalid-bad-flags)
[220.855251] Starting subtest: invalid-bad-flags
[220.856134] Subtest invalid-bad-flags: SUCCESS (0.000s)
[220.974043] [015/133] (799s left) gem_ctx_exec (basic-invalid-context)
[221.027145] Starting subtest: basic-invalid-context
[221.031964] Subtest basic-invalid-context: SUCCESS (0.005s)
[221.144788] [016/133] (799s left) gem_exec_reloc (basic-write-read-active)
[221.193496] Subtest basic-write-read-active: SKIP (0.000s)
[221.262988] [017/133] (799s left) kms_vblank (wait-busy-hang)
[221.348257] Starting subtest: wait-busy-hang
[221.349160] Starting dynamic subtest: pipe-A-eDP-1
[247.709885] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.361s)
[247.718356] Starting dynamic subtest: pipe-D-eDP-1
[272.672426] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.960s)
[272.673246] Subtest wait-busy-hang: SUCCESS (51.325s)
[273.460221] [018/133] (746s left) kms_chamelium_color (ctm-0-50)
[273.551704] Subtest ctm-0-50: SKIP (0.000s)
[273.590284] [019/133] (746s left) gem_exec_flush (basic-uc-prw-default)
[273.645494] Starting subtest: basic-uc-prw-default
[279.139802] Subtest basic-uc-prw-default: SUCCESS (5.494s)
[279.336565] [020/133] (741s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[279.425766] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[286.213445] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.776s)
[286.327975] [021/133] (734s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[286.411932] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[286.414036] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[286.477039] [022/133] (734s left) kms_plane_scaling (planes-upscale-factor-0-25)
[286.573541] Starting subtest: planes-upscale-factor-0-25
[286.574543] Starting dynamic subtest: pipe-A
[286.635057] Dynamic subtest pipe-A: SUCCESS (0.063s)
[286.644372] Starting dynamic subtest: pipe-B
[287.746042] Dynamic subtest pipe-B: SUCCESS (1.111s)
[287.754650] Starting dynamic subtest: pipe-C
[288.856063] Dynamic subtest pipe-C: SUCCESS (1.110s)
[288.864088] Starting dynamic subtest: pipe-D
[289.983195] Dynamic subtest pipe-D: SUCCESS (1.126s)
[289.984244] Subtest planes-upscale-factor-0-25: SUCCESS (3.411s)
[291.124054] [023/133] (729s left) i915_selftest (perf)
[292.889253] Starting subtest: perf
[292.890545] Starting dynamic subtest: engine_cs
[297.289860] Dynamic subtest engine_cs: SUCCESS (4.392s)
[297.298640] Starting dynamic subtest: request
[304.582747] Dynamic subtest request: SUCCESS (7.292s)
[304.591442] Starting dynamic subtest: migrate
[307.447240] Dynamic subtest migrate: SUCCESS (2.863s)
[307.455593] Starting dynamic subtest: region
[313.145308] Dynamic subtest region: SUCCESS (5.697s)
[313.146411] Subtest perf: SUCCESS (20.247s)
[313.167298] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[313.168113] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[313.169587] [024/133] (707s left) kms_color (legacy-gamma)
[314.734120] Starting subtest: legacy-gamma
[314.735149] Starting dynamic subtest: pipe-A-eDP-1
[315.488888] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.754s)
[315.495370] Starting dynamic subtest: pipe-B-eDP-1
[316.887144] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[316.893888] Starting dynamic subtest: pipe-C-eDP-1
[319.000387] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.103s)
[319.008218] Starting dynamic subtest: pipe-D-eDP-1
[319.876424] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.885s)
[319.877335] Subtest legacy-gamma: SUCCESS (5.143s)
[320.714201] [FACT kms_color (legacy-gamma)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[320.715856] [FACT kms_color (legacy-gamma)] new: kernel.kmod_is_loaded.i915: true
[320.718389] [025/133] (699s left) perf (gen12-mi-rpc)
[320.867388] Starting subtest: gen12-mi-rpc
[320.868203] Starting dynamic subtest: rcs0
[320.886471] Dynamic subtest rcs0: SUCCESS (0.019s)
[320.887344] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[320.931165] [026/133] (699s left) syncobj_timeline (invalid-wait-bad-flags)
[321.006044] Starting subtest: invalid-wait-bad-flags
[321.007453] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[321.095249] [027/133] (699s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[321.211411] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[321.213359] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[321.349937] [028/133] (699s left) gem_eio (kms)
[321.543204] Starting subtest: kms
[338.154711] Subtest kms: SUCCESS (16.602s)
[339.325597] [029/133] (681s left) gem_exec_fence (long-history)
[339.731621] Starting subtest: long-history
[346.595200] Subtest long-history: SUCCESS (6.855s)
[347.091843] [030/133] (673s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[347.195735] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[347.197863] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[347.275046] [031/133] (673s left) gem_render_copy (y-tiled)
[347.336502] Starting subtest: y-tiled
[347.338407] Subtest y-tiled: SKIP (0.000s)
[347.525568] [032/133] (673s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[347.623379] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[347.624312] Starting dynamic subtest: pipe-A-default-mode
[348.791043] Dynamic subtest pipe-A-default-mode: SKIP (1.166s)
[348.792890] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.167s)
[348.933014] [033/133] (671s left) sw_sync (sync_multi_consumer)
[348.966224] Starting subtest: sync_multi_consumer
[349.377907] Subtest sync_multi_consumer: SUCCESS (0.404s)
[349.425489] [034/133] (671s left) gem_exec_schedule (noreorder-priority)
[349.595463] Starting subtest: noreorder-priority
[349.596473] Starting dynamic subtest: rcs0
[350.726648] Dynamic subtest rcs0: SUCCESS (1.131s)
[350.736588] Starting dynamic subtest: vcs0
[351.886764] Dynamic subtest vcs0: SUCCESS (1.159s)
[351.897356] Starting dynamic subtest: vcs1
[353.947295] Dynamic subtest vcs1: SUCCESS (2.049s)
[353.957714] Starting dynamic subtest: vecs0
[355.908831] Dynamic subtest vecs0: SUCCESS (1.960s)
[355.918466] Starting dynamic subtest: ccs0
[357.042561] Dynamic subtest ccs0: SUCCESS (1.142s)
[357.045799] Subtest noreorder-priority: SUCCESS (7.449s)
[357.226578] [035/133] (663s left) gem_tiled_fence_blits (basic)
[357.281432] Subtest basic: SKIP (0.000s)
[357.349887] [036/133] (663s left) i915_pm_rpm (gem-execbuf-stress)
[359.075554] Starting subtest: gem-execbuf-stress
[359.076722] Starting dynamic subtest: smem0
[372.004065] Dynamic subtest smem0: SUCCESS (12.929s)
[372.015252] Starting dynamic subtest: extra-wait-smem0
[433.875133] Dynamic subtest extra-wait-smem0: SUCCESS (61.860s)
[433.876232] Subtest gem-execbuf-stress: SUCCESS (74.793s)
[434.237674] [037/133] (586s left) kms_addfb_basic (basic-y-tiled-legacy)
[434.316050] Starting subtest: basic-y-tiled-legacy
[434.317807] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[434.436440] [038/133] (586s left) kms_concurrent (multi-plane-atomic-lowres)
[434.521868] Starting subtest: multi-plane-atomic-lowres
[434.522753] Starting dynamic subtest: pipe-A-eDP-1
[435.002565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[435.010718] Starting dynamic subtest: pipe-B-eDP-1
[436.304457] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.300s)
[436.316688] Starting dynamic subtest: pipe-C-eDP-1
[437.500514] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[437.508652] Starting dynamic subtest: pipe-D-eDP-1
[438.750702] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[438.751638] Subtest multi-plane-atomic-lowres: SUCCESS (4.228s)
[439.560536] [039/133] (581s left) gem_exec_balancer (bonded-true-hang)
[439.831827] Starting subtest: bonded-true-hang
[439.834402] Subtest bonded-true-hang: SKIP (0.000s)
[439.911374] [040/133] (581s left) prime_self_import (basic-with_two_bos)
[439.950155] Starting subtest: basic-with_two_bos
[439.967743] Subtest basic-with_two_bos: SUCCESS (0.018s)
[440.058425] [041/133] (581s left) gem_partial_pwrite_pread (reads)
[440.111233] Subtest reads: SKIP (0.000s)
[440.179995] [042/133] (580s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[440.233613] Starting subtest: invalid-multi-wait-unsubmitted
[440.234570] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[440.299069] [043/133] (580s left) sysfs_timeslice_duration (idempotent)
[440.370518] Starting subtest: idempotent
[440.371476] Starting dynamic subtest: vecs0
[440.372373] Dynamic subtest vecs0: SUCCESS (0.000s)
[440.380742] Starting dynamic subtest: ccs0
[440.381566] Dynamic subtest ccs0: SUCCESS (0.000s)
[440.388563] Starting dynamic subtest: vcs0
[440.389369] Dynamic subtest vcs0: SUCCESS (0.000s)
[440.396382] Starting dynamic subtest: bcs0
[440.397232] Dynamic subtest bcs0: SUCCESS (0.000s)
[440.404295] Starting dynamic subtest: rcs0
[440.405157] Dynamic subtest rcs0: SUCCESS (0.000s)
[440.412251] Starting dynamic subtest: vcs1
[440.413114] Dynamic subtest vcs1: SUCCESS (0.000s)
[440.413917] Subtest idempotent: SUCCESS (0.006s)
[440.472296] [044/133] (580s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[440.562775] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[440.564704] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[440.654635] [045/133] (580s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[440.748113] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[447.927250] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.180s)
[448.036325] [046/133] (573s left) kms_vblank (query-busy)
[448.128567] Starting subtest: query-busy
[448.129492] Starting dynamic subtest: pipe-A-eDP-1
[450.002703] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[450.012036] Starting dynamic subtest: pipe-D-eDP-1
[452.552889] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[452.553722] Subtest query-busy: SUCCESS (4.425s)
[453.344668] [047/133] (567s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[453.396840] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[453.397833] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[453.509363] [048/133] (567s left) gem_render_copy (y-tiled-to-vebox-linear)
[453.569658] Starting subtest: y-tiled-to-vebox-linear
[453.571375] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[453.753039] [049/133] (567s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[453.848762] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[453.850603] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[453.932239] [050/133] (567s left) perf_pmu (interrupts)
[453.982674] Starting subtest: interrupts
[455.067190] Subtest interrupts: SUCCESS (1.075s)
[455.184016] [051/133] (566s left) gem_mmap (basic)
[455.233534] Subtest basic: SKIP (0.000s)
[455.287768] [052/133] (566s left) syncobj_timeline (single-wait-all-available-submitted)
[455.328609] Starting subtest: single-wait-all-available-submitted
[455.329414] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[455.422828] [053/133] (566s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[457.038548] Starting subtest: modeset-lpsp-stress-no-wait
[467.044554] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.008s)
[467.129288] [054/133] (554s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[467.197521] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[467.264647] [055/133] (554s left) gem_exec_fence (syncobj-unused-fence)
[467.681189] Starting subtest: syncobj-unused-fence
[467.685488] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[468.960680] [056/133] (552s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[469.053974] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[469.055790] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[469.161247] [057/133] (552s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[469.252788] Starting subtest: yf-tiled-16bpp-rotate-270
[469.254852] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[469.351911] [058/133] (552s left) gem_exec_fence (basic-wait)
[469.533494] Starting subtest: basic-wait
[469.534520] Starting dynamic subtest: rcs0
[469.610172] Dynamic subtest rcs0: SUCCESS (0.083s)
[469.621608] Starting dynamic subtest: bcs0
[469.673126] Dynamic subtest bcs0: SUCCESS (0.061s)
[469.684814] Starting dynamic subtest: vcs0
[469.737659] Dynamic subtest vcs0: SUCCESS (0.063s)
[469.748976] Starting dynamic subtest: vcs1
[469.795508] Dynamic subtest vcs1: SUCCESS (0.056s)
[469.806294] Starting dynamic subtest: vecs0
[469.849725] Dynamic subtest vecs0: SUCCESS (0.052s)
[469.861526] Starting dynamic subtest: ccs0
[469.911695] Dynamic subtest ccs0: SUCCESS (0.060s)
[469.912876] Subtest basic-wait: SUCCESS (0.386s)
[471.989307] [059/133] (549s left) prime_mmap_coherency (ioctl-errors)
[472.056371] Starting subtest: ioctl-errors
[489.659906] Subtest ioctl-errors: SUCCESS (17.603s)
[489.844923] [060/133] (531s left) kms_busy (basic)
[489.990648] Starting subtest: basic
[489.991613] Starting dynamic subtest: flip
[490.628706] Dynamic subtest flip: SUCCESS (0.637s)
[490.637525] Starting dynamic subtest: modeset
[494.051718] Dynamic subtest modeset: SUCCESS (3.422s)
[494.052558] Subtest basic: SUCCESS (4.062s)
[494.839430] [061/133] (526s left) gem_exec_store (cachelines)
[494.916477] Starting subtest: cachelines
[494.917502] Starting dynamic subtest: rcs0
[494.981647] Dynamic subtest rcs0: SUCCESS (0.064s)
[494.992895] Starting dynamic subtest: bcs0
[495.038312] Dynamic subtest bcs0: SUCCESS (0.055s)
[495.051471] Starting dynamic subtest: vcs0
[495.093940] Dynamic subtest vcs0: SUCCESS (0.054s)
[495.113585] Starting dynamic subtest: vcs1
[495.146819] Dynamic subtest vcs1: SUCCESS (0.051s)
[495.159169] Starting dynamic subtest: vecs0
[495.203077] Dynamic subtest vecs0: SUCCESS (0.054s)
[495.215940] Starting dynamic subtest: ccs0
[495.263305] Dynamic subtest ccs0: SUCCESS (0.058s)
[495.264562] Subtest cachelines: SUCCESS (0.348s)
[495.444374] [062/133] (526s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[495.542691] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[496.535053] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.993s)
[496.674435] [063/133] (525s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[496.773374] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[496.775527] Starting dynamic subtest: pipe-A-eDP-1
[496.783836] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[496.792197] Starting dynamic subtest: pipe-B-eDP-1
[496.800099] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[496.808199] Starting dynamic subtest: pipe-C-eDP-1
[496.816426] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[496.824806] Starting dynamic subtest: pipe-D-eDP-1
[496.832250] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[496.833716] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.015s)
[499.098861] [064/133] (522s left) prime_busy (hang-wait)
[499.154060] Starting subtest: hang-wait
[499.156242] Starting dynamic subtest: rcs0
[525.438616] Dynamic subtest rcs0: SUCCESS (26.280s)
[525.447431] Starting dynamic subtest: bcs0
[532.522360] Dynamic subtest bcs0: SUCCESS (7.081s)
[532.532667] Starting dynamic subtest: vcs0
[539.556525] Dynamic subtest vcs0: SUCCESS (7.035s)
[539.566437] Starting dynamic subtest: vcs1
[546.599064] Dynamic subtest vcs1: SUCCESS (7.039s)
[546.607800] Starting dynamic subtest: vecs0
[553.508071] Dynamic subtest vecs0: SUCCESS (6.906s)
[553.518862] Starting dynamic subtest: ccs0
[567.343220] Dynamic subtest ccs0: SUCCESS (13.835s)
[567.345924] Subtest hang-wait: SUCCESS (68.191s)
[567.450933] [065/133] (454s left) kms_flip (flip-vs-panning-vs-hang)
[567.550533] Starting subtest: flip-vs-panning-vs-hang
[567.551314] Starting dynamic subtest: A-eDP1
[618.367806] Dynamic subtest A-eDP1: SUCCESS (50.816s)
[618.376104] Starting dynamic subtest: D-eDP1
[658.433801] Dynamic subtest D-eDP1: SUCCESS (40.065s)
[658.435751] Subtest flip-vs-panning-vs-hang: SUCCESS (90.884s)
[659.597799] [066/133] (362s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[659.689169] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[659.691162] Starting dynamic subtest: pipe-A-eDP-1
[659.985157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[659.994055] Starting dynamic subtest: pipe-B-eDP-1
[661.251473] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[661.260476] Starting dynamic subtest: pipe-C-eDP-1
[662.460514] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[662.469464] Starting dynamic subtest: pipe-D-eDP-1
[663.690166] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[663.690929] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.991s)
[664.828236] [067/133] (357s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[664.878721] Subtest tiled-to-tiled: SKIP (0.000s)
[664.939905] [068/133] (357s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[665.029342] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[665.031049] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[665.109849] [069/133] (356s left) gem_ctx_isolation (clean)
[665.161934] Starting subtest: clean
[665.162954] Starting dynamic subtest: rcs0
[665.201307] Dynamic subtest rcs0: SUCCESS (0.039s)
[665.212697] Starting dynamic subtest: bcs0
[665.270061] Dynamic subtest bcs0: SUCCESS (0.067s)
[665.281570] Starting dynamic subtest: vcs0
[665.326973] Dynamic subtest vcs0: SUCCESS (0.056s)
[665.336830] Starting dynamic subtest: vcs1
[666.898797] Dynamic subtest vcs1: SUCCESS (1.571s)
[666.909332] Starting dynamic subtest: vecs0
[668.885876] Dynamic subtest vecs0: SUCCESS (1.986s)
[668.896554] Starting dynamic subtest: ccs0
[670.936763] Dynamic subtest ccs0: SUCCESS (2.050s)
[670.937753] Subtest clean: SUCCESS (5.775s)
[671.159771] [070/133] (350s left) perf_pmu (init-sema)
[671.195762] Starting subtest: init-sema
[671.196721] Starting dynamic subtest: rcs0
[671.197593] Dynamic subtest rcs0: SUCCESS (0.002s)
[671.205602] Starting dynamic subtest: bcs0
[671.206474] Dynamic subtest bcs0: SUCCESS (0.000s)
[671.214306] Starting dynamic subtest: vcs0
[671.215169] Dynamic subtest vcs0: SUCCESS (0.001s)
[671.222998] Starting dynamic subtest: vcs1
[671.223866] Dynamic subtest vcs1: SUCCESS (0.001s)
[671.231748] Starting dynamic subtest: vecs0
[671.232649] Dynamic subtest vecs0: SUCCESS (0.001s)
[671.240640] Starting dynamic subtest: ccs0
[671.241673] Dynamic subtest ccs0: SUCCESS (0.000s)
[671.242531] Subtest init-sema: SUCCESS (0.008s)
[671.305808] [071/133] (350s left) kms_force_connector_basic (prune-stale-modes)
[671.388844] Starting subtest: prune-stale-modes
[671.837642] Subtest prune-stale-modes: SUCCESS (0.449s)
[671.976042] [072/133] (350s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[672.043599] Subtest no-spare-fences-busy: SKIP (0.000s)
[672.100115] [073/133] (350s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[672.189346] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[672.191075] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[673.340533] [074/133] (348s left) i915_pm_freq_api (freq-suspend)
[673.390950] Starting subtest: freq-suspend
[673.391953] Starting dynamic subtest: gt0
[690.551407] Dynamic subtest gt0: SUCCESS (1.748s)
[690.562944] Starting dynamic subtest: gt1
[707.550661] Dynamic subtest gt1: SUCCESS (1.642s)
[707.551454] Subtest freq-suspend: SUCCESS (3.394s)
[714.657829] [075/133] (314s left) kms_cursor_edge_walk (256x256-top-bottom)
[714.765577] Starting subtest: 256x256-top-bottom
[714.766648] Starting dynamic subtest: pipe-A-eDP-1
[718.251035] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s)
[718.262400] Starting dynamic subtest: pipe-D-eDP-1
[721.412147] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.176s)
[721.412976] Subtest 256x256-top-bottom: SUCCESS (6.690s)
[722.296010] [076/133] (307s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[722.377444] Starting subtest: psr-rgb565-draw-pwrite
[729.541185] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.183s)
[729.667439] [077/133] (299s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[729.854733] Starting subtest: cursor-rapid-movement-64x64
[729.857811] Starting dynamic subtest: pipe-A-eDP-1
[730.402187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[730.433026] Starting dynamic subtest: pipe-D-eDP-1
[731.653865] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[731.654866] Subtest cursor-rapid-movement-64x64: SUCCESS (1.802s)
[732.467478] [078/133] (296s left) gem_ctx_persistence (legacy-engines-queued)
[732.532701] Starting subtest: legacy-engines-queued
[732.533788] Starting dynamic subtest: render
[732.614989] Dynamic subtest render: SUCCESS (0.081s)
[732.628832] Starting dynamic subtest: bsd1
[734.634113] Dynamic subtest bsd1: SUCCESS (2.009s)
[734.645943] Starting dynamic subtest: bsd2
[736.617743] Dynamic subtest bsd2: SUCCESS (1.982s)
[736.629604] Starting dynamic subtest: blt
[736.651296] Dynamic subtest blt: SUCCESS (0.041s)
[736.661249] Starting dynamic subtest: vebox
[738.664190] Dynamic subtest vebox: SUCCESS (2.003s)
[738.665630] Subtest legacy-engines-queued: SUCCESS (6.129s)
[738.784187] [079/133] (290s left) kms_flip (2x-flip-vs-fences-interruptible)
[738.886421] Starting subtest: 2x-flip-vs-fences-interruptible
[738.888134] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[739.016716] [080/133] (290s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[739.111587] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[739.112495] Starting dynamic subtest: pipe-A-eDP-1
[739.200300] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[739.210155] Starting dynamic subtest: pipe-B-eDP-1
[740.309152] Dynamic subtest pipe-B-eDP-1: SKIP (1.108s)
[740.310808] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.200s)
[741.544586] [081/133] (288s left) syncobj_timeline (etime-multi-wait-submitted)
[741.603278] Starting subtest: etime-multi-wait-submitted
[741.709229] Subtest etime-multi-wait-submitted: SUCCESS (0.105s)
[741.782866] [082/133] (287s left) gem_render_copy (linear-to-vebox-yf-tiled)
[741.843108] Starting subtest: linear-to-vebox-yf-tiled
[741.845566] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[742.030935] [083/133] (287s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[742.117484] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[742.118366] Starting dynamic subtest: pipe-A-eDP-1
[742.140202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[742.150828] Starting dynamic subtest: pipe-B-eDP-1
[742.166736] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[742.177620] Starting dynamic subtest: pipe-C-eDP-1
[742.190183] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[742.200059] Starting dynamic subtest: pipe-D-eDP-1
[742.213172] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[742.213909] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.097s)
[744.439771] [084/133] (285s left) kms_psr (psr-cursor-render)
[744.518292] Starting subtest: psr-cursor-render
[744.519074] Starting dynamic subtest: eDP-1
[746.219302] Dynamic subtest eDP-1: SUCCESS (1.702s)
[746.220024] Subtest psr-cursor-render: SUCCESS (1.703s)
[747.050762] [085/133] (282s left) kms_atomic (atomic-invalid-params)
[747.135343] Starting subtest: atomic-invalid-params
[747.136151] Starting dynamic subtest: pipe-A-eDP-1
[747.536165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[747.537020] Subtest atomic-invalid-params: SUCCESS (0.401s)
[748.329542] [086/133] (281s left) gem_exec_schedule (semaphore-power)
[748.510105] Subtest semaphore-power: SKIP (0.000s)
[748.686154] [087/133] (281s left) api_intel_allocator (default-alignment)
[748.746090] Starting subtest: default-alignment
[748.748620] Subtest default-alignment: SUCCESS (0.003s)
[748.873036] [088/133] (280s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[748.964617] Starting subtest: yf-tiled-32bpp-rotate-90
[748.966436] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[749.057722] [089/133] (280s left) gem_mmap_wc (copy)
[749.110367] Subtest copy: SKIP (0.000s)
[749.168524] [090/133] (280s left) gem_exec_whisper (basic-queues-forked-all)
[749.224288] Starting subtest: basic-queues-forked-all
[768.856955] Subtest basic-queues-forked-all: SUCCESS (19.632s)
[769.029957] [091/133] (260s left) kms_plane_scaling (intel-max-src-size)
[769.118345] Starting subtest: intel-max-src-size
[769.122344] Subtest intel-max-src-size: SKIP (0.000s)
[769.216164] [092/133] (260s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[769.307684] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[776.311615] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.009s)
[776.490670] [093/133] (253s left) kms_psr (fbc-psr2-sprite-render)
[776.589751] Starting subtest: fbc-psr2-sprite-render
[776.590705] Starting dynamic subtest: eDP-1
[776.592694] Dynamic subtest eDP-1: SKIP (0.000s)
[776.594323] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[776.681330] [094/133] (253s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[776.775797] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[776.777628] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[776.865413] [095/133] (253s left) gem_pread (self)
[776.905669] Subtest self: SKIP (0.000s)
[776.972436] [096/133] (253s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[777.068534] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[777.070107] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[777.172186] [097/133] (252s left) kms_prop_blob (invalid-set-prop)
[777.222436] Starting subtest: invalid-set-prop
[777.223233] Subtest invalid-set-prop: SUCCESS (0.000s)
[777.329223] [098/133] (252s left) fbdev (unaligned-write)
[777.369831] Starting subtest: unaligned-write
[777.472235] Subtest unaligned-write: SUCCESS (0.101s)
[777.546685] [099/133] (252s left) kms_plane (pixel-format-x-tiled-modifier)
[777.633589] Starting subtest: pixel-format-x-tiled-modifier
[777.661846] Starting dynamic subtest: pipe-A-plane-0
[778.305904] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[778.319313] Starting dynamic subtest: pipe-A-plane-3
[778.727797] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[778.738599] Starting dynamic subtest: pipe-A-plane-5
[778.740253] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[779.889443] Starting dynamic subtest: pipe-B-plane-0
[780.510316] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[780.521190] Starting dynamic subtest: pipe-B-plane-3
[780.954607] Dynamic subtest pipe-B-plane-3: SUCCESS (0.442s)
[780.965679] Starting dynamic subtest: pipe-B-plane-5
[780.967158] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[781.262818] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.630s)
[782.130073] [100/133] (248s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[782.188982] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[782.250548] [101/133] (248s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[782.341505] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[786.089042] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.749s)
[787.231325] [102/133] (243s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[787.321487] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[787.333617] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.012s)
[787.406874] [103/133] (242s left) core_getversion (all-cards)
[787.435013] Starting subtest: all-cards
[787.445409] Subtest all-cards: SUCCESS (0.011s)
[787.481157] [104/133] (242s left) gem_exec_reloc (basic-wc-read-noreloc)
[787.543252] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[787.608548] [105/133] (242s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[787.706757] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[787.708690] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[787.799194] [106/133] (242s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[787.895162] Starting subtest: x-tiled-16bpp-rotate-90
[787.918285] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[788.035688] [107/133] (242s left) kms_feature_discovery (display-1x)
[788.117980] Starting subtest: display-1x
[788.118929] Subtest display-1x: SUCCESS (0.000s)
[788.186830] [108/133] (242s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[788.298215] Starting subtest: cursorA-vs-flipB-varying-size
[788.299988] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[788.441351] [109/133] (242s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[788.544637] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[788.546500] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[788.631111] [110/133] (241s left) kms_psr2_su (page_flip-xrgb8888)
[788.681201] Subtest page_flip-XRGB8888: SKIP (0.000s)
[788.742982] [111/133] (241s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[788.839885] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[788.841629] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[788.941921] [112/133] (241s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[789.038607] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[793.625656] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.589s)
[794.830149] [113/133] (235s left) i915_drm_fdinfo (isolation)
[794.867503] Starting subtest: isolation
[794.868423] Starting dynamic subtest: rcs0
[794.885421] Dynamic subtest rcs0: SKIP (0.017s)
[794.896445] Starting dynamic subtest: bcs0
[794.898103] Dynamic subtest bcs0: SKIP (0.001s)
[794.906715] Starting dynamic subtest: vcs0
[794.908488] Dynamic subtest vcs0: SKIP (0.001s)
[794.916972] Starting dynamic subtest: vcs1
[794.918783] Dynamic subtest vcs1: SKIP (0.000s)
[794.927431] Starting dynamic subtest: vecs0
[794.929223] Dynamic subtest vecs0: SKIP (0.000s)
[794.938049] Starting dynamic subtest: ccs0
[794.939771] Dynamic subtest ccs0: SKIP (0.000s)
[794.941325] Subtest isolation: SKIP (0.025s)
[794.972925] [114/133] (235s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[795.059424] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[795.061188] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[795.157721] [115/133] (235s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[795.248692] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[799.789751] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.544s)
[800.913360] [116/133] (229s left) kms_big_fb (4-tiled-addfb)
[801.020713] Starting subtest: 4-tiled-addfb
[801.021612] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[801.134428] [117/133] (229s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[801.224214] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[801.225921] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[801.323874] [118/133] (229s left) kms_cursor_crc (cursor-offscreen-512x512)
[801.601563] Starting subtest: cursor-offscreen-512x512
[801.603227] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[801.764461] [119/133] (229s left) gem_mmap (bad-size)
[801.820857] Subtest bad-size: SKIP (0.000s)
[801.872345] [120/133] (229s left) gem_mmap_offset (blt-coherency)
[801.932170] Starting subtest: blt-coherency
[801.937981] Subtest blt-coherency: SUCCESS (0.007s)
[802.057381] [121/133] (228s left) api_intel_bb (simple-bb-ctx)
[802.112075] Starting subtest: simple-bb-ctx
[802.120160] Subtest simple-bb-ctx: SUCCESS (0.008s)
[802.204254] [122/133] (228s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[802.290409] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[802.292003] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[802.380946] [123/133] (228s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[802.470795] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[802.472462] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[802.539910] [124/133] (228s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[802.628713] Starting subtest: fbc-pr-sprite-mmap-gtt
[802.630642] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[802.713291] [125/133] (228s left) kms_psr (pr-primary-mmap-gtt)
[802.802352] Starting subtest: pr-primary-mmap-gtt
[802.804140] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[802.876195] [126/133] (228s left) kms_pipe_crc_basic (suspend-read-crc)
[802.958391] Starting subtest: suspend-read-crc
[802.959237] Starting dynamic subtest: pipe-A-eDP-1
[821.464577] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.977s)
[821.474228] Starting dynamic subtest: pipe-B-eDP-1
[840.469683] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.511s)
[840.491760] Starting dynamic subtest: pipe-C-eDP-1
[859.455246] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.456s)
[859.465757] Starting dynamic subtest: pipe-D-eDP-1
[878.430607] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.454s)
[878.431498] Subtest suspend-read-crc: SUCCESS (13.404s)
[883.376517] [127/133] (151s left) kms_chamelium_hpd (hdmi-hpd-storm)
[883.765805] Subtest hdmi-hpd-storm: SKIP (0.000s)
[884.595027] [128/133] (150s left) gem_wait (write-busy)
[884.648705] Starting subtest: write-busy
[884.649740] Starting dynamic subtest: all-engines
[885.247752] Dynamic subtest all-engines: SUCCESS (0.603s)
[885.267496] Starting dynamic subtest: rcs0
[885.810385] Dynamic subtest rcs0: SUCCESS (0.565s)
[885.827617] Starting dynamic subtest: bcs0
[886.362177] Dynamic subtest bcs0: SUCCESS (0.554s)
[886.380304] Starting dynamic subtest: vcs0
[887.751202] Dynamic subtest vcs0: SUCCESS (1.381s)
[887.760383] Starting dynamic subtest: vcs1
[889.734434] Dynamic subtest vcs1: SUCCESS (1.991s)
[889.743911] Starting dynamic subtest: vecs0
[891.783043] Dynamic subtest vecs0: SUCCESS (2.053s)
[891.793072] Starting dynamic subtest: ccs0
[892.320628] Dynamic subtest ccs0: SUCCESS (0.550s)
[892.321705] Subtest write-busy: SUCCESS (7.710s)
[892.511913] [129/133] (142s left) gem_userptr_blits (relocations)
[892.576643] Starting subtest: relocations
[892.578548] Subtest relocations: SKIP (0.000s)
[892.703726] [130/133] (142s left) gem_eio (wait-immediate)
[892.918178] Starting subtest: wait-immediate
[893.270350] Subtest wait-immediate: SUCCESS (0.356s)
[893.399635] [131/133] (142s left) gem_userptr_blits (create-destroy-unsync)
[893.464254] Subtest create-destroy-unsync: SKIP (0.000s)
[893.576016] [132/133] (141s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[893.664749] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[900.904512] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.254s)
[901.014095] [133/133] (134s left) gem_exec_reloc (basic-wc)
[901.076869] Subtest basic-wc: SKIP (0.000s)
[901.148645] 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.