[102.479751] Initializing watchdogs
[102.479800]   /dev/watchdog0
[102.493992] [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]
[102.498407] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[102.500566] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[102.503879] [001/133] (960s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[102.632691] Starting subtest: pipe-fbc-rte
[102.639498] Starting dynamic subtest: pipe-B-eDP-1
[108.326970] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.697s)
[108.335325] Subtest pipe-fbc-rte: SUCCESS (5.699s)
[110.610146] [002/133] (952s left) gem_exec_schedule (timeslicing)
[110.682761] Starting subtest: timeslicing
[110.685074] Starting dynamic subtest: rcs0
[110.696537] Dynamic subtest rcs0: SUCCESS (0.022s)
[110.704539] Starting dynamic subtest: bcs0
[110.720964] Dynamic subtest bcs0: SUCCESS (0.024s)
[110.728634] Starting dynamic subtest: vcs0
[110.743106] Dynamic subtest vcs0: SUCCESS (0.021s)
[110.750893] Starting dynamic subtest: vcs1
[110.764502] Dynamic subtest vcs1: SUCCESS (0.021s)
[110.772220] Starting dynamic subtest: vecs0
[110.784806] Dynamic subtest vecs0: SUCCESS (0.020s)
[110.792497] Starting dynamic subtest: ccs0
[110.805787] Dynamic subtest ccs0: SUCCESS (0.021s)
[110.808243] Subtest timeslicing: SUCCESS (0.131s)
[112.357193] [003/133] (950s left) kms_cursor_edge_walk (256x256-top-bottom)
[112.455397] Starting subtest: 256x256-top-bottom
[112.457825] Starting dynamic subtest: pipe-A-eDP-1
[115.911724] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.457s)
[115.920902] Starting dynamic subtest: pipe-D-eDP-1
[119.025335] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[119.027295] Subtest 256x256-top-bottom: SUCCESS (6.570s)
[119.844582] [004/133] (943s left) kms_cursor_crc (cursor-dpms)
[119.959060] Starting subtest: cursor-dpms
[119.961537] Starting dynamic subtest: pipe-A-eDP-1
[123.023485] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.061s)
[123.031890] Starting dynamic subtest: pipe-D-eDP-1
[126.592396] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.569s)
[126.594727] Subtest cursor-dpms: SUCCESS (6.632s)
[127.436885] [005/133] (935s left) kms_psr (fbc-pr-dpms)
[127.522210] Starting subtest: fbc-pr-dpms
[127.526685] Subtest fbc-pr-dpms: SKIP (0.000s)
[127.590955] [006/133] (935s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[127.680285] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[127.682670] Starting dynamic subtest: pipe-A-eDP-1
[127.706523] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[127.716577] Starting dynamic subtest: pipe-B-eDP-1
[127.738242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[127.746116] Starting dynamic subtest: pipe-C-eDP-1
[127.767672] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[127.777189] Starting dynamic subtest: pipe-D-eDP-1
[127.799212] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[127.803611] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[129.989080] [007/133] (933s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[130.092058] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[130.103860] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[130.204671] [008/133] (933s left) syncobj_timeline (signal-point-0)
[130.252777] Starting subtest: signal-point-0
[130.255469] Subtest signal-point-0: SUCCESS (0.000s)
[130.363876] [009/133] (932s left) gem_exec_params (invalid-flag)
[130.415571] Starting subtest: invalid-flag
[130.417585] Subtest invalid-flag: SUCCESS (0.000s)
[130.536309] [010/133] (932s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[130.625880] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[130.630062] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[130.693411] [011/133] (932s left) gem_close_race (multigpu-basic-process)
[130.759929] Starting subtest: multigpu-basic-process
[130.764560] Subtest multigpu-basic-process: SKIP (0.000s)
[130.997804] [012/133] (932s left) kms_universal_plane (universal-plane-functional)
[131.083427] Starting subtest: universal-plane-functional
[131.085833] Starting dynamic subtest: pipe-A-eDP-1
[134.960896] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.877s)
[134.969376] Starting dynamic subtest: pipe-B-eDP-1
[139.426143] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.463s)
[139.435980] Starting dynamic subtest: pipe-C-eDP-1
[143.669467] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.243s)
[143.678688] Starting dynamic subtest: pipe-D-eDP-1
[147.851847] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.182s)
[147.854239] Subtest universal-plane-functional: SUCCESS (16.769s)
[148.674240] [013/133] (914s left) perf (per-context-mode-unprivileged)
[148.795496] Starting subtest: per-context-mode-unprivileged
[148.799568] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[148.836160] [014/133] (914s left) gem_set_tiling_vs_gtt
[148.936583] [015/133] (914s left) api_intel_allocator (simple-allocator)
[148.994276] Starting subtest: simple-allocator
[148.996601] Starting dynamic subtest: basic
[148.998811] Dynamic subtest basic: SUCCESS (0.005s)
[149.014651] Starting dynamic subtest: parallel-one
[149.174383] Dynamic subtest parallel-one: SUCCESS (0.174s)
[149.182697] Starting dynamic subtest: print
[149.184680] Dynamic subtest print: SUCCESS (0.000s)
[149.192826] Starting dynamic subtest: reuse
[149.195143] Dynamic subtest reuse: SUCCESS (0.000s)
[149.202711] Starting dynamic subtest: reserve
[149.205166] Dynamic subtest reserve: SUCCESS (0.000s)
[149.212615] Starting dynamic subtest: fork-reopen-allocator
[149.214918] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[149.217224] Subtest simple-allocator: SUCCESS (0.195s)
[149.313989] [016/133] (914s left) gem_exec_parallel (contexts)
[149.374618] Starting subtest: contexts
[149.377059] Starting dynamic subtest: rcs0
[152.102972] Dynamic subtest rcs0: SUCCESS (2.726s)
[152.111997] Starting dynamic subtest: bcs0
[155.362625] Dynamic subtest bcs0: SUCCESS (3.257s)
[155.371806] Starting dynamic subtest: vcs0
[159.669111] Dynamic subtest vcs0: SUCCESS (4.304s)
[159.679139] Starting dynamic subtest: vcs1
[163.720341] Dynamic subtest vcs1: SUCCESS (4.050s)
[163.731653] Starting dynamic subtest: vecs0
[167.686967] Dynamic subtest vecs0: SUCCESS (3.964s)
[167.700976] Starting dynamic subtest: ccs0
[171.049428] Dynamic subtest ccs0: SUCCESS (3.361s)
[171.051721] Subtest contexts: SUCCESS (21.673s)
[171.234211] [017/133] (892s left) gem_tiled_swapping (non-threaded)
[171.291107] Subtest non-threaded: SKIP (0.000s)
[171.372971] [018/133] (892s left) gen9_exec_parse (allowed-all)
[171.435409] Subtest allowed-all: SKIP (0.000s)
[171.500106] [019/133] (892s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[171.600015] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[171.604660] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[172.694457] [020/133] (891s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[172.791621] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[173.836810] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.046s)
[173.968967] [021/133] (889s left) gem_vm_create (execbuf)
[174.029537] Starting subtest: execbuf
[174.036255] Subtest execbuf: SUCCESS (0.007s)
[174.162605] [022/133] (889s left) gem_mmap_wc (read)
[174.213014] Subtest read: SKIP (0.000s)
[174.269854] [023/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[174.356538] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[174.360150] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[174.449409] [024/133] (889s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[174.713324] Starting subtest: parallel-dmabuf-import-out-fence
[175.857554] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.144s)
[175.980335] [025/133] (887s left) i915_power (sanity)
[176.035405] Starting subtest: sanity
[180.098622] Subtest sanity: SUCCESS (4.055s)
[181.326971] [026/133] (882s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[181.425115] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[181.427441] Starting dynamic subtest: pipe-A-eDP-1
[181.449955] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[181.459321] Starting dynamic subtest: pipe-B-eDP-1
[181.480301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[181.488479] Starting dynamic subtest: pipe-C-eDP-1
[181.510179] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[181.518089] Starting dynamic subtest: pipe-D-eDP-1
[181.539914] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[181.544242] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[183.577396] [027/133] (880s left) kms_psr (pr-primary-page-flip)
[183.669273] Starting subtest: pr-primary-page-flip
[183.673660] Subtest pr-primary-page-flip: SKIP (0.000s)
[183.740873] [028/133] (880s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[183.797033] Starting subtest: etime-single-wait-available-unsubmitted
[183.900258] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s)
[183.981171] [029/133] (880s left) i915_drm_fdinfo (busy-hang)
[184.024114] Starting subtest: busy-hang
[184.026642] Starting dynamic subtest: rcs0
[184.051351] Dynamic subtest rcs0: SKIP (0.025s)
[184.062376] Starting dynamic subtest: bcs0
[184.066878] Dynamic subtest bcs0: SKIP (0.001s)
[184.075948] Starting dynamic subtest: vcs0
[184.080701] Dynamic subtest vcs0: SKIP (0.000s)
[184.088986] Starting dynamic subtest: vcs1
[184.093442] Dynamic subtest vcs1: SKIP (0.001s)
[184.101659] Starting dynamic subtest: vecs0
[184.106082] Dynamic subtest vecs0: SKIP (0.000s)
[184.114371] Starting dynamic subtest: ccs0
[184.118862] Dynamic subtest ccs0: SKIP (0.000s)
[184.123314] Subtest busy-hang: SKIP (0.031s)
[184.158203] [030/133] (879s left) gem_ctx_sseu (engines)
[184.211051] Subtest engines: SKIP (0.000s)
[184.268034] [031/133] (879s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[184.360989] Starting subtest: fbc-rgb565-draw-blt
[188.585567] Subtest fbc-rgb565-draw-blt: SUCCESS (4.228s)
[189.781355] [032/133] (874s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[189.874643] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[189.879508] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[189.953134] [033/133] (874s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[190.049140] Starting subtest: psr-1p-primscrn-cur-indfb-move
[197.484636] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.437s)
[197.618299] [034/133] (866s left) prime_busy (hang-wait)
[197.684965] Starting subtest: hang-wait
[197.687259] Starting dynamic subtest: rcs0
[223.780097] Dynamic subtest rcs0: SUCCESS (26.093s)
[223.790973] Starting dynamic subtest: bcs0
[230.929054] Dynamic subtest bcs0: SUCCESS (7.145s)
[230.944810] Starting dynamic subtest: vcs0
[237.896901] Dynamic subtest vcs0: SUCCESS (6.969s)
[237.908139] Starting dynamic subtest: vcs1
[244.943376] Dynamic subtest vcs1: SUCCESS (7.045s)
[244.954604] Starting dynamic subtest: vecs0
[251.914788] Dynamic subtest vecs0: SUCCESS (6.967s)
[251.923287] Starting dynamic subtest: ccs0
[265.752617] Dynamic subtest ccs0: SUCCESS (13.839s)
[265.754881] Subtest hang-wait: SUCCESS (68.070s)
[265.889949] [035/133] (798s left) syncobj_wait (invalid-reset-zero-handles)
[265.943685] Starting subtest: invalid-reset-zero-handles
[265.945958] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[266.048844] [036/133] (798s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[266.159368] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[273.237446] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.081s)
[273.382280] [037/133] (790s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[273.486569] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[273.490603] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[273.590447] [038/133] (790s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[273.646146] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[273.650621] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[273.826297] [039/133] (790s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[273.885107] Starting subtest: invalid-bsd2-flag-on-blt
[273.887061] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[273.996147] [040/133] (790s left) gem_userptr_blits (readonly-unsync)
[274.049897] Subtest readonly-unsync: SKIP (0.000s)
[274.174036] [041/133] (790s left) drm_read (empty-nonblock)
[274.305308] Starting subtest: empty-nonblock
[274.307812] Subtest empty-nonblock: SUCCESS (0.000s)
[274.429909] [042/133] (790s left) kms_chamelium_frames (hdmi-aspect-ratio)
[274.833154] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[275.627096] [043/133] (788s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[275.724619] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[275.726771] Starting dynamic subtest: pipe-A
[276.061146] Dynamic subtest pipe-A: SUCCESS (0.339s)
[276.070651] Starting dynamic subtest: pipe-B
[277.453814] Dynamic subtest pipe-B: SUCCESS (1.391s)
[277.464475] Starting dynamic subtest: pipe-C
[278.894133] Dynamic subtest pipe-C: SUCCESS (1.440s)
[278.906671] Starting dynamic subtest: pipe-D
[280.314261] Dynamic subtest pipe-D: SUCCESS (1.419s)
[280.316616] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.594s)
[281.474732] [044/133] (783s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[281.573300] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[281.577664] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[281.670715] [045/133] (782s left) kms_getfb (getfb-handle-not-fb)
[281.766922] Starting subtest: getfb-handle-not-fb
[281.769258] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[281.862359] [046/133] (782s left) gem_exec_balancer (bonded-true-hang)
[282.150540] Starting subtest: bonded-true-hang
[282.159794] Subtest bonded-true-hang: SKIP (0.000s)
[282.222484] [047/133] (782s left) gem_mmap_wc (bad-object)
[282.277067] Subtest bad-object: SKIP (0.000s)
[282.331144] [048/133] (782s left) gem_partial_pwrite_pread (reads-display)
[282.385589] Subtest reads-display: SKIP (0.000s)
[282.468779] [049/133] (782s left) kms_tv_load_detect (load-detect)
[282.519253] Subtest load-detect: SKIP (0.000s)
[282.582284] [050/133] (782s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[282.679154] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[282.683228] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[282.759907] [051/133] (782s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[282.857280] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[287.005815] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.152s)
[288.200093] [052/133] (776s left) gem_softpin (allocator-nopin-reserve)
[288.256905] Starting subtest: allocator-nopin-reserve
[288.370505] Subtest allocator-nopin-reserve: SUCCESS (0.112s)
[288.496434] [053/133] (776s left) kms_lease (lease-invalid-connector)
[288.590050] Starting subtest: lease-invalid-connector
[288.592665] Starting dynamic subtest: pipe-A-eDP-1
[288.595104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[288.604811] Starting dynamic subtest: pipe-B-eDP-1
[288.606797] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[288.615705] Starting dynamic subtest: pipe-C-eDP-1
[288.618025] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[288.626793] Starting dynamic subtest: pipe-D-eDP-1
[288.629064] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[288.631304] Subtest lease-invalid-connector: SUCCESS (0.004s)
[288.669405] [054/133] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[288.756818] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[288.761105] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[288.847814] [055/133] (776s left) gem_exec_params (no-vebox)
[288.898579] Starting subtest: no-vebox
[288.900988] Subtest no-vebox: SUCCESS (0.002s)
[290.379119] [056/133] (774s left) gem_eio (in-flight-contexts-10ms)
[290.557358] Starting subtest: in-flight-contexts-10ms
[304.350077] Subtest in-flight-contexts-10ms: SUCCESS (13.794s)
[304.482497] [057/133] (760s left) kms_vblank (ts-continuation-dpms-suspend)
[304.574225] Starting subtest: ts-continuation-dpms-suspend
[304.576066] Starting dynamic subtest: pipe-A-eDP-1
[322.128767] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.055s)
[322.143496] Starting dynamic subtest: pipe-D-eDP-1
[340.082575] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.460s)
[340.085455] Subtest ts-continuation-dpms-suspend: SUCCESS (4.518s)
[340.891157] [058/133] (724s left) kms_rmfb (close-fd)
[340.993426] Starting subtest: close-fd
[340.995752] Starting dynamic subtest: pipe-A-eDP-1
[341.100347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[341.111573] Starting dynamic subtest: pipe-B-eDP-1
[342.249014] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[342.259521] Starting dynamic subtest: pipe-C-eDP-1
[343.379585] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[343.389233] Starting dynamic subtest: pipe-D-eDP-1
[344.516615] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[344.518950] Subtest close-fd: SUCCESS (3.522s)
[345.725212] [059/133] (719s left) gem_mmap_gtt (basic-short)
[345.775332] Subtest basic-short: SKIP (0.000s)
[345.844279] [060/133] (719s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[345.930971] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[345.933262] Starting dynamic subtest: pipe-A-eDP-1
[345.954199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[345.966354] Starting dynamic subtest: pipe-B-eDP-1
[345.986046] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[345.995566] Starting dynamic subtest: pipe-C-eDP-1
[346.015368] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[346.024670] Starting dynamic subtest: pipe-D-eDP-1
[346.047500] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[346.049760] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[348.104070] [061/133] (717s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[348.208631] Starting subtest: yf-tiled-64bpp-rotate-180
[348.213059] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[348.325136] [062/133] (717s left) perf (enable-disable)
[348.410497] Starting subtest: enable-disable
[348.413451] Starting dynamic subtest: 0-rcs0
[350.666567] Dynamic subtest 0-rcs0: SUCCESS (2.253s)
[350.678399] Starting dynamic subtest: 1-vcs0
[355.145019] Dynamic subtest 1-vcs0: SUCCESS (4.476s)
[355.147828] Subtest enable-disable: SUCCESS (6.731s)
[355.194183] [063/133] (710s left) kms_plane_scaling (planes-scaler-unity-scaling)
[355.294775] Starting subtest: planes-scaler-unity-scaling
[355.297058] Starting dynamic subtest: pipe-A
[355.357795] Dynamic subtest pipe-A: SUCCESS (0.065s)
[355.370087] Starting dynamic subtest: pipe-B
[356.522517] Dynamic subtest pipe-B: SUCCESS (1.163s)
[356.534792] Starting dynamic subtest: pipe-C
[357.651168] Dynamic subtest pipe-C: SUCCESS (1.127s)
[357.663360] Starting dynamic subtest: pipe-D
[358.779583] Dynamic subtest pipe-D: SUCCESS (1.127s)
[358.781929] Subtest planes-scaler-unity-scaling: SUCCESS (3.487s)
[359.958220] [064/133] (705s left) kms_cursor_legacy (torture-bo)
[360.081294] Starting subtest: torture-bo
[360.083232] Starting dynamic subtest: pipe-A
[365.753782] Dynamic subtest pipe-A: SUCCESS (5.667s)
[365.771926] Starting dynamic subtest: pipe-B
[373.170224] Dynamic subtest pipe-B: SUCCESS (7.415s)
[373.180450] Starting dynamic subtest: pipe-C
[380.657472] Dynamic subtest pipe-C: SUCCESS (7.482s)
[380.669400] Starting dynamic subtest: pipe-D
[387.262772] Dynamic subtest pipe-D: SUCCESS (6.604s)
[387.276359] Starting dynamic subtest: all-pipes
[394.588492] Dynamic subtest all-pipes: SUCCESS (7.321s)
[394.591190] Subtest torture-bo: SUCCESS (34.500s)
[394.745599] [065/133] (670s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[394.845589] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[394.858382] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.013s)
[394.945096] [066/133] (670s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[395.035740] Starting subtest: fbc-psr2-sprite-mmap-gtt
[395.038089] Starting dynamic subtest: eDP-1
[395.042365] Dynamic subtest eDP-1: SKIP (0.000s)
[395.046788] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[395.107177] [067/133] (670s left) i915_pm_freq_api (freq-reset)
[395.157432] Starting subtest: freq-reset
[395.159927] Starting dynamic subtest: gt0
[395.338623] Dynamic subtest gt0: SUCCESS (0.180s)
[395.349120] Starting dynamic subtest: gt1
[395.504449] Dynamic subtest gt1: SUCCESS (0.164s)
[395.507490] Subtest freq-reset: SUCCESS (0.346s)
[395.593504] [068/133] (670s left) gem_exec_fence (syncobj-unused-fence)
[396.070639] Starting subtest: syncobj-unused-fence
[396.076923] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[397.331586] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[397.335181] [069/133] (668s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[397.433416] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[397.437839] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[397.547378] [070/133] (668s left) kms_psr (fbc-pr-primary-render)
[397.645461] Starting subtest: fbc-pr-primary-render
[397.649835] Subtest fbc-pr-primary-render: SKIP (0.000s)
[397.729032] [071/133] (667s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[397.831215] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[398.888424] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.057s)
[399.011483] [072/133] (666s left) syncobj_timeline (wait-any-snapshot)
[399.074860] Starting subtest: wait-any-snapshot
[399.154922] Subtest wait-any-snapshot: SUCCESS (0.082s)
[399.234292] [073/133] (666s left) gem_exec_flush (basic-wb-prw-default)
[399.291247] Starting subtest: basic-wb-prw-default
[404.752556] Subtest basic-wb-prw-default: SUCCESS (5.460s)
[404.947055] [074/133] (660s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[405.032776] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[405.035066] Starting dynamic subtest: pipe-A-eDP-1
[405.060417] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[405.072332] Starting dynamic subtest: pipe-B-eDP-1
[405.096374] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[405.105874] Starting dynamic subtest: pipe-C-eDP-1
[405.129887] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[405.139371] Starting dynamic subtest: pipe-D-eDP-1
[405.163550] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[405.168461] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[407.238863] [075/133] (658s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[407.333201] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[407.337457] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[407.429709] [076/133] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[407.524257] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[407.528454] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[407.615532] [077/133] (658s left) kms_color (invalid-gamma-lut-sizes)
[407.698579] Starting subtest: invalid-gamma-lut-sizes
[407.700818] Starting dynamic subtest: pipe-A
[407.987877] Dynamic subtest pipe-A: SUCCESS (0.287s)
[407.998741] Starting dynamic subtest: pipe-B
[408.001398] Dynamic subtest pipe-B: SUCCESS (0.000s)
[408.011777] Starting dynamic subtest: pipe-C
[408.014465] Dynamic subtest pipe-C: SUCCESS (0.000s)
[408.024341] Starting dynamic subtest: pipe-D
[408.026356] Dynamic subtest pipe-D: SUCCESS (0.000s)
[408.028344] Subtest invalid-gamma-lut-sizes: SUCCESS (0.290s)
[408.782440] [078/133] (657s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[408.884752] Starting subtest: x-tiled-8bpp-rotate-90
[408.906935] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[409.013624] [079/133] (657s left) syncobj_timeline (reset-during-wait-for-submit)
[409.072417] Starting subtest: reset-during-wait-for-submit
[409.176880] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[409.258306] [080/133] (656s left) vgem_basic (setversion)
[409.304512] Starting subtest: setversion
[409.308567] Subtest setversion: SUCCESS (0.000s)
[409.363779] [081/133] (656s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[409.490312] Starting subtest: cursorA-vs-flipB-legacy
[409.495198] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[409.668542] [082/133] (656s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[409.822516] Starting subtest: cursor-rapid-movement-32x32
[409.879322] Subtest cursor-rapid-movement-32x32: SKIP (0.050s)
[410.176600] [083/133] (656s left) template (a)
[410.225213] Starting subtest: A
[410.227309] Subtest A: SUCCESS (0.000s)
[410.322257] [084/133] (655s left) syncobj_eventfd (invalid-illegal-eventfd)
[410.376680] Starting subtest: invalid-illegal-eventfd
[410.378366] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[410.474653] [085/133] (655s left) gem_mmap_offset (partial-remap)
[410.522078] Starting subtest: partial-remap
[410.523771] Starting dynamic subtest: smem0
[410.531183] Dynamic subtest smem0: SUCCESS (0.004s)
[410.533003] Subtest partial-remap: SUCCESS (0.004s)
[410.646494] [086/133] (655s left) gem_ctx_param (invalid-get-engines)
[410.704260] Starting subtest: invalid-get-engines
[410.706180] Subtest invalid-get-engines: SUCCESS (0.001s)
[410.823651] [087/133] (655s left) gem_exec_fence (syncobj-timeline-signal)
[411.354735] Starting subtest: syncobj-timeline-signal
[411.361558] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[412.395827] [088/133] (654s left) gem_ctx_persistence (legacy-engines-mixed)
[412.458510] Starting subtest: legacy-engines-mixed
[412.460950] Starting dynamic subtest: render
[412.542519] Dynamic subtest render: SUCCESS (0.083s)
[412.556336] Starting dynamic subtest: bsd1
[412.597991] Dynamic subtest bsd1: SUCCESS (0.055s)
[412.613083] Starting dynamic subtest: bsd2
[412.670776] Dynamic subtest bsd2: SUCCESS (0.069s)
[412.682784] Starting dynamic subtest: blt
[412.733763] Dynamic subtest blt: SUCCESS (0.060s)
[412.746763] Starting dynamic subtest: vebox
[412.791383] Dynamic subtest vebox: SUCCESS (0.055s)
[412.793789] Subtest legacy-engines-mixed: SUCCESS (0.334s)
[412.891358] [089/133] (653s left) kms_force_connector_basic (prune-stale-modes)
[412.965799] Starting subtest: prune-stale-modes
[413.412296] Subtest prune-stale-modes: SUCCESS (0.449s)
[413.550457] [090/133] (652s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[413.640152] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[413.643559] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[413.716446] [091/133] (652s left) kms_cursor_crc (cursor-alpha-opaque)
[413.808380] Starting subtest: cursor-alpha-opaque
[413.810340] Starting dynamic subtest: pipe-A-eDP-1
[414.440514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[414.451766] Starting dynamic subtest: pipe-D-eDP-1
[415.773758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[415.775595] Subtest cursor-alpha-opaque: SUCCESS (1.964s)
[416.624582] [092/133] (649s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[416.726459] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[416.731046] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[416.827857] [093/133] (649s left) gem_exec_schedule (manyslice)
[416.905191] Starting subtest: manyslice
[416.907455] Starting dynamic subtest: rcs0
[422.042494] Dynamic subtest rcs0: SUCCESS (5.142s)
[422.059265] Starting dynamic subtest: bcs0
[428.684347] Dynamic subtest bcs0: SUCCESS (6.639s)
[428.696842] Starting dynamic subtest: vcs0
[435.287175] Dynamic subtest vcs0: SUCCESS (6.599s)
[435.306567] Starting dynamic subtest: vcs1
[441.369612] Dynamic subtest vcs1: SUCCESS (6.080s)
[441.385326] Starting dynamic subtest: vecs0
[446.950984] Dynamic subtest vecs0: SUCCESS (5.578s)
[446.962730] Starting dynamic subtest: ccs0
[453.646647] Dynamic subtest ccs0: SUCCESS (6.691s)
[453.649385] Subtest manyslice: SUCCESS (36.742s)
[453.945201] [094/133] (612s left) syncobj_timeline (invalid-wait-illegal-handle)
[454.003378] Starting subtest: invalid-wait-illegal-handle
[454.005704] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[454.099321] [095/133] (612s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[454.192847] Starting subtest: basic-modeset-with-all-modifiers-formats
[454.563678] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[455.359583] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.798s)
[455.370230] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[455.381832] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[455.392879] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[455.404006] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[455.418358] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[455.558863] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.154s)
[455.569470] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[455.580860] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[455.590762] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[455.603582] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[455.613508] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[455.625286] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[455.635324] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[455.647769] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[455.657506] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[455.669944] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[455.679734] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[455.692309] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[455.702195] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[455.714475] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[455.724200] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[455.737404] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[455.747631] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[455.881176] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[455.891937] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[455.903316] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[455.913294] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[455.925724] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[455.936614] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[455.948316] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[455.958165] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[455.970125] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[455.981909] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[455.992080] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[456.001975] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[456.015383] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[456.025131] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[456.036668] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[456.046727] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[456.058955] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[456.068943] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[456.215294] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[456.227092] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[456.236828] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[456.247031] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[456.259493] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[456.269392] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[456.281669] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[456.291490] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[456.304420] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[456.317062] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[456.326064] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[456.335918] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[456.348019] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[456.357435] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[456.370344] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[456.379750] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[456.392198] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[456.787074] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.594s)
[457.621092] [096/133] (609s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[457.723770] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[457.728082] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[457.823923] [097/133] (608s left) gem_sync (basic-all)
[457.889885] Starting subtest: basic-all
[461.261786] Subtest basic-all: SUCCESS (3.381s)
[461.464443] [098/133] (605s left) kms_prop_blob (blob-prop-core)
[461.517709] Starting subtest: blob-prop-core
[461.519621] Subtest blob-prop-core: SUCCESS (0.000s)
[461.630963] [099/133] (605s left) kms_pm_rpm (cursor-dpms)
[463.460919] Starting subtest: cursor-dpms
[463.466498] Subtest cursor-dpms: SKIP (0.000s)
[463.934852] [100/133] (603s left) kms_dsc (dsc-fractional-bpp)
[464.021456] Starting subtest: dsc-fractional-bpp
[464.034950] Subtest dsc-fractional-bpp: SKIP (0.000s)
[464.111136] [101/133] (602s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[464.211306] Starting subtest: flip-vs-dpms-on-nop-interruptible
[464.213652] Starting dynamic subtest: A-eDP1
[466.075822] Dynamic subtest A-eDP1: SUCCESS (1.863s)
[466.088933] Starting dynamic subtest: B-eDP1
[467.875697] Dynamic subtest B-eDP1: SUCCESS (1.797s)
[467.886895] Starting dynamic subtest: C-eDP1
[469.654816] Dynamic subtest C-eDP1: SUCCESS (1.777s)
[469.665590] Starting dynamic subtest: D-eDP1
[471.472433] Dynamic subtest D-eDP1: SUCCESS (1.817s)
[471.477888] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.264s)
[472.634870] [102/133] (594s left) core_debugfs (read-all-entries)
[472.688897] Starting subtest: read-all-entries
[472.784179] Subtest read-all-entries: SUCCESS (0.096s)
[472.849818] [103/133] (594s left) gem_mmap_wc (set-cache-level)
[472.899983] Subtest set-cache-level: SKIP (0.000s)
[472.964017] [104/133] (594s left) kms_atomic (plane-invalid-params-fence)
[473.058850] Starting subtest: plane-invalid-params-fence
[473.061152] Starting dynamic subtest: pipe-A-eDP-1
[473.414899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[473.417194] Subtest plane-invalid-params-fence: SUCCESS (0.355s)
[474.206058] [105/133] (592s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[474.588391] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[475.388919] [106/133] (591s left) kms_big_fb (linear-64bpp-rotate-270)
[475.504931] Starting subtest: linear-64bpp-rotate-270
[475.526738] Subtest linear-64bpp-rotate-270: SKIP (0.021s)
[475.652358] [107/133] (591s left) kms_properties (get_properties-sanity-non-atomic)
[475.745832] Starting subtest: get_properties-sanity-non-atomic
[475.748094] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[475.823612] [108/133] (591s left) syncobj_basic (bad-fd-to-handle)
[475.877373] Starting subtest: bad-fd-to-handle
[475.879718] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[475.969522] [109/133] (591s left) kms_flip (2x-flip-vs-panning-interruptible)
[476.069656] Starting subtest: 2x-flip-vs-panning-interruptible
[476.081251] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[476.174480] [110/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[476.264013] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[476.268479] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[476.366934] [111/133] (591s left) kms_pm_rpm (modeset-non-lpsp-stress)
[478.493199] Starting subtest: modeset-non-lpsp-stress
[479.636910] Subtest modeset-non-lpsp-stress: SKIP (1.146s)
[480.005867] [112/133] (587s left) gem_mmap_gtt (bad-object)
[480.069065] Subtest bad-object: SKIP (0.000s)
[480.136362] [113/133] (587s left) gem_exec_whisper (basic-sync-all)
[480.199970] Starting subtest: basic-sync-all
[486.989412] Subtest basic-sync-all: SUCCESS (6.785s)
[487.177061] [114/133] (580s left) gem_partial_pwrite_pread (writes-after-reads)
[487.238239] Subtest writes-after-reads: SKIP (0.000s)
[487.308732] [115/133] (580s left) gem_exec_whisper (basic-fds-priority-all)
[487.364739] Starting subtest: basic-fds-priority-all
[511.304911] Subtest basic-fds-priority-all: SUCCESS (23.936s)
[511.496188] [116/133] (556s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[511.590654] Starting subtest: multiplane-rotation-cropping-top
[529.129034] Subtest multiplane-rotation-cropping-top: SUCCESS (17.537s)
[529.268122] [117/133] (538s left) core_setmaster (master-drop-set-user)
[529.362231] Starting subtest: master-drop-set-user
[529.376001] Subtest master-drop-set-user: SUCCESS (0.014s)
[529.413987] [118/133] (538s left) gem_userptr_blits (sync-unmap-after-close)
[529.469876] Starting subtest: sync-unmap-after-close
[529.482596] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[529.614039] [119/133] (538s left) perf (blocking-parameterized)
[529.701033] Starting subtest: blocking-parameterized
[549.722042] Subtest blocking-parameterized: SUCCESS (20.018s)
[549.772846] [120/133] (518s left) perf_pmu (most-busy-check-all)
[549.807857] Starting subtest: most-busy-check-all
[549.809951] Starting dynamic subtest: rcs0
[551.309629] Dynamic subtest rcs0: SUCCESS (1.502s)
[551.326726] Starting dynamic subtest: bcs0
[553.230452] Dynamic subtest bcs0: SUCCESS (1.917s)
[553.244654] Starting dynamic subtest: vcs0
[555.277378] Dynamic subtest vcs0: SUCCESS (2.044s)
[555.292066] Starting dynamic subtest: vcs1
[557.262284] Dynamic subtest vcs1: SUCCESS (1.981s)
[557.276234] Starting dynamic subtest: vecs0
[559.310249] Dynamic subtest vecs0: SUCCESS (2.045s)
[559.324674] Starting dynamic subtest: ccs0
[561.229430] Dynamic subtest ccs0: SUCCESS (1.915s)
[561.232445] Subtest most-busy-check-all: SUCCESS (11.422s)
[561.353328] [121/133] (506s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[561.483977] Starting subtest: short-flip-before-cursor-atomic-transitions
[562.447183] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.963s)
[563.315501] [122/133] (504s left) perf (gen8-unprivileged-single-ctx-counters)
[563.396202] Starting subtest: gen8-unprivileged-single-ctx-counters
[563.400973] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[563.448016] [123/133] (504s left) kms_plane_alpha_blend (constant-alpha-mid)
[563.535752] Starting subtest: constant-alpha-mid
[563.816283] Starting dynamic subtest: pipe-A-eDP-1
[564.702389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.885s)
[564.714454] Starting dynamic subtest: pipe-D-eDP-1
[566.198967] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.496s)
[566.201481] Subtest constant-alpha-mid: SUCCESS (2.666s)
[567.032253] [124/133] (500s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[567.118911] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[567.127497] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[567.216818] [125/133] (500s left) kms_joiner (invalid-modeset-force-big-joiner)
[567.316486] Starting subtest: invalid-modeset-force-big-joiner
[567.320664] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[567.383052] [126/133] (500s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[567.474498] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[574.432765] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.961s)
[574.572314] [127/133] (493s left) i915_pm_rps (thresholds)
[574.639231] Starting subtest: thresholds
[574.643771] Subtest thresholds: SKIP (0.001s)
[574.742723] [128/133] (493s left) kms_flip (basic-plain-flip)
[574.833265] Starting subtest: basic-plain-flip
[574.835654] Starting dynamic subtest: A-eDP1
[576.492028] Dynamic subtest A-eDP1: SUCCESS (1.661s)
[576.505216] Starting dynamic subtest: B-eDP1
[578.190964] Dynamic subtest B-eDP1: SUCCESS (1.698s)
[578.203507] Starting dynamic subtest: C-eDP1
[579.884096] Dynamic subtest C-eDP1: SUCCESS (1.692s)
[579.898145] Starting dynamic subtest: D-eDP1
[581.576330] Dynamic subtest D-eDP1: SUCCESS (1.691s)
[581.578778] Subtest basic-plain-flip: SUCCESS (6.751s)
[582.815976] [129/133] (485s left) gem_exec_flush (basic-batch-kernel-default-uc)
[582.877836] Starting subtest: basic-batch-kernel-default-uc
[589.994314] Subtest basic-batch-kernel-default-uc: SUCCESS (7.118s)
[590.184664] [130/133] (478s left) kms_psr (psr2-sprite-render)
[590.297213] Starting subtest: psr2-sprite-render
[590.300103] Starting dynamic subtest: eDP-1
[591.977370] Dynamic subtest eDP-1: SUCCESS (1.681s)
[591.979812] Subtest psr2-sprite-render: SUCCESS (1.682s)
[592.799061] [131/133] (475s left) gem_pxp (regular-baseline-src-copy-readible)
[592.915450] Starting subtest: regular-baseline-src-copy-readible
[592.978416] Subtest regular-baseline-src-copy-readible: SUCCESS (0.065s)
[593.117544] [132/133] (475s left) fbdev (read)
[593.163189] Starting subtest: read
[593.689490] Subtest read: SUCCESS (0.524s)
[593.754436] [133/133] (474s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[593.854498] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[593.858865] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[593.957488] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_close_race
results: parsing output: 11/ for test: kms_universal_plane
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: gem_set_tiling_vs_gtt
results: parsing output: 14/ for test: api_intel_allocator
results: parsing output: 15/ for test: gem_exec_parallel
results: parsing output: 16/ for test: gem_tiled_swapping
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_vm_create
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: i915_power
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: gem_ctx_sseu
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: prime_busy
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: drm_read
results: parsing output: 41/ for test: kms_chamelium_frames
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_getfb
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: gem_partial_pwrite_pread
results: parsing output: 48/ for test: kms_tv_load_detect
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_rmfb
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: i915_pm_freq_api
results: parsing output: 67/ for test: gem_exec_fence
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_exec_flush
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_color
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: template
results: parsing output: 83/ for test: syncobj_eventfd
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: gem_ctx_param
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: kms_force_connector_basic
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_sync
results: parsing output: 97/ for test: kms_prop_blob
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_dsc
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: core_debugfs
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: kms_atomic
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_properties
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_pm_rpm
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: core_setmaster
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: kms_plane_alpha_blend
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_joiner
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: i915_pm_rps
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: fbdev
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.