[59.043950] Initializing watchdogs
[59.044036]   /dev/watchdog0
[59.059445] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.063883] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.066239] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.069939] [001/133] (960s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[59.149786] Starting subtest: yf-tiled-ccs-to-x-tiled
[59.159100] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[59.325527] [002/133] (960s left) gem_mmap_gtt (medium-copy-odd)
[59.385755] Subtest medium-copy-odd: SKIP (0.000s)
[59.440271] [003/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[59.557167] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[66.386266] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.858s)
[66.520172] [004/133] (953s left) kms_cursor_crc (cursor-sliding-512x512)
[66.807904] Starting subtest: cursor-sliding-512x512
[66.812492] Subtest cursor-sliding-512x512: SKIP (0.001s)
[66.981876] [005/133] (952s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[67.292048] Starting subtest: 4-tiled-16bpp-rotate-180
[68.746258] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.459s)
[68.889621] [006/133] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[68.986139] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[68.989816] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[69.084733] [007/133] (950s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[69.138069] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[69.205741] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.026s)
[69.238147] [008/133] (950s left) perf (oa-exponents)
[69.362809] Starting subtest: oa-exponents
[69.364387] Starting dynamic subtest: 0-rcs0
[71.114835] Dynamic subtest 0-rcs0: SUCCESS (1.754s)
[71.123559] Starting dynamic subtest: 1-vecs0
[72.912056] Dynamic subtest 1-vecs0: SUCCESS (1.799s)
[72.914540] Subtest oa-exponents: SUCCESS (3.554s)
[72.958698] [009/133] (946s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[73.085638] Starting subtest: basic-flip-before-cursor-varying-size
[74.011595] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.926s)
[74.834831] [010/133] (945s left) kms_psr (fbc-pr-sprite-render)
[74.948696] Starting subtest: fbc-pr-sprite-render
[74.952793] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[75.015530] [011/133] (944s left) syncobj_wait (multi-wait-for-submit-signaled)
[75.072675] Starting subtest: multi-wait-for-submit-signaled
[75.075092] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[75.170386] [012/133] (944s left) gem_exec_reloc (basic-write-gtt-active)
[75.235086] Subtest basic-write-gtt-active: SKIP (0.000s)
[75.313991] [013/133] (944s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[75.402081] Starting subtest: addfb25-yf-tiled-legacy
[75.403951] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[75.490618] [014/133] (944s left) gem_tiled_swapping (non-threaded)
[75.549613] Subtest non-threaded: SKIP (0.000s)
[75.611914] [015/133] (944s left) gem_exec_capture (userptr)
[75.676763] Starting subtest: userptr
[76.520606] Subtest userptr: SUCCESS (0.843s)
[76.654870] [016/133] (943s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[76.756272] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[76.760906] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[77.863936] [017/133] (942s left) kms_rotation_crc (bad-tiling)
[77.964061] Starting subtest: bad-tiling
[77.968427] Subtest bad-tiling: SKIP (0.001s)
[78.035537] [018/133] (942s left) kms_addfb_basic (small-bo)
[78.129904] Starting subtest: small-bo
[78.131904] Subtest small-bo: SUCCESS (0.000s)
[78.213742] [019/133] (942s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[78.313484] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[78.317756] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[78.382937] [020/133] (941s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[78.480350] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[82.054589] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.578s)
[83.269241] [021/133] (937s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[83.366127] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[83.368462] Starting dynamic subtest: pipe-A-eDP-1
[83.394426] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.403586] Starting dynamic subtest: pipe-B-eDP-1
[83.426765] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.433660] Starting dynamic subtest: pipe-C-eDP-1
[83.456624] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.463573] Starting dynamic subtest: pipe-D-eDP-1
[83.487223] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.491549] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[85.618047] [022/133] (934s left) perf (enable-disable)
[85.713385] Starting subtest: enable-disable
[85.715837] Starting dynamic subtest: 0-rcs0
[87.983930] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[87.992180] Starting dynamic subtest: 1-vcs1
[92.471474] Dynamic subtest 1-vcs1: SUCCESS (4.486s)
[92.474078] Subtest enable-disable: SUCCESS (6.757s)
[92.517589] [023/133] (927s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[92.621884] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[92.624194] Starting dynamic subtest: pipe-A-eDP-1
[92.646383] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[92.655240] Starting dynamic subtest: pipe-B-eDP-1
[92.676140] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[92.682999] Starting dynamic subtest: pipe-C-eDP-1
[92.703635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[92.710648] Starting dynamic subtest: pipe-D-eDP-1
[92.732110] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[92.736417] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[94.896870] [024/133] (925s left) kms_setmode (basic-clone-single-crtc)
[94.957794] Starting subtest: basic-clone-single-crtc
[94.964565] Subtest basic-clone-single-crtc: SKIP (0.000s)
[95.053441] [025/133] (925s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[95.156198] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[95.160657] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[95.261206] [026/133] (925s left) gem_exec_parallel (userptr)
[95.330059] Starting subtest: userptr
[95.332557] Starting dynamic subtest: rcs0
[96.750967] Dynamic subtest rcs0: SUCCESS (1.421s)
[96.758838] Starting dynamic subtest: bcs0
[98.219899] Dynamic subtest bcs0: SUCCESS (1.468s)
[98.230531] Starting dynamic subtest: vcs0
[99.874047] Dynamic subtest vcs0: SUCCESS (1.652s)
[99.883997] Starting dynamic subtest: vcs1
[101.909083] Dynamic subtest vcs1: SUCCESS (2.034s)
[101.918942] Starting dynamic subtest: vecs0
[103.829851] Dynamic subtest vecs0: SUCCESS (1.920s)
[103.838269] Starting dynamic subtest: ccs0
[105.318054] Dynamic subtest ccs0: SUCCESS (1.488s)
[105.320548] Subtest userptr: SUCCESS (9.988s)
[105.507876] [027/133] (915s left) kms_cursor_crc (cursor-random-256x256)
[105.759504] Starting subtest: cursor-random-256x256
[105.764488] Starting dynamic subtest: pipe-A-eDP-1
[109.109878] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.347s)
[109.141473] Starting dynamic subtest: pipe-D-eDP-1
[113.082576] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.948s)
[113.084976] Subtest cursor-random-256x256: SUCCESS (7.322s)
[113.958883] [028/133] (906s left) gem_exec_fence (invalid-fence-array)
[114.431814] Starting subtest: invalid-fence-array
[114.436575] Subtest invalid-fence-array: SUCCESS (0.003s)
[116.000928] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[116.004152] [029/133] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[116.100213] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[116.104199] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[116.190256] [030/133] (904s left) i915_drm_fdinfo (memory-info-idle)
[116.231678] Starting subtest: memory-info-idle
[116.233934] Starting dynamic subtest: smem0
[116.280664] Dynamic subtest smem0: SUCCESS (0.049s)
[116.283114] Subtest memory-info-idle: SUCCESS (0.049s)
[116.355847] [031/133] (904s left) perf_pmu (render-node-busy)
[116.417480] Starting subtest: render-node-busy
[116.419870] Starting dynamic subtest: rcs0
[117.004331] Dynamic subtest rcs0: SUCCESS (0.587s)
[117.015174] Starting dynamic subtest: bcs0
[117.565082] Dynamic subtest bcs0: SUCCESS (0.559s)
[117.576194] Starting dynamic subtest: vcs0
[118.933072] Dynamic subtest vcs0: SUCCESS (1.366s)
[118.944045] Starting dynamic subtest: vcs1
[120.917420] Dynamic subtest vcs1: SUCCESS (1.983s)
[120.927903] Starting dynamic subtest: vecs0
[122.901534] Dynamic subtest vecs0: SUCCESS (1.983s)
[122.912701] Starting dynamic subtest: ccs0
[123.469887] Dynamic subtest ccs0: SUCCESS (0.568s)
[123.472472] Subtest render-node-busy: SUCCESS (7.052s)
[123.546848] [032/133] (897s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[123.643889] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[130.253872] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.613s)
[130.357339] [033/133] (890s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[130.453575] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[134.515093] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.065s)
[135.686113] [034/133] (885s left) kms_flip (2x-plain-flip)
[135.770280] Starting subtest: 2x-plain-flip
[135.781766] Subtest 2x-plain-flip: SKIP (0.011s)
[135.862797] [035/133] (885s left) kms_flip (nonblocking-read)
[135.966390] Starting subtest: nonblocking-read
[135.968420] Subtest nonblocking-read: SUCCESS (0.000s)
[136.065806] [036/133] (884s left) kms_plane (pixel-format-4-tiled-modifier)
[136.170559] Starting subtest: pixel-format-4-tiled-modifier
[136.195981] Starting dynamic subtest: pipe-A-plane-0
[136.818510] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[136.828697] Starting dynamic subtest: pipe-A-plane-3
[137.217893] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[137.226860] Starting dynamic subtest: pipe-A-plane-5
[137.230529] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[138.364181] Starting dynamic subtest: pipe-B-plane-0
[138.969449] Dynamic subtest pipe-B-plane-0: SUCCESS (0.611s)
[138.986450] Starting dynamic subtest: pipe-B-plane-3
[139.423049] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[139.430688] Starting dynamic subtest: pipe-B-plane-5
[139.434229] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[139.733178] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.563s)
[140.544927] [037/133] (880s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[140.636616] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[140.640815] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[140.741685] [038/133] (880s left) gen9_exec_parse (bb-oversize)
[140.797652] Subtest bb-oversize: SKIP (0.000s)
[140.856502] [039/133] (880s left) gem_mmap_offset (close-race)
[140.909025] Starting subtest: close-race
[161.022706] Subtest close-race: SUCCESS (20.112s)
[161.137596] [040/133] (859s left) gem_exec_await (wide-all)
[161.383469] Starting subtest: wide-all
[184.773042] Subtest wide-all: SUCCESS (23.387s)
[184.966129] [041/133] (836s left) kms_vblank (ts-continuation-suspend)
[185.102368] Starting subtest: ts-continuation-suspend
[185.104685] Starting dynamic subtest: pipe-A-eDP-1
[202.039692] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.825s)
[202.052896] Starting dynamic subtest: pipe-D-eDP-1
[220.038697] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s)
[220.041064] Subtest ts-continuation-suspend: SUCCESS (5.407s)
[229.866020] [042/133] (800s left) syncobj_wait (wait-for-submit-complex)
[229.935287] Starting subtest: wait-for-submit-complex
[229.997505] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[230.074096] [043/133] (800s left) kms_busy (extended-pageflip-hang-oldfb)
[230.188141] Starting subtest: extended-pageflip-hang-oldfb
[230.189987] Starting dynamic subtest: pipe-A
[230.611064] Dynamic subtest pipe-A: SUCCESS (0.434s)
[230.621009] Starting dynamic subtest: pipe-D
[231.730389] Dynamic subtest pipe-D: SUCCESS (1.147s)
[231.732651] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.588s)
[232.546134] [044/133] (797s left) i915_pm_freq_api (freq-basic-api)
[232.613278] Starting subtest: freq-basic-api
[232.615753] Starting dynamic subtest: gt0
[232.618109] Dynamic subtest gt0: SUCCESS (0.002s)
[232.628564] Starting dynamic subtest: gt1
[232.630361] Dynamic subtest gt1: SUCCESS (0.003s)
[232.632121] Subtest freq-basic-api: SUCCESS (0.007s)
[232.708898] [045/133] (797s left) gem_exec_whisper (basic-normal)
[232.776610] Starting subtest: basic-normal
[236.363193] Subtest basic-normal: SUCCESS (3.644s)
[236.550223] [046/133] (793s left) gem_userptr_blits (sd-probe)
[236.615072] Starting subtest: sd-probe
[236.616974] Subtest sd-probe: SUCCESS (0.000s)
[236.748909] [047/133] (793s left) kms_cursor_crc (cursor-alpha-transparent)
[236.846158] Starting subtest: cursor-alpha-transparent
[236.848023] Starting dynamic subtest: pipe-A-eDP-1
[237.471197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[237.481256] Starting dynamic subtest: pipe-D-eDP-1
[238.739112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.280s)
[238.740952] Subtest cursor-alpha-transparent: SUCCESS (1.914s)
[239.538385] [048/133] (790s left) prime_mmap (test_forked_cpu_write)
[239.591716] Starting subtest: test_forked_cpu_write
[239.593991] Starting dynamic subtest: test_forked_cpu_write-smem
[239.599080] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[239.600995] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[239.704945] [049/133] (790s left) perf (gen12-unprivileged-single-ctx-counters)
[239.812141] Starting subtest: gen12-unprivileged-single-ctx-counters
[239.814482] Starting dynamic subtest: rcs0
[239.884955] Dynamic subtest rcs0: SUCCESS (0.074s)
[239.887240] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.075s)
[239.937814] [050/133] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[240.059864] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[240.063818] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[240.168045] [051/133] (790s left) kms_pm_rpm (package-g7)
[241.692883] Starting subtest: package-g7
[241.697549] Subtest package-g7: SKIP (0.000s)
[242.458563] [052/133] (788s left) gem_softpin (noreloc-s3)
[242.514444] Starting subtest: noreloc-S3
[263.438945] Subtest noreloc-S3: SUCCESS (5.401s)
[270.635850] [053/133] (767s left) gem_mmap_gtt (basic-small-copy-odd)
[270.699420] Subtest basic-small-copy-odd: SKIP (0.000s)
[270.754696] [054/133] (766s left) kms_big_fb (linear-32bpp-rotate-0)
[270.867043] Starting subtest: linear-32bpp-rotate-0
[272.356817] Subtest linear-32bpp-rotate-0: SUCCESS (1.523s)
[272.491304] [055/133] (765s left) kms_psr (psr-sprite-plane-onoff)
[272.581696] Starting subtest: psr-sprite-plane-onoff
[272.583602] Starting dynamic subtest: eDP-1
[274.367707] Dynamic subtest eDP-1: SUCCESS (1.817s)
[274.370019] Subtest psr-sprite-plane-onoff: SUCCESS (1.819s)
[275.159685] [056/133] (762s left) api_intel_allocator (two-level-inception-interruptible)
[275.217728] Starting subtest: two-level-inception-interruptible
[280.570328] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[280.698996] [057/133] (757s left) kms_plane_multiple (tiling-yf)
[280.803217] Starting subtest: tiling-yf
[280.807660] Subtest tiling-yf: SKIP (0.000s)
[280.879772] [058/133] (757s left) kms_lease (possible-crtcs-filtering)
[280.978793] Starting subtest: possible-crtcs-filtering
[280.983478] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[281.098845] [059/133] (756s left) sw_sync (timeline_closed_signaled)
[281.139814] Starting subtest: timeline_closed_signaled
[281.141991] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[281.192006] [060/133] (756s left) prime_vgem (basic-write)
[281.262947] Starting subtest: basic-write
[281.283603] Subtest basic-write: SKIP (0.019s)
[281.416233] [061/133] (756s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[281.517413] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[281.529740] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[281.611068] [062/133] (756s left) gem_lmem_swapping (heavy-verify-random)
[281.651927] Subtest heavy-verify-random: SKIP (0.000s)
[281.702381] [063/133] (756s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[281.792088] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[281.794021] Starting dynamic subtest: pipe-A
[281.854884] Dynamic subtest pipe-A: SUCCESS (0.065s)
[281.863794] Starting dynamic subtest: pipe-B
[283.004515] Dynamic subtest pipe-B: SUCCESS (1.155s)
[283.015098] Starting dynamic subtest: pipe-C
[284.113903] Dynamic subtest pipe-C: SUCCESS (1.113s)
[284.123747] Starting dynamic subtest: pipe-D
[285.236572] Dynamic subtest pipe-D: SUCCESS (1.128s)
[285.239093] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.464s)
[286.401818] [064/133] (751s left) gem_exec_balancer (hog)
[286.460055] Starting subtest: hog
[286.464641] Subtest hog: SKIP (0.000s)
[286.769313] [065/133] (751s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[286.827564] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[286.894177] [066/133] (751s left) gem_ctx_isolation (dirty-create)
[286.955673] Starting subtest: dirty-create
[286.957992] Starting dynamic subtest: rcs0
[287.142335] Dynamic subtest rcs0: SUCCESS (0.187s)
[287.152245] Starting dynamic subtest: bcs0
[287.351130] Dynamic subtest bcs0: SUCCESS (0.208s)
[287.361697] Starting dynamic subtest: vcs0
[287.557388] Dynamic subtest vcs0: SUCCESS (0.206s)
[287.568853] Starting dynamic subtest: vcs1
[289.185758] Dynamic subtest vcs1: SUCCESS (1.632s)
[289.196076] Starting dynamic subtest: vecs0
[291.188657] Dynamic subtest vecs0: SUCCESS (2.007s)
[291.199218] Starting dynamic subtest: ccs0
[293.198540] Dynamic subtest ccs0: SUCCESS (2.013s)
[293.200833] Subtest dirty-create: SUCCESS (6.258s)
[293.414929] [067/133] (744s left) gem_mmap (short-mmap)
[293.467882] Subtest short-mmap: SKIP (0.000s)
[293.528373] [068/133] (744s left) kms_content_protection (lic-type-0-hdcp14)
[293.669261] Starting subtest: lic-type-0-hdcp14
[293.673581] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[293.782355] [069/133] (744s left) kms_properties (plane-properties-atomic)
[293.880425] Starting subtest: plane-properties-atomic
[293.882311] Starting dynamic subtest: pipe-A-eDP-1
[294.449252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[294.458682] Starting dynamic subtest: pipe-B-eDP-1
[295.777128] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.330s)
[295.786587] Starting dynamic subtest: pipe-C-eDP-1
[297.014999] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[297.025184] Starting dynamic subtest: pipe-D-eDP-1
[298.251280] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[298.253471] Subtest plane-properties-atomic: SUCCESS (4.377s)
[299.042864] [070/133] (739s left) kms_plane_alpha_blend (constant-alpha-mid)
[299.132686] Starting subtest: constant-alpha-mid
[299.416027] Starting dynamic subtest: pipe-A-eDP-1
[300.329851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.913s)
[300.339617] Starting dynamic subtest: pipe-D-eDP-1
[301.895320] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.564s)
[301.897702] Subtest constant-alpha-mid: SUCCESS (2.766s)
[302.699235] [071/133] (735s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[303.097090] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[303.907692] [072/133] (734s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[304.005424] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[308.262597] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.258s)
[309.452594] [073/133] (729s left) gem_exec_reloc (basic-gtt-cpu-active)
[309.524022] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[309.602565] [074/133] (728s left) gem_eio (create-ext)
[309.875459] Starting subtest: create-ext
[310.222638] Subtest create-ext: SUCCESS (0.347s)
[310.357621] [075/133] (728s left) syncobj_timeline (invalid-query-bad-pad)
[310.418089] Starting subtest: invalid-query-bad-pad
[310.420143] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[310.518463] [076/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[310.622272] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[310.625751] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[310.722969] [077/133] (727s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[310.815644] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[310.819400] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[310.915763] [078/133] (727s left) drm_buddy (drm_buddy)
[310.954569] Starting subtest: drm_buddy
[310.958211] Subtest drm_buddy: SKIP (0.001s)
[311.013418] [079/133] (727s left) gen3_render_linear_blits
[311.142100] [080/133] (727s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[311.249732] Starting subtest: flip-vs-cursor-atomic-transitions
[318.821517] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.570s)
[319.665371] [081/133] (719s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[319.734543] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[319.737061] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[319.827043] [082/133] (719s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[319.922709] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[319.924925] Starting dynamic subtest: pipe-A-default-mode
[321.040448] Dynamic subtest pipe-A-default-mode: SKIP (1.115s)
[321.044978] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.116s)
[321.188519] [083/133] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[321.286172] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[321.290130] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[321.376845] [084/133] (717s left) fbdev (pan)
[321.413110] Starting subtest: pan
[321.436150] Subtest pan: SUCCESS (0.026s)
[321.509181] [085/133] (717s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[321.612563] Starting subtest: 4-tiled-32bpp-rotate-270
[321.632541] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[321.772593] [086/133] (717s left) gem_ctx_persistence (heartbeat-close)
[321.836931] Starting subtest: heartbeat-close
[321.841596] Subtest heartbeat-close: SKIP (0.000s)
[321.974294] [087/133] (717s left) kms_joiner (basic-big-joiner)
[322.064580] Starting subtest: basic-big-joiner
[322.068217] Subtest basic-big-joiner: SKIP (0.000s)
[322.133553] [088/133] (717s left) gem_lmem_swapping (random-engines)
[322.173290] Subtest random-engines: SKIP (0.000s)
[322.220105] [089/133] (716s left) kms_sequence (get-forked)
[322.308715] Starting subtest: get-forked
[322.310651] Starting dynamic subtest: pipe-A-eDP-1
[324.190313] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[324.201603] Starting dynamic subtest: pipe-B-eDP-1
[326.744621] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.553s)
[326.757877] Starting dynamic subtest: pipe-C-eDP-1
[329.279599] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.532s)
[329.293188] Starting dynamic subtest: pipe-D-eDP-1
[331.783829] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.505s)
[331.786222] Subtest get-forked: SUCCESS (9.477s)
[332.627656] [090/133] (706s left) kms_psr (pr-sprite-plane-move)
[332.720628] Starting subtest: pr-sprite-plane-move
[332.724705] Subtest pr-sprite-plane-move: SKIP (0.000s)
[332.799915] [091/133] (706s left) core_auth (getclient-simple)
[332.839251] Starting subtest: getclient-simple
[332.860814] Subtest getclient-simple: SUCCESS (0.021s)
[332.956859] [092/133] (706s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[333.053186] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[333.055539] Starting dynamic subtest: pipe-A-eDP-1
[344.063623] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.014s)
[344.078444] Starting dynamic subtest: pipe-B-eDP-1
[355.753422] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.692s)
[355.755580] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.709s)
[356.603801] [093/133] (682s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[356.703386] Starting subtest: fbc-psr-cursor-mmap-gtt
[356.705570] Starting dynamic subtest: eDP-1
[356.709965] Dynamic subtest eDP-1: SKIP (0.000s)
[356.714245] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.002s)
[356.793166] [094/133] (682s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[356.892225] Starting subtest: random-ccs-data-yf-tiled-ccs
[356.894505] Starting dynamic subtest: pipe-A-eDP-1
[356.918555] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[356.929610] Starting dynamic subtest: pipe-B-eDP-1
[356.953142] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[356.963008] Starting dynamic subtest: pipe-C-eDP-1
[356.986519] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[356.996549] Starting dynamic subtest: pipe-D-eDP-1
[357.022891] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.027021] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[359.162511] [095/133] (680s left) syncobj_eventfd (timeline-wait)
[359.234139] Starting subtest: timeline-wait
[359.243251] Subtest timeline-wait: SUCCESS (0.011s)
[359.354429] [096/133] (680s left) kms_pm_rpm (dpms-non-lpsp)
[361.186203] Starting subtest: dpms-non-lpsp
[361.191007] Subtest dpms-non-lpsp: SKIP (0.001s)
[361.587662] [097/133] (677s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[361.687527] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[361.691582] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[361.761067] [098/133] (677s left) gem_create (create-clear)
[361.817940] Starting subtest: create-clear
[361.820154] Starting dynamic subtest: smem0
[394.672953] Dynamic subtest smem0: SUCCESS (32.847s)
[394.674983] Subtest create-clear: SUCCESS (32.849s)
[394.863420] [099/133] (644s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[394.973643] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[396.007742] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.034s)
[396.121088] [100/133] (643s left) kms_dp_link_training (uhbr-mst)
[396.221255] Starting subtest: uhbr-mst
[396.229570] Subtest uhbr-mst: SKIP (0.000s)
[396.305008] [101/133] (643s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[396.394325] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[397.563175] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.167s)
[397.675310] [102/133] (642s left) gem_exec_schedule (preempt-self)
[397.739241] Starting subtest: preempt-self
[397.740925] Starting dynamic subtest: rcs0
[397.759504] Dynamic subtest rcs0: SUCCESS (0.025s)
[397.770319] Starting dynamic subtest: bcs0
[397.780770] Dynamic subtest bcs0: SUCCESS (0.019s)
[397.790409] Starting dynamic subtest: vcs0
[397.800456] Dynamic subtest vcs0: SUCCESS (0.019s)
[397.809681] Starting dynamic subtest: vcs1
[397.820588] Dynamic subtest vcs1: SUCCESS (0.019s)
[397.829744] Starting dynamic subtest: vecs0
[397.848698] Dynamic subtest vecs0: SUCCESS (0.027s)
[397.857940] Starting dynamic subtest: ccs0
[397.868491] Dynamic subtest ccs0: SUCCESS (0.019s)
[397.870435] Subtest preempt-self: SUCCESS (0.134s)
[399.106782] [103/133] (640s left) syncobj_timeline (etime-multi-wait-all-submitted)
[399.170877] Starting subtest: etime-multi-wait-all-submitted
[399.276569] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s)
[399.353493] [104/133] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[399.454798] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[399.459073] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[399.549998] [105/133] (640s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[399.644523] Starting subtest: fbc-pr-cursor-mmap-gtt
[399.648880] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[399.718816] [106/133] (640s left) kms_feature_discovery (display-2x)
[399.809770] Starting subtest: display-2x
[399.814092] Subtest display-2x: SKIP (0.000s)
[399.882499] [107/133] (640s left) syncobj_timeline (reset-signaled)
[399.924718] Starting subtest: reset-signaled
[399.926963] Subtest reset-signaled: SUCCESS (0.000s)
[400.004769] [108/133] (640s left) syncobj_timeline (wait-all-for-submit-complex)
[400.060731] Starting subtest: wait-all-for-submit-complex
[400.274370] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[400.349231] [109/133] (639s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[400.450780] Starting subtest: primary-y-tiled-reflect-x-90
[400.455321] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[400.521893] [110/133] (639s left) sysfs_timeslice_duration (timeout)
[400.577784] Starting subtest: timeout
[400.579939] Starting dynamic subtest: vecs0
[409.953261] Dynamic subtest vecs0: SUCCESS (9.371s)
[409.965745] Starting dynamic subtest: ccs0
[411.205941] Dynamic subtest ccs0: SUCCESS (1.251s)
[411.218082] Starting dynamic subtest: vcs0
[420.964498] Dynamic subtest vcs0: SUCCESS (9.758s)
[420.976602] Starting dynamic subtest: bcs0
[421.583831] Dynamic subtest bcs0: SUCCESS (0.618s)
[421.598318] Starting dynamic subtest: rcs0
[422.799487] Dynamic subtest rcs0: SUCCESS (1.216s)
[422.808980] Starting dynamic subtest: vcs1
[431.969291] Dynamic subtest vcs1: SUCCESS (9.165s)
[431.972164] Subtest timeout: SUCCESS (31.391s)
[432.044393] [111/133] (608s left) i915_pm_rc6_residency (rc6-accuracy)
[432.095128] Starting subtest: rc6-accuracy
[432.097399] Starting dynamic subtest: gt0
[435.266767] Dynamic subtest gt0: SUCCESS (3.170s)
[435.279254] Starting dynamic subtest: gt1
[438.440240] Dynamic subtest gt1: SUCCESS (3.169s)
[438.443141] Subtest rc6-accuracy: SUCCESS (6.346s)
[438.531853] [112/133] (601s left) kms_color (invalid-ctm-matrix-sizes)
[438.633913] Starting subtest: invalid-ctm-matrix-sizes
[438.636163] Starting dynamic subtest: pipe-A
[438.638323] Dynamic subtest pipe-A: SUCCESS (0.002s)
[438.654573] Starting dynamic subtest: pipe-B
[438.656464] Dynamic subtest pipe-B: SUCCESS (0.003s)
[438.671617] Starting dynamic subtest: pipe-C
[438.674027] Dynamic subtest pipe-C: SUCCESS (0.003s)
[438.686826] Starting dynamic subtest: pipe-D
[438.688779] Dynamic subtest pipe-D: SUCCESS (0.004s)
[438.690657] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[438.732392] [113/133] (601s left) kms_plane (plane-panning-bottom-right)
[438.829777] Starting subtest: plane-panning-bottom-right
[438.832035] Starting dynamic subtest: pipe-A
[440.845038] Dynamic subtest pipe-A: FAIL (1.431s)
[440.855921] Starting dynamic subtest: pipe-B
[443.322623] Dynamic subtest pipe-B: FAIL (2.454s)
[443.324955] Subtest plane-panning-bottom-right: FAIL (3.888s)
[443.921869] [114/133] (596s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[444.021646] Starting subtest: psr-1p-primscrn-spr-indfb-move
[451.614391] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.596s)
[451.754246] [115/133] (588s left) gem_bad_reloc (negative-reloc-bltcopy)
[451.823597] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[451.899889] [116/133] (588s left) kms_psr (psr2-no-drrs)
[451.988306] Starting subtest: psr2-no-drrs
[451.990592] Starting dynamic subtest: eDP-1
[453.608874] Dynamic subtest eDP-1: SUCCESS (1.619s)
[453.611042] Subtest psr2-no-drrs: SUCCESS (1.620s)
[454.410703] [117/133] (585s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[454.809666] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[455.622420] [118/133] (584s left) kms_flip (2x-modeset-vs-vblank-race)
[455.718529] Starting subtest: 2x-modeset-vs-vblank-race
[455.730208] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[455.819334] [119/133] (584s left) gem_readwrite (write-bad-handle)
[455.881854] Subtest write-bad-handle: SKIP (0.000s)
[455.943505] [120/133] (584s left) gem_exec_schedule (implicit-write-read)
[456.017924] Starting subtest: implicit-write-read
[456.019860] Starting dynamic subtest: rcs0
[456.125375] Dynamic subtest rcs0: SUCCESS (0.113s)
[456.137723] Starting dynamic subtest: vcs0
[456.204584] Dynamic subtest vcs0: SUCCESS (0.082s)
[456.217382] Starting dynamic subtest: vcs1
[456.286401] Dynamic subtest vcs1: SUCCESS (0.081s)
[456.300820] Starting dynamic subtest: vecs0
[456.383512] Dynamic subtest vecs0: SUCCESS (0.096s)
[456.396308] Starting dynamic subtest: ccs0
[456.488287] Dynamic subtest ccs0: SUCCESS (0.104s)
[456.491000] Subtest implicit-write-read: SUCCESS (0.481s)
[458.068307] [121/133] (582s left) gem_exec_basic (basic)
[458.140896] Starting subtest: basic
[458.143265] Starting dynamic subtest: rcs0-smem
[458.145651] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[458.157444] Starting dynamic subtest: bcs0-smem
[458.159547] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[458.169450] Starting dynamic subtest: vcs0-smem
[458.171600] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[458.181157] Starting dynamic subtest: vcs1-smem
[458.183419] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[458.194427] Starting dynamic subtest: vecs0-smem
[458.196660] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[458.206031] Starting dynamic subtest: ccs0-smem
[458.208294] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[458.210527] Subtest basic: SUCCESS (0.013s)
[460.048308] [122/133] (580s left) gem_softpin (allocator-nopin-reserve)
[460.108768] Starting subtest: allocator-nopin-reserve
[460.203140] Subtest allocator-nopin-reserve: SUCCESS (0.093s)
[460.315380] [123/133] (580s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[460.404547] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[460.406418] Starting dynamic subtest: pipe-A-eDP-1
[493.992533] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.697s)
[494.002907] Starting dynamic subtest: pipe-B-eDP-1
[528.945585] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.456s)
[528.956131] Starting dynamic subtest: pipe-C-eDP-1
[563.904302] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.443s)
[563.917059] Starting dynamic subtest: pipe-D-eDP-1
[598.911256] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.406s)
[598.913601] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.010s)
[609.164190] [124/133] (440s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[609.307372] Starting subtest: 2x-long-cursor-vs-flip-atomic
[609.312073] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[609.451688] [125/133] (440s left) gem_mmap_wc (bad-object)
[609.507365] Subtest bad-object: SKIP (0.000s)
[609.562849] [126/133] (440s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[609.661943] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[609.663846] Starting dynamic subtest: A-eDP1
[613.192426] Dynamic subtest A-eDP1: SUCCESS (3.610s)
[613.202958] Starting dynamic subtest: B-eDP1
[616.348460] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[616.360790] Starting dynamic subtest: C-eDP1
[619.530280] Dynamic subtest C-eDP1: SUCCESS (3.215s)
[619.541009] Starting dynamic subtest: D-eDP1
[622.721834] Dynamic subtest D-eDP1: SUCCESS (3.211s)
[622.724187] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.251s)
[623.523263] [127/133] (426s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[623.631898] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[623.635943] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[623.736366] [128/133] (426s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[623.788279] Starting subtest: y-tiled-ccs-to-yf-tiled
[623.792715] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[623.977874] [129/133] (425s left) kms_flip (flip-vs-blocking-wf-vblank)
[624.078615] Starting subtest: flip-vs-blocking-wf-vblank
[624.081180] Starting dynamic subtest: A-eDP1
[632.950573] Dynamic subtest A-eDP1: SUCCESS (8.899s)
[632.961138] Starting dynamic subtest: B-eDP1
[641.873671] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[641.885761] Starting dynamic subtest: C-eDP1
[650.809600] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[650.820608] Starting dynamic subtest: D-eDP1
[659.744842] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[659.752601] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.698s)
[660.966600] [130/133] (388s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[661.053592] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[668.461449] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.411s)
[668.587585] [131/133] (381s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[668.647889] Starting subtest: rel-constants-invalid-rel-gen5
[668.650242] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[668.770859] [132/133] (381s left) vgem_basic (debugfs)
[668.809395] Starting subtest: debugfs
[668.811517] Subtest debugfs: SUCCESS (0.000s)
[668.867861] [133/133] (381s left) i915_selftest (live)
[672.255110] Starting subtest: live
[672.258276] Starting dynamic subtest: sanitycheck
[676.599020] Dynamic subtest sanitycheck: SUCCESS (4.344s)
[676.609560] Starting dynamic subtest: uncore
[680.938192] Dynamic subtest uncore: SUCCESS (4.338s)
[680.948265] Starting dynamic subtest: workarounds
[698.396712] Dynamic subtest workarounds: FAIL (16.967s)
[698.406098] Starting dynamic subtest: gt_engines
[700.990704] Dynamic subtest gt_engines: SUCCESS (3.088s)
[701.000707] Starting dynamic subtest: gt_timelines
[716.923513] Dynamic subtest gt_timelines: SUCCESS (15.927s)
[716.933169] Starting dynamic subtest: gt_contexts
[719.663269] Dynamic subtest gt_contexts: SUCCESS (2.736s)
[719.673845] Starting dynamic subtest: gt_lrc
[725.796275] Dynamic subtest gt_lrc: SUCCESS (6.131s)
[725.805558] Starting dynamic subtest: gt_mocs
[728.741139] Dynamic subtest gt_mocs: SUCCESS (2.942s)
[728.751176] Starting dynamic subtest: gt_pm
[735.428706] Dynamic subtest gt_pm: SUCCESS (6.686s)
[735.438921] Starting dynamic subtest: gt_heartbeat
[739.781594] Dynamic subtest gt_heartbeat: SUCCESS (4.351s)
[739.791697] Starting dynamic subtest: gt_tlb
[749.105206] Dynamic subtest gt_tlb: SUCCESS (9.305s)
[749.115111] Starting dynamic subtest: requests
[762.566557] Dynamic subtest requests: SUCCESS (13.477s)
[762.575335] Starting dynamic subtest: migrate
[770.319808] Dynamic subtest migrate: SUCCESS (7.752s)
[770.335762] Starting dynamic subtest: active
[774.683253] Dynamic subtest active: SUCCESS (4.363s)
[774.693563] Starting dynamic subtest: objects
[779.484235] Dynamic subtest objects: SUCCESS (4.799s)
[779.494864] Starting dynamic subtest: mman
[782.820389] Dynamic subtest mman: SUCCESS (3.334s)
[782.830796] Starting dynamic subtest: dmabuf
[787.105639] Dynamic subtest dmabuf: SUCCESS (4.284s)
[787.113894] Starting dynamic subtest: vma
[791.394410] Dynamic subtest vma: SUCCESS (4.288s)
[791.404497] Starting dynamic subtest: coherency
[796.799309] Dynamic subtest coherency: SUCCESS (5.404s)
[796.809300] Starting dynamic subtest: gtt
[806.650666] Dynamic subtest gtt: SUCCESS (9.852s)
[806.661367] Starting dynamic subtest: gem
[814.154245] Dynamic subtest gem: SUCCESS (7.504s)
[814.164203] Starting dynamic subtest: evict
[818.147484] Dynamic subtest evict: SUCCESS (3.993s)
[818.157380] Starting dynamic subtest: hugepages
[826.989647] Dynamic subtest hugepages: SUCCESS (8.841s)
[826.998558] Starting dynamic subtest: gem_contexts
[855.547727] Dynamic subtest gem_contexts: SUCCESS (28.550s)
[855.558359] Starting dynamic subtest: client
[859.883096] Dynamic subtest client: SUCCESS (4.333s)
[859.892840] Starting dynamic subtest: gem_migrate
[864.212292] Dynamic subtest gem_migrate: SUCCESS (4.327s)
[864.222302] Starting dynamic subtest: reset
[867.026107] Dynamic subtest reset: SUCCESS (2.811s)
[867.036182] Starting dynamic subtest: memory_region
[871.315630] Dynamic subtest memory_region: SUCCESS (4.287s)
[871.326065] Starting dynamic subtest: hangcheck
[884.449712] Dynamic subtest hangcheck: SUCCESS (13.130s)
[884.463387] Starting dynamic subtest: execlists
[887.172522] Dynamic subtest execlists: SUCCESS (2.722s)
[887.186045] Starting dynamic subtest: ring_submission
[891.509268] Dynamic subtest ring_submission: SUCCESS (4.332s)
[891.519724] Starting dynamic subtest: perf
[895.794491] Dynamic subtest perf: SUCCESS (4.284s)
[895.804578] Starting dynamic subtest: slpc
[909.840925] Dynamic subtest slpc: SUCCESS (14.043s)
[909.851115] Starting dynamic subtest: guc
[913.719259] Dynamic subtest guc: SUCCESS (3.877s)
[913.731543] Starting dynamic subtest: guc_multi_lrc
[916.387979] Dynamic subtest guc_multi_lrc: SUCCESS (2.666s)
[916.398110] Starting dynamic subtest: guc_hang
[921.198873] Dynamic subtest guc_hang: SUCCESS (4.810s)
[921.209348] Starting dynamic subtest: late_gt_pm
[925.549494] Dynamic subtest late_gt_pm: SUCCESS (4.349s)
[925.552200] Subtest live: FAIL (253.295s)
[925.582930] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[925.583612] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[925.583744] 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.