[60.498422] Initializing watchdogs
[60.498465]   /dev/watchdog0
[60.512721] [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]
[60.517310] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.519741] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.523133] [001/131] (960s left) fbdev (unaligned-read)
[60.583451] Starting subtest: unaligned-read
[60.598454] Subtest unaligned-read: SUCCESS (0.014s)
[60.675391] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[60.742092] Starting subtest: dirty-switch
[60.744407] Starting dynamic subtest: rcs0
[60.976587] Dynamic subtest rcs0: SUCCESS (0.237s)
[60.987208] Starting dynamic subtest: bcs0
[61.251484] Dynamic subtest bcs0: SUCCESS (0.274s)
[61.261587] Starting dynamic subtest: vcs0
[61.518565] Dynamic subtest vcs0: SUCCESS (0.267s)
[61.525381] Starting dynamic subtest: vcs1
[63.152176] Dynamic subtest vcs1: SUCCESS (1.632s)
[63.161781] Starting dynamic subtest: vecs0
[65.111929] Dynamic subtest vecs0: SUCCESS (1.960s)
[65.122585] Starting dynamic subtest: ccs0
[67.636407] Dynamic subtest ccs0: SUCCESS (2.524s)
[67.638845] Subtest dirty-switch: SUCCESS (6.897s)
[68.050865] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[68.164191] Starting subtest: psr-modesetfrombusy
[74.277068] Subtest psr-modesetfrombusy: SUCCESS (6.117s)
[74.481028] [004/131] (946s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[74.581286] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[74.583292] Starting dynamic subtest: pipe-A-default-mode
[77.290068] Dynamic subtest pipe-A-default-mode: SUCCESS (2.708s)
[77.292524] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.709s)
[78.180616] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[78.242618] Starting subtest: sol-reset-invalid
[78.244942] Subtest sol-reset-invalid: SUCCESS (0.002s)
[80.010491] [006/131] (941s left) gem_spin_batch (resubmit-new)
[80.083343] Starting subtest: resubmit-new
[80.085426] Starting dynamic subtest: rcs0
[80.097819] Dynamic subtest rcs0: SUCCESS (0.014s)
[80.105301] Starting dynamic subtest: bcs0
[80.107685] Dynamic subtest bcs0: SUCCESS (0.004s)
[80.115137] Starting dynamic subtest: vcs0
[80.117446] Dynamic subtest vcs0: SUCCESS (0.005s)
[80.124952] Starting dynamic subtest: vcs1
[80.127256] Dynamic subtest vcs1: SUCCESS (0.004s)
[80.133930] Starting dynamic subtest: vecs0
[80.136193] Dynamic subtest vecs0: SUCCESS (0.005s)
[80.142950] Starting dynamic subtest: ccs0
[80.145187] Dynamic subtest ccs0: SUCCESS (0.004s)
[80.147350] Subtest resubmit-new: SUCCESS (0.037s)
[81.937978] [007/131] (939s left) gem_exec_schedule (preempt-user)
[82.012958] Starting subtest: preempt-user
[82.015066] Starting dynamic subtest: rcs0
[82.054912] Dynamic subtest rcs0: SUCCESS (0.048s)
[82.065155] Starting dynamic subtest: bcs0
[82.084866] Dynamic subtest bcs0: SUCCESS (0.030s)
[82.092583] Starting dynamic subtest: vcs0
[82.110063] Dynamic subtest vcs0: SUCCESS (0.025s)
[82.117416] Starting dynamic subtest: vcs1
[82.138845] Dynamic subtest vcs1: SUCCESS (0.029s)
[82.149501] Starting dynamic subtest: vecs0
[82.165785] Dynamic subtest vecs0: SUCCESS (0.026s)
[82.176101] Starting dynamic subtest: ccs0
[82.197347] Dynamic subtest ccs0: SUCCESS (0.031s)
[82.199596] Subtest preempt-user: SUCCESS (0.191s)
[84.043198] [008/131] (937s left) sysfs_heartbeat_interval (nopreempt)
[84.107607] Starting subtest: nopreempt
[84.109888] Starting dynamic subtest: vecs0
[93.934106] Dynamic subtest vecs0: SUCCESS (9.823s)
[93.947212] Starting dynamic subtest: ccs0
[97.991048] Dynamic subtest ccs0: SUCCESS (4.057s)
[98.001523] Starting dynamic subtest: vcs0
[106.920915] Dynamic subtest vcs0: SUCCESS (8.927s)
[106.931669] Starting dynamic subtest: bcs0
[110.907628] Dynamic subtest bcs0: SUCCESS (3.987s)
[110.918062] Starting dynamic subtest: rcs0
[114.982514] Dynamic subtest rcs0: SUCCESS (4.074s)
[114.992645] Starting dynamic subtest: vcs1
[124.906495] Dynamic subtest vcs1: SUCCESS (9.923s)
[124.909049] Subtest nopreempt: SUCCESS (40.798s)
[125.007628] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[125.119189] Starting subtest: zero-hdisplay
[125.121497] Starting dynamic subtest: pipe-A-eDP-1
[125.417915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[125.427418] Starting dynamic subtest: pipe-B-eDP-1
[125.429610] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[125.437113] Starting dynamic subtest: pipe-C-eDP-1
[125.439289] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[125.446634] Starting dynamic subtest: pipe-D-eDP-1
[125.448505] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[125.450381] Subtest zero-hdisplay: SUCCESS (0.313s)
[126.309090] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[126.405569] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[126.409964] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[126.530622] [011/131] (894s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[126.631948] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[127.533517] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.903s)
[127.765157] [012/131] (893s left) kms_getfb (getfb-handle-zero)
[127.858903] Starting subtest: getfb-handle-zero
[127.861235] Subtest getfb-handle-zero: SUCCESS (0.000s)
[128.001588] [013/131] (893s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[128.068748] Starting subtest: yf-tiled-ccs-to-yf-tiled
[128.073097] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[128.274203] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[128.372288] Starting subtest: multiplane-rotation-cropping-bottom
[135.598536] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.228s)
[135.757482] [015/131] (885s left) gem_eio (wait-1us)
[136.000345] Starting subtest: wait-1us
[136.352700] Subtest wait-1us: SUCCESS (0.354s)
[136.492926] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[136.540675] Starting subtest: multi-wait-for-submit-signaled
[136.542636] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[136.651597] [017/131] (884s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[136.754395] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[136.756212] Starting dynamic subtest: pipe-A-default-mode
[137.045414] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[137.050055] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.291s)
[137.945303] [018/131] (883s left) kms_plane_alpha_blend (alpha-7efc)
[138.052141] Starting subtest: alpha-7efc
[138.330873] Starting dynamic subtest: pipe-A-eDP-1
[138.940771] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[138.976579] Starting dynamic subtest: pipe-D-eDP-1
[140.237861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.269s)
[140.240244] Subtest alpha-7efc: SUCCESS (2.188s)
[141.111651] [019/131] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[141.221195] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[141.225105] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[141.358506] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[141.452162] Starting subtest: fbc-psr2-primary-mmap-cpu
[141.454518] Starting dynamic subtest: eDP-1
[141.458417] Dynamic subtest eDP-1: SKIP (0.000s)
[141.462650] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[141.544693] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[141.638619] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[141.647821] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[141.750854] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[141.822100] Starting subtest: basic-normal-all
[144.312037] Subtest basic-normal-all: SUCCESS (2.492s)
[144.530136] [023/131] (877s left) kms_big_fb (linear-16bpp-rotate-180)
[144.645588] Starting subtest: linear-16bpp-rotate-180
[146.079211] Subtest linear-16bpp-rotate-180: SUCCESS (1.434s)
[146.243312] [024/131] (875s left) kms_frontbuffer_tracking (psr-slowdraw)
[146.344422] Starting subtest: psr-slowdraw
[171.548866] Subtest psr-slowdraw: SUCCESS (25.204s)
[171.704053] [025/131] (850s left) vgem_basic (dmabuf-fence)
[171.813866] Starting subtest: dmabuf-fence
[171.816263] Subtest dmabuf-fence: SUCCESS (0.002s)
[171.896239] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[171.899507] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[171.954344] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[171.956668] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[172.089956] [027/131] (849s left) kms_psr (pr-primary-render)
[172.174212] Starting subtest: pr-primary-render
[172.178667] Subtest pr-primary-render: SKIP (0.000s)
[172.267964] [028/131] (849s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[172.367197] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[172.369060] Starting dynamic subtest: pipe-A-eDP-1
[172.388634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[172.398093] Starting dynamic subtest: pipe-B-eDP-1
[172.416307] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[172.423570] Starting dynamic subtest: pipe-C-eDP-1
[172.442214] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[172.449518] Starting dynamic subtest: pipe-D-eDP-1
[172.467781] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[172.471444] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[174.665276] [029/131] (847s left) core_auth (getclient-master-drop)
[174.707349] Starting subtest: getclient-master-drop
[174.736387] Subtest getclient-master-drop: SUCCESS (0.031s)
[174.875291] [030/131] (847s left) kms_plane_scaling (planes-downscale-factor-0-5)
[174.966996] Starting subtest: planes-downscale-factor-0-5
[174.969333] Starting dynamic subtest: pipe-A
[174.986485] Dynamic subtest pipe-A: SKIP (0.017s)
[174.994669] Starting dynamic subtest: pipe-B
[175.023234] Dynamic subtest pipe-B: SKIP (0.034s)
[175.032490] Starting dynamic subtest: pipe-C
[175.057893] Dynamic subtest pipe-C: SKIP (0.034s)
[175.066050] Starting dynamic subtest: pipe-D
[175.086479] Dynamic subtest pipe-D: SKIP (0.030s)
[175.090871] Subtest planes-downscale-factor-0-5: SKIP (0.116s)
[175.197651] [031/131] (846s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[175.290145] Starting subtest: fb-8bpc-vs-panel-8bpc
[175.292451] Starting dynamic subtest: pipe-A-eDP-1
[176.734483] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.443s)
[176.736699] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.444s)
[177.625353] [032/131] (844s left) gem_partial_pwrite_pread (reads-snoop)
[177.697060] Subtest reads-snoop: SKIP (0.000s)
[177.775885] [033/131] (844s left) gem_eio (in-flight-contexts-immediate)
[178.007639] Starting subtest: in-flight-contexts-immediate
[191.921566] Subtest in-flight-contexts-immediate: SUCCESS (13.914s)
[192.126650] [034/131] (830s left) gen3_render_mixed_blits
[192.248204] [035/131] (830s left) kms_pm_rpm (pm-tiling)
[193.988804] Starting subtest: pm-tiling
[193.993256] Subtest pm-tiling: SKIP (0.000s)
[194.553618] [036/131] (827s left) i915_module_load (reload-no-display)
[194.586917] Starting subtest: reload-no-display
[200.811961] Subtest reload-no-display: SUCCESS (6.225s)
[200.839540] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[200.840242] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[200.843258] [037/131] (821s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[202.436335] Starting subtest: plane-upscale-20x20-with-rotation
[202.439024] Starting dynamic subtest: pipe-A
[202.678922] Dynamic subtest pipe-A: SUCCESS (0.245s)
[202.685806] Starting dynamic subtest: pipe-B
[204.007548] Dynamic subtest pipe-B: SUCCESS (1.327s)
[204.016072] Starting dynamic subtest: pipe-C
[205.331310] Dynamic subtest pipe-C: SUCCESS (1.323s)
[205.339214] Starting dynamic subtest: pipe-D
[206.665472] Dynamic subtest pipe-D: SUCCESS (1.333s)
[206.667737] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.232s)
[207.830507] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[207.833431] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[207.837231] [038/131] (814s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[207.949875] Starting subtest: 4-tiled-8bpp-rotate-180
[209.110762] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.161s)
[209.280135] [039/131] (813s left) kms_rotation_crc (primary-rotation-90)
[209.377240] Starting subtest: primary-rotation-90
[209.380824] Subtest primary-rotation-90: SKIP (0.001s)
[209.473971] [040/131] (813s left) kms_cursor_crc (cursor-onscreen-32x10)
[209.616703] Starting subtest: cursor-onscreen-32x10
[209.662358] Subtest cursor-onscreen-32x10: SKIP (0.040s)
[209.957874] [041/131] (812s left) kms_vblank (wait-idle)
[210.055710] Starting subtest: wait-idle
[210.057354] Starting dynamic subtest: pipe-A-eDP-1
[211.821200] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s)
[211.834267] Starting dynamic subtest: pipe-D-eDP-1
[214.299724] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.478s)
[214.302069] Subtest wait-idle: SUCCESS (4.246s)
[215.148502] [042/131] (807s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[215.258648] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[215.262807] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[215.399653] [043/131] (807s left) kms_flip (2x-flip-vs-dpms)
[215.502420] Starting subtest: 2x-flip-vs-dpms
[215.510454] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[215.659026] [044/131] (807s left) gem_exec_fence (syncobj-channel)
[216.082032] Starting subtest: syncobj-channel
[217.099892] Subtest syncobj-channel: SUCCESS (1.015s)
[218.075678] [045/131] (804s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[218.179794] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[218.181996] Starting dynamic subtest: pipe-A-eDP-1
[218.190500] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[218.206023] Starting dynamic subtest: pipe-B-eDP-1
[218.214613] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[218.222146] Starting dynamic subtest: pipe-C-eDP-1
[218.230410] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[218.237666] Starting dynamic subtest: pipe-D-eDP-1
[218.246122] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[218.250202] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[220.501122] [046/131] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[220.604642] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[228.031384] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.429s)
[228.188242] [047/131] (794s left) kms_flip (busy-flip)
[228.293218] Starting subtest: busy-flip
[228.295395] Starting dynamic subtest: A-eDP1
[230.019727] Dynamic subtest A-eDP1: SUCCESS (1.725s)
[230.030864] Starting dynamic subtest: B-eDP1
[231.748865] Dynamic subtest B-eDP1: SUCCESS (1.727s)
[231.759544] Starting dynamic subtest: C-eDP1
[233.390927] Dynamic subtest C-eDP1: SUCCESS (1.639s)
[233.401623] Starting dynamic subtest: D-eDP1
[235.023376] Dynamic subtest D-eDP1: SUCCESS (1.631s)
[235.025617] Subtest busy-flip: SUCCESS (6.734s)
[236.313180] [048/131] (786s left) prime_mmap (test_aperture_limit)
[236.382621] Starting subtest: test_aperture_limit
[236.385075] Starting dynamic subtest: test_aperture_limit-smem
[236.393250] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[236.397792] Subtest test_aperture_limit: SKIP (0.008s)
[236.555397] [049/131] (786s left) i915_pm_rpm (sysfs-read)
[238.095717] Starting subtest: sysfs-read
[239.251635] Subtest sysfs-read: SUCCESS (1.158s)
[239.649056] [050/131] (783s left) kms_big_fb (yf-tiled-addfb)
[239.766443] Starting subtest: yf-tiled-addfb
[239.770717] Subtest yf-tiled-addfb: SKIP (0.000s)
[239.901455] [051/131] (783s left) sriov_basic (enable-vfs-autoprobe-on)
[239.964532] Starting subtest: enable-vfs-autoprobe-on
[239.966654] Starting dynamic subtest: numvfs-1
[240.044109] Dynamic subtest numvfs-1: FAIL (0.029s)
[240.053320] Starting dynamic subtest: numvfs-2
[240.125068] Dynamic subtest numvfs-2: FAIL (0.003s)
[240.134383] Starting dynamic subtest: numvfs-3
[240.211817] Dynamic subtest numvfs-3: FAIL (0.003s)
[240.221215] Starting dynamic subtest: numvfs-4
[240.294744] Dynamic subtest numvfs-4: FAIL (0.003s)
[240.304110] Starting dynamic subtest: numvfs-5
[240.378507] Dynamic subtest numvfs-5: FAIL (0.003s)
[240.387627] Starting dynamic subtest: numvfs-6
[240.460814] Dynamic subtest numvfs-6: FAIL (0.003s)
[240.469862] Starting dynamic subtest: numvfs-7
[240.543578] Dynamic subtest numvfs-7: FAIL (0.004s)
[240.552893] Starting dynamic subtest: numvfs-random
[240.611311] Dynamic subtest numvfs-random: FAIL (0.003s)
[240.619059] Starting dynamic subtest: numvfs-all
[240.675699] Dynamic subtest numvfs-all: FAIL (0.512s)
[240.677477] Subtest enable-vfs-autoprobe-on: FAIL (0.573s)
[240.710977] [052/131] (782s left) gem_exec_whisper (basic-queues)
[240.776995] Starting subtest: basic-queues
[247.861527] Subtest basic-queues: SUCCESS (7.082s)
[248.070502] [053/131] (775s left) kms_flip (2x-dpms-vs-vblank-race)
[248.176771] Starting subtest: 2x-dpms-vs-vblank-race
[248.185509] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[248.288779] [054/131] (774s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[248.390923] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[248.761761] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[251.491235] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.728s)
[251.502148] Starting dynamic subtest: pipe-A-eDP-1-4
[253.666539] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[253.677118] Starting dynamic subtest: pipe-A-eDP-1-4
[255.676539] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[255.687728] Starting dynamic subtest: pipe-A-eDP-1-x
[257.855039] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[258.221652] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[261.020356] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.807s)
[261.031690] Starting dynamic subtest: pipe-B-eDP-1-4
[263.207697] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[263.218109] Starting dynamic subtest: pipe-B-eDP-1-4
[265.217458] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[265.227963] Starting dynamic subtest: pipe-B-eDP-1-x
[267.407389] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[267.801952] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[270.551570] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[270.561089] Starting dynamic subtest: pipe-C-eDP-1-4
[272.736411] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s)
[272.745755] Starting dynamic subtest: pipe-C-eDP-1-4
[274.747867] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[274.758405] Starting dynamic subtest: pipe-C-eDP-1-x
[276.926067] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[277.287583] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[280.079987] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[280.087985] Starting dynamic subtest: pipe-D-eDP-1-4
[282.255808] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[282.269861] Starting dynamic subtest: pipe-D-eDP-1-4
[284.266368] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[284.277381] Starting dynamic subtest: pipe-D-eDP-1-x
[286.467058] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s)
[286.469975] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.075s)
[287.680955] [055/131] (735s left) gem_mmap_gtt (basic-write-read-distinct)
[287.752108] Subtest basic-write-read-distinct: SKIP (0.000s)
[287.841394] [056/131] (735s left) gem_mmap_offset (oob-read)
[287.894514] Starting subtest: oob-read
[287.896483] Subtest oob-read: SUCCESS (0.000s)
[288.032160] [057/131] (735s left) kms_atomic (atomic-plane-damage)
[288.126317] Starting subtest: atomic-plane-damage
[288.174995] Starting dynamic subtest: pipe-A-eDP-1
[288.730049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[288.732224] Subtest atomic-plane-damage: SUCCESS (0.601s)
[289.612446] [058/131] (733s left) kms_atomic_transition (plane-all-transition-nonblocking)
[289.722285] Starting subtest: plane-all-transition-nonblocking
[289.724391] Starting dynamic subtest: pipe-A-eDP-1
[292.216271] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[292.533542] Starting dynamic subtest: pipe-B-eDP-1
[295.741482] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.216s)
[296.052629] Subtest plane-all-transition-nonblocking: SUCCESS (6.329s)
[296.906258] [059/131] (726s left) gem_exec_parallel (contexts)
[296.970261] Starting subtest: contexts
[296.972678] Starting dynamic subtest: rcs0
[299.748645] Dynamic subtest rcs0: SUCCESS (2.776s)
[299.762746] Starting dynamic subtest: bcs0
[303.247836] Dynamic subtest bcs0: SUCCESS (3.498s)
[303.259560] Starting dynamic subtest: vcs0
[307.427565] Dynamic subtest vcs0: SUCCESS (4.176s)
[307.437873] Starting dynamic subtest: vcs1
[311.454890] Dynamic subtest vcs1: SUCCESS (4.024s)
[311.463846] Starting dynamic subtest: vecs0
[315.396992] Dynamic subtest vecs0: SUCCESS (3.939s)
[315.406608] Starting dynamic subtest: ccs0
[318.907273] Dynamic subtest ccs0: SUCCESS (3.508s)
[318.910238] Subtest contexts: SUCCESS (21.936s)
[319.119955] [060/131] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[319.234331] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[325.949747] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.717s)
[326.094084] [061/131] (697s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[326.208479] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[326.212834] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.342617] [062/131] (697s left) kms_atomic_interruptible (legacy-pageflip)
[326.431975] Starting subtest: legacy-pageflip
[326.434123] Starting dynamic subtest: pipe-A-eDP-1
[333.837230] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.405s)
[333.839567] Subtest legacy-pageflip: SUCCESS (7.407s)
[334.695114] [063/131] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[334.804950] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[334.809617] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[334.927274] [064/131] (688s left) kms_psr (psr2-sprite-mmap-cpu)
[335.020470] Starting subtest: psr2-sprite-mmap-cpu
[335.022645] Starting dynamic subtest: eDP-1
[336.750570] Dynamic subtest eDP-1: SUCCESS (1.728s)
[336.752902] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.729s)
[337.658226] [065/131] (685s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[337.755597] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[344.831494] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.078s)
[345.024314] [066/131] (678s left) gem_exec_schedule (fairslice-all)
[345.100133] Starting subtest: fairslice-all
[347.156439] Subtest fairslice-all: SUCCESS (2.057s)
[348.998351] [067/131] (674s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[354.019088] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[354.021429] Starting dynamic subtest: pipe-A-eDP-1
[354.836355] Dynamic subtest pipe-A-eDP-1: SKIP (0.813s)
[354.845410] Starting dynamic subtest: pipe-B-eDP-1
[355.975329] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[355.979626] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.953s)
[357.176346] [068/131] (666s left) api_intel_allocator (two-level-inception)
[357.232969] Starting subtest: two-level-inception
[362.638558] Subtest two-level-inception: SUCCESS (5.406s)
[362.799220] [069/131] (660s left) i915_suspend (debugfs-reader)
[362.877307] Starting subtest: debugfs-reader
[381.377150] Subtest debugfs-reader: SUCCESS (7.264s)
[381.581164] [070/131] (642s left) kms_flip (plain-flip-fb-recreate-interruptible)
[381.697304] Starting subtest: plain-flip-fb-recreate-interruptible
[381.699515] Starting dynamic subtest: A-eDP1
[390.558979] Dynamic subtest A-eDP1: SUCCESS (8.855s)
[390.571661] Starting dynamic subtest: B-eDP1
[399.381755] Dynamic subtest B-eDP1: SUCCESS (8.818s)
[399.392054] Starting dynamic subtest: C-eDP1
[408.200925] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[408.210092] Starting dynamic subtest: D-eDP1
[417.039978] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[417.044503] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.336s)
[418.252334] [071/131] (605s left) gem_vm_create (invalid-destroy)
[418.329769] Starting subtest: invalid-destroy
[418.332135] Subtest invalid-destroy: SUCCESS (0.002s)
[418.472301] [072/131] (605s left) gem_ccs (ctrl-surf-copy-new-ctx)
[418.541134] Starting subtest: ctrl-surf-copy-new-ctx
[418.545287] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[418.687411] [073/131] (605s left) syncobj_basic (bad-destroy-pad)
[418.737237] Starting subtest: bad-destroy-pad
[418.739458] Subtest bad-destroy-pad: SUCCESS (0.000s)
[418.862156] [074/131] (605s left) kms_plane_multiple (2x-tiling-y)
[418.953851] Starting subtest: 2x-tiling-y
[418.957822] Subtest 2x-tiling-y: SKIP (0.000s)
[419.050490] [075/131] (605s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[419.149759] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[419.151765] Starting dynamic subtest: pipe-A-eDP-1
[419.170619] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[419.181434] Starting dynamic subtest: pipe-B-eDP-1
[419.198946] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[419.208784] Starting dynamic subtest: pipe-C-eDP-1
[419.225880] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[419.233994] Starting dynamic subtest: pipe-D-eDP-1
[419.251823] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[419.255185] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[421.329181] [076/131] (602s left) kms_pm_rpm (modeset-lpsp)
[423.300593] Starting subtest: modeset-lpsp
[424.746435] Subtest modeset-lpsp: SUCCESS (1.448s)
[424.895775] [077/131] (599s left) kms_setmode (basic)
[424.960947] Starting subtest: basic
[425.294117] Starting dynamic subtest: pipe-A-eDP-1
[427.420109] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s)
[427.771884] Starting dynamic subtest: pipe-B-eDP-1
[429.863245] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.096s)
[430.169840] Subtest basic: SUCCESS (5.206s)
[431.019964] [078/131] (593s left) kms_psr (fbc-psr-suspend)
[431.114817] Starting subtest: fbc-psr-suspend
[431.117197] Starting dynamic subtest: eDP-1
[431.121507] Dynamic subtest eDP-1: SKIP (0.000s)
[431.125782] Subtest fbc-psr-suspend: SKIP (0.001s)
[431.216188] [079/131] (593s left) gem_ringfill (engines-basic)
[437.116234] Starting subtest: engines-basic
[437.118632] Starting dynamic subtest: rcs0
[437.210927] Dynamic subtest rcs0: SUCCESS (0.094s)
[437.222878] Starting dynamic subtest: bcs0
[437.257765] Dynamic subtest bcs0: SUCCESS (0.045s)
[437.268045] Starting dynamic subtest: vcs0
[437.299929] Dynamic subtest vcs0: SUCCESS (0.040s)
[437.310395] Starting dynamic subtest: vcs1
[437.343460] Dynamic subtest vcs1: SUCCESS (0.041s)
[437.355315] Starting dynamic subtest: vecs0
[437.384984] Dynamic subtest vecs0: SUCCESS (0.040s)
[437.396537] Starting dynamic subtest: ccs0
[437.430018] Dynamic subtest ccs0: SUCCESS (0.043s)
[437.432371] Subtest engines-basic: SUCCESS (0.316s)
[437.539022] [080/131] (586s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[437.609261] Starting subtest: invalid-bsd2-flag-on-vebox
[437.611681] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[437.737644] [081/131] (586s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[437.848749] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[437.851056] Starting dynamic subtest: pipe-A-eDP-1
[437.870782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[437.882167] Starting dynamic subtest: pipe-B-eDP-1
[437.902285] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[437.911379] Starting dynamic subtest: pipe-C-eDP-1
[437.930644] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[437.939093] Starting dynamic subtest: pipe-D-eDP-1
[437.958685] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[437.960802] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[440.183249] [082/131] (584s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[440.288933] Starting subtest: extended-pageflip-modeset-hang-oldfb
[440.290819] Starting dynamic subtest: pipe-A
[448.194609] Dynamic subtest pipe-A: SUCCESS (7.905s)
[448.206682] Starting dynamic subtest: pipe-D
[456.779216] Dynamic subtest pipe-D: SUCCESS (8.579s)
[456.781496] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.492s)
[457.648336] [083/131] (566s left) gem_ppgtt (shrink-vs-evict-any)
[457.713793] Starting subtest: shrink-vs-evict-any
[463.132415] Subtest shrink-vs-evict-any: SUCCESS (5.416s)
[463.253901] [084/131] (561s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[463.314267] Starting subtest: etime-single-wait-for-submit-unsubmitted
[463.421484] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[463.522302] [085/131] (561s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[463.583965] Starting subtest: multi-wait-all-for-submit-signaled
[463.586438] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[463.721101] [086/131] (560s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[463.784606] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[463.893586] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[463.996852] [087/131] (560s left) gem_exec_schedule (implicit-write-read)
[464.067510] Starting subtest: implicit-write-read
[464.069854] Starting dynamic subtest: rcs0
[464.245183] Dynamic subtest rcs0: SUCCESS (0.186s)
[464.259447] Starting dynamic subtest: vcs0
[464.352085] Dynamic subtest vcs0: SUCCESS (0.107s)
[464.366500] Starting dynamic subtest: vcs1
[464.457896] Dynamic subtest vcs1: SUCCESS (0.105s)
[464.471092] Starting dynamic subtest: vecs0
[464.574734] Dynamic subtest vecs0: SUCCESS (0.114s)
[464.587692] Starting dynamic subtest: ccs0
[464.693410] Dynamic subtest ccs0: SUCCESS (0.117s)
[464.696253] Subtest implicit-write-read: SUCCESS (0.634s)
[465.318313] [088/131] (559s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[465.424085] Starting subtest: fbcpsr-rgb565-draw-blt
[472.511106] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.088s)
[472.692970] [089/131] (552s left) gem_ctx_persistence (processes)
[472.773323] Starting subtest: processes
[474.117669] Subtest processes: SUCCESS (1.347s)
[474.228824] [090/131] (550s left) kms_cursor_crc (cursor-sliding-32x10)
[474.393572] Starting subtest: cursor-sliding-32x10
[474.439231] Subtest cursor-sliding-32x10: SKIP (0.040s)
[474.739451] [091/131] (550s left) kms_psr (fbc-pr-primary-render)
[474.854656] Starting subtest: fbc-pr-primary-render
[474.859296] Subtest fbc-pr-primary-render: SKIP (0.000s)
[474.958492] [092/131] (549s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[475.025102] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[475.106840] [093/131] (549s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[475.172144] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[475.174180] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[475.291814] [094/131] (549s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[475.404930] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[475.408654] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[475.543121] [095/131] (549s left) gem_exec_async (concurrent-writes)
[475.602403] Starting subtest: concurrent-writes
[475.604419] Starting dynamic subtest: rcs0
[475.617475] Dynamic subtest rcs0: SUCCESS (0.015s)
[475.629783] Starting dynamic subtest: bcs0
[475.631365] Dynamic subtest bcs0: SUCCESS (0.007s)
[475.640008] Starting dynamic subtest: vcs0
[475.641970] Dynamic subtest vcs0: SUCCESS (0.005s)
[475.650761] Starting dynamic subtest: vcs1
[475.652510] Dynamic subtest vcs1: SUCCESS (0.006s)
[475.660886] Starting dynamic subtest: vecs0
[475.662600] Dynamic subtest vecs0: SUCCESS (0.006s)
[475.670845] Starting dynamic subtest: ccs0
[475.672432] Dynamic subtest ccs0: SUCCESS (0.004s)
[475.674126] Subtest concurrent-writes: SUCCESS (0.047s)
[475.928724] [096/131] (549s left) gem_mmap_gtt (basic-small-bo-tiledx)
[475.988624] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[476.057482] [097/131] (549s left) dmabuf_sync_file (import-basic)
[476.097350] Starting subtest: import-basic
[476.099125] Subtest import-basic: SUCCESS (0.001s)
[476.170716] [098/131] (549s left) kms_feature_discovery (display)
[476.261998] Starting subtest: display
[476.263660] Subtest display: SUCCESS (0.000s)
[476.380779] [099/131] (548s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[476.470329] Starting subtest: x-tiled-64bpp-rotate-90
[476.490273] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[476.639211] [100/131] (548s left) perf_pmu (busy-no-semaphores)
[476.689769] Starting subtest: busy-no-semaphores
[476.691714] Starting dynamic subtest: rcs0
[477.282071] Dynamic subtest rcs0: SUCCESS (0.590s)
[477.295083] Starting dynamic subtest: bcs0
[477.833498] Dynamic subtest bcs0: SUCCESS (0.548s)
[477.846658] Starting dynamic subtest: vcs0
[478.384250] Dynamic subtest vcs0: SUCCESS (0.548s)
[478.396875] Starting dynamic subtest: vcs1
[479.677298] Dynamic subtest vcs1: SUCCESS (1.289s)
[479.689092] Starting dynamic subtest: vecs0
[481.661656] Dynamic subtest vecs0: SUCCESS (1.982s)
[481.672715] Starting dynamic subtest: ccs0
[483.646684] Dynamic subtest ccs0: SUCCESS (1.982s)
[483.649430] Subtest busy-no-semaphores: SUCCESS (6.957s)
[483.786162] [101/131] (541s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[483.893305] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[483.897203] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[484.037115] [102/131] (541s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[484.160539] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[484.165137] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[484.331068] [103/131] (541s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[484.721581] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[485.544466] [104/131] (539s left) kms_getfb (getfb-reject-nv12)
[485.656534] Starting subtest: getfb-reject-nv12
[485.658857] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[485.796308] [105/131] (539s left) i915_drm_fdinfo (context-close-stress)
[485.834359] Starting subtest: context-close-stress
[496.578876] Subtest context-close-stress: SUCCESS (10.746s)
[496.677552] [106/131] (528s left) perf_pmu (module-unload)
[496.936640] Starting subtest: module-unload
[505.417468] Subtest module-unload: FAIL (8.367s)
[505.449262] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[505.449961] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[505.453065] [107/131] (520s left) kms_chamelium_edid (dp-edid-read)
[507.246871] Subtest dp-edid-read: SKIP (0.000s)
[508.098731] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[508.100012] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[508.103637] [108/131] (517s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[513.273346] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[513.275259] Starting dynamic subtest: pipe-A-eDP-1
[514.066047] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[514.075222] Starting dynamic subtest: pipe-B-eDP-1
[515.201331] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[515.205958] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.927s)
[516.400978] [109/131] (509s left) kms_vblank (query-busy)
[516.528898] Starting subtest: query-busy
[516.531197] Starting dynamic subtest: pipe-A-eDP-1
[518.413815] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[518.427239] Starting dynamic subtest: pipe-D-eDP-1
[520.948598] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[520.950600] Subtest query-busy: SUCCESS (4.419s)
[521.775374] [110/131] (503s left) syncobj_timeline (wait-for-submit-complex)
[521.829618] Starting subtest: wait-for-submit-complex
[521.890274] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[521.988134] [111/131] (503s left) perf (invalid-create-userspace-config)
[522.122384] Starting subtest: invalid-create-userspace-config
[522.124497] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[522.167096] [112/131] (503s left) gem_exec_basic (basic)
[522.230804] Starting subtest: basic
[522.233592] Starting dynamic subtest: rcs0-smem
[522.236088] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[522.246808] Starting dynamic subtest: bcs0-smem
[522.248711] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[522.256933] Starting dynamic subtest: vcs0-smem
[522.258816] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[522.266949] Starting dynamic subtest: vcs1-smem
[522.268869] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[522.277018] Starting dynamic subtest: vecs0-smem
[522.279002] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[522.287047] Starting dynamic subtest: ccs0-smem
[522.289099] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[522.291079] Subtest basic: SUCCESS (0.013s)
[524.218173] [113/131] (501s left) kms_chamelium_color (ctm-0-25)
[524.320766] Subtest ctm-0-25: SKIP (0.000s)
[524.365104] [114/131] (501s left) gem_userptr_blits (process-exit-busy)
[524.430259] Starting subtest: process-exit-busy
[524.443895] Subtest process-exit-busy: SUCCESS (0.015s)
[524.612050] [115/131] (501s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[524.673097] Starting subtest: y-tiled-ccs-to-y-tiled
[524.677317] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[524.876752] [116/131] (501s left) gen7_exec_parse (bitmasks)
[524.937086] Subtest bitmasks: SKIP (0.000s)
[525.009704] [117/131] (500s left) gem_eio (wait-wedge-10ms)
[525.193626] Starting subtest: wait-wedge-10ms
[526.179179] Subtest wait-wedge-10ms: SUCCESS (0.987s)
[526.361960] [118/131] (499s left) kms_content_protection (atomic)
[526.508366] Starting subtest: atomic
[526.512769] Subtest atomic: SKIP (0.000s)
[526.679437] [119/131] (499s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[526.784717] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[526.786913] Starting dynamic subtest: pipe-A-default-mode
[527.074312] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[527.078691] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.289s)
[527.898578] [120/131] (498s left) gem_exec_params (invalid-flag)
[527.957364] Starting subtest: invalid-flag
[527.959718] Subtest invalid-flag: SUCCESS (0.000s)
[528.107728] [121/131] (498s left) kms_getfb (getfb-addfb-different-handles)
[528.214397] Starting subtest: getfb-addfb-different-handles
[528.216629] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[528.392581] [122/131] (497s left) gem_exec_flush (basic-uc-ro-default)
[528.462105] Starting subtest: basic-uc-ro-default
[533.913325] Subtest basic-uc-ro-default: SUCCESS (5.451s)
[534.132857] [123/131] (492s left) gem_sync (basic-each)
[534.208364] Starting subtest: basic-each
[536.751066] Subtest basic-each: SUCCESS (2.553s)
[536.967497] [124/131] (489s left) gem_exec_balancer (full)
[537.051810] Starting subtest: full
[542.070190] Subtest full: SUCCESS (5.018s)
[542.443595] [125/131] (483s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[542.576054] Starting subtest: y-tiled-8bpp-rotate-180
[542.580542] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[542.711016] [126/131] (483s left) sw_sync (sync_merge_invalid)
[542.741409] Starting subtest: sync_merge_invalid
[542.774194] Subtest sync_merge_invalid: SUCCESS (0.034s)
[542.863511] [127/131] (483s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[542.965917] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[547.398389] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.437s)
[548.606676] [128/131] (477s left) gem_lmem_swapping (parallel-random-verify-ccs)
[548.645965] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[548.691266] [129/131] (477s left) kms_lease (lease-unleased-connector)
[548.788001] Starting subtest: lease-unleased-connector
[548.790526] Starting dynamic subtest: pipe-A-eDP-1
[548.795808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s)
[548.806364] Starting dynamic subtest: pipe-B-eDP-1
[548.808594] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[548.817872] Starting dynamic subtest: pipe-C-eDP-1
[548.820053] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[548.830779] Starting dynamic subtest: pipe-D-eDP-1
[548.832917] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[548.835130] Subtest lease-unleased-connector: SUCCESS (0.040s)
[548.955395] [130/131] (477s left) perf (enable-disable)
[549.067519] Starting subtest: enable-disable
[549.069976] Starting dynamic subtest: 0-rcs0
[551.328158] Dynamic subtest 0-rcs0: SUCCESS (2.258s)
[551.338741] Starting dynamic subtest: 1-vcs0
[555.915888] Dynamic subtest 1-vcs0: SUCCESS (4.586s)
[555.918872] Subtest enable-disable: SUCCESS (6.847s)
[555.964179] [131/131] (470s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[556.116171] Starting subtest: cursor-rapid-movement-32x32
[556.161254] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[556.494250] Closing watchdogs
results: parsing output: 0/ for test: fbdev
results: parsing output: 1/ for test: gem_ctx_isolation
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: gem_spin_batch
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: sysfs_heartbeat_interval
results: parsing output: 8/ for test: kms_invalid_mode
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_getfb
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_plane_alpha_blend
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: core_auth
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_dither
results: parsing output: 31/ for test: gem_partial_pwrite_pread
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: gen3_render_mixed_blits
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: i915_module_load
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: sriov_basic
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: kms_atomic
results: parsing output: 57/ for test: kms_atomic_transition
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_atomic_interruptible
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: i915_suspend
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_vm_create
results: parsing output: 71/ for test: gem_ccs
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: kms_setmode
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_ringfill
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_busy
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_async
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: dmabuf_sync_file
results: parsing output: 97/ for test: kms_feature_discovery
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: gem_exec_basic
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: gen7_exec_parse
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: gem_sync
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_lmem_swapping
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: kms_cursor_crc
Done.