[58.572352] Initializing watchdogs
[58.572400]   /dev/watchdog0
[58.587412] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.592043] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.594806] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.597904] [001/133] (960s left) syncobj_timeline (single-wait-all-available-signaled)
[58.670970] Starting subtest: single-wait-all-available-signaled
[58.673453] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[58.782202] [002/133] (960s left) kms_big_fb (4-tiled-addfb)
[58.885154] Starting subtest: 4-tiled-addfb
[58.887526] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[58.973878] [003/133] (960s left) gem_exec_whisper (basic-contexts-all)
[59.030364] Starting subtest: basic-contexts-all
[70.838769] Subtest basic-contexts-all: SUCCESS (11.787s)
[71.024536] [004/133] (948s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[71.122166] Starting subtest: y-tiled-32bpp-rotate-270
[71.126754] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[71.212895] [005/133] (948s left) gem_pwrite (basic-random)
[71.264324] Subtest basic-random: SKIP (0.000s)
[71.322845] [006/133] (947s left) kms_frontbuffer_tracking (fbc-tiling-y)
[71.432546] Starting subtest: fbc-tiling-y
[71.436749] Subtest fbc-tiling-y: SKIP (0.000s)
[71.531206] [007/133] (947s left) dumb_buffer (invalid-bpp)
[71.581913] Starting subtest: invalid-bpp
[71.583888] Subtest invalid-bpp: SUCCESS (0.000s)
[71.686053] [008/133] (947s left) kms_plane_lowres (tiling-none)
[71.765172] Starting subtest: tiling-none
[71.767514] Starting dynamic subtest: pipe-A-eDP-1
[71.772072] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.083649] Starting dynamic subtest: pipe-B-eDP-1
[72.088069] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[72.098889] Starting dynamic subtest: pipe-C-eDP-1
[72.103321] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[72.111464] Starting dynamic subtest: pipe-D-eDP-1
[72.115759] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[72.120113] Subtest tiling-none: SKIP (0.312s)
[72.877846] [009/133] (946s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[72.945393] Starting subtest: x-tiled-to-vebox-y-tiled
[72.949898] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[73.136160] [010/133] (946s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[73.188081] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[73.291217] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[73.375506] [011/133] (946s left) kms_cursor_legacy (forked-bo)
[73.503832] Starting subtest: forked-bo
[73.505702] Starting dynamic subtest: pipe-A
[78.975893] Dynamic subtest pipe-A: SUCCESS (5.468s)
[78.987306] Starting dynamic subtest: pipe-B
[84.471604] Dynamic subtest pipe-B: SUCCESS (5.494s)
[84.481356] Starting dynamic subtest: pipe-C
[89.946671] Dynamic subtest pipe-C: SUCCESS (5.473s)
[89.955679] Starting dynamic subtest: pipe-D
[95.416825] Dynamic subtest pipe-D: SUCCESS (5.468s)
[95.430508] Starting dynamic subtest: all-pipes
[100.929158] Dynamic subtest all-pipes: SUCCESS (5.510s)
[100.931702] Subtest forked-bo: SUCCESS (27.419s)
[101.081974] [012/133] (918s left) gem_madvise (dontneed-after-mmap)
[101.135347] Starting subtest: dontneed-after-mmap
[101.158244] Subtest dontneed-after-mmap: SUCCESS (0.024s)
[101.268235] [013/133] (918s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[101.337626] Starting subtest: etime-multi-wait-all-submitted-signaled
[101.442514] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[101.522245] [014/133] (918s left) kms_flip (wf_vblank-ts-check-interruptible)
[101.616050] Starting subtest: wf_vblank-ts-check-interruptible
[101.618335] Starting dynamic subtest: A-eDP1
[110.536220] Dynamic subtest A-eDP1: SUCCESS (8.918s)
[110.546600] Starting dynamic subtest: B-eDP1
[119.465578] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[119.476642] Starting dynamic subtest: C-eDP1
[128.382386] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[128.392964] Starting dynamic subtest: D-eDP1
[137.311777] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[137.317058] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.698s)
[138.555619] [015/133] (881s left) gem_spin_batch (spin-each)
[138.620910] Starting subtest: spin-each
[141.888490] Subtest spin-each: SUCCESS (3.262s)
[142.130127] [016/133] (877s left) kms_psr (fbc-psr2-sprite-blt)
[142.236736] Starting subtest: fbc-psr2-sprite-blt
[142.239050] Starting dynamic subtest: eDP-1
[142.243345] Dynamic subtest eDP-1: SKIP (0.000s)
[142.247725] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[142.308923] [017/133] (877s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[142.399573] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[142.426417] Starting dynamic subtest: pipe-A-plane-0
[142.715437] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[142.726721] Starting dynamic subtest: pipe-A-plane-3
[142.948151] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[142.957741] Starting dynamic subtest: pipe-A-plane-5
[142.962163] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[144.034187] Starting dynamic subtest: pipe-B-plane-0
[144.328116] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[144.335950] Starting dynamic subtest: pipe-B-plane-3
[144.561424] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[144.569899] Starting dynamic subtest: pipe-B-plane-5
[144.574067] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[144.871644] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.472s)
[145.701349] [018/133] (874s left) gem_workarounds (reset-context)
[145.783071] Starting subtest: reset-context
[145.951989] Subtest reset-context: SUCCESS (0.169s)
[146.101320] [019/133] (873s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[146.197418] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[146.202081] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[146.264296] [020/133] (873s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[146.362152] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[153.130972] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.773s)
[153.265830] [021/133] (866s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[153.354060] Starting subtest: primary-yf-tiled-reflect-x-0
[153.426070] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[153.540401] [022/133] (866s left) kms_chamelium_color (ctm-0-75)
[153.644535] Subtest ctm-0-75: SKIP (0.000s)
[153.688576] [023/133] (866s left) kms_content_protection (atomic)
[153.822055] Starting subtest: atomic
[153.826593] Subtest atomic: SKIP (0.000s)
[153.938485] [024/133] (866s left) gem_ctx_param (invalid-param-get)
[153.982918] Starting subtest: invalid-param-get
[153.985254] Subtest invalid-param-get: SUCCESS (0.001s)
[154.085288] [025/133] (866s left) syncobj_wait (wait-for-submit-delayed-submit)
[154.139490] Starting subtest: wait-for-submit-delayed-submit
[154.244647] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[154.321356] [026/133] (865s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[154.412203] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[154.414628] Starting dynamic subtest: pipe-A-eDP-1
[154.437942] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.448955] Starting dynamic subtest: pipe-B-eDP-1
[154.470877] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[154.479421] Starting dynamic subtest: pipe-C-eDP-1
[154.501404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.509613] Starting dynamic subtest: pipe-D-eDP-1
[154.532497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.537116] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[156.701038] [027/133] (863s left) gem_exec_balancer (semaphore)
[156.772598] Starting subtest: semaphore
[157.902268] Subtest semaphore: SUCCESS (1.128s)
[158.230185] [028/133] (861s left) gem_ctx_persistence (file)
[158.300775] Starting subtest: file
[158.405298] Subtest file: SUCCESS (0.104s)
[158.515847] [029/133] (861s left) kms_async_flips (test-time-stamp-atomic)
[158.606198] Starting subtest: test-time-stamp-atomic
[158.992071] Starting dynamic subtest: pipe-A-eDP-1
[159.810785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s)
[160.190934] Starting dynamic subtest: pipe-B-eDP-1
[160.948309] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[161.323936] Starting dynamic subtest: pipe-C-eDP-1
[162.085016] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[162.452564] Starting dynamic subtest: pipe-D-eDP-1
[163.213070] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[163.215440] Subtest test-time-stamp-atomic: SUCCESS (4.607s)
[164.372949] [030/133] (855s left) kms_plane (planar-pixel-format-settings)
[164.462553] Starting subtest: planar-pixel-format-settings
[164.528596] Subtest planar-pixel-format-settings: SUCCESS (0.066s)
[164.645355] [031/133] (855s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[164.739068] Starting subtest: primary-4-tiled-reflect-x-0
[171.718020] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.981s)
[172.929890] [032/133] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[173.043019] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[173.047720] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[173.144804] [033/133] (847s left) gem_exec_reloc (basic-cpu-gtt)
[173.212879] Subtest basic-cpu-gtt: SKIP (0.000s)
[173.281837] [034/133] (847s left) kms_universal_plane (universal-plane-sanity)
[173.370270] Starting subtest: universal-plane-sanity
[173.372596] Starting dynamic subtest: pipe-A-eDP-1
[173.966295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[173.976362] Starting dynamic subtest: pipe-B-eDP-1
[175.165455] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.197s)
[175.175264] Starting dynamic subtest: pipe-C-eDP-1
[176.377549] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[176.388693] Starting dynamic subtest: pipe-D-eDP-1
[177.602097] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[177.604434] Subtest universal-plane-sanity: SUCCESS (4.232s)
[178.469014] [035/133] (842s left) gem_mmap_offset (mmap-boundaries)
[178.522034] Starting subtest: mmap-boundaries
[178.524354] Starting dynamic subtest: smem0
[178.797076] Dynamic subtest smem0: SUCCESS (0.277s)
[178.799654] Subtest mmap-boundaries: SUCCESS (0.277s)
[178.914476] [036/133] (841s left) gem_wait (busy)
[178.979610] Starting subtest: busy
[178.982129] Starting dynamic subtest: all-engines
[180.885671] Dynamic subtest all-engines: SUCCESS (1.904s)
[180.898080] Starting dynamic subtest: rcs0
[181.428919] Dynamic subtest rcs0: SUCCESS (0.543s)
[181.440759] Starting dynamic subtest: bcs0
[181.969541] Dynamic subtest bcs0: SUCCESS (0.540s)
[181.980593] Starting dynamic subtest: vcs0
[183.893608] Dynamic subtest vcs0: SUCCESS (1.922s)
[183.905883] Starting dynamic subtest: vcs1
[185.877623] Dynamic subtest vcs1: SUCCESS (1.982s)
[185.888873] Starting dynamic subtest: vecs0
[187.926214] Dynamic subtest vecs0: SUCCESS (2.047s)
[187.937998] Starting dynamic subtest: ccs0
[188.467709] Dynamic subtest ccs0: SUCCESS (0.541s)
[188.470128] Subtest busy: SUCCESS (9.488s)
[188.663482] [037/133] (831s left) gem_create (create-valid-nonaligned)
[188.718311] Starting subtest: create-valid-nonaligned
[188.720809] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[188.900163] [038/133] (831s left) gem_media_fill (media-fill)
[188.963444] Subtest media-fill: SKIP (0.000s)
[189.104173] [039/133] (831s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[189.169696] Starting subtest: invalid-multi-wait-all-unsubmitted
[189.171947] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[189.274257] [040/133] (831s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[189.372625] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[189.375072] Starting dynamic subtest: pipe-A-eDP-1
[189.492420] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[189.504587] Starting dynamic subtest: pipe-B-eDP-1
[190.650429] Dynamic subtest pipe-B-eDP-1: SKIP (1.156s)
[190.655129] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.280s)
[191.831315] [041/133] (828s left) gem_create (create-ext-placement-all)
[191.990183] Starting subtest: create-ext-placement-all
[191.992315] Subtest create-ext-placement-all: SUCCESS (0.000s)
[192.092920] [042/133] (828s left) i915_pm_freq_api (freq-reset)
[192.146664] Starting subtest: freq-reset
[192.148910] Starting dynamic subtest: gt0
[192.321709] Dynamic subtest gt0: SUCCESS (0.173s)
[192.330988] Starting dynamic subtest: gt1
[192.478088] Dynamic subtest gt1: SUCCESS (0.157s)
[192.480510] Subtest freq-reset: SUCCESS (0.330s)
[192.584235] [043/133] (828s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[192.669919] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[192.672114] Starting dynamic subtest: pipe-A-eDP-1
[193.488933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.812s)
[193.498649] Starting dynamic subtest: pipe-B-eDP-1
[195.057468] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.568s)
[195.069284] Starting dynamic subtest: pipe-C-eDP-1
[196.606594] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.547s)
[196.616033] Starting dynamic subtest: pipe-D-eDP-1
[198.116616] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.510s)
[198.118752] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.440s)
[199.263326] [044/133] (821s left) kms_flip (dpms-off-confusion-interruptible)
[199.358076] Starting subtest: dpms-off-confusion-interruptible
[199.360458] Starting dynamic subtest: A-eDP1
[207.981027] Dynamic subtest A-eDP1: SUCCESS (8.618s)
[207.990951] Starting dynamic subtest: B-eDP1
[216.712211] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[216.723710] Starting dynamic subtest: C-eDP1
[225.333059] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[225.343976] Starting dynamic subtest: D-eDP1
[233.972496] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[233.974956] Subtest dpms-off-confusion-interruptible: SUCCESS (34.616s)
[235.146352] [045/133] (785s left) kms_chamelium_edid (hdmi-mode-timings)
[235.546602] Subtest hdmi-mode-timings: SKIP (0.000s)
[236.372816] [046/133] (784s left) gem_exec_reloc (basic-scanout)
[236.437874] Subtest basic-scanout: SKIP (0.000s)
[236.488224] [047/133] (784s left) api_intel_allocator (default-alignment)
[236.538831] Starting subtest: default-alignment
[236.541074] Subtest default-alignment: SUCCESS (0.002s)
[236.659170] [048/133] (784s left) gem_exec_schedule (u-independent)
[236.733473] Starting subtest: u-independent
[236.735686] Starting dynamic subtest: rcs0
[237.910055] Dynamic subtest rcs0: SUCCESS (1.186s)
[237.927104] Starting dynamic subtest: vcs0
[239.903040] Dynamic subtest vcs0: SUCCESS (1.990s)
[239.915314] Starting dynamic subtest: vcs1
[241.950447] Dynamic subtest vcs1: SUCCESS (2.046s)
[241.962492] Starting dynamic subtest: vecs0
[243.939053] Dynamic subtest vecs0: SUCCESS (1.986s)
[243.950168] Starting dynamic subtest: ccs0
[245.910256] Dynamic subtest ccs0: SUCCESS (1.969s)
[245.912917] Subtest u-independent: SUCCESS (9.188s)
[246.213576] [049/133] (774s left) gen7_exec_parse (cmd-crossing-page)
[246.276730] Subtest cmd-crossing-page: SKIP (0.000s)
[246.342038] [050/133] (774s left) kms_vblank (query-idle)
[246.448705] Starting subtest: query-idle
[246.450527] Starting dynamic subtest: pipe-A-eDP-1
[248.193347] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.745s)
[248.208063] Starting dynamic subtest: pipe-D-eDP-1
[250.625934] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.428s)
[250.628260] Subtest query-idle: SUCCESS (4.177s)
[251.445894] [051/133] (769s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[251.518609] Starting subtest: y-tiled-to-vebox-x-tiled
[251.523267] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[251.714888] [052/133] (769s left) gem_exec_balancer (hog)
[251.785213] Starting subtest: hog
[251.789911] Subtest hog: SKIP (0.000s)
[252.087353] [053/133] (769s left) kms_atomic_interruptible (legacy-pageflip)
[252.189875] Starting subtest: legacy-pageflip
[252.192169] Starting dynamic subtest: pipe-A-eDP-1
[259.575877] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.383s)
[259.578278] Subtest legacy-pageflip: SUCCESS (7.385s)
[260.416611] [054/133] (760s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[260.517994] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[260.522322] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[260.612712] [055/133] (760s left) gem_exec_params (invalid-flag)
[260.661876] Starting subtest: invalid-flag
[260.664248] Subtest invalid-flag: SUCCESS (0.000s)
[260.754087] [056/133] (760s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[260.850736] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[260.852720] Starting dynamic subtest: A-eDP1
[264.443601] Dynamic subtest A-eDP1: SUCCESS (3.593s)
[264.453622] Starting dynamic subtest: B-eDP1
[267.629030] Dynamic subtest B-eDP1: SUCCESS (3.183s)
[267.638818] Starting dynamic subtest: C-eDP1
[270.749390] Dynamic subtest C-eDP1: SUCCESS (3.120s)
[270.759064] Starting dynamic subtest: D-eDP1
[273.849715] Dynamic subtest D-eDP1: SUCCESS (3.103s)
[273.852087] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.005s)
[274.659839] [057/133] (746s left) gen3_render_mixed_blits
[274.783643] [058/133] (746s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[274.841604] Starting subtest: invalid-smem-bo-on-discrete
[274.845969] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[274.966244] [059/133] (746s left) kms_flip (2x-flip-vs-rmfb)
[275.057587] Starting subtest: 2x-flip-vs-rmfb
[275.068786] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[275.148478] [060/133] (746s left) kms_dsc (dsc-fractional-bpp)
[275.250275] Starting subtest: dsc-fractional-bpp
[275.263312] Subtest dsc-fractional-bpp: SKIP (0.000s)
[275.319612] [061/133] (746s left) i915_drm_fdinfo (memory-info-idle)
[275.361330] Starting subtest: memory-info-idle
[275.363760] Starting dynamic subtest: smem0
[275.404624] Dynamic subtest smem0: SUCCESS (0.043s)
[275.407526] Subtest memory-info-idle: SUCCESS (0.044s)
[275.481068] [062/133] (746s left) perf_pmu (semaphore-wait-idle)
[275.523887] Starting subtest: semaphore-wait-idle
[275.526286] Starting dynamic subtest: rcs0
[276.038068] Dynamic subtest rcs0: SUCCESS (0.512s)
[276.050128] Starting dynamic subtest: bcs0
[276.552309] Dynamic subtest bcs0: SUCCESS (0.510s)
[276.563823] Starting dynamic subtest: vcs0
[277.065772] Dynamic subtest vcs0: SUCCESS (0.511s)
[277.077746] Starting dynamic subtest: vcs1
[277.580357] Dynamic subtest vcs1: SUCCESS (0.511s)
[277.591623] Starting dynamic subtest: vecs0
[278.093926] Dynamic subtest vecs0: SUCCESS (0.510s)
[278.105330] Starting dynamic subtest: ccs0
[278.610636] Dynamic subtest ccs0: SUCCESS (0.512s)
[278.613289] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[279.901516] [063/133] (741s left) kms_psr (psr2-cursor-plane-onoff)
[280.008714] Starting subtest: psr2-cursor-plane-onoff
[280.010866] Starting dynamic subtest: eDP-1
[281.733782] Dynamic subtest eDP-1: SUCCESS (1.723s)
[281.736085] Subtest psr2-cursor-plane-onoff: SUCCESS (1.724s)
[282.525800] [064/133] (739s left) perf (blocking)
[282.657047] Starting subtest: blocking
[282.659191] Starting dynamic subtest: 0-rcs0
[292.679945] Dynamic subtest 0-rcs0: SUCCESS (10.021s)
[292.691754] Starting dynamic subtest: 1-vecs0
[302.705336] Dynamic subtest 1-vecs0: SUCCESS (10.023s)
[302.707826] Subtest blocking: SUCCESS (20.048s)
[302.758028] [065/133] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[302.854054] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[302.857948] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[302.948442] [066/133] (718s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[303.003212] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[303.005674] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[303.104583] [067/133] (718s left) kms_properties (connector-properties-atomic)
[303.195836] Starting subtest: connector-properties-atomic
[303.198074] Starting dynamic subtest: pipe-A-eDP-1
[311.225897] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.027s)
[311.235605] Starting dynamic subtest: pipe-None-DP-1
[311.240284] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[311.248843] Starting dynamic subtest: pipe-None-HDMI-A-1
[311.253439] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[311.262079] Starting dynamic subtest: pipe-None-DP-2
[311.266724] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[311.275572] Starting dynamic subtest: pipe-None-HDMI-A-2
[311.280217] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[311.289058] Starting dynamic subtest: pipe-None-DP-3
[311.293222] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[311.301429] Starting dynamic subtest: pipe-None-DP-4
[311.305534] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[311.307437] Subtest connector-properties-atomic: SUCCESS (8.040s)
[312.088569] [068/133] (709s left) perf (invalid-create-userspace-config)
[312.191879] Starting subtest: invalid-create-userspace-config
[312.194358] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[312.234573] [069/133] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[312.338740] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[312.343101] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[312.442713] [070/133] (709s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[312.541280] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[312.545319] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[312.643729] [071/133] (709s left) kms_invalid_mode (bad-htotal)
[312.741521] Starting subtest: bad-htotal
[312.743838] Starting dynamic subtest: pipe-A-eDP-1
[313.023562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[313.032995] Starting dynamic subtest: pipe-B-eDP-1
[313.035267] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[313.044058] Starting dynamic subtest: pipe-C-eDP-1
[313.046333] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[313.054626] Starting dynamic subtest: pipe-D-eDP-1
[313.056532] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[313.058432] Subtest bad-htotal: SUCCESS (0.289s)
[313.823741] [072/133] (708s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[313.885095] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[313.887422] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[313.997867] [073/133] (708s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[314.094472] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[320.854443] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.762s)
[320.975402] [074/133] (701s left) kms_force_connector_basic (force-connector-state)
[321.062260] Starting subtest: force-connector-state
[321.677266] Subtest force-connector-state: SUCCESS (0.615s)
[322.616435] [075/133] (699s left) kms_plane_alpha_blend (alpha-transparent-fb)
[322.717437] Starting subtest: alpha-transparent-fb
[323.011556] Starting dynamic subtest: pipe-A-eDP-1
[323.653889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[323.664428] Starting dynamic subtest: pipe-D-eDP-1
[325.038037] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.381s)
[325.040423] Subtest alpha-transparent-fb: SUCCESS (2.322s)
[325.884873] [076/133] (696s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[325.981251] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[325.985805] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[326.051962] [077/133] (696s left) gem_exec_schedule (preempt-contexts)
[326.125097] Starting subtest: preempt-contexts
[326.126994] Starting dynamic subtest: rcs0
[326.172656] Dynamic subtest rcs0: SUCCESS (0.055s)
[326.182021] Starting dynamic subtest: bcs0
[326.224469] Dynamic subtest bcs0: SUCCESS (0.050s)
[326.233511] Starting dynamic subtest: vcs0
[326.277853] Dynamic subtest vcs0: SUCCESS (0.052s)
[326.286868] Starting dynamic subtest: vcs1
[326.333072] Dynamic subtest vcs1: SUCCESS (0.055s)
[326.342225] Starting dynamic subtest: vecs0
[326.378647] Dynamic subtest vecs0: SUCCESS (0.044s)
[326.387860] Starting dynamic subtest: ccs0
[326.437831] Dynamic subtest ccs0: SUCCESS (0.058s)
[326.440109] Subtest preempt-contexts: SUCCESS (0.321s)
[328.001013] [078/133] (694s left) gem_busy (parallel)
[328.192091] Starting subtest: parallel
[328.194572] Starting dynamic subtest: rcs0
[329.877487] Dynamic subtest rcs0: SUCCESS (1.684s)
[329.893009] Starting dynamic subtest: bcs0
[331.925571] Dynamic subtest bcs0: SUCCESS (2.045s)
[331.936082] Starting dynamic subtest: vcs0
[333.910879] Dynamic subtest vcs0: SUCCESS (1.982s)
[333.923885] Starting dynamic subtest: vcs1
[335.895445] Dynamic subtest vcs1: SUCCESS (1.981s)
[335.918024] Starting dynamic subtest: vecs0
[337.879603] Dynamic subtest vecs0: SUCCESS (1.981s)
[337.900798] Starting dynamic subtest: ccs0
[339.863210] Dynamic subtest ccs0: SUCCESS (1.980s)
[339.866287] Subtest parallel: SUCCESS (11.671s)
[340.128345] [079/133] (682s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[340.220022] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[340.222201] Starting dynamic subtest: pipe-A
[340.242188] Dynamic subtest pipe-A: SKIP (0.017s)
[340.251479] Starting dynamic subtest: pipe-B
[340.271616] Dynamic subtest pipe-B: SKIP (0.030s)
[340.280592] Starting dynamic subtest: pipe-C
[340.302935] Dynamic subtest pipe-C: SKIP (0.030s)
[340.311695] Starting dynamic subtest: pipe-D
[340.334131] Dynamic subtest pipe-D: SKIP (0.031s)
[340.338321] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.111s)
[340.457227] [080/133] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[340.556758] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[363.497309] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.941s)
[363.619898] [081/133] (658s left) gem_render_copy_redux (normal)
[363.687318] Starting subtest: normal
[363.996029] Subtest normal: SUCCESS (0.309s)
[364.124027] [082/133] (658s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[364.189103] Starting subtest: map-fixed-invalidate-overlap
[364.192646] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[364.324525] [083/133] (658s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[364.387809] Starting subtest: multi-wait-all-for-submit-unsubmitted
[364.497403] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[364.570889] [084/133] (657s left) kms_psr (fbc-psr-suspend)
[364.683288] Starting subtest: fbc-psr-suspend
[364.685648] Starting dynamic subtest: eDP-1
[364.690091] Dynamic subtest eDP-1: SKIP (0.000s)
[364.694554] Subtest fbc-psr-suspend: SKIP (0.001s)
[364.754558] [085/133] (657s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[364.861354] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[365.686200] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[365.836215] [086/133] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[365.934593] Starting subtest: psr-2p-primscrn-spr-indfb-move
[365.938667] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[366.024294] [087/133] (656s left) tools_test (tools_test)
[366.073915] Starting subtest: tools_test
[366.129250] Subtest tools_test: SUCCESS (0.069s)
[366.190224] [088/133] (656s left) kms_pm_rpm (basic-pci-d3-state)
[368.007197] Starting subtest: basic-pci-d3-state
[369.495731] Subtest basic-pci-d3-state: SUCCESS (1.488s)
[369.586114] [089/133] (653s left) kms_hdr (brightness-with-hdr)
[369.684157] Starting subtest: brightness-with-hdr
[369.690181] Subtest brightness-with-hdr: SKIP (0.000s)
[369.756459] [090/133] (653s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[369.815617] Subtest writes-after-reads: SKIP (0.000s)
[369.884448] [091/133] (652s left) gem_userptr_blits (stress-mm-invalidate-close)
[369.949911] Starting subtest: stress-mm-invalidate-close
[372.097645] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[372.223052] [092/133] (650s left) gem_exec_reloc (basic-write-read-active)
[372.297747] Subtest basic-write-read-active: SKIP (0.000s)
[372.369388] [093/133] (650s left) kms_color (ctm-signed)
[372.460297] Starting subtest: ctm-signed
[372.462527] Starting dynamic subtest: pipe-A-eDP-1
[374.531765] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.072s)
[374.541266] Starting dynamic subtest: pipe-B-eDP-1
[377.325935] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.791s)
[377.335575] Starting dynamic subtest: pipe-C-eDP-1
[380.085847] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[380.095621] Starting dynamic subtest: pipe-D-eDP-1
[382.789182] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.702s)
[382.791551] Subtest ctm-signed: SUCCESS (10.330s)
[383.597661] [094/133] (639s left) gem_exec_create (forked)
[383.662654] Starting subtest: forked
[383.665147] Starting dynamic subtest: smem
[403.856383] Dynamic subtest smem: SUCCESS (20.192s)
[403.858796] Subtest forked: SUCCESS (20.194s)
[404.045647] [095/133] (618s left) i915_pm_rc6_residency (rc6-accuracy)
[404.109752] Starting subtest: rc6-accuracy
[404.111815] Starting dynamic subtest: gt0
[407.281713] Dynamic subtest gt0: SUCCESS (3.169s)
[407.293360] Starting dynamic subtest: gt1
[410.452808] Dynamic subtest gt1: SUCCESS (3.168s)
[410.455333] Subtest rc6-accuracy: SUCCESS (6.343s)
[410.525733] [096/133] (612s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[410.626839] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[410.631316] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[410.721009] [097/133] (612s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[410.809191] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[410.811459] Starting dynamic subtest: pipe-A-eDP-1
[410.870468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[411.189326] Starting dynamic subtest: pipe-B-eDP-1
[411.956467] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.777s)
[412.241511] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.434s)
[413.088347] [098/133] (610s left) perf (non-zero-reason)
[413.171424] Starting subtest: non-zero-reason
[413.173858] Starting dynamic subtest: 0-rcs0
[418.560707] Dynamic subtest 0-rcs0: SUCCESS (5.387s)
[418.572479] Starting dynamic subtest: 1-vcs0
[422.496332] Dynamic subtest 1-vcs0: SUCCESS (3.934s)
[422.499018] Subtest non-zero-reason: SUCCESS (9.324s)
[422.547854] [099/133] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[422.649462] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[422.653475] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[422.759571] [100/133] (600s left) i915_pm_rps (thresholds)
[422.829598] Starting subtest: thresholds
[422.833737] Subtest thresholds: SKIP (0.001s)
[422.937680] [101/133] (600s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[423.050622] Starting subtest: cursorA-vs-flipA-legacy
[434.182105] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.130s)
[434.990352] [102/133] (588s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[435.118436] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[435.122614] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[435.209938] [103/133] (588s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[435.250412] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[435.294602] [104/133] (588s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[435.403634] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[435.407893] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[435.499478] [105/133] (587s left) sysfs_heartbeat_interval (mixed)
[435.560657] Starting subtest: mixed
[435.563052] Starting dynamic subtest: vecs0
[440.822143] Dynamic subtest vecs0: SUCCESS (5.260s)
[440.833862] Starting dynamic subtest: ccs0
[446.025747] Dynamic subtest ccs0: SUCCESS (5.201s)
[446.037366] Starting dynamic subtest: vcs0
[451.245126] Dynamic subtest vcs0: SUCCESS (5.218s)
[451.256142] Starting dynamic subtest: bcs0
[456.457018] Dynamic subtest bcs0: SUCCESS (5.210s)
[456.468412] Starting dynamic subtest: rcs0
[461.692917] Dynamic subtest rcs0: SUCCESS (5.234s)
[461.704471] Starting dynamic subtest: vcs1
[466.915325] Dynamic subtest vcs1: SUCCESS (5.220s)
[466.918601] Subtest mixed: SUCCESS (31.355s)
[466.996888] [106/133] (556s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[467.316699] Starting subtest: cursor-rapid-movement-512x170
[467.321016] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[467.466909] [107/133] (555s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[467.567978] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[467.570137] Starting dynamic subtest: pipe-A-eDP-1
[467.592680] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.603473] Starting dynamic subtest: pipe-B-eDP-1
[467.624193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.633070] Starting dynamic subtest: pipe-C-eDP-1
[467.654076] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.662747] Starting dynamic subtest: pipe-D-eDP-1
[467.684820] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.688914] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[469.794716] [108/133] (553s left) drm_read (empty-nonblock)
[469.925074] Starting subtest: empty-nonblock
[469.927476] Subtest empty-nonblock: SUCCESS (0.000s)
[470.052286] [109/133] (553s left) kms_prime (basic-crc-hybrid)
[470.130927] Subtest basic-crc-hybrid: SKIP (0.000s)
[470.284256] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[470.287706] [110/133] (553s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[470.423259] Starting subtest: basic-busy-flip-before-cursor-atomic
[470.427590] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[470.591885] [111/133] (553s left) kms_psr (fbc-psr-primary-mmap-gtt)
[470.684072] Starting subtest: fbc-psr-primary-mmap-gtt
[470.686214] Starting dynamic subtest: eDP-1
[470.690126] Dynamic subtest eDP-1: SKIP (0.000s)
[470.694159] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[470.756975] [112/133] (552s left) gem_ctx_persistence (engines-mixed)
[470.808931] Starting subtest: engines-mixed
[470.810819] Starting dynamic subtest: rcs0
[470.889482] Dynamic subtest rcs0: SUCCESS (0.080s)
[470.901881] Starting dynamic subtest: bcs0
[470.942270] Dynamic subtest bcs0: SUCCESS (0.051s)
[470.953837] Starting dynamic subtest: vcs0
[470.993458] Dynamic subtest vcs0: SUCCESS (0.049s)
[471.006063] Starting dynamic subtest: vcs1
[471.061617] Dynamic subtest vcs1: SUCCESS (0.065s)
[471.071796] Starting dynamic subtest: vecs0
[471.114323] Dynamic subtest vecs0: SUCCESS (0.051s)
[471.125061] Starting dynamic subtest: ccs0
[471.156230] Dynamic subtest ccs0: SUCCESS (0.041s)
[471.158213] Subtest engines-mixed: SUCCESS (0.348s)
[471.248564] [113/133] (552s left) kms_cursor_edge_walk (256x256-left-edge)
[471.333218] Starting subtest: 256x256-left-edge
[471.335080] Starting dynamic subtest: pipe-A-eDP-1
[474.860639] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.528s)
[474.870153] Starting dynamic subtest: pipe-D-eDP-1
[477.994446] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[477.996592] Subtest 256x256-left-edge: SUCCESS (6.661s)
[478.883021] [114/133] (544s left) gem_exec_fence (submit3)
[479.054984] Starting subtest: submit3
[479.059670] Subtest submit3: SKIP (0.000s)
[480.993917] [115/133] (542s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[481.093411] Starting subtest: yf-tiled-32bpp-rotate-0
[481.097822] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[481.206087] [116/133] (542s left) kms_cursor_crc (cursor-offscreen-512x170)
[481.528842] Starting subtest: cursor-offscreen-512x170
[481.533340] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[481.673135] [117/133] (542s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[481.761839] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[488.365169] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.606s)
[488.468905] [118/133] (535s left) api_intel_bb (intel-bb-blit-x)
[488.520117] Starting subtest: intel-bb-blit-x
[492.375357] Subtest intel-bb-blit-x: SUCCESS (3.855s)
[492.483105] [119/133] (531s left) gem_exec_reloc (basic-gtt-read-active)
[492.544317] Subtest basic-gtt-read-active: SKIP (0.000s)
[492.603250] [120/133] (531s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[492.696993] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[492.701870] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[492.790935] [121/133] (531s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[492.886311] Starting subtest: yf-tiled-64bpp-rotate-180
[492.890588] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[492.982583] [122/133] (531s left) kms_chamelium_hpd (dp-hpd-fast)
[493.363532] Subtest dp-hpd-fast: SKIP (0.000s)
[494.151810] [123/133] (529s left) gem_exec_async (concurrent-writes)
[494.207800] Starting subtest: concurrent-writes
[494.210186] Starting dynamic subtest: rcs0
[494.229223] Dynamic subtest rcs0: SUCCESS (0.021s)
[494.239470] Starting dynamic subtest: bcs0
[494.241765] Dynamic subtest bcs0: SUCCESS (0.005s)
[494.251054] Starting dynamic subtest: vcs0
[494.253399] Dynamic subtest vcs0: SUCCESS (0.005s)
[494.262415] Starting dynamic subtest: vcs1
[494.264302] Dynamic subtest vcs1: SUCCESS (0.006s)
[494.272793] Starting dynamic subtest: vecs0
[494.274709] Dynamic subtest vecs0: SUCCESS (0.005s)
[494.283406] Starting dynamic subtest: ccs0
[494.285309] Dynamic subtest ccs0: SUCCESS (0.007s)
[494.287209] Subtest concurrent-writes: SUCCESS (0.053s)
[494.486084] [124/133] (529s left) prime_self_import (basic-with_two_bos)
[494.528312] Starting subtest: basic-with_two_bos
[494.553981] Subtest basic-with_two_bos: SUCCESS (0.025s)
[494.695979] [125/133] (529s left) perf_pmu (multi-client)
[494.749327] Starting subtest: multi-client
[494.751393] Starting dynamic subtest: rcs0
[495.816555] Dynamic subtest rcs0: SUCCESS (1.066s)
[495.827139] Starting dynamic subtest: bcs0
[496.867345] Dynamic subtest bcs0: SUCCESS (1.048s)
[496.879251] Starting dynamic subtest: vcs0
[497.921574] Dynamic subtest vcs0: SUCCESS (1.051s)
[497.933284] Starting dynamic subtest: vcs1
[499.916990] Dynamic subtest vcs1: SUCCESS (1.993s)
[499.928121] Starting dynamic subtest: vecs0
[501.900542] Dynamic subtest vecs0: SUCCESS (1.980s)
[501.912100] Starting dynamic subtest: ccs0
[503.948896] Dynamic subtest ccs0: SUCCESS (2.046s)
[503.951597] Subtest multi-client: SUCCESS (9.201s)
[504.068630] [126/133] (520s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[504.175667] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[504.178063] Starting dynamic subtest: pipe-A-default-mode
[506.875663] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[506.877985] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.702s)
[507.682154] [127/133] (516s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[507.774122] Starting subtest: fbc-pr-cursor-mmap-cpu
[507.778054] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[507.858468] [128/133] (516s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[507.957714] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[507.961903] Starting dynamic subtest: pipe-A-eDP-1
[508.019867] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[508.033255] Starting dynamic subtest: pipe-B-eDP-1
[508.090571] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[508.101290] Starting dynamic subtest: pipe-C-eDP-1
[508.159605] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[508.171409] Starting dynamic subtest: pipe-D-eDP-1
[508.228221] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[508.232622] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[510.200703] [129/133] (514s left) kms_lease (lease-invalid-crtc)
[510.290480] Starting subtest: lease-invalid-crtc
[510.292893] Starting dynamic subtest: pipe-A-eDP-1
[510.295293] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[510.305810] Starting dynamic subtest: pipe-B-eDP-1
[510.308178] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[510.318080] Starting dynamic subtest: pipe-C-eDP-1
[510.320079] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[510.328967] Starting dynamic subtest: pipe-D-eDP-1
[510.330955] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[510.333052] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[510.373233] [130/133] (514s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[510.473168] Starting subtest: x-tiled-8bpp-rotate-90
[510.499370] Subtest x-tiled-8bpp-rotate-90: SKIP (0.025s)
[510.605934] [131/133] (513s left) gem_sync (basic-each)
[510.669039] Starting subtest: basic-each
[513.011052] Subtest basic-each: SUCCESS (2.353s)
[513.209544] [132/133] (511s left) syncobj_wait (multi-wait-submitted)
[513.266381] Starting subtest: multi-wait-submitted
[513.370095] Subtest multi-wait-submitted: SUCCESS (0.103s)
[513.450219] [133/133] (511s left) gem_exec_create (madvise)
[513.510862] Starting subtest: madvise
[513.513437] Starting dynamic subtest: smem
[534.997905] Dynamic subtest smem: SUCCESS (21.484s)
[535.000775] Subtest madvise: SUCCESS (21.485s)
[535.926805] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_pwrite
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: dumb_buffer
results: parsing output: 7/ for test: kms_plane_lowres
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_madvise
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: gem_workarounds
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_universal_plane
results: parsing output: 34/ for test: gem_mmap_offset
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: gem_create
results: parsing output: 37/ for test: gem_media_fill
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: gem_create
results: parsing output: 41/ for test: i915_pm_freq_api
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_chamelium_edid
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: api_intel_allocator
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gen7_exec_parse
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gen3_render_mixed_blits
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_dsc
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_force_connector_basic
results: parsing output: 74/ for test: kms_plane_alpha_blend
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: gem_busy
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_render_copy_redux
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: tools_test
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: kms_hdr
results: parsing output: 89/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: gem_exec_create
results: parsing output: 94/ for test: i915_pm_rc6_residency
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_atomic_transition
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: i915_pm_rps
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: sysfs_heartbeat_interval
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_prime
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_cursor_edge_walk
results: parsing output: 113/ for test: gem_exec_fence
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_chamelium_hpd
results: parsing output: 122/ for test: gem_exec_async
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_sync
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: gem_exec_create
Done.