[58.362121] Initializing watchdogs
[58.362190]   /dev/watchdog0
[58.376937] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.381526] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.383874] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.387312] [001/132] (960s left) gem_fence_thrash (bo-write-verify-y)
[58.440399] Starting subtest: bo-write-verify-y
[58.460908] Subtest bo-write-verify-y: SKIP (0.016s)
[58.512338] [002/132] (960s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[58.628864] Starting subtest: yf-tiled-32bpp-rotate-180
[58.632724] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[58.726397] [003/132] (960s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[58.830699] Starting subtest: pixel-format-linear-modifier-source-clamping
[58.868217] Starting dynamic subtest: pipe-A-plane-0
[62.456702] Dynamic subtest pipe-A-plane-0: SUCCESS (3.589s)
[62.465134] Starting dynamic subtest: pipe-A-plane-3
[64.234437] Dynamic subtest pipe-A-plane-3: SUCCESS (1.777s)
[65.317059] Starting dynamic subtest: pipe-B-plane-0
[69.132527] Dynamic subtest pipe-B-plane-0: SUCCESS (3.822s)
[69.139347] Starting dynamic subtest: pipe-B-plane-3
[70.801081] Dynamic subtest pipe-B-plane-3: SUCCESS (1.667s)
[71.107556] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.278s)
[71.992621] [004/132] (947s left) kms_psr (fbc-pr-cursor-render)
[72.088948] Starting subtest: fbc-pr-cursor-render
[72.093133] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[72.157163] [005/132] (946s left) kms_lease (simple-lease)
[72.258784] Starting subtest: simple-lease
[72.262422] Starting dynamic subtest: pipe-A-eDP-1
[72.780185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.522s)
[72.789927] Starting dynamic subtest: pipe-B-eDP-1
[74.245968] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.462s)
[74.255895] Starting dynamic subtest: pipe-C-eDP-1
[75.657103] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.411s)
[75.665545] Starting dynamic subtest: pipe-D-eDP-1
[77.070417] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.412s)
[77.072856] Subtest simple-lease: SUCCESS (4.812s)
[77.866669] [006/132] (941s left) gem_mmap_gtt (ptrace)
[77.930508] Subtest ptrace: SKIP (0.000s)
[77.987736] [007/132] (941s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[78.084905] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[78.087247] Starting dynamic subtest: pipe-A-default-mode
[80.813426] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s)
[80.815801] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.723s)
[81.665416] [008/132] (937s left) i915_pm_rps (min-max-config-loaded)
[81.739657] Starting subtest: min-max-config-loaded
[81.744112] Subtest min-max-config-loaded: SKIP (0.001s)
[81.837123] [009/132] (937s left) perf (gen12-mi-rpc)
[81.976876] Starting subtest: gen12-mi-rpc
[81.979036] Starting dynamic subtest: rcs0
[81.994331] Dynamic subtest rcs0: SUCCESS (0.018s)
[81.996434] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[82.039823] [010/132] (937s left) kms_flip (2x-flip-vs-rmfb)
[82.168108] Starting subtest: 2x-flip-vs-rmfb
[82.177671] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[82.250830] [011/132] (937s left) i915_query (query-topology-coherent-slice-mask)
[82.315999] Starting subtest: query-topology-coherent-slice-mask
[82.320675] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[82.424610] [012/132] (936s left) kms_psr (pr-sprite-blt)
[82.515913] Starting subtest: pr-sprite-blt
[82.520050] Subtest pr-sprite-blt: SKIP (0.000s)
[82.603678] [013/132] (936s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[82.693868] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[82.697572] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[82.775458] [014/132] (936s left) kms_atomic (plane-immutable-zpos)
[82.866114] Starting subtest: plane-immutable-zpos
[82.868126] Starting dynamic subtest: pipe-A-eDP-1
[83.505634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.639s)
[83.508074] Subtest plane-immutable-zpos: SUCCESS (0.640s)
[84.313285] [015/132] (935s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[84.420028] Starting subtest: bad-pixel-format-yf-tiled-ccs
[84.422219] Starting dynamic subtest: pipe-A-eDP-1
[84.444454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[84.454089] Starting dynamic subtest: pipe-B-eDP-1
[84.475778] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[84.482986] Starting dynamic subtest: pipe-C-eDP-1
[84.504257] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[84.511416] Starting dynamic subtest: pipe-D-eDP-1
[84.532857] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[84.537441] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[86.681620] [016/132] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[86.790078] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[86.794262] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[86.882063] [017/132] (932s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[86.983609] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[86.995265] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[87.074772] [018/132] (932s left) sw_sync (alloc_merge_fence)
[87.116597] Starting subtest: alloc_merge_fence
[87.118727] Subtest alloc_merge_fence: SUCCESS (0.000s)
[87.170923] [019/132] (932s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[87.264163] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[87.268295] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[87.351729] [020/132] (932s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[87.449951] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[87.454511] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[87.551482] [021/132] (932s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[87.632154] Starting subtest: mixed-tiled-to-y-tiled-ccs
[87.635677] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[87.811701] [022/132] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[87.908699] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[95.412017] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.508s)
[95.534847] [023/132] (924s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[95.623129] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[95.627553] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[96.750868] [024/132] (923s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[96.868985] Starting subtest: 4-tiled-32bpp-rotate-0
[98.336227] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.468s)
[98.467894] [025/132] (921s left) kms_prime (basic-crc-vgem)
[98.633032] Starting subtest: basic-crc-vgem
[98.634799] Starting dynamic subtest: second-to-first
[99.622086] Dynamic subtest second-to-first: SUCCESS (0.991s)
[99.624157] Subtest basic-crc-vgem: SUCCESS (0.992s)
[99.713772] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[99.717211] [026/132] (920s left) kms_properties (plane-properties-atomic)
[99.842212] Starting subtest: plane-properties-atomic
[99.844218] Starting dynamic subtest: pipe-A-eDP-1
[100.391902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[100.402132] Starting dynamic subtest: pipe-B-eDP-1
[101.627071] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.234s)
[101.637160] Starting dynamic subtest: pipe-C-eDP-1
[102.862076] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[102.871176] Starting dynamic subtest: pipe-D-eDP-1
[104.088473] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[104.090751] Subtest plane-properties-atomic: SUCCESS (4.247s)
[104.888159] [027/132] (915s left) kms_vblank (crtc-id)
[104.999259] Starting subtest: crtc-id
[105.001433] Starting dynamic subtest: pipe-A-eDP-1
[105.453925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[105.467663] Starting dynamic subtest: pipe-D-eDP-1
[106.635454] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.181s)
[106.637352] Subtest crtc-id: SUCCESS (1.638s)
[107.468317] [028/132] (912s left) gem_shrink (reclaim)
[107.537395] Starting subtest: reclaim
[110.059162] Subtest reclaim: SUCCESS (2.517s)
[110.190328] [029/132] (909s left) kms_pm_rpm (fences)
[112.038990] Starting subtest: fences
[112.044054] Subtest fences: SKIP (0.000s)
[112.525127] [030/132] (907s left) gem_spin_batch (legacy-resubmit)
[112.590066] Starting subtest: legacy-resubmit
[112.592407] Starting dynamic subtest: default
[112.596834] Dynamic subtest default: SUCCESS (0.006s)
[112.604794] Starting dynamic subtest: render
[112.606662] Dynamic subtest render: SUCCESS (0.001s)
[112.614471] Starting dynamic subtest: bsd
[112.616374] Dynamic subtest bsd: SUCCESS (0.002s)
[112.623375] Starting dynamic subtest: bsd1
[112.625295] Dynamic subtest bsd1: SUCCESS (0.001s)
[112.632270] Starting dynamic subtest: bsd2
[112.634178] Dynamic subtest bsd2: SUCCESS (0.003s)
[112.641144] Starting dynamic subtest: blt
[112.643031] Dynamic subtest blt: SUCCESS (0.002s)
[112.650062] Starting dynamic subtest: vebox
[112.651885] Dynamic subtest vebox: SUCCESS (0.003s)
[112.653780] Subtest legacy-resubmit: SUCCESS (0.023s)
[112.841709] [031/132] (907s left) prime_mmap (test_correct_cpu_write)
[112.888881] Starting subtest: test_correct_cpu_write
[112.890750] Starting dynamic subtest: test_correct_cpu_write-smem
[112.892597] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[112.894492] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[112.966584] [032/132] (907s left) gen9_exec_parse (bb-oversize)
[113.028169] Subtest bb-oversize: SKIP (0.000s)
[113.103201] [033/132] (907s left) prime_busy (hang)
[113.151233] Starting subtest: hang
[113.153592] Starting dynamic subtest: rcs0
[139.439743] Dynamic subtest rcs0: SUCCESS (26.285s)
[139.449772] Starting dynamic subtest: bcs0
[146.595997] Dynamic subtest bcs0: SUCCESS (7.154s)
[146.603324] Starting dynamic subtest: vcs0
[153.571881] Dynamic subtest vcs0: SUCCESS (6.975s)
[153.579464] Starting dynamic subtest: vcs1
[160.542718] Dynamic subtest vcs1: SUCCESS (6.972s)
[160.550457] Starting dynamic subtest: vecs0
[167.584380] Dynamic subtest vecs0: SUCCESS (7.038s)
[167.591592] Starting dynamic subtest: ccs0
[181.423550] Dynamic subtest ccs0: SUCCESS (13.838s)
[181.425934] Subtest hang: SUCCESS (68.267s)
[181.531948] [034/132] (838s left) kms_content_protection (suspend-resume)
[181.677117] Starting subtest: suspend-resume
[181.681570] Subtest suspend-resume: SKIP (0.000s)
[181.788130] [035/132] (838s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[181.884000] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[181.888362] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[181.982471] [036/132] (838s left) syncobj_timeline (single-wait-available-submitted)
[182.033818] Starting subtest: single-wait-available-submitted
[182.035987] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[182.141344] [037/132] (838s left) gem_exec_whisper (basic-queues-priority-all)
[182.198776] Starting subtest: basic-queues-priority-all
[204.075780] Subtest basic-queues-priority-all: SUCCESS (21.873s)
[204.259203] [038/132] (816s left) gem_mmap_gtt (fault-concurrent-x)
[204.307724] Subtest fault-concurrent-X: SKIP (0.000s)
[204.371947] [039/132] (816s left) kms_vblank (query-forked)
[204.481893] Starting subtest: query-forked
[204.484096] Starting dynamic subtest: pipe-A-eDP-1
[206.316521] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.833s)
[206.330876] Starting dynamic subtest: pipe-D-eDP-1
[208.803328] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.486s)
[208.805759] Subtest query-forked: SUCCESS (4.323s)
[209.658664] [040/132] (810s left) kms_invalid_mode (clock-too-high)
[209.743943] Starting subtest: clock-too-high
[209.746235] Starting dynamic subtest: pipe-A-eDP-1
[209.750672] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[209.759100] Starting dynamic subtest: pipe-B-eDP-1
[209.763575] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.771649] Starting dynamic subtest: pipe-C-eDP-1
[209.775837] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.783539] Starting dynamic subtest: pipe-D-eDP-1
[209.788566] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.792980] Subtest clock-too-high: SKIP (0.004s)
[209.829455] [041/132] (810s left) gem_sync (basic-each)
[209.895821] Starting subtest: basic-each
[212.250074] Subtest basic-each: SUCCESS (2.363s)
[212.434263] [042/132] (808s left) kms_plane_scaling (planes-upscale-20x20)
[212.522103] Starting subtest: planes-upscale-20x20
[212.524454] Starting dynamic subtest: pipe-A
[212.582099] Dynamic subtest pipe-A: SUCCESS (0.062s)
[212.590329] Starting dynamic subtest: pipe-B
[213.688077] Dynamic subtest pipe-B: SUCCESS (1.105s)
[213.698105] Starting dynamic subtest: pipe-C
[214.798539] Dynamic subtest pipe-C: SUCCESS (1.110s)
[214.808060] Starting dynamic subtest: pipe-D
[215.933488] Dynamic subtest pipe-D: SUCCESS (1.134s)
[215.935730] Subtest planes-upscale-20x20: SUCCESS (3.415s)
[217.091225] [043/132] (803s left) gem_mmap_gtt (hang)
[217.164502] Subtest hang: SKIP (0.000s)
[217.224096] [044/132] (803s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[217.342278] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[228.532848] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.189s)
[229.331682] [045/132] (791s left) kms_rotation_crc (sprite-rotation-270)
[229.434021] Starting subtest: sprite-rotation-270
[229.438358] Subtest sprite-rotation-270: SKIP (0.002s)
[229.520887] [046/132] (791s left) gem_exec_whisper (basic-normal)
[229.583382] Starting subtest: basic-normal
[233.002526] Subtest basic-normal: SUCCESS (3.419s)
[233.185980] [047/132] (787s left) syncobj_timeline (invalid-wait-illegal-handle)
[233.251267] Starting subtest: invalid-wait-illegal-handle
[233.253572] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[233.346157] [048/132] (787s left) gem_userptr_blits (sync-unmap)
[233.413061] Starting subtest: sync-unmap
[233.429662] Subtest sync-unmap: SUCCESS (0.019s)
[233.552694] [049/132] (787s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[233.655790] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[234.687952] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.032s)
[234.812740] [050/132] (786s left) kms_getfb (getfb-handle-protection)
[234.928071] Starting subtest: getfb-handle-protection
[234.944927] Subtest getfb-handle-protection: SUCCESS (0.018s)
[235.077326] [051/132] (785s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[235.165311] Starting subtest: random-ccs-data-yf-tiled-ccs
[235.167173] Starting dynamic subtest: pipe-A-eDP-1
[235.187749] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[235.198723] Starting dynamic subtest: pipe-B-eDP-1
[235.217998] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[235.228218] Starting dynamic subtest: pipe-C-eDP-1
[235.247256] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[235.257191] Starting dynamic subtest: pipe-D-eDP-1
[235.277072] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[235.280363] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[237.488622] [052/132] (783s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[237.583994] Starting subtest: async-flip-with-page-flip-events-tiled
[237.959624] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[240.752260] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[240.763815] Starting dynamic subtest: pipe-A-eDP-1-4
[242.938796] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[242.949694] Starting dynamic subtest: pipe-A-eDP-1-4
[244.948233] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[244.959648] Starting dynamic subtest: pipe-A-eDP-1-x
[247.138792] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[247.525838] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[250.288645] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.768s)
[250.297515] Starting dynamic subtest: pipe-B-eDP-1-4
[252.476266] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[252.484945] Starting dynamic subtest: pipe-B-eDP-1-4
[254.484828] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[254.494517] Starting dynamic subtest: pipe-B-eDP-1-x
[256.686658] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[257.050334] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[259.821466] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[259.833108] Starting dynamic subtest: pipe-C-eDP-1-4
[261.995082] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[262.004346] Starting dynamic subtest: pipe-C-eDP-1-4
[264.006880] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[264.018118] Starting dynamic subtest: pipe-C-eDP-1-x
[266.196284] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[266.568207] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[269.354946] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[269.364329] Starting dynamic subtest: pipe-D-eDP-1-4
[271.528531] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s)
[271.538559] Starting dynamic subtest: pipe-D-eDP-1-4
[273.538469] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[273.550329] Starting dynamic subtest: pipe-D-eDP-1-x
[275.728681] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[275.732089] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.145s)
[276.941798] [053/132] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[277.046632] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[277.050764] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[277.143366] [054/132] (743s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[277.246988] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[277.251625] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[277.338123] [055/132] (743s left) kms_plane (plane-panning-bottom-right)
[277.439242] Starting subtest: plane-panning-bottom-right
[277.441547] Starting dynamic subtest: pipe-A
[279.096933] Dynamic subtest pipe-A: SUCCESS (1.653s)
[279.106151] Starting dynamic subtest: pipe-B
[281.446831] Dynamic subtest pipe-B: SUCCESS (2.352s)
[281.449210] Subtest plane-panning-bottom-right: SUCCESS (4.009s)
[282.260180] [056/132] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[282.366542] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[282.370579] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[282.463432] [057/132] (738s left) kms_rmfb (close-fd)
[282.557283] Starting subtest: close-fd
[282.559492] Starting dynamic subtest: pipe-A-eDP-1
[282.666427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[282.675879] Starting dynamic subtest: pipe-B-eDP-1
[283.815530] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s)
[283.825663] Starting dynamic subtest: pipe-C-eDP-1
[284.951013] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[284.959634] Starting dynamic subtest: pipe-D-eDP-1
[286.090180] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[286.092546] Subtest close-fd: SUCCESS (3.533s)
[287.299600] [058/132] (733s left) kms_flip (2x-flip-vs-dpms)
[287.406437] Starting subtest: 2x-flip-vs-dpms
[287.415083] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[287.511307] [059/132] (733s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[287.623681] Starting subtest: psr-2p-primscrn-spr-indfb-move
[287.628242] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[287.727699] [060/132] (733s left) sysfs_preempt_timeout (invalid)
[287.785636] Starting subtest: invalid
[287.787953] Starting dynamic subtest: vecs0
[287.790288] Dynamic subtest vecs0: SUCCESS (0.000s)
[287.800447] Starting dynamic subtest: ccs0
[287.802267] Dynamic subtest ccs0: SUCCESS (0.000s)
[287.810236] Starting dynamic subtest: vcs0
[287.812062] Dynamic subtest vcs0: SUCCESS (0.000s)
[287.820140] Starting dynamic subtest: bcs0
[287.821970] Dynamic subtest bcs0: SUCCESS (0.000s)
[287.829681] Starting dynamic subtest: rcs0
[287.832773] Dynamic subtest rcs0: SUCCESS (0.000s)
[287.840896] Starting dynamic subtest: vcs1
[287.843247] Dynamic subtest vcs1: SUCCESS (0.000s)
[287.845608] Subtest invalid: SUCCESS (0.006s)
[287.894399] [061/132] (733s left) api_intel_allocator (fork-simple-once)
[287.950395] Starting subtest: fork-simple-once
[287.966713] Subtest fork-simple-once: SUCCESS (0.019s)
[288.098730] [062/132] (733s left) gem_exec_reloc (basic-cpu-read-active)
[288.157984] Subtest basic-cpu-read-active: SKIP (0.000s)
[288.226218] [063/132] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[288.316047] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[288.319703] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[288.424188] [064/132] (733s left) kms_properties (colorop-properties-atomic)
[288.509733] Starting subtest: colorop-properties-atomic
[288.511350] Starting dynamic subtest: pipe-A-eDP-1
[288.870597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[288.881788] Starting dynamic subtest: pipe-B-eDP-1
[289.968739] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.094s)
[289.979803] Starting dynamic subtest: pipe-C-eDP-1
[291.012308] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.041s)
[291.020946] Starting dynamic subtest: pipe-D-eDP-1
[292.055384] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.043s)
[292.057659] Subtest colorop-properties-atomic: SUCCESS (3.547s)
[292.857165] [065/132] (728s left) gem_exec_reloc (basic-write-gtt)
[292.916686] Subtest basic-write-gtt: SKIP (0.000s)
[292.986301] [066/132] (728s left) syncobj_wait (invalid-single-wait-unsubmitted)
[293.034780] Starting subtest: invalid-single-wait-unsubmitted
[293.036976] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[293.145393] [067/132] (728s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[293.239056] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[293.241193] Starting dynamic subtest: pipe-A-eDP-1
[293.297646] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[293.305950] Starting dynamic subtest: pipe-B-eDP-1
[293.359682] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[293.368722] Starting dynamic subtest: pipe-C-eDP-1
[293.422622] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[293.430951] Starting dynamic subtest: pipe-D-eDP-1
[293.484691] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[293.489169] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[295.518602] [068/132] (726s left) gem_exec_params (rsvd2-dirt)
[295.579043] Starting subtest: rsvd2-dirt
[295.583291] Subtest rsvd2-dirt: SKIP (0.000s)
[295.684144] [069/132] (725s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[295.820925] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[295.824913] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[295.919595] [070/132] (725s left) i915_pm_freq_api (freq-basic-api)
[295.981707] Starting subtest: freq-basic-api
[295.983979] Starting dynamic subtest: gt0
[295.986320] Dynamic subtest gt0: SUCCESS (0.003s)
[295.996076] Starting dynamic subtest: gt1
[295.998343] Dynamic subtest gt1: SUCCESS (0.004s)
[296.000481] Subtest freq-basic-api: SUCCESS (0.009s)
[296.114949] [071/132] (725s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[296.482605] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[297.338275] [072/132] (724s left) kms_cursor_edge_walk (128x128-top-edge)
[297.438185] Starting subtest: 128x128-top-edge
[297.440308] Starting dynamic subtest: pipe-A-eDP-1
[300.921477] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[300.932118] Starting dynamic subtest: pipe-D-eDP-1
[304.034492] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[304.036795] Subtest 128x128-top-edge: SUCCESS (6.597s)
[304.854009] [073/132] (716s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[304.970198] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[304.974090] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[305.042750] [074/132] (716s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[305.160458] Starting subtest: flip-vs-cursor-crc-legacy
[305.859399] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.699s)
[306.694371] [075/132] (715s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[306.747031] Starting subtest: invalid-bsd1-flag-on-blt
[306.749675] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[306.845947] [076/132] (715s left) gem_exec_schedule (semaphore-user)
[306.929760] Starting subtest: semaphore-user
[306.980823] Subtest semaphore-user: SUCCESS (0.057s)
[308.961995] [077/132] (713s left) kms_psr (psr2-sprite-mmap-cpu)
[309.060021] Starting subtest: psr2-sprite-mmap-cpu
[309.062309] Starting dynamic subtest: eDP-1
[310.781952] Dynamic subtest eDP-1: SUCCESS (1.720s)
[310.784346] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.722s)
[311.656375] [078/132] (710s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[311.757273] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[311.761473] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[311.869807] [079/132] (710s left) kms_cursor_crc (cursor-onscreen-32x10)
[312.039467] Starting subtest: cursor-onscreen-32x10
[312.090371] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[312.396858] [080/132] (709s left) syncobj_timeline (reset-multiple-signaled)
[312.459653] Starting subtest: reset-multiple-signaled
[312.461988] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[312.551428] [081/132] (709s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[312.650447] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[312.653962] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[312.742747] [082/132] (709s left) kms_chamelium_edid (dp-mode-timings)
[313.143933] Subtest dp-mode-timings: SKIP (0.000s)
[313.963579] [083/132] (708s left) kms_psr (fbc-pr-sprite-blt)
[314.063421] Starting subtest: fbc-pr-sprite-blt
[314.067769] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[314.141355] [084/132] (708s left) prime_mmap (test_correct)
[314.204473] Starting subtest: test_correct
[314.206665] Starting dynamic subtest: test_correct-smem
[314.246812] Dynamic subtest test_correct-smem: SUCCESS (0.042s)
[314.249226] Subtest test_correct: SUCCESS (0.044s)
[314.357447] [085/132] (708s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[314.467237] Starting subtest: y-tiled-32bpp-rotate-270
[314.471106] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[314.565198] [086/132] (707s left) i915_drm_fdinfo (busy)
[314.605416] Starting subtest: busy
[314.607271] Starting dynamic subtest: rcs0
[314.621679] Dynamic subtest rcs0: SKIP (0.016s)
[314.630038] Starting dynamic subtest: bcs0
[314.636647] Dynamic subtest bcs0: SKIP (0.014s)
[314.647590] Starting dynamic subtest: vcs0
[314.651730] Dynamic subtest vcs0: SKIP (0.000s)
[314.660085] Starting dynamic subtest: vcs1
[314.664205] Dynamic subtest vcs1: SKIP (0.000s)
[314.672474] Starting dynamic subtest: vecs0
[314.676662] Dynamic subtest vecs0: SKIP (0.000s)
[314.684787] Starting dynamic subtest: ccs0
[314.689088] Dynamic subtest ccs0: SKIP (0.000s)
[314.693235] Subtest busy: SKIP (0.035s)
[314.730484] [087/132] (707s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[314.834716] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[314.839053] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[314.913020] [088/132] (707s left) kms_color (invalid-gamma-lut-sizes)
[315.000210] Starting subtest: invalid-gamma-lut-sizes
[315.002245] Starting dynamic subtest: pipe-A
[315.288923] Dynamic subtest pipe-A: SUCCESS (0.289s)
[315.298773] Starting dynamic subtest: pipe-B
[315.300902] Dynamic subtest pipe-B: SUCCESS (0.000s)
[315.319721] Starting dynamic subtest: pipe-C
[315.322244] Dynamic subtest pipe-C: SUCCESS (0.000s)
[315.340366] Starting dynamic subtest: pipe-D
[315.342706] Dynamic subtest pipe-D: SUCCESS (0.000s)
[315.344933] Subtest invalid-gamma-lut-sizes: SUCCESS (0.292s)
[316.116576] [089/132] (706s left) kms_dsc (dsc-with-formats)
[316.218878] Starting subtest: dsc-with-formats
[316.258768] Subtest dsc-with-formats: SKIP (0.002s)
[316.299639] [090/132] (706s left) perf_pmu (render-node-busy)
[316.374299] Starting subtest: render-node-busy
[316.376752] Starting dynamic subtest: rcs0
[316.961992] Dynamic subtest rcs0: SUCCESS (0.587s)
[316.973469] Starting dynamic subtest: bcs0
[317.528279] Dynamic subtest bcs0: SUCCESS (0.564s)
[317.539738] Starting dynamic subtest: vcs0
[318.933057] Dynamic subtest vcs0: SUCCESS (1.401s)
[318.944562] Starting dynamic subtest: vcs1
[320.917456] Dynamic subtest vcs1: SUCCESS (1.981s)
[320.928870] Starting dynamic subtest: vecs0
[322.900556] Dynamic subtest vecs0: SUCCESS (1.980s)
[322.912896] Starting dynamic subtest: ccs0
[323.478631] Dynamic subtest ccs0: SUCCESS (0.577s)
[323.481197] Subtest render-node-busy: SUCCESS (7.105s)
[323.556168] [091/132] (699s left) gem_exec_capture (pi)
[323.626759] Starting subtest: pi
[323.629008] Starting dynamic subtest: rcs0
[327.911972] Dynamic subtest rcs0: SUCCESS (4.284s)
[327.921805] Starting dynamic subtest: bcs0
[331.871648] Dynamic subtest bcs0: SUCCESS (3.958s)
[331.882472] Starting dynamic subtest: vcs0
[335.767212] Dynamic subtest vcs0: SUCCESS (3.893s)
[335.776511] Starting dynamic subtest: vcs1
[339.697198] Dynamic subtest vcs1: SUCCESS (3.928s)
[339.708414] Starting dynamic subtest: vecs0
[343.635383] Dynamic subtest vecs0: SUCCESS (3.938s)
[343.644362] Starting dynamic subtest: ccs0
[347.673785] Dynamic subtest ccs0: SUCCESS (4.036s)
[347.677078] Subtest pi: SUCCESS (24.047s)
[347.763871] [092/132] (674s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[347.880729] Starting subtest: multi-wait-all-for-submit-signaled
[347.882730] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[347.984465] [093/132] (674s left) gem_create (create-ext-placement-each)
[348.154809] Starting subtest: create-ext-placement-each
[348.157482] Subtest create-ext-placement-each: SUCCESS (0.000s)
[348.272383] [094/132] (674s left) gem_pxp (create-regular-context-2)
[348.399979] Starting subtest: create-regular-context-2
[348.402474] Subtest create-regular-context-2: SUCCESS (0.002s)
[348.518238] [095/132] (674s left) kms_flip (dpms-off-confusion)
[348.621221] Starting subtest: dpms-off-confusion
[348.623167] Starting dynamic subtest: A-eDP1
[357.321161] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[357.332707] Starting dynamic subtest: B-eDP1
[365.959488] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[365.973362] Starting dynamic subtest: C-eDP1
[374.579759] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[374.590196] Starting dynamic subtest: D-eDP1
[383.211624] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[383.216652] Subtest dpms-off-confusion: SUCCESS (34.598s)
[384.386172] [096/132] (638s left) gem_exec_reloc (basic-write-wc-noreloc)
[384.457154] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[384.539551] [097/132] (638s left) i915_pm_rps (thresholds-idle)
[384.602314] Starting subtest: thresholds-idle
[384.606959] Subtest thresholds-idle: SKIP (0.000s)
[384.705451] [098/132] (638s left) core_getstats (basic)
[384.766311] Starting subtest: basic
[384.768569] Subtest basic: SUCCESS (0.000s)
[384.866969] [099/132] (638s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[384.929611] Starting subtest: saturated-hostile-nopreempt
[384.931833] Starting dynamic subtest: rcs0
[384.996268] Dynamic subtest rcs0: SKIP (0.063s)
[385.007526] Starting dynamic subtest: bcs0
[385.011795] Dynamic subtest bcs0: SKIP (0.015s)
[385.020402] Starting dynamic subtest: vcs0
[385.035502] Dynamic subtest vcs0: SKIP (0.023s)
[385.043911] Starting dynamic subtest: vcs1
[385.057445] Dynamic subtest vcs1: SKIP (0.021s)
[385.065684] Starting dynamic subtest: vecs0
[385.072183] Dynamic subtest vecs0: SKIP (0.012s)
[385.080232] Starting dynamic subtest: ccs0
[385.084321] Dynamic subtest ccs0: SKIP (0.013s)
[385.088520] Subtest saturated-hostile-nopreempt: SKIP (0.153s)
[385.160493] [100/132] (637s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[385.221595] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[385.329079] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[385.407393] [101/132] (637s left) vgem_basic (unload)
[385.443548] Starting subtest: unload
[414.453806] Subtest unload: SUCCESS (29.011s)
[414.550940] [102/132] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[414.657178] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[414.661388] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[414.756672] [103/132] (608s left) gem_bad_reloc (negative-reloc)
[414.825238] Subtest negative-reloc: SKIP (0.000s)
[414.907391] [104/132] (608s left) syncobj_wait (invalid-reset-zero-handles)
[414.955552] Starting subtest: invalid-reset-zero-handles
[414.957472] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[415.053627] [105/132] (608s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[415.148589] Starting subtest: psr-rgb101010-draw-mmap-gtt
[415.152729] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[415.248867] [106/132] (608s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[415.305231] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[415.374767] [107/132] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[415.493703] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[415.497275] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[415.587234] [108/132] (607s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[415.674636] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[415.676425] Starting dynamic subtest: pipe-A-eDP-1
[415.694851] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[415.705133] Starting dynamic subtest: pipe-B-eDP-1
[415.722433] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[415.730645] Starting dynamic subtest: pipe-C-eDP-1
[415.747779] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[415.756065] Starting dynamic subtest: pipe-D-eDP-1
[415.773452] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[415.776699] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[417.951470] [109/132] (605s left) gem_exec_fence (syncobj-timeline-chain-engines)
[418.482178] Starting subtest: syncobj-timeline-chain-engines
[418.593251] Subtest syncobj-timeline-chain-engines: SUCCESS (0.112s)
[419.984371] [110/132] (603s left) gem_workarounds (basic-read)
[420.073651] Starting subtest: basic-read
[420.089475] Subtest basic-read: SUCCESS (0.016s)
[420.215104] [111/132] (603s left) kms_psr (psr-sprite-mmap-gtt)
[420.310061] Starting subtest: psr-sprite-mmap-gtt
[420.312239] Starting dynamic subtest: eDP-1
[421.760392] Dynamic subtest eDP-1: SKIP (1.447s)
[421.764945] Subtest psr-sprite-mmap-gtt: SKIP (1.449s)
[421.930181] [112/132] (601s left) kms_psr (fbc-psr-sprite-plane-onoff)
[422.022698] Starting subtest: fbc-psr-sprite-plane-onoff
[422.024936] Starting dynamic subtest: eDP-1
[422.029076] Dynamic subtest eDP-1: SKIP (0.000s)
[422.033428] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[422.095696] [113/132] (601s left) kms_plane_alpha_blend (coverage-7efc)
[422.190276] Starting subtest: coverage-7efc
[422.492197] Starting dynamic subtest: pipe-A-eDP-1
[423.058276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[423.087252] Starting dynamic subtest: pipe-D-eDP-1
[424.386575] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[424.388956] Subtest coverage-7efc: SUCCESS (2.196s)
[425.229847] [114/132] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[425.325980] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[425.330469] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[425.423783] [115/132] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[425.526602] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[425.530667] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[425.622274] [116/132] (598s left) gem_exec_schedule (preempt-other-chain)
[425.685267] Starting subtest: preempt-other-chain
[425.687486] Starting dynamic subtest: rcs0
[425.761723] Dynamic subtest rcs0: SUCCESS (0.083s)
[425.773980] Starting dynamic subtest: bcs0
[425.848600] Dynamic subtest bcs0: SUCCESS (0.086s)
[425.859549] Starting dynamic subtest: vcs0
[425.929497] Dynamic subtest vcs0: SUCCESS (0.080s)
[425.943098] Starting dynamic subtest: vcs1
[426.007037] Dynamic subtest vcs1: SUCCESS (0.076s)
[426.021405] Starting dynamic subtest: vecs0
[426.092212] Dynamic subtest vecs0: SUCCESS (0.084s)
[426.110040] Starting dynamic subtest: ccs0
[426.171947] Dynamic subtest ccs0: SUCCESS (0.079s)
[426.174168] Subtest preempt-other-chain: SUCCESS (0.495s)
[427.013163] [117/132] (596s left) kms_vblank (query-forked-hang)
[427.105266] Starting subtest: query-forked-hang
[427.107537] Starting dynamic subtest: pipe-A-eDP-1
[453.646457] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.538s)
[453.661714] Starting dynamic subtest: pipe-D-eDP-1
[468.769472] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.121s)
[468.771341] Subtest query-forked-hang: SUCCESS (41.664s)
[469.598053] [118/132] (554s left) kms_cursor_legacy (forked-bo)
[469.723300] Starting subtest: forked-bo
[469.725578] Starting dynamic subtest: pipe-A
[475.181609] Dynamic subtest pipe-A: SUCCESS (5.455s)
[475.195875] Starting dynamic subtest: pipe-B
[480.655505] Dynamic subtest pipe-B: SUCCESS (5.471s)
[480.670737] Starting dynamic subtest: pipe-C
[486.120444] Dynamic subtest pipe-C: SUCCESS (5.463s)
[486.131748] Starting dynamic subtest: pipe-D
[491.606403] Dynamic subtest pipe-D: SUCCESS (5.483s)
[491.622744] Starting dynamic subtest: all-pipes
[497.104882] Dynamic subtest all-pipes: SUCCESS (5.495s)
[497.107478] Subtest forked-bo: SUCCESS (27.379s)
[497.264724] [119/132] (526s left) kms_atomic_transition (plane-all-transition-nonblocking)
[497.358353] Starting subtest: plane-all-transition-nonblocking
[497.360754] Starting dynamic subtest: pipe-A-eDP-1
[499.851197] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[500.158967] Starting dynamic subtest: pipe-B-eDP-1
[503.424791] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.274s)
[503.721818] Subtest plane-all-transition-nonblocking: SUCCESS (6.366s)
[504.555607] [120/132] (519s left) core_hotunplug (unbind-rebind)
[504.663153] Starting subtest: unbind-rebind
[510.548380] Subtest unbind-rebind: SUCCESS (5.888s)
[510.591624] [121/132] (513s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[511.909761] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[515.515792] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.610s)
[516.645733] [122/132] (507s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[516.742075] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[516.746296] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[516.816554] [123/132] (507s left) kms_flip (2x-plain-flip-interruptible)
[516.908641] Starting subtest: 2x-plain-flip-interruptible
[516.921066] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[516.997445] [124/132] (507s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[517.054683] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[517.161080] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[517.249969] [125/132] (506s left) kms_addfb_basic (bad-pitch-32)
[517.307419] Starting subtest: bad-pitch-32
[517.309647] Subtest bad-pitch-32: SUCCESS (0.000s)
[517.436824] [126/132] (506s left) gem_exec_params (invalid-fence-in)
[517.498407] Starting subtest: invalid-fence-in
[517.500297] Subtest invalid-fence-in: SUCCESS (0.000s)
[517.600155] [127/132] (506s left) gem_userptr_blits (vma-merge)
[517.667635] Starting subtest: vma-merge
[517.705690] Subtest vma-merge: SUCCESS (0.038s)
[517.843408] [128/132] (506s left) gem_exec_balancer (noheartbeat)
[518.112421] Starting subtest: noheartbeat
[518.117394] Subtest noheartbeat: SKIP (0.000s)
[518.244442] [129/132] (506s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[518.507889] Starting subtest: cursor-rapid-movement-256x85
[518.558841] Subtest cursor-rapid-movement-256x85: SKIP (0.048s)
[518.714039] [130/132] (505s left) gem_ctx_param (invalid-set-ringsize)
[518.767763] Starting subtest: invalid-set-ringsize
[518.770245] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[518.856073] [131/132] (505s left) gem_exec_reloc (basic-scanout)
[518.913062] Subtest basic-scanout: SKIP (0.000s)
[518.990277] [132/132] (505s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[519.045554] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[519.049968] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[519.227487] Closing watchdogs
results: parsing output: 0/ for test: gem_fence_thrash
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: i915_pm_rps
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: i915_query
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_atomic
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: sw_sync
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_prime
results: parsing output: 25/ for test: kms_properties
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: gem_shrink
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: prime_mmap
results: parsing output: 31/ for test: gen9_exec_parse
results: parsing output: 32/ for test: prime_busy
results: parsing output: 33/ for test: kms_content_protection
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_vblank
results: parsing output: 39/ for test: kms_invalid_mode
results: parsing output: 40/ for test: gem_sync
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: gem_exec_whisper
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_async_flips
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_rmfb
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: sysfs_preempt_timeout
results: parsing output: 60/ for test: api_intel_allocator
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_properties
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: i915_pm_freq_api
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_cursor_edge_walk
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gem_exec_params
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_chamelium_edid
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: prime_mmap
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_color
results: parsing output: 88/ for test: kms_dsc
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: gem_exec_capture
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_create
results: parsing output: 93/ for test: gem_pxp
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: i915_pm_rps
results: parsing output: 97/ for test: core_getstats
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: vgem_basic
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_bad_reloc
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_pipe_b_c_ivb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_workarounds
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_plane_alpha_blend
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: core_hotunplug
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_ctx_param
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: gem_render_copy
Done.