[59.577500] Initializing watchdogs
[59.577547]   /dev/watchdog0
[59.591342] [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]
[59.595640] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.598266] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.601844] [001/132] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[59.722642] Starting subtest: psr-rgb565-draw-mmap-wc
[66.423701] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.713s)
[66.543837] [002/132] (953s left) i915_drm_fdinfo (virtual-busy-all)
[66.586514] Starting subtest: virtual-busy-all
[66.591310] Subtest virtual-busy-all: SKIP (0.000s)
[66.652706] [003/132] (953s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[66.823138] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[66.827588] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[66.967843] [004/132] (953s left) kms_pm_backlight (fade-with-dpms)
[67.110456] Starting subtest: fade-with-dpms
[69.322306] Starting dynamic subtest: eDP-1
[71.836847] Dynamic subtest eDP-1: SUCCESS (2.512s)
[71.838996] Subtest fade-with-dpms: SUCCESS (4.728s)
[72.710686] [005/132] (947s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[72.767019] Starting subtest: multi-wait-all-for-submit-unsubmitted
[72.872382] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[72.943702] [006/132] (947s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[73.053017] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[73.057389] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[73.206792] [007/132] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[73.308390] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[73.312734] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[73.406399] [008/132] (946s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[73.498038] Starting subtest: plane-lut1d-pre-ctm3x4
[73.621417] Starting dynamic subtest: pipe-A-plane-0
[73.776871] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[73.785676] Starting dynamic subtest: pipe-A-plane-1
[73.921041] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[73.928724] Starting dynamic subtest: pipe-A-plane-2
[74.098333] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[75.367075] Starting dynamic subtest: pipe-B-plane-0
[75.506070] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[75.514193] Starting dynamic subtest: pipe-B-plane-1
[75.639432] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[75.646451] Starting dynamic subtest: pipe-B-plane-2
[75.775584] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[76.947622] Starting dynamic subtest: pipe-C-plane-0
[77.076070] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[77.086414] Starting dynamic subtest: pipe-C-plane-1
[77.219823] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[77.228236] Starting dynamic subtest: pipe-C-plane-2
[77.364579] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[78.594471] Starting dynamic subtest: pipe-D-plane-0
[78.741382] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[78.750281] Starting dynamic subtest: pipe-D-plane-1
[78.874803] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[78.883154] Starting dynamic subtest: pipe-D-plane-2
[79.030745] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[79.328142] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.832s)
[80.163229] [009/132] (940s left) kms_selftest (drm_plane_helper)
[80.205891] Starting subtest: drm_plane_helper
[80.215743] Starting dynamic subtest: drm_test_check_plane_state
[80.311424] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.096s)
[80.319557] Starting dynamic subtest: drm_test_check_invalid_plane_state
[80.406052] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.093s)
[80.408222] Subtest drm_plane_helper: SUCCESS (0.198s)
[80.539575] [010/132] (939s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[80.647685] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[80.652032] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[80.728844] [011/132] (939s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[80.828643] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[80.830836] Starting dynamic subtest: pipe-A
[80.855258] Dynamic subtest pipe-A: SKIP (0.022s)
[80.865625] Starting dynamic subtest: pipe-B
[80.885692] Dynamic subtest pipe-B: SKIP (0.030s)
[80.895822] Starting dynamic subtest: pipe-C
[80.917596] Dynamic subtest pipe-C: SKIP (0.030s)
[80.924672] Starting dynamic subtest: pipe-D
[80.948237] Dynamic subtest pipe-D: SKIP (0.030s)
[80.951855] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.114s)
[81.025630] [012/132] (939s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[81.079063] Starting subtest: x-tiled-to-vebox-y-tiled
[81.083601] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[81.256795] [013/132] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[81.352076] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[81.356725] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[81.444155] [014/132] (939s left) syncobj_eventfd (invalid-illegal-eventfd)
[81.505067] Starting subtest: invalid-illegal-eventfd
[81.507201] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[81.631099] [015/132] (938s left) syncobj_wait (reset-during-wait-for-submit)
[81.685038] Starting subtest: reset-during-wait-for-submit
[81.789448] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[81.862382] [016/132] (938s left) perf (blocking)
[81.984255] Starting subtest: blocking
[81.986252] Starting dynamic subtest: 0-rcs0
[92.000855] Dynamic subtest 0-rcs0: SUCCESS (10.015s)
[92.008502] Starting dynamic subtest: 1-vcs0
[102.022732] Dynamic subtest 1-vcs0: SUCCESS (10.021s)
[102.025081] Subtest blocking: SUCCESS (20.037s)
[102.066595] [017/132] (918s left) gem_exec_parallel (userptr)
[102.125443] Starting subtest: userptr
[102.127858] Starting dynamic subtest: rcs0
[103.655799] Dynamic subtest rcs0: SUCCESS (1.530s)
[103.666054] Starting dynamic subtest: bcs0
[105.159446] Dynamic subtest bcs0: SUCCESS (1.503s)
[105.167667] Starting dynamic subtest: vcs0
[106.913176] Dynamic subtest vcs0: SUCCESS (1.752s)
[106.921166] Starting dynamic subtest: vcs1
[108.883117] Dynamic subtest vcs1: SUCCESS (1.968s)
[108.893415] Starting dynamic subtest: vecs0
[110.934303] Dynamic subtest vecs0: SUCCESS (2.049s)
[110.945046] Starting dynamic subtest: ccs0
[112.404352] Dynamic subtest ccs0: SUCCESS (1.470s)
[112.406739] Subtest userptr: SUCCESS (10.280s)
[112.586187] [018/132] (908s left) fbdev (read)
[112.628574] Starting subtest: read
[113.158464] Subtest read: SUCCESS (0.528s)
[113.215334] [019/132] (907s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[113.316699] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[113.321218] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[113.444050] [020/132] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[113.533895] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[113.538328] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[113.625425] [021/132] (907s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[113.718865] Starting subtest: primary-x-tiled-reflect-x-0
[120.672255] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.956s)
[121.819998] [022/132] (899s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[121.923679] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[128.814329] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.894s)
[128.953458] [023/132] (891s left) kms_plane_alpha_blend (coverage-7efc)
[129.042722] Starting subtest: coverage-7efc
[129.327648] Starting dynamic subtest: pipe-A-eDP-1
[129.928533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[129.954437] Starting dynamic subtest: pipe-D-eDP-1
[131.282181] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[131.284454] Subtest coverage-7efc: SUCCESS (2.242s)
[132.109292] [024/132] (888s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[132.216856] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[133.150717] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.934s)
[133.268715] [025/132] (887s left) gem_exec_flush (basic-wb-rw-default)
[133.328321] Starting subtest: basic-wb-rw-default
[138.775386] Subtest basic-wb-rw-default: SUCCESS (5.448s)
[138.957277] [026/132] (882s left) kms_content_protection (lic-type-0)
[139.096109] Starting subtest: lic-type-0
[139.100777] Subtest lic-type-0: SKIP (0.000s)
[139.220445] [027/132] (881s left) kms_debugfs (display-on-read-all)
[139.302912] Starting subtest: display-on-read-all
[139.469192] Subtest display-on-read-all: SUCCESS (0.166s)
[139.584841] [028/132] (881s left) kms_lease (lease-invalid-connector)
[139.674241] Starting subtest: lease-invalid-connector
[139.676458] Starting dynamic subtest: pipe-A-eDP-1
[139.678676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[139.685943] Starting dynamic subtest: pipe-B-eDP-1
[139.687822] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[139.695149] Starting dynamic subtest: pipe-C-eDP-1
[139.697238] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[139.704718] Starting dynamic subtest: pipe-D-eDP-1
[139.706783] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[139.708616] Subtest lease-invalid-connector: SUCCESS (0.003s)
[139.743911] [029/132] (881s left) kms_plane (plane-panning-bottom-right-suspend)
[139.832941] Starting subtest: plane-panning-bottom-right-suspend
[139.835290] Starting dynamic subtest: pipe-A
[157.446089] Dynamic subtest pipe-A: SUCCESS (2.872s)
[157.455173] Starting dynamic subtest: pipe-B
[176.470986] Dynamic subtest pipe-B: SUCCESS (3.563s)
[176.473322] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.438s)
[177.333732] [030/132] (843s left) gem_exec_flush (basic-wb-set-default)
[177.391881] Starting subtest: basic-wb-set-default
[182.808339] Subtest basic-wb-set-default: SUCCESS (5.459s)
[182.996650] [031/132] (838s left) kms_chamelium_color (ctm-max)
[183.101849] Subtest ctm-max: SKIP (0.000s)
[183.141521] [032/132] (838s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[183.244424] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[183.248720] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[183.326959] [033/132] (837s left) gem_exec_balancer (bonded-false-hang)
[183.578302] Starting subtest: bonded-false-hang
[183.583183] Subtest bonded-false-hang: SKIP (0.000s)
[183.680970] [034/132] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[183.773461] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[190.480650] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.733s)
[190.599980] [035/132] (830s left) gem_exec_reloc (basic-write-wc)
[190.659637] Subtest basic-write-wc: SKIP (0.000s)
[190.728874] [036/132] (830s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[190.832339] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[197.328640] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.509s)
[197.425682] [037/132] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[197.522379] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[204.355655] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.843s)
[204.480195] [038/132] (817s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[204.571899] Starting subtest: blocking-absolute-wf_vblank-interruptible
[204.574238] Starting dynamic subtest: A-eDP1
[213.255256] Dynamic subtest A-eDP1: SUCCESS (8.678s)
[213.263355] Starting dynamic subtest: B-eDP1
[221.984581] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[222.000629] Starting dynamic subtest: C-eDP1
[230.709366] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[230.718005] Starting dynamic subtest: D-eDP1
[239.431901] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[239.436927] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.859s)
[240.642010] [039/132] (780s left) gem_exec_fence (syncobj-invalid-flags)
[241.129558] Starting subtest: syncobj-invalid-flags
[241.132240] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[242.250499] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[242.254115] [040/132] (779s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[242.351911] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[242.354205] Starting dynamic subtest: pipe-A-eDP-1
[242.377609] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.388569] Starting dynamic subtest: pipe-B-eDP-1
[242.410365] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.417947] Starting dynamic subtest: pipe-C-eDP-1
[242.440165] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.450530] Starting dynamic subtest: pipe-D-eDP-1
[242.472448] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.476953] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[244.602340] [041/132] (777s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[244.672854] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[244.744039] [042/132] (776s left) kms_addfb_basic (too-wide)
[244.832749] Starting subtest: too-wide
[244.834941] Subtest too-wide: SUCCESS (0.000s)
[244.938515] [043/132] (776s left) i915_hangman (gt-engine-hang)
[245.001625] Starting subtest: gt-engine-hang
[245.003594] Starting dynamic subtest: rcs0
[246.099092] Dynamic subtest rcs0: SUCCESS (1.096s)
[246.111412] Starting dynamic subtest: bcs0
[248.081406] Dynamic subtest bcs0: SUCCESS (1.980s)
[248.093801] Starting dynamic subtest: vcs0
[250.128071] Dynamic subtest vcs0: SUCCESS (2.044s)
[250.139497] Starting dynamic subtest: vcs1
[252.112354] Dynamic subtest vcs1: SUCCESS (1.982s)
[252.124154] Starting dynamic subtest: vecs0
[254.097194] Dynamic subtest vecs0: SUCCESS (1.982s)
[254.108909] Starting dynamic subtest: ccs0
[256.081383] Dynamic subtest ccs0: SUCCESS (1.982s)
[256.084130] Subtest gt-engine-hang: SUCCESS (11.084s)
[256.165310] [044/132] (765s left) gen3_render_mixed_blits
[256.290510] [045/132] (765s left) api_intel_allocator (reserve-simple)
[256.351289] Starting subtest: reserve-simple
[256.354180] Subtest reserve-simple: SUCCESS (0.005s)
[256.466910] [046/132] (765s left) kms_draw_crc (draw-method-mmap-gtt)
[256.559518] Starting subtest: draw-method-mmap-gtt
[256.563931] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[256.647429] [047/132] (765s left) kms_atomic_transition (plane-all-transition-fencing)
[256.743446] Starting subtest: plane-all-transition-fencing
[256.745806] Starting dynamic subtest: pipe-A-eDP-1
[259.239834] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[259.548325] Starting dynamic subtest: pipe-B-eDP-1
[262.733301] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.196s)
[263.033571] Subtest plane-all-transition-fencing: SUCCESS (6.292s)
[263.851733] [048/132] (758s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[263.909333] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[263.913590] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[264.089844] [049/132] (757s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[264.238667] Starting subtest: cursor-rapid-movement-32x32
[264.291355] Subtest cursor-rapid-movement-32x32: SKIP (0.049s)
[264.573853] [050/132] (757s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[264.635682] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[264.638383] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[264.731409] [051/132] (757s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[264.823390] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[264.825605] Starting dynamic subtest: pipe-A-default-mode
[267.592933] Dynamic subtest pipe-A-default-mode: SUCCESS (2.768s)
[267.595219] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.771s)
[268.448669] [052/132] (753s left) gem_eio (wait-1us)
[268.658701] Starting subtest: wait-1us
[268.960082] Subtest wait-1us: SUCCESS (0.303s)
[269.078472] [053/132] (753s left) gem_exec_balancer (parallel-keep-in-fence)
[269.337994] Starting subtest: parallel-keep-in-fence
[270.467546] Subtest parallel-keep-in-fence: SUCCESS (1.130s)
[270.584919] [054/132] (751s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[270.672261] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[277.974245] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.301s)
[278.096590] [055/132] (744s left) kms_atomic (plane-invalid-params)
[278.191065] Starting subtest: plane-invalid-params
[278.193308] Starting dynamic subtest: pipe-A-eDP-1
[278.581455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.386s)
[278.583689] Subtest plane-invalid-params: SUCCESS (0.388s)
[279.396397] [056/132] (742s left) gem_eio (banned)
[279.628481] Starting subtest: banned
[280.241702] Subtest banned: SUCCESS (0.613s)
[280.397656] [057/132] (741s left) i915_pm_rpm (system-suspend-devices)
[282.323859] Starting subtest: system-suspend-devices
[290.011422] Subtest system-suspend-devices: SUCCESS (7.689s)
[290.391101] [058/132] (731s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[290.494823] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[291.106504] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.614s)
[291.246118] [059/132] (731s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[291.341440] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[298.353602] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.016s)
[299.494508] [060/132] (722s left) kms_psr (psr2-cursor-plane-move)
[299.591790] Starting subtest: psr2-cursor-plane-move
[299.593946] Starting dynamic subtest: eDP-1
[301.271144] Dynamic subtest eDP-1: SUCCESS (1.678s)
[301.273380] Subtest psr2-cursor-plane-move: SUCCESS (1.680s)
[302.079462] [061/132] (720s left) gem_exec_schedule (preemptive-hang)
[302.250796] Starting subtest: preemptive-hang
[302.253542] Starting dynamic subtest: rcs0
[311.259535] Dynamic subtest rcs0: SUCCESS (9.011s)
[311.270584] Starting dynamic subtest: bcs0
[320.283484] Dynamic subtest bcs0: SUCCESS (9.021s)
[320.296241] Starting dynamic subtest: vcs0
[329.311907] Dynamic subtest vcs0: SUCCESS (9.029s)
[329.325610] Starting dynamic subtest: vcs1
[338.331824] Dynamic subtest vcs1: SUCCESS (9.019s)
[338.341323] Starting dynamic subtest: vecs0
[347.287141] Dynamic subtest vecs0: SUCCESS (8.957s)
[347.295837] Starting dynamic subtest: ccs0
[356.251830] Dynamic subtest ccs0: SUCCESS (8.964s)
[356.254497] Subtest preemptive-hang: SUCCESS (54.012s)
[356.485923] [062/132] (665s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[356.594993] Starting subtest: fbc-rgb101010-draw-render
[361.177508] Subtest fbc-rgb101010-draw-render: SUCCESS (4.586s)
[362.359112] [063/132] (660s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[362.459186] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[362.461340] Starting dynamic subtest: pipe-A-eDP-1
[378.916195] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.465s)
[378.925003] Starting dynamic subtest: pipe-B-eDP-1
[396.107146] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.191s)
[396.109460] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.660s)
[396.905444] [064/132] (625s left) syncobj_timeline (signal-array)
[396.965321] Starting subtest: signal-array
[396.967465] Subtest signal-array: SUCCESS (0.000s)
[397.072584] [065/132] (625s left) sysfs_timeslice_duration (timeout)
[397.134560] Starting subtest: timeout
[397.136924] Starting dynamic subtest: vecs0
[407.149786] Dynamic subtest vecs0: SUCCESS (10.013s)
[407.161316] Starting dynamic subtest: ccs0
[408.342052] Dynamic subtest ccs0: SUCCESS (1.192s)
[408.353614] Starting dynamic subtest: vcs0
[418.160663] Dynamic subtest vcs0: SUCCESS (9.819s)
[418.171716] Starting dynamic subtest: bcs0
[418.777319] Dynamic subtest bcs0: SUCCESS (0.616s)
[418.789719] Starting dynamic subtest: rcs0
[419.944364] Dynamic subtest rcs0: SUCCESS (1.165s)
[419.955783] Starting dynamic subtest: vcs1
[428.141591] Dynamic subtest vcs1: SUCCESS (8.197s)
[428.144180] Subtest timeout: SUCCESS (31.012s)
[428.218663] [066/132] (594s left) kms_flip (2x-plain-flip)
[428.326139] Starting subtest: 2x-plain-flip
[428.338671] Subtest 2x-plain-flip: SKIP (0.014s)
[428.421197] [067/132] (594s left) kms_chamelium_color (ctm-red-to-blue)
[428.516091] Subtest ctm-red-to-blue: SKIP (0.000s)
[428.563621] [068/132] (594s left) kms_vblank (ts-continuation-suspend)
[428.660842] Starting subtest: ts-continuation-suspend
[428.662961] Starting dynamic subtest: pipe-A-eDP-1
[445.335813] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.534s)
[445.349967] Starting dynamic subtest: pipe-D-eDP-1
[462.329061] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.182s)
[462.331563] Subtest ts-continuation-suspend: SUCCESS (3.720s)
[463.127007] [069/132] (559s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[463.241657] Starting subtest: bad-rotation-90-y-tiled-ccs
[463.244268] Starting dynamic subtest: pipe-A-eDP-1
[463.267851] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[463.277983] Starting dynamic subtest: pipe-B-eDP-1
[463.302812] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[463.311532] Starting dynamic subtest: pipe-C-eDP-1
[463.337176] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[463.345889] Starting dynamic subtest: pipe-D-eDP-1
[463.372029] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[463.377524] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[465.464337] [070/132] (557s left) gem_pxp (create-regular-context-1)
[465.582977] Starting subtest: create-regular-context-1
[465.585954] Subtest create-regular-context-1: SUCCESS (0.002s)
[465.699460] [071/132] (557s left) gem_close_race (multigpu-basic-process)
[465.778505] Starting subtest: multigpu-basic-process
[465.784206] Subtest multigpu-basic-process: SKIP (0.000s)
[466.002144] [072/132] (556s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[466.136067] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[466.138447] Starting dynamic subtest: pipe-A-eDP-1
[466.282040] Dynamic subtest pipe-A-eDP-1: SKIP (0.150s)
[466.292876] Starting dynamic subtest: pipe-B-eDP-1
[467.444465] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s)
[467.449726] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.322s)
[468.631308] [073/132] (554s left) kms_chamelium_hpd (hdmi-hpd-fast)
[469.016479] Subtest hdmi-hpd-fast: SKIP (0.000s)
[469.840574] [074/132] (553s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[469.889495] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[469.978317] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.014s)
[470.020531] [075/132] (552s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[470.114588] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[470.120254] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[470.215185] [076/132] (552s left) kms_joiner (invalid-modeset-force-big-joiner)
[470.319535] Starting subtest: invalid-modeset-force-big-joiner
[470.324517] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[470.395109] [077/132] (552s left) kms_rotation_crc (primary-rotation-270)
[470.487113] Starting subtest: primary-rotation-270
[470.491687] Subtest primary-rotation-270: SKIP (0.001s)
[470.563322] [078/132] (552s left) gem_eio (wait-wedge-1us)
[470.781299] Starting subtest: wait-wedge-1us
[472.209645] Subtest wait-wedge-1us: SUCCESS (1.432s)
[472.336071] [079/132] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[472.430691] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[479.065166] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.652s)
[479.190851] [080/132] (544s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[479.280389] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[479.283119] Starting dynamic subtest: pipe-A-eDP-1
[479.351218] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[479.360705] Starting dynamic subtest: pipe-B-eDP-1
[479.428201] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[479.437970] Starting dynamic subtest: pipe-C-eDP-1
[479.506235] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[479.516660] Starting dynamic subtest: pipe-D-eDP-1
[479.588475] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[479.594431] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[481.551270] [081/132] (541s left) gem_ppgtt (flink-and-close-vma-leak)
[481.617656] Starting subtest: flink-and-close-vma-leak
[481.661263] Subtest flink-and-close-vma-leak: SUCCESS (0.043s)
[481.774975] [082/132] (541s left) kms_psr (fbc-psr-cursor-plane-move)
[481.869452] Starting subtest: fbc-psr-cursor-plane-move
[481.872428] Starting dynamic subtest: eDP-1
[481.877481] Dynamic subtest eDP-1: SKIP (0.000s)
[481.882913] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[481.944671] [083/132] (541s left) gem_exec_flush (basic-batch-kernel-default-uc)
[482.003681] Starting subtest: basic-batch-kernel-default-uc
[489.367484] Subtest basic-batch-kernel-default-uc: SUCCESS (7.372s)
[489.554513] [084/132] (533s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[489.659942] Starting subtest: y-tiled-16bpp-rotate-180
[489.664951] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[489.782175] [085/132] (533s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[489.826979] Starting subtest: etime-multi-wait-all-submitted-signaled
[489.929239] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[490.018835] [086/132] (533s left) gem_lmem_swapping (random)
[490.061513] Subtest random: SKIP (0.000s)
[490.103559] [087/132] (533s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[490.190486] Starting subtest: async-flip-with-page-flip-events-linear
[490.575569] Starting dynamic subtest: pipe-A-eDP-1
[493.322021] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.748s)
[493.685600] Starting dynamic subtest: pipe-B-eDP-1
[496.457228] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.777s)
[496.820808] Starting dynamic subtest: pipe-C-eDP-1
[499.596984] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.781s)
[499.956526] Starting dynamic subtest: pipe-D-eDP-1
[502.727465] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[502.730341] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.538s)
[503.907650] [088/132] (519s left) gem_partial_pwrite_pread (writes-after-reads-display)
[503.970714] Subtest writes-after-reads-display: SKIP (0.000s)
[504.046667] [089/132] (519s left) kms_setmode (invalid-clone-exclusive-crtc)
[504.095144] Starting subtest: invalid-clone-exclusive-crtc
[504.103235] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[504.192464] [090/132] (519s left) gem_exec_whisper (basic-queues-forked)
[504.244680] Starting subtest: basic-queues-forked
[526.922670] Subtest basic-queues-forked: SUCCESS (22.677s)
[527.105223] [091/132] (496s left) gem_exec_whisper (basic-fds-priority)
[527.175936] Starting subtest: basic-fds-priority
[552.595646] Subtest basic-fds-priority: SUCCESS (25.424s)
[552.779507] [092/132] (470s left) gem_ctx_shared (single-timeline)
[552.844732] Starting subtest: single-timeline
[552.876387] Subtest single-timeline: SUCCESS (0.029s)
[553.119148] [093/132] (470s left) gem_exec_schedule (semaphore-codependency)
[553.196924] Starting subtest: semaphore-codependency
[553.212475] Subtest semaphore-codependency: SUCCESS (0.025s)
[553.579267] [094/132] (470s left) perf_pmu (busy-hang)
[553.622683] Starting subtest: busy-hang
[553.625523] Starting dynamic subtest: rcs0
[554.866931] Dynamic subtest rcs0: SUCCESS (1.246s)
[554.880891] Starting dynamic subtest: bcs0
[556.103513] Dynamic subtest bcs0: SUCCESS (1.232s)
[556.115152] Starting dynamic subtest: vcs0
[558.606559] Dynamic subtest vcs0: SUCCESS (2.501s)
[558.616740] Starting dynamic subtest: vcs1
[560.645579] Dynamic subtest vcs1: SUCCESS (2.040s)
[560.658658] Starting dynamic subtest: vecs0
[562.631508] Dynamic subtest vecs0: SUCCESS (1.983s)
[562.644658] Starting dynamic subtest: ccs0
[563.860464] Dynamic subtest ccs0: SUCCESS (1.226s)
[563.863530] Subtest busy-hang: SUCCESS (10.238s)
[563.967319] [095/132] (459s left) gem_mmap_gtt (basic-write-read-distinct)
[564.033457] Subtest basic-write-read-distinct: SKIP (0.000s)
[564.089146] [096/132] (459s left) gem_ctx_isolation (dirty-create)
[564.144702] Starting subtest: dirty-create
[564.147469] Starting dynamic subtest: rcs0
[564.402244] Dynamic subtest rcs0: SUCCESS (0.256s)
[564.413758] Starting dynamic subtest: bcs0
[564.667110] Dynamic subtest bcs0: SUCCESS (0.264s)
[564.678307] Starting dynamic subtest: vcs0
[564.938472] Dynamic subtest vcs0: SUCCESS (0.271s)
[564.950228] Starting dynamic subtest: vcs1
[566.311700] Dynamic subtest vcs1: SUCCESS (1.371s)
[566.323709] Starting dynamic subtest: vecs0
[568.350102] Dynamic subtest vecs0: SUCCESS (2.037s)
[568.361924] Starting dynamic subtest: ccs0
[570.334045] Dynamic subtest ccs0: SUCCESS (1.982s)
[570.336575] Subtest dirty-create: SUCCESS (6.187s)
[570.578999] [097/132] (453s left) gem_mmap_gtt (hang-user)
[570.639526] Subtest hang-user: SKIP (0.000s)
[570.695821] [098/132] (453s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[570.809769] Starting subtest: flip-vs-cursor-atomic
[577.878541] Subtest flip-vs-cursor-atomic: SUCCESS (7.068s)
[578.737106] [099/132] (445s left) kms_cursor_crc (cursor-offscreen-512x512)
[579.029521] Starting subtest: cursor-offscreen-512x512
[579.034583] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[579.199554] [100/132] (444s left) kms_plane_lowres (tiling-none)
[579.293659] Starting subtest: tiling-none
[579.296381] Starting dynamic subtest: pipe-A-eDP-1
[579.301568] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[579.598611] Starting dynamic subtest: pipe-B-eDP-1
[579.603323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[579.613080] Starting dynamic subtest: pipe-C-eDP-1
[579.617642] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[579.627552] Starting dynamic subtest: pipe-D-eDP-1
[579.632517] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[579.637501] Subtest tiling-none: SKIP (0.305s)
[580.399986] [101/132] (443s left) gem_wait (busy)
[580.459177] Starting subtest: busy
[580.461990] Starting dynamic subtest: all-engines
[582.085932] Dynamic subtest all-engines: SUCCESS (1.625s)
[582.099438] Starting dynamic subtest: rcs0
[582.628032] Dynamic subtest rcs0: SUCCESS (0.541s)
[582.640492] Starting dynamic subtest: bcs0
[583.169492] Dynamic subtest bcs0: SUCCESS (0.541s)
[583.181716] Starting dynamic subtest: vcs0
[585.093058] Dynamic subtest vcs0: SUCCESS (1.921s)
[585.104835] Starting dynamic subtest: vcs1
[587.141392] Dynamic subtest vcs1: SUCCESS (2.044s)
[587.154676] Starting dynamic subtest: vecs0
[589.060835] Dynamic subtest vecs0: SUCCESS (1.916s)
[589.073533] Starting dynamic subtest: ccs0
[589.603767] Dynamic subtest ccs0: SUCCESS (0.541s)
[589.606388] Subtest busy: SUCCESS (9.145s)
[589.808156] [102/132] (434s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[589.866265] Starting subtest: y-tiled-ccs-to-x-tiled
[589.871520] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[590.053632] [103/132] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[590.177452] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[590.183146] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[590.277968] [104/132] (433s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[590.368955] Starting subtest: yf-tiled-64bpp-rotate-90
[590.374095] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[590.455082] [105/132] (433s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[590.550221] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[591.707294] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.156s)
[591.816035] [106/132] (432s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[591.906155] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[591.908049] Starting dynamic subtest: pipe-A-eDP-1
[594.017444] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[594.027456] Starting dynamic subtest: pipe-B-eDP-1
[596.267832] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.250s)
[596.277549] Starting dynamic subtest: pipe-C-eDP-1
[598.351566] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.083s)
[598.361730] Starting dynamic subtest: pipe-D-eDP-1
[600.479216] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.126s)
[600.481479] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.575s)
[601.638675] [107/132] (422s left) kms_flip (2x-flip-vs-suspend-interruptible)
[601.738602] Starting subtest: 2x-flip-vs-suspend-interruptible
[601.749922] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[601.849481] [108/132] (422s left) syncobj_wait (signal)
[601.908606] Starting subtest: signal
[601.911414] Subtest signal: SUCCESS (0.000s)
[602.009047] [109/132] (422s left) dumb_buffer (create-clear)
[602.063275] Starting subtest: create-clear
[636.399364] Subtest create-clear: SUCCESS (34.338s)
[636.501757] [110/132] (388s left) gen9_exec_parse (bb-start-cmd)
[636.550156] Subtest bb-start-cmd: SKIP (0.000s)
[636.618792] [111/132] (387s left) perf_pmu (invalid-init)
[636.658513] Starting subtest: invalid-init
[636.661093] Subtest invalid-init: SUCCESS (0.000s)
[636.750423] [112/132] (387s left) api_intel_bb (reset-flags)
[636.806430] Starting subtest: reset-flags
[636.816367] Subtest reset-flags: SUCCESS (0.012s)
[636.931117] [113/132] (387s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[637.035481] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[637.040581] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[637.123380] [114/132] (387s left) gem_mmap_gtt (basic-write-read)
[637.181435] Subtest basic-write-read: SKIP (0.000s)
[637.239787] [115/132] (387s left) perf_pmu (busy-accuracy-50)
[637.286388] Starting subtest: busy-accuracy-50
[637.288984] Starting dynamic subtest: rcs0
[638.818488] Dynamic subtest rcs0: SUCCESS (1.531s)
[638.830914] Starting dynamic subtest: bcs0
[640.365436] Dynamic subtest bcs0: SUCCESS (1.545s)
[640.376265] Starting dynamic subtest: vcs0
[641.909674] Dynamic subtest vcs0: SUCCESS (1.542s)
[641.919652] Starting dynamic subtest: vcs1
[643.448212] Dynamic subtest vcs1: SUCCESS (1.536s)
[643.460180] Starting dynamic subtest: vecs0
[644.985059] Dynamic subtest vecs0: SUCCESS (1.536s)
[644.996217] Starting dynamic subtest: ccs0
[646.536518] Dynamic subtest ccs0: SUCCESS (1.548s)
[646.539298] Subtest busy-accuracy-50: SUCCESS (9.253s)
[646.653445] [116/132] (378s left) gem_ctx_persistence (saturated-hostile)
[646.716936] Starting subtest: saturated-hostile
[646.719574] Starting dynamic subtest: rcs0
[647.552464] Dynamic subtest rcs0: SUCCESS (0.835s)
[647.566572] Starting dynamic subtest: bcs0
[648.346376] Dynamic subtest bcs0: SUCCESS (0.792s)
[648.359911] Starting dynamic subtest: vcs0
[649.152003] Dynamic subtest vcs0: SUCCESS (0.803s)
[649.165159] Starting dynamic subtest: vcs1
[649.946441] Dynamic subtest vcs1: SUCCESS (0.793s)
[649.959813] Starting dynamic subtest: vecs0
[650.744211] Dynamic subtest vecs0: SUCCESS (0.796s)
[650.758032] Starting dynamic subtest: ccs0
[651.571327] Dynamic subtest ccs0: SUCCESS (0.825s)
[651.574512] Subtest saturated-hostile: SUCCESS (4.855s)
[651.653495] [117/132] (373s left) kms_psr (fbc-psr2-dpms)
[651.746830] Starting subtest: fbc-psr2-dpms
[651.749296] Starting dynamic subtest: eDP-1
[651.754422] Dynamic subtest eDP-1: SKIP (0.000s)
[651.759655] Subtest fbc-psr2-dpms: SKIP (0.001s)
[651.819444] [118/132] (373s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[651.916667] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[651.922539] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[652.012830] [119/132] (372s left) kms_psr (pr-cursor-blt)
[652.108683] Starting subtest: pr-cursor-blt
[652.114442] Subtest pr-cursor-blt: SKIP (0.000s)
[652.193415] [120/132] (372s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[652.297418] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[652.303078] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[652.376592] [121/132] (372s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[652.481200] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[653.491542] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.012s)
[653.614062] [122/132] (371s left) kms_psr (psr-suspend)
[653.703946] Starting subtest: psr-suspend
[653.705817] Starting dynamic subtest: eDP-1
[671.477587] Dynamic subtest eDP-1: SUCCESS (2.914s)
[671.480368] Subtest psr-suspend: SUCCESS (2.915s)
[672.333687] [123/132] (352s left) gem_softpin (evict-active-interruptible)
[672.400824] Starting subtest: evict-active-interruptible
[672.407156] Subtest evict-active-interruptible: SUCCESS (0.007s)
[672.526311] [124/132] (352s left) kms_properties (colorop-properties-legacy)
[672.612995] Starting subtest: colorop-properties-legacy
[672.615794] Starting dynamic subtest: pipe-A-eDP-1
[672.943324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.335s)
[672.955042] Starting dynamic subtest: pipe-B-eDP-1
[673.985260] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[673.997913] Starting dynamic subtest: pipe-C-eDP-1
[675.021207] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.046s)
[675.034607] Starting dynamic subtest: pipe-D-eDP-1
[676.049333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.033s)
[676.052131] Subtest colorop-properties-legacy: SUCCESS (3.466s)
[676.854386] [125/132] (348s left) kms_flip (2x-flip-vs-fences)
[676.954964] Starting subtest: 2x-flip-vs-fences
[676.960141] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[677.030869] [126/132] (348s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[677.132089] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[677.137654] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[677.239833] [127/132] (347s left) gem_softpin (zero)
[677.294101] Starting subtest: zero
[677.299478] Subtest zero: SUCCESS (0.005s)
[677.406843] [128/132] (347s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[677.462190] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[677.464888] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[677.560033] [129/132] (347s left) gem_exec_parallel (basic)
[677.610991] Starting subtest: basic
[677.613406] Starting dynamic subtest: rcs0
[679.361198] Dynamic subtest rcs0: SUCCESS (1.758s)
[679.377329] Starting dynamic subtest: bcs0
[681.069359] Dynamic subtest bcs0: SUCCESS (1.714s)
[681.079557] Starting dynamic subtest: vcs0
[682.960628] Dynamic subtest vcs0: SUCCESS (1.895s)
[682.971033] Starting dynamic subtest: vcs1
[684.945834] Dynamic subtest vcs1: SUCCESS (1.988s)
[684.956367] Starting dynamic subtest: vecs0
[686.993289] Dynamic subtest vecs0: SUCCESS (2.050s)
[687.006383] Starting dynamic subtest: ccs0
[688.808275] Dynamic subtest ccs0: SUCCESS (1.816s)
[688.811260] Subtest basic: SUCCESS (11.233s)
[689.056435] [130/132] (336s left) i915_selftest (perf)
[690.871358] Starting subtest: perf
[690.874233] Starting dynamic subtest: engine_cs
[694.477403] Dynamic subtest engine_cs: SUCCESS (3.610s)
[694.486887] Starting dynamic subtest: request
[702.577638] Dynamic subtest request: SUCCESS (8.106s)
[702.587585] Starting dynamic subtest: migrate
[706.172266] Dynamic subtest migrate: SUCCESS (3.593s)
[706.182359] Starting dynamic subtest: region
[711.142766] Dynamic subtest region: SUCCESS (4.967s)
[711.145821] Subtest perf: SUCCESS (20.281s)
[711.176854] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[711.177610] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[711.180718] [131/132] (314s left) kms_cursor_edge_walk (64x64-left-edge)
[713.590256] Starting subtest: 64x64-left-edge
[713.593251] Starting dynamic subtest: pipe-A-eDP-1
[717.099332] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[717.109027] Starting dynamic subtest: pipe-D-eDP-1
[720.229267] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[720.232335] Subtest 64x64-left-edge: SUCCESS (6.640s)
[721.078321] [FACT kms_cursor_edge_walk (64x64-left-edge)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[721.079542] [FACT kms_cursor_edge_walk (64x64-left-edge)] new: kernel.kmod_is_loaded.i915: true
[721.084054] [132/132] (304s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[721.155388] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[721.158327] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[721.261893] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_pm_backlight
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_color_pipeline
results: parsing output: 8/ for test: kms_selftest
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: syncobj_eventfd
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: gem_exec_parallel
results: parsing output: 17/ for test: fbdev
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_alpha_blend
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: kms_content_protection
results: parsing output: 26/ for test: kms_debugfs
results: parsing output: 27/ for test: kms_lease
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: gem_exec_flush
results: parsing output: 30/ for test: kms_chamelium_color
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: i915_hangman
results: parsing output: 43/ for test: gen3_render_mixed_blits
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_draw_crc
results: parsing output: 46/ for test: kms_atomic_transition
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_atomic
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: i915_pm_rpm
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: sysfs_timeslice_duration
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_chamelium_color
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: gem_close_race
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: sriov_basic
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_joiner
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: gem_eio
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_ppgtt
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: kms_async_flips
results: parsing output: 87/ for test: gem_partial_pwrite_pread
results: parsing output: 88/ for test: kms_setmode
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: gem_ctx_shared
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: gem_ctx_isolation
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_plane_lowres
results: parsing output: 100/ for test: gem_wait
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: dumb_buffer
results: parsing output: 109/ for test: gen9_exec_parse
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_softpin
results: parsing output: 123/ for test: kms_properties
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: gem_exec_parallel
results: parsing output: 129/ for test: i915_selftest
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: syncobj_wait
Done.