[57.666314] Initializing watchdogs
[57.666358]   /dev/watchdog0
[57.679767] [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]
[57.683986] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.686133] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.689721] [001/133] (960s left) vgem_basic (second-client)
[57.776402] Starting subtest: second-client
[57.797900] Subtest second-client: SUCCESS (0.022s)
[57.853795] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[57.856899] [002/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[57.992283] Starting subtest: cursorA-vs-flipB-atomic-transitions
[57.996667] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[58.136118] [003/133] (960s left) syncobj_timeline (multi-wait-available-submitted)
[58.184580] Starting subtest: multi-wait-available-submitted
[58.186662] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[58.273560] [004/133] (960s left) kms_invalid_mode (bad-vsync-end)
[58.359428] Starting subtest: bad-vsync-end
[58.361940] Starting dynamic subtest: pipe-A-eDP-1
[58.651373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[58.659771] Starting dynamic subtest: pipe-B-eDP-1
[58.661919] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[58.668631] Starting dynamic subtest: pipe-C-eDP-1
[58.670750] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[58.678615] Starting dynamic subtest: pipe-D-eDP-1
[58.680851] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[58.683061] Subtest bad-vsync-end: SUCCESS (0.301s)
[59.494686] [005/133] (958s left) kms_pm_backlight (fade-with-dpms)
[59.584018] Starting subtest: fade-with-dpms
[61.758430] Starting dynamic subtest: eDP-1
[64.249180] Dynamic subtest eDP-1: SUCCESS (2.499s)
[64.251649] Subtest fade-with-dpms: SUCCESS (4.683s)
[65.042824] [006/133] (953s left) kms_flip (bo-too-big-interruptible)
[65.146275] Starting subtest: bo-too-big-interruptible
[65.148465] Starting dynamic subtest: A-eDP1
[66.406753] Dynamic subtest A-eDP1: SUCCESS (1.262s)
[66.415923] Starting dynamic subtest: B-eDP1
[67.648737] Dynamic subtest B-eDP1: SUCCESS (1.243s)
[67.662442] Starting dynamic subtest: C-eDP1
[68.974646] Dynamic subtest C-eDP1: SUCCESS (1.327s)
[68.981967] Starting dynamic subtest: D-eDP1
[70.301799] Dynamic subtest D-eDP1: SUCCESS (1.329s)
[70.306837] Subtest bo-too-big-interruptible: SUCCESS (5.169s)
[71.500512] [007/133] (946s left) gem_mmap_gtt (basic-read)
[71.565335] Subtest basic-read: SKIP (0.000s)
[71.621301] [008/133] (946s left) gem_softpin (allocator-evict)
[71.679109] Starting subtest: allocator-evict
[71.681506] Starting dynamic subtest: rcs0
[95.039366] Dynamic subtest rcs0: SUCCESS (23.366s)
[95.048329] Starting dynamic subtest: bcs0
[119.084056] Dynamic subtest bcs0: SUCCESS (24.044s)
[119.091787] Starting dynamic subtest: vcs0
[142.519865] Dynamic subtest vcs0: SUCCESS (23.435s)
[142.530177] Starting dynamic subtest: vcs1
[166.431877] Dynamic subtest vcs1: SUCCESS (23.910s)
[166.440624] Starting dynamic subtest: vecs0
[190.066870] Dynamic subtest vecs0: SUCCESS (23.633s)
[190.077223] Starting dynamic subtest: ccs0
[213.956498] Dynamic subtest ccs0: SUCCESS (23.888s)
[213.959428] Subtest allocator-evict: SUCCESS (142.279s)
[214.035919] [009/133] (804s left) gem_render_linear_blits (basic)
[214.129043] Starting subtest: basic
[214.165994] Subtest basic: SUCCESS (0.037s)
[214.254565] [010/133] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[214.375721] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[214.379958] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[214.467334] [011/133] (804s left) kms_psr (psr-primary-mmap-cpu)
[214.560873] Starting subtest: psr-primary-mmap-cpu
[214.563295] Starting dynamic subtest: eDP-1
[216.286914] Dynamic subtest eDP-1: SUCCESS (1.725s)
[216.288854] Subtest psr-primary-mmap-cpu: SUCCESS (1.726s)
[217.159938] [012/133] (801s left) kms_chamelium_edid (hdmi-mode-timings)
[217.537219] Subtest hdmi-mode-timings: SKIP (0.000s)
[218.367340] [013/133] (800s left) gen7_exec_parse (load-register-reg)
[218.434278] Subtest load-register-reg: SKIP (0.000s)
[218.498850] [014/133] (800s left) syncobj_eventfd (invalid-bad-flags)
[218.557375] Starting subtest: invalid-bad-flags
[218.559933] Subtest invalid-bad-flags: SUCCESS (0.000s)
[218.676657] [015/133] (800s left) gem_ctx_exec (basic-invalid-context)
[218.730872] Starting subtest: basic-invalid-context
[218.735675] Subtest basic-invalid-context: SUCCESS (0.004s)
[218.870434] [016/133] (799s left) gem_exec_reloc (basic-write-read-active)
[218.925424] Subtest basic-write-read-active: SKIP (0.000s)
[218.999805] [017/133] (799s left) kms_vblank (wait-busy-hang)
[219.090800] Starting subtest: wait-busy-hang
[219.093131] Starting dynamic subtest: pipe-A-eDP-1
[245.662441] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.570s)
[245.676369] Starting dynamic subtest: pipe-D-eDP-1
[270.679550] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[270.681772] Subtest wait-busy-hang: SUCCESS (51.588s)
[271.565659] [018/133] (747s left) kms_chamelium_color (ctm-0-50)
[271.653059] Subtest ctm-0-50: SKIP (0.000s)
[271.697722] [019/133] (747s left) gem_exec_flush (basic-uc-prw-default)
[271.771383] Starting subtest: basic-uc-prw-default
[277.239576] Subtest basic-uc-prw-default: SUCCESS (5.469s)
[277.439518] [020/133] (741s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[277.535379] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[284.182091] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.649s)
[284.313668] [021/133] (734s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[284.416578] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[284.421345] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[284.500164] [022/133] (734s left) kms_plane_scaling (planes-upscale-factor-0-25)
[284.603682] Starting subtest: planes-upscale-factor-0-25
[284.605982] Starting dynamic subtest: pipe-A
[284.665821] Dynamic subtest pipe-A: SUCCESS (0.063s)
[284.675750] Starting dynamic subtest: pipe-B
[285.810719] Dynamic subtest pipe-B: SUCCESS (1.144s)
[285.820615] Starting dynamic subtest: pipe-C
[286.918417] Dynamic subtest pipe-C: SUCCESS (1.107s)
[286.928121] Starting dynamic subtest: pipe-D
[288.051702] Dynamic subtest pipe-D: SUCCESS (1.133s)
[288.053913] Subtest planes-upscale-factor-0-25: SUCCESS (3.449s)
[289.204475] [023/133] (729s left) i915_selftest (perf)
[290.931227] Starting subtest: perf
[290.934671] Starting dynamic subtest: engine_cs
[295.294342] Dynamic subtest engine_cs: SUCCESS (4.362s)
[295.303267] Starting dynamic subtest: request
[302.543218] Dynamic subtest request: SUCCESS (7.249s)
[302.551869] Starting dynamic subtest: migrate
[306.775521] Dynamic subtest migrate: SUCCESS (4.231s)
[306.784551] Starting dynamic subtest: region
[312.390661] Dynamic subtest region: SUCCESS (5.613s)
[312.393684] Subtest perf: SUCCESS (21.459s)
[312.423087] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[312.423807] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[312.426764] [024/133] (706s left) kms_color (legacy-gamma)
[314.017372] Starting subtest: legacy-gamma
[314.019577] Starting dynamic subtest: pipe-A-eDP-1
[314.717375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[314.726246] Starting dynamic subtest: pipe-B-eDP-1
[316.123733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[316.132778] Starting dynamic subtest: pipe-C-eDP-1
[317.527962] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[317.542661] Starting dynamic subtest: pipe-D-eDP-1
[318.850930] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[318.853236] Subtest legacy-gamma: SUCCESS (4.834s)
[319.684875] [FACT kms_color (legacy-gamma)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[319.686061] [FACT kms_color (legacy-gamma)] new: kernel.kmod_is_loaded.i915: true
[319.689599] [025/133] (699s left) perf (gen12-mi-rpc)
[319.842914] Starting subtest: gen12-mi-rpc
[319.845176] Starting dynamic subtest: rcs0
[319.866867] Dynamic subtest rcs0: SUCCESS (0.024s)
[319.869067] Subtest gen12-mi-rpc: SUCCESS (0.025s)
[319.919443] [026/133] (699s left) syncobj_timeline (invalid-wait-bad-flags)
[320.012463] Starting subtest: invalid-wait-bad-flags
[320.014951] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[320.134865] [027/133] (699s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[320.262281] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[320.267094] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[320.406796] [028/133] (698s left) gem_eio (kms)
[320.590789] Starting subtest: kms
[336.231772] Subtest kms: SUCCESS (15.641s)
[337.407087] [029/133] (681s left) gem_exec_fence (long-history)
[337.850910] Starting subtest: long-history
[344.657222] Subtest long-history: SUCCESS (6.807s)
[345.092689] [030/133] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[345.185371] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[345.189840] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[345.263131] [031/133] (674s left) gem_render_copy (y-tiled)
[345.329085] Starting subtest: y-tiled
[345.333281] Subtest y-tiled: SKIP (0.000s)
[345.520467] [032/133] (673s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[345.615630] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[345.618072] Starting dynamic subtest: pipe-A-default-mode
[346.773479] Dynamic subtest pipe-A-default-mode: SKIP (1.155s)
[346.777725] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.156s)
[346.922737] [033/133] (672s left) sw_sync (sync_multi_consumer)
[346.965941] Starting subtest: sync_multi_consumer
[347.399056] Subtest sync_multi_consumer: SUCCESS (0.434s)
[347.463188] [034/133] (672s left) gem_exec_schedule (noreorder-priority)
[347.637815] Starting subtest: noreorder-priority
[347.640301] Starting dynamic subtest: rcs0
[348.782529] Dynamic subtest rcs0: SUCCESS (1.145s)
[348.794322] Starting dynamic subtest: vcs0
[351.892893] Dynamic subtest vcs0: SUCCESS (3.107s)
[351.904205] Starting dynamic subtest: vcs1
[353.932497] Dynamic subtest vcs1: SUCCESS (2.037s)
[353.943937] Starting dynamic subtest: vecs0
[355.925336] Dynamic subtest vecs0: SUCCESS (1.991s)
[355.936491] Starting dynamic subtest: ccs0
[357.066332] Dynamic subtest ccs0: SUCCESS (1.140s)
[357.069256] Subtest noreorder-priority: SUCCESS (9.428s)
[357.250892] [035/133] (662s left) gem_tiled_fence_blits (basic)
[357.318702] Subtest basic: SKIP (0.000s)
[357.394347] [036/133] (662s left) i915_pm_rpm (gem-execbuf-stress)
[359.122365] Starting subtest: gem-execbuf-stress
[359.125235] Starting dynamic subtest: smem0
[372.067483] Dynamic subtest smem0: SUCCESS (12.943s)
[372.078921] Starting dynamic subtest: extra-wait-smem0
[433.836149] Dynamic subtest extra-wait-smem0: SUCCESS (61.765s)
[433.839217] Subtest gem-execbuf-stress: SUCCESS (74.712s)
[434.210576] [037/133] (585s left) kms_addfb_basic (basic-y-tiled-legacy)
[434.257044] Starting subtest: basic-y-tiled-legacy
[434.261141] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[434.390139] [038/133] (585s left) kms_concurrent (multi-plane-atomic-lowres)
[434.478759] Starting subtest: multi-plane-atomic-lowres
[434.481059] Starting dynamic subtest: pipe-A-eDP-1
[434.988444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s)
[434.997774] Starting dynamic subtest: pipe-B-eDP-1
[436.247852] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.258s)
[436.257041] Starting dynamic subtest: pipe-C-eDP-1
[437.466808] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.219s)
[437.477290] Starting dynamic subtest: pipe-D-eDP-1
[438.701113] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[438.703345] Subtest multi-plane-atomic-lowres: SUCCESS (4.222s)
[439.536921] [039/133] (580s left) gem_exec_balancer (bonded-true-hang)
[439.781066] Starting subtest: bonded-true-hang
[439.786267] Subtest bonded-true-hang: SKIP (0.000s)
[439.904743] [040/133] (579s left) prime_self_import (basic-with_two_bos)
[439.943915] Starting subtest: basic-with_two_bos
[439.962021] Subtest basic-with_two_bos: SUCCESS (0.018s)
[440.058958] [041/133] (579s left) gem_partial_pwrite_pread (reads)
[440.108325] Subtest reads: SKIP (0.000s)
[440.175289] [042/133] (579s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[440.226668] Starting subtest: invalid-multi-wait-unsubmitted
[440.228925] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[440.309358] [043/133] (579s left) sysfs_timeslice_duration (idempotent)
[440.360610] Starting subtest: idempotent
[440.362857] Starting dynamic subtest: vecs0
[440.365059] Dynamic subtest vecs0: SUCCESS (0.000s)
[440.374656] Starting dynamic subtest: ccs0
[440.376742] Dynamic subtest ccs0: SUCCESS (0.000s)
[440.384696] Starting dynamic subtest: vcs0
[440.386557] Dynamic subtest vcs0: SUCCESS (0.000s)
[440.394126] Starting dynamic subtest: bcs0
[440.395993] Dynamic subtest bcs0: SUCCESS (0.000s)
[440.404202] Starting dynamic subtest: rcs0
[440.406337] Dynamic subtest rcs0: SUCCESS (0.000s)
[440.414306] Starting dynamic subtest: vcs1
[440.416147] Dynamic subtest vcs1: SUCCESS (0.000s)
[440.417982] Subtest idempotent: SUCCESS (0.005s)
[440.472750] [044/133] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[440.570697] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[440.574884] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[440.670577] [045/133] (579s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[440.767574] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[447.830030] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.066s)
[447.939552] [046/133] (572s left) kms_vblank (query-busy)
[448.057256] Starting subtest: query-busy
[448.059333] Starting dynamic subtest: pipe-A-eDP-1
[449.930988] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[449.944954] Starting dynamic subtest: pipe-D-eDP-1
[452.525651] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s)
[452.527821] Subtest query-busy: SUCCESS (4.469s)
[453.339464] [047/133] (566s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[453.403628] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[453.405898] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[453.519436] [048/133] (566s left) gem_render_copy (y-tiled-to-vebox-linear)
[453.598051] Starting subtest: y-tiled-to-vebox-linear
[453.602553] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[453.779007] [049/133] (566s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[453.887835] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[453.891795] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[453.986728] [050/133] (566s left) perf_pmu (interrupts)
[454.029516] Starting subtest: interrupts
[455.105607] Subtest interrupts: SUCCESS (1.075s)
[455.210651] [051/133] (565s left) gem_mmap (basic)
[455.283239] Subtest basic: SKIP (0.000s)
[455.343090] [052/133] (564s left) syncobj_timeline (single-wait-all-available-submitted)
[455.404530] Starting subtest: single-wait-all-available-submitted
[455.406785] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[455.501410] [053/133] (564s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[457.127199] Starting subtest: modeset-lpsp-stress-no-wait
[467.014651] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.892s)
[467.101871] [054/133] (553s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[467.152801] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[467.215995] [055/133] (553s left) gem_exec_fence (syncobj-unused-fence)
[467.649957] Starting subtest: syncobj-unused-fence
[467.654805] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[468.937814] [056/133] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[469.036516] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[469.040879] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[469.130278] [057/133] (551s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[469.231697] Starting subtest: yf-tiled-16bpp-rotate-270
[469.236157] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[469.326449] [058/133] (551s left) gem_exec_fence (basic-wait)
[469.533442] Starting subtest: basic-wait
[469.537857] Starting dynamic subtest: rcs0
[469.581475] Dynamic subtest rcs0: SUCCESS (0.071s)
[469.594168] Starting dynamic subtest: bcs0
[469.644334] Dynamic subtest bcs0: SUCCESS (0.062s)
[469.656213] Starting dynamic subtest: vcs0
[469.704617] Dynamic subtest vcs0: SUCCESS (0.057s)
[469.714709] Starting dynamic subtest: vcs1
[469.767190] Dynamic subtest vcs1: SUCCESS (0.060s)
[469.778154] Starting dynamic subtest: vecs0
[469.819158] Dynamic subtest vecs0: SUCCESS (0.050s)
[469.830553] Starting dynamic subtest: ccs0
[469.876382] Dynamic subtest ccs0: SUCCESS (0.056s)
[469.878888] Subtest basic-wait: SUCCESS (0.369s)
[471.949507] [059/133] (548s left) prime_mmap_coherency (ioctl-errors)
[472.020207] Starting subtest: ioctl-errors
[490.060694] Subtest ioctl-errors: SUCCESS (18.040s)
[490.223020] [060/133] (530s left) kms_busy (basic)
[490.351251] Starting subtest: basic
[490.353055] Starting dynamic subtest: flip
[490.974318] Dynamic subtest flip: SUCCESS (0.621s)
[490.983675] Starting dynamic subtest: modeset
[494.415452] Dynamic subtest modeset: SUCCESS (3.441s)
[494.417849] Subtest basic: SUCCESS (4.064s)
[495.220141] [061/133] (525s left) gem_exec_store (cachelines)
[495.285380] Starting subtest: cachelines
[495.287381] Starting dynamic subtest: rcs0
[495.355961] Dynamic subtest rcs0: SUCCESS (0.072s)
[495.368951] Starting dynamic subtest: bcs0
[495.420545] Dynamic subtest bcs0: SUCCESS (0.063s)
[495.433259] Starting dynamic subtest: vcs0
[495.474275] Dynamic subtest vcs0: SUCCESS (0.052s)
[495.485584] Starting dynamic subtest: vcs1
[495.534121] Dynamic subtest vcs1: SUCCESS (0.058s)
[495.543837] Starting dynamic subtest: vecs0
[495.589074] Dynamic subtest vecs0: SUCCESS (0.053s)
[495.599667] Starting dynamic subtest: ccs0
[495.658809] Dynamic subtest ccs0: SUCCESS (0.067s)
[495.661262] Subtest cachelines: SUCCESS (0.376s)
[495.847374] [062/133] (524s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[495.954489] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[497.065471] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.112s)
[497.193169] [063/133] (523s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[497.293033] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[497.294872] Starting dynamic subtest: pipe-A-eDP-1
[497.313492] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[497.324982] Starting dynamic subtest: pipe-B-eDP-1
[497.343420] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[497.361350] Starting dynamic subtest: pipe-C-eDP-1
[497.379954] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[497.390868] Starting dynamic subtest: pipe-D-eDP-1
[497.409203] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[497.412549] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[499.605762] [064/133] (521s left) prime_busy (hang-wait)
[499.673949] Starting subtest: hang-wait
[499.676187] Starting dynamic subtest: rcs0
[525.366297] Dynamic subtest rcs0: SUCCESS (25.690s)
[525.375318] Starting dynamic subtest: bcs0
[532.516407] Dynamic subtest bcs0: SUCCESS (7.146s)
[532.532057] Starting dynamic subtest: vcs0
[539.493218] Dynamic subtest vcs0: SUCCESS (6.975s)
[539.502071] Starting dynamic subtest: vcs1
[546.532937] Dynamic subtest vcs1: SUCCESS (7.036s)
[546.541662] Starting dynamic subtest: vecs0
[553.508198] Dynamic subtest vecs0: SUCCESS (6.974s)
[553.518567] Starting dynamic subtest: ccs0
[567.344411] Dynamic subtest ccs0: SUCCESS (13.834s)
[567.346755] Subtest hang-wait: SUCCESS (67.670s)
[567.449356] [065/133] (453s left) kms_flip (flip-vs-panning-vs-hang)
[567.547368] Starting subtest: flip-vs-panning-vs-hang
[567.549916] Starting dynamic subtest: A-eDP1
[618.369784] Dynamic subtest A-eDP1: SUCCESS (50.822s)
[618.381658] Starting dynamic subtest: D-eDP1
[658.365797] Dynamic subtest D-eDP1: SUCCESS (39.993s)
[658.368236] Subtest flip-vs-panning-vs-hang: SUCCESS (90.820s)
[659.542431] [066/133] (361s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[659.634078] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[659.636509] Starting dynamic subtest: pipe-A-eDP-1
[659.929251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.262s)
[659.938795] Starting dynamic subtest: pipe-B-eDP-1
[661.193534] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.265s)
[661.205377] Starting dynamic subtest: pipe-C-eDP-1
[662.397667] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[662.409753] Starting dynamic subtest: pipe-D-eDP-1
[663.629658] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[663.631895] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.968s)
[664.757020] [067/133] (356s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[664.820430] Subtest tiled-to-tiled: SKIP (0.000s)
[664.893121] [068/133] (356s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[664.988840] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[664.993138] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[665.061276] [069/133] (355s left) gem_ctx_isolation (clean)
[665.120336] Starting subtest: clean
[665.122436] Starting dynamic subtest: rcs0
[665.168903] Dynamic subtest rcs0: SUCCESS (0.048s)
[665.178742] Starting dynamic subtest: bcs0
[665.223053] Dynamic subtest bcs0: SUCCESS (0.053s)
[665.233150] Starting dynamic subtest: vcs0
[665.284268] Dynamic subtest vcs0: SUCCESS (0.060s)
[665.294899] Starting dynamic subtest: vcs1
[666.897468] Dynamic subtest vcs1: SUCCESS (1.612s)
[666.908166] Starting dynamic subtest: vecs0
[668.884895] Dynamic subtest vecs0: SUCCESS (1.986s)
[668.897017] Starting dynamic subtest: ccs0
[670.964736] Dynamic subtest ccs0: SUCCESS (2.079s)
[670.967158] Subtest clean: SUCCESS (5.845s)
[671.196683] [070/133] (349s left) perf_pmu (init-sema)
[671.239953] Starting subtest: init-sema
[671.242347] Starting dynamic subtest: rcs0
[671.244635] Dynamic subtest rcs0: SUCCESS (0.002s)
[671.255104] Starting dynamic subtest: bcs0
[671.257337] Dynamic subtest bcs0: SUCCESS (0.000s)
[671.266208] Starting dynamic subtest: vcs0
[671.268418] Dynamic subtest vcs0: SUCCESS (0.001s)
[671.278100] Starting dynamic subtest: vcs1
[671.279962] Dynamic subtest vcs1: SUCCESS (0.001s)
[671.289388] Starting dynamic subtest: vecs0
[671.291646] Dynamic subtest vecs0: SUCCESS (0.001s)
[671.300696] Starting dynamic subtest: ccs0
[671.302599] Dynamic subtest ccs0: SUCCESS (0.000s)
[671.304559] Subtest init-sema: SUCCESS (0.008s)
[671.344516] [071/133] (349s left) kms_force_connector_basic (prune-stale-modes)
[671.431732] Starting subtest: prune-stale-modes
[671.872859] Subtest prune-stale-modes: SUCCESS (0.443s)
[672.010379] [072/133] (349s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[672.065275] Subtest no-spare-fences-busy: SKIP (0.000s)
[672.135372] [073/133] (349s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[672.219224] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[672.222908] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[673.370138] [074/133] (347s left) i915_pm_freq_api (freq-suspend)
[673.429758] Starting subtest: freq-suspend
[673.432187] Starting dynamic subtest: gt0
[689.903327] Dynamic subtest gt0: SUCCESS (2.043s)
[689.919664] Starting dynamic subtest: gt1
[705.926961] Dynamic subtest gt1: SUCCESS (1.198s)
[705.929312] Subtest freq-suspend: SUCCESS (3.244s)
[706.001862] [075/133] (315s left) kms_cursor_edge_walk (256x256-top-bottom)
[706.100580] Starting subtest: 256x256-top-bottom
[706.102893] Starting dynamic subtest: pipe-A-eDP-1
[709.489834] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[709.499936] Starting dynamic subtest: pipe-D-eDP-1
[712.588202] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.146s)
[712.590313] Subtest 256x256-top-bottom: SUCCESS (6.613s)
[713.385374] [076/133] (307s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[713.473694] Starting subtest: psr-rgb565-draw-pwrite
[720.374823] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.958s)
[720.488404] [077/133] (300s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[720.677541] Starting subtest: cursor-rapid-movement-64x64
[720.682252] Starting dynamic subtest: pipe-A-eDP-1
[721.233839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[721.279766] Starting dynamic subtest: pipe-D-eDP-1
[722.470896] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s)
[722.473185] Subtest cursor-rapid-movement-64x64: SUCCESS (1.798s)
[723.323281] [078/133] (298s left) gem_ctx_persistence (legacy-engines-queued)
[723.413502] Starting subtest: legacy-engines-queued
[723.415691] Starting dynamic subtest: render
[723.597282] Dynamic subtest render: SUCCESS (0.185s)
[723.611076] Starting dynamic subtest: bsd1
[725.100439] Dynamic subtest bsd1: SUCCESS (1.504s)
[725.113747] Starting dynamic subtest: bsd2
[727.084352] Dynamic subtest bsd2: SUCCESS (1.985s)
[727.098064] Starting dynamic subtest: blt
[727.128576] Dynamic subtest blt: SUCCESS (0.042s)
[727.142560] Starting dynamic subtest: vebox
[729.131252] Dynamic subtest vebox: SUCCESS (2.002s)
[729.134276] Subtest legacy-engines-queued: SUCCESS (5.735s)
[729.241636] [079/133] (292s left) kms_flip (2x-flip-vs-fences-interruptible)
[729.354165] Starting subtest: 2x-flip-vs-fences-interruptible
[729.358805] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[729.450032] [080/133] (292s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[729.548844] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[729.551113] Starting dynamic subtest: pipe-A-eDP-1
[729.634218] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[729.644673] Starting dynamic subtest: pipe-B-eDP-1
[730.815540] Dynamic subtest pipe-B-eDP-1: SKIP (1.182s)
[730.819998] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.272s)
[732.075197] [081/133] (289s left) syncobj_timeline (etime-multi-wait-submitted)
[732.134013] Starting subtest: etime-multi-wait-submitted
[732.241782] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[732.319613] [082/133] (289s left) gem_render_copy (linear-to-vebox-yf-tiled)
[732.390423] Starting subtest: linear-to-vebox-yf-tiled
[732.394540] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[732.583703] [083/133] (289s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[732.675475] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[732.677629] Starting dynamic subtest: pipe-A-eDP-1
[732.697250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[732.708345] Starting dynamic subtest: pipe-B-eDP-1
[732.727609] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[732.737978] Starting dynamic subtest: pipe-C-eDP-1
[732.757585] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[732.767980] Starting dynamic subtest: pipe-D-eDP-1
[732.787552] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[732.789729] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[734.968715] [084/133] (286s left) kms_psr (psr-cursor-render)
[735.061994] Starting subtest: psr-cursor-render
[735.064205] Starting dynamic subtest: eDP-1
[736.737114] Dynamic subtest eDP-1: SUCCESS (1.677s)
[736.739381] Subtest psr-cursor-render: SUCCESS (1.678s)
[737.571754] [085/133] (284s left) kms_atomic (atomic-invalid-params)
[737.681631] Starting subtest: atomic-invalid-params
[737.683831] Starting dynamic subtest: pipe-A-eDP-1
[738.071899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[738.074192] Subtest atomic-invalid-params: SUCCESS (0.392s)
[738.873776] [086/133] (282s left) gem_exec_schedule (semaphore-power)
[739.069048] Subtest semaphore-power: SKIP (0.000s)
[739.250786] [087/133] (282s left) api_intel_allocator (default-alignment)
[739.324347] Starting subtest: default-alignment
[739.326327] Subtest default-alignment: SUCCESS (0.004s)
[739.463197] [088/133] (282s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[739.565679] Starting subtest: yf-tiled-32bpp-rotate-90
[739.570002] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[739.654280] [089/133] (282s left) gem_mmap_wc (copy)
[739.705811] Subtest copy: SKIP (0.000s)
[739.766878] [090/133] (282s left) gem_exec_whisper (basic-queues-forked-all)
[739.824991] Starting subtest: basic-queues-forked-all
[759.402763] Subtest basic-queues-forked-all: SUCCESS (19.575s)
[759.588365] [091/133] (262s left) kms_plane_scaling (intel-max-src-size)
[759.683137] Starting subtest: intel-max-src-size
[759.689369] Subtest intel-max-src-size: SKIP (0.000s)
[759.792194] [092/133] (262s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[759.882555] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[766.790253] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.911s)
[766.947195] [093/133] (255s left) kms_psr (fbc-psr2-sprite-render)
[767.034494] Starting subtest: fbc-psr2-sprite-render
[767.036623] Starting dynamic subtest: eDP-1
[767.040586] Dynamic subtest eDP-1: SKIP (0.000s)
[767.044529] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[767.108274] [094/133] (254s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[767.200061] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[767.204175] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[767.298041] [095/133] (254s left) gem_pread (self)
[767.349422] Subtest self: SKIP (0.000s)
[767.407074] [096/133] (254s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[767.498584] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[767.502736] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[767.586148] [097/133] (254s left) kms_prop_blob (invalid-set-prop)
[767.646665] Starting subtest: invalid-set-prop
[767.649010] Subtest invalid-set-prop: SUCCESS (0.000s)
[767.746603] [098/133] (254s left) fbdev (unaligned-write)
[767.784052] Starting subtest: unaligned-write
[767.950293] Subtest unaligned-write: SUCCESS (0.163s)
[768.014240] [099/133] (254s left) kms_plane (pixel-format-x-tiled-modifier)
[768.111899] Starting subtest: pixel-format-x-tiled-modifier
[768.139401] Starting dynamic subtest: pipe-A-plane-0
[768.760369] Dynamic subtest pipe-A-plane-0: SUCCESS (0.621s)
[768.772499] Starting dynamic subtest: pipe-A-plane-3
[769.183523] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[769.193504] Starting dynamic subtest: pipe-A-plane-5
[769.197358] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[770.328436] Starting dynamic subtest: pipe-B-plane-0
[771.020612] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[771.031389] Starting dynamic subtest: pipe-B-plane-3
[771.422226] Dynamic subtest pipe-B-plane-3: SUCCESS (0.398s)
[771.435793] Starting dynamic subtest: pipe-B-plane-5
[771.439750] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[771.739314] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.629s)
[772.571499] [100/133] (249s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[772.634998] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[772.713652] [101/133] (249s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[772.800435] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[776.537988] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.742s)
[777.680421] [102/133] (244s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[777.773790] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[777.793540] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.018s)
[777.871491] [103/133] (244s left) core_getversion (all-cards)
[777.914697] Starting subtest: all-cards
[777.921680] Subtest all-cards: SUCCESS (0.011s)
[777.972261] [104/133] (244s left) gem_exec_reloc (basic-wc-read-noreloc)
[778.041354] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[778.115666] [105/133] (244s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[778.213272] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[778.217555] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[778.310613] [106/133] (244s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[778.402989] Starting subtest: x-tiled-16bpp-rotate-90
[778.425391] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[778.527443] [107/133] (244s left) kms_feature_discovery (display-1x)
[778.627719] Starting subtest: display-1x
[778.629323] Subtest display-1x: SUCCESS (0.000s)
[778.730173] [108/133] (243s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[778.846522] Starting subtest: cursorA-vs-flipB-varying-size
[778.850291] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[778.989629] [109/133] (243s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[779.076898] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[779.080475] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[779.150792] [110/133] (243s left) kms_psr2_su (page_flip-xrgb8888)
[779.212490] Subtest page_flip-XRGB8888: SKIP (0.000s)
[779.282823] [111/133] (243s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[779.384544] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[779.388086] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[779.478484] [112/133] (243s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[779.568419] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[783.921476] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.357s)
[785.066347] [113/133] (237s left) i915_drm_fdinfo (isolation)
[785.105476] Starting subtest: isolation
[785.107714] Starting dynamic subtest: rcs0
[785.121558] Dynamic subtest rcs0: SKIP (0.017s)
[785.133409] Starting dynamic subtest: bcs0
[785.137370] Dynamic subtest bcs0: SKIP (0.011s)
[785.147405] Starting dynamic subtest: vcs0
[785.151654] Dynamic subtest vcs0: SKIP (0.000s)
[785.162049] Starting dynamic subtest: vcs1
[785.165991] Dynamic subtest vcs1: SKIP (0.000s)
[785.175570] Starting dynamic subtest: vecs0
[785.180608] Dynamic subtest vecs0: SKIP (0.000s)
[785.190989] Starting dynamic subtest: ccs0
[785.195467] Dynamic subtest ccs0: SKIP (0.000s)
[785.199563] Subtest isolation: SKIP (0.032s)
[785.237546] [114/133] (237s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[785.342984] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[785.347147] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[785.443576] [115/133] (237s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[785.556800] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[789.953726] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.403s)
[791.165206] [116/133] (231s left) kms_big_fb (4-tiled-addfb)
[791.270223] Starting subtest: 4-tiled-addfb
[791.272403] Subtest 4-tiled-addfb: SUCCESS (0.001s)
[791.369510] [117/133] (231s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[791.474214] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[791.478541] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[791.570090] [118/133] (231s left) kms_cursor_crc (cursor-offscreen-512x512)
[791.835390] Starting subtest: cursor-offscreen-512x512
[791.839745] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[792.002352] [119/133] (231s left) gem_mmap (bad-size)
[792.050568] Subtest bad-size: SKIP (0.000s)
[792.120866] [120/133] (231s left) gem_mmap_offset (blt-coherency)
[792.168292] Starting subtest: blt-coherency
[792.172721] Subtest blt-coherency: SUCCESS (0.007s)
[792.312914] [121/133] (230s left) api_intel_bb (simple-bb-ctx)
[792.369519] Starting subtest: simple-bb-ctx
[792.376452] Subtest simple-bb-ctx: SUCCESS (0.009s)
[792.486820] [122/133] (230s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[792.575296] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[792.578828] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[792.686288] [123/133] (230s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[792.775742] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[792.779419] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[792.842884] [124/133] (230s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[792.935017] Starting subtest: fbc-pr-sprite-mmap-gtt
[792.938562] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[793.023349] [125/133] (230s left) kms_psr (pr-primary-mmap-gtt)
[793.124007] Starting subtest: pr-primary-mmap-gtt
[793.127695] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[793.196687] [126/133] (230s left) kms_pipe_crc_basic (suspend-read-crc)
[793.280131] Starting subtest: suspend-read-crc
[793.282024] Starting dynamic subtest: pipe-A-eDP-1
[810.819748] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.519s)
[810.830752] Starting dynamic subtest: pipe-B-eDP-1
[828.809413] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.153s)
[828.821829] Starting dynamic subtest: pipe-C-eDP-1
[846.757833] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.058s)
[846.771849] Starting dynamic subtest: pipe-D-eDP-1
[864.760344] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.108s)
[864.762604] Subtest suspend-read-crc: SUCCESS (11.845s)
[865.626345] [127/133] (157s left) kms_chamelium_hpd (hdmi-hpd-storm)
[866.006284] Subtest hdmi-hpd-storm: SKIP (0.000s)
[866.781781] [128/133] (156s left) gem_wait (write-busy)
[866.849000] Starting subtest: write-busy
[866.851339] Starting dynamic subtest: all-engines
[867.462071] Dynamic subtest all-engines: SUCCESS (0.623s)
[867.475132] Starting dynamic subtest: rcs0
[868.026084] Dynamic subtest rcs0: SUCCESS (0.570s)
[868.044258] Starting dynamic subtest: bcs0
[868.580114] Dynamic subtest bcs0: SUCCESS (0.561s)
[868.597711] Starting dynamic subtest: vcs0
[869.966320] Dynamic subtest vcs0: SUCCESS (1.402s)
[869.982128] Starting dynamic subtest: vcs1
[871.950700] Dynamic subtest vcs1: SUCCESS (2.002s)
[871.968373] Starting dynamic subtest: vecs0
[873.998753] Dynamic subtest vecs0: SUCCESS (2.062s)
[874.017265] Starting dynamic subtest: ccs0
[874.550570] Dynamic subtest ccs0: SUCCESS (0.554s)
[874.552714] Subtest write-busy: SUCCESS (7.788s)
[874.757229] [129/133] (148s left) gem_userptr_blits (relocations)
[874.823422] Starting subtest: relocations
[874.827952] Subtest relocations: SKIP (0.000s)
[874.972691] [130/133] (148s left) gem_eio (wait-immediate)
[875.174032] Starting subtest: wait-immediate
[875.507809] Subtest wait-immediate: SUCCESS (0.335s)
[875.647947] [131/133] (147s left) gem_userptr_blits (create-destroy-unsync)
[875.709206] Subtest create-destroy-unsync: SKIP (0.000s)
[875.850349] [132/133] (147s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[875.949493] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[883.107425] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.188s)
[883.236588] [133/133] (140s left) gem_exec_reloc (basic-wc)
[883.297421] Subtest basic-wc: SKIP (0.000s)
[883.394183] 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.