[57.315301] Initializing watchdogs
[57.315354]   /dev/watchdog0
[57.329703] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.334087] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.336340] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.339494] [001/133] (960s left) gem_exec_fence (submit67)
[57.546408] Starting subtest: submit67
[57.551254] Subtest submit67: SKIP (0.000s)
[59.347956] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[59.350684] [002/133] (958s left) perf_pmu (gt-awake)
[59.390335] Starting subtest: gt-awake
[68.289803] Subtest gt-awake: SUCCESS (8.902s)
[68.395426] [003/133] (949s left) gem_create (hog-create)
[68.457746] Starting subtest: hog-create
[68.460199] Starting dynamic subtest: smem0
[101.314929] Dynamic subtest smem0: SUCCESS (32.860s)
[101.317344] Subtest hog-create: SUCCESS (32.861s)
[101.502082] [004/133] (916s left) kms_flip (plain-flip-ts-check-interruptible)
[101.619978] Starting subtest: plain-flip-ts-check-interruptible
[101.622331] Starting dynamic subtest: A-eDP1
[110.516437] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[110.527091] Starting dynamic subtest: B-eDP1
[119.344363] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[119.353042] Starting dynamic subtest: C-eDP1
[128.167578] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[128.179040] Starting dynamic subtest: D-eDP1
[137.006810] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[137.009213] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.390s)
[138.195577] [005/133] (879s left) kms_force_connector_basic (force-load-detect)
[138.282219] Starting subtest: force-load-detect
[138.286550] Subtest force-load-detect: SKIP (0.000s)
[138.396946] [006/133] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[138.507994] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[138.512092] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[138.641474] [007/133] (879s left) syncobj_wait (single-wait-for-submit-submitted)
[138.709698] Starting subtest: single-wait-for-submit-submitted
[138.814362] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[138.893704] [008/133] (879s left) prime_self_import (reimport-vs-gem_close-race)
[138.933174] Starting subtest: reimport-vs-gem_close-race
[144.011090] Subtest reimport-vs-gem_close-race: SUCCESS (5.077s)
[144.086990] [009/133] (874s left) core_setmaster (master-drop-set-user)
[144.182025] Starting subtest: master-drop-set-user
[144.193059] Subtest master-drop-set-user: SUCCESS (0.014s)
[144.234952] [010/133] (874s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[144.334823] Starting subtest: x-tiled-16bpp-rotate-90
[144.367287] Subtest x-tiled-16bpp-rotate-90: SKIP (0.032s)
[144.483910] [011/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[144.583215] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[144.587834] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[144.676285] [012/133] (873s left) gen9_exec_parse (bb-start-param)
[144.740192] Subtest bb-start-param: SKIP (0.000s)
[144.807201] [013/133] (873s left) kms_big_fb (linear-64bpp-rotate-0)
[144.905815] Starting subtest: linear-64bpp-rotate-0
[146.506338] Subtest linear-64bpp-rotate-0: SUCCESS (1.601s)
[146.692994] [014/133] (871s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[146.807700] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[147.604685] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.798s)
[147.790893] [015/133] (870s left) kms_flip (basic-flip-vs-wf_vblank)
[147.893829] Starting subtest: basic-flip-vs-wf_vblank
[147.897930] Starting dynamic subtest: A-eDP1
[149.840292] Dynamic subtest A-eDP1: SUCCESS (1.943s)
[149.853984] Starting dynamic subtest: B-eDP1
[151.776141] Dynamic subtest B-eDP1: SUCCESS (1.935s)
[151.787196] Starting dynamic subtest: C-eDP1
[153.703931] Dynamic subtest C-eDP1: SUCCESS (1.926s)
[153.714208] Starting dynamic subtest: D-eDP1
[155.634357] Dynamic subtest D-eDP1: SUCCESS (1.929s)
[155.636690] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.745s)
[156.864045] [016/133] (861s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[156.966695] Starting subtest: psr-2p-pri-indfb-multidraw
[156.971374] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[157.055509] [017/133] (861s left) gem_ccs (block-copy-compressed)
[157.112045] Starting subtest: block-copy-compressed
[157.116276] Subtest block-copy-compressed: SKIP (0.000s)
[157.205872] [018/133] (861s left) kms_psr (psr-suspend)
[157.305373] Starting subtest: psr-suspend
[157.307653] Starting dynamic subtest: eDP-1
[175.381369] Dynamic subtest eDP-1: SUCCESS (3.055s)
[175.383733] Subtest psr-suspend: SUCCESS (3.056s)
[176.233644] [019/133] (842s left) sw_sync (sync_multi_producer_single_consumer)
[176.288096] Starting subtest: sync_multi_producer_single_consumer
[177.362791] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[177.423751] [020/133] (841s left) api_intel_bb (destroy-bb)
[177.482899] Starting subtest: destroy-bb
[177.493311] Subtest destroy-bb: SUCCESS (0.009s)
[177.604114] [021/133] (841s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[177.713009] Starting subtest: cursorA-vs-flipB-legacy
[177.717583] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[177.861243] [022/133] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[177.962741] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[177.966815] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[178.053772] [023/133] (840s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[178.154735] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[178.767431] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.615s)
[178.930935] [024/133] (839s left) perf (short-reads)
[179.070310] Starting subtest: short-reads
[179.083274] Subtest short-reads: SUCCESS (0.015s)
[179.127450] [025/133] (839s left) gem_exec_balancer (parallel)
[179.392430] Starting subtest: parallel
[180.355676] Subtest parallel: SUCCESS (0.964s)
[181.337498] [026/133] (837s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[181.458561] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[181.460799] Starting dynamic subtest: pipe-A-eDP-1
[181.483401] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[181.494243] Starting dynamic subtest: pipe-B-eDP-1
[181.517328] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[181.528305] Starting dynamic subtest: pipe-C-eDP-1
[181.549471] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[181.558915] Starting dynamic subtest: pipe-D-eDP-1
[181.580271] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[181.584204] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[183.621967] [027/133] (835s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[183.743905] Starting subtest: 2x-cursor-vs-flip-legacy
[183.748883] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[183.908840] [028/133] (835s left) kms_chamelium_hpd (dp-hpd-storm)
[184.292625] Subtest dp-hpd-storm: SKIP (0.000s)
[185.122235] [029/133] (833s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[185.188140] Starting subtest: etime-multi-wait-all-for-submit-submitted
[185.300891] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[185.398532] [030/133] (833s left) vgem_basic (busy-fence)
[185.451201] Starting subtest: busy-fence
[185.453519] Subtest busy-fence: SUCCESS (0.000s)
[185.508869] [031/133] (833s left) prime_mmap_coherency (read)
[185.565621] Starting subtest: read
[190.941420] Subtest read: SUCCESS (5.375s)
[191.061331] [032/133] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[191.161085] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[200.569812] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.411s)
[200.709930] [033/133] (818s left) gem_exec_flush (basic-wb-pro-default)
[200.777912] Starting subtest: basic-wb-pro-default
[206.233246] Subtest basic-wb-pro-default: SUCCESS (5.458s)
[206.418111] [034/133] (812s left) i915_query (query-garbage)
[206.486077] Starting subtest: query-garbage
[206.488486] Subtest query-garbage: SUCCESS (0.000s)
[206.603725] [035/133] (812s left) kms_addfb_basic (invalid-get-prop)
[206.666902] Starting subtest: invalid-get-prop
[206.669213] Subtest invalid-get-prop: SUCCESS (0.000s)
[206.817287] [036/133] (812s left) kms_content_protection (lic-type-0-hdcp14)
[206.967165] Starting subtest: lic-type-0-hdcp14
[206.971228] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[207.090416] [037/133] (812s left) kms_pm_rpm (fences-dpms)
[208.617089] Starting subtest: fences-dpms
[208.622091] Subtest fences-dpms: SKIP (0.000s)
[209.331606] [038/133] (810s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[209.386973] Subtest tiled-to-untiled: SKIP (0.000s)
[209.462724] [039/133] (810s left) kms_properties (plane-properties-atomic)
[209.554929] Starting subtest: plane-properties-atomic
[209.557353] Starting dynamic subtest: pipe-A-eDP-1
[210.115468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[210.126177] Starting dynamic subtest: pipe-B-eDP-1
[211.383875] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.268s)
[211.394725] Starting dynamic subtest: pipe-C-eDP-1
[212.621747] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[212.631860] Starting dynamic subtest: pipe-D-eDP-1
[213.865337] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[213.867642] Subtest plane-properties-atomic: SUCCESS (4.309s)
[214.675309] [040/133] (804s left) gem_exec_schedule (preempt-engines)
[214.747966] Starting subtest: preempt-engines
[214.750009] Starting dynamic subtest: rcs0
[217.055957] Dynamic subtest rcs0: SUCCESS (2.314s)
[217.070461] Starting dynamic subtest: bcs0
[219.304189] Dynamic subtest bcs0: SUCCESS (2.247s)
[219.316962] Starting dynamic subtest: vcs0
[221.667107] Dynamic subtest vcs0: SUCCESS (2.362s)
[221.679421] Starting dynamic subtest: vcs1
[223.958813] Dynamic subtest vcs1: SUCCESS (2.291s)
[223.971296] Starting dynamic subtest: vecs0
[226.251804] Dynamic subtest vecs0: SUCCESS (2.292s)
[226.263743] Starting dynamic subtest: ccs0
[228.534718] Dynamic subtest ccs0: SUCCESS (2.282s)
[228.537430] Subtest preempt-engines: SUCCESS (13.795s)
[228.842010] [041/133] (790s left) kms_plane_multiple (2x-tiling-none)
[228.950276] Starting subtest: 2x-tiling-none
[228.954665] Subtest 2x-tiling-none: SKIP (0.000s)
[229.024940] [042/133] (790s left) kms_addfb_basic (bad-pitch-0)
[229.092148] Starting subtest: bad-pitch-0
[229.094507] Subtest bad-pitch-0: SUCCESS (0.000s)
[229.237423] [043/133] (790s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[229.339857] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[229.344019] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[229.439145] [044/133] (790s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[229.571241] Starting subtest: basic-busy-flip-before-cursor-atomic
[229.575775] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[229.719076] [045/133] (790s left) kms_psr (fbc-pr-primary-blt)
[229.817089] Starting subtest: fbc-pr-primary-blt
[229.820822] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[229.890814] [046/133] (789s left) kms_pipe_crc_basic (nonblocking-crc)
[229.982239] Starting subtest: nonblocking-crc
[229.984228] Starting dynamic subtest: pipe-A-eDP-1
[230.728614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s)
[230.744459] Starting dynamic subtest: pipe-B-eDP-1
[232.177334] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[232.188972] Starting dynamic subtest: pipe-C-eDP-1
[233.582079] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.402s)
[233.592823] Starting dynamic subtest: pipe-D-eDP-1
[234.973265] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.390s)
[234.975807] Subtest nonblocking-crc: SUCCESS (4.991s)
[235.801177] [047/133] (784s left) kms_plane_scaling (planes-scaler-unity-scaling)
[235.892205] Starting subtest: planes-scaler-unity-scaling
[235.894359] Starting dynamic subtest: pipe-A
[235.956087] Dynamic subtest pipe-A: SUCCESS (0.064s)
[235.966400] Starting dynamic subtest: pipe-B
[237.121223] Dynamic subtest pipe-B: SUCCESS (1.164s)
[237.133499] Starting dynamic subtest: pipe-C
[238.225425] Dynamic subtest pipe-C: SUCCESS (1.103s)
[238.238233] Starting dynamic subtest: pipe-D
[239.359175] Dynamic subtest pipe-D: SUCCESS (1.133s)
[239.361346] Subtest planes-scaler-unity-scaling: SUCCESS (3.468s)
[240.508415] [048/133] (779s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[240.565589] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[240.674375] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[240.766781] [049/133] (779s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[240.850229] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[240.852591] Starting dynamic subtest: pipe-A-default-mode
[241.975321] Dynamic subtest pipe-A-default-mode: SKIP (1.125s)
[241.979370] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.126s)
[242.125921] [050/133] (777s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[242.238811] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[242.243258] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[242.337379] [051/133] (777s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[242.435554] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[242.437842] Starting dynamic subtest: pipe-A-eDP-1
[242.535193] Dynamic subtest pipe-A-eDP-1: SKIP (0.103s)
[242.545007] Starting dynamic subtest: pipe-B-eDP-1
[243.723637] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s)
[243.728340] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.292s)
[244.905765] [052/133] (775s left) kms_async_flips (test-time-stamp)
[244.996062] Starting subtest: test-time-stamp
[245.372175] Starting dynamic subtest: pipe-A-eDP-1
[246.206940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.834s)
[246.597717] Starting dynamic subtest: pipe-B-eDP-1
[247.356742] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[247.736001] Starting dynamic subtest: pipe-C-eDP-1
[248.496165] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[248.863982] Starting dynamic subtest: pipe-D-eDP-1
[249.632807] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[249.635259] Subtest test-time-stamp: SUCCESS (4.638s)
[250.786123] [053/133] (769s left) i915_query (engine-info)
[250.839408] Starting subtest: engine-info
[250.844679] Subtest engine-info: SUCCESS (0.007s)
[250.948128] [054/133] (769s left) kms_async_flips (alternate-sync-async-flip-atomic)
[251.044850] Starting subtest: alternate-sync-async-flip-atomic
[251.429385] Starting dynamic subtest: pipe-A-eDP-1
[254.179548] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s)
[254.564417] Starting dynamic subtest: pipe-B-eDP-1
[257.311015] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[257.691242] Starting dynamic subtest: pipe-C-eDP-1
[260.449427] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[260.814657] Starting dynamic subtest: pipe-D-eDP-1
[263.582070] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[263.584207] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.541s)
[264.757856] [055/133] (755s left) gem_lmem_swapping (massive-random)
[264.809133] Subtest massive-random: SKIP (0.000s)
[264.856308] [056/133] (755s left) kms_flip (absolute-wf_vblank)
[264.947694] Starting subtest: absolute-wf_vblank
[264.950064] Starting dynamic subtest: A-eDP1
[273.713803] Dynamic subtest A-eDP1: SUCCESS (8.765s)
[273.723299] Starting dynamic subtest: B-eDP1
[282.439657] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[282.449726] Starting dynamic subtest: C-eDP1
[291.162595] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[291.175382] Starting dynamic subtest: D-eDP1
[299.884631] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[299.887078] Subtest absolute-wf_vblank: SUCCESS (34.943s)
[301.109744] [057/133] (719s left) prime_mmap (test_aperture_limit)
[301.172859] Starting subtest: test_aperture_limit
[301.174877] Starting dynamic subtest: test_aperture_limit-smem
[301.184244] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[301.188625] Subtest test_aperture_limit: SKIP (0.009s)
[301.260873] [058/133] (719s left) prime_vgem (basic-blt)
[301.343587] Starting subtest: basic-blt
[301.385322] Subtest basic-blt: SUCCESS (0.042s)
[301.518248] [059/133] (718s left) kms_busy (extended-modeset-hang-oldfb)
[301.612098] Starting subtest: extended-modeset-hang-oldfb
[301.614375] Starting dynamic subtest: pipe-A
[313.556429] Dynamic subtest pipe-A: SUCCESS (11.943s)
[313.566356] Starting dynamic subtest: pipe-D
[326.132837] Dynamic subtest pipe-D: SUCCESS (12.577s)
[326.135294] Subtest extended-modeset-hang-oldfb: SUCCESS (24.524s)
[326.935639] [060/133] (693s left) gem_mmap_offset (mmap-unmap)
[326.995614] Starting subtest: mmap-unmap
[326.997894] Starting dynamic subtest: smem0
[350.264505] Dynamic subtest smem0: SUCCESS (23.272s)
[350.267107] Subtest mmap-unmap: SUCCESS (23.273s)
[350.371830] [061/133] (670s left) gem_pxp (create-protected-buffer)
[350.509357] Starting subtest: create-protected-buffer
[350.511864] Subtest create-protected-buffer: SUCCESS (0.000s)
[350.631679] [062/133] (669s left) gem_ppgtt (blt-vs-render-ctx0)
[350.698972] Starting subtest: blt-vs-render-ctx0
[383.678896] Subtest blt-vs-render-ctx0: SUCCESS (32.980s)
[383.818163] [063/133] (636s left) gem_exec_gttfill (engines)
[383.926894] Starting subtest: engines
[383.929225] Starting dynamic subtest: rcs0
[407.237947] Dynamic subtest rcs0: SUCCESS (23.312s)
[407.251472] Starting dynamic subtest: bcs0
[430.560935] Dynamic subtest bcs0: SUCCESS (23.313s)
[430.577579] Starting dynamic subtest: vcs0
[453.898831] Dynamic subtest vcs0: SUCCESS (23.329s)
[453.912710] Starting dynamic subtest: vcs1
[477.176917] Dynamic subtest vcs1: SUCCESS (23.274s)
[477.189927] Starting dynamic subtest: vecs0
[500.486086] Dynamic subtest vecs0: SUCCESS (23.305s)
[500.499130] Starting dynamic subtest: ccs0
[523.848453] Dynamic subtest ccs0: SUCCESS (23.358s)
[523.851471] Subtest engines: SUCCESS (139.908s)
[524.056579] [064/133] (496s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[524.212762] Starting subtest: bad-pixel-format-yf-tiled-ccs
[524.215153] Starting dynamic subtest: pipe-A-eDP-1
[524.237987] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[524.250617] Starting dynamic subtest: pipe-B-eDP-1
[524.272483] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[524.282085] Starting dynamic subtest: pipe-C-eDP-1
[524.303007] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[524.312920] Starting dynamic subtest: pipe-D-eDP-1
[524.335238] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[524.339632] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[526.482103] [065/133] (494s left) kms_vblank (query-idle)
[526.583171] Starting subtest: query-idle
[526.585102] Starting dynamic subtest: pipe-A-eDP-1
[528.324788] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[528.340528] Starting dynamic subtest: pipe-D-eDP-1
[530.727625] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.399s)
[530.729587] Subtest query-idle: SUCCESS (4.145s)
[531.569482] [066/133] (489s left) kms_rotation_crc (exhaust-fences)
[531.664947] Starting subtest: exhaust-fences
[531.669249] Subtest exhaust-fences: SKIP (0.000s)
[531.758118] [067/133] (488s left) gem_ctx_exec (basic-norecovery)
[531.814259] Starting subtest: basic-norecovery
[532.170999] Subtest basic-norecovery: SUCCESS (0.357s)
[532.288730] [068/133] (488s left) gem_exec_balancer (smoke)
[532.352531] Starting subtest: smoke
[554.942273] Subtest smoke: SUCCESS (22.588s)
[556.454205] [069/133] (464s left) gem_softpin (evict-prime-sanity-check)
[556.526820] Starting subtest: evict-prime-sanity-check
[556.529150] Starting dynamic subtest: rcs0
[557.672629] Dynamic subtest rcs0: SUCCESS (1.145s)
[557.687773] Starting dynamic subtest: bcs0
[558.796661] Dynamic subtest bcs0: SUCCESS (1.121s)
[558.815978] Starting dynamic subtest: vcs0
[560.299469] Dynamic subtest vcs0: SUCCESS (1.499s)
[560.312693] Starting dynamic subtest: vcs1
[562.281553] Dynamic subtest vcs1: SUCCESS (1.979s)
[562.295802] Starting dynamic subtest: vecs0
[564.334474] Dynamic subtest vecs0: SUCCESS (2.051s)
[564.348053] Starting dynamic subtest: ccs0
[565.475896] Dynamic subtest ccs0: SUCCESS (1.140s)
[565.489798] Starting dynamic subtest: all
[566.600939] Dynamic subtest all: SUCCESS (1.123s)
[566.604152] Subtest evict-prime-sanity-check: SUCCESS (10.075s)
[566.683496] [070/133] (454s left) kms_getfb (getfb2-handle-closed)
[566.781882] Starting subtest: getfb2-handle-closed
[566.784242] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[566.907287] [071/133] (453s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[567.005002] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[567.007309] Starting dynamic subtest: pipe-A-eDP-1
[567.029195] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.041780] Starting dynamic subtest: pipe-B-eDP-1
[567.063095] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.072716] Starting dynamic subtest: pipe-C-eDP-1
[567.093452] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.103144] Starting dynamic subtest: pipe-D-eDP-1
[567.123847] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[567.128084] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[569.309563] [072/133] (451s left) i915_drm_fdinfo (virtual-busy-all)
[569.356694] Starting subtest: virtual-busy-all
[569.360786] Subtest virtual-busy-all: SKIP (0.000s)
[569.419708] [073/133] (451s left) gem_media_vme
[569.546054] [074/133] (451s left) gem_wait (await)
[569.613201] Starting subtest: await
[569.615320] Starting dynamic subtest: all-engines
[570.747772] Dynamic subtest all-engines: SUCCESS (1.137s)
[570.761146] Starting dynamic subtest: rcs0
[571.817129] Dynamic subtest rcs0: SUCCESS (1.067s)
[571.835112] Starting dynamic subtest: bcs0
[572.877216] Dynamic subtest bcs0: SUCCESS (1.058s)
[572.895826] Starting dynamic subtest: vcs0
[573.932082] Dynamic subtest vcs0: SUCCESS (1.053s)
[573.951963] Starting dynamic subtest: vcs1
[574.987826] Dynamic subtest vcs1: SUCCESS (1.053s)
[575.005287] Starting dynamic subtest: vecs0
[576.041339] Dynamic subtest vecs0: SUCCESS (1.052s)
[576.058843] Starting dynamic subtest: ccs0
[577.098273] Dynamic subtest ccs0: SUCCESS (1.055s)
[577.100783] Subtest await: SUCCESS (7.489s)
[577.294699] [075/133] (443s left) i915_drm_fdinfo (virtual-idle)
[577.332999] Starting subtest: virtual-idle
[580.370364] Subtest virtual-idle: SUCCESS (3.036s)
[580.451732] [076/133] (440s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[580.517181] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[580.519363] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[580.630569] [077/133] (440s left) kms_flip (2x-flip-vs-suspend)
[580.723948] Starting subtest: 2x-flip-vs-suspend
[580.728370] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[580.822485] [078/133] (440s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[580.882381] Starting subtest: wait-all-for-submit-delayed-submit
[580.985208] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[581.078370] [079/133] (440s left) kms_frontbuffer_tracking (fbc-suspend)
[581.188120] Starting subtest: fbc-suspend
[621.420625] Subtest fbc-suspend: SUCCESS (10.190s)
[623.620662] [080/133] (398s left) kms_hdr (static-toggle-dpms)
[623.720150] Starting subtest: static-toggle-dpms
[623.726576] Subtest static-toggle-dpms: SKIP (0.000s)
[623.794622] [081/133] (398s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[623.859653] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[623.864324] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[624.057518] [082/133] (398s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[624.154609] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[631.176531] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.027s)
[631.287784] [083/133] (391s left) perf (i915-ref-count)
[631.377856] Starting subtest: i915-ref-count
[631.417844] Subtest i915-ref-count: SUCCESS (0.040s)
[631.474145] [084/133] (390s left) i915_pm_rpm (debugfs-forcewake-user)
[633.550539] Starting subtest: debugfs-forcewake-user
[644.936726] Subtest debugfs-forcewake-user: SUCCESS (11.390s)
[645.322452] [085/133] (377s left) kms_lease (cursor-implicit-plane)
[645.431886] Starting subtest: cursor-implicit-plane
[645.434324] Starting dynamic subtest: pipe-A-eDP-1
[645.880464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[645.893948] Starting dynamic subtest: pipe-B-eDP-1
[647.025647] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s)
[647.036857] Starting dynamic subtest: pipe-C-eDP-1
[648.137441] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[648.149793] Starting dynamic subtest: pipe-D-eDP-1
[649.275284] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[649.277582] Subtest cursor-implicit-plane: SUCCESS (3.846s)
[650.134462] [086/133] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[650.247101] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[650.251145] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[650.333950] [087/133] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[650.429371] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[650.433777] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[650.521895] [088/133] (372s left) kms_dsc (dsc-with-output-formats-with-bpc)
[650.617498] Starting subtest: dsc-with-output-formats-with-bpc
[650.676308] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[650.717557] [089/133] (371s left) vgem_basic (mmap)
[650.769959] Starting subtest: mmap
[650.775396] Subtest mmap: SUCCESS (0.007s)
[650.829867] [090/133] (371s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[650.928413] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[650.930732] Starting dynamic subtest: pipe-A-eDP-1
[651.024803] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[651.040374] Starting dynamic subtest: pipe-B-eDP-1
[652.112104] Dynamic subtest pipe-B-eDP-1: SKIP (1.086s)
[652.116518] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.188s)
[653.313110] [091/133] (369s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[653.409670] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[653.411801] Starting dynamic subtest: pipe-A-eDP-1
[653.433365] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[653.447652] Starting dynamic subtest: pipe-B-eDP-1
[653.468305] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[653.481812] Starting dynamic subtest: pipe-C-eDP-1
[653.502538] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[653.513102] Starting dynamic subtest: pipe-D-eDP-1
[653.534706] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[653.538779] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[655.673895] [092/133] (367s left) gem_exec_parallel (basic)
[655.739989] Starting subtest: basic
[655.742401] Starting dynamic subtest: rcs0
[657.161805] Dynamic subtest rcs0: SUCCESS (1.421s)
[657.173428] Starting dynamic subtest: bcs0
[658.642835] Dynamic subtest bcs0: SUCCESS (1.479s)
[658.655734] Starting dynamic subtest: vcs0
[660.363403] Dynamic subtest vcs0: SUCCESS (1.718s)
[660.376539] Starting dynamic subtest: vcs1
[662.347677] Dynamic subtest vcs1: SUCCESS (1.981s)
[662.361419] Starting dynamic subtest: vecs0
[664.331703] Dynamic subtest vecs0: SUCCESS (1.981s)
[664.344807] Starting dynamic subtest: ccs0
[665.836869] Dynamic subtest ccs0: SUCCESS (1.504s)
[665.839370] Subtest basic: SUCCESS (10.097s)
[666.026288] [093/133] (356s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[666.081471] Starting subtest: multi-wait-all-for-submit-submitted
[666.183956] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[666.265751] [094/133] (356s left) kms_frontbuffer_tracking (psr-slowdraw)
[666.371576] Starting subtest: psr-slowdraw
[691.573409] Subtest psr-slowdraw: SUCCESS (25.203s)
[691.713466] [095/133] (331s left) kms_universal_plane (disable-primary-vs-flip)
[691.803695] Starting subtest: disable-primary-vs-flip
[691.806211] Starting dynamic subtest: pipe-A-eDP-1
[693.362119] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.557s)
[693.373344] Starting dynamic subtest: pipe-B-eDP-1
[695.527999] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.167s)
[695.539099] Starting dynamic subtest: pipe-C-eDP-1
[697.696351] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.166s)
[697.708977] Starting dynamic subtest: pipe-D-eDP-1
[699.856712] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.160s)
[699.859119] Subtest disable-primary-vs-flip: SUCCESS (8.055s)
[700.658467] [096/133] (322s left) gem_mmap_gtt (basic)
[700.713679] Subtest basic: SKIP (0.000s)
[700.777701] [097/133] (322s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[700.883271] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[700.887196] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[700.999887] [098/133] (322s left) kms_setmode (basic)
[701.050212] Starting subtest: basic
[701.369912] Starting dynamic subtest: pipe-A-eDP-1
[703.471290] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s)
[703.835527] Starting dynamic subtest: pipe-B-eDP-1
[705.915406] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s)
[706.227075] Subtest basic: SUCCESS (5.175s)
[707.051845] [099/133] (316s left) kms_psr (fbc-psr2-sprite-blt)
[707.142804] Starting subtest: fbc-psr2-sprite-blt
[707.145014] Starting dynamic subtest: eDP-1
[707.149122] Dynamic subtest eDP-1: SKIP (0.000s)
[707.153207] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[707.229401] [100/133] (315s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[707.277514] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[707.384352] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[707.468509] [101/133] (315s left) api_intel_allocator (default-alignment)
[707.524115] Starting subtest: default-alignment
[707.526539] Subtest default-alignment: SUCCESS (0.004s)
[707.658836] [102/133] (315s left) gem_exec_reloc (basic-wc-read-noreloc)
[707.751209] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[707.864279] [103/133] (315s left) kms_psr (fbc-psr-dpms)
[707.971159] Starting subtest: fbc-psr-dpms
[707.973472] Starting dynamic subtest: eDP-1
[707.978007] Dynamic subtest eDP-1: SKIP (0.000s)
[707.982717] Subtest fbc-psr-dpms: SKIP (0.001s)
[708.052263] [104/133] (315s left) kms_cursor_edge_walk (256x256-left-edge)
[708.150886] Starting subtest: 256x256-left-edge
[708.153090] Starting dynamic subtest: pipe-A-eDP-1
[711.602218] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s)
[711.613834] Starting dynamic subtest: pipe-D-eDP-1
[714.732513] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[714.734779] Subtest 256x256-left-edge: SUCCESS (6.585s)
[715.537296] [105/133] (307s left) kms_pm_lpsp (screens-disabled)
[716.635754] Starting subtest: screens-disabled
[716.639690] Subtest screens-disabled: SKIP (0.000s)
[716.710390] [106/133] (306s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[716.814622] Starting subtest: y-tiled-64bpp-rotate-180
[716.819093] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[716.918681] [107/133] (306s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[717.025061] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[717.029228] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[717.115874] [108/133] (306s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[717.203835] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[717.229797] Starting dynamic subtest: pipe-A-plane-0
[717.518871] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[717.529893] Starting dynamic subtest: pipe-A-plane-3
[717.751228] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[718.820835] Starting dynamic subtest: pipe-B-plane-0
[719.121781] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[719.135281] Starting dynamic subtest: pipe-B-plane-3
[719.355431] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[719.676912] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.473s)
[720.491124] [109/133] (303s left) kms_psr (pr-primary-mmap-cpu)
[720.590133] Starting subtest: pr-primary-mmap-cpu
[720.594229] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[720.663768] [110/133] (302s left) perf (gen12-mi-rpc)
[720.758240] Starting subtest: gen12-mi-rpc
[720.760730] Starting dynamic subtest: rcs0
[720.777090] Dynamic subtest rcs0: SUCCESS (0.016s)
[720.779184] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[720.818497] [111/133] (302s left) kms_color (ctm-red-to-blue)
[720.946714] Starting subtest: ctm-red-to-blue
[720.949055] Starting dynamic subtest: pipe-A-eDP-1
[721.716828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.769s)
[721.730014] Starting dynamic subtest: pipe-B-eDP-1
[723.098967] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[723.111630] Starting dynamic subtest: pipe-C-eDP-1
[724.496131] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[724.510803] Starting dynamic subtest: pipe-D-eDP-1
[725.908422] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[725.910412] Subtest ctm-red-to-blue: SUCCESS (4.961s)
[726.725784] [112/133] (296s left) gem_render_copy (yf-tiled-to-vebox-linear)
[726.790625] Starting subtest: yf-tiled-to-vebox-linear
[726.795118] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[726.975641] [113/133] (296s left) gem_exec_reloc (basic-wc-noreloc)
[727.039070] Subtest basic-wc-noreloc: SKIP (0.000s)
[727.107163] [114/133] (296s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[727.219653] Starting subtest: plane-downscale-factor-0-75-with-rotation
[727.222101] Starting dynamic subtest: pipe-A
[727.446065] Dynamic subtest pipe-A: SUCCESS (0.231s)
[727.457053] Starting dynamic subtest: pipe-B
[728.706408] Dynamic subtest pipe-B: SUCCESS (1.259s)
[728.719722] Starting dynamic subtest: pipe-C
[730.042998] Dynamic subtest pipe-C: SUCCESS (1.336s)
[730.057279] Starting dynamic subtest: pipe-D
[731.387209] Dynamic subtest pipe-D: SUCCESS (1.343s)
[731.389717] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.172s)
[732.575098] [115/133] (291s left) gem_mmap_gtt (basic-read-write)
[732.643870] Subtest basic-read-write: SKIP (0.000s)
[732.705796] [116/133] (291s left) gem_ctx_shared (q-smoketest)
[732.784200] Starting subtest: Q-smoketest
[732.786383] Starting dynamic subtest: rcs0
[738.377453] Dynamic subtest rcs0: SUCCESS (5.547s)
[738.389976] Starting dynamic subtest: bcs0
[743.861715] Dynamic subtest bcs0: SUCCESS (5.481s)
[743.878227] Starting dynamic subtest: vcs0
[749.365608] Dynamic subtest vcs0: SUCCESS (5.499s)
[749.379791] Starting dynamic subtest: vcs1
[754.844154] Dynamic subtest vcs1: SUCCESS (5.482s)
[754.855343] Starting dynamic subtest: vecs0
[760.324749] Dynamic subtest vecs0: SUCCESS (5.479s)
[760.336285] Starting dynamic subtest: ccs0
[765.829625] Dynamic subtest ccs0: SUCCESS (5.502s)
[765.831980] Subtest Q-smoketest: SUCCESS (33.000s)
[765.969877] [117/133] (257s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[766.021052] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[766.023344] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[766.128243] [118/133] (257s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[766.190781] Starting subtest: framebuffer-vs-set-tiling
[766.195305] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[766.329729] [119/133] (257s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[766.423763] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[766.427933] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[766.536514] [120/133] (257s left) gem_exec_schedule (u-fairslice)
[766.614907] Starting subtest: u-fairslice
[766.617218] Starting dynamic subtest: rcs0
[768.629944] Dynamic subtest rcs0: SUCCESS (2.023s)
[768.640715] Starting dynamic subtest: bcs0
[770.650937] Dynamic subtest bcs0: SUCCESS (2.017s)
[770.662772] Starting dynamic subtest: vcs0
[772.669093] Dynamic subtest vcs0: SUCCESS (2.018s)
[772.682137] Starting dynamic subtest: vcs1
[774.691097] Dynamic subtest vcs1: SUCCESS (2.019s)
[774.701670] Starting dynamic subtest: vecs0
[776.710492] Dynamic subtest vecs0: SUCCESS (2.017s)
[776.721605] Starting dynamic subtest: ccs0
[778.727882] Dynamic subtest ccs0: SUCCESS (2.019s)
[778.730060] Subtest u-fairslice: SUCCESS (12.122s)
[779.033251] [121/133] (245s left) gem_ctx_persistence (legacy-engines-persistence)
[779.096183] Starting subtest: legacy-engines-persistence
[779.098463] Starting dynamic subtest: render
[779.923259] Dynamic subtest render: SUCCESS (0.826s)
[779.937483] Starting dynamic subtest: bsd1
[780.678963] Dynamic subtest bsd1: SUCCESS (0.753s)
[780.694668] Starting dynamic subtest: bsd2
[781.447871] Dynamic subtest bsd2: SUCCESS (0.766s)
[781.462576] Starting dynamic subtest: blt
[782.219763] Dynamic subtest blt: SUCCESS (0.769s)
[782.235454] Starting dynamic subtest: vebox
[782.981992] Dynamic subtest vebox: SUCCESS (0.759s)
[782.984662] Subtest legacy-engines-persistence: SUCCESS (3.887s)
[783.065653] [122/133] (241s left) syncobj_wait (single-wait-for-submit-signaled)
[783.117104] Starting subtest: single-wait-for-submit-signaled
[783.119418] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[783.217155] [123/133] (240s left) kms_cursor_legacy (forked-bo)
[783.329403] Starting subtest: forked-bo
[783.331672] Starting dynamic subtest: pipe-A
[788.802767] Dynamic subtest pipe-A: SUCCESS (5.469s)
[788.821785] Starting dynamic subtest: pipe-B
[794.278994] Dynamic subtest pipe-B: SUCCESS (5.475s)
[794.297842] Starting dynamic subtest: pipe-C
[799.768025] Dynamic subtest pipe-C: SUCCESS (5.486s)
[799.781448] Starting dynamic subtest: pipe-D
[805.244964] Dynamic subtest pipe-D: SUCCESS (5.474s)
[805.258945] Starting dynamic subtest: all-pipes
[810.750786] Dynamic subtest all-pipes: SUCCESS (5.503s)
[810.753455] Subtest forked-bo: SUCCESS (27.418s)
[810.902122] [124/133] (213s left) kms_cursor_crc (cursor-random-128x128)
[811.125971] Starting subtest: cursor-random-128x128
[811.130921] Starting dynamic subtest: pipe-A-eDP-1
[814.451519] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.318s)
[814.483533] Starting dynamic subtest: pipe-D-eDP-1
[818.475579] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.006s)
[818.477984] Subtest cursor-random-128x128: SUCCESS (7.350s)
[819.340834] [125/133] (204s left) kms_psr (psr2-dpms)
[819.439441] Starting subtest: psr2-dpms
[819.441751] Starting dynamic subtest: eDP-1
[822.268586] Dynamic subtest eDP-1: SUCCESS (2.829s)
[822.270800] Subtest psr2-dpms: SUCCESS (2.830s)
[823.139449] [126/133] (201s left) gem_softpin (evict-snoop-interruptible)
[823.200743] Starting subtest: evict-snoop-interruptible
[823.205127] Subtest evict-snoop-interruptible: SKIP (0.000s)
[823.289564] [127/133] (201s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[823.403540] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[827.591419] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.189s)
[828.759308] [128/133] (195s left) gem_exec_whisper (basic-fds-forked-all)
[828.824776] Starting subtest: basic-fds-forked-all
[848.707225] Subtest basic-fds-forked-all: SUCCESS (19.876s)
[848.910449] [129/133] (175s left) kms_chamelium_color (degamma)
[849.011579] Subtest degamma: SKIP (0.000s)
[849.060665] [130/133] (175s left) gem_eio (in-flight-contexts-10ms)
[849.299555] Starting subtest: in-flight-contexts-10ms
[863.393666] Subtest in-flight-contexts-10ms: SUCCESS (14.093s)
[863.520622] [131/133] (160s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[863.618389] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[871.015995] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.399s)
[871.162405] [132/133] (153s left) kms_cursor_crc (cursor-offscreen-256x256)
[871.434865] Starting subtest: cursor-offscreen-256x256
[871.437087] Starting dynamic subtest: pipe-A-eDP-1
[873.378297] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[873.408390] Starting dynamic subtest: pipe-D-eDP-1
[876.014321] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.614s)
[876.016454] Subtest cursor-offscreen-256x256: SUCCESS (4.581s)
[876.850107] [133/133] (147s left) kms_chamelium_audio (hdmi-audio)
[877.221863] Subtest hdmi-audio: SKIP (0.000s)
[878.054801] 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.