[57.914086] Initializing watchdogs
[57.914159]   /dev/watchdog0
[57.928789] [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.933562] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.936161] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.939616] [001/133] (960s left) kms_flip (dpms-off-confusion-interruptible)
[58.058470] Starting subtest: dpms-off-confusion-interruptible
[58.060837] Starting dynamic subtest: A-eDP1
[66.727886] Dynamic subtest A-eDP1: SUCCESS (8.707s)
[66.738050] Starting dynamic subtest: B-eDP1
[75.417693] Dynamic subtest B-eDP1: SUCCESS (8.701s)
[75.429085] Starting dynamic subtest: C-eDP1
[84.032419] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[84.042212] Starting dynamic subtest: D-eDP1
[92.643815] Dynamic subtest D-eDP1: SUCCESS (8.609s)
[92.648741] Subtest dpms-off-confusion-interruptible: SUCCESS (34.642s)
[93.811199] [002/133] (924s left) kms_properties (crtc-properties-atomic)
[93.913326] Starting subtest: crtc-properties-atomic
[93.915667] Starting dynamic subtest: pipe-A-eDP-1
[94.364028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[94.372927] Starting dynamic subtest: pipe-B-eDP-1
[95.490523] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[95.499449] Starting dynamic subtest: pipe-C-eDP-1
[96.618677] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[96.626491] Starting dynamic subtest: pipe-D-eDP-1
[97.748456] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[97.750743] Subtest crtc-properties-atomic: SUCCESS (3.836s)
[98.552695] [003/133] (919s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[98.651123] Starting subtest: fbc-psr2-primary-mmap-cpu
[98.653328] Starting dynamic subtest: eDP-1
[98.657359] Dynamic subtest eDP-1: SKIP (0.000s)
[98.661342] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[98.719934] [004/133] (919s left) gem_mmap_gtt (big-copy-xy)
[98.773589] Subtest big-copy-XY: SKIP (0.000s)
[98.827040] [005/133] (919s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[98.917314] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[98.921606] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[99.014885] [006/133] (919s left) kms_addfb_basic (size-max)
[99.116804] Starting subtest: size-max
[99.119240] Subtest size-max: SUCCESS (0.000s)
[99.229951] [007/133] (919s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[99.319149] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[99.321343] Starting dynamic subtest: pipe-A-eDP-1
[99.343542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.353881] Starting dynamic subtest: pipe-B-eDP-1
[99.375137] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.382168] Starting dynamic subtest: pipe-C-eDP-1
[99.403310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.410219] Starting dynamic subtest: pipe-D-eDP-1
[99.432340] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.436403] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[101.611139] [008/133] (917s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[101.717443] Starting subtest: yf-tiled-32bpp-rotate-0
[101.721695] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[101.806413] [009/133] (916s left) perf_pmu (semaphore-busy)
[101.853402] Starting subtest: semaphore-busy
[101.856041] Starting dynamic subtest: rcs0
[103.497945] Dynamic subtest rcs0: SUCCESS (1.640s)
[103.508490] Starting dynamic subtest: bcs0
[105.129981] Dynamic subtest bcs0: SUCCESS (1.631s)
[105.139973] Starting dynamic subtest: vcs0
[109.392988] Dynamic subtest vcs0: SUCCESS (4.261s)
[109.402660] Starting dynamic subtest: vcs1
[115.410654] Dynamic subtest vcs1: SUCCESS (6.017s)
[115.419868] Starting dynamic subtest: vecs0
[121.426036] Dynamic subtest vecs0: SUCCESS (6.014s)
[121.435210] Starting dynamic subtest: ccs0
[124.498359] Dynamic subtest ccs0: SUCCESS (3.072s)
[124.500954] Subtest semaphore-busy: SUCCESS (22.642s)
[124.611465] [010/133] (894s left) api_intel_bb (purge-bb)
[124.671303] Starting subtest: purge-bb
[124.677029] Subtest purge-bb: SUCCESS (0.008s)
[124.811670] [011/133] (894s left) gem_mmap_gtt (cpuset-big-copy-odd)
[124.878310] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[124.945728] [012/133] (893s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[125.048100] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[125.052309] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[125.128740] [013/133] (893s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[125.229419] Starting subtest: plane-upscale-20x20-with-modifiers
[125.231777] Starting dynamic subtest: pipe-A
[125.570560] Dynamic subtest pipe-A: SUCCESS (0.339s)
[125.582306] Starting dynamic subtest: pipe-B
[126.990786] Dynamic subtest pipe-B: SUCCESS (1.422s)
[127.000130] Starting dynamic subtest: pipe-C
[128.424662] Dynamic subtest pipe-C: SUCCESS (1.433s)
[128.434367] Starting dynamic subtest: pipe-D
[129.849510] Dynamic subtest pipe-D: SUCCESS (1.424s)
[129.852252] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.622s)
[131.042675] [014/133] (887s left) gem_exec_reloc (basic-gtt-wc)
[131.116658] Subtest basic-gtt-wc: SKIP (0.000s)
[131.191960] [015/133] (887s left) gem_ctx_persistence (legacy-engines-persistence)
[131.250826] Starting subtest: legacy-engines-persistence
[131.253264] Starting dynamic subtest: render
[132.061055] Dynamic subtest render: SUCCESS (0.809s)
[132.071766] Starting dynamic subtest: bsd1
[132.828932] Dynamic subtest bsd1: SUCCESS (0.766s)
[132.839144] Starting dynamic subtest: bsd2
[133.595725] Dynamic subtest bsd2: SUCCESS (0.765s)
[133.606343] Starting dynamic subtest: blt
[134.334515] Dynamic subtest blt: SUCCESS (0.737s)
[134.344496] Starting dynamic subtest: vebox
[135.117700] Dynamic subtest vebox: SUCCESS (0.782s)
[135.120458] Subtest legacy-engines-persistence: SUCCESS (3.867s)
[135.226627] [016/133] (883s left) gem_exec_schedule (smoketest)
[135.417941] Starting subtest: smoketest
[135.420329] Starting dynamic subtest: rcs0
[140.968311] Dynamic subtest rcs0: SUCCESS (5.500s)
[140.979476] Starting dynamic subtest: bcs0
[146.474630] Dynamic subtest bcs0: SUCCESS (5.507s)
[146.484330] Starting dynamic subtest: vcs0
[151.982375] Dynamic subtest vcs0: SUCCESS (5.505s)
[151.991991] Starting dynamic subtest: vcs1
[157.477438] Dynamic subtest vcs1: SUCCESS (5.494s)
[157.486958] Starting dynamic subtest: vecs0
[162.977644] Dynamic subtest vecs0: SUCCESS (5.499s)
[162.988256] Starting dynamic subtest: ccs0
[168.473799] Dynamic subtest ccs0: SUCCESS (5.497s)
[168.476144] Subtest smoketest: SUCCESS (33.005s)
[168.621460] [017/133] (850s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[168.733586] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[168.735950] Starting dynamic subtest: pipe-A-eDP-1
[168.830628] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[168.840184] Starting dynamic subtest: pipe-B-eDP-1
[170.008087] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s)
[170.013017] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.277s)
[171.206795] [018/133] (847s left) kms_big_fb (yf-tiled-addfb)
[171.318437] Starting subtest: yf-tiled-addfb
[171.322539] Subtest yf-tiled-addfb: SKIP (0.000s)
[171.421245] [019/133] (847s left) kms_hdr (bpc-switch)
[171.517715] Starting subtest: bpc-switch
[172.567854] Starting dynamic subtest: pipe-A-eDP-1
[175.948908] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.381s)
[175.951116] Subtest bpc-switch: SUCCESS (4.433s)
[176.049195] [020/133] (843s left) gem_exec_reloc (basic-cpu-wc-active)
[176.107278] Subtest basic-cpu-wc-active: SKIP (0.000s)
[176.178643] [021/133] (843s left) gem_exec_whisper (basic-contexts-priority-all)
[176.238109] Starting subtest: basic-contexts-priority-all
[198.874384] Subtest basic-contexts-priority-all: SUCCESS (22.637s)
[199.055387] [022/133] (820s left) gem_softpin (softpin)
[199.128476] Starting subtest: softpin
[231.438626] Subtest softpin: SUCCESS (32.304s)
[231.540918] [023/133] (787s left) gem_ctx_bad_destroy (double-destroy)
[231.586407] Starting subtest: double-destroy
[231.588860] Subtest double-destroy: SUCCESS (0.000s)
[231.651371] [024/133] (787s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[231.766179] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[231.768129] Starting dynamic subtest: pipe-A-eDP-1
[233.029830] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.266s)
[233.039308] Starting dynamic subtest: pipe-B-eDP-1
[235.366522] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.336s)
[235.376325] Starting dynamic subtest: pipe-C-eDP-1
[237.690734] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.322s)
[237.700261] Starting dynamic subtest: pipe-D-eDP-1
[240.042460] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.351s)
[240.044817] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.279s)
[241.231397] [025/133] (778s left) gem_tiled_partial_pwrite_pread (writes)
[241.291241] Subtest writes: SKIP (0.000s)
[241.362420] [026/133] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[241.459600] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[241.463783] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[241.560281] [027/133] (777s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[241.648819] Starting subtest: primary-4-tiled-reflect-x-0
[248.753663] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.104s)
[249.985992] [028/133] (769s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[250.093524] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[250.097827] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[250.178302] [029/133] (769s left) kms_psr (psr-cursor-mmap-gtt)
[250.274940] Starting subtest: psr-cursor-mmap-gtt
[250.277091] Starting dynamic subtest: eDP-1
[251.983137] Dynamic subtest eDP-1: SUCCESS (1.709s)
[251.985453] Subtest psr-cursor-mmap-gtt: SUCCESS (1.710s)
[252.846033] [030/133] (766s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[252.896544] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[252.947822] [031/133] (766s left) gem_exec_fence (basic-busy-all)
[253.011811] Starting subtest: basic-busy-all
[253.084618] Subtest basic-busy-all: SUCCESS (0.074s)
[255.007077] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[255.010535] [032/133] (764s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[255.072205] Starting subtest: y-tiled-to-vebox-y-tiled
[255.076833] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[255.253534] [033/133] (764s left) prime_mmap_coherency (ioctl-errors)
[255.307474] Starting subtest: ioctl-errors
[271.554213] Subtest ioctl-errors: SUCCESS (16.246s)
[271.703644] [034/133] (748s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[271.843357] Starting subtest: psr-rgb101010-draw-mmap-gtt
[271.846843] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[271.950780] [035/133] (747s left) gem_render_copy_redux (flink-interruptible)
[272.005547] Starting subtest: flink-interruptible
[272.795295] Subtest flink-interruptible: SUCCESS (0.790s)
[272.939916] [036/133] (746s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[273.506430] Starting subtest: syncobj-timeline-invalid-flags
[273.508971] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[274.999305] [037/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[275.098557] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[275.102966] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[275.201782] [038/133] (744s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[275.307380] Starting subtest: stress-xrgb8888-ytiled
[275.311832] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[275.380934] [039/133] (744s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[275.476117] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[275.480154] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[275.562966] [040/133] (744s left) gem_mmap_wc (fault-concurrent)
[275.628174] Subtest fault-concurrent: SKIP (0.000s)
[275.703742] [041/133] (744s left) kms_flip (plain-flip-interruptible)
[275.806322] Starting subtest: plain-flip-interruptible
[275.808587] Starting dynamic subtest: A-eDP1
[277.463560] Dynamic subtest A-eDP1: SUCCESS (1.656s)
[277.473448] Starting dynamic subtest: B-eDP1
[279.100463] Dynamic subtest B-eDP1: SUCCESS (1.634s)
[279.112136] Starting dynamic subtest: C-eDP1
[280.712670] Dynamic subtest C-eDP1: SUCCESS (1.611s)
[280.723282] Starting dynamic subtest: D-eDP1
[282.345150] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[282.347575] Subtest plain-flip-interruptible: SUCCESS (6.541s)
[283.524383] [042/133] (736s left) kms_flip (wf_vblank-ts-check)
[283.619259] Starting subtest: wf_vblank-ts-check
[283.621513] Starting dynamic subtest: A-eDP1
[292.564875] Dynamic subtest A-eDP1: SUCCESS (8.946s)
[292.576986] Starting dynamic subtest: B-eDP1
[301.495581] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[301.505130] Starting dynamic subtest: C-eDP1
[310.417311] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[310.428727] Starting dynamic subtest: D-eDP1
[319.339848] Dynamic subtest D-eDP1: SUCCESS (8.919s)
[319.344731] Subtest wf_vblank-ts-check: SUCCESS (35.726s)
[320.562875] [043/133] (699s left) gem_userptr_blits (coherency-unsync)
[320.654964] Subtest coherency-unsync: SKIP (0.000s)
[320.766415] [044/133] (699s left) gem_pxp (verify-pxp-stale-buf-execution)
[320.911747] Starting subtest: verify-pxp-stale-buf-execution
[321.973857] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[322.094773] [045/133] (698s left) gem_exec_reloc (basic-gtt-cpu-active)
[322.163072] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[322.239673] [046/133] (698s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[322.325090] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[322.329351] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[322.398847] [047/133] (697s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[322.514930] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[329.301174] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.789s)
[329.413758] [048/133] (690s left) gem_busy (semaphore)
[329.619456] Subtest semaphore: SKIP (0.000s)
[329.836870] [049/133] (690s left) kms_vrr (flip-basic-fastset)
[329.941113] Starting subtest: flip-basic-fastset
[329.947658] Subtest flip-basic-fastset: SKIP (0.000s)
[330.009695] [050/133] (690s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[330.115593] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[330.119667] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[330.213894] [051/133] (690s left) kms_flip (2x-flip-vs-suspend)
[330.311181] Starting subtest: 2x-flip-vs-suspend
[330.320258] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[330.403522] [052/133] (690s left) gem_exec_basic (basic)
[330.458574] Starting subtest: basic
[330.460818] Starting dynamic subtest: rcs0-smem
[330.462651] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[330.472919] Starting dynamic subtest: bcs0-smem
[330.475091] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[330.484293] Starting dynamic subtest: vcs0-smem
[330.486385] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[330.495326] Starting dynamic subtest: vcs1-smem
[330.497499] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[330.506049] Starting dynamic subtest: vecs0-smem
[330.508152] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[330.516828] Starting dynamic subtest: ccs0-smem
[330.518978] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[330.521103] Subtest basic: SUCCESS (0.016s)
[331.902140] [053/133] (688s left) gem_fence_thrash (bo-write-verify-y)
[331.946794] Starting subtest: bo-write-verify-y
[331.965564] Subtest bo-write-verify-y: SKIP (0.016s)
[332.040752] [054/133] (688s left) gen7_exec_parse (cmd-crossing-page)
[332.092165] Subtest cmd-crossing-page: SKIP (0.000s)
[332.156431] [055/133] (688s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[332.260948] Starting subtest: bad-rotation-90-yf-tiled-ccs
[332.263237] Starting dynamic subtest: pipe-A-eDP-1
[332.286672] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.298899] Starting dynamic subtest: pipe-B-eDP-1
[332.320064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.329596] Starting dynamic subtest: pipe-C-eDP-1
[332.350272] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.359097] Starting dynamic subtest: pipe-D-eDP-1
[332.380940] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.385217] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[334.544151] [056/133] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[334.654808] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[334.659210] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[334.742118] [057/133] (685s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[334.838832] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[342.237963] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.402s)
[342.374345] [058/133] (678s left) gem_exec_params (invalid-fence-in-submit)
[342.438540] Starting subtest: invalid-fence-in-submit
[342.444284] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[342.561322] [059/133] (678s left) perf (disabled-read-error)
[342.717969] Starting subtest: disabled-read-error
[342.733507] Subtest disabled-read-error: SUCCESS (0.016s)
[342.783739] [060/133] (678s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[342.848024] Subtest writes-after-reads-snoop: SKIP (0.000s)
[342.930862] [061/133] (677s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[343.030821] Starting subtest: 4-tiled-8bpp-rotate-90
[343.051856] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[343.170644] [062/133] (677s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[343.256378] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[343.258285] Starting dynamic subtest: pipe-A-eDP-1
[343.277527] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[343.287136] Starting dynamic subtest: pipe-B-eDP-1
[343.305057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[343.314116] Starting dynamic subtest: pipe-C-eDP-1
[343.332270] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[343.342213] Starting dynamic subtest: pipe-D-eDP-1
[343.360785] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[343.364141] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[345.524058] [063/133] (675s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[345.615904] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[345.618156] Starting dynamic subtest: pipe-A
[346.766261] Dynamic subtest pipe-A: SUCCESS (1.152s)
[346.778505] Starting dynamic subtest: pipe-B
[349.041845] Dynamic subtest pipe-B: SUCCESS (2.274s)
[349.050745] Starting dynamic subtest: pipe-C
[350.236876] Dynamic subtest pipe-C: SUCCESS (1.193s)
[350.251258] Starting dynamic subtest: pipe-D
[351.478471] Dynamic subtest pipe-D: SUCCESS (1.241s)
[351.480625] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.866s)
[352.674198] [064/133] (668s left) syncobj_eventfd (binary-wait-signaled)
[352.724444] Starting subtest: binary-wait-signaled
[352.726828] Subtest binary-wait-signaled: SUCCESS (0.000s)
[352.842546] [065/133] (668s left) perf_pmu (busy-check-all)
[352.881420] Starting subtest: busy-check-all
[352.883693] Starting dynamic subtest: rcs0
[353.431969] Dynamic subtest rcs0: SUCCESS (0.551s)
[353.444694] Starting dynamic subtest: bcs0
[353.982626] Dynamic subtest bcs0: SUCCESS (0.549s)
[353.994707] Starting dynamic subtest: vcs0
[355.926791] Dynamic subtest vcs0: SUCCESS (1.940s)
[355.938682] Starting dynamic subtest: vcs1
[357.911094] Dynamic subtest vcs1: SUCCESS (1.981s)
[357.923599] Starting dynamic subtest: vecs0
[359.895256] Dynamic subtest vecs0: SUCCESS (1.981s)
[359.907425] Starting dynamic subtest: ccs0
[360.454595] Dynamic subtest ccs0: SUCCESS (0.557s)
[360.457159] Subtest busy-check-all: SUCCESS (7.575s)
[360.548960] [066/133] (660s left) prime_busy (after)
[360.612664] Starting subtest: after
[360.615086] Starting dynamic subtest: rcs0
[360.658259] Dynamic subtest rcs0: SUCCESS (0.045s)
[360.669370] Starting dynamic subtest: bcs0
[360.699486] Dynamic subtest bcs0: SUCCESS (0.040s)
[360.709566] Starting dynamic subtest: vcs0
[360.741485] Dynamic subtest vcs0: SUCCESS (0.041s)
[360.751271] Starting dynamic subtest: vcs1
[360.782250] Dynamic subtest vcs1: SUCCESS (0.040s)
[360.791918] Starting dynamic subtest: vecs0
[360.825379] Dynamic subtest vecs0: SUCCESS (0.042s)
[360.835396] Starting dynamic subtest: ccs0
[360.867774] Dynamic subtest ccs0: SUCCESS (0.041s)
[360.977878] Subtest after: SUCCESS (0.366s)
[361.070466] [067/133] (660s left) kms_hdr (static-toggle-dpms)
[361.178982] Starting subtest: static-toggle-dpms
[361.185669] Subtest static-toggle-dpms: SKIP (0.000s)
[361.251858] [068/133] (659s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[361.313516] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[361.419407] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[361.505632] [069/133] (659s left) kms_cursor_crc (cursor-random-max-size)
[361.795680] Starting subtest: cursor-random-max-size
[361.802372] Subtest cursor-random-max-size: SKIP (0.000s)
[361.920539] [070/133] (659s left) gem_exec_schedule (independent)
[362.003926] Starting subtest: independent
[362.005948] Starting dynamic subtest: rcs0
[363.926958] Dynamic subtest rcs0: SUCCESS (1.932s)
[363.939794] Starting dynamic subtest: vcs0
[365.925268] Dynamic subtest vcs0: SUCCESS (1.996s)
[365.936148] Starting dynamic subtest: vcs1
[367.905559] Dynamic subtest vcs1: SUCCESS (1.977s)
[367.917302] Starting dynamic subtest: vecs0
[369.894629] Dynamic subtest vecs0: SUCCESS (1.987s)
[369.905943] Starting dynamic subtest: ccs0
[371.926716] Dynamic subtest ccs0: SUCCESS (2.029s)
[371.929763] Subtest independent: SUCCESS (9.934s)
[372.232568] [071/133] (649s left) gem_exec_params (dr4-dirt)
[372.298813] Starting subtest: DR4-dirt
[372.301101] Subtest DR4-dirt: SUCCESS (0.000s)
[372.407218] [072/133] (648s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[372.502202] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[372.506353] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.588533] [073/133] (648s left) gem_mmap_gtt (hang-user)
[372.650719] Subtest hang-user: SKIP (0.000s)
[372.706979] [074/133] (648s left) vgem_basic (bad-handle)
[372.748700] Starting subtest: bad-handle
[372.750796] Subtest bad-handle: SUCCESS (0.000s)
[372.806424] [075/133] (648s left) kms_psr (fbc-pr-cursor-render)
[372.918126] Starting subtest: fbc-pr-cursor-render
[372.922190] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[372.992250] [076/133] (648s left) i915_selftest (live)
[376.377381] Starting subtest: live
[376.383575] Starting dynamic subtest: sanitycheck
[380.709466] Dynamic subtest sanitycheck: SUCCESS (4.331s)
[380.717323] Starting dynamic subtest: uncore
[385.139473] Dynamic subtest uncore: SUCCESS (4.405s)
[385.149572] Starting dynamic subtest: workarounds
[388.303857] Dynamic subtest workarounds: SUCCESS (3.184s)
[388.313372] Starting dynamic subtest: gt_engines
[391.404943] Dynamic subtest gt_engines: SUCCESS (3.099s)
[391.415053] Starting dynamic subtest: gt_timelines
[406.937356] Dynamic subtest gt_timelines: SUCCESS (15.530s)
[406.946143] Starting dynamic subtest: gt_contexts
[411.254875] Dynamic subtest gt_contexts: SUCCESS (4.315s)
[411.264434] Starting dynamic subtest: gt_lrc
[417.354259] Dynamic subtest gt_lrc: SUCCESS (6.098s)
[417.362657] Starting dynamic subtest: gt_mocs
[420.325040] Dynamic subtest gt_mocs: SUCCESS (2.968s)
[420.334856] Starting dynamic subtest: gt_pm
[425.040926] Dynamic subtest gt_pm: SUCCESS (4.715s)
[425.051134] Starting dynamic subtest: gt_heartbeat
[429.385274] Dynamic subtest gt_heartbeat: SUCCESS (4.341s)
[429.394964] Starting dynamic subtest: gt_tlb
[438.704473] Dynamic subtest gt_tlb: SUCCESS (9.318s)
[438.714323] Starting dynamic subtest: requests
[452.135590] Dynamic subtest requests: SUCCESS (13.429s)
[452.145664] Starting dynamic subtest: migrate
[457.905337] Dynamic subtest migrate: SUCCESS (5.768s)
[457.915208] Starting dynamic subtest: active
[462.264866] Dynamic subtest active: SUCCESS (4.357s)
[462.274452] Starting dynamic subtest: objects
[467.069027] Dynamic subtest objects: SUCCESS (4.802s)
[467.078118] Starting dynamic subtest: mman
[471.891311] Dynamic subtest mman: SUCCESS (4.821s)
[471.901076] Starting dynamic subtest: dmabuf
[476.237214] Dynamic subtest dmabuf: SUCCESS (4.345s)
[476.247427] Starting dynamic subtest: vma
[478.895457] Dynamic subtest vma: SUCCESS (2.656s)
[478.904702] Starting dynamic subtest: coherency
[483.181659] Dynamic subtest coherency: SUCCESS (4.283s)
[483.191662] Starting dynamic subtest: gtt
[493.394821] Dynamic subtest gtt: SUCCESS (10.211s)
[493.404205] Starting dynamic subtest: gem
[501.592851] Dynamic subtest gem: SUCCESS (8.197s)
[501.602159] Starting dynamic subtest: evict
[507.133863] Dynamic subtest evict: SUCCESS (5.538s)
[507.142821] Starting dynamic subtest: hugepages
[517.822956] Dynamic subtest hugepages: SUCCESS (10.686s)
[517.832664] Starting dynamic subtest: gem_contexts
[544.992116] Dynamic subtest gem_contexts: SUCCESS (27.166s)
[545.001474] Starting dynamic subtest: client
[547.768659] Dynamic subtest client: SUCCESS (2.775s)
[547.783989] Starting dynamic subtest: gem_migrate
[552.159385] Dynamic subtest gem_migrate: SUCCESS (4.389s)
[552.169068] Starting dynamic subtest: reset
[554.986421] Dynamic subtest reset: SUCCESS (2.825s)
[554.996175] Starting dynamic subtest: memory_region
[559.328326] Dynamic subtest memory_region: SUCCESS (4.340s)
[559.338367] Starting dynamic subtest: hangcheck
[572.358206] Dynamic subtest hangcheck: SUCCESS (13.027s)
[572.367960] Starting dynamic subtest: execlists
[576.726367] Dynamic subtest execlists: SUCCESS (4.366s)
[576.736573] Starting dynamic subtest: ring_submission
[581.039050] Dynamic subtest ring_submission: SUCCESS (4.310s)
[581.049110] Starting dynamic subtest: perf
[585.371330] Dynamic subtest perf: SUCCESS (4.330s)
[585.380685] Starting dynamic subtest: slpc
[599.458870] Dynamic subtest slpc: SUCCESS (14.086s)
[599.471655] Starting dynamic subtest: guc
[603.383519] Dynamic subtest guc: SUCCESS (3.922s)
[603.394246] Starting dynamic subtest: guc_multi_lrc
[607.675377] Dynamic subtest guc_multi_lrc: SUCCESS (4.290s)
[607.685469] Starting dynamic subtest: guc_hang
[612.479080] Dynamic subtest guc_hang: SUCCESS (4.802s)
[612.489027] Starting dynamic subtest: late_gt_pm
[615.181086] Dynamic subtest late_gt_pm: SUCCESS (2.701s)
[615.183944] Subtest live: SUCCESS (238.795s)
[615.210697] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[615.211445] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[615.214586] [077/133] (406s left) kms_big_fb (x-tiled-addfb)
[616.786929] Starting subtest: x-tiled-addfb
[616.789392] Subtest x-tiled-addfb: SUCCESS (0.000s)
[616.901041] [FACT kms_big_fb (x-tiled-addfb)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[616.902362] [FACT kms_big_fb (x-tiled-addfb)] new: kernel.kmod_is_loaded.i915: true
[616.906177] [078/133] (404s left) kms_color (legacy-gamma)
[617.013773] Starting subtest: legacy-gamma
[617.015596] Starting dynamic subtest: pipe-A-eDP-1
[617.747227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[617.756101] Starting dynamic subtest: pipe-B-eDP-1
[619.145059] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[619.154137] Starting dynamic subtest: pipe-C-eDP-1
[620.489153] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s)
[620.499834] Starting dynamic subtest: pipe-D-eDP-1
[621.859731] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.370s)
[621.861903] Subtest legacy-gamma: SUCCESS (4.849s)
[622.650638] [079/133] (398s left) api_intel_bb (bb-with-allocator)
[622.714226] Starting subtest: bb-with-allocator
[622.719322] Subtest bb-with-allocator: SUCCESS (0.006s)
[622.841241] [080/133] (398s left) i915_pciid
[623.018939] [081/133] (398s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[623.104226] Starting subtest: crc-primary-basic-yf-tiled-ccs
[623.106416] Starting dynamic subtest: pipe-A-eDP-1
[623.129220] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[623.140185] Starting dynamic subtest: pipe-B-eDP-1
[623.161565] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[623.170071] Starting dynamic subtest: pipe-C-eDP-1
[623.191655] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[623.199968] Starting dynamic subtest: pipe-D-eDP-1
[623.221760] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[623.225752] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[625.409149] [082/133] (396s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[625.460074] Starting subtest: invalid-signal-one-illegal-handle
[625.462356] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[625.539906] [083/133] (396s left) kms_content_protection (atomic-dpms-hdcp14)
[625.687226] Starting subtest: atomic-dpms-hdcp14
[625.691310] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[625.824587] [084/133] (396s left) gem_exec_reloc (basic-range)
[625.885265] Subtest basic-range: SKIP (0.000s)
[625.948168] [085/133] (395s left) gem_exercise_blt (fast-copy-emit)
[625.999461] Starting subtest: fast-copy-emit
[626.001621] Starting dynamic subtest: linear-smem-smem-emit
[626.022067] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[626.032995] Starting dynamic subtest: xmajor-smem-smem-emit
[626.043322] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.020s)
[626.052061] Starting dynamic subtest: tile4-smem-smem-emit
[626.064066] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.020s)
[626.074198] Starting dynamic subtest: tile64-smem-smem-emit
[626.085080] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.020s)
[626.087371] Subtest fast-copy-emit: SUCCESS (0.086s)
[626.191380] [086/133] (395s left) kms_pm_rpm (cursor-dpms)
[628.032197] Starting subtest: cursor-dpms
[628.037557] Subtest cursor-dpms: SKIP (0.000s)
[628.440196] [087/133] (393s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[628.506303] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[628.508536] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[628.618159] [088/133] (393s left) i915_drm_fdinfo (memory-info-idle)
[628.659620] Starting subtest: memory-info-idle
[628.662067] Starting dynamic subtest: smem0
[628.710328] Dynamic subtest smem0: SUCCESS (0.052s)
[628.712801] Subtest memory-info-idle: SUCCESS (0.052s)
[628.787970] [089/133] (393s left) kms_async_flips (invalid-async-flip-atomic)
[628.877072] Starting subtest: invalid-async-flip-atomic
[629.264948] Starting dynamic subtest: pipe-A-eDP-1
[630.059629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s)
[630.425160] Starting dynamic subtest: pipe-B-eDP-1
[631.213300] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.798s)
[631.575025] Starting dynamic subtest: pipe-C-eDP-1
[632.432628] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.863s)
[632.796194] Starting dynamic subtest: pipe-D-eDP-1
[633.639541] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.850s)
[633.642205] Subtest invalid-async-flip-atomic: SUCCESS (4.765s)
[634.803095] [090/133] (387s left) kms_chamelium_frames (hdmi-crc-fast)
[635.192344] Subtest hdmi-crc-fast: SKIP (0.000s)
[636.003315] [091/133] (386s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[636.101217] Starting subtest: fbcpsr-indfb-scaledprimary
[641.912000] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.814s)
[642.061217] [092/133] (380s left) gem_mmap_gtt (basic-write-read-distinct)
[642.115114] Subtest basic-write-read-distinct: SKIP (0.000s)
[642.170846] [093/133] (380s left) kms_lease (lease-unleased-connector)
[642.278387] Starting subtest: lease-unleased-connector
[642.280639] Starting dynamic subtest: pipe-A-eDP-1
[642.282950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[642.292933] Starting dynamic subtest: pipe-B-eDP-1
[642.295223] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[642.304062] Starting dynamic subtest: pipe-C-eDP-1
[642.306281] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[642.314621] Starting dynamic subtest: pipe-D-eDP-1
[642.316491] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[642.318347] Subtest lease-unleased-connector: SUCCESS (0.031s)
[642.415257] [094/133] (379s left) syncobj_timeline (wait-all-for-submit-complex)
[642.484378] Starting subtest: wait-all-for-submit-complex
[642.699108] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[642.784421] [095/133] (379s left) gem_workarounds (basic-read-fd)
[642.881531] Starting subtest: basic-read-fd
[642.894433] Subtest basic-read-fd: SUCCESS (0.013s)
[643.031566] [096/133] (379s left) kms_rmfb (close-fd)
[643.127967] Starting subtest: close-fd
[643.129826] Starting dynamic subtest: pipe-A-eDP-1
[643.236968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[643.252307] Starting dynamic subtest: pipe-B-eDP-1
[644.394685] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s)
[644.405057] Starting dynamic subtest: pipe-C-eDP-1
[645.532053] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.137s)
[645.541750] Starting dynamic subtest: pipe-D-eDP-1
[646.668025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[646.670331] Subtest close-fd: SUCCESS (3.540s)
[647.885963] [097/133] (374s left) gem_eio (context-create)
[648.068734] Starting subtest: context-create
[648.308466] Subtest context-create: SUCCESS (0.239s)
[648.419814] [098/133] (373s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[648.514449] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[648.516779] Starting dynamic subtest: pipe-A-default-mode
[649.653630] Dynamic subtest pipe-A-default-mode: SKIP (1.135s)
[649.657717] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.137s)
[649.797414] [099/133] (372s left) syncobj_wait (reset-multiple-signaled)
[649.850307] Starting subtest: reset-multiple-signaled
[649.852609] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[649.945562] [100/133] (372s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[650.041200] Starting subtest: y-tiled-16bpp-rotate-0
[650.045599] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[650.156862] [101/133] (372s left) gem_render_copy_redux (flink)
[650.222212] Starting subtest: flink
[651.175860] Subtest flink: SUCCESS (0.954s)
[651.281330] [102/133] (371s left) gem_pread (self)
[651.338188] Subtest self: SKIP (0.000s)
[651.402356] [103/133] (371s left) i915_pm_rpm (gem-evict-pwrite)
[653.038607] Starting subtest: gem-evict-pwrite
[653.043577] Subtest gem-evict-pwrite: SKIP (0.000s)
[653.684727] [104/133] (368s left) gem_ctx_persistence (engines-mixed-process)
[653.743043] Starting subtest: engines-mixed-process
[653.745470] Starting dynamic subtest: rcs0
[654.881645] Dynamic subtest rcs0: SUCCESS (1.138s)
[654.894882] Starting dynamic subtest: bcs0
[656.916868] Dynamic subtest bcs0: SUCCESS (2.032s)
[656.928667] Starting dynamic subtest: vcs0
[658.916960] Dynamic subtest vcs0: SUCCESS (1.999s)
[658.929095] Starting dynamic subtest: vcs1
[660.869911] Dynamic subtest vcs1: SUCCESS (1.950s)
[660.880450] Starting dynamic subtest: vecs0
[662.880482] Dynamic subtest vecs0: SUCCESS (2.010s)
[662.893546] Starting dynamic subtest: ccs0
[664.910094] Dynamic subtest ccs0: SUCCESS (2.027s)
[664.912577] Subtest engines-mixed-process: SUCCESS (11.167s)
[664.989816] [105/133] (357s left) kms_fb_coherency (memset-crc)
[665.099050] Starting subtest: memset-crc
[665.101244] Starting dynamic subtest: mmap-offset-wc
[665.496262] Dynamic subtest mmap-offset-wc: SUCCESS (0.398s)
[665.798674] Starting dynamic subtest: mmap-offset-uc
[671.896517] Dynamic subtest mmap-offset-uc: SUCCESS (6.106s)
[672.189829] Subtest memset-crc: SUCCESS (7.088s)
[673.021147] [106/133] (349s left) vgem_basic (dmabuf-fence-before)
[673.072014] Starting subtest: dmabuf-fence-before
[673.074588] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[673.131782] [107/133] (349s left) kms_pm_rpm (pm-caching)
[675.054928] Starting subtest: pm-caching
[675.061468] Subtest pm-caching: SKIP (0.000s)
[675.445939] [108/133] (347s left) gem_userptr_blits (map-fixed-invalidate-busy)
[675.522633] Starting subtest: map-fixed-invalidate-busy
[675.527174] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[675.645026] [109/133] (347s left) template (b)
[675.701090] Starting subtest: B
[675.702929] Subtest B: SUCCESS (0.000s)
[675.788009] [110/133] (347s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[675.892800] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[675.896994] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[675.962521] [111/133] (346s left) kms_big_fb (linear-8bpp-rotate-180)
[676.068416] Starting subtest: linear-8bpp-rotate-180
[677.404874] Subtest linear-8bpp-rotate-180: SUCCESS (1.338s)
[677.545226] [112/133] (345s left) kms_cursor_crc (cursor-sliding-256x85)
[677.823547] Starting subtest: cursor-sliding-256x85
[677.868648] Subtest cursor-sliding-256x85: SKIP (0.044s)
[678.047196] [113/133] (344s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[678.147329] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[678.151057] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[678.237816] [114/133] (344s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[678.326050] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[685.250449] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.925s)
[685.369937] [115/133] (337s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[685.468256] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[685.472563] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[685.566624] [116/133] (337s left) gem_userptr_blits (set-cache-level)
[685.631618] Starting subtest: set-cache-level
[685.635727] Subtest set-cache-level: SKIP (0.000s)
[685.759399] [117/133] (337s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[685.854470] Starting subtest: addfb25-y-tiled-legacy
[685.856694] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[685.946519] [118/133] (337s left) gem_exec_balancer (full-pulse)
[686.009622] Starting subtest: full-pulse
[690.736217] Subtest full-pulse: SUCCESS (4.726s)
[691.071766] [119/133] (332s left) perf (i915-ref-count)
[691.137650] Starting subtest: i915-ref-count
[691.195199] Subtest i915-ref-count: SUCCESS (0.059s)
[691.250858] [120/133] (332s left) kms_psr (psr2-cursor-blt)
[691.342812] Starting subtest: psr2-cursor-blt
[691.344965] Starting dynamic subtest: eDP-1
[693.091513] Dynamic subtest eDP-1: SUCCESS (1.746s)
[693.093805] Subtest psr2-cursor-blt: SUCCESS (1.747s)
[694.007230] [121/133] (329s left) gem_softpin (evict-single-offset)
[694.138661] Starting subtest: evict-single-offset
[720.855061] Subtest evict-single-offset: SUCCESS (26.713s)
[720.953812] [122/133] (302s left) kms_chamelium_hpd (hdmi-hpd)
[721.387583] Subtest hdmi-hpd: SKIP (0.000s)
[722.183905] [123/133] (301s left) kms_selftest (drm_format_helper)
[722.235253] Starting subtest: drm_format_helper
[722.283629] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[722.380369] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.097s)
[722.391259] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[722.481970] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.100s)
[722.492460] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[722.586726] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.105s)
[722.597524] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[722.695531] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.106s)
[722.705048] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[722.787168] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.092s)
[722.797404] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[722.884317] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.097s)
[722.895470] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[722.990102] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.104s)
[723.001406] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[723.085061] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.094s)
[723.096334] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[723.203440] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.116s)
[723.213316] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[723.303085] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.098s)
[723.313241] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[723.402444] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.099s)
[723.412057] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[723.496744] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.094s)
[723.506562] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[723.594761] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.097s)
[723.604341] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[723.674753] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.081s)
[723.685476] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[723.768401] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.093s)
[723.778521] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[723.866357] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.097s)
[723.875178] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[723.978680] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.111s)
[723.980674] Subtest drm_format_helper: SUCCESS (1.744s)
[724.134897] [124/133] (299s left) kms_frontbuffer_tracking (fbc-tiling-y)
[724.241471] Starting subtest: fbc-tiling-y
[724.245052] Subtest fbc-tiling-y: SKIP (0.000s)
[724.333163] [125/133] (299s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[724.435367] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[724.438956] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[724.528386] [126/133] (299s left) gem_userptr_blits (stress-mm-invalidate-close)
[724.596074] Starting subtest: stress-mm-invalidate-close
[726.745949] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[726.888517] [127/133] (296s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[726.947630] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[726.950074] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[727.036953] [128/133] (296s left) kms_display_modes (extended-mode-basic)
[727.137933] Starting subtest: extended-mode-basic
[727.142254] Subtest extended-mode-basic: SKIP (0.000s)
[727.192380] [129/133] (296s left) sw_sync (sync_busy_fork_unixsocket)
[727.225884] Starting subtest: sync_busy_fork_unixsocket
[727.228177] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[727.293705] [130/133] (296s left) kms_cursor_crc (cursor-alpha-transparent)
[727.377977] Starting subtest: cursor-alpha-transparent
[727.379855] Starting dynamic subtest: pipe-A-eDP-1
[728.019512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.640s)
[728.029725] Starting dynamic subtest: pipe-D-eDP-1
[729.282575] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.261s)
[729.284450] Subtest cursor-alpha-transparent: SUCCESS (1.905s)
[730.092921] [131/133] (293s left) kms_psr (fbc-psr-dpms)
[730.190427] Starting subtest: fbc-psr-dpms
[730.192739] Starting dynamic subtest: eDP-1
[730.197054] Dynamic subtest eDP-1: SKIP (0.000s)
[730.201366] Subtest fbc-psr-dpms: SKIP (0.001s)
[730.266657] [132/133] (293s left) gem_create (create-ext-placement-sanity-check)
[730.438704] Starting subtest: create-ext-placement-sanity-check
[730.441159] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[730.534336] [133/133] (293s left) drm_read (short-buffer-wakeup)
[730.680377] Starting subtest: short-buffer-wakeup
[762.895363] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[763.049955] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_properties
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_hdr
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: gem_softpin
results: parsing output: 22/ for test: gem_ctx_bad_destroy
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_rotation_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_pipe_b_c_ivb
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: prime_mmap_coherency
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_pipe_stress
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: gem_exec_reloc
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_busy
results: parsing output: 48/ for test: kms_vrr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_exec_basic
results: parsing output: 52/ for test: gem_fence_thrash
results: parsing output: 53/ for test: gen7_exec_parse
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: syncobj_eventfd
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: prime_busy
results: parsing output: 66/ for test: kms_hdr
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: vgem_basic
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: i915_selftest
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_color
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: i915_pciid
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_content_protection
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: gem_exercise_blt
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_workarounds
results: parsing output: 95/ for test: kms_rmfb
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_render_copy_redux
results: parsing output: 101/ for test: gem_pread
results: parsing output: 102/ for test: i915_pm_rpm
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: kms_fb_coherency
results: parsing output: 105/ for test: vgem_basic
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: template
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: gem_exec_balancer
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: kms_chamelium_hpd
results: parsing output: 122/ for test: kms_selftest
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_display_modes
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_create
results: parsing output: 132/ for test: drm_read
Done.