[141.250339] Initializing watchdogs
[141.250388]   /dev/watchdog0
[141.264402] [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]
[141.268730] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[141.270950] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[141.274335] [001/131] (960s left) gem_userptr_blits (unsync-unmap-after-close)
[141.371792] Subtest unsync-unmap-after-close: SKIP (0.000s)
[141.547772] [002/131] (960s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[141.611622] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[141.614123] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[141.747578] [003/131] (960s left) gem_ccs (ctrl-surf-copy)
[141.817182] Starting subtest: ctrl-surf-copy
[141.821597] Subtest ctrl-surf-copy: SKIP (0.000s)
[141.956605] [004/131] (959s left) i915_hangman (hangcheck-unterminated)
[142.035115] Starting subtest: hangcheck-unterminated
[153.848247] Subtest hangcheck-unterminated: SUCCESS (11.813s)
[154.027631] [005/131] (947s left) gem_exec_schedule (preempt-hang)
[154.197054] Starting subtest: preempt-hang
[154.199867] Starting dynamic subtest: rcs0
[154.448871] Dynamic subtest rcs0: SUCCESS (0.252s)
[154.457060] Starting dynamic subtest: bcs0
[154.685945] Dynamic subtest bcs0: SUCCESS (0.238s)
[154.694186] Starting dynamic subtest: vcs0
[154.900407] Dynamic subtest vcs0: SUCCESS (0.214s)
[154.913054] Starting dynamic subtest: vcs1
[155.118094] Dynamic subtest vcs1: SUCCESS (0.217s)
[155.128612] Starting dynamic subtest: vecs0
[155.341285] Dynamic subtest vecs0: SUCCESS (0.221s)
[155.351521] Starting dynamic subtest: ccs0
[155.584083] Dynamic subtest ccs0: SUCCESS (0.243s)
[155.586558] Subtest preempt-hang: SUCCESS (1.389s)
[156.045897] [006/131] (945s left) gem_exec_reloc (basic-write-gtt-active)
[156.113180] Subtest basic-write-gtt-active: SKIP (0.000s)
[156.179425] [007/131] (945s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[156.242509] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[156.246712] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[156.447786] [008/131] (945s left) gem_exercise_blt (fast-copy-emit)
[156.515347] Starting subtest: fast-copy-emit
[156.517322] Starting dynamic subtest: linear-smem-smem-emit
[156.545443] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.030s)
[156.555610] Starting dynamic subtest: xmajor-smem-smem-emit
[156.564638] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.019s)
[156.572222] Starting dynamic subtest: tile4-smem-smem-emit
[156.582972] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[156.590654] Starting dynamic subtest: tile64-smem-smem-emit
[156.602581] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.019s)
[156.604836] Subtest fast-copy-emit: SUCCESS (0.088s)
[156.741964] [009/131] (945s left) kms_cursor_crc (cursor-size-hints)
[156.883647] Starting subtest: cursor-size-hints
[156.885802] Starting dynamic subtest: pipe-A-eDP-1
[157.547835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.663s)
[157.559259] Starting dynamic subtest: pipe-D-eDP-1
[158.842637] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[158.845052] Subtest cursor-size-hints: SUCCESS (1.958s)
[159.659919] [010/131] (942s left) kms_getfb (getfb2-handle-not-fb)
[159.742266] Starting subtest: getfb2-handle-not-fb
[159.744649] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[159.868182] [011/131] (942s left) sriov_basic (enable-vfs-bind-unbind-each)
[159.937684] Starting subtest: enable-vfs-bind-unbind-each
[159.940117] Starting dynamic subtest: numvfs-1
[160.022600] Dynamic subtest numvfs-1: FAIL (0.033s)
[160.032509] Starting dynamic subtest: numvfs-2
[160.104751] Dynamic subtest numvfs-2: FAIL (0.004s)
[160.114033] Starting dynamic subtest: numvfs-3
[160.187424] Dynamic subtest numvfs-3: FAIL (0.005s)
[160.196052] Starting dynamic subtest: numvfs-4
[160.268909] Dynamic subtest numvfs-4: FAIL (0.004s)
[160.278955] Starting dynamic subtest: numvfs-5
[160.351884] Dynamic subtest numvfs-5: FAIL (0.004s)
[160.360660] Starting dynamic subtest: numvfs-6
[160.433481] Dynamic subtest numvfs-6: FAIL (0.004s)
[160.443653] Starting dynamic subtest: numvfs-7
[160.516053] Dynamic subtest numvfs-7: FAIL (0.004s)
[160.524763] Starting dynamic subtest: numvfs-random
[160.592598] Dynamic subtest numvfs-random: FAIL (0.004s)
[160.594531] Subtest enable-vfs-bind-unbind-each: FAIL (0.064s)
[160.628908] [012/131] (941s left) kms_psr (psr2-cursor-plane-move)
[160.727208] Starting subtest: psr2-cursor-plane-move
[160.729113] Starting dynamic subtest: eDP-1
[162.416477] Dynamic subtest eDP-1: SUCCESS (1.688s)
[162.418805] Subtest psr2-cursor-plane-move: SUCCESS (1.689s)
[163.224768] [013/131] (939s left) prime_mmap (test_correct_cpu_write)
[163.290579] Starting subtest: test_correct_cpu_write
[163.293032] Starting dynamic subtest: test_correct_cpu_write-smem
[163.295312] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[163.297616] Subtest test_correct_cpu_write: SUCCESS (0.000s)
[163.411968] [014/131] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[163.509526] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[163.513625] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[163.634536] [015/131] (938s left) kms_universal_plane (disable-primary-vs-flip)
[163.723298] Starting subtest: disable-primary-vs-flip
[163.725540] Starting dynamic subtest: pipe-A-eDP-1
[165.269284] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.545s)
[165.278743] Starting dynamic subtest: pipe-B-eDP-1
[167.459525] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.188s)
[167.467998] Starting dynamic subtest: pipe-C-eDP-1
[169.711352] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.250s)
[169.720689] Starting dynamic subtest: pipe-D-eDP-1
[171.870543] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.158s)
[171.872724] Subtest disable-primary-vs-flip: SUCCESS (8.145s)
[172.697424] [016/131] (929s left) gem_mmap_gtt (zero-extend)
[172.767905] Subtest zero-extend: SKIP (0.000s)
[172.827608] [017/131] (929s left) gem_exec_reloc (basic-write-cpu-active)
[172.894207] Subtest basic-write-cpu-active: SKIP (0.000s)
[172.969718] [018/131] (929s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[173.075031] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[173.077341] Starting dynamic subtest: pipe-A
[173.370804] Dynamic subtest pipe-A: SUCCESS (0.297s)
[173.378789] Starting dynamic subtest: pipe-B
[174.670757] Dynamic subtest pipe-B: SUCCESS (1.298s)
[174.679778] Starting dynamic subtest: pipe-C
[176.006781] Dynamic subtest pipe-C: SUCCESS (1.335s)
[176.016579] Starting dynamic subtest: pipe-D
[177.334276] Dynamic subtest pipe-D: SUCCESS (1.326s)
[177.336586] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.261s)
[178.540468] [019/131] (923s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[178.651984] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[178.656527] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[178.784672] [020/131] (923s left) kms_async_flips (test-cursor)
[178.876028] Starting subtest: test-cursor
[178.880380] Subtest test-cursor: SKIP (0.000s)
[180.074564] [021/131] (922s left) sysfs_heartbeat_interval (idempotent)
[180.137313] Starting subtest: idempotent
[180.139570] Starting dynamic subtest: vecs0
[180.141872] Dynamic subtest vecs0: SUCCESS (0.001s)
[180.150086] Starting dynamic subtest: ccs0
[180.151942] Dynamic subtest ccs0: SUCCESS (0.001s)
[180.159520] Starting dynamic subtest: vcs0
[180.161400] Dynamic subtest vcs0: SUCCESS (0.000s)
[180.168304] Starting dynamic subtest: bcs0
[180.170113] Dynamic subtest bcs0: SUCCESS (0.001s)
[180.177136] Starting dynamic subtest: rcs0
[180.178995] Dynamic subtest rcs0: SUCCESS (0.000s)
[180.185897] Starting dynamic subtest: vcs1
[180.187789] Dynamic subtest vcs1: SUCCESS (0.000s)
[180.189689] Subtest idempotent: SUCCESS (0.006s)
[180.274629] [022/131] (922s left) syncobj_wait (single-wait-all-signaled)
[180.336052] Starting subtest: single-wait-all-signaled
[180.338527] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[180.461469] [023/131] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[180.573332] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[180.577615] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[180.699850] [024/131] (921s left) gem_unfence_active_buffers
[180.885128] [025/131] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[180.982236] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[187.771765] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.791s)
[187.921139] [026/131] (914s left) dumb_buffer (create-valid-dumb)
[187.974151] Starting subtest: create-valid-dumb
[187.976397] Subtest create-valid-dumb: SUCCESS (0.000s)
[188.132504] [027/131] (914s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[188.246773] Starting subtest: x-tiled-64bpp-rotate-180
[189.825459] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.578s)
[190.072850] [028/131] (912s left) kms_big_fb (linear-8bpp-rotate-270)
[190.185955] Starting subtest: linear-8bpp-rotate-270
[190.207345] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[190.330110] [029/131] (912s left) gem_ctx_shared (q-in-order)
[190.401425] Starting subtest: Q-in-order
[190.403952] Starting dynamic subtest: rcs0
[190.556108] Dynamic subtest rcs0: SUCCESS (0.153s)
[190.571332] Starting dynamic subtest: vcs0
[190.630685] Dynamic subtest vcs0: SUCCESS (0.075s)
[190.645602] Starting dynamic subtest: vcs1
[190.705503] Dynamic subtest vcs1: SUCCESS (0.074s)
[190.721087] Starting dynamic subtest: vecs0
[190.781884] Dynamic subtest vecs0: SUCCESS (0.076s)
[190.796778] Starting dynamic subtest: ccs0
[190.863343] Dynamic subtest ccs0: SUCCESS (0.081s)
[190.865789] Subtest Q-in-order: SUCCESS (0.462s)
[192.028031] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[192.030881] [030/131] (910s left) kms_draw_crc (draw-method-blt)
[192.125285] Starting subtest: draw-method-blt
[192.127461] Starting dynamic subtest: xrgb8888-untiled
[192.359035] Dynamic subtest xrgb8888-untiled: SUCCESS (0.235s)
[192.367875] Starting dynamic subtest: rgb565-untiled
[192.581125] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[192.589383] Starting dynamic subtest: xrgb2101010-untiled
[192.803889] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[192.813079] Starting dynamic subtest: xbgr16161616f-untiled
[193.036450] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s)
[193.045730] Starting dynamic subtest: xrgb8888-xtiled
[193.158506] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[193.166802] Starting dynamic subtest: rgb565-xtiled
[193.280880] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[193.289609] Starting dynamic subtest: xrgb2101010-xtiled
[193.391910] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[193.400136] Starting dynamic subtest: xbgr16161616f-xtiled
[193.492200] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.100s)
[193.500840] Starting dynamic subtest: xrgb8888-4tiled
[193.647502] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[193.656094] Starting dynamic subtest: rgb565-4tiled
[193.769798] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[193.782073] Starting dynamic subtest: xrgb2101010-4tiled
[193.881411] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[193.894645] Starting dynamic subtest: xbgr16161616f-4tiled
[194.003162] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s)
[194.005272] Subtest draw-method-blt: SUCCESS (1.880s)
[194.141435] [031/131] (908s left) i915_query (query-topology-unsupported)
[194.208789] Starting subtest: query-topology-unsupported
[194.212665] Subtest query-topology-unsupported: SKIP (0.000s)
[194.336947] [032/131] (908s left) kms_invalid_mode (int-max-clock)
[194.428430] Starting subtest: int-max-clock
[194.430424] Starting dynamic subtest: pipe-A-eDP-1
[194.712532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[194.722232] Starting dynamic subtest: pipe-B-eDP-1
[194.724398] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[194.732322] Starting dynamic subtest: pipe-C-eDP-1
[194.734671] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[194.742470] Starting dynamic subtest: pipe-D-eDP-1
[194.744381] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[194.746258] Subtest int-max-clock: SUCCESS (0.290s)
[195.543805] [033/131] (907s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[195.644945] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[199.761632] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.121s)
[200.934144] [034/131] (902s left) gem_exec_balancer (bonded-pair)
[201.009368] Starting subtest: bonded-pair
[201.013940] Subtest bonded-pair: SKIP (0.000s)
[201.351916] [035/131] (901s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[201.644721] Starting subtest: cursor-rapid-movement-512x170
[201.648986] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[201.818518] [036/131] (901s left) gem_exec_whisper (basic-fds-priority-all)
[201.887184] Starting subtest: basic-fds-priority-all
[224.364336] Subtest basic-fds-priority-all: SUCCESS (22.472s)
[224.571049] [037/131] (878s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[224.678036] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[224.682691] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[225.848147] [038/131] (877s left) i915_drm_fdinfo (virtual-busy)
[225.890453] Starting subtest: virtual-busy
[225.895280] Subtest virtual-busy: SKIP (0.000s)
[225.982777] [039/131] (877s left) i915_suspend (forcewake)
[226.039683] Starting subtest: forcewake
[258.244031] Subtest forcewake: SUCCESS (6.064s)
[258.347021] [040/131] (844s left) kms_vblank (wait-forked)
[258.451294] Starting subtest: wait-forked
[258.453448] Starting dynamic subtest: pipe-A-eDP-1
[260.304544] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.821s)
[260.319567] Starting dynamic subtest: pipe-D-eDP-1
[262.850390] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.504s)
[262.852719] Subtest wait-forked: SUCCESS (4.330s)
[263.765862] [041/131] (839s left) perf (gen12-group-concurrent-oa-buffer-read)
[263.913942] Starting subtest: gen12-group-concurrent-oa-buffer-read
[273.959088] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (9.981s)
[274.007695] [042/131] (829s left) kms_chamelium_audio (hdmi-audio-edid)
[274.393416] Subtest hdmi-audio-edid: SKIP (0.000s)
[275.217266] [043/131] (828s left) gem_close_race (multigpu-basic-threads)
[275.287769] Starting subtest: multigpu-basic-threads
[275.291986] Subtest multigpu-basic-threads: SKIP (0.000s)
[275.545005] [044/131] (827s left) kms_chamelium_edid (hdmi-mode-timings)
[275.935107] Subtest hdmi-mode-timings: SKIP (0.000s)
[276.745568] [045/131] (826s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[276.856095] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[284.234801] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.369s)
[284.398123] [046/131] (819s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[284.507798] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[284.512478] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[284.638724] [047/131] (818s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[284.725313] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[284.727658] Starting dynamic subtest: pipe-A-default-mode
[285.015128] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[285.019854] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.288s)
[285.867695] [048/131] (817s left) kms_plane_cursor (overlay)
[285.971401] Starting subtest: overlay
[285.975477] Starting dynamic subtest: pipe-A-eDP-1-size-64
[288.590495] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.616s)
[288.655230] Starting dynamic subtest: pipe-A-eDP-1-size-128
[291.224096] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[291.290781] Starting dynamic subtest: pipe-A-eDP-1-size-256
[293.820946] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.548s)
[294.172113] Starting dynamic subtest: pipe-B-eDP-1-size-64
[297.373420] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.212s)
[297.433589] Starting dynamic subtest: pipe-B-eDP-1-size-128
[299.907103] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[299.967672] Starting dynamic subtest: pipe-B-eDP-1-size-256
[302.463370] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s)
[302.824758] Starting dynamic subtest: pipe-C-eDP-1-size-64
[305.749226] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.935s)
[305.788251] Starting dynamic subtest: pipe-C-eDP-1-size-128
[307.981716] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s)
[308.019796] Starting dynamic subtest: pipe-C-eDP-1-size-256
[310.203671] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s)
[310.554078] Starting dynamic subtest: pipe-D-eDP-1-size-64
[313.370837] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.827s)
[313.408574] Starting dynamic subtest: pipe-D-eDP-1-size-128
[315.614524] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.213s)
[315.653790] Starting dynamic subtest: pipe-D-eDP-1-size-256
[317.793830] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[318.112792] Subtest overlay: SUCCESS (32.140s)
[318.989869] [049/131] (784s left) core_auth (basic-auth)
[319.058476] Starting subtest: basic-auth
[319.060704] Subtest basic-auth: SUCCESS (0.001s)
[319.204256] [050/131] (784s left) gem_userptr_blits (unsync-unmap-cycles)
[319.284186] Subtest unsync-unmap-cycles: SKIP (0.000s)
[319.451698] [051/131] (784s left) kms_pm_dc (dc9-dpms)
[320.567548] Starting subtest: dc9-dpms
[321.985055] Subtest dc9-dpms: SUCCESS (1.418s)
[322.087132] [052/131] (781s left) gem_ctx_persistence (processes)
[322.157041] Starting subtest: processes
[324.049379] Subtest processes: SUCCESS (1.892s)
[324.152742] [053/131] (779s left) gem_exec_schedule (preempt-user)
[324.236769] Starting subtest: preempt-user
[324.238742] Starting dynamic subtest: rcs0
[324.253133] Dynamic subtest rcs0: SUCCESS (0.024s)
[324.266083] Starting dynamic subtest: bcs0
[324.274099] Dynamic subtest bcs0: SUCCESS (0.020s)
[324.284449] Starting dynamic subtest: vcs0
[324.294592] Dynamic subtest vcs0: SUCCESS (0.020s)
[324.304730] Starting dynamic subtest: vcs1
[324.314411] Dynamic subtest vcs1: SUCCESS (0.019s)
[324.327642] Starting dynamic subtest: vecs0
[324.334137] Dynamic subtest vecs0: SUCCESS (0.019s)
[324.344319] Starting dynamic subtest: ccs0
[324.354463] Dynamic subtest ccs0: SUCCESS (0.020s)
[324.356982] Subtest preempt-user: SUCCESS (0.126s)
[326.182650] [054/131] (777s left) gem_exec_fence (nb-await)
[326.360632] Starting subtest: nb-await
[326.362921] Starting dynamic subtest: rcs0
[326.437585] Dynamic subtest rcs0: SUCCESS (0.076s)
[326.450454] Starting dynamic subtest: bcs0
[326.497383] Dynamic subtest bcs0: SUCCESS (0.058s)
[326.509824] Starting dynamic subtest: vcs0
[326.557319] Dynamic subtest vcs0: SUCCESS (0.058s)
[326.569398] Starting dynamic subtest: vcs1
[326.616968] Dynamic subtest vcs1: SUCCESS (0.058s)
[326.629181] Starting dynamic subtest: vecs0
[326.677977] Dynamic subtest vecs0: SUCCESS (0.058s)
[326.689981] Starting dynamic subtest: ccs0
[326.737869] Dynamic subtest ccs0: SUCCESS (0.058s)
[326.740543] Subtest nb-await: SUCCESS (0.378s)
[328.172851] [055/131] (775s left) kms_psr (pr-basic)
[328.270536] Starting subtest: pr-basic
[328.274935] Subtest pr-basic: SKIP (0.000s)
[328.371890] [056/131] (775s left) gen9_exec_parse (basic-rejected)
[328.430156] Subtest basic-rejected: SKIP (0.000s)
[328.497398] [057/131] (775s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[328.602556] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[328.604807] Starting dynamic subtest: pipe-A-eDP-1
[328.630212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.641961] Starting dynamic subtest: pipe-B-eDP-1
[328.665665] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.675533] Starting dynamic subtest: pipe-C-eDP-1
[328.699855] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.710860] Starting dynamic subtest: pipe-D-eDP-1
[328.734579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.738945] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[330.932245] [058/131] (773s left) kms_pm_rpm (system-suspend-idle)
[333.154770] Starting subtest: system-suspend-idle
[352.785072] Subtest system-suspend-idle: SUCCESS (4.561s)
[353.169296] [059/131] (750s left) gem_gtt_cpu_tlb
[353.308984] [060/131] (750s left) kms_flip (absolute-wf_vblank)
[353.413733] Starting subtest: absolute-wf_vblank
[353.416087] Starting dynamic subtest: A-eDP1
[362.086158] Dynamic subtest A-eDP1: SUCCESS (8.591s)
[362.104085] Starting dynamic subtest: B-eDP1
[370.860197] Dynamic subtest B-eDP1: SUCCESS (8.742s)
[370.876747] Starting dynamic subtest: C-eDP1
[379.600893] Dynamic subtest C-eDP1: SUCCESS (8.726s)
[379.610946] Starting dynamic subtest: D-eDP1
[388.330097] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[388.332485] Subtest absolute-wf_vblank: SUCCESS (34.797s)
[389.571760] [061/131] (714s left) kms_psr (fbc-pr-primary-render)
[389.680068] Starting subtest: fbc-pr-primary-render
[389.684734] Subtest fbc-pr-primary-render: SKIP (0.000s)
[389.785313] [062/131] (714s left) gem_exec_balancer (parallel-out-fence)
[390.046972] Starting subtest: parallel-out-fence
[391.160445] Subtest parallel-out-fence: SUCCESS (1.114s)
[391.295384] [063/131] (713s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[391.384939] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[391.389268] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[391.536232] [064/131] (712s left) kms_chamelium_hpd (hdmi-hpd)
[391.919911] Subtest hdmi-hpd: SKIP (0.000s)
[392.757986] [065/131] (711s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[392.889504] Starting subtest: cursorA-vs-flipA-legacy
[404.012616] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.121s)
[404.838043] [066/131] (699s left) syncobj_timeline (signal-point-0)
[404.894355] Starting subtest: signal-point-0
[404.896563] Subtest signal-point-0: SUCCESS (0.001s)
[405.037737] [067/131] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[405.138671] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[405.142873] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[405.284437] [068/131] (699s left) gem_pxp (verify-pxp-stale-buf-execution)
[405.411316] Starting subtest: verify-pxp-stale-buf-execution
[406.473241] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[406.637679] [069/131] (697s left) gem_ppgtt (blt-vs-render-ctx0)
[406.693179] Starting subtest: blt-vs-render-ctx0
[439.782827] Subtest blt-vs-render-ctx0: SUCCESS (33.075s)
[439.953865] [070/131] (664s left) gem_mmap_gtt (cpuset-big-copy-xy)
[440.057827] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[440.120286] [071/131] (664s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[440.221491] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[440.223778] Starting dynamic subtest: pipe-A
[441.280584] Dynamic subtest pipe-A: SUCCESS (1.061s)
[441.291145] Starting dynamic subtest: pipe-B
[443.448378] Dynamic subtest pipe-B: SUCCESS (2.166s)
[443.458635] Starting dynamic subtest: pipe-C
[444.634871] Dynamic subtest pipe-C: SUCCESS (1.185s)
[444.645573] Starting dynamic subtest: pipe-D
[445.863686] Dynamic subtest pipe-D: SUCCESS (1.227s)
[445.866291] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.643s)
[447.087236] [072/131] (657s left) syncobj_basic (bad-pad-handle-to-fd)
[447.138800] Starting subtest: bad-pad-handle-to-fd
[447.141232] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[447.277551] [073/131] (657s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[447.369218] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[447.371137] Starting dynamic subtest: A-eDP1
[450.999337] Dynamic subtest A-eDP1: SUCCESS (3.633s)
[451.010829] Starting dynamic subtest: B-eDP1
[454.181936] Dynamic subtest B-eDP1: SUCCESS (3.181s)
[454.194365] Starting dynamic subtest: C-eDP1
[457.290297] Dynamic subtest C-eDP1: SUCCESS (3.107s)
[457.300871] Starting dynamic subtest: D-eDP1
[460.407793] Dynamic subtest D-eDP1: SUCCESS (3.117s)
[460.410082] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.046s)
[461.227788] [074/131] (643s left) syncobj_wait (wait-for-submit-complex)
[461.296942] Starting subtest: wait-for-submit-complex
[461.359321] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[461.464007] [075/131] (643s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[461.574541] Starting subtest: yf-tiled-16bpp-rotate-270
[461.578961] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[461.714100] [076/131] (643s left) sw_sync (sync_multi_timeline_wait)
[461.752988] Starting subtest: sync_multi_timeline_wait
[461.755280] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[461.843396] [077/131] (643s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[461.937343] Starting subtest: primary-y-tiled-reflect-x-0
[461.996971] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[462.123279] [078/131] (642s left) kms_mmap_write_crc (main)
[462.222303] Starting subtest: main
[462.224263] Starting dynamic subtest: pipe-A-eDP-1
[465.706088] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[465.708298] Subtest main: SUCCESS (3.481s)
[466.570398] [079/131] (638s left) kms_cursor_edge_walk (64x64-left-edge)
[466.673672] Starting subtest: 64x64-left-edge
[466.675823] Starting dynamic subtest: pipe-A-eDP-1
[470.094283] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s)
[470.105380] Starting dynamic subtest: pipe-D-eDP-1
[473.220397] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[473.222726] Subtest 64x64-left-edge: SUCCESS (6.547s)
[474.044125] [080/131] (631s left) kms_flip (wf_vblank-ts-check-interruptible)
[474.146650] Starting subtest: wf_vblank-ts-check-interruptible
[474.149039] Starting dynamic subtest: A-eDP1
[483.066043] Dynamic subtest A-eDP1: SUCCESS (8.918s)
[483.081308] Starting dynamic subtest: B-eDP1
[491.991841] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[492.002603] Starting dynamic subtest: C-eDP1
[500.920847] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[500.932126] Starting dynamic subtest: D-eDP1
[509.767147] Dynamic subtest D-eDP1: SUCCESS (8.844s)
[509.773082] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.620s)
[511.018665] [081/131] (594s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[511.097048] Starting subtest: y-tiled-ccs-to-x-tiled
[511.101754] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[511.313587] [082/131] (593s left) kms_psr (fbc-psr2-no-drrs)
[511.422008] Starting subtest: fbc-psr2-no-drrs
[511.424269] Starting dynamic subtest: eDP-1
[511.428686] Dynamic subtest eDP-1: SKIP (0.000s)
[511.433138] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[511.521131] [083/131] (593s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[511.624550] Starting subtest: fbc-rgb565-draw-mmap-gtt
[511.628545] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[511.777013] [084/131] (593s left) kms_psr (psr-primary-render)
[511.874185] Starting subtest: psr-primary-render
[511.876586] Starting dynamic subtest: eDP-1
[513.583233] Dynamic subtest eDP-1: SUCCESS (1.709s)
[513.585645] Subtest psr-primary-render: SUCCESS (1.710s)
[514.471925] [085/131] (590s left) gem_softpin (evict-prime-sanity-check)
[514.540139] Starting subtest: evict-prime-sanity-check
[514.542676] Starting dynamic subtest: rcs0
[515.691413] Dynamic subtest rcs0: SUCCESS (1.150s)
[515.705075] Starting dynamic subtest: bcs0
[516.827653] Dynamic subtest bcs0: SUCCESS (1.135s)
[516.841679] Starting dynamic subtest: vcs0
[518.074334] Dynamic subtest vcs0: SUCCESS (1.243s)
[518.088292] Starting dynamic subtest: vcs1
[520.060807] Dynamic subtest vcs1: SUCCESS (1.984s)
[520.074110] Starting dynamic subtest: vecs0
[522.107307] Dynamic subtest vecs0: SUCCESS (2.043s)
[522.121082] Starting dynamic subtest: ccs0
[523.267503] Dynamic subtest ccs0: SUCCESS (1.159s)
[523.281442] Starting dynamic subtest: all
[524.413703] Dynamic subtest all: SUCCESS (1.143s)
[524.416398] Subtest evict-prime-sanity-check: SUCCESS (9.872s)
[524.520082] [086/131] (580s left) kms_content_protection (dp-mst-type-0)
[524.667771] Starting subtest: dp-mst-type-0
[524.672244] Subtest dp-mst-type-0: SKIP (0.000s)
[524.843429] [087/131] (580s left) gem_tiling_max_stride
[524.975268] [088/131] (580s left) kms_async_flips (async-flip-suspend-resume)
[525.080493] Starting subtest: async-flip-suspend-resume
[525.455543] Starting dynamic subtest: pipe-A-eDP-1
[543.254048] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.958s)
[543.633727] Starting dynamic subtest: pipe-B-eDP-1
[561.266415] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.884s)
[561.652078] Starting dynamic subtest: pipe-C-eDP-1
[579.283618] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.896s)
[579.663918] Starting dynamic subtest: pipe-D-eDP-1
[597.268557] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.883s)
[597.271428] Subtest async-flip-suspend-resume: SUCCESS (13.105s)
[598.493552] [089/131] (506s left) gem_exec_flush (basic-wb-ro-default)
[598.583142] Starting subtest: basic-wb-ro-default
[604.162510] Subtest basic-wb-ro-default: SUCCESS (5.504s)
[604.379013] [090/131] (501s left) gem_tiled_swapping (non-threaded)
[604.448424] Subtest non-threaded: SKIP (0.000s)
[604.519832] [091/131] (501s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[604.615668] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[609.262672] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.619s)
[610.413899] [092/131] (495s left) kms_lease (multimaster-lease)
[610.511154] Starting subtest: multimaster-lease
[610.516026] Subtest multimaster-lease: SUCCESS (0.007s)
[610.658758] [093/131] (494s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[610.759167] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[610.764314] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[611.941079] [094/131] (493s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[612.044330] Starting subtest: yf-tiled-8bpp-rotate-270
[612.050311] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[612.164967] [095/131] (493s left) kms_frontbuffer_tracking (psr-1p-rte)
[612.259766] Starting subtest: psr-1p-rte
[617.652801] Subtest psr-1p-rte: SUCCESS (5.381s)
[617.798821] [096/131] (487s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[622.793141] Starting subtest: psr2-overlay-plane-move-continuous-sf
[622.795491] Starting dynamic subtest: pipe-A-eDP-1
[629.507185] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.708s)
[629.517838] Starting dynamic subtest: pipe-B-eDP-1
[636.229505] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.721s)
[636.232692] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.433s)
[637.135688] [097/131] (468s left) gem_mmap_gtt (big-bo-tiledy)
[637.198289] Subtest big-bo-tiledY: SKIP (0.000s)
[637.267638] [098/131] (468s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[637.362194] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[637.364748] Starting dynamic subtest: pipe-A-eDP-1
[637.389415] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[637.400736] Starting dynamic subtest: pipe-B-eDP-1
[637.426047] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[637.436471] Starting dynamic subtest: pipe-C-eDP-1
[637.462234] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[637.473210] Starting dynamic subtest: pipe-D-eDP-1
[637.498753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[637.503201] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[639.694887] [099/131] (466s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[639.807179] Starting subtest: psr-2p-primscrn-spr-indfb-move
[639.812327] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[639.938058] [100/131] (465s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[640.052494] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[641.033430] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.982s)
[641.935931] [101/131] (464s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[642.038445] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[642.041227] Starting dynamic subtest: pipe-A-default-mode
[643.165199] Dynamic subtest pipe-A-default-mode: SKIP (1.125s)
[643.170358] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.126s)
[643.348310] [102/131] (462s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[643.411087] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[643.511425] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[643.613991] [103/131] (462s left) prime_vgem (fence-write-hang)
[643.695223] Subtest fence-write-hang: SKIP (0.000s)
[643.824302] [104/131] (462s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[643.919253] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[643.924467] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[644.034831] [105/131] (462s left) kms_psr (psr-cursor-blt)
[644.127123] Starting subtest: psr-cursor-blt
[644.129325] Starting dynamic subtest: eDP-1
[645.821132] Dynamic subtest eDP-1: SUCCESS (1.692s)
[645.823430] Subtest psr-cursor-blt: SUCCESS (1.693s)
[646.704702] [106/131] (459s left) gem_exec_schedule (fairslice)
[646.777910] Starting subtest: fairslice
[646.780466] Starting dynamic subtest: rcs0
[648.786485] Dynamic subtest rcs0: SUCCESS (2.019s)
[648.799307] Starting dynamic subtest: bcs0
[650.810500] Dynamic subtest bcs0: SUCCESS (2.020s)
[650.825159] Starting dynamic subtest: vcs0
[652.831671] Dynamic subtest vcs0: SUCCESS (2.019s)
[652.844651] Starting dynamic subtest: vcs1
[654.853871] Dynamic subtest vcs1: SUCCESS (2.020s)
[654.866267] Starting dynamic subtest: vecs0
[656.870477] Dynamic subtest vecs0: SUCCESS (2.018s)
[656.883127] Starting dynamic subtest: ccs0
[658.892262] Dynamic subtest ccs0: SUCCESS (2.021s)
[658.895178] Subtest fairslice: SUCCESS (12.122s)
[659.215429] [107/131] (447s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[659.322404] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[666.106682] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.784s)
[666.299849] [108/131] (439s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[666.370499] Starting subtest: etime-multi-wait-available-unsubmitted
[666.470982] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s)
[666.573572] [109/131] (439s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[671.488847] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[671.494314] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[672.371345] [110/131] (433s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[672.478746] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[672.483946] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[672.609472] [111/131] (433s left) api_intel_bb (offset-control)
[672.678103] Starting subtest: offset-control
[672.684378] Subtest offset-control: SUCCESS (0.009s)
[672.861585] [112/131] (433s left) i915_pm_rps (engine-order)
[672.929408] Starting subtest: engine-order
[677.865377] Subtest engine-order: SUCCESS (4.931s)
[678.018845] [113/131] (428s left) gem_ctx_persistence (engines-mixed)
[678.069055] Starting subtest: engines-mixed
[678.071744] Starting dynamic subtest: rcs0
[678.187838] Dynamic subtest rcs0: SUCCESS (0.118s)
[678.206170] Starting dynamic subtest: bcs0
[678.243417] Dynamic subtest bcs0: SUCCESS (0.053s)
[678.258769] Starting dynamic subtest: vcs0
[678.300385] Dynamic subtest vcs0: SUCCESS (0.056s)
[678.314529] Starting dynamic subtest: vcs1
[678.401427] Dynamic subtest vcs1: SUCCESS (0.099s)
[678.415895] Starting dynamic subtest: vecs0
[678.487492] Dynamic subtest vecs0: SUCCESS (0.084s)
[678.499737] Starting dynamic subtest: ccs0
[678.574429] Dynamic subtest ccs0: SUCCESS (0.084s)
[678.577219] Subtest engines-mixed: SUCCESS (0.507s)
[678.682841] [114/131] (427s left) kms_plane_scaling (2x-scaler-multi-pipe)
[678.787246] Starting subtest: 2x-scaler-multi-pipe
[678.792483] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[678.921798] [115/131] (427s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[679.033179] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[686.083250] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.050s)
[686.209346] [116/131] (420s left) gem_pread (snoop)
[686.277409] Subtest snoop: SKIP (0.000s)
[686.338293] [117/131] (420s left) gem_exec_capture (userptr)
[686.403351] Starting subtest: userptr
[687.221667] Subtest userptr: SUCCESS (0.815s)
[687.389801] [118/131] (419s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[687.490474] Starting subtest: 4-tiled-8bpp-rotate-180
[688.683255] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.192s)
[688.838404] [119/131] (417s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[688.939963] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[696.317392] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.378s)
[696.502709] [120/131] (410s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[696.607750] Starting subtest: y-tiled-16bpp-rotate-270
[696.613063] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[696.752610] [121/131] (410s left) kms_frontbuffer_tracking (fbc-stridechange)
[696.847949] Starting subtest: fbc-stridechange
[700.162236] Subtest fbc-stridechange: SUCCESS (3.319s)
[701.358391] [122/131] (405s left) kms_addfb_basic (basic)
[701.414238] Starting subtest: basic
[701.416413] Subtest basic: SUCCESS (0.000s)
[701.578993] [123/131] (405s left) gem_vm_create (create-ext)
[701.642338] Starting subtest: create-ext
[701.648273] Subtest create-ext: SUCCESS (0.006s)
[701.796881] [124/131] (405s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[701.892268] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[701.897257] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[702.027056] [125/131] (405s left) syncobj_timeline (multi-wait-available-submitted)
[702.084328] Starting subtest: multi-wait-available-submitted
[702.087263] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[702.199927] [126/131] (404s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[702.294076] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[702.298473] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[702.410878] [127/131] (404s left) syncobj_timeline (wait-for-submit-snapshot)
[702.466171] Starting subtest: wait-for-submit-snapshot
[702.545997] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[702.650948] [128/131] (404s left) kms_cursor_crc (cursor-onscreen-128x128)
[702.856915] Starting subtest: cursor-onscreen-128x128
[702.861259] Starting dynamic subtest: pipe-A-eDP-1
[704.968473] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[705.000817] Starting dynamic subtest: pipe-D-eDP-1
[707.814683] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.822s)
[707.817030] Subtest cursor-onscreen-128x128: SUCCESS (4.957s)
[708.713975] [129/131] (398s left) prime_mmap (test_invalid_sync_flags)
[708.773818] Starting subtest: test_invalid_sync_flags
[708.776309] Starting dynamic subtest: test_invalid_sync_flags-smem
[708.778962] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[708.781345] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[708.926003] [130/131] (398s left) gem_mmap_offset (pf-nonblock)
[708.992752] Starting subtest: pf-nonblock
[708.998543] Subtest pf-nonblock: SUCCESS (0.007s)
[709.163332] [131/131] (398s left) perf_pmu (most-busy-idle-check-all)
[709.202475] Starting subtest: most-busy-idle-check-all
[709.204865] Starting dynamic subtest: rcs0
[710.981251] Dynamic subtest rcs0: SUCCESS (1.778s)
[710.995811] Starting dynamic subtest: bcs0
[712.963896] Dynamic subtest bcs0: SUCCESS (1.980s)
[712.978489] Starting dynamic subtest: vcs0
[715.013068] Dynamic subtest vcs0: SUCCESS (2.046s)
[715.027738] Starting dynamic subtest: vcs1
[716.997302] Dynamic subtest vcs1: SUCCESS (1.981s)
[717.012670] Starting dynamic subtest: vecs0
[718.980741] Dynamic subtest vecs0: SUCCESS (1.981s)
[718.995720] Starting dynamic subtest: ccs0
[720.965261] Dynamic subtest ccs0: SUCCESS (1.981s)
[720.968314] Subtest most-busy-idle-check-all: SUCCESS (11.765s)
[721.114182] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_ccs
results: parsing output: 3/ for test: i915_hangman
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: gem_exercise_blt
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_getfb
results: parsing output: 10/ for test: sriov_basic
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: prime_mmap
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_universal_plane
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: sysfs_heartbeat_interval
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_unfence_active_buffers
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: dumb_buffer
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: kms_draw_crc
results: parsing output: 30/ for test: i915_query
results: parsing output: 31/ for test: kms_invalid_mode
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: i915_suspend
results: parsing output: 39/ for test: kms_vblank
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: kms_chamelium_audio
results: parsing output: 42/ for test: gem_close_race
results: parsing output: 43/ for test: kms_chamelium_edid
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_plane_cursor
results: parsing output: 48/ for test: core_auth
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_pm_dc
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: gem_gtt_cpu_tlb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_pxp
results: parsing output: 68/ for test: gem_ppgtt
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: syncobj_basic
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: sw_sync
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: kms_mmap_write_crc
results: parsing output: 78/ for test: kms_cursor_edge_walk
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_softpin
results: parsing output: 85/ for test: kms_content_protection
results: parsing output: 86/ for test: gem_tiling_max_stride
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: gem_exec_flush
results: parsing output: 89/ for test: gem_tiled_swapping
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_flip_scaled_crc
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: prime_vgem
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: i915_pm_rps
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_pread
results: parsing output: 116/ for test: gem_exec_capture
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: gem_vm_create
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: prime_mmap
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: perf_pmu
Done.