[56.099859] Initializing watchdogs
[56.100025]   /dev/watchdog0
[56.115547] [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]
[56.119699] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.121818] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.125203] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[56.255089] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[56.259657] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[56.375937] [002/131] (960s left) api_intel_bb (render)
[56.430528] Starting subtest: render
[56.432958] Starting dynamic subtest: render-none-512
[56.536765] Dynamic subtest render-none-512: SUCCESS (0.106s)
[56.545442] Starting dynamic subtest: render-none-1024
[56.911702] Dynamic subtest render-none-1024: SUCCESS (0.374s)
[56.920206] Starting dynamic subtest: render-x-512
[56.997795] Dynamic subtest render-x-512: SUCCESS (0.087s)
[57.007075] Starting dynamic subtest: render-x-1024
[57.332270] Dynamic subtest render-x-1024: SUCCESS (0.334s)
[57.340215] Starting dynamic subtest: render-y-512
[57.418676] Dynamic subtest render-y-512: SUCCESS (0.086s)
[57.427125] Starting dynamic subtest: render-y-1024
[57.758211] Dynamic subtest render-y-1024: SUCCESS (0.338s)
[57.761056] Subtest render: SUCCESS (1.327s)
[57.900298] [003/131] (958s left) intel_hwmon (hwmon-read)
[57.961748] Subtest hwmon-read: SKIP (0.000s)
[58.021809] [004/131] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[58.118201] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[62.570779] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.456s)
[63.793988] [005/131] (952s left) kms_psr (pr-sprite-render)
[63.893813] Starting subtest: pr-sprite-render
[63.898598] Subtest pr-sprite-render: SKIP (0.000s)
[63.987740] [006/131] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[64.086649] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[64.091070] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[64.209975] [007/131] (952s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[64.331445] Starting subtest: cursorA-vs-flipA-atomic
[75.490241] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.159s)
[76.309896] [008/131] (940s left) fbdev (eof)
[76.352710] Starting subtest: eof
[76.355080] Subtest eof: SUCCESS (0.000s)
[76.454420] [009/131] (940s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[76.510568] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[76.512800] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[76.629811] [010/131] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[76.723639] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[85.991819] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.272s)
[86.160451] [011/131] (930s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[86.260447] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[86.262764] Starting dynamic subtest: pipe-A-default-mode
[88.962785] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[88.965284] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.702s)
[89.844226] [012/131] (927s left) gem_userptr_blits (huge-split)
[89.925105] Starting subtest: huge-split
[89.931329] Subtest huge-split: SUCCESS (0.006s)
[90.102178] [013/131] (926s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[90.217200] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[90.259642] [014/131] (926s left) kms_chamelium_frames (dp-crc-multiple)
[90.645102] Subtest dp-crc-multiple: SKIP (0.000s)
[91.423625] [015/131] (925s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[91.521807] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[91.524078] Starting dynamic subtest: pipe-A-eDP-1
[91.546726] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[91.554793] Starting dynamic subtest: pipe-B-eDP-1
[91.576257] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[91.582684] Starting dynamic subtest: pipe-C-eDP-1
[91.603698] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[91.610149] Starting dynamic subtest: pipe-D-eDP-1
[91.631197] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[91.635116] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[93.739358] [016/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[93.844672] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[100.625306] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.784s)
[100.797263] [017/131] (916s left) gem_mmap_wc (bad-size)
[100.860290] Subtest bad-size: SKIP (0.000s)
[100.923709] [018/131] (916s left) kms_fence_pin_leak
[101.082449] [019/131] (916s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[101.175169] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[101.177672] Starting dynamic subtest: pipe-A
[101.513814] Dynamic subtest pipe-A: SUCCESS (0.341s)
[101.521651] Starting dynamic subtest: pipe-B
[102.918799] Dynamic subtest pipe-B: SUCCESS (1.402s)
[102.932016] Starting dynamic subtest: pipe-C
[104.353984] Dynamic subtest pipe-C: SUCCESS (1.434s)
[104.361163] Starting dynamic subtest: pipe-D
[105.793580] Dynamic subtest pipe-D: SUCCESS (1.439s)
[105.795982] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.621s)
[106.952968] [020/131] (910s left) kms_plane (plane-panning-bottom-right-suspend)
[107.049725] Starting subtest: plane-panning-bottom-right-suspend
[107.051638] Starting dynamic subtest: pipe-A
[124.663966] Dynamic subtest pipe-A: SUCCESS (6.532s)
[124.673205] Starting dynamic subtest: pipe-B
[142.697855] Dynamic subtest pipe-B: SUCCESS (3.459s)
[142.700086] Subtest plane-panning-bottom-right-suspend: SUCCESS (9.994s)
[143.519565] [021/131] (873s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[143.640074] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[143.644443] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[143.773030] [022/131] (873s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[143.899039] Starting subtest: short-busy-flip-before-cursor-toggle
[143.903510] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[144.064169] [023/131] (873s left) gem_spin_batch (resubmit-new-all)
[144.133726] Starting subtest: resubmit-new-all
[144.136175] Starting dynamic subtest: rcs0
[144.148084] Dynamic subtest rcs0: SUCCESS (0.014s)
[144.156982] Starting dynamic subtest: bcs0
[144.159233] Dynamic subtest bcs0: SUCCESS (0.010s)
[144.167266] Starting dynamic subtest: vcs0
[144.169601] Dynamic subtest vcs0: SUCCESS (0.008s)
[144.178658] Starting dynamic subtest: vcs1
[144.180984] Dynamic subtest vcs1: SUCCESS (0.009s)
[144.191449] Starting dynamic subtest: vecs0
[144.193868] Dynamic subtest vecs0: SUCCESS (0.008s)
[144.201368] Starting dynamic subtest: ccs0
[144.203594] Dynamic subtest ccs0: SUCCESS (0.007s)
[144.205884] Subtest resubmit-new-all: SUCCESS (0.059s)
[145.621761] [024/131] (871s left) kms_lease (cursor-implicit-plane)
[145.707867] Starting subtest: cursor-implicit-plane
[145.710295] Starting dynamic subtest: pipe-A-eDP-1
[146.182720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.474s)
[146.191428] Starting dynamic subtest: pipe-B-eDP-1
[147.324728] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[147.335710] Starting dynamic subtest: pipe-C-eDP-1
[148.440786] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[148.457544] Starting dynamic subtest: pipe-D-eDP-1
[149.582518] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[149.584437] Subtest cursor-implicit-plane: SUCCESS (3.873s)
[150.459616] [025/131] (867s left) gem_exec_whisper (basic-forked-all)
[150.536131] Starting subtest: basic-forked-all
[163.123180] Subtest basic-forked-all: SUCCESS (12.584s)
[163.335902] [026/131] (854s left) kms_flip (nonexisting-fb)
[163.434820] Starting subtest: nonexisting-fb
[163.437090] Starting dynamic subtest: A-eDP1
[164.621407] Dynamic subtest A-eDP1: SUCCESS (1.185s)
[164.632831] Starting dynamic subtest: B-eDP1
[165.757847] Dynamic subtest B-eDP1: SUCCESS (1.135s)
[165.766970] Starting dynamic subtest: C-eDP1
[166.880998] Dynamic subtest C-eDP1: SUCCESS (1.122s)
[166.889718] Starting dynamic subtest: D-eDP1
[168.009005] Dynamic subtest D-eDP1: SUCCESS (1.127s)
[168.011393] Subtest nonexisting-fb: SUCCESS (4.577s)
[169.204762] [027/131] (848s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[169.300972] Starting subtest: x-tiled-16bpp-rotate-180
[170.546213] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.246s)
[170.714213] [028/131] (846s left) i915_drm_fdinfo (virtual-idle)
[170.754178] Starting subtest: virtual-idle
[173.797600] Subtest virtual-idle: SUCCESS (3.041s)
[173.894198] [029/131] (843s left) gem_caching (reads)
[173.955304] Subtest reads: SKIP (0.000s)
[174.021158] [030/131] (843s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[174.079966] Starting subtest: wait-all-for-submit-delayed-submit
[174.181817] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[174.289981] [031/131] (843s left) kms_hdmi_inject (inject-4k)
[174.635227] Starting subtest: inject-4k
[174.956548] Subtest inject-4k: SUCCESS (0.323s)
[175.564043] [032/131] (842s left) gem_lmem_swapping (parallel-random-engines)
[175.606429] Subtest parallel-random-engines: SKIP (0.000s)
[175.647364] [033/131] (842s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[175.743737] Starting subtest: yf-tiled-64bpp-rotate-270
[175.748125] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[175.860057] [034/131] (842s left) gem_exec_reloc (basic-write-read-noreloc)
[175.919623] Subtest basic-write-read-noreloc: SKIP (0.000s)
[176.005997] [035/131] (841s left) kms_cursor_crc (cursor-onscreen-64x21)
[176.186527] Starting subtest: cursor-onscreen-64x21
[176.232295] Subtest cursor-onscreen-64x21: SKIP (0.043s)
[176.498640] [036/131] (841s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[176.596149] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[176.597876] Starting dynamic subtest: pipe-A-eDP-1
[178.677254] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.082s)
[178.685373] Starting dynamic subtest: pipe-B-eDP-1
[180.769594] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s)
[180.777286] Starting dynamic subtest: pipe-C-eDP-1
[182.807914] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.036s)
[182.816303] Starting dynamic subtest: pipe-D-eDP-1
[184.789283] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.980s)
[184.791609] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.194s)
[186.033171] [037/131] (831s left) gem_exec_schedule (pi-shared-iova)
[186.212873] Starting subtest: pi-shared-iova
[186.214840] Starting dynamic subtest: rcs0
[186.282572] Dynamic subtest rcs0: SUCCESS (0.072s)
[186.293831] Starting dynamic subtest: vcs0
[186.334217] Dynamic subtest vcs0: SUCCESS (0.051s)
[186.344857] Starting dynamic subtest: vcs1
[186.385036] Dynamic subtest vcs1: SUCCESS (0.050s)
[186.392688] Starting dynamic subtest: vecs0
[186.433793] Dynamic subtest vecs0: SUCCESS (0.048s)
[186.444039] Starting dynamic subtest: ccs0
[186.485260] Dynamic subtest ccs0: SUCCESS (0.051s)
[186.487719] Subtest pi-shared-iova: SUCCESS (0.275s)
[187.650215] [038/131] (830s left) gem_exec_schedule (submit-late-slice)
[187.718268] Starting subtest: submit-late-slice
[187.720548] Starting dynamic subtest: rcs0
[187.741374] Dynamic subtest rcs0: SUCCESS (0.032s)
[187.750437] Starting dynamic subtest: bcs0
[187.767165] Dynamic subtest bcs0: SUCCESS (0.025s)
[187.775448] Starting dynamic subtest: vcs0
[187.794451] Dynamic subtest vcs0: SUCCESS (0.027s)
[187.806744] Starting dynamic subtest: vcs1
[187.823355] Dynamic subtest vcs1: SUCCESS (0.028s)
[187.831359] Starting dynamic subtest: vecs0
[187.851595] Dynamic subtest vecs0: SUCCESS (0.027s)
[187.860122] Starting dynamic subtest: ccs0
[187.879353] Dynamic subtest ccs0: SUCCESS (0.027s)
[187.881830] Subtest submit-late-slice: SUCCESS (0.170s)
[189.715952] [039/131] (828s left) kms_psr (psr-suspend)
[189.819504] Starting subtest: psr-suspend
[189.821715] Starting dynamic subtest: eDP-1
[207.717830] Dynamic subtest eDP-1: SUCCESS (3.000s)
[207.720162] Subtest psr-suspend: SUCCESS (3.001s)
[208.538214] [040/131] (809s left) kms_pipe_crc_basic (hang-read-crc)
[208.646163] Starting subtest: hang-read-crc
[208.648323] Starting dynamic subtest: pipe-A-eDP-1
[210.745938] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s)
[210.755535] Starting dynamic subtest: pipe-B-eDP-1
[213.545922] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.797s)
[213.555051] Starting dynamic subtest: pipe-C-eDP-1
[216.183325] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.632s)
[216.192823] Starting dynamic subtest: pipe-D-eDP-1
[218.787591] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.604s)
[218.789925] Subtest hang-read-crc: SUCCESS (10.139s)
[219.632696] [041/131] (798s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[219.852924] Starting subtest: cursor-rapid-movement-128x128
[219.857769] Starting dynamic subtest: pipe-A-eDP-1
[220.394527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.536s)
[220.420301] Starting dynamic subtest: pipe-D-eDP-1
[221.571078] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.157s)
[221.573525] Subtest cursor-rapid-movement-128x128: SUCCESS (1.717s)
[222.426478] [042/131] (795s left) api_intel_allocator (open-vm)
[222.483105] Starting subtest: open-vm
[222.485458] Subtest open-vm: SUCCESS (0.003s)
[222.636384] [043/131] (795s left) kms_properties (plane-properties-atomic)
[222.738220] Starting subtest: plane-properties-atomic
[222.740145] Starting dynamic subtest: pipe-A-eDP-1
[223.285368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[223.299509] Starting dynamic subtest: pipe-B-eDP-1
[224.547765] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[224.556986] Starting dynamic subtest: pipe-C-eDP-1
[225.846824] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[225.857563] Starting dynamic subtest: pipe-D-eDP-1
[227.149372] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[227.151685] Subtest plane-properties-atomic: SUCCESS (4.411s)
[228.025096] [044/131] (790s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[228.082735] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[228.152024] [045/131] (790s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[228.253398] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[234.905905] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.652s)
[235.064662] [046/131] (783s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[235.181717] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[239.394356] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.215s)
[240.549930] [047/131] (777s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[241.118747] Starting subtest: syncobj-stationary-timeline-chain-engines
[241.240221] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.122s)
[242.565165] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[242.569257] [048/131] (775s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[242.666681] Starting subtest: fbc-psr2-cursor-plane-onoff
[242.668881] Starting dynamic subtest: eDP-1
[242.672899] Dynamic subtest eDP-1: SKIP (0.000s)
[242.676891] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[242.766496] [049/131] (775s left) perf (polling)
[242.904011] Starting subtest: polling
[242.906384] Starting dynamic subtest: 0-rcs0
[252.917857] Dynamic subtest 0-rcs0: SUCCESS (10.013s)
[252.926965] Starting dynamic subtest: 1-vcs0
[262.936908] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[262.939448] Subtest polling: SUCCESS (20.034s)
[262.985759] [050/131] (755s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[263.044826] Starting subtest: y-tiled-to-vebox-y-tiled
[263.049349] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[263.257820] [051/131] (755s left) kms_frontbuffer_tracking (fbc-stridechange)
[263.358551] Starting subtest: fbc-stridechange
[266.712410] Subtest fbc-stridechange: SUCCESS (3.357s)
[267.942733] [052/131] (750s left) perf_pmu (idle-no-semaphores)
[267.986204] Starting subtest: idle-no-semaphores
[267.988373] Starting dynamic subtest: rcs0
[268.550518] Dynamic subtest rcs0: SUCCESS (0.563s)
[268.563222] Starting dynamic subtest: bcs0
[269.076077] Dynamic subtest bcs0: SUCCESS (0.522s)
[269.085390] Starting dynamic subtest: vcs0
[269.596262] Dynamic subtest vcs0: SUCCESS (0.517s)
[269.608687] Starting dynamic subtest: vcs1
[270.114033] Dynamic subtest vcs1: SUCCESS (0.515s)
[270.126429] Starting dynamic subtest: vecs0
[270.636442] Dynamic subtest vecs0: SUCCESS (0.520s)
[270.648602] Starting dynamic subtest: ccs0
[271.166155] Dynamic subtest ccs0: SUCCESS (0.526s)
[271.168867] Subtest idle-no-semaphores: SUCCESS (3.181s)
[271.292389] [053/131] (747s left) gen9_exec_parse (shadow-peek)
[271.353920] Subtest shadow-peek: SKIP (0.000s)
[271.422260] [054/131] (747s left) gem_exec_balancer (nohangcheck)
[271.683080] Starting subtest: nohangcheck
[272.554613] Subtest nohangcheck: SUCCESS (0.871s)
[272.690778] [055/131] (746s left) gem_exec_flush (basic-wb-prw-default)
[272.755835] Starting subtest: basic-wb-prw-default
[278.226822] Subtest basic-wb-prw-default: SUCCESS (5.470s)
[278.434440] [056/131] (740s left) gem_readwrite (write-bad-handle)
[278.507933] Subtest write-bad-handle: SKIP (0.000s)
[278.567367] [057/131] (740s left) kms_pm_rpm (modeset-non-lpsp-stress)
[280.591744] Starting subtest: modeset-non-lpsp-stress
[281.762227] Subtest modeset-non-lpsp-stress: SKIP (1.170s)
[282.168024] [058/131] (736s left) gem_mmap_offset (blt-coherency)
[282.220100] Starting subtest: blt-coherency
[282.228441] Subtest blt-coherency: SUCCESS (0.011s)
[282.373703] [059/131] (736s left) gem_exec_reloc (basic-write-cpu-noreloc)
[282.439731] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[282.522351] [060/131] (736s left) gem_ctx_engines (independent)
[282.577435] Starting subtest: independent
[282.579724] Starting dynamic subtest: rcs0
[282.718961] Dynamic subtest rcs0: SUCCESS (0.140s)
[282.730354] Starting dynamic subtest: bcs0
[282.860487] Dynamic subtest bcs0: SUCCESS (0.141s)
[282.870958] Starting dynamic subtest: vcs0
[283.009534] Dynamic subtest vcs0: SUCCESS (0.148s)
[283.020096] Starting dynamic subtest: vcs1
[283.153128] Dynamic subtest vcs1: SUCCESS (0.143s)
[283.165695] Starting dynamic subtest: vecs0
[283.311153] Dynamic subtest vecs0: SUCCESS (0.158s)
[283.319458] Starting dynamic subtest: ccs0
[283.488345] Dynamic subtest ccs0: SUCCESS (0.176s)
[283.499466] Starting dynamic subtest: all-engines
[284.148140] Dynamic subtest all-engines: SUCCESS (0.658s)
[284.150813] Subtest independent: SUCCESS (1.569s)
[284.644076] [061/131] (734s left) kms_pm_dc (dc5-dpms-negative)
[285.760069] Starting subtest: dc5-dpms-negative
[285.764544] Subtest dc5-dpms-negative: SKIP (0.000s)
[285.857264] [062/131] (733s left) perf_pmu (render-node-busy-idle)
[285.936975] Starting subtest: render-node-busy-idle
[285.939415] Starting dynamic subtest: rcs0
[286.634521] Dynamic subtest rcs0: SUCCESS (0.700s)
[286.646407] Starting dynamic subtest: bcs0
[287.305567] Dynamic subtest bcs0: SUCCESS (0.669s)
[287.317259] Starting dynamic subtest: vcs0
[288.444528] Dynamic subtest vcs0: SUCCESS (1.135s)
[288.456246] Starting dynamic subtest: vcs1
[290.492162] Dynamic subtest vcs1: SUCCESS (2.044s)
[290.504006] Starting dynamic subtest: vecs0
[292.475196] Dynamic subtest vecs0: SUCCESS (1.980s)
[292.486787] Starting dynamic subtest: ccs0
[293.138704] Dynamic subtest ccs0: SUCCESS (0.662s)
[293.141374] Subtest render-node-busy-idle: SUCCESS (7.205s)
[293.265496] [063/131] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[293.366180] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[293.370150] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[293.511855] [064/131] (725s left) gem_exercise_blt (fast-copy-emit)
[293.579878] Starting subtest: fast-copy-emit
[293.582329] Starting dynamic subtest: linear-smem-smem-emit
[293.611202] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.031s)
[293.619849] Starting dynamic subtest: xmajor-smem-smem-emit
[293.627852] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[293.636644] Starting dynamic subtest: tile4-smem-smem-emit
[293.644163] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[293.652609] Starting dynamic subtest: tile64-smem-smem-emit
[293.660575] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[293.662902] Subtest fast-copy-emit: SUCCESS (0.081s)
[293.828337] [065/131] (725s left) sw_sync (timeline_closed)
[293.866647] Starting subtest: timeline_closed
[293.868565] Subtest timeline_closed: SUCCESS (0.000s)
[293.944048] [066/131] (725s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[294.078475] Starting subtest: basic-flip-after-cursor-atomic
[295.014443] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.934s)
[295.830336] [067/131] (723s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[295.945197] Starting subtest: y-tiled-8bpp-rotate-180
[295.949472] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[296.082599] [068/131] (723s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[296.192200] Starting subtest: flip-vs-dpms-on-nop-interruptible
[296.196482] Starting dynamic subtest: A-eDP1
[298.068681] Dynamic subtest A-eDP1: SUCCESS (1.873s)
[298.079198] Starting dynamic subtest: B-eDP1
[299.966658] Dynamic subtest B-eDP1: SUCCESS (1.896s)
[299.986402] Starting dynamic subtest: C-eDP1
[301.755387] Dynamic subtest C-eDP1: SUCCESS (1.786s)
[301.776354] Starting dynamic subtest: D-eDP1
[303.559743] Dynamic subtest D-eDP1: SUCCESS (1.801s)
[303.565524] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.370s)
[304.730083] [069/131] (714s left) kms_psr2_su (page_flip-xrgb8888)
[304.798550] Subtest page_flip-XRGB8888: SKIP (0.000s)
[304.862205] [070/131] (714s left) kms_vrr (max-min)
[304.948787] Starting subtest: max-min
[304.955364] Subtest max-min: SKIP (0.000s)
[305.047542] [071/131] (714s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[305.168338] Starting subtest: flip-vs-cursor-atomic
[312.297074] Subtest flip-vs-cursor-atomic: SUCCESS (7.130s)
[313.122573] [072/131] (706s left) gem_exec_reloc (basic-gtt)
[313.195179] Subtest basic-gtt: SKIP (0.000s)
[313.274058] [073/131] (706s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[313.372218] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[313.374426] Starting dynamic subtest: pipe-A-eDP-1
[313.396480] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.406841] Starting dynamic subtest: pipe-B-eDP-1
[313.427203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[313.435619] Starting dynamic subtest: pipe-C-eDP-1
[313.456215] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[313.464605] Starting dynamic subtest: pipe-D-eDP-1
[313.486105] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[313.490172] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[315.627678] [074/131] (703s left) gen9_exec_parse (bb-secure)
[315.687564] Subtest bb-secure: SKIP (0.000s)
[315.755567] [075/131] (703s left) kms_content_protection (type1)
[315.885854] Starting subtest: type1
[315.890369] Subtest type1: SKIP (0.000s)
[316.055358] [076/131] (703s left) vgem_basic (sysfs)
[316.104802] Starting subtest: sysfs
[316.106873] Subtest sysfs: SUCCESS (0.000s)
[316.182732] [077/131] (703s left) syncobj_eventfd (binary-wait)
[316.238870] Starting subtest: binary-wait
[316.246809] Subtest binary-wait: SUCCESS (0.010s)
[316.345067] [078/131] (703s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[316.717422] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[317.486931] [079/131] (702s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[317.583299] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[317.587261] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[317.715220] [080/131] (702s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[317.808920] Starting subtest: plane-ctm3x4-lut1d
[317.822236] Starting dynamic subtest: pipe-A-eDP-1
[318.525044] Dynamic subtest pipe-A-eDP-1: FAIL (0.335s)
[319.254709] Starting dynamic subtest: pipe-B-eDP-1
[320.047397] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[320.650688] Starting dynamic subtest: pipe-C-eDP-1
[321.485733] Dynamic subtest pipe-C-eDP-1: FAIL (0.248s)
[321.951265] Starting dynamic subtest: pipe-D-eDP-1
[322.772205] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[322.774203] Subtest plane-ctm3x4-lut1d: FAIL (4.662s)
[323.322772] [081/131] (696s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[323.430439] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[323.432644] Starting dynamic subtest: A-eDP1
[332.327855] Dynamic subtest A-eDP1: SUCCESS (8.896s)
[332.341777] Starting dynamic subtest: B-eDP1
[341.214502] Dynamic subtest B-eDP1: SUCCESS (8.883s)
[341.224945] Starting dynamic subtest: C-eDP1
[350.131592] Dynamic subtest C-eDP1: SUCCESS (8.887s)
[350.142653] Starting dynamic subtest: D-eDP1
[359.012175] Dynamic subtest D-eDP1: SUCCESS (8.906s)
[359.017462] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.584s)
[360.227872] [082/131] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[360.330149] Starting subtest: psr-2p-primscrn-spr-indfb-move
[360.334312] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[360.436522] [083/131] (659s left) kms_cursor_edge_walk (256x256-top-bottom)
[360.532003] Starting subtest: 256x256-top-bottom
[360.534277] Starting dynamic subtest: pipe-A-eDP-1
[364.032761] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s)
[364.045274] Starting dynamic subtest: pipe-D-eDP-1
[367.225380] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.193s)
[367.227731] Subtest 256x256-top-bottom: SUCCESS (6.695s)
[368.126689] [084/131] (651s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[368.250923] Starting subtest: 2x-long-cursor-vs-flip-legacy
[368.255494] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[368.425049] [085/131] (651s left) kms_flip (flip-vs-modeset-vs-hang)
[368.520165] Starting subtest: flip-vs-modeset-vs-hang
[368.522374] Starting dynamic subtest: A-eDP1
[419.925899] Dynamic subtest A-eDP1: SUCCESS (51.400s)
[419.937293] Starting dynamic subtest: D-eDP1
[469.909816] Dynamic subtest D-eDP1: SUCCESS (49.981s)
[469.912282] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.388s)
[470.330141] [086/131] (549s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[470.721917] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[471.574388] [087/131] (548s left) gem_pxp (reject-modify-context-protection-off-3)
[471.704135] Starting subtest: reject-modify-context-protection-off-3
[471.706637] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[471.842350] [088/131] (548s left) kms_big_fb (linear-16bpp-rotate-0)
[471.945785] Starting subtest: linear-16bpp-rotate-0
[473.302506] Subtest linear-16bpp-rotate-0: SUCCESS (1.358s)
[473.478974] [089/131] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[473.593922] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[481.969748] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.378s)
[482.109915] [090/131] (538s left) gem_exec_reloc (basic-active)
[482.174024] Subtest basic-active: SKIP (0.000s)
[482.261566] [091/131] (537s left) syncobj_timeline (reset-unsignaled)
[482.322723] Starting subtest: reset-unsignaled
[482.324688] Subtest reset-unsignaled: SUCCESS (0.000s)
[482.456741] [092/131] (537s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[482.562753] Starting subtest: fbcpsr-shrfb-scaledprimary
[488.256224] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.695s)
[488.417370] [093/131] (531s left) syncobj_timeline (invalid-wait-bad-flags)
[488.474814] Starting subtest: invalid-wait-bad-flags
[488.477149] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[488.598199] [094/131] (531s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[488.698301] Starting subtest: fbc-rgb101010-draw-render
[493.275796] Subtest fbc-rgb101010-draw-render: SUCCESS (4.580s)
[494.433504] [095/131] (525s left) kms_hdr (bpc-switch)
[494.537497] Starting subtest: bpc-switch
[495.632307] Starting dynamic subtest: pipe-A-eDP-1
[499.023153] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.393s)
[499.025343] Subtest bpc-switch: SUCCESS (4.485s)
[499.174798] [096/131] (521s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[499.273506] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[503.675699] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.404s)
[504.820487] [097/131] (515s left) gem_exec_balancer (parallel-keep-submit-fence)
[505.077081] Starting subtest: parallel-keep-submit-fence
[506.278686] Subtest parallel-keep-submit-fence: SUCCESS (1.201s)
[506.416676] [098/131] (514s left) i915_pm_rc6_residency (rc6-idle)
[506.468848] Starting subtest: rc6-idle
[506.491043] Starting dynamic subtest: gt0-rcs0
[530.782706] Dynamic subtest gt0-rcs0: SUCCESS (24.290s)
[530.794312] Starting dynamic subtest: gt0-bcs0
[555.096578] Dynamic subtest gt0-bcs0: SUCCESS (24.310s)
[555.105144] Starting dynamic subtest: gt0-ccs0
[579.463885] Dynamic subtest gt0-ccs0: SUCCESS (24.363s)
[579.474907] Starting dynamic subtest: gt1-vcs0
[585.637845] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[585.649527] Starting dynamic subtest: gt1-vecs0
[591.809942] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[591.812795] Subtest rc6-idle: SUCCESS (85.337s)
[591.916220] [099/131] (428s left) prime_mmap (test_map_unmap)
[591.987672] Starting subtest: test_map_unmap
[591.989859] Starting dynamic subtest: test_map_unmap-smem
[592.015782] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s)
[592.018175] Subtest test_map_unmap: SUCCESS (0.030s)
[592.179250] [100/131] (428s left) kms_addfb_basic (invalid-set-prop-any)
[592.241628] Starting subtest: invalid-set-prop-any
[592.243533] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[592.403292] [101/131] (428s left) kms_setmode (basic)
[592.468701] Starting subtest: basic
[592.793583] Starting dynamic subtest: pipe-A-eDP-1
[594.876148] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.078s)
[595.220987] Starting dynamic subtest: pipe-B-eDP-1
[597.276007] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.059s)
[597.582831] Subtest basic: SUCCESS (5.112s)
[598.408754] [102/131] (422s left) kms_properties (colorop-properties-atomic)
[598.502175] Starting subtest: colorop-properties-atomic
[598.504146] Starting dynamic subtest: pipe-A-eDP-1
[598.846279] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.344s)
[598.855366] Starting dynamic subtest: pipe-B-eDP-1
[599.966003] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.119s)
[599.974918] Starting dynamic subtest: pipe-C-eDP-1
[601.018996] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.049s)
[601.028793] Starting dynamic subtest: pipe-D-eDP-1
[602.122175] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.101s)
[602.124127] Subtest colorop-properties-atomic: SUCCESS (3.619s)
[603.018581] [103/131] (417s left) gem_mmap_wc (read-write)
[603.094723] Subtest read-write: SKIP (0.000s)
[603.165409] [104/131] (417s left) gem_eio (kms)
[603.432915] Starting subtest: kms
[623.943460] Subtest kms: SUCCESS (20.507s)
[625.126591] [105/131] (395s left) drm_read (short-buffer-block)
[625.281618] Starting subtest: short-buffer-block
[625.283784] Subtest short-buffer-block: SUCCESS (0.000s)
[625.444261] [106/131] (395s left) gem_workarounds (reset-fd)
[625.510629] Starting subtest: reset-fd
[625.694103] Subtest reset-fd: SUCCESS (0.182s)
[625.849748] [107/131] (394s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[625.956490] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[625.960822] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[626.096251] [108/131] (394s left) kms_psr (fbc-psr-sprite-blt)
[626.206393] Starting subtest: fbc-psr-sprite-blt
[626.208262] Starting dynamic subtest: eDP-1
[626.211647] Dynamic subtest eDP-1: SKIP (0.000s)
[626.215162] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[626.306017] [109/131] (394s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[626.399566] Starting subtest: 4-tiled-16bpp-rotate-0
[627.767502] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.367s)
[627.912597] [110/131] (393s left) syncobj_timeline (invalid-signal-illegal-point)
[627.963037] Starting subtest: invalid-signal-illegal-point
[627.965051] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[628.101041] [111/131] (392s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[628.207003] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[628.208898] Starting dynamic subtest: pipe-A-eDP-1
[628.228591] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[628.239751] Starting dynamic subtest: pipe-B-eDP-1
[628.259333] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[628.269697] Starting dynamic subtest: pipe-C-eDP-1
[628.288477] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[628.297080] Starting dynamic subtest: pipe-D-eDP-1
[628.318155] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[628.321936] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[630.508166] [112/131] (390s left) kms_dsc (dsc-with-output-formats)
[630.609764] Starting subtest: dsc-with-output-formats
[630.631420] Subtest dsc-with-output-formats: SKIP (0.001s)
[630.706206] [113/131] (390s left) kms_properties (get_properties-sanity-atomic)
[630.803911] Starting subtest: get_properties-sanity-atomic
[630.806078] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[630.904992] [114/131] (390s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[631.012412] Starting subtest: 4-tiled-32bpp-rotate-90
[631.033360] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[631.184977] [115/131] (389s left) core_setmaster (master-drop-set-root)
[631.273928] Starting subtest: master-drop-set-root
[631.286008] Subtest master-drop-set-root: SUCCESS (0.012s)
[631.332825] [116/131] (389s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[631.429934] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[631.433446] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[631.562621] [117/131] (389s left) gem_sync (basic-all)
[631.638428] Starting subtest: basic-all
[633.787656] Subtest basic-all: SUCCESS (2.157s)
[633.996623] [118/131] (387s left) gem_ctx_persistence (heartbeat-close)
[634.066589] Starting subtest: heartbeat-close
[634.071129] Subtest heartbeat-close: SKIP (0.000s)
[634.210961] [119/131] (387s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[639.268734] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[639.273138] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[640.113764] [120/131] (381s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[640.216520] Starting subtest: primary-x-tiled-reflect-x-0
[647.172595] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.957s)
[648.411913] [121/131] (372s left) gem_eio (in-flight-external)
[648.639655] Starting subtest: in-flight-external
[650.502497] Subtest in-flight-external: SUCCESS (1.862s)
[650.687380] [122/131] (370s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[650.786827] Starting subtest: compare-crc-sanitycheck-xr24
[650.788999] Starting dynamic subtest: pipe-A-eDP-1
[651.386882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[651.396360] Starting dynamic subtest: pipe-B-eDP-1
[652.600977] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.213s)
[652.612062] Starting dynamic subtest: pipe-C-eDP-1
[653.848446] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.244s)
[653.858945] Starting dynamic subtest: pipe-D-eDP-1
[655.057449] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[655.059757] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.273s)
[655.907162] [123/131] (365s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[655.970170] Subtest writes-after-reads-uncached: SKIP (0.000s)
[656.030532] [124/131] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[656.120237] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[656.124216] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[656.242533] [125/131] (365s left) gem_mmap_gtt (big-bo-tiledy)
[656.311934] Subtest big-bo-tiledY: SKIP (0.000s)
[656.385572] [126/131] (365s left) i915_query (engine-info)
[656.439784] Starting subtest: engine-info
[656.441716] Subtest engine-info: SUCCESS (0.005s)
[656.612444] [127/131] (365s left) gem_ctx_persistence (engines-mixed-process)
[656.674598] Starting subtest: engines-mixed-process
[656.676939] Starting dynamic subtest: rcs0
[658.444017] Dynamic subtest rcs0: SUCCESS (1.769s)
[658.455056] Starting dynamic subtest: bcs0
[660.477883] Dynamic subtest bcs0: SUCCESS (2.032s)
[660.489061] Starting dynamic subtest: vcs0
[662.412869] Dynamic subtest vcs0: SUCCESS (1.934s)
[662.424276] Starting dynamic subtest: vcs1
[664.457056] Dynamic subtest vcs1: SUCCESS (2.042s)
[664.468603] Starting dynamic subtest: vecs0
[666.475374] Dynamic subtest vecs0: SUCCESS (2.013s)
[666.486357] Starting dynamic subtest: ccs0
[668.427175] Dynamic subtest ccs0: SUCCESS (1.954s)
[668.429957] Subtest engines-mixed-process: SUCCESS (11.752s)
[668.535451] [128/131] (353s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[668.598657] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[668.704343] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[668.809449] [129/131] (352s left) sysfs_heartbeat_interval (precise)
[668.872515] Starting subtest: precise
[668.875013] Starting dynamic subtest: vecs0
[676.476179] Dynamic subtest vecs0: SUCCESS (7.600s)
[676.487276] Starting dynamic subtest: ccs0
[677.707983] Dynamic subtest ccs0: SUCCESS (1.230s)
[677.720765] Starting dynamic subtest: vcs0
[685.452101] Dynamic subtest vcs0: SUCCESS (7.740s)
[685.464838] Starting dynamic subtest: bcs0
[686.574671] Dynamic subtest bcs0: SUCCESS (1.122s)
[686.587554] Starting dynamic subtest: rcs0
[687.746546] Dynamic subtest rcs0: SUCCESS (1.170s)
[687.762808] Starting dynamic subtest: vcs1
[695.491981] Dynamic subtest vcs1: SUCCESS (7.741s)
[695.494672] Subtest precise: SUCCESS (26.616s)
[695.590818] [130/131] (326s left) kms_psr (fbc-pr-cursor-render)
[695.678191] Starting subtest: fbc-pr-cursor-render
[695.682624] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[695.778615] [131/131] (326s left) kms_psr (psr2-sprite-render)
[695.874295] Starting subtest: psr2-sprite-render
[695.876576] Starting dynamic subtest: eDP-1
[697.540385] Dynamic subtest eDP-1: SUCCESS (1.668s)
[697.542861] Subtest psr2-sprite-render: SUCCESS (1.669s)
[698.403909] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: intel_hwmon
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: fbdev
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_tiled_display
results: parsing output: 13/ for test: kms_chamelium_frames
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_mmap_wc
results: parsing output: 17/ for test: kms_fence_pin_leak
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: kms_plane
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_lease
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: gem_caching
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_hdmi_inject
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_properties
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: gen9_exec_parse
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: gem_readwrite
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: gem_ctx_engines
results: parsing output: 60/ for test: kms_pm_dc
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exercise_blt
results: parsing output: 64/ for test: sw_sync
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_psr2_su
results: parsing output: 69/ for test: kms_vrr
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: vgem_basic
results: parsing output: 76/ for test: syncobj_eventfd
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_color_pipeline
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_chamelium_edid
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_hdr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: i915_pm_rc6_residency
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: kms_setmode
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: gem_workarounds
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: core_setmaster
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_sync
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: kms_pipe_crc_basic
results: parsing output: 122/ for test: gem_partial_pwrite_pread
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: sysfs_heartbeat_interval
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_psr
Done.