[57.850883] Initializing watchdogs
[57.850977]   /dev/watchdog0
[57.864027] [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.868239] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.870432] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.874304] [001/131] (960s left) gem_eio (in-flight-suspend)
[58.035801] Starting subtest: in-flight-suspend
[101.452429] Subtest in-flight-suspend: SUCCESS (14.615s)
[101.588519] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[101.591954] [002/131] (916s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[106.639697] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[106.644631] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.003s)
[107.491674] [003/131] (910s left) prime_vgem (busy)
[107.581501] Starting subtest: busy
[107.584546] Starting dynamic subtest: rcs0
[107.623042] Dynamic subtest rcs0: SUCCESS (0.042s)
[107.631448] Starting dynamic subtest: bcs0
[107.708287] Dynamic subtest bcs0: SUCCESS (0.085s)
[107.716410] Starting dynamic subtest: vcs0
[107.756242] Dynamic subtest vcs0: SUCCESS (0.047s)
[107.764940] Starting dynamic subtest: vcs1
[107.801438] Dynamic subtest vcs1: SUCCESS (0.045s)
[107.809237] Starting dynamic subtest: vecs0
[107.850391] Dynamic subtest vecs0: SUCCESS (0.048s)
[107.858340] Starting dynamic subtest: ccs0
[107.901621] Dynamic subtest ccs0: SUCCESS (0.051s)
[107.904320] Subtest busy: SUCCESS (0.320s)
[108.044300] [004/131] (910s left) kms_pm_dc (dc5-psr)
[109.140392] Starting subtest: dc5-psr
[112.027663] Subtest dc5-psr: SUCCESS (2.887s)
[112.829188] [005/131] (905s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[112.892582] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[113.001093] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[113.074858] [006/131] (905s left) prime_vgem (basic-gtt)
[113.170489] Starting subtest: basic-gtt
[113.175507] Subtest basic-gtt: SKIP (0.000s)
[113.272712] [007/131] (905s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[113.370212] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[113.372620] Starting dynamic subtest: pipe-A-default-mode
[116.094496] Dynamic subtest pipe-A-default-mode: SUCCESS (2.720s)
[116.097365] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.721s)
[116.933890] [008/131] (901s left) gem_exec_params (sol-reset-not-gen7)
[116.995295] Starting subtest: sol-reset-not-gen7
[117.001105] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[117.141198] [009/131] (901s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[117.232582] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[117.245090] Starting dynamic subtest: pipe-A-eDP-1
[117.274993] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[117.283629] Starting dynamic subtest: pipe-B-eDP-1
[117.307718] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[117.315737] Starting dynamic subtest: pipe-C-eDP-1
[117.340854] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[117.349476] Starting dynamic subtest: pipe-D-eDP-1
[117.374265] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[117.379321] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.002s)
[119.413986] [010/131] (899s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[119.532392] Starting subtest: cursorA-vs-flipA-atomic
[130.701491] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.168s)
[131.556862] [011/131] (887s left) api_intel_bb (bb-with-allocator)
[131.622107] Starting subtest: bb-with-allocator
[131.627975] Subtest bb-with-allocator: SUCCESS (0.007s)
[131.766830] [012/131] (887s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[131.863341] Starting subtest: fbc-pr-sprite-mmap-cpu
[131.868598] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[131.934906] [013/131] (886s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[132.037571] Starting subtest: 2x-flip-vs-cursor-legacy
[132.042725] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[132.179054] [014/131] (886s left) kms_psr (fbc-psr2-primary-page-flip)
[132.279775] Starting subtest: fbc-psr2-primary-page-flip
[132.282566] Starting dynamic subtest: eDP-1
[132.287569] Dynamic subtest eDP-1: SKIP (0.000s)
[132.292393] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[132.347758] [015/131] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[132.449332] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[132.454540] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[132.554332] [016/131] (886s left) kms_joiner (invalid-modeset-force-big-joiner)
[132.643149] Starting subtest: invalid-modeset-force-big-joiner
[132.644995] Starting dynamic subtest: big_joiner_on_last_pipe
[132.972242] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.335s)
[132.974927] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.335s)
[133.808009] [017/131] (885s left) i915_pm_rc6_residency (rc6-idle)
[133.857347] Starting subtest: rc6-idle
[133.897831] Starting dynamic subtest: gt0-rcs0
[158.257372] Dynamic subtest gt0-rcs0: SUCCESS (24.359s)
[158.265729] Starting dynamic subtest: gt0-bcs0
[182.468587] Dynamic subtest gt0-bcs0: SUCCESS (24.209s)
[182.479580] Starting dynamic subtest: gt0-ccs0
[206.739021] Dynamic subtest gt0-ccs0: SUCCESS (24.269s)
[206.747351] Starting dynamic subtest: gt1-vcs0
[212.963443] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[212.975848] Starting dynamic subtest: gt1-vecs0
[219.133015] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[219.135726] Subtest rc6-idle: SUCCESS (85.224s)
[219.173291] [018/131] (799s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[219.295376] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[219.300385] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[219.439392] [019/131] (799s left) gem_eio (execbuf)
[219.635861] Starting subtest: execbuf
[219.901891] Subtest execbuf: SUCCESS (0.266s)
[220.061909] [020/131] (799s left) gem_lmem_swapping (verify-random-ccs)
[220.099826] Subtest verify-random-ccs: SKIP (0.000s)
[220.150044] [021/131] (799s left) gem_exec_gttfill (basic)
[220.210177] Starting subtest: basic
[222.687014] Subtest basic: SUCCESS (2.476s)
[222.879660] [022/131] (796s left) kms_addfb_basic (bad-pitch-999)
[222.977851] Starting subtest: bad-pitch-999
[222.980525] Subtest bad-pitch-999: SUCCESS (0.000s)
[223.145581] [023/131] (796s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[223.204772] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[223.209593] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[223.380982] [024/131] (795s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[223.931898] Starting subtest: syncobj-timeline-invalid-flags
[223.934377] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[225.780359] [025/131] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[225.882026] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[233.036495] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.158s)
[233.184484] [026/131] (786s left) syncobj_timeline (signal-point-0)
[233.247590] Starting subtest: signal-point-0
[233.250733] Subtest signal-point-0: SUCCESS (0.000s)
[233.348819] [027/131] (786s left) gem_spin_batch (legacy-resubmit)
[233.415547] Starting subtest: legacy-resubmit
[233.418271] Starting dynamic subtest: default
[233.423459] Dynamic subtest default: SUCCESS (0.007s)
[233.434178] Starting dynamic subtest: render
[233.436351] Dynamic subtest render: SUCCESS (0.001s)
[233.445319] Starting dynamic subtest: bsd
[233.447616] Dynamic subtest bsd: SUCCESS (0.002s)
[233.456711] Starting dynamic subtest: bsd1
[233.459496] Dynamic subtest bsd1: SUCCESS (0.002s)
[233.468452] Starting dynamic subtest: bsd2
[233.471109] Dynamic subtest bsd2: SUCCESS (0.002s)
[233.479593] Starting dynamic subtest: blt
[233.482656] Dynamic subtest blt: SUCCESS (0.004s)
[233.491358] Starting dynamic subtest: vebox
[233.493787] Dynamic subtest vebox: SUCCESS (0.003s)
[233.496397] Subtest legacy-resubmit: SUCCESS (0.023s)
[233.664252] [028/131] (785s left) perf_pmu (interrupts)
[233.701343] Starting subtest: interrupts
[234.783561] Subtest interrupts: SUCCESS (1.082s)
[234.887148] [029/131] (784s left) gem_exec_reloc (basic-concurrent16)
[234.942563] Subtest basic-concurrent16: SKIP (0.000s)
[235.025010] [030/131] (784s left) gem_exec_await (wide-contexts)
[235.201692] Starting subtest: wide-contexts
[258.414613] Subtest wide-contexts: SUCCESS (23.211s)
[258.611207] [031/131] (760s left) gem_reg_read (timestamp-moving)
[258.705422] Starting subtest: timestamp-moving
[259.707210] Subtest timestamp-moving: SUCCESS (1.001s)
[259.786501] [032/131] (759s left) gem_render_copy_redux (flink-interruptible)
[259.857450] Starting subtest: flink-interruptible
[261.124514] Subtest flink-interruptible: SUCCESS (1.266s)
[261.255780] [033/131] (758s left) vgem_basic (dmabuf-fence-before)
[261.318083] Starting subtest: dmabuf-fence-before
[261.320140] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[261.381176] [034/131] (758s left) vgem_basic (bad-handle)
[261.418886] Starting subtest: bad-handle
[261.421059] Subtest bad-handle: SUCCESS (0.000s)
[261.475508] [035/131] (758s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[261.568095] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[261.578884] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[261.662894] [036/131] (758s left) gem_ctx_param (invalid-size-get)
[261.715387] Starting subtest: invalid-size-get
[261.717891] Subtest invalid-size-get: SUCCESS (0.001s)
[261.801050] [037/131] (758s left) gem_mmap_wc (close)
[261.856871] Subtest close: SKIP (0.000s)
[261.926935] [038/131] (757s left) core_sysfs (read-all-entries)
[261.976768] Starting subtest: read-all-entries
[261.978830] Subtest read-all-entries: SUCCESS (0.003s)
[262.080896] [039/131] (757s left) gem_softpin (overlap)
[262.134495] Starting subtest: overlap
[263.038241] Subtest overlap: SUCCESS (0.902s)
[263.180598] [040/131] (756s left) gem_pread (display)
[263.244499] Subtest display: SKIP (0.000s)
[263.312330] [041/131] (756s left) kms_busy (basic-hang)
[263.411554] Starting subtest: basic-hang
[263.414363] Starting dynamic subtest: flip-pipe-A
[264.106471] Dynamic subtest flip-pipe-A: SUCCESS (0.696s)
[264.119525] Starting dynamic subtest: modeset-pipe-A
[267.547665] Dynamic subtest modeset-pipe-A: SUCCESS (3.439s)
[267.558110] Starting dynamic subtest: flip-pipe-D
[268.741391] Dynamic subtest flip-pipe-D: SUCCESS (1.194s)
[268.752740] Starting dynamic subtest: modeset-pipe-D
[272.170768] Dynamic subtest modeset-pipe-D: SUCCESS (3.428s)
[272.173365] Subtest basic-hang: SUCCESS (8.760s)
[272.974978] [042/131] (747s left) gem_exec_schedule (submit-golden-slice)
[273.043205] Starting subtest: submit-golden-slice
[273.046093] Starting dynamic subtest: rcs0
[273.077007] Dynamic subtest rcs0: SUCCESS (0.045s)
[273.089491] Starting dynamic subtest: bcs0
[273.111260] Dynamic subtest bcs0: SUCCESS (0.034s)
[273.120335] Starting dynamic subtest: vcs0
[273.143641] Dynamic subtest vcs0: SUCCESS (0.032s)
[273.153206] Starting dynamic subtest: vcs1
[273.176923] Dynamic subtest vcs1: SUCCESS (0.033s)
[273.187337] Starting dynamic subtest: vecs0
[273.210524] Dynamic subtest vecs0: SUCCESS (0.033s)
[273.219603] Starting dynamic subtest: ccs0
[273.248387] Dynamic subtest ccs0: SUCCESS (0.038s)
[273.250964] Subtest submit-golden-slice: SUCCESS (0.217s)
[274.822893] [043/131] (745s left) syncobj_timeline (single-wait-signaled)
[274.877555] Starting subtest: single-wait-signaled
[274.879901] Subtest single-wait-signaled: SUCCESS (0.000s)
[274.976556] [044/131] (745s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[275.075479] Starting subtest: fbcpsr-shrfb-scaledprimary
[282.862566] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (7.790s)
[283.021876] [045/131] (737s left) kms_sequence (get-busy)
[283.123043] Starting subtest: get-busy
[283.125440] Starting dynamic subtest: pipe-A-eDP-1
[285.060573] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[285.072145] Starting dynamic subtest: pipe-B-eDP-1
[287.690330] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.628s)
[287.701011] Starting dynamic subtest: pipe-C-eDP-1
[290.305221] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[290.316868] Starting dynamic subtest: pipe-D-eDP-1
[292.941068] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.635s)
[292.943509] Subtest get-busy: SUCCESS (9.819s)
[293.732475] [046/131] (726s left) vgem_basic (create)
[293.787461] Starting subtest: create
[293.790613] Subtest create: SUCCESS (0.000s)
[293.843769] [047/131] (726s left) perf (invalid-open-flags)
[293.975395] Starting subtest: invalid-open-flags
[293.977899] Subtest invalid-open-flags: SUCCESS (0.000s)
[294.018161] [048/131] (726s left) kms_big_fb (linear-32bpp-rotate-90)
[294.127885] Starting subtest: linear-32bpp-rotate-90
[294.146945] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[294.280966] [049/131] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[294.379248] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[294.383969] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[294.493355] [050/131] (725s left) gem_ctx_persistence (legacy-engines-hang)
[294.553489] Starting subtest: legacy-engines-hang
[294.555859] Starting dynamic subtest: render
[294.594618] Dynamic subtest render: SUCCESS (0.042s)
[294.606442] Starting dynamic subtest: bsd1
[294.760750] Dynamic subtest bsd1: SUCCESS (0.165s)
[294.773764] Starting dynamic subtest: bsd2
[294.877756] Dynamic subtest bsd2: SUCCESS (0.115s)
[294.890527] Starting dynamic subtest: blt
[294.993733] Dynamic subtest blt: SUCCESS (0.114s)
[295.007037] Starting dynamic subtest: vebox
[295.099726] Dynamic subtest vebox: SUCCESS (0.104s)
[295.102174] Subtest legacy-engines-hang: SUCCESS (0.548s)
[295.180848] [051/131] (725s left) kms_plane_scaling (planes-scaler-unity-scaling)
[295.278541] Starting subtest: planes-scaler-unity-scaling
[295.280694] Starting dynamic subtest: pipe-A
[295.343183] Dynamic subtest pipe-A: SUCCESS (0.067s)
[295.353207] Starting dynamic subtest: pipe-B
[296.457498] Dynamic subtest pipe-B: SUCCESS (1.112s)
[296.469315] Starting dynamic subtest: pipe-C
[297.569313] Dynamic subtest pipe-C: SUCCESS (1.111s)
[297.582160] Starting dynamic subtest: pipe-D
[298.698994] Dynamic subtest pipe-D: SUCCESS (1.129s)
[298.701317] Subtest planes-scaler-unity-scaling: SUCCESS (3.424s)
[299.857780] [052/131] (720s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[299.955050] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[306.865073] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SUCCESS (6.913s)
[307.033979] [053/131] (713s left) gem_mmap (bad-object)
[307.104323] Subtest bad-object: SKIP (0.000s)
[307.164601] [054/131] (713s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[307.217594] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[307.319339] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[307.400347] [055/131] (713s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[307.489473] Starting subtest: y-tiled-8bpp-rotate-180
[307.494579] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[307.580949] [056/131] (713s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[307.670254] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[307.672730] Starting dynamic subtest: pipe-A-eDP-1
[307.916561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.207s)
[307.937629] Starting dynamic subtest: pipe-B-eDP-1
[309.140118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.226s)
[309.151647] Starting dynamic subtest: pipe-C-eDP-1
[310.351379] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[310.361653] Starting dynamic subtest: pipe-D-eDP-1
[311.586140] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[311.588358] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.878s)
[312.702120] [057/131] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[312.808551] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[312.813654] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[312.913342] [058/131] (707s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[313.010455] Starting subtest: drrs-dirtyfb-ioctl
[313.024542] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[313.104857] [059/131] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[313.206816] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[313.210903] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[313.322900] [060/131] (707s left) gem_exec_capture (capture)
[313.392760] Starting subtest: capture
[313.395539] Starting dynamic subtest: rcs0-smem
[314.220475] Dynamic subtest rcs0-smem: SUCCESS (0.830s)
[314.231395] Starting dynamic subtest: bcs0-smem
[315.544088] Dynamic subtest bcs0-smem: SUCCESS (1.321s)
[315.553069] Starting dynamic subtest: vcs0-smem
[316.367363] Dynamic subtest vcs0-smem: SUCCESS (0.822s)
[316.376476] Starting dynamic subtest: vcs1-smem
[317.681633] Dynamic subtest vcs1-smem: SUCCESS (1.314s)
[317.692283] Starting dynamic subtest: vecs0-smem
[318.579860] Dynamic subtest vecs0-smem: FAIL (0.830s)
[318.590287] Starting dynamic subtest: ccs0-smem
[319.835543] Dynamic subtest ccs0-smem: SUCCESS (1.323s)
[319.838548] Subtest capture: FAIL (6.444s)
[319.971118] [061/131] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[320.075513] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[320.080615] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[320.167051] [062/131] (700s left) sw_sync (sync_merge_same)
[320.196863] Starting subtest: sync_merge_same
[320.199181] Subtest sync_merge_same: SUCCESS (0.001s)
[320.251982] [063/131] (700s left) gem_eio (kms)
[320.459112] Starting subtest: kms
[341.750383] Subtest kms: SUCCESS (21.291s)
[342.929245] [064/131] (678s left) gem_softpin (noreloc)
[342.979492] Starting subtest: noreloc
[348.453463] Subtest noreloc: SUCCESS (5.421s)
[348.589296] [065/131] (672s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[348.963465] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[349.741190] [066/131] (671s left) kms_invalid_mode (bad-hsync-end)
[349.839342] Starting subtest: bad-hsync-end
[349.841702] Starting dynamic subtest: pipe-A-eDP-1
[350.122516] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[350.133633] Starting dynamic subtest: pipe-B-eDP-1
[350.136427] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[350.145983] Starting dynamic subtest: pipe-C-eDP-1
[350.148553] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[350.158007] Starting dynamic subtest: pipe-D-eDP-1
[350.160701] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[350.163722] Subtest bad-hsync-end: SUCCESS (0.288s)
[350.989076] [067/131] (670s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[351.375320] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[352.216074] [068/131] (668s left) i915_fb_tiling (basic-x-tiling)
[352.269302] Subtest basic-x-tiling: SKIP (0.000s)
[352.328939] [069/131] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[352.429370] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[352.434164] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[352.543192] [070/131] (668s left) gem_caching (reads)
[352.619483] Subtest reads: SKIP (0.000s)
[352.710062] [071/131] (668s left) kms_tv_load_detect (load-detect)
[352.772470] Subtest load-detect: SKIP (0.000s)
[352.838723] [072/131] (668s left) gem_ctx_shared (detached-shared-gtt)
[352.905744] Starting subtest: detached-shared-gtt
[355.059293] Subtest detached-shared-gtt: SUCCESS (2.152s)
[355.411070] [073/131] (665s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[355.506972] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[355.519388] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[355.629510] [074/131] (665s left) gem_ctx_exec (basic-nohangcheck)
[355.687342] Starting subtest: basic-nohangcheck
[355.941626] Subtest basic-nohangcheck: SUCCESS (0.257s)
[356.080015] [075/131] (665s left) dumb_buffer (map-uaf)
[356.135983] Starting subtest: map-uaf
[356.138498] Subtest map-uaf: SUCCESS (0.004s)
[356.243509] [076/131] (665s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[356.335544] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[356.337875] Starting dynamic subtest: pipe-A-default-mode
[356.692666] Dynamic subtest pipe-A-default-mode: SKIP (0.354s)
[356.697550] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.355s)
[357.446347] [077/131] (664s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[357.541052] Starting subtest: random-ccs-data-yf-tiled-ccs
[357.543390] Starting dynamic subtest: pipe-A-eDP-1
[357.570508] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.581531] Starting dynamic subtest: pipe-B-eDP-1
[357.608094] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.618914] Starting dynamic subtest: pipe-C-eDP-1
[357.647922] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.659442] Starting dynamic subtest: pipe-D-eDP-1
[357.687444] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.692379] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[359.726214] [078/131] (661s left) syncobj_timeline (multi-wait-all-signaled)
[359.785252] Starting subtest: multi-wait-all-signaled
[359.788268] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[359.882056] [079/131] (661s left) core_auth (many-magics)
[359.931282] Starting subtest: many-magics
[360.755125] Subtest many-magics: SUCCESS (0.826s)
[360.839858] [080/131] (660s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[360.938074] Starting subtest: fbc-psr-sprite-mmap-gtt
[360.940051] Starting dynamic subtest: eDP-1
[360.943728] Dynamic subtest eDP-1: SKIP (0.000s)
[360.947445] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[361.009033] [081/131] (660s left) gem_wait (busy)
[361.072101] Starting subtest: busy
[361.074351] Starting dynamic subtest: all-engines
[362.708415] Dynamic subtest all-engines: SUCCESS (1.634s)
[362.720733] Starting dynamic subtest: rcs0
[363.248992] Dynamic subtest rcs0: SUCCESS (0.540s)
[363.260206] Starting dynamic subtest: bcs0
[363.789501] Dynamic subtest bcs0: SUCCESS (0.540s)
[363.799157] Starting dynamic subtest: vcs0
[365.715241] Dynamic subtest vcs0: SUCCESS (1.925s)
[365.726285] Starting dynamic subtest: vcs1
[367.700901] Dynamic subtest vcs1: SUCCESS (1.981s)
[367.711600] Starting dynamic subtest: vecs0
[369.684266] Dynamic subtest vecs0: SUCCESS (1.981s)
[369.696451] Starting dynamic subtest: ccs0
[370.226050] Dynamic subtest ccs0: SUCCESS (0.541s)
[370.229024] Subtest busy: SUCCESS (9.153s)
[370.425363] [082/131] (651s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[370.812716] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[371.638335] [083/131] (650s left) kms_cursor_crc (cursor-dpms)
[371.768752] Starting subtest: cursor-dpms
[371.771722] Starting dynamic subtest: pipe-A-eDP-1
[374.747611] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.976s)
[374.758629] Starting dynamic subtest: pipe-D-eDP-1
[378.324585] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.577s)
[378.327208] Subtest cursor-dpms: SUCCESS (6.555s)
[379.175448] [084/131] (642s left) gem_exec_balancer (invalid-balancer)
[379.239630] Starting subtest: invalid-balancer
[380.084147] Subtest invalid-balancer: SUCCESS (0.842s)
[380.401223] [085/131] (641s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[385.454250] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[385.459468] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[386.316779] [086/131] (635s left) kms_psr (pr-sprite-render)
[386.412001] Starting subtest: pr-sprite-render
[386.416630] Subtest pr-sprite-render: SKIP (0.000s)
[386.486189] [087/131] (635s left) kms_vblank (query-idle)
[386.576371] Starting subtest: query-idle
[386.578530] Starting dynamic subtest: pipe-A-eDP-1
[388.316960] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.740s)
[388.330607] Starting dynamic subtest: pipe-D-eDP-1
[390.766404] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.445s)
[390.769168] Subtest query-idle: SUCCESS (4.192s)
[391.577846] [088/131] (630s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[391.678459] Starting subtest: disable-crc-after-crtc
[391.680764] Starting dynamic subtest: pipe-A-eDP-1
[393.310225] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.630s)
[393.321813] Starting dynamic subtest: pipe-B-eDP-1
[395.572346] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.263s)
[395.583004] Starting dynamic subtest: pipe-C-eDP-1
[397.833092] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.255s)
[397.842727] Starting dynamic subtest: pipe-D-eDP-1
[400.086275] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.253s)
[400.088651] Subtest disable-crc-after-crtc: SUCCESS (8.408s)
[400.924385] [089/131] (621s left) gem_softpin (allocator-basic-reserve)
[400.984086] Starting subtest: allocator-basic-reserve
[401.046483] Subtest allocator-basic-reserve: SUCCESS (0.062s)
[401.192774] [090/131] (620s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[401.278551] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[401.280934] Starting dynamic subtest: pipe-A-eDP-1
[401.305884] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[401.315733] Starting dynamic subtest: pipe-B-eDP-1
[401.340879] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[401.349610] Starting dynamic subtest: pipe-C-eDP-1
[401.374852] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.383526] Starting dynamic subtest: pipe-D-eDP-1
[401.409587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.414621] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[403.504564] [091/131] (618s left) kms_addfb_basic (legacy-format)
[403.557300] Starting subtest: legacy-format
[403.590040] Subtest legacy-format: SUCCESS (0.029s)
[403.743794] [092/131] (618s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[403.843035] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[403.846941] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[403.937244] [093/131] (618s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[403.998960] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[404.001134] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[404.088353] [094/131] (618s left) gem_pxp (create-valid-protected-context)
[404.212192] Starting subtest: create-valid-protected-context
[404.214921] Subtest create-valid-protected-context: SUCCESS (0.002s)
[404.323650] [095/131] (617s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[404.424497] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[408.888711] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.469s)
[410.016830] [096/131] (612s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[410.104594] Starting subtest: plane-all-transition-nonblocking-fencing
[410.107168] Starting dynamic subtest: pipe-A-eDP-1
[412.606131] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[412.906342] Starting dynamic subtest: pipe-B-eDP-1
[416.141938] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.244s)
[416.454714] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.351s)
[417.269427] [097/131] (605s left) kms_cursor_crc (cursor-offscreen-max-size)
[417.567737] Starting subtest: cursor-offscreen-max-size
[417.575505] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[417.708887] [098/131] (604s left) kms_vblank (ts-continuation-modeset-hang)
[417.796383] Starting subtest: ts-continuation-modeset-hang
[417.798918] Starting dynamic subtest: pipe-A-eDP-1
[444.499548] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.698s)
[444.517502] Starting dynamic subtest: pipe-D-eDP-1
[469.456352] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.952s)
[469.458718] Subtest ts-continuation-modeset-hang: SUCCESS (51.654s)
[470.321504] [099/131] (552s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[470.425237] Starting subtest: x-tiled-64bpp-rotate-270
[470.443868] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[470.567941] [100/131] (551s left) perf_pmu (busy-start)
[470.614277] Starting subtest: busy-start
[470.616518] Starting dynamic subtest: rcs0
[473.166037] Dynamic subtest rcs0: SUCCESS (2.550s)
[473.178515] Starting dynamic subtest: bcs0
[475.736753] Dynamic subtest bcs0: SUCCESS (2.547s)
[475.748751] Starting dynamic subtest: vcs0
[479.700519] Dynamic subtest vcs0: SUCCESS (3.983s)
[479.713720] Starting dynamic subtest: vcs1
[483.732765] Dynamic subtest vcs1: SUCCESS (4.030s)
[483.745842] Starting dynamic subtest: vecs0
[487.700571] Dynamic subtest vecs0: SUCCESS (3.966s)
[487.713732] Starting dynamic subtest: ccs0
[490.270574] Dynamic subtest ccs0: SUCCESS (2.547s)
[490.273206] Subtest busy-start: SUCCESS (19.633s)
[490.357566] [101/131] (532s left) gem_mmap_gtt (flink-race)
[490.431914] Subtest flink-race: SKIP (0.000s)
[490.505236] [102/131] (532s left) gem_exec_whisper (basic-contexts-priority)
[490.568956] Starting subtest: basic-contexts-priority
[514.866748] Subtest basic-contexts-priority: SUCCESS (24.240s)
[514.996821] [103/131] (507s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[515.118036] Starting subtest: cursorB-vs-flipA-atomic
[515.123781] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[515.262954] [104/131] (507s left) kms_big_fb (yf-tiled-addfb)
[515.362034] Starting subtest: yf-tiled-addfb
[515.366491] Subtest yf-tiled-addfb: SKIP (0.000s)
[515.459444] [105/131] (507s left) gem_pwrite_snooped
[515.584972] [106/131] (507s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[515.695168] Starting subtest: psr-rgb565-draw-mmap-gtt
[515.699423] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[515.811115] [107/131] (506s left) gem_ccs (block-copy-compressed)
[515.876790] Starting subtest: block-copy-compressed
[515.881006] Subtest block-copy-compressed: SKIP (0.000s)
[515.986219] [108/131] (506s left) gem_ctx_param (invalid-ctx-set)
[516.036619] Starting subtest: invalid-ctx-set
[516.038893] Subtest invalid-ctx-set: SUCCESS (0.001s)
[516.140458] [109/131] (506s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[516.233017] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[522.693172] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.461s)
[522.817657] [110/131] (500s left) kms_rotation_crc (cursor-rotation-180)
[522.917722] Starting subtest: cursor-rotation-180
[524.503722] Subtest cursor-rotation-180: SUCCESS (1.587s)
[525.690799] [111/131] (497s left) kms_psr (psr2-sprite-mmap-cpu)
[525.772250] Starting subtest: psr2-sprite-mmap-cpu
[525.774603] Starting dynamic subtest: eDP-1
[527.485963] Dynamic subtest eDP-1: SUCCESS (1.710s)
[527.488016] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.711s)
[528.354111] [112/131] (494s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[528.460212] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[529.117617] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[529.288969] [113/131] (493s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[529.382611] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[529.385351] Starting dynamic subtest: pipe-A
[529.395193] Dynamic subtest pipe-A: SKIP (0.004s)
[529.404961] Starting dynamic subtest: pipe-B
[529.414542] Dynamic subtest pipe-B: SKIP (0.017s)
[529.423934] Starting dynamic subtest: pipe-C
[529.433604] Dynamic subtest pipe-C: SKIP (0.016s)
[529.442885] Starting dynamic subtest: pipe-D
[529.451280] Dynamic subtest pipe-D: SKIP (0.016s)
[529.455776] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.055s)
[529.520307] [114/131] (493s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[529.623263] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[533.639715] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.020s)
[534.771230] [115/131] (488s left) kms_prop_blob (blob-prop-lifetime)
[534.831060] Starting subtest: blob-prop-lifetime
[534.833752] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[534.939055] [116/131] (488s left) i915_pm_rps (thresholds-idle)
[534.999601] Starting subtest: thresholds-idle
[535.004217] Subtest thresholds-idle: SKIP (0.000s)
[535.077853] [117/131] (488s left) i915_drm_fdinfo (busy-idle)
[535.113439] Starting subtest: busy-idle
[535.116011] Starting dynamic subtest: rcs0
[535.155585] Dynamic subtest rcs0: SKIP (0.040s)
[535.167917] Starting dynamic subtest: bcs0
[535.173566] Dynamic subtest bcs0: SKIP (0.000s)
[535.186426] Starting dynamic subtest: vcs0
[535.191907] Dynamic subtest vcs0: SKIP (0.000s)
[535.201345] Starting dynamic subtest: vcs1
[535.206424] Dynamic subtest vcs1: SKIP (0.000s)
[535.215757] Starting dynamic subtest: vecs0
[535.221266] Dynamic subtest vecs0: SKIP (0.000s)
[535.230427] Starting dynamic subtest: ccs0
[535.235348] Dynamic subtest ccs0: SKIP (0.000s)
[535.240359] Subtest busy-idle: SKIP (0.045s)
[535.278591] [118/131] (487s left) perf_pmu (busy-idle-check-all)
[535.318518] Starting subtest: busy-idle-check-all
[535.321219] Starting dynamic subtest: rcs0
[536.000090] Dynamic subtest rcs0: SUCCESS (0.682s)
[536.013895] Starting dynamic subtest: bcs0
[536.653013] Dynamic subtest bcs0: SUCCESS (0.651s)
[536.665430] Starting dynamic subtest: vcs0
[538.708567] Dynamic subtest vcs0: SUCCESS (2.052s)
[538.721527] Starting dynamic subtest: vcs1
[540.692855] Dynamic subtest vcs1: SUCCESS (1.982s)
[540.706650] Starting dynamic subtest: vecs0
[542.675869] Dynamic subtest vecs0: SUCCESS (1.981s)
[542.688310] Starting dynamic subtest: ccs0
[543.332956] Dynamic subtest ccs0: SUCCESS (0.656s)
[543.335866] Subtest busy-idle-check-all: SUCCESS (8.015s)
[543.440250] [119/131] (479s left) kms_plane_alpha_blend (coverage-7efc)
[543.532320] Starting subtest: coverage-7efc
[543.823307] Starting dynamic subtest: pipe-A-eDP-1
[544.377848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[544.404364] Starting dynamic subtest: pipe-D-eDP-1
[545.641720] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[545.644425] Subtest coverage-7efc: SUCCESS (2.108s)
[546.528421] [120/131] (476s left) kms_cursor_crc (cursor-sliding-128x128)
[546.731133] Starting subtest: cursor-sliding-128x128
[546.733490] Starting dynamic subtest: pipe-A-eDP-1
[549.935557] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.203s)
[549.962925] Starting dynamic subtest: pipe-D-eDP-1
[553.798967] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.844s)
[553.801531] Subtest cursor-sliding-128x128: SUCCESS (7.069s)
[554.605931] [121/131] (468s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[554.702318] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[559.351650] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.653s)
[560.517233] [122/131] (462s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[560.612451] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[560.614940] Starting dynamic subtest: pipe-A-eDP-1
[560.640020] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[560.651065] Starting dynamic subtest: pipe-B-eDP-1
[560.676481] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[560.686240] Starting dynamic subtest: pipe-C-eDP-1
[560.711501] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[560.721563] Starting dynamic subtest: pipe-D-eDP-1
[560.748850] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[560.753621] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[562.778557] [123/131] (460s left) syncobj_timeline (device-signal-unordered)
[562.849747] Starting subtest: device-signal-unordered
[562.852410] Subtest device-signal-unordered: SUCCESS (0.000s)
[562.946358] [124/131] (460s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[563.056265] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[563.060536] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[563.160062] [125/131] (460s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[563.264225] Starting subtest: fbcpsr-rgb565-draw-blt
[570.265584] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.004s)
[570.422171] [126/131] (453s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[570.515235] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[570.887277] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[573.689258] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[573.707232] Starting dynamic subtest: pipe-A-eDP-1-4
[575.866919] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[575.876508] Starting dynamic subtest: pipe-A-eDP-1-4
[577.875000] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[577.887332] Starting dynamic subtest: pipe-A-eDP-1-x
[580.054254] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[580.424091] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[583.217510] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[583.229500] Starting dynamic subtest: pipe-B-eDP-1-4
[585.392995] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.175s)
[585.411124] Starting dynamic subtest: pipe-B-eDP-1-4
[587.400774] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[587.411579] Starting dynamic subtest: pipe-B-eDP-1-x
[589.601737] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[589.977608] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[592.804397] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[592.817403] Starting dynamic subtest: pipe-C-eDP-1-4
[594.927988] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[594.944935] Starting dynamic subtest: pipe-C-eDP-1-4
[596.937181] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[596.947232] Starting dynamic subtest: pipe-C-eDP-1-x
[599.116556] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[599.487661] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[602.285097] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.804s)
[602.298372] Starting dynamic subtest: pipe-D-eDP-1-4
[604.459581] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[604.470364] Starting dynamic subtest: pipe-D-eDP-1-4
[606.470418] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[606.480741] Starting dynamic subtest: pipe-D-eDP-1-x
[608.649373] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[608.652105] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.134s)
[609.871193] [127/131] (413s left) gem_mmap_wc (write-prefaulted)
[609.930229] Subtest write-prefaulted: SKIP (0.000s)
[609.998450] [128/131] (413s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[610.095474] Starting subtest: 4-tiled-16bpp-rotate-270
[610.116038] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.018s)
[610.236798] [129/131] (413s left) gem_exec_whisper (basic-normal-all)
[610.305153] Starting subtest: basic-normal-all
[612.638664] Subtest basic-normal-all: SUCCESS (2.330s)
[612.821066] [130/131] (410s left) kms_hdmi_inject (inject-audio)
[613.172753] Starting subtest: inject-audio
[613.431745] Subtest inject-audio: SUCCESS (0.262s)
[614.041179] [131/131] (409s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[614.140100] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[614.144534] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[614.244126] Closing watchdogs
results: parsing output: 0/ for test: gem_eio
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: prime_vgem
results: parsing output: 3/ for test: kms_pm_dc
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: prime_vgem
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: i915_pm_rc6_residency
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: gem_exec_gttfill
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_spin_batch
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_exec_await
results: parsing output: 30/ for test: gem_reg_read
results: parsing output: 31/ for test: gem_render_copy_redux
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: vgem_basic
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: core_sysfs
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: gem_pread
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_sequence
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_mmap
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_dirtyfb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_capture
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: sw_sync
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: kms_invalid_mode
results: parsing output: 66/ for test: kms_chamelium_edid
results: parsing output: 67/ for test: i915_fb_tiling
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_caching
results: parsing output: 70/ for test: kms_tv_load_detect
results: parsing output: 71/ for test: gem_ctx_shared
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_ctx_exec
results: parsing output: 74/ for test: dumb_buffer
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: core_auth
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_wait
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_pipe_crc_basic
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: gem_pxp
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_vblank
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_pwrite_snooped
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ccs
results: parsing output: 107/ for test: gem_ctx_param
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_prop_blob
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: kms_plane_alpha_blend
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: kms_hdmi_inject
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.