[58.853556] Initializing watchdogs
[58.853656]   /dev/watchdog0
[58.869333] [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.875086] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.877367] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.880759] [001/133] (960s left) gem_exec_fence (submit67)
[59.088132] Starting subtest: submit67
[59.092732] Subtest submit67: SKIP (0.000s)
[61.405914] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[61.411550] [002/133] (958s left) perf_pmu (gt-awake)
[61.451765] Starting subtest: gt-awake
[70.282182] Subtest gt-awake: SUCCESS (8.828s)
[70.403551] [003/133] (949s left) gem_create (hog-create)
[70.453716] Starting subtest: hog-create
[70.455917] Starting dynamic subtest: smem0
[104.278127] Dynamic subtest smem0: SUCCESS (33.821s)
[104.280893] Subtest hog-create: SUCCESS (33.822s)
[104.511106] [004/133] (915s left) kms_flip (plain-flip-ts-check-interruptible)
[104.631260] Starting subtest: plain-flip-ts-check-interruptible
[104.633705] Starting dynamic subtest: A-eDP1
[113.507566] Dynamic subtest A-eDP1: SUCCESS (8.875s)
[113.518491] Starting dynamic subtest: B-eDP1
[122.325317] Dynamic subtest B-eDP1: SUCCESS (8.816s)
[122.334265] Starting dynamic subtest: C-eDP1
[131.142621] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[131.151289] Starting dynamic subtest: D-eDP1
[139.977060] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[139.979499] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.349s)
[141.157187] [005/133] (878s left) kms_force_connector_basic (force-load-detect)
[141.236567] Starting subtest: force-load-detect
[141.241111] Subtest force-load-detect: SKIP (0.000s)
[141.354189] [006/133] (878s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[141.465557] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[141.470021] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[141.573963] [007/133] (878s left) syncobj_wait (single-wait-for-submit-submitted)
[141.639251] Starting subtest: single-wait-for-submit-submitted
[141.747761] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[141.823021] [008/133] (877s left) prime_self_import (reimport-vs-gem_close-race)
[141.869264] Starting subtest: reimport-vs-gem_close-race
[146.970459] Subtest reimport-vs-gem_close-race: SUCCESS (5.101s)
[147.059625] [009/133] (872s left) core_setmaster (master-drop-set-user)
[147.142026] Starting subtest: master-drop-set-user
[147.154967] Subtest master-drop-set-user: SUCCESS (0.015s)
[147.192992] [010/133] (872s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[147.298069] Starting subtest: x-tiled-16bpp-rotate-90
[147.330155] Subtest x-tiled-16bpp-rotate-90: SKIP (0.032s)
[147.428453] [011/133] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[147.531376] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[147.535461] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[147.636231] [012/133] (872s left) gen9_exec_parse (bb-start-param)
[147.690865] Subtest bb-start-param: SKIP (0.000s)
[147.760210] [013/133] (872s left) kms_big_fb (linear-64bpp-rotate-0)
[147.858685] Starting subtest: linear-64bpp-rotate-0
[149.547932] Subtest linear-64bpp-rotate-0: SUCCESS (1.690s)
[149.713931] [014/133] (870s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[149.821480] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[150.613306] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.793s)
[150.784482] [015/133] (869s left) kms_flip (basic-flip-vs-wf_vblank)
[150.869287] Starting subtest: basic-flip-vs-wf_vblank
[150.871701] Starting dynamic subtest: A-eDP1
[152.801273] Dynamic subtest A-eDP1: SUCCESS (1.931s)
[152.812088] Starting dynamic subtest: B-eDP1
[154.740965] Dynamic subtest B-eDP1: SUCCESS (1.938s)
[154.751561] Starting dynamic subtest: C-eDP1
[156.661171] Dynamic subtest C-eDP1: SUCCESS (1.919s)
[156.669391] Starting dynamic subtest: D-eDP1
[158.589911] Dynamic subtest D-eDP1: SUCCESS (1.928s)
[158.592351] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.724s)
[159.814952] [016/133] (860s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[159.924144] Starting subtest: psr-2p-pri-indfb-multidraw
[159.928761] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[160.048154] [017/133] (860s left) gem_ccs (block-copy-compressed)
[160.100075] Starting subtest: block-copy-compressed
[160.104396] Subtest block-copy-compressed: SKIP (0.000s)
[160.205257] [018/133] (859s left) kms_psr (psr-suspend)
[160.292365] Starting subtest: psr-suspend
[160.294654] Starting dynamic subtest: eDP-1
[178.121457] Dynamic subtest eDP-1: SUCCESS (3.055s)
[178.123903] Subtest psr-suspend: SUCCESS (3.055s)
[178.970731] [019/133] (841s left) sw_sync (sync_multi_producer_single_consumer)
[179.033287] Starting subtest: sync_multi_producer_single_consumer
[180.110538] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[180.169431] [020/133] (840s left) api_intel_bb (destroy-bb)
[180.215430] Starting subtest: destroy-bb
[180.223306] Subtest destroy-bb: SUCCESS (0.008s)
[180.338575] [021/133] (839s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[180.465385] Starting subtest: cursorA-vs-flipB-legacy
[180.469922] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[180.611124] [022/133] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[180.705787] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[180.709812] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[180.812078] [023/133] (839s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[180.915541] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[181.528729] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.615s)
[181.725111] [024/133] (838s left) perf (short-reads)
[181.854914] Starting subtest: short-reads
[181.870086] Subtest short-reads: SUCCESS (0.016s)
[181.914420] [025/133] (838s left) gem_exec_balancer (parallel)
[182.177835] Starting subtest: parallel
[183.143240] Subtest parallel: SUCCESS (0.966s)
[184.101352] [026/133] (836s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[184.197315] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[184.199647] Starting dynamic subtest: pipe-A-eDP-1
[184.222111] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[184.233702] Starting dynamic subtest: pipe-B-eDP-1
[184.255100] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[184.263777] Starting dynamic subtest: pipe-C-eDP-1
[184.290251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[184.299685] Starting dynamic subtest: pipe-D-eDP-1
[184.321680] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[184.325730] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[186.369105] [027/133] (834s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[186.493645] Starting subtest: 2x-cursor-vs-flip-legacy
[186.498162] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[186.654481] [028/133] (833s left) kms_chamelium_hpd (dp-hpd-storm)
[187.038428] Subtest dp-hpd-storm: SKIP (0.000s)
[187.861758] [029/133] (832s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[187.922426] Starting subtest: etime-multi-wait-all-for-submit-submitted
[188.025177] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[188.100748] [030/133] (832s left) vgem_basic (busy-fence)
[188.152840] Starting subtest: busy-fence
[188.155108] Subtest busy-fence: SUCCESS (0.000s)
[188.212689] [031/133] (832s left) prime_mmap_coherency (read)
[188.277319] Starting subtest: read
[193.653535] Subtest read: SUCCESS (5.375s)
[193.782014] [032/133] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[193.887333] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[203.302051] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.418s)
[203.436554] [033/133] (817s left) gem_exec_flush (basic-wb-pro-default)
[203.503118] Starting subtest: basic-wb-pro-default
[208.957230] Subtest basic-wb-pro-default: SUCCESS (5.455s)
[209.143399] [034/133] (811s left) i915_query (query-garbage)
[209.195129] Starting subtest: query-garbage
[209.197237] Subtest query-garbage: SUCCESS (0.000s)
[209.315568] [035/133] (811s left) kms_addfb_basic (invalid-get-prop)
[209.375541] Starting subtest: invalid-get-prop
[209.377513] Subtest invalid-get-prop: SUCCESS (0.000s)
[209.528017] [036/133] (811s left) kms_content_protection (lic-type-0-hdcp14)
[209.671602] Starting subtest: lic-type-0-hdcp14
[209.676167] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[209.792704] [037/133] (811s left) kms_pm_rpm (fences-dpms)
[211.307854] Starting subtest: fences-dpms
[211.312620] Subtest fences-dpms: SKIP (0.000s)
[212.044751] [038/133] (808s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[212.100739] Subtest tiled-to-untiled: SKIP (0.000s)
[212.170742] [039/133] (808s left) kms_properties (plane-properties-atomic)
[212.256438] Starting subtest: plane-properties-atomic
[212.258592] Starting dynamic subtest: pipe-A-eDP-1
[212.806478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[212.816127] Starting dynamic subtest: pipe-B-eDP-1
[214.100645] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.292s)
[214.110973] Starting dynamic subtest: pipe-C-eDP-1
[215.336414] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[215.346164] Starting dynamic subtest: pipe-D-eDP-1
[216.562305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[216.564719] Subtest plane-properties-atomic: SUCCESS (4.308s)
[217.368621] [040/133] (803s left) gem_exec_schedule (preempt-engines)
[217.442258] Starting subtest: preempt-engines
[217.444241] Starting dynamic subtest: rcs0
[219.701428] Dynamic subtest rcs0: SUCCESS (2.266s)
[219.710712] Starting dynamic subtest: bcs0
[221.929305] Dynamic subtest bcs0: SUCCESS (2.227s)
[221.938818] Starting dynamic subtest: vcs0
[224.234336] Dynamic subtest vcs0: SUCCESS (2.303s)
[224.245322] Starting dynamic subtest: vcs1
[226.545036] Dynamic subtest vcs1: SUCCESS (2.309s)
[226.556045] Starting dynamic subtest: vecs0
[228.868762] Dynamic subtest vecs0: SUCCESS (2.322s)
[228.878616] Starting dynamic subtest: ccs0
[231.153957] Dynamic subtest ccs0: SUCCESS (2.283s)
[231.156402] Subtest preempt-engines: SUCCESS (13.718s)
[231.457271] [041/133] (789s left) kms_plane_multiple (2x-tiling-none)
[231.548042] Starting subtest: 2x-tiling-none
[231.552611] Subtest 2x-tiling-none: SKIP (0.000s)
[231.621741] [042/133] (789s left) kms_addfb_basic (bad-pitch-0)
[231.677053] Starting subtest: bad-pitch-0
[231.679211] Subtest bad-pitch-0: SUCCESS (0.000s)
[231.817613] [043/133] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[231.924357] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[231.928585] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[232.017268] [044/133] (789s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[232.142109] Starting subtest: basic-busy-flip-before-cursor-atomic
[232.146911] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[232.297716] [045/133] (788s left) kms_psr (fbc-pr-primary-blt)
[232.399405] Starting subtest: fbc-pr-primary-blt
[232.402762] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[232.469243] [046/133] (788s left) kms_pipe_crc_basic (nonblocking-crc)
[232.561549] Starting subtest: nonblocking-crc
[232.563476] Starting dynamic subtest: pipe-A-eDP-1
[233.306330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[233.316322] Starting dynamic subtest: pipe-B-eDP-1
[234.771805] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.462s)
[234.782471] Starting dynamic subtest: pipe-C-eDP-1
[236.147606] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[236.158225] Starting dynamic subtest: pipe-D-eDP-1
[237.476313] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[237.478798] Subtest nonblocking-crc: SUCCESS (4.914s)
[238.285121] [047/133] (783s left) kms_plane_scaling (planes-scaler-unity-scaling)
[238.384539] Starting subtest: planes-scaler-unity-scaling
[238.386851] Starting dynamic subtest: pipe-A
[238.446763] Dynamic subtest pipe-A: SUCCESS (0.064s)
[238.458481] Starting dynamic subtest: pipe-B
[239.611380] Dynamic subtest pipe-B: SUCCESS (1.164s)
[239.621172] Starting dynamic subtest: pipe-C
[240.720737] Dynamic subtest pipe-C: SUCCESS (1.108s)
[240.735966] Starting dynamic subtest: pipe-D
[241.847290] Dynamic subtest pipe-D: SUCCESS (1.126s)
[241.849519] Subtest planes-scaler-unity-scaling: SUCCESS (3.465s)
[243.010844] [048/133] (778s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[243.067572] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[243.167555] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[243.246464] [049/133] (778s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[243.338474] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[243.340779] Starting dynamic subtest: pipe-A-default-mode
[244.471816] Dynamic subtest pipe-A-default-mode: SKIP (1.131s)
[244.476134] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.132s)
[244.610858] [050/133] (776s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[244.714971] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[244.719203] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[244.807608] [051/133] (776s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[244.902475] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[244.904846] Starting dynamic subtest: pipe-A-eDP-1
[245.004802] Dynamic subtest pipe-A-eDP-1: SKIP (0.103s)
[245.015035] Starting dynamic subtest: pipe-B-eDP-1
[246.116644] Dynamic subtest pipe-B-eDP-1: SKIP (1.111s)
[246.121328] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.216s)
[247.311989] [052/133] (774s left) kms_async_flips (test-time-stamp)
[247.415227] Starting subtest: test-time-stamp
[247.786888] Starting dynamic subtest: pipe-A-eDP-1
[248.621229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[248.996909] Starting dynamic subtest: pipe-B-eDP-1
[249.743582] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s)
[250.161878] Starting dynamic subtest: pipe-C-eDP-1
[250.886182] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.742s)
[251.256643] Starting dynamic subtest: pipe-D-eDP-1
[252.016044] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[252.018441] Subtest test-time-stamp: SUCCESS (4.600s)
[253.179098] [053/133] (768s left) i915_query (engine-info)
[253.243857] Starting subtest: engine-info
[253.249736] Subtest engine-info: SUCCESS (0.008s)
[253.377366] [054/133] (768s left) kms_async_flips (alternate-sync-async-flip-atomic)
[253.465584] Starting subtest: alternate-sync-async-flip-atomic
[253.844180] Starting dynamic subtest: pipe-A-eDP-1
[256.667522] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.824s)
[257.059572] Starting dynamic subtest: pipe-B-eDP-1
[259.795213] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.744s)
[260.208192] Starting dynamic subtest: pipe-C-eDP-1
[262.929785] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.731s)
[263.296662] Starting dynamic subtest: pipe-D-eDP-1
[266.061457] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[266.063457] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.598s)
[267.251983] [055/133] (754s left) gem_lmem_swapping (massive-random)
[267.316159] Subtest massive-random: SKIP (0.000s)
[267.361074] [056/133] (754s left) kms_flip (absolute-wf_vblank)
[267.445595] Starting subtest: absolute-wf_vblank
[267.447913] Starting dynamic subtest: A-eDP1
[276.183164] Dynamic subtest A-eDP1: SUCCESS (8.736s)
[276.194309] Starting dynamic subtest: B-eDP1
[284.909202] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[284.926194] Starting dynamic subtest: C-eDP1
[293.625328] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[293.635269] Starting dynamic subtest: D-eDP1
[302.354154] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[302.358868] Subtest absolute-wf_vblank: SUCCESS (34.913s)
[303.566638] [057/133] (718s left) prime_mmap (test_aperture_limit)
[303.616527] Starting subtest: test_aperture_limit
[303.618631] Starting dynamic subtest: test_aperture_limit-smem
[303.624141] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[303.628128] Subtest test_aperture_limit: SKIP (0.009s)
[303.726372] [058/133] (718s left) prime_vgem (basic-blt)
[303.798394] Starting subtest: basic-blt
[303.837224] Subtest basic-blt: SUCCESS (0.038s)
[303.957587] [059/133] (717s left) kms_busy (extended-modeset-hang-oldfb)
[304.063114] Starting subtest: extended-modeset-hang-oldfb
[304.065339] Starting dynamic subtest: pipe-A
[315.644429] Dynamic subtest pipe-A: SUCCESS (11.580s)
[315.653981] Starting dynamic subtest: pipe-D
[327.906664] Dynamic subtest pipe-D: SUCCESS (12.258s)
[327.909011] Subtest extended-modeset-hang-oldfb: SUCCESS (23.843s)
[328.726987] [060/133] (693s left) gem_mmap_offset (mmap-unmap)
[328.786737] Starting subtest: mmap-unmap
[328.789276] Starting dynamic subtest: smem0
[352.095271] Dynamic subtest smem0: SUCCESS (23.307s)
[352.097457] Subtest mmap-unmap: SUCCESS (23.308s)
[352.225159] [061/133] (669s left) gem_pxp (create-protected-buffer)
[352.357300] Starting subtest: create-protected-buffer
[352.360051] Subtest create-protected-buffer: SUCCESS (0.000s)
[352.463706] [062/133] (669s left) gem_ppgtt (blt-vs-render-ctx0)
[352.516830] Starting subtest: blt-vs-render-ctx0
[385.454635] Subtest blt-vs-render-ctx0: SUCCESS (32.934s)
[385.587769] [063/133] (636s left) gem_exec_gttfill (engines)
[385.689364] Starting subtest: engines
[385.691978] Starting dynamic subtest: rcs0
[409.074904] Dynamic subtest rcs0: SUCCESS (23.383s)
[409.085995] Starting dynamic subtest: bcs0
[432.425826] Dynamic subtest bcs0: SUCCESS (23.347s)
[432.436020] Starting dynamic subtest: vcs0
[455.723800] Dynamic subtest vcs0: SUCCESS (23.294s)
[455.736155] Starting dynamic subtest: vcs1
[478.993332] Dynamic subtest vcs1: SUCCESS (23.267s)
[479.008296] Starting dynamic subtest: vecs0
[502.350831] Dynamic subtest vecs0: SUCCESS (23.353s)
[502.364326] Starting dynamic subtest: ccs0
[525.746449] Dynamic subtest ccs0: SUCCESS (23.393s)
[525.749287] Subtest engines: SUCCESS (140.051s)
[525.937701] [064/133] (496s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[526.086237] Starting subtest: bad-pixel-format-yf-tiled-ccs
[526.088522] Starting dynamic subtest: pipe-A-eDP-1
[526.110450] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[526.121749] Starting dynamic subtest: pipe-B-eDP-1
[526.143330] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[526.153020] Starting dynamic subtest: pipe-C-eDP-1
[526.174104] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[526.183295] Starting dynamic subtest: pipe-D-eDP-1
[526.205084] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[526.209459] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[528.352231] [065/133] (493s left) kms_vblank (query-idle)
[528.448450] Starting subtest: query-idle
[528.450457] Starting dynamic subtest: pipe-A-eDP-1
[530.189904] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.740s)
[530.205830] Starting dynamic subtest: pipe-D-eDP-1
[532.598311] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.407s)
[532.600743] Subtest query-idle: SUCCESS (4.151s)
[533.428027] [066/133] (488s left) kms_rotation_crc (exhaust-fences)
[533.528706] Starting subtest: exhaust-fences
[533.533145] Subtest exhaust-fences: SKIP (0.000s)
[533.604065] [067/133] (488s left) gem_ctx_exec (basic-norecovery)
[533.664626] Starting subtest: basic-norecovery
[534.007469] Subtest basic-norecovery: SUCCESS (0.344s)
[534.144271] [068/133] (488s left) gem_exec_balancer (smoke)
[534.203561] Starting subtest: smoke
[556.834036] Subtest smoke: SUCCESS (22.628s)
[557.906488] [069/133] (464s left) gem_softpin (evict-prime-sanity-check)
[557.969360] Starting subtest: evict-prime-sanity-check
[557.971830] Starting dynamic subtest: rcs0
[559.120286] Dynamic subtest rcs0: SUCCESS (1.150s)
[559.134447] Starting dynamic subtest: bcs0
[560.245832] Dynamic subtest bcs0: SUCCESS (1.123s)
[560.259379] Starting dynamic subtest: vcs0
[562.038316] Dynamic subtest vcs0: SUCCESS (1.790s)
[562.051549] Starting dynamic subtest: vcs1
[564.086975] Dynamic subtest vcs1: SUCCESS (2.046s)
[564.099665] Starting dynamic subtest: vecs0
[566.071069] Dynamic subtest vecs0: SUCCESS (1.981s)
[566.085804] Starting dynamic subtest: ccs0
[567.188375] Dynamic subtest ccs0: SUCCESS (1.117s)
[567.199159] Starting dynamic subtest: all
[568.301548] Dynamic subtest all: SUCCESS (1.112s)
[568.304144] Subtest evict-prime-sanity-check: SUCCESS (10.333s)
[568.388230] [070/133] (453s left) kms_getfb (getfb2-handle-closed)
[568.487011] Starting subtest: getfb2-handle-closed
[568.488992] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[568.589792] [071/133] (453s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[568.683560] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[568.685674] Starting dynamic subtest: pipe-A-eDP-1
[568.707664] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[568.720373] Starting dynamic subtest: pipe-B-eDP-1
[568.740628] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[568.751090] Starting dynamic subtest: pipe-C-eDP-1
[568.771868] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[568.783463] Starting dynamic subtest: pipe-D-eDP-1
[568.804515] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[568.808335] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[570.979398] [072/133] (451s left) i915_drm_fdinfo (virtual-busy-all)
[571.033548] Starting subtest: virtual-busy-all
[571.038038] Subtest virtual-busy-all: SKIP (0.000s)
[571.106157] [073/133] (451s left) gem_media_vme
[571.260752] [074/133] (451s left) gem_wait (await)
[571.326886] Starting subtest: await
[571.329075] Starting dynamic subtest: all-engines
[572.445915] Dynamic subtest all-engines: SUCCESS (1.122s)
[572.466653] Starting dynamic subtest: rcs0
[573.509751] Dynamic subtest rcs0: SUCCESS (1.061s)
[573.527400] Starting dynamic subtest: bcs0
[574.570738] Dynamic subtest bcs0: SUCCESS (1.058s)
[574.587389] Starting dynamic subtest: vcs0
[575.625755] Dynamic subtest vcs0: SUCCESS (1.053s)
[575.643838] Starting dynamic subtest: vcs1
[576.679945] Dynamic subtest vcs1: SUCCESS (1.052s)
[576.697840] Starting dynamic subtest: vecs0
[577.734675] Dynamic subtest vecs0: SUCCESS (1.052s)
[577.752222] Starting dynamic subtest: ccs0
[578.792029] Dynamic subtest ccs0: SUCCESS (1.055s)
[578.794566] Subtest await: SUCCESS (7.469s)
[578.994040] [075/133] (443s left) i915_drm_fdinfo (virtual-idle)
[579.033424] Starting subtest: virtual-idle
[582.074940] Subtest virtual-idle: SUCCESS (3.037s)
[582.163239] [076/133] (440s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[582.218518] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[582.220695] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[582.326656] [077/133] (440s left) kms_flip (2x-flip-vs-suspend)
[582.419568] Starting subtest: 2x-flip-vs-suspend
[582.423943] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[582.534547] [078/133] (440s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[582.589118] Starting subtest: wait-all-for-submit-delayed-submit
[582.693896] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[582.786044] [079/133] (439s left) kms_frontbuffer_tracking (fbc-suspend)
[582.874094] Starting subtest: fbc-suspend
[621.165917] Subtest fbc-suspend: SUCCESS (7.536s)
[622.353609] [080/133] (400s left) kms_hdr (static-toggle-dpms)
[622.459237] Starting subtest: static-toggle-dpms
[622.465746] Subtest static-toggle-dpms: SKIP (0.000s)
[622.536397] [081/133] (400s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[622.603477] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[622.607916] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[622.803289] [082/133] (400s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[622.896902] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[629.921999] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.022s)
[630.063724] [083/133] (392s left) perf (i915-ref-count)
[630.151356] Starting subtest: i915-ref-count
[630.200902] Subtest i915-ref-count: SUCCESS (0.047s)
[630.260107] [084/133] (392s left) i915_pm_rpm (debugfs-forcewake-user)
[632.016074] Starting subtest: debugfs-forcewake-user
[643.412394] Subtest debugfs-forcewake-user: SUCCESS (11.390s)
[643.800184] [085/133] (379s left) kms_lease (cursor-implicit-plane)
[643.901073] Starting subtest: cursor-implicit-plane
[643.903236] Starting dynamic subtest: pipe-A-eDP-1
[644.359652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[644.372046] Starting dynamic subtest: pipe-B-eDP-1
[645.517565] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[645.528922] Starting dynamic subtest: pipe-C-eDP-1
[646.629038] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[646.640159] Starting dynamic subtest: pipe-D-eDP-1
[647.763257] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[647.765463] Subtest cursor-implicit-plane: SUCCESS (3.863s)
[648.625958] [086/133] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[648.729741] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[648.733668] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[648.818654] [087/133] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[648.922522] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[648.926962] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[649.017244] [088/133] (374s left) kms_dsc (dsc-with-output-formats-with-bpc)
[649.104872] Starting subtest: dsc-with-output-formats-with-bpc
[649.160758] Subtest dsc-with-output-formats-with-bpc: SKIP (0.003s)
[649.202405] [089/133] (373s left) vgem_basic (mmap)
[649.251496] Starting subtest: mmap
[649.258345] Subtest mmap: SUCCESS (0.008s)
[649.323468] [090/133] (373s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[649.435554] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[649.437880] Starting dynamic subtest: pipe-A-eDP-1
[649.510395] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[649.524059] Starting dynamic subtest: pipe-B-eDP-1
[650.601363] Dynamic subtest pipe-B-eDP-1: SKIP (1.090s)
[650.605548] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.171s)
[651.785235] [091/133] (371s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[651.878909] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[651.881171] Starting dynamic subtest: pipe-A-eDP-1
[651.903255] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[651.914932] Starting dynamic subtest: pipe-B-eDP-1
[651.935519] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[651.945436] Starting dynamic subtest: pipe-C-eDP-1
[651.965982] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[651.975359] Starting dynamic subtest: pipe-D-eDP-1
[651.996480] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[652.000545] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.005s)
[654.171565] [092/133] (369s left) gem_exec_parallel (basic)
[654.232135] Starting subtest: basic
[654.234515] Starting dynamic subtest: rcs0
[655.702174] Dynamic subtest rcs0: SUCCESS (1.469s)
[655.714950] Starting dynamic subtest: bcs0
[657.173152] Dynamic subtest bcs0: SUCCESS (1.469s)
[657.185369] Starting dynamic subtest: vcs0
[658.863135] Dynamic subtest vcs0: SUCCESS (1.687s)
[658.879043] Starting dynamic subtest: vcs1
[660.765405] Dynamic subtest vcs1: SUCCESS (1.898s)
[660.779938] Starting dynamic subtest: vecs0
[662.814400] Dynamic subtest vecs0: SUCCESS (2.046s)
[662.827604] Starting dynamic subtest: ccs0
[664.291500] Dynamic subtest ccs0: SUCCESS (1.476s)
[664.294071] Subtest basic: SUCCESS (10.061s)
[664.485445] [093/133] (358s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[664.538911] Starting subtest: multi-wait-all-for-submit-submitted
[664.642252] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[664.726370] [094/133] (358s left) kms_frontbuffer_tracking (psr-slowdraw)
[664.816327] Starting subtest: psr-slowdraw
[690.074889] Subtest psr-slowdraw: SUCCESS (25.256s)
[690.168828] [095/133] (333s left) kms_universal_plane (disable-primary-vs-flip)
[690.265879] Starting subtest: disable-primary-vs-flip
[690.268016] Starting dynamic subtest: pipe-A-eDP-1
[691.862097] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.595s)
[691.873312] Starting dynamic subtest: pipe-B-eDP-1
[694.119306] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.254s)
[694.132897] Starting dynamic subtest: pipe-C-eDP-1
[696.347669] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.227s)
[696.358617] Starting dynamic subtest: pipe-D-eDP-1
[698.536528] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.186s)
[698.538912] Subtest disable-primary-vs-flip: SUCCESS (8.269s)
[699.339193] [096/133] (324s left) gem_mmap_gtt (basic)
[699.403528] Subtest basic: SKIP (0.000s)
[699.479970] [097/133] (324s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[699.573840] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[699.578327] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[699.678585] [098/133] (323s left) kms_setmode (basic)
[699.729222] Starting subtest: basic
[700.053263] Starting dynamic subtest: pipe-A-eDP-1
[702.151902] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.093s)
[702.498282] Starting dynamic subtest: pipe-B-eDP-1
[704.590699] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.098s)
[704.900251] Subtest basic: SUCCESS (5.169s)
[705.734108] [099/133] (317s left) kms_psr (fbc-psr2-sprite-blt)
[705.833165] Starting subtest: fbc-psr2-sprite-blt
[705.835277] Starting dynamic subtest: eDP-1
[705.839521] Dynamic subtest eDP-1: SKIP (0.000s)
[705.843888] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[705.945424] [100/133] (317s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[706.008639] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[706.113966] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[706.203781] [101/133] (317s left) api_intel_allocator (default-alignment)
[706.264374] Starting subtest: default-alignment
[706.267503] Subtest default-alignment: SUCCESS (0.005s)
[706.397333] [102/133] (317s left) gem_exec_reloc (basic-wc-read-noreloc)
[706.455541] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[706.525805] [103/133] (317s left) kms_psr (fbc-psr-dpms)
[706.615928] Starting subtest: fbc-psr-dpms
[706.618166] Starting dynamic subtest: eDP-1
[706.622915] Dynamic subtest eDP-1: SKIP (0.000s)
[706.626935] Subtest fbc-psr-dpms: SKIP (0.003s)
[706.699518] [104/133] (317s left) kms_cursor_edge_walk (256x256-left-edge)
[706.783070] Starting subtest: 256x256-left-edge
[706.785337] Starting dynamic subtest: pipe-A-eDP-1
[710.209657] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[710.220937] Starting dynamic subtest: pipe-D-eDP-1
[713.343623] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[713.345950] Subtest 256x256-left-edge: SUCCESS (6.561s)
[714.157118] [105/133] (309s left) kms_pm_lpsp (screens-disabled)
[715.268439] Starting subtest: screens-disabled
[715.272519] Subtest screens-disabled: SKIP (0.000s)
[715.342594] [106/133] (308s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[715.453519] Starting subtest: y-tiled-64bpp-rotate-180
[715.458104] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[715.548974] [107/133] (308s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[715.650323] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[715.654387] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[715.757350] [108/133] (308s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[715.845826] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[715.872206] Starting dynamic subtest: pipe-A-plane-0
[716.182981] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s)
[716.193674] Starting dynamic subtest: pipe-A-plane-3
[716.415793] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[717.530012] Starting dynamic subtest: pipe-B-plane-0
[717.831478] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[717.845361] Starting dynamic subtest: pipe-B-plane-3
[718.098469] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[718.413748] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.569s)
[719.220186] [109/133] (304s left) kms_psr (pr-primary-mmap-cpu)
[719.317139] Starting subtest: pr-primary-mmap-cpu
[719.321494] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[719.391185] [110/133] (304s left) perf (gen12-mi-rpc)
[719.474662] Starting subtest: gen12-mi-rpc
[719.476988] Starting dynamic subtest: rcs0
[719.497280] Dynamic subtest rcs0: SUCCESS (0.020s)
[719.499079] Subtest gen12-mi-rpc: SUCCESS (0.021s)
[719.545199] [111/133] (304s left) kms_color (ctm-red-to-blue)
[719.670937] Starting subtest: ctm-red-to-blue
[719.673037] Starting dynamic subtest: pipe-A-eDP-1
[720.378395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[720.389803] Starting dynamic subtest: pipe-B-eDP-1
[721.823617] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s)
[721.835535] Starting dynamic subtest: pipe-C-eDP-1
[723.218713] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[723.229665] Starting dynamic subtest: pipe-D-eDP-1
[724.548945] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[724.551210] Subtest ctm-red-to-blue: SUCCESS (4.879s)
[725.356304] [112/133] (298s left) gem_render_copy (yf-tiled-to-vebox-linear)
[725.415011] Starting subtest: yf-tiled-to-vebox-linear
[725.419374] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[725.596796] [113/133] (298s left) gem_exec_reloc (basic-wc-noreloc)
[725.657080] Subtest basic-wc-noreloc: SKIP (0.000s)
[725.730755] [114/133] (298s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[725.828893] Starting subtest: plane-downscale-factor-0-75-with-rotation
[725.831199] Starting dynamic subtest: pipe-A
[726.090935] Dynamic subtest pipe-A: SUCCESS (0.264s)
[726.102355] Starting dynamic subtest: pipe-B
[727.428271] Dynamic subtest pipe-B: SUCCESS (1.335s)
[727.439640] Starting dynamic subtest: pipe-C
[728.762284] Dynamic subtest pipe-C: SUCCESS (1.333s)
[728.773787] Starting dynamic subtest: pipe-D
[730.086715] Dynamic subtest pipe-D: SUCCESS (1.324s)
[730.089097] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.261s)
[731.288172] [115/133] (293s left) gem_mmap_gtt (basic-read-write)
[731.349925] Subtest basic-read-write: SKIP (0.000s)
[731.411144] [116/133] (292s left) gem_ctx_shared (q-smoketest)
[731.490093] Starting subtest: Q-smoketest
[731.492367] Starting dynamic subtest: rcs0
[737.030124] Dynamic subtest rcs0: SUCCESS (5.489s)
[737.046905] Starting dynamic subtest: bcs0
[742.518392] Dynamic subtest bcs0: SUCCESS (5.486s)
[742.532004] Starting dynamic subtest: vcs0
[747.983778] Dynamic subtest vcs0: SUCCESS (5.471s)
[747.998639] Starting dynamic subtest: vcs1
[753.467481] Dynamic subtest vcs1: SUCCESS (5.480s)
[753.481197] Starting dynamic subtest: vecs0
[758.952466] Dynamic subtest vecs0: SUCCESS (5.480s)
[758.968061] Starting dynamic subtest: ccs0
[764.459967] Dynamic subtest ccs0: SUCCESS (5.506s)
[764.462159] Subtest Q-smoketest: SUCCESS (32.921s)
[764.632032] [117/133] (259s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[764.685708] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[764.688052] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[764.798084] [118/133] (259s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[764.862253] Starting subtest: framebuffer-vs-set-tiling
[764.866865] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[765.010423] [119/133] (259s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[765.109659] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[765.113888] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[765.208776] [120/133] (259s left) gem_exec_schedule (u-fairslice)
[765.282592] Starting subtest: u-fairslice
[765.284611] Starting dynamic subtest: rcs0
[767.298936] Dynamic subtest rcs0: SUCCESS (2.021s)
[767.309582] Starting dynamic subtest: bcs0
[769.319572] Dynamic subtest bcs0: SUCCESS (2.020s)
[769.341346] Starting dynamic subtest: vcs0
[771.346284] Dynamic subtest vcs0: SUCCESS (2.024s)
[771.368452] Starting dynamic subtest: vcs1
[773.366462] Dynamic subtest vcs1: SUCCESS (2.016s)
[773.388248] Starting dynamic subtest: vecs0
[775.386302] Dynamic subtest vecs0: SUCCESS (2.020s)
[775.397115] Starting dynamic subtest: ccs0
[777.404245] Dynamic subtest ccs0: SUCCESS (2.018s)
[777.406628] Subtest u-fairslice: SUCCESS (12.126s)
[777.705778] [121/133] (246s left) gem_ctx_persistence (legacy-engines-persistence)
[777.774896] Starting subtest: legacy-engines-persistence
[777.777263] Starting dynamic subtest: render
[778.589144] Dynamic subtest render: SUCCESS (0.813s)
[778.604901] Starting dynamic subtest: bsd1
[779.331072] Dynamic subtest bsd1: SUCCESS (0.739s)
[779.344571] Starting dynamic subtest: bsd2
[780.124906] Dynamic subtest bsd2: SUCCESS (0.791s)
[780.139293] Starting dynamic subtest: blt
[780.867101] Dynamic subtest blt: SUCCESS (0.739s)
[780.880459] Starting dynamic subtest: vebox
[781.637238] Dynamic subtest vebox: SUCCESS (0.768s)
[781.639915] Subtest legacy-engines-persistence: SUCCESS (3.862s)
[781.786196] [122/133] (242s left) syncobj_wait (single-wait-for-submit-signaled)
[781.835197] Starting subtest: single-wait-for-submit-signaled
[781.837582] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[781.938325] [123/133] (242s left) kms_cursor_legacy (forked-bo)
[782.056219] Starting subtest: forked-bo
[782.058492] Starting dynamic subtest: pipe-A
[787.526967] Dynamic subtest pipe-A: SUCCESS (5.467s)
[787.542294] Starting dynamic subtest: pipe-B
[792.998147] Dynamic subtest pipe-B: SUCCESS (5.468s)
[793.011724] Starting dynamic subtest: pipe-C
[798.471902] Dynamic subtest pipe-C: SUCCESS (5.470s)
[798.486777] Starting dynamic subtest: pipe-D
[803.956661] Dynamic subtest pipe-D: SUCCESS (5.481s)
[803.970148] Starting dynamic subtest: all-pipes
[809.461216] Dynamic subtest all-pipes: SUCCESS (5.500s)
[809.463743] Subtest forked-bo: SUCCESS (27.398s)
[809.601797] [124/133] (215s left) kms_cursor_crc (cursor-random-128x128)
[809.862810] Starting subtest: cursor-random-128x128
[809.867904] Starting dynamic subtest: pipe-A-eDP-1
[813.209883] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.342s)
[813.242347] Starting dynamic subtest: pipe-D-eDP-1
[817.193749] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.962s)
[817.196478] Subtest cursor-random-128x128: SUCCESS (7.332s)
[818.046133] [125/133] (206s left) kms_psr (psr2-dpms)
[818.144999] Starting subtest: psr2-dpms
[818.147279] Starting dynamic subtest: eDP-1
[821.080293] Dynamic subtest eDP-1: SUCCESS (2.935s)
[821.082611] Subtest psr2-dpms: SUCCESS (2.936s)
[821.941163] [126/133] (202s left) gem_softpin (evict-snoop-interruptible)
[821.993867] Starting subtest: evict-snoop-interruptible
[821.998865] Subtest evict-snoop-interruptible: SKIP (0.000s)
[822.103620] [127/133] (202s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[822.216997] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[826.456454] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.240s)
[827.670364] [128/133] (197s left) gem_exec_whisper (basic-fds-forked-all)
[827.742668] Starting subtest: basic-fds-forked-all
[848.465572] Subtest basic-fds-forked-all: SUCCESS (20.716s)
[848.651900] [129/133] (176s left) kms_chamelium_color (degamma)
[848.753080] Subtest degamma: SKIP (0.000s)
[848.836535] [130/133] (176s left) gem_eio (in-flight-contexts-10ms)
[849.089954] Starting subtest: in-flight-contexts-10ms
[862.829897] Subtest in-flight-contexts-10ms: SUCCESS (13.743s)
[862.987020] [131/133] (162s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[863.092595] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[870.380246] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.293s)
[870.534476] [132/133] (154s left) kms_cursor_crc (cursor-offscreen-256x256)
[870.792892] Starting subtest: cursor-offscreen-256x256
[870.798167] Starting dynamic subtest: pipe-A-eDP-1
[872.778670] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.983s)
[872.811681] Starting dynamic subtest: pipe-D-eDP-1
[875.404265] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.601s)
[875.406939] Subtest cursor-offscreen-256x256: SUCCESS (4.610s)
[876.254803] [133/133] (148s left) kms_chamelium_audio (hdmi-audio)
[876.664580] Subtest hdmi-audio: SKIP (0.000s)
[877.469201] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: gem_create
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_force_connector_basic
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: prime_self_import
results: parsing output: 8/ for test: core_setmaster
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gen9_exec_parse
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: api_intel_bb
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_chamelium_hpd
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: vgem_basic
results: parsing output: 30/ for test: prime_mmap_coherency
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_flush
results: parsing output: 33/ for test: i915_query
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: gem_set_tiling_vs_blt
results: parsing output: 38/ for test: kms_properties
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_plane_multiple
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_pipe_crc_basic
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_async_flips
results: parsing output: 52/ for test: i915_query
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: gem_lmem_swapping
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: prime_mmap
results: parsing output: 57/ for test: prime_vgem
results: parsing output: 58/ for test: kms_busy
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: gem_ppgtt
results: parsing output: 62/ for test: gem_exec_gttfill
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: gem_ctx_exec
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: kms_getfb
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: gem_media_vme
results: parsing output: 73/ for test: gem_wait
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_hdr
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: i915_pm_rpm
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_dsc
results: parsing output: 88/ for test: vgem_basic
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: gem_exec_parallel
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_universal_plane
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_setmode
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: api_intel_allocator
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_cursor_edge_walk
results: parsing output: 104/ for test: kms_pm_lpsp
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_color
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: gem_ctx_shared
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: kms_chamelium_audio
Done.