[57.443026] Initializing watchdogs
[57.443073]   /dev/watchdog0
[57.456461] [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]
[57.460639] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.462897] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.466371] [001/133] (960s left) gem_mmap (short-mmap)
[57.546450] Subtest short-mmap: SKIP (0.000s)
[57.606422] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[57.709329] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[57.713359] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.803553] [003/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[57.900775] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[57.903769] Starting dynamic subtest: pipe-A-eDP-1
[57.931811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.941934] Starting dynamic subtest: pipe-B-eDP-1
[57.963589] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.969755] Starting dynamic subtest: pipe-C-eDP-1
[57.991844] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.997957] Starting dynamic subtest: pipe-D-eDP-1
[58.020617] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.024982] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[60.141964] [004/133] (957s left) gem_ctx_shared (disjoint-timelines)
[60.199712] Starting subtest: disjoint-timelines
[60.240054] Subtest disjoint-timelines: SUCCESS (0.040s)
[60.481534] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[60.484706] [005/133] (957s left) gem_mmap_gtt (isolation)
[60.553284] Subtest isolation: SKIP (0.000s)
[60.606406] [006/133] (957s left) gem_userptr_blits (sync-unmap)
[60.672167] Starting subtest: sync-unmap
[60.686466] Subtest sync-unmap: SUCCESS (0.014s)
[60.814691] [007/133] (957s left) device_reset (unbind-cold-reset-rebind)
[60.863073] Starting subtest: unbind-cold-reset-rebind
[60.867769] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[60.949568] [008/133] (957s left) gem_mmap_gtt (medium-copy-odd)
[61.010168] Subtest medium-copy-odd: SKIP (0.000s)
[61.072906] [009/133] (957s left) gem_exec_params (invalid-bsd-ring)
[61.125796] Starting subtest: invalid-bsd-ring
[61.128055] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[61.213943] [010/133] (957s left) kms_psr (fbc-psr-cursor-plane-move)
[61.300155] Starting subtest: fbc-psr-cursor-plane-move
[61.302440] Starting dynamic subtest: eDP-1
[61.306720] Dynamic subtest eDP-1: SKIP (0.000s)
[61.311241] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[61.380300] [011/133] (956s left) gem_exec_params (rs-invalid)
[61.451285] Starting subtest: rs-invalid
[61.455516] Subtest rs-invalid: SUCCESS (0.003s)
[61.590136] [012/133] (956s left) kms_color (ctm-max)
[61.685061] Starting subtest: ctm-max
[61.686941] Starting dynamic subtest: pipe-A-eDP-1
[62.409495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[62.417732] Starting dynamic subtest: pipe-B-eDP-1
[63.868757] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.457s)
[63.877314] Starting dynamic subtest: pipe-C-eDP-1
[65.249649] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[65.256916] Starting dynamic subtest: pipe-D-eDP-1
[66.586053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[66.588398] Subtest ctm-max: SUCCESS (4.889s)
[67.418717] [013/133] (951s left) kms_hdr (brightness-with-hdr)
[67.546471] Starting subtest: brightness-with-hdr
[67.553367] Subtest brightness-with-hdr: SKIP (0.000s)
[67.637378] [014/133] (950s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[67.733103] Starting subtest: yf-tiled-ccs-to-x-tiled
[67.737865] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[67.922514] [015/133] (950s left) gem_exec_reloc (basic-wc)
[67.987298] Subtest basic-wc: SKIP (0.000s)
[68.119737] [016/133] (950s left) gem_userptr_blits (dmabuf-sync)
[68.189237] Starting subtest: dmabuf-sync
[68.193913] Subtest dmabuf-sync: SKIP (0.003s)
[68.335728] [017/133] (950s left) kms_psr (fbc-pr-primary-blt)
[68.430435] Starting subtest: fbc-pr-primary-blt
[68.435191] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[68.528078] [018/133] (950s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[68.620592] Starting subtest: fbcpsr-tiling-4
[75.665952] Subtest fbcpsr-tiling-4: SUCCESS (7.043s)
[75.794795] [019/133] (942s left) gem_create (create-ext-cpu-access-sanity-check)
[75.973076] Starting subtest: create-ext-cpu-access-sanity-check
[75.978246] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[76.048719] [020/133] (942s left) i915_pm_rpm (gem-mmap-type)
[78.100461] Starting subtest: gem-mmap-type
[78.103586] Starting dynamic subtest: wb-smem0
[81.272754] Dynamic subtest wb-smem0: SUCCESS (3.171s)
[81.287828] Starting dynamic subtest: wc-smem0
[84.164599] Dynamic subtest wc-smem0: SUCCESS (2.891s)
[84.171801] Starting dynamic subtest: uc-smem0
[87.338555] Dynamic subtest uc-smem0: SUCCESS (3.173s)
[87.340852] Subtest gem-mmap-type: SUCCESS (9.236s)
[87.455606] [021/133] (931s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[87.553410] Starting subtest: nonblocking-crc-frame-sequence
[87.555708] Starting dynamic subtest: pipe-A-eDP-1
[88.323267] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.769s)
[88.332060] Starting dynamic subtest: pipe-B-eDP-1
[89.692326] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.366s)
[89.700769] Starting dynamic subtest: pipe-C-eDP-1
[91.086470] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[91.095066] Starting dynamic subtest: pipe-D-eDP-1
[92.413945] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[92.416485] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.859s)
[93.215389] [022/133] (925s left) kms_big_fb (linear-64bpp-rotate-0)
[93.330791] Starting subtest: linear-64bpp-rotate-0
[94.943262] Subtest linear-64bpp-rotate-0: SUCCESS (1.613s)
[95.111652] [023/133] (923s left) kms_atomic (plane-immutable-zpos)
[95.206164] Starting subtest: plane-immutable-zpos
[95.208518] Starting dynamic subtest: pipe-A-eDP-1
[95.835513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[95.837809] Subtest plane-immutable-zpos: SUCCESS (0.630s)
[96.653447] [024/133] (922s left) gem_lmem_swapping (random-engines)
[96.709277] Subtest random-engines: SKIP (0.000s)
[96.756530] [025/133] (922s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[97.050128] Starting subtest: cursor-rapid-movement-512x170
[97.054625] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[97.167537] [026/133] (921s left) kms_chamelium_color (ctm-blue-to-red)
[97.267095] Subtest ctm-blue-to-red: SKIP (0.000s)
[97.312811] [027/133] (921s left) gem_softpin (invalid)
[97.375636] Starting subtest: invalid
[97.383418] Subtest invalid: SUCCESS (0.006s)
[97.486340] [028/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[97.578580] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[97.582732] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[97.676805] [029/133] (921s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[97.771918] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[104.774773] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.004s)
[104.874878] [030/133] (914s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[104.965633] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[104.967989] Starting dynamic subtest: pipe-A-eDP-1
[121.571619] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.557s)
[121.581465] Starting dynamic subtest: pipe-B-eDP-1
[138.541883] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.428s)
[138.551075] Starting dynamic subtest: pipe-C-eDP-1
[155.472947] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.393s)
[155.482882] Starting dynamic subtest: pipe-D-eDP-1
[172.479121] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.340s)
[172.481725] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.723s)
[173.628851] [031/133] (845s left) api_intel_bb (intel-bb-blit-x)
[173.708030] Starting subtest: intel-bb-blit-x
[177.436368] Subtest intel-bb-blit-x: SUCCESS (3.681s)
[177.556170] [032/133] (841s left) kms_draw_crc (draw-method-pwrite)
[177.658256] Starting subtest: draw-method-pwrite
[177.660643] Starting dynamic subtest: xrgb8888-untiled
[178.229895] Dynamic subtest xrgb8888-untiled: SUCCESS (0.567s)
[178.241623] Starting dynamic subtest: rgb565-untiled
[178.700644] Dynamic subtest rgb565-untiled: SUCCESS (0.465s)
[178.709098] Starting dynamic subtest: xrgb2101010-untiled
[179.250295] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.542s)
[179.268490] Starting dynamic subtest: xbgr16161616f-untiled
[180.023304] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.766s)
[180.031996] Starting dynamic subtest: xrgb8888-xtiled
[181.767018] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.731s)
[181.775395] Starting dynamic subtest: rgb565-xtiled
[182.817278] Dynamic subtest rgb565-xtiled: SUCCESS (1.044s)
[182.826985] Starting dynamic subtest: xrgb2101010-xtiled
[184.569883] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.742s)
[184.579134] Starting dynamic subtest: xbgr16161616f-xtiled
[187.802980] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.222s)
[187.813745] Starting dynamic subtest: xrgb8888-4tiled
[188.873602] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.066s)
[188.890252] Starting dynamic subtest: rgb565-4tiled
[189.430651] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s)
[189.441464] Starting dynamic subtest: xrgb2101010-4tiled
[190.499362] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.066s)
[190.508189] Starting dynamic subtest: xbgr16161616f-4tiled
[193.450004] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.944s)
[193.452468] Subtest draw-method-pwrite: SUCCESS (15.723s)
[193.555917] [033/133] (825s left) kms_plane_scaling (planes-downscale-factor-0-5)
[193.655209] Starting subtest: planes-downscale-factor-0-5
[193.657786] Starting dynamic subtest: pipe-A
[193.679450] Dynamic subtest pipe-A: SKIP (0.017s)
[193.687710] Starting dynamic subtest: pipe-B
[193.709998] Dynamic subtest pipe-B: SKIP (0.030s)
[193.727769] Starting dynamic subtest: pipe-C
[193.739167] Dynamic subtest pipe-C: SKIP (0.030s)
[193.756659] Starting dynamic subtest: pipe-D
[193.774600] Dynamic subtest pipe-D: SKIP (0.030s)
[193.780237] Subtest planes-downscale-factor-0-5: SKIP (0.109s)
[193.868536] [034/133] (825s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[193.978089] Starting subtest: cursorA-vs-flipA-atomic
[205.104614] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.117s)
[205.907328] [035/133] (813s left) gem_exec_schedule (noreorder)
[206.102106] Starting subtest: noreorder
[206.104961] Starting dynamic subtest: rcs0
[206.171464] Dynamic subtest rcs0: SUCCESS (0.069s)
[206.181746] Starting dynamic subtest: vcs0
[207.548320] Dynamic subtest vcs0: SUCCESS (1.373s)
[207.563384] Starting dynamic subtest: vcs1
[209.575986] Dynamic subtest vcs1: SUCCESS (2.025s)
[209.587860] Starting dynamic subtest: vecs0
[211.581438] Dynamic subtest vecs0: SUCCESS (2.003s)
[211.596354] Starting dynamic subtest: ccs0
[211.646254] Dynamic subtest ccs0: SUCCESS (0.063s)
[211.649480] Subtest noreorder: SUCCESS (5.543s)
[211.839244] [036/133] (807s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[211.958229] Starting subtest: cursor-vs-flip-varying-size
[242.772982] Subtest cursor-vs-flip-varying-size: SUCCESS (30.802s)
[243.657780] [037/133] (775s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[243.765070] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[243.770073] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[243.861278] [038/133] (775s left) kms_pm_rpm (modeset-pc8-residency-stress)
[245.697453] Starting subtest: modeset-pc8-residency-stress
[245.702892] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[246.093987] [039/133] (773s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[246.193816] Starting subtest: primary-yf-tiled-reflect-x-270
[246.199005] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[246.271984] [040/133] (773s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[246.329437] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[246.335234] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[246.520823] [041/133] (773s left) gem_close_race (basic-process)
[246.585223] Starting subtest: basic-process
[246.629873] Subtest basic-process: SUCCESS (0.045s)
[246.816571] [042/133] (772s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[246.915037] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[246.920186] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[247.010660] [043/133] (772s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[247.065752] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[247.135143] [044/133] (772s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[247.235347] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[247.238264] Starting dynamic subtest: A-eDP1
[250.839179] Dynamic subtest A-eDP1: SUCCESS (3.602s)
[250.848888] Starting dynamic subtest: B-eDP1
[254.027005] Dynamic subtest B-eDP1: SUCCESS (3.186s)
[254.035982] Starting dynamic subtest: C-eDP1
[257.144301] Dynamic subtest C-eDP1: SUCCESS (3.115s)
[257.153453] Starting dynamic subtest: D-eDP1
[260.234467] Dynamic subtest D-eDP1: SUCCESS (3.087s)
[260.237480] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.997s)
[261.052737] [045/133] (758s left) gem_ctx_persistence (file)
[261.109039] Starting subtest: file
[261.218105] Subtest file: SUCCESS (0.109s)
[261.332124] [046/133] (758s left) kms_cursor_edge_walk (64x64-right-edge)
[261.423229] Starting subtest: 64x64-right-edge
[261.425970] Starting dynamic subtest: pipe-A-eDP-1
[264.915756] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[264.925473] Starting dynamic subtest: pipe-D-eDP-1
[268.030890] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[268.033735] Subtest 64x64-right-edge: SUCCESS (6.608s)
[268.838345] [047/133] (751s left) kms_psr (psr2-basic)
[268.933133] Starting subtest: psr2-basic
[268.935599] Starting dynamic subtest: eDP-1
[270.513436] Dynamic subtest eDP-1: SUCCESS (1.580s)
[270.516178] Subtest psr2-basic: SUCCESS (1.581s)
[271.312911] [048/133] (748s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[271.373345] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[271.375785] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[271.465818] [049/133] (748s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[271.567394] Starting subtest: bad-aux-stride-yf-tiled-ccs
[271.570156] Starting dynamic subtest: pipe-A-eDP-1
[271.596691] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.606388] Starting dynamic subtest: pipe-B-eDP-1
[271.633167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.641487] Starting dynamic subtest: pipe-C-eDP-1
[271.667343] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.675436] Starting dynamic subtest: pipe-D-eDP-1
[271.700436] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.705479] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.008s)
[273.861085] [050/133] (746s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[273.963992] Starting subtest: pr-cursor-plane-move-continuous-sf
[273.969104] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[274.033176] [051/133] (746s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[274.090382] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[274.197525] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[274.272708] [052/133] (745s left) kms_vblank (ts-continuation-dpms-suspend)
[274.359853] Starting subtest: ts-continuation-dpms-suspend
[274.362302] Starting dynamic subtest: pipe-A-eDP-1
[290.897554] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[290.911880] Starting dynamic subtest: pipe-D-eDP-1
[308.875492] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.469s)
[308.878124] Subtest ts-continuation-dpms-suspend: SUCCESS (4.360s)
[309.701029] [053/133] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[309.806289] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[309.811700] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[309.912092] [054/133] (710s left) kms_sequence (get-forked)
[309.997173] Starting subtest: get-forked
[310.000065] Starting dynamic subtest: pipe-A-eDP-1
[311.914845] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s)
[311.929457] Starting dynamic subtest: pipe-B-eDP-1
[314.521887] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.575s)
[314.531678] Starting dynamic subtest: pipe-C-eDP-1
[317.029100] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.484s)
[317.039080] Starting dynamic subtest: pipe-D-eDP-1
[319.591116] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[319.594124] Subtest get-forked: SUCCESS (9.502s)
[320.431089] [055/133] (699s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[320.530760] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[328.044096] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.493s)
[328.174136] [056/133] (692s left) i915_hangman (engine-engine-hang)
[328.244109] Starting subtest: engine-engine-hang
[328.246569] Starting dynamic subtest: rcs0
[329.664675] Dynamic subtest rcs0: SUCCESS (1.418s)
[329.676738] Starting dynamic subtest: bcs0
[331.644903] Dynamic subtest bcs0: SUCCESS (1.974s)
[331.657061] Starting dynamic subtest: vcs0
[333.628706] Dynamic subtest vcs0: SUCCESS (1.979s)
[333.640670] Starting dynamic subtest: vcs1
[335.677744] Dynamic subtest vcs1: SUCCESS (2.044s)
[335.690277] Starting dynamic subtest: vecs0
[337.660622] Dynamic subtest vecs0: SUCCESS (1.978s)
[337.674685] Starting dynamic subtest: ccs0
[339.644713] Dynamic subtest ccs0: SUCCESS (1.981s)
[339.647594] Subtest engine-engine-hang: SUCCESS (11.391s)
[339.728442] [057/133] (680s left) gem_exec_balancer (bonded-false-hang)
[339.994768] Starting subtest: bonded-false-hang
[340.000711] Subtest bonded-false-hang: SKIP (0.000s)
[340.101943] [058/133] (680s left) kms_psr (psr-sprite-blt)
[340.192102] Starting subtest: psr-sprite-blt
[340.194465] Starting dynamic subtest: eDP-1
[341.899466] Dynamic subtest eDP-1: SUCCESS (1.708s)
[341.902022] Subtest psr-sprite-blt: SUCCESS (1.709s)
[342.722296] [059/133] (677s left) gem_exec_schedule (semaphore-resolve)
[342.809710] Starting subtest: semaphore-resolve
[342.850567] Subtest semaphore-resolve: SUCCESS (0.045s)
[343.181490] [060/133] (677s left) kms_flip (flip-vs-fences)
[343.270319] Starting subtest: flip-vs-fences
[343.274517] Subtest flip-vs-fences: SKIP (0.000s)
[343.375239] [061/133] (677s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[343.430530] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[343.501001] [062/133] (677s left) kms_chamelium_hpd (dp-hpd)
[343.877253] Subtest dp-hpd: SKIP (0.000s)
[344.729802] [063/133] (675s left) gem_mmap_gtt (basic-read)
[344.789891] Subtest basic-read: SKIP (0.000s)
[344.858655] [064/133] (675s left) kms_pm_backlight (basic-brightness)
[344.948983] Starting subtest: basic-brightness
[344.998849] Starting dynamic subtest: eDP-1
[345.502963] Dynamic subtest eDP-1: SUCCESS (0.503s)
[345.505891] Subtest basic-brightness: SUCCESS (0.556s)
[346.373435] [065/133] (674s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[346.503875] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[346.508892] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[346.647632] [066/133] (674s left) gem_exec_whisper (basic-normal-all)
[346.708079] Starting subtest: basic-normal-all
[348.952829] Subtest basic-normal-all: SUCCESS (2.243s)
[349.140079] [067/133] (671s left) gem_watchdog (default-virtual)
[349.216740] Starting subtest: default-virtual
[355.497423] Subtest default-virtual: SUCCESS (6.293s)
[355.591359] [068/133] (665s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[355.689400] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[355.715874] Starting dynamic subtest: pipe-A-plane-0
[356.004259] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[356.021085] Starting dynamic subtest: pipe-A-plane-3
[356.238240] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[356.249574] Starting dynamic subtest: pipe-A-plane-5
[356.253874] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[357.365175] Starting dynamic subtest: pipe-B-plane-0
[357.661641] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[357.671250] Starting dynamic subtest: pipe-B-plane-3
[357.891807] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[357.903955] Starting dynamic subtest: pipe-B-plane-5
[357.908869] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[358.211389] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.524s)
[359.039485] [069/133] (661s left) api_intel_allocator (fork-simple-once)
[359.097793] Starting subtest: fork-simple-once
[359.109883] Subtest fork-simple-once: SUCCESS (0.015s)
[359.223534] [070/133] (661s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[359.347250] Starting subtest: cursorA-vs-flipB-toggle
[359.351880] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[359.493680] [071/133] (661s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[359.609492] Starting subtest: 2x-cursor-vs-flip-atomic
[359.614043] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[359.755461] [072/133] (661s left) kms_flip (flip-vs-panning-interruptible)
[359.851371] Starting subtest: flip-vs-panning-interruptible
[359.853771] Starting dynamic subtest: A-eDP1
[368.546855] Dynamic subtest A-eDP1: SUCCESS (8.695s)
[368.556074] Starting dynamic subtest: B-eDP1
[377.274703] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[377.286880] Starting dynamic subtest: C-eDP1
[385.996139] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[386.005286] Starting dynamic subtest: D-eDP1
[394.728800] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[394.732828] Subtest flip-vs-panning-interruptible: SUCCESS (34.877s)
[395.903282] [073/133] (625s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[396.009904] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[396.014834] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[396.110733] [074/133] (625s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[396.208045] Starting subtest: x-tiled-32bpp-rotate-270
[396.227046] Subtest x-tiled-32bpp-rotate-270: SKIP (0.018s)
[396.355336] [075/133] (624s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[396.427849] Starting subtest: single-wait-all-for-submit-available-signaled
[396.430520] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[396.519847] [076/133] (624s left) i915_suspend (basic-s2idle-without-i915)
[396.560516] Starting subtest: basic-s2idle-without-i915
[415.733016] Subtest basic-s2idle-without-i915: SUCCESS (4.009s)
[415.849563] [077/133] (605s left) kms_vblank (wait-idle-hang)
[415.960968] Starting subtest: wait-idle-hang
[415.962880] Starting dynamic subtest: pipe-A-eDP-1
[443.597727] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.485s)
[443.613327] Starting dynamic subtest: pipe-D-eDP-1
[458.557876] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.961s)
[458.560159] Subtest wait-idle-hang: SUCCESS (42.451s)
[459.363110] [078/133] (561s left) gem_exec_reloc (basic-wc-read)
[459.453483] Subtest basic-wc-read: SKIP (0.000s)
[459.538025] [079/133] (561s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[459.662802] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[459.667014] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[459.849118] [080/133] (561s left) sw_sync (alloc_fence_invalid_timeline)
[459.895306] Starting subtest: alloc_fence_invalid_timeline
[459.897155] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[459.955804] [081/133] (561s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[460.047517] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[460.049775] Starting dynamic subtest: pipe-A-eDP-1
[460.073762] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[460.081987] Starting dynamic subtest: pipe-B-eDP-1
[460.107106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[460.117728] Starting dynamic subtest: pipe-C-eDP-1
[460.140841] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[460.148951] Starting dynamic subtest: pipe-D-eDP-1
[460.172890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[460.177292] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.013s)
[462.322051] [082/133] (559s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[462.418167] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[466.711372] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.296s)
[467.850574] [083/133] (553s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[467.973575] Starting subtest: basic-busy-flip-before-cursor-atomic
[467.977980] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[468.131082] [084/133] (553s left) kms_invalid_mode (zero-vdisplay)
[468.226060] Starting subtest: zero-vdisplay
[468.228434] Starting dynamic subtest: pipe-A-eDP-1
[468.513978] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[468.524605] Starting dynamic subtest: pipe-B-eDP-1
[468.527113] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[468.534764] Starting dynamic subtest: pipe-C-eDP-1
[468.537151] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[468.547896] Starting dynamic subtest: pipe-D-eDP-1
[468.550418] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[468.552777] Subtest zero-vdisplay: SUCCESS (0.292s)
[469.360434] [085/133] (552s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[469.457961] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[469.461922] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[469.533955] [086/133] (552s left) sysfs_timeslice_duration (idempotent)
[469.593912] Starting subtest: idempotent
[469.596155] Starting dynamic subtest: vecs0
[469.598287] Dynamic subtest vecs0: SUCCESS (0.000s)
[469.607314] Starting dynamic subtest: ccs0
[469.609461] Dynamic subtest ccs0: SUCCESS (0.000s)
[469.617611] Starting dynamic subtest: vcs0
[469.619518] Dynamic subtest vcs0: SUCCESS (0.000s)
[469.629841] Starting dynamic subtest: bcs0
[469.631962] Dynamic subtest bcs0: SUCCESS (0.000s)
[469.639610] Starting dynamic subtest: rcs0
[469.641760] Dynamic subtest rcs0: SUCCESS (0.000s)
[469.649293] Starting dynamic subtest: vcs1
[469.651374] Dynamic subtest vcs1: SUCCESS (0.000s)
[469.653480] Subtest idempotent: SUCCESS (0.006s)
[469.689980] [087/133] (551s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[469.784683] Starting subtest: yf-tiled-16bpp-rotate-0
[469.788989] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[469.889248] [088/133] (551s left) gem_mmap (pf-nonblock)
[469.935347] Subtest pf-nonblock: SKIP (0.000s)
[469.994729] [089/133] (551s left) gem_ctx_persistence (engines-mixed)
[470.053993] Starting subtest: engines-mixed
[470.056300] Starting dynamic subtest: rcs0
[470.133365] Dynamic subtest rcs0: SUCCESS (0.079s)
[470.147104] Starting dynamic subtest: bcs0
[470.181365] Dynamic subtest bcs0: SUCCESS (0.046s)
[470.192820] Starting dynamic subtest: vcs0
[470.229305] Dynamic subtest vcs0: SUCCESS (0.046s)
[470.240298] Starting dynamic subtest: vcs1
[470.276414] Dynamic subtest vcs1: SUCCESS (0.045s)
[470.286783] Starting dynamic subtest: vecs0
[470.326345] Dynamic subtest vecs0: SUCCESS (0.048s)
[470.336281] Starting dynamic subtest: ccs0
[470.372030] Dynamic subtest ccs0: SUCCESS (0.044s)
[470.374297] Subtest engines-mixed: SUCCESS (0.319s)
[470.462251] [090/133] (551s left) gem_ccs (block-multicopy-compressed)
[470.509258] Starting subtest: block-multicopy-compressed
[470.513126] Subtest block-multicopy-compressed: SKIP (0.000s)
[470.607052] [091/133] (551s left) syncobj_wait (single-wait-for-submit-signaled)
[470.674512] Starting subtest: single-wait-for-submit-signaled
[470.676571] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[470.780800] [092/133] (551s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[470.865606] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[471.250574] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[474.043070] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[474.051954] Starting dynamic subtest: pipe-A-eDP-1-4
[476.253723] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[476.261744] Starting dynamic subtest: pipe-A-eDP-1-4
[478.239589] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[478.248179] Starting dynamic subtest: pipe-A-eDP-1-x
[480.419525] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[480.802731] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[483.582936] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[483.591460] Starting dynamic subtest: pipe-B-eDP-1-4
[485.766242] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.182s)
[485.778422] Starting dynamic subtest: pipe-B-eDP-1-4
[487.776497] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[487.787416] Starting dynamic subtest: pipe-B-eDP-1-x
[489.967621] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[490.332395] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[493.117138] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[493.128858] Starting dynamic subtest: pipe-C-eDP-1-4
[495.302098] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.183s)
[495.313464] Starting dynamic subtest: pipe-C-eDP-1-4
[497.312541] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[497.323902] Starting dynamic subtest: pipe-C-eDP-1-x
[499.492457] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[499.863918] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[502.647477] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[502.659027] Starting dynamic subtest: pipe-D-eDP-1-4
[504.822464] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[504.832495] Starting dynamic subtest: pipe-D-eDP-1-4
[506.832881] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[506.842376] Starting dynamic subtest: pipe-D-eDP-1-x
[509.012374] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[509.014718] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.136s)
[510.240505] [093/133] (511s left) kms_flip (nonblocking-read)
[510.340082] Starting subtest: nonblocking-read
[510.342320] Subtest nonblocking-read: SUCCESS (0.000s)
[510.443673] [094/133] (511s left) prime_busy (after)
[510.499634] Starting subtest: after
[510.505178] Starting dynamic subtest: rcs0
[510.534919] Dynamic subtest rcs0: SUCCESS (0.032s)
[510.545149] Starting dynamic subtest: bcs0
[510.575216] Dynamic subtest bcs0: SUCCESS (0.039s)
[510.584240] Starting dynamic subtest: vcs0
[510.616378] Dynamic subtest vcs0: SUCCESS (0.041s)
[510.625380] Starting dynamic subtest: vcs1
[510.657487] Dynamic subtest vcs1: SUCCESS (0.040s)
[510.666361] Starting dynamic subtest: vecs0
[510.698478] Dynamic subtest vecs0: SUCCESS (0.040s)
[510.707434] Starting dynamic subtest: ccs0
[510.738208] Dynamic subtest ccs0: SUCCESS (0.039s)
[510.847464] Subtest after: SUCCESS (0.346s)
[510.934495] [095/133] (511s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[511.016574] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[511.018911] Starting dynamic subtest: pipe-A-eDP-1
[511.040536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[511.050671] Starting dynamic subtest: pipe-B-eDP-1
[511.071120] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[511.079419] Starting dynamic subtest: pipe-C-eDP-1
[511.099070] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[511.107055] Starting dynamic subtest: pipe-D-eDP-1
[511.126738] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[511.128943] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[513.271126] [096/133] (508s left) gem_exec_balancer (waits)
[513.342342] Starting subtest: waits
[519.773799] Subtest waits: SUCCESS (6.434s)
[520.078078] [097/133] (502s left) kms_cursor_crc (cursor-onscreen-64x21)
[520.280656] Starting subtest: cursor-onscreen-64x21
[520.327209] Subtest cursor-onscreen-64x21: SKIP (0.044s)
[520.552505] [098/133] (501s left) kms_content_protection (uevent)
[520.678765] Starting subtest: uevent
[520.683312] Subtest uevent: SKIP (0.000s)
[520.814292] [099/133] (501s left) gem_exec_fence (syncobj-invalid-flags)
[521.254466] Starting subtest: syncobj-invalid-flags
[521.256386] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[522.900646] [100/133] (499s left) gem_partial_pwrite_pread (write-snoop)
[522.956505] Subtest write-snoop: SKIP (0.000s)
[523.021317] [101/133] (499s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[523.108684] Starting subtest: 4-tiled-64bpp-rotate-90
[523.128503] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[523.220187] [102/133] (499s left) i915_drm_fdinfo (all-busy-check-all)
[523.254352] Starting subtest: all-busy-check-all
[523.261311] Subtest all-busy-check-all: SKIP (0.004s)
[523.332233] [103/133] (499s left) kms_lease (simple-lease)
[523.473023] Starting subtest: simple-lease
[523.475268] Starting dynamic subtest: pipe-A-eDP-1
[523.986423] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.512s)
[523.994868] Starting dynamic subtest: pipe-B-eDP-1
[525.394041] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[525.403018] Starting dynamic subtest: pipe-C-eDP-1
[526.783107] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[526.793248] Starting dynamic subtest: pipe-D-eDP-1
[528.194012] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[528.196404] Subtest simple-lease: SUCCESS (4.724s)
[529.001268] [104/133] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[529.100323] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[529.104660] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[529.204374] [105/133] (493s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[529.260044] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[529.368360] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[529.447583] [106/133] (493s left) gem_softpin (evict-prime-sanity-check)
[529.506307] Starting subtest: evict-prime-sanity-check
[529.508573] Starting dynamic subtest: rcs0
[530.681542] Dynamic subtest rcs0: SUCCESS (1.175s)
[530.692067] Starting dynamic subtest: bcs0
[531.816876] Dynamic subtest bcs0: SUCCESS (1.133s)
[531.827783] Starting dynamic subtest: vcs0
[533.822195] Dynamic subtest vcs0: SUCCESS (2.002s)
[533.831295] Starting dynamic subtest: vcs1
[535.788389] Dynamic subtest vcs1: SUCCESS (1.963s)
[535.799133] Starting dynamic subtest: vecs0
[537.854325] Dynamic subtest vecs0: SUCCESS (2.064s)
[537.865957] Starting dynamic subtest: ccs0
[538.990925] Dynamic subtest ccs0: SUCCESS (1.135s)
[539.001811] Starting dynamic subtest: all
[540.121744] Dynamic subtest all: SUCCESS (1.129s)
[540.124400] Subtest evict-prime-sanity-check: SUCCESS (10.617s)
[540.200648] [107/133] (482s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[540.324973] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[547.656934] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.336s)
[547.793159] [108/133] (474s left) perf (sysctl-defaults)
[547.873554] Starting subtest: sysctl-defaults
[547.876294] Subtest sysctl-defaults: SUCCESS (0.000s)
[547.957160] [109/133] (474s left) perf_pmu (init-wait)
[547.995508] Starting subtest: init-wait
[547.997684] Starting dynamic subtest: rcs0
[547.999862] Dynamic subtest rcs0: SUCCESS (0.002s)
[548.009317] Starting dynamic subtest: bcs0
[548.011434] Dynamic subtest bcs0: SUCCESS (0.000s)
[548.019692] Starting dynamic subtest: vcs0
[548.021876] Dynamic subtest vcs0: SUCCESS (0.001s)
[548.029981] Starting dynamic subtest: vcs1
[548.032104] Dynamic subtest vcs1: SUCCESS (0.001s)
[548.040149] Starting dynamic subtest: vecs0
[548.042419] Dynamic subtest vecs0: SUCCESS (0.001s)
[548.050477] Starting dynamic subtest: ccs0
[548.052360] Dynamic subtest ccs0: SUCCESS (0.000s)
[548.054662] Subtest init-wait: SUCCESS (0.008s)
[548.099634] [110/133] (474s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[548.193773] Starting subtest: plane-all-transition-nonblocking-fencing
[548.195959] Starting dynamic subtest: pipe-A-eDP-1
[550.690545] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[550.996364] Starting dynamic subtest: pipe-B-eDP-1
[554.252051] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.264s)
[554.553856] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.360s)
[555.381226] [111/133] (467s left) gem_exec_whisper (basic-sync)
[555.454329] Starting subtest: basic-sync
[562.186551] Subtest basic-sync: SUCCESS (6.729s)
[562.373921] [112/133] (460s left) gem_exec_reloc (basic-write-gtt)
[562.437805] Subtest basic-write-gtt: SKIP (0.000s)
[562.510706] [113/133] (460s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[562.615974] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[562.618349] Starting dynamic subtest: pipe-A-default-mode
[565.323680] Dynamic subtest pipe-A-default-mode: SUCCESS (2.706s)
[565.326099] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.707s)
[566.200040] [114/133] (456s left) syncobj_timeline (multi-wait-available-signaled)
[566.253688] Starting subtest: multi-wait-available-signaled
[566.255895] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[566.356295] [115/133] (456s left) kms_psr (psr2-primary-mmap-cpu)
[566.439993] Starting subtest: psr2-primary-mmap-cpu
[566.442314] Starting dynamic subtest: eDP-1
[568.170780] Dynamic subtest eDP-1: SUCCESS (1.729s)
[568.173069] Subtest psr2-primary-mmap-cpu: SUCCESS (1.730s)
[569.040044] [116/133] (453s left) gem_ctx_param (invalid-param-get)
[569.087573] Starting subtest: invalid-param-get
[569.090464] Subtest invalid-param-get: SUCCESS (0.001s)
[569.184043] [117/133] (453s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[569.281127] Starting subtest: y-tiled-8bpp-rotate-0
[569.285263] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[569.374481] [118/133] (453s left) syncobj_wait (multi-wait-submitted)
[569.433185] Starting subtest: multi-wait-submitted
[569.535351] Subtest multi-wait-submitted: SUCCESS (0.103s)
[569.628268] [119/133] (453s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[569.722996] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[573.472565] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.753s)
[574.648146] [120/133] (448s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[574.747555] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[574.758818] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[574.870061] [121/133] (448s left) kms_plane_scaling (intel-max-src-size)
[574.971598] Starting subtest: intel-max-src-size
[574.978696] Subtest intel-max-src-size: SKIP (0.000s)
[575.072122] [122/133] (448s left) gem_fence_thrash (bo-write-verify-threaded-none)
[575.108924] Starting subtest: bo-write-verify-threaded-none
[575.130310] Subtest bo-write-verify-threaded-none: SKIP (0.018s)
[575.192645] [123/133] (447s left) syncobj_timeline (etime-single-wait-all-submitted)
[575.240734] Starting subtest: etime-single-wait-all-submitted
[575.344729] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[575.432410] [124/133] (447s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[575.526825] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[579.666806] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.142s)
[580.839511] [125/133] (442s left) gen9_exec_parse (bb-start-cmd)
[580.905429] Subtest bb-start-cmd: SKIP (0.000s)
[580.981052] [126/133] (442s left) kms_rotation_crc (bad-pixel-format)
[581.065766] Starting subtest: bad-pixel-format
[581.070073] Subtest bad-pixel-format: SKIP (0.001s)
[581.159419] [127/133] (442s left) kms_atomic_interruptible (universal-setplane-cursor)
[581.243803] Starting subtest: universal-setplane-cursor
[581.246024] Starting dynamic subtest: pipe-A-eDP-1
[588.631994] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.386s)
[588.634352] Subtest universal-setplane-cursor: SUCCESS (7.387s)
[589.488513] [128/133] (433s left) kms_psr (fbc-pr-sprite-render)
[589.589777] Starting subtest: fbc-pr-sprite-render
[589.593869] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[589.660327] [129/133] (433s left) kms_plane_lowres (tiling-none)
[589.750690] Starting subtest: tiling-none
[589.752973] Starting dynamic subtest: pipe-A-eDP-1
[589.757426] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[590.045981] Starting dynamic subtest: pipe-B-eDP-1
[590.050633] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[590.059406] Starting dynamic subtest: pipe-C-eDP-1
[590.064075] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[590.072662] Starting dynamic subtest: pipe-D-eDP-1
[590.076962] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[590.081319] Subtest tiling-none: SKIP (0.294s)
[590.915920] [130/133] (432s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[591.291188] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[592.136089] [131/133] (431s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[592.224982] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[592.227364] Starting dynamic subtest: pipe-A-default-mode
[594.986410] Dynamic subtest pipe-A-default-mode: SUCCESS (2.759s)
[594.988560] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.761s)
[595.838825] [132/133] (427s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[595.936949] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[595.940843] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[596.030516] [133/133] (427s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[596.129084] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[603.234959] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.098s)
[603.359785] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_ctx_shared
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: device_reset
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_hdr
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_create
results: parsing output: 19/ for test: i915_pm_rpm
results: parsing output: 20/ for test: kms_pipe_crc_basic
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_atomic
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_chamelium_color
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: kms_draw_crc
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: gem_close_race
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_fenced_exec_thrash
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_ctx_persistence
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_sequence
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: i915_hangman
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: kms_pm_backlight
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: gem_watchdog
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: api_intel_allocator
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: i915_suspend
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: sw_sync
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_invalid_mode
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: sysfs_timeslice_duration
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_mmap
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: gem_ccs
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: prime_busy
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: gem_partial_pwrite_pread
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: perf
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_atomic_transition
results: parsing output: 110/ for test: gem_exec_whisper
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_ctx_param
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: kms_rotation_crc
results: parsing output: 126/ for test: kms_atomic_interruptible
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_plane_lowres
results: parsing output: 129/ for test: kms_chamelium_edid
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.