[61.400283] Initializing watchdogs
[61.400334]   /dev/watchdog0
[61.413954] [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]
[61.418635] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.420778] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.423959] [001/133] (960s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[61.500093] Starting subtest: yf-tiled-ccs-to-x-tiled
[61.504548] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[61.697300] [002/133] (960s left) gem_mmap_gtt (medium-copy-odd)
[61.750727] Subtest medium-copy-odd: SKIP (0.000s)
[61.819238] [003/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[61.913349] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[68.649925] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.738s)
[68.803869] [004/133] (953s left) kms_cursor_crc (cursor-sliding-512x512)
[69.065671] Starting subtest: cursor-sliding-512x512
[69.070339] Subtest cursor-sliding-512x512: SKIP (0.001s)
[69.206541] [005/133] (952s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[69.309774] Starting subtest: 4-tiled-16bpp-rotate-180
[70.541094] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.232s)
[70.659694] [006/133] (951s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[70.749792] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[70.753230] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[70.825283] [007/133] (951s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[70.872356] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[70.932807] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.014s)
[70.968173] [008/133] (951s left) perf (oa-exponents)
[71.087660] Starting subtest: oa-exponents
[71.089552] Starting dynamic subtest: 0-rcs0
[72.860351] Dynamic subtest 0-rcs0: SUCCESS (1.772s)
[72.869826] Starting dynamic subtest: 1-vecs0
[74.666850] Dynamic subtest 1-vecs0: SUCCESS (1.806s)
[74.669646] Subtest oa-exponents: SUCCESS (3.579s)
[74.711040] [009/133] (947s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[74.847140] Starting subtest: basic-flip-before-cursor-varying-size
[75.772916] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.924s)
[76.617250] [010/133] (945s left) kms_psr (fbc-pr-sprite-render)
[76.709998] Starting subtest: fbc-pr-sprite-render
[76.714294] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[76.777424] [011/133] (945s left) syncobj_wait (multi-wait-for-submit-signaled)
[76.828618] Starting subtest: multi-wait-for-submit-signaled
[76.830797] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[76.914088] [012/133] (945s left) gem_exec_reloc (basic-write-gtt-active)
[76.963140] Subtest basic-write-gtt-active: SKIP (0.000s)
[77.023069] [013/133] (945s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[77.116660] Starting subtest: addfb25-yf-tiled-legacy
[77.118966] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[77.197193] [014/133] (945s left) gem_tiled_swapping (non-threaded)
[77.260379] Subtest non-threaded: SKIP (0.000s)
[77.320810] [015/133] (945s left) gem_exec_capture (userptr)
[77.389338] Starting subtest: userptr
[78.226987] Subtest userptr: SUCCESS (0.835s)
[78.326421] [016/133] (944s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[78.423405] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[78.428158] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[79.551412] [017/133] (942s left) kms_rotation_crc (bad-tiling)
[79.643237] Starting subtest: bad-tiling
[79.648275] Subtest bad-tiling: SKIP (0.001s)
[79.712127] [018/133] (942s left) kms_addfb_basic (small-bo)
[79.804052] Starting subtest: small-bo
[79.806409] Subtest small-bo: SUCCESS (0.000s)
[79.898419] [019/133] (942s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[79.994387] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[79.998914] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[80.056163] [020/133] (942s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[80.156216] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[83.727483] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.574s)
[84.850942] [021/133] (937s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[84.963431] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[84.967849] Starting dynamic subtest: pipe-A-eDP-1
[84.996954] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[85.006050] Starting dynamic subtest: pipe-B-eDP-1
[85.030604] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[85.038093] Starting dynamic subtest: pipe-C-eDP-1
[85.062183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.069444] Starting dynamic subtest: pipe-D-eDP-1
[85.093831] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.098742] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[87.189224] [022/133] (935s left) perf (enable-disable)
[87.296392] Starting subtest: enable-disable
[87.298741] Starting dynamic subtest: 0-rcs0
[89.613605] Dynamic subtest 0-rcs0: SUCCESS (2.261s)
[89.622871] Starting dynamic subtest: 1-vcs1
[94.047520] Dynamic subtest 1-vcs1: SUCCESS (4.436s)
[94.049993] Subtest enable-disable: SUCCESS (6.698s)
[94.085237] [023/133] (928s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[94.182403] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[94.184707] Starting dynamic subtest: pipe-A-eDP-1
[94.207985] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[94.217529] Starting dynamic subtest: pipe-B-eDP-1
[94.239660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[94.246446] Starting dynamic subtest: pipe-C-eDP-1
[94.268200] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[94.275069] Starting dynamic subtest: pipe-D-eDP-1
[94.298375] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[94.302705] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[96.360660] [024/133] (926s left) kms_setmode (basic-clone-single-crtc)
[96.424732] Starting subtest: basic-clone-single-crtc
[96.431430] Subtest basic-clone-single-crtc: SKIP (0.000s)
[96.542604] [025/133] (926s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[96.642201] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[96.646123] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[96.722584] [026/133] (926s left) gem_exec_parallel (userptr)
[96.796422] Starting subtest: userptr
[96.798737] Starting dynamic subtest: rcs0
[98.211598] Dynamic subtest rcs0: SUCCESS (1.415s)
[98.219257] Starting dynamic subtest: bcs0
[99.683146] Dynamic subtest bcs0: SUCCESS (1.471s)
[99.693646] Starting dynamic subtest: vcs0
[102.870193] Dynamic subtest vcs0: SUCCESS (3.184s)
[102.881956] Starting dynamic subtest: vcs1
[104.853618] Dynamic subtest vcs1: SUCCESS (1.982s)
[104.861957] Starting dynamic subtest: vecs0
[106.836922] Dynamic subtest vecs0: SUCCESS (1.982s)
[106.846331] Starting dynamic subtest: ccs0
[108.303882] Dynamic subtest ccs0: SUCCESS (1.468s)
[108.306264] Subtest userptr: SUCCESS (11.508s)
[108.486719] [027/133] (914s left) kms_cursor_crc (cursor-random-256x256)
[108.717312] Starting subtest: cursor-random-256x256
[108.719519] Starting dynamic subtest: pipe-A-eDP-1
[112.026357] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.307s)
[112.057634] Starting dynamic subtest: pipe-D-eDP-1
[116.049083] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s)
[116.051334] Subtest cursor-random-256x256: SUCCESS (7.333s)
[116.926979] [028/133] (905s left) gem_exec_fence (invalid-fence-array)
[117.418757] Starting subtest: invalid-fence-array
[117.420812] Subtest invalid-fence-array: SUCCESS (0.003s)
[118.945115] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[118.948229] [029/133] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[119.040468] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[119.044524] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[119.138929] [030/133] (903s left) i915_drm_fdinfo (memory-info-idle)
[119.185520] Starting subtest: memory-info-idle
[119.187822] Starting dynamic subtest: smem0
[119.244872] Dynamic subtest smem0: SUCCESS (0.059s)
[119.247618] Subtest memory-info-idle: SUCCESS (0.059s)
[119.317889] [031/133] (903s left) perf_pmu (render-node-busy)
[119.395941] Starting subtest: render-node-busy
[119.398422] Starting dynamic subtest: rcs0
[119.980530] Dynamic subtest rcs0: SUCCESS (0.585s)
[119.991316] Starting dynamic subtest: bcs0
[120.548498] Dynamic subtest bcs0: SUCCESS (0.566s)
[120.560234] Starting dynamic subtest: vcs0
[121.876924] Dynamic subtest vcs0: SUCCESS (1.326s)
[121.887862] Starting dynamic subtest: vcs1
[123.924868] Dynamic subtest vcs1: SUCCESS (2.047s)
[123.934141] Starting dynamic subtest: vecs0
[125.908567] Dynamic subtest vecs0: SUCCESS (1.982s)
[125.918447] Starting dynamic subtest: ccs0
[126.478548] Dynamic subtest ccs0: SUCCESS (0.570s)
[126.481064] Subtest render-node-busy: SUCCESS (7.083s)
[126.553619] [032/133] (896s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[126.651862] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[133.191016] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.542s)
[133.296829] [033/133] (889s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[133.401022] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[137.323710] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.927s)
[138.457613] [034/133] (884s left) kms_flip (2x-plain-flip)
[138.564170] Starting subtest: 2x-plain-flip
[138.572231] Subtest 2x-plain-flip: SKIP (0.010s)
[138.654781] [035/133] (884s left) kms_flip (nonblocking-read)
[138.743709] Starting subtest: nonblocking-read
[138.745841] Subtest nonblocking-read: SUCCESS (0.000s)
[138.858972] [036/133] (884s left) kms_plane (pixel-format-4-tiled-modifier)
[138.950243] Starting subtest: pixel-format-4-tiled-modifier
[138.978524] Starting dynamic subtest: pipe-A-plane-0
[139.611359] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[139.618906] Starting dynamic subtest: pipe-A-plane-3
[140.022572] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[140.030240] Starting dynamic subtest: pipe-A-plane-5
[140.033843] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[141.126085] Starting dynamic subtest: pipe-B-plane-0
[141.775402] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[141.785899] Starting dynamic subtest: pipe-B-plane-3
[142.241838] Dynamic subtest pipe-B-plane-3: SUCCESS (0.466s)
[142.249584] Starting dynamic subtest: pipe-B-plane-5
[142.252967] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[142.564851] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.611s)
[143.405676] [037/133] (879s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[143.506519] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[143.510797] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[143.596743] [038/133] (879s left) gen9_exec_parse (bb-oversize)
[143.660319] Subtest bb-oversize: SKIP (0.000s)
[143.725318] [039/133] (879s left) gem_mmap_offset (close-race)
[143.780354] Starting subtest: close-race
[163.935789] Subtest close-race: SUCCESS (20.102s)
[163.989280] [040/133] (859s left) gem_exec_await (wide-all)
[164.231060] Starting subtest: wide-all
[187.815302] Subtest wide-all: SUCCESS (23.568s)
[187.996890] [041/133] (835s left) kms_vblank (ts-continuation-suspend)
[188.156705] Starting subtest: ts-continuation-suspend
[188.158517] Starting dynamic subtest: pipe-A-eDP-1
[204.293783] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.708s)
[204.312000] Starting dynamic subtest: pipe-D-eDP-1
[221.226806] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.189s)
[221.229109] Subtest ts-continuation-suspend: SUCCESS (3.902s)
[222.042272] [042/133] (801s left) syncobj_wait (wait-for-submit-complex)
[222.112386] Starting subtest: wait-for-submit-complex
[222.173087] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[222.263302] [043/133] (801s left) kms_busy (extended-pageflip-hang-oldfb)
[222.359046] Starting subtest: extended-pageflip-hang-oldfb
[222.361294] Starting dynamic subtest: pipe-A
[222.793846] Dynamic subtest pipe-A: SUCCESS (0.434s)
[222.803763] Starting dynamic subtest: pipe-D
[223.961188] Dynamic subtest pipe-D: SUCCESS (1.165s)
[223.963632] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.603s)
[224.806928] [044/133] (798s left) i915_pm_freq_api (freq-basic-api)
[224.881848] Starting subtest: freq-basic-api
[224.884157] Starting dynamic subtest: gt0
[224.886534] Dynamic subtest gt0: SUCCESS (0.003s)
[224.897315] Starting dynamic subtest: gt1
[224.899208] Dynamic subtest gt1: SUCCESS (0.003s)
[224.901547] Subtest freq-basic-api: SUCCESS (0.007s)
[224.959467] [045/133] (798s left) gem_exec_whisper (basic-normal)
[225.022296] Starting subtest: basic-normal
[228.688473] Subtest basic-normal: SUCCESS (3.662s)
[228.872039] [046/133] (794s left) gem_userptr_blits (sd-probe)
[228.944344] Starting subtest: sd-probe
[228.946711] Subtest sd-probe: SUCCESS (0.000s)
[229.108222] [047/133] (794s left) kms_cursor_crc (cursor-alpha-transparent)
[229.199378] Starting subtest: cursor-alpha-transparent
[229.201273] Starting dynamic subtest: pipe-A-eDP-1
[229.810205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[229.821662] Starting dynamic subtest: pipe-D-eDP-1
[231.113328] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[231.115482] Subtest cursor-alpha-transparent: SUCCESS (1.914s)
[231.981740] [048/133] (791s left) prime_mmap (test_forked_cpu_write)
[232.049112] Starting subtest: test_forked_cpu_write
[232.051322] Starting dynamic subtest: test_forked_cpu_write-smem
[232.059573] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[232.061844] Subtest test_forked_cpu_write: SUCCESS (0.012s)
[232.162655] [049/133] (791s left) perf (gen12-unprivileged-single-ctx-counters)
[232.269466] Starting subtest: gen12-unprivileged-single-ctx-counters
[232.271822] Starting dynamic subtest: rcs0
[232.344357] Dynamic subtest rcs0: SUCCESS (0.074s)
[232.346582] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.075s)
[232.392990] [050/133] (791s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[232.516007] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[232.520303] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[232.599577] [051/133] (791s left) kms_pm_rpm (package-g7)
[234.244050] Starting subtest: package-g7
[234.249061] Subtest package-g7: SKIP (0.000s)
[234.854700] [052/133] (789s left) gem_softpin (noreloc-s3)
[234.917477] Starting subtest: noreloc-S3
[255.063087] Subtest noreloc-S3: SUCCESS (5.389s)
[255.257909] [053/133] (768s left) gem_mmap_gtt (basic-small-copy-odd)
[255.310635] Subtest basic-small-copy-odd: SKIP (0.000s)
[255.368968] [054/133] (768s left) kms_big_fb (linear-32bpp-rotate-0)
[255.471078] Starting subtest: linear-32bpp-rotate-0
[256.850736] Subtest linear-32bpp-rotate-0: SUCCESS (1.378s)
[256.987879] [055/133] (767s left) kms_psr (psr-sprite-plane-onoff)
[257.080117] Starting subtest: psr-sprite-plane-onoff
[257.082018] Starting dynamic subtest: eDP-1
[258.813228] Dynamic subtest eDP-1: SUCCESS (1.731s)
[258.815611] Subtest psr-sprite-plane-onoff: SUCCESS (1.732s)
[259.648004] [056/133] (764s left) api_intel_allocator (two-level-inception-interruptible)
[259.703400] Starting subtest: two-level-inception-interruptible
[265.160748] Subtest two-level-inception-interruptible: SUCCESS (5.405s)
[265.268100] [057/133] (758s left) kms_plane_multiple (tiling-yf)
[265.371194] Starting subtest: tiling-yf
[265.375128] Subtest tiling-yf: SKIP (0.000s)
[265.445497] [058/133] (758s left) kms_lease (possible-crtcs-filtering)
[265.545989] Starting subtest: possible-crtcs-filtering
[265.550546] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[265.662543] [059/133] (758s left) sw_sync (timeline_closed_signaled)
[265.698126] Starting subtest: timeline_closed_signaled
[265.700519] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[265.758977] [060/133] (758s left) prime_vgem (basic-write)
[265.842271] Starting subtest: basic-write
[265.861506] Subtest basic-write: SKIP (0.017s)
[265.997889] [061/133] (758s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[266.096731] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[266.108954] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[266.194101] [062/133] (758s left) gem_lmem_swapping (heavy-verify-random)
[266.234534] Subtest heavy-verify-random: SKIP (0.000s)
[266.286500] [063/133] (758s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[266.378357] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[266.380270] Starting dynamic subtest: pipe-A
[266.440881] Dynamic subtest pipe-A: SUCCESS (0.065s)
[266.450157] Starting dynamic subtest: pipe-B
[267.579649] Dynamic subtest pipe-B: SUCCESS (1.137s)
[267.594361] Starting dynamic subtest: pipe-C
[268.684947] Dynamic subtest pipe-C: SUCCESS (1.104s)
[268.694629] Starting dynamic subtest: pipe-D
[269.819660] Dynamic subtest pipe-D: SUCCESS (1.134s)
[269.822065] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.442s)
[270.989804] [064/133] (753s left) gem_exec_balancer (hog)
[271.056542] Starting subtest: hog
[271.060638] Subtest hog: SKIP (0.000s)
[271.403875] [065/133] (753s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[271.467575] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[271.543163] [066/133] (752s left) gem_ctx_isolation (dirty-create)
[271.591137] Starting subtest: dirty-create
[271.593436] Starting dynamic subtest: rcs0
[271.777474] Dynamic subtest rcs0: SUCCESS (0.186s)
[271.787073] Starting dynamic subtest: bcs0
[271.973507] Dynamic subtest bcs0: SUCCESS (0.195s)
[271.983323] Starting dynamic subtest: vcs0
[272.176154] Dynamic subtest vcs0: SUCCESS (0.202s)
[272.186224] Starting dynamic subtest: vcs1
[274.019617] Dynamic subtest vcs1: SUCCESS (1.842s)
[274.029704] Starting dynamic subtest: vecs0
[276.001281] Dynamic subtest vecs0: SUCCESS (1.980s)
[276.014213] Starting dynamic subtest: ccs0
[278.074412] Dynamic subtest ccs0: SUCCESS (2.071s)
[278.076758] Subtest dirty-create: SUCCESS (6.481s)
[278.305264] [067/133] (746s left) gem_mmap (short-mmap)
[278.367838] Subtest short-mmap: SKIP (0.000s)
[278.431730] [068/133] (746s left) kms_content_protection (lic-type-0-hdcp14)
[278.573189] Starting subtest: lic-type-0-hdcp14
[278.577880] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[278.681681] [069/133] (745s left) kms_properties (plane-properties-atomic)
[278.769206] Starting subtest: plane-properties-atomic
[278.771430] Starting dynamic subtest: pipe-A-eDP-1
[279.315547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[279.325164] Starting dynamic subtest: pipe-B-eDP-1
[280.561775] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.245s)
[280.571771] Starting dynamic subtest: pipe-C-eDP-1
[281.786637] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s)
[281.798186] Starting dynamic subtest: pipe-D-eDP-1
[283.026013] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[283.028468] Subtest plane-properties-atomic: SUCCESS (4.258s)
[283.868561] [070/133] (740s left) kms_plane_alpha_blend (constant-alpha-mid)
[283.966127] Starting subtest: constant-alpha-mid
[284.247445] Starting dynamic subtest: pipe-A-eDP-1
[285.185126] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.935s)
[285.195148] Starting dynamic subtest: pipe-D-eDP-1
[286.731531] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.546s)
[286.733753] Subtest constant-alpha-mid: SUCCESS (2.764s)
[287.588619] [071/133] (737s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[287.983669] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[288.798605] [072/133] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[288.891882] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[293.188094] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.299s)
[294.335935] [073/133] (730s left) gem_exec_reloc (basic-gtt-cpu-active)
[294.390487] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[294.462153] [074/133] (730s left) gem_eio (create-ext)
[294.688477] Starting subtest: create-ext
[295.010054] Subtest create-ext: SUCCESS (0.320s)
[295.162576] [075/133] (729s left) syncobj_timeline (invalid-query-bad-pad)
[295.227036] Starting subtest: invalid-query-bad-pad
[295.229241] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[295.325437] [076/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[295.423128] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[295.426490] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[295.514668] [077/133] (729s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[295.613369] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[295.617085] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[295.702210] [078/133] (729s left) drm_buddy (drm_buddy)
[295.740766] Starting subtest: drm_buddy
[295.744622] Subtest drm_buddy: SKIP (0.001s)
[295.803053] [079/133] (729s left) gen3_render_linear_blits
[295.918488] [080/133] (729s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[296.037052] Starting subtest: flip-vs-cursor-atomic-transitions
[303.560401] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.518s)
[304.366136] [081/133] (720s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[304.421756] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[304.423670] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[304.515720] [082/133] (720s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[304.602820] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[304.605143] Starting dynamic subtest: pipe-A-default-mode
[305.724870] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[305.729388] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.121s)
[305.882944] [083/133] (719s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[305.978706] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[305.983011] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[306.073284] [084/133] (719s left) fbdev (pan)
[306.114187] Starting subtest: pan
[306.145611] Subtest pan: SUCCESS (0.033s)
[306.218647] [085/133] (719s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[306.313399] Starting subtest: 4-tiled-32bpp-rotate-270
[306.333274] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[306.439205] [086/133] (718s left) gem_ctx_persistence (heartbeat-close)
[306.488707] Starting subtest: heartbeat-close
[306.493129] Subtest heartbeat-close: SKIP (0.000s)
[306.592319] [087/133] (718s left) kms_joiner (basic-big-joiner)
[306.688772] Starting subtest: basic-big-joiner
[306.692345] Subtest basic-big-joiner: SKIP (0.000s)
[306.755882] [088/133] (718s left) gem_lmem_swapping (random-engines)
[306.801333] Subtest random-engines: SKIP (0.000s)
[306.844749] [089/133] (718s left) kms_sequence (get-forked)
[306.931396] Starting subtest: get-forked
[306.933028] Starting dynamic subtest: pipe-A-eDP-1
[308.835565] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.902s)
[308.846043] Starting dynamic subtest: pipe-B-eDP-1
[311.364712] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.527s)
[311.375317] Starting dynamic subtest: pipe-C-eDP-1
[313.855105] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.488s)
[313.870487] Starting dynamic subtest: pipe-D-eDP-1
[316.369638] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.514s)
[316.372045] Subtest get-forked: SUCCESS (9.437s)
[317.212067] [090/133] (708s left) kms_psr (pr-sprite-plane-move)
[317.306205] Starting subtest: pr-sprite-plane-move
[317.310382] Subtest pr-sprite-plane-move: SKIP (0.000s)
[317.380755] [091/133] (708s left) core_auth (getclient-simple)
[317.424830] Starting subtest: getclient-simple
[317.445122] Subtest getclient-simple: SUCCESS (0.018s)
[317.541318] [092/133] (708s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[317.640250] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[317.642624] Starting dynamic subtest: pipe-A-eDP-1
[328.624830] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.986s)
[328.636547] Starting dynamic subtest: pipe-B-eDP-1
[340.335990] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.705s)
[340.337980] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.694s)
[341.187179] [093/133] (684s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[341.288135] Starting subtest: fbc-psr-cursor-mmap-gtt
[341.290422] Starting dynamic subtest: eDP-1
[341.294612] Dynamic subtest eDP-1: SKIP (0.000s)
[341.298895] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[341.365704] [094/133] (684s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[341.451014] Starting subtest: random-ccs-data-yf-tiled-ccs
[341.453158] Starting dynamic subtest: pipe-A-eDP-1
[341.477050] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[341.488599] Starting dynamic subtest: pipe-B-eDP-1
[341.510892] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[341.520683] Starting dynamic subtest: pipe-C-eDP-1
[341.543986] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[341.554524] Starting dynamic subtest: pipe-D-eDP-1
[341.578040] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[341.582275] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[343.737915] [095/133] (682s left) syncobj_eventfd (timeline-wait)
[343.801956] Starting subtest: timeline-wait
[343.810770] Subtest timeline-wait: SUCCESS (0.011s)
[343.918566] [096/133] (681s left) kms_pm_rpm (dpms-non-lpsp)
[345.940512] Starting subtest: dpms-non-lpsp
[345.945134] Subtest dpms-non-lpsp: SKIP (0.001s)
[346.315407] [097/133] (679s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[346.402674] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[346.406856] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[346.479302] [098/133] (679s left) gem_create (create-clear)
[346.521324] Starting subtest: create-clear
[346.523196] Starting dynamic subtest: smem0
[379.240375] Dynamic subtest smem0: SUCCESS (32.708s)
[379.242267] Subtest create-clear: SUCCESS (32.710s)
[379.445448] [099/133] (646s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[379.545555] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[380.512558] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.967s)
[380.653289] [100/133] (645s left) kms_dp_link_training (uhbr-mst)
[380.765410] Starting subtest: uhbr-mst
[380.772624] Subtest uhbr-mst: SKIP (0.000s)
[380.838296] [101/133] (645s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[380.925612] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[382.114153] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.189s)
[382.236109] [102/133] (643s left) gem_exec_schedule (preempt-self)
[382.309693] Starting subtest: preempt-self
[382.311404] Starting dynamic subtest: rcs0
[382.325220] Dynamic subtest rcs0: SUCCESS (0.020s)
[382.336857] Starting dynamic subtest: bcs0
[382.343281] Dynamic subtest bcs0: SUCCESS (0.017s)
[382.352847] Starting dynamic subtest: vcs0
[382.363525] Dynamic subtest vcs0: SUCCESS (0.019s)
[382.377762] Starting dynamic subtest: vcs1
[382.386127] Dynamic subtest vcs1: SUCCESS (0.021s)
[382.395669] Starting dynamic subtest: vecs0
[382.405655] Dynamic subtest vecs0: SUCCESS (0.019s)
[382.415039] Starting dynamic subtest: ccs0
[382.426702] Dynamic subtest ccs0: SUCCESS (0.020s)
[382.428684] Subtest preempt-self: SUCCESS (0.123s)
[383.948252] [103/133] (642s left) syncobj_timeline (etime-multi-wait-all-submitted)
[384.013395] Starting subtest: etime-multi-wait-all-submitted
[384.121540] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[384.201815] [104/133] (641s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[384.306810] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[384.311064] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[384.408219] [105/133] (641s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[384.500726] Starting subtest: fbc-pr-cursor-mmap-gtt
[384.504982] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[384.573559] [106/133] (641s left) kms_feature_discovery (display-2x)
[384.671957] Starting subtest: display-2x
[384.675932] Subtest display-2x: SKIP (0.000s)
[384.755401] [107/133] (641s left) syncobj_timeline (reset-signaled)
[384.804124] Starting subtest: reset-signaled
[384.806064] Subtest reset-signaled: SUCCESS (0.000s)
[384.903841] [108/133] (641s left) syncobj_timeline (wait-all-for-submit-complex)
[384.957513] Starting subtest: wait-all-for-submit-complex
[385.171094] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[385.259944] [109/133] (641s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[385.355655] Starting subtest: primary-y-tiled-reflect-x-90
[385.360053] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[385.440306] [110/133] (640s left) sysfs_timeslice_duration (timeout)
[385.505297] Starting subtest: timeout
[385.507658] Starting dynamic subtest: vecs0
[394.853723] Dynamic subtest vecs0: SUCCESS (9.341s)
[394.866375] Starting dynamic subtest: ccs0
[396.127496] Dynamic subtest ccs0: SUCCESS (1.275s)
[396.137561] Starting dynamic subtest: vcs0
[405.794733] Dynamic subtest vcs0: SUCCESS (9.659s)
[405.807146] Starting dynamic subtest: bcs0
[406.443050] Dynamic subtest bcs0: SUCCESS (0.648s)
[406.455178] Starting dynamic subtest: rcs0
[407.744711] Dynamic subtest rcs0: SUCCESS (1.300s)
[407.757390] Starting dynamic subtest: vcs1
[416.799780] Dynamic subtest vcs1: SUCCESS (9.049s)
[416.802330] Subtest timeout: SUCCESS (31.283s)
[416.875218] [111/133] (609s left) i915_pm_rc6_residency (rc6-accuracy)
[416.939918] Starting subtest: rc6-accuracy
[416.942305] Starting dynamic subtest: gt0
[420.172785] Dynamic subtest gt0: SUCCESS (3.173s)
[420.185757] Starting dynamic subtest: gt1
[423.342783] Dynamic subtest gt1: SUCCESS (3.167s)
[423.345489] Subtest rc6-accuracy: SUCCESS (6.346s)
[423.388014] [112/133] (603s left) kms_color (invalid-ctm-matrix-sizes)
[423.502856] Starting subtest: invalid-ctm-matrix-sizes
[423.505174] Starting dynamic subtest: pipe-A
[423.507470] Dynamic subtest pipe-A: SUCCESS (0.002s)
[423.520217] Starting dynamic subtest: pipe-B
[423.522173] Dynamic subtest pipe-B: SUCCESS (0.003s)
[423.531881] Starting dynamic subtest: pipe-C
[423.534191] Dynamic subtest pipe-C: SUCCESS (0.004s)
[423.543823] Starting dynamic subtest: pipe-D
[423.545738] Dynamic subtest pipe-D: SUCCESS (0.004s)
[423.547661] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.016s)
[423.589030] [113/133] (602s left) kms_plane (plane-panning-bottom-right)
[423.693012] Starting subtest: plane-panning-bottom-right
[423.694958] Starting dynamic subtest: pipe-A
[425.689602] Dynamic subtest pipe-A: FAIL (1.405s)
[425.701995] Starting dynamic subtest: pipe-B
[428.053573] Dynamic subtest pipe-B: FAIL (2.347s)
[428.055887] Subtest plane-panning-bottom-right: FAIL (3.756s)
[428.657326] [114/133] (597s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[428.763103] Starting subtest: psr-1p-primscrn-spr-indfb-move
[436.237984] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.476s)
[436.387652] [115/133] (590s left) gem_bad_reloc (negative-reloc-bltcopy)
[436.448248] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[436.519273] [116/133] (590s left) kms_psr (psr2-no-drrs)
[436.607093] Starting subtest: psr2-no-drrs
[436.609374] Starting dynamic subtest: eDP-1
[438.227019] Dynamic subtest eDP-1: SUCCESS (1.620s)
[438.229392] Subtest psr2-no-drrs: SUCCESS (1.621s)
[439.039508] [117/133] (587s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[439.413048] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[440.248904] [118/133] (586s left) kms_flip (2x-modeset-vs-vblank-race)
[440.346009] Starting subtest: 2x-modeset-vs-vblank-race
[440.356832] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[440.435871] [119/133] (586s left) gem_readwrite (write-bad-handle)
[440.498529] Subtest write-bad-handle: SKIP (0.000s)
[440.557374] [120/133] (586s left) gem_exec_schedule (implicit-write-read)
[440.624164] Starting subtest: implicit-write-read
[440.626336] Starting dynamic subtest: rcs0
[440.719745] Dynamic subtest rcs0: SUCCESS (0.105s)
[440.734708] Starting dynamic subtest: vcs0
[440.815403] Dynamic subtest vcs0: SUCCESS (0.095s)
[440.829606] Starting dynamic subtest: vcs1
[440.896838] Dynamic subtest vcs1: SUCCESS (0.080s)
[440.911985] Starting dynamic subtest: vecs0
[440.974392] Dynamic subtest vecs0: SUCCESS (0.077s)
[440.987147] Starting dynamic subtest: ccs0
[441.066501] Dynamic subtest ccs0: SUCCESS (0.091s)
[441.068872] Subtest implicit-write-read: SUCCESS (0.453s)
[441.914286] [121/133] (584s left) gem_exec_basic (basic)
[441.985891] Starting subtest: basic
[441.988208] Starting dynamic subtest: rcs0-smem
[441.990622] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[442.004846] Starting dynamic subtest: bcs0-smem
[442.006723] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[442.016017] Starting dynamic subtest: vcs0-smem
[442.017881] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[442.026724] Starting dynamic subtest: vcs1-smem
[442.028672] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[442.037572] Starting dynamic subtest: vecs0-smem
[442.039477] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[442.048744] Starting dynamic subtest: ccs0-smem
[442.050652] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[442.052544] Subtest basic: SUCCESS (0.015s)
[443.859768] [122/133] (583s left) gem_softpin (allocator-nopin-reserve)
[443.917470] Starting subtest: allocator-nopin-reserve
[444.012818] Subtest allocator-nopin-reserve: SUCCESS (0.094s)
[444.176524] [123/133] (582s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[444.271708] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[444.274007] Starting dynamic subtest: pipe-A-eDP-1
[476.198645] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.857s)
[476.215923] Starting dynamic subtest: pipe-B-eDP-1
[509.126858] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.710s)
[509.138077] Starting dynamic subtest: pipe-C-eDP-1
[542.126650] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.587s)
[542.142954] Starting dynamic subtest: pipe-D-eDP-1
[575.088407] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.619s)
[575.090645] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.779s)
[576.263019] [124/133] (450s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[576.390848] Starting subtest: 2x-long-cursor-vs-flip-atomic
[576.395234] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[576.540328] [125/133] (450s left) gem_mmap_wc (bad-object)
[576.592016] Subtest bad-object: SKIP (0.000s)
[576.653437] [126/133] (450s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[576.745053] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[576.747352] Starting dynamic subtest: A-eDP1
[580.288925] Dynamic subtest A-eDP1: SUCCESS (3.535s)
[580.299849] Starting dynamic subtest: B-eDP1
[583.488517] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[583.500216] Starting dynamic subtest: C-eDP1
[586.595766] Dynamic subtest C-eDP1: SUCCESS (3.107s)
[586.607055] Starting dynamic subtest: D-eDP1
[589.730420] Dynamic subtest D-eDP1: SUCCESS (3.129s)
[589.732720] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.972s)
[590.539979] [127/133] (436s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[590.643650] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[590.647988] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[590.743710] [128/133] (436s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[590.802725] Starting subtest: y-tiled-ccs-to-yf-tiled
[590.807367] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[591.014050] [129/133] (436s left) kms_flip (flip-vs-blocking-wf-vblank)
[591.113654] Starting subtest: flip-vs-blocking-wf-vblank
[591.116094] Starting dynamic subtest: A-eDP1
[600.082410] Dynamic subtest A-eDP1: SUCCESS (8.967s)
[600.093118] Starting dynamic subtest: B-eDP1
[609.025595] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[609.035636] Starting dynamic subtest: C-eDP1
[617.994825] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[618.007849] Starting dynamic subtest: D-eDP1
[626.933968] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[626.935886] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.766s)
[628.110258] [130/133] (399s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[628.223560] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[635.406480] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.188s)
[635.535175] [131/133] (391s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[635.601548] Starting subtest: rel-constants-invalid-rel-gen5
[635.603463] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[635.699262] [132/133] (391s left) vgem_basic (debugfs)
[635.753396] Starting subtest: debugfs
[635.755380] Subtest debugfs: SUCCESS (0.000s)
[635.815185] [133/133] (391s left) i915_selftest (live)
[639.204360] Starting subtest: live
[639.206998] Starting dynamic subtest: sanitycheck
[643.555259] Dynamic subtest sanitycheck: SUCCESS (4.349s)
[643.565130] Starting dynamic subtest: uncore
[647.840612] Dynamic subtest uncore: SUCCESS (4.283s)
[647.856629] Starting dynamic subtest: workarounds
[665.904388] Dynamic subtest workarounds: FAIL (17.798s)
[665.913740] Starting dynamic subtest: gt_engines
[668.628048] Dynamic subtest gt_engines: SUCCESS (2.980s)
[668.638544] Starting dynamic subtest: gt_timelines
[682.651724] Dynamic subtest gt_timelines: SUCCESS (14.018s)
[682.662501] Starting dynamic subtest: gt_contexts
[686.982611] Dynamic subtest gt_contexts: SUCCESS (4.327s)
[686.991682] Starting dynamic subtest: gt_lrc
[692.997665] Dynamic subtest gt_lrc: SUCCESS (6.015s)
[693.008408] Starting dynamic subtest: gt_mocs
[695.884382] Dynamic subtest gt_mocs: SUCCESS (2.886s)
[695.894785] Starting dynamic subtest: gt_pm
[702.628639] Dynamic subtest gt_pm: SUCCESS (6.745s)
[702.638717] Starting dynamic subtest: gt_heartbeat
[706.917300] Dynamic subtest gt_heartbeat: SUCCESS (4.287s)
[706.928035] Starting dynamic subtest: gt_tlb
[716.909742] Dynamic subtest gt_tlb: SUCCESS (9.992s)
[716.920010] Starting dynamic subtest: requests
[728.833155] Dynamic subtest requests: SUCCESS (11.920s)
[728.843780] Starting dynamic subtest: migrate
[736.581429] Dynamic subtest migrate: SUCCESS (7.745s)
[736.591909] Starting dynamic subtest: active
[740.889997] Dynamic subtest active: SUCCESS (4.306s)
[740.900685] Starting dynamic subtest: objects
[744.140808] Dynamic subtest objects: SUCCESS (3.249s)
[744.151120] Starting dynamic subtest: mman
[748.848036] Dynamic subtest mman: SUCCESS (4.706s)
[748.858659] Starting dynamic subtest: dmabuf
[753.143387] Dynamic subtest dmabuf: SUCCESS (4.290s)
[753.153679] Starting dynamic subtest: vma
[757.471946] Dynamic subtest vma: SUCCESS (4.327s)
[757.483056] Starting dynamic subtest: coherency
[762.340206] Dynamic subtest coherency: SUCCESS (4.866s)
[762.351200] Starting dynamic subtest: gtt
[774.414622] Dynamic subtest gtt: SUCCESS (12.069s)
[774.425440] Starting dynamic subtest: gem
[780.560165] Dynamic subtest gem: SUCCESS (6.143s)
[780.573263] Starting dynamic subtest: evict
[785.994191] Dynamic subtest evict: SUCCESS (5.431s)
[786.004909] Starting dynamic subtest: hugepages
[795.315791] Dynamic subtest hugepages: SUCCESS (9.317s)
[795.325127] Starting dynamic subtest: gem_contexts
[822.991060] Dynamic subtest gem_contexts: SUCCESS (27.670s)
[823.002334] Starting dynamic subtest: client
[827.332601] Dynamic subtest client: SUCCESS (4.341s)
[827.343302] Starting dynamic subtest: gem_migrate
[829.937973] Dynamic subtest gem_migrate: SUCCESS (2.604s)
[829.949045] Starting dynamic subtest: reset
[834.284949] Dynamic subtest reset: SUCCESS (4.346s)
[834.294572] Starting dynamic subtest: memory_region
[838.619710] Dynamic subtest memory_region: SUCCESS (4.333s)
[838.633235] Starting dynamic subtest: hangcheck
[854.069963] Dynamic subtest hangcheck: SUCCESS (15.449s)
[854.081042] Starting dynamic subtest: execlists
[858.449711] Dynamic subtest execlists: SUCCESS (4.378s)
[858.460427] Starting dynamic subtest: ring_submission
[862.708121] Dynamic subtest ring_submission: SUCCESS (4.258s)
[862.724328] Starting dynamic subtest: perf
[867.010331] Dynamic subtest perf: SUCCESS (4.301s)
[867.021300] Starting dynamic subtest: slpc
[879.644068] Dynamic subtest slpc: SUCCESS (12.629s)
[879.660720] Starting dynamic subtest: guc
[883.475011] Dynamic subtest guc: SUCCESS (3.828s)
[883.490496] Starting dynamic subtest: guc_multi_lrc
[887.808976] Dynamic subtest guc_multi_lrc: SUCCESS (4.333s)
[887.819432] Starting dynamic subtest: guc_hang
[892.640289] Dynamic subtest guc_hang: SUCCESS (4.829s)
[892.650637] Starting dynamic subtest: late_gt_pm
[896.958078] Dynamic subtest late_gt_pm: SUCCESS (4.317s)
[896.960634] Subtest live: FAIL (257.730s)
[896.987661] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[896.988414] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[896.988553] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: sriov_basic
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: gem_tiled_swapping
results: parsing output: 14/ for test: gem_exec_capture
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_setmode
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_exec_parallel
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: perf_pmu
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gen9_exec_parse
results: parsing output: 38/ for test: gem_mmap_offset
results: parsing output: 39/ for test: gem_exec_await
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_busy
results: parsing output: 43/ for test: i915_pm_freq_api
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: api_intel_allocator
results: parsing output: 56/ for test: kms_plane_multiple
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: gem_lmem_swapping
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gem_ctx_isolation
results: parsing output: 66/ for test: gem_mmap
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: kms_properties
results: parsing output: 69/ for test: kms_plane_alpha_blend
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: drm_buddy
results: parsing output: 78/ for test: gen3_render_linear_blits
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: fbdev
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_sequence
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: core_auth
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: syncobj_eventfd
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: gem_create
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_dp_link_training
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_feature_discovery
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: sysfs_timeslice_duration
results: parsing output: 110/ for test: i915_pm_rc6_residency
results: parsing output: 111/ for test: kms_color
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_bad_reloc
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_chamelium_edid
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: gem_readwrite
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: gem_exec_basic
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: vgem_basic
results: parsing output: 132/ for test: i915_selftest
Done.