[60.458162] Initializing watchdogs
[60.458211]   /dev/watchdog0
[60.472875] [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]
[60.477506] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.479946] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.483448] [001/132] (960s left) gem_userptr_blits (unsync-unmap-cycles)
[60.585985] Subtest unsync-unmap-cycles: SKIP (0.000s)
[60.729777] [002/132] (960s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[60.839731] Starting subtest: fbc-psr2-sprite-plane-onoff
[60.842046] Starting dynamic subtest: eDP-1
[60.846374] Dynamic subtest eDP-1: SKIP (0.000s)
[60.850807] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[60.926616] [003/132] (960s left) gem_flink_basic (flink-lifetime)
[60.989952] Starting subtest: flink-lifetime
[60.992390] Subtest flink-lifetime: SUCCESS (0.002s)
[61.102012] [004/132] (959s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[61.206363] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[61.208695] Starting dynamic subtest: pipe-A-eDP-1
[61.487302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.250s)
[61.495033] Starting dynamic subtest: pipe-B-eDP-1
[62.846458] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.354s)
[62.855459] Starting dynamic subtest: pipe-C-eDP-1
[64.115648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.266s)
[64.124750] Starting dynamic subtest: pipe-D-eDP-1
[65.372591] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[65.374666] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.133s)
[66.567293] [005/132] (954s left) gem_ctx_isolation (preservation-reset)
[66.740306] Starting subtest: preservation-reset
[66.743704] Starting dynamic subtest: rcs0
[66.963342] Dynamic subtest rcs0: SUCCESS (0.224s)
[66.972443] Starting dynamic subtest: bcs0
[67.561081] Dynamic subtest bcs0: SUCCESS (0.597s)
[67.569333] Starting dynamic subtest: vcs0
[67.894965] Dynamic subtest vcs0: SUCCESS (0.333s)
[67.902740] Starting dynamic subtest: vcs1
[69.096316] Dynamic subtest vcs1: SUCCESS (1.201s)
[69.106744] Starting dynamic subtest: vecs0
[71.162897] Dynamic subtest vecs0: SUCCESS (2.066s)
[71.172867] Starting dynamic subtest: ccs0
[73.151542] Dynamic subtest ccs0: SUCCESS (1.988s)
[73.154164] Subtest preservation-reset: SUCCESS (6.414s)
[73.278293] [006/132] (947s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[73.369803] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[73.373968] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[73.437306] [007/132] (947s left) kms_getfb (getfb2-handle-closed)
[73.532720] Starting subtest: getfb2-handle-closed
[73.535043] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[73.620670] [008/132] (947s left) kms_psr (psr-primary-render)
[73.710198] Starting subtest: psr-primary-render
[73.712615] Starting dynamic subtest: eDP-1
[75.470648] Dynamic subtest eDP-1: SUCCESS (1.761s)
[75.473137] Subtest psr-primary-render: SUCCESS (1.761s)
[76.334995] [009/132] (944s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[76.425452] Starting subtest: random-ccs-data-yf-tiled-ccs
[76.427840] Starting dynamic subtest: pipe-A-eDP-1
[76.453831] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.463439] Starting dynamic subtest: pipe-B-eDP-1
[76.487126] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.494686] Starting dynamic subtest: pipe-C-eDP-1
[76.518013] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.525047] Starting dynamic subtest: pipe-D-eDP-1
[76.549366] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.553699] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[78.701600] [010/132] (942s left) kms_psr (fbc-psr2-sprite-blt)
[78.791696] Starting subtest: fbc-psr2-sprite-blt
[78.793818] Starting dynamic subtest: eDP-1
[78.797751] Dynamic subtest eDP-1: SKIP (0.000s)
[78.801707] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[78.861169] [011/132] (942s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[78.922717] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[79.033359] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[79.124070] [012/132] (942s left) perf (enable-disable)
[79.254324] Starting subtest: enable-disable
[79.256648] Starting dynamic subtest: 0-rcs0
[79.770469] Dynamic subtest 0-rcs0: FAIL (0.472s)
[79.779812] Starting dynamic subtest: 1-vecs0
[80.658261] Dynamic subtest 1-vecs0: FAIL (0.876s)
[80.660080] Subtest enable-disable: FAIL (1.349s)
[81.281271] [013/132] (940s left) kms_invalid_mode (bad-htotal)
[81.381146] Starting subtest: bad-htotal
[81.383391] Starting dynamic subtest: pipe-A-eDP-1
[81.663690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[81.673089] Starting dynamic subtest: pipe-B-eDP-1
[81.675066] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[81.681979] Starting dynamic subtest: pipe-C-eDP-1
[81.683972] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[81.691277] Starting dynamic subtest: pipe-D-eDP-1
[81.693600] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[81.695986] Subtest bad-htotal: SUCCESS (0.290s)
[82.516368] [014/132] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[82.623715] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[82.628188] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[82.704206] [015/132] (938s left) kms_psr (psr2-cursor-mmap-cpu)
[82.784662] Starting subtest: psr2-cursor-mmap-cpu
[82.786956] Starting dynamic subtest: eDP-1
[84.510201] Dynamic subtest eDP-1: SUCCESS (1.725s)
[84.512567] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.726s)
[85.383393] [016/132] (936s left) kms_chamelium_frames (dp-frame-dump)
[85.779712] Subtest dp-frame-dump: SKIP (0.000s)
[86.644118] [017/132] (934s left) kms_dsc (dsc-fractional-bpp)
[86.754811] Starting subtest: dsc-fractional-bpp
[86.768357] Subtest dsc-fractional-bpp: SKIP (0.000s)
[86.839254] [018/132] (934s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[86.936598] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[86.938742] Starting dynamic subtest: A-eDP1
[90.555192] Dynamic subtest A-eDP1: SUCCESS (3.614s)
[90.563107] Starting dynamic subtest: B-eDP1
[93.755824] Dynamic subtest B-eDP1: SUCCESS (3.199s)
[93.770970] Starting dynamic subtest: C-eDP1
[96.876412] Dynamic subtest C-eDP1: SUCCESS (3.121s)
[96.885763] Starting dynamic subtest: D-eDP1
[99.986166] Dynamic subtest D-eDP1: SUCCESS (3.108s)
[99.988348] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.049s)
[100.781843] [019/132] (920s left) gem_exec_reloc (basic-gtt-wc)
[100.852725] Subtest basic-gtt-wc: SKIP (0.000s)
[100.922536] [020/132] (920s left) kms_atomic_interruptible (legacy-setmode)
[101.019031] Starting subtest: legacy-setmode
[101.021382] Starting dynamic subtest: pipe-A-eDP-1
[107.904100] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.883s)
[107.906457] Subtest legacy-setmode: SUCCESS (6.885s)
[108.703792] [021/132] (913s left) gem_mmap_wc (bad-object)
[108.766081] Subtest bad-object: SKIP (0.000s)
[108.826641] [022/132] (913s left) kms_properties (plane-properties-atomic)
[108.918082] Starting subtest: plane-properties-atomic
[108.920307] Starting dynamic subtest: pipe-A-eDP-1
[109.474458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[109.488429] Starting dynamic subtest: pipe-B-eDP-1
[110.761785] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.287s)
[110.770865] Starting dynamic subtest: pipe-C-eDP-1
[111.986344] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s)
[111.995670] Starting dynamic subtest: pipe-D-eDP-1
[113.214277] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[113.216718] Subtest plane-properties-atomic: SUCCESS (4.297s)
[114.024921] [023/132] (907s left) kms_flip (2x-blocking-absolute-wf_vblank)
[114.121568] Starting subtest: 2x-blocking-absolute-wf_vblank
[114.133026] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[114.226682] [024/132] (907s left) gem_exec_schedule (u-lateslice)
[114.304243] Starting subtest: u-lateslice
[114.306203] Starting dynamic subtest: rcs0
[114.317635] Dynamic subtest rcs0: SUCCESS (0.021s)
[114.328317] Starting dynamic subtest: bcs0
[114.335237] Dynamic subtest bcs0: SUCCESS (0.017s)
[114.342930] Starting dynamic subtest: vcs0
[114.353624] Dynamic subtest vcs0: SUCCESS (0.018s)
[114.361345] Starting dynamic subtest: vcs1
[114.371972] Dynamic subtest vcs1: SUCCESS (0.018s)
[114.379547] Starting dynamic subtest: vecs0
[114.391181] Dynamic subtest vecs0: SUCCESS (0.019s)
[114.398877] Starting dynamic subtest: ccs0
[114.409800] Dynamic subtest ccs0: SUCCESS (0.018s)
[114.412141] Subtest u-lateslice: SUCCESS (0.114s)
[115.994262] [025/132] (905s left) prime_vgem (coherency-gtt)
[116.121197] Starting subtest: coherency-gtt
[116.125827] Subtest coherency-gtt: SKIP (0.000s)
[116.239040] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[116.242502] [026/132] (905s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[116.338832] Starting subtest: y-tiled-16bpp-rotate-270
[116.343140] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[116.424020] [027/132] (905s left) kms_plane (plane-position-hole-dpms)
[116.515438] Starting subtest: plane-position-hole-dpms
[117.057592] Starting dynamic subtest: pipe-A-plane-1
[119.461770] Dynamic subtest pipe-A-plane-1: SUCCESS (2.403s)
[119.471101] Starting dynamic subtest: pipe-A-plane-2
[121.801182] Dynamic subtest pipe-A-plane-2: SUCCESS (2.340s)
[121.810166] Starting dynamic subtest: pipe-A-plane-3
[124.210932] Dynamic subtest pipe-A-plane-3: SUCCESS (2.407s)
[124.220032] Starting dynamic subtest: pipe-A-plane-4
[126.663903] Dynamic subtest pipe-A-plane-4: SUCCESS (2.453s)
[126.672688] Starting dynamic subtest: pipe-A-plane-5
[126.689471] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[127.922769] Starting dynamic subtest: pipe-B-plane-1
[130.331225] Dynamic subtest pipe-B-plane-1: SUCCESS (2.413s)
[130.339838] Starting dynamic subtest: pipe-B-plane-2
[132.708657] Dynamic subtest pipe-B-plane-2: SUCCESS (2.379s)
[132.717622] Starting dynamic subtest: pipe-B-plane-3
[135.131087] Dynamic subtest pipe-B-plane-3: SUCCESS (2.419s)
[135.140091] Starting dynamic subtest: pipe-B-plane-4
[137.505812] Dynamic subtest pipe-B-plane-4: SUCCESS (2.375s)
[137.514314] Starting dynamic subtest: pipe-B-plane-5
[137.531538] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[137.533666] Subtest plane-position-hole-dpms: SUCCESS (21.016s)
[138.304430] [028/132] (883s left) kms_content_protection (content-type-change)
[138.449568] Starting subtest: content-type-change
[138.454059] Subtest content-type-change: SKIP (0.000s)
[138.566807] [029/132] (883s left) gem_ctx_shared (q-smoketest-all)
[138.632709] Starting subtest: Q-smoketest-all
[171.005469] Subtest Q-smoketest-all: SUCCESS (32.323s)
[171.971700] [030/132] (850s left) gem_mmap_gtt (hang-user)
[172.035061] Subtest hang-user: SKIP (0.000s)
[172.095683] [031/132] (850s left) kms_psr (psr2-cursor-plane-onoff)
[172.207145] Starting subtest: psr2-cursor-plane-onoff
[172.209363] Starting dynamic subtest: eDP-1
[173.885197] Dynamic subtest eDP-1: SUCCESS (1.677s)
[173.887468] Subtest psr2-cursor-plane-onoff: SUCCESS (1.678s)
[174.679457] [032/132] (847s left) gem_spin_batch (resubmit-all)
[174.740346] Starting subtest: resubmit-all
[174.742695] Starting dynamic subtest: rcs0
[174.751434] Dynamic subtest rcs0: SUCCESS (0.011s)
[174.759999] Starting dynamic subtest: bcs0
[174.762351] Dynamic subtest bcs0: SUCCESS (0.002s)
[174.769842] Starting dynamic subtest: vcs0
[174.771687] Dynamic subtest vcs0: SUCCESS (0.002s)
[174.778877] Starting dynamic subtest: vcs1
[174.780734] Dynamic subtest vcs1: SUCCESS (0.002s)
[174.787936] Starting dynamic subtest: vecs0
[174.789836] Dynamic subtest vecs0: SUCCESS (0.002s)
[174.797575] Starting dynamic subtest: ccs0
[174.799486] Dynamic subtest ccs0: SUCCESS (0.002s)
[174.801377] Subtest resubmit-all: SUCCESS (0.026s)
[175.933156] [033/132] (846s left) api_intel_bb (blit-noreloc-purge-cache)
[175.998497] Starting subtest: blit-noreloc-purge-cache
[176.011498] Subtest blit-noreloc-purge-cache: SUCCESS (0.014s)
[176.119086] [034/132] (846s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[176.218789] Starting subtest: x-tiled-16bpp-rotate-0
[177.533075] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.314s)
[177.666279] [035/132] (844s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[177.753056] Starting subtest: stress-xrgb8888-xtiled
[183.597561] Subtest stress-xrgb8888-xtiled: SUCCESS (5.846s)
[183.649082] [036/132] (838s left) kms_cursor_crc (cursor-alpha-opaque)
[183.740923] Starting subtest: cursor-alpha-opaque
[183.742809] Starting dynamic subtest: pipe-A-eDP-1
[184.360116] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[184.371166] Starting dynamic subtest: pipe-D-eDP-1
[185.684768] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[185.687079] Subtest cursor-alpha-opaque: SUCCESS (1.943s)
[186.551007] [037/132] (835s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[186.678683] Starting subtest: short-flip-after-cursor-toggle
[187.602048] Subtest short-flip-after-cursor-toggle: SUCCESS (0.924s)
[188.490441] [038/132] (834s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[188.590932] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[188.594944] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[188.668960] [039/132] (833s left) gem_exec_whisper (basic-forked-all)
[188.733166] Starting subtest: basic-forked-all
[202.296516] Subtest basic-forked-all: SUCCESS (13.561s)
[202.495446] [040/132] (820s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[202.599287] Starting subtest: yf-tiled-16bpp-rotate-0
[202.603182] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[202.700332] [041/132] (819s left) kms_chamelium_hpd (common-hpd-after-suspend)
[203.090803] Subtest common-hpd-after-suspend: SKIP (0.000s)
[203.896970] [042/132] (818s left) kms_sequence (queue-busy)
[204.000648] Starting subtest: queue-busy
[204.002880] Starting dynamic subtest: pipe-A-eDP-1
[205.957823] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.954s)
[205.966673] Starting dynamic subtest: pipe-B-eDP-1
[208.533286] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.572s)
[208.543899] Starting dynamic subtest: pipe-C-eDP-1
[211.137978] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.606s)
[211.146603] Starting dynamic subtest: pipe-D-eDP-1
[213.672798] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[213.675082] Subtest queue-busy: SUCCESS (9.671s)
[214.468864] [043/132] (808s left) gem_mmap_gtt (basic-write)
[214.524492] Subtest basic-write: SKIP (0.000s)
[214.586096] [044/132] (808s left) prime_vgem (basic-write)
[214.666946] Starting subtest: basic-write
[214.691577] Subtest basic-write: SKIP (0.020s)
[214.825644] [045/132] (807s left) kms_vblank (wait-forked-busy-hang)
[214.915792] Starting subtest: wait-forked-busy-hang
[214.917614] Starting dynamic subtest: pipe-A-eDP-1
[241.680775] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.765s)
[241.693752] Starting dynamic subtest: pipe-D-eDP-1
[266.648970] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.965s)
[266.651447] Subtest wait-forked-busy-hang: SUCCESS (51.735s)
[267.534014] [046/132] (755s left) gem_exec_reloc (basic-cpu)
[267.594946] Subtest basic-cpu: SKIP (0.000s)
[267.662571] [047/132] (755s left) kms_pm_rpm (pm-caching)
[269.192484] Starting subtest: pm-caching
[269.197087] Subtest pm-caching: SKIP (0.000s)
[269.988890] [048/132] (752s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[270.093933] Starting subtest: fbc-2p-pri-indfb-multidraw
[270.098289] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[270.208234] [049/132] (752s left) gen3_render_tiledy_blits
[270.318248] [050/132] (752s left) kms_pm_rpm (drm-resources-equal)
[272.034220] Starting subtest: drm-resources-equal
[277.250135] Subtest drm-resources-equal: SUCCESS (5.217s)
[277.354370] [051/132] (745s left) i915_pm_rpm (reg-read-ioctl)
[279.085497] Starting subtest: reg-read-ioctl
[281.362750] Subtest reg-read-ioctl: SUCCESS (2.282s)
[281.729315] [052/132] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[281.838287] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[281.842579] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[281.933446] [053/132] (741s left) kms_atomic_transition (modeset-transition)
[282.023857] Starting subtest: modeset-transition
[282.025715] Starting dynamic subtest: 1x-outputs
[292.894656] Dynamic subtest 1x-outputs: SUCCESS (10.872s)
[292.897042] Subtest modeset-transition: SUCCESS (10.874s)
[293.750251] [054/132] (729s left) kms_frontbuffer_tracking (psr-suspend)
[293.850717] Starting subtest: psr-suspend
[332.426806] Subtest psr-suspend: SUCCESS (8.068s)
[332.552179] [055/132] (690s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[332.635931] Starting subtest: y-tiled-ccs-to-x-tiled
[332.640120] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[332.817928] [056/132] (690s left) gem_ctx_exec (basic-invalid-context)
[332.876397] Starting subtest: basic-invalid-context
[332.882664] Subtest basic-invalid-context: SUCCESS (0.007s)
[333.014372] [057/132] (690s left) gem_userptr_blits (stress-mm-invalidate-close)
[333.080166] Starting subtest: stress-mm-invalidate-close
[335.231763] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[335.358969] [058/132] (687s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[335.474340] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[335.476621] Starting dynamic subtest: pipe-A-default-mode
[338.169649] Dynamic subtest pipe-A-default-mode: SUCCESS (2.694s)
[338.171994] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.696s)
[339.038909] [059/132] (684s left) gem_exec_schedule (fairslice-all)
[339.111412] Starting subtest: fairslice-all
[341.175626] Subtest fairslice-all: SUCCESS (2.059s)
[342.389091] [060/132] (680s left) device_reset (unbind-cold-reset-rebind)
[342.437448] Starting subtest: unbind-cold-reset-rebind
[342.442602] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[342.501738] [061/132] (680s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[342.618859] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[342.999336] Starting dynamic subtest: pipe-A-eDP-1
[345.730118] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.728s)
[346.094075] Starting dynamic subtest: pipe-B-eDP-1
[348.856478] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[349.231570] Starting dynamic subtest: pipe-C-eDP-1
[351.999775] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.774s)
[352.369554] Starting dynamic subtest: pipe-D-eDP-1
[355.135222] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[355.137770] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.511s)
[356.315648] [062/132] (667s left) tools_test (sysfs_l3_parity)
[356.376119] Starting subtest: sysfs_l3_parity
[356.434687] Subtest sysfs_l3_parity: SKIP (0.070s)
[356.488446] [063/132] (667s left) gem_ringfill (legacy-basic)
[362.437823] Starting subtest: legacy-basic
[362.440358] Starting dynamic subtest: default
[362.502516] Dynamic subtest default: SUCCESS (0.064s)
[362.514605] Starting dynamic subtest: render
[362.544324] Dynamic subtest render: SUCCESS (0.040s)
[362.554762] Starting dynamic subtest: bsd
[362.587370] Dynamic subtest bsd: SUCCESS (0.041s)
[362.598099] Starting dynamic subtest: bsd1
[362.630379] Dynamic subtest bsd1: SUCCESS (0.041s)
[362.641180] Starting dynamic subtest: bsd2
[362.670473] Dynamic subtest bsd2: SUCCESS (0.038s)
[362.680547] Starting dynamic subtest: blt
[362.715472] Dynamic subtest blt: SUCCESS (0.043s)
[362.726576] Starting dynamic subtest: vebox
[362.758446] Dynamic subtest vebox: SUCCESS (0.041s)
[362.761254] Subtest legacy-basic: SUCCESS (0.323s)
[362.850915] [064/132] (660s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[362.962788] Starting subtest: cursorB-vs-flipB-varying-size
[362.967118] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[363.111694] [065/132] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[363.204043] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[363.208408] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[363.301562] [066/132] (660s left) gem_softpin (evict-active-interruptible)
[363.355587] Starting subtest: evict-active-interruptible
[363.362749] Subtest evict-active-interruptible: SUCCESS (0.007s)
[363.460988] [067/132] (660s left) gem_mmap_gtt (fault-concurrent-x)
[363.511052] Subtest fault-concurrent-X: SKIP (0.000s)
[363.569632] [068/132] (660s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[363.622047] Starting subtest: wait-all-for-submit-delayed-submit
[363.724572] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[363.801324] [069/132] (659s left) i915_drm_fdinfo (busy-idle-check-all)
[363.842202] Starting subtest: busy-idle-check-all
[363.844404] Starting dynamic subtest: rcs0
[363.848810] Dynamic subtest rcs0: SKIP (0.004s)
[363.858160] Starting dynamic subtest: bcs0
[363.862202] Dynamic subtest bcs0: SKIP (0.000s)
[363.871600] Starting dynamic subtest: vcs0
[363.876035] Dynamic subtest vcs0: SKIP (0.000s)
[363.885045] Starting dynamic subtest: vcs1
[363.889103] Dynamic subtest vcs1: SKIP (0.000s)
[363.898114] Starting dynamic subtest: vecs0
[363.902231] Dynamic subtest vecs0: SKIP (0.000s)
[363.911488] Starting dynamic subtest: ccs0
[363.915600] Dynamic subtest ccs0: SKIP (0.000s)
[363.919650] Subtest busy-idle-check-all: SKIP (0.009s)
[363.957806] [070/132] (659s left) kms_addfb_basic (unused-modifier)
[364.031357] Starting subtest: unused-modifier
[364.033716] Subtest unused-modifier: SUCCESS (0.000s)
[364.161340] [071/132] (659s left) kms_big_fb (linear-32bpp-rotate-270)
[364.267260] Starting subtest: linear-32bpp-rotate-270
[364.286867] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[364.390042] [072/132] (659s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[364.487741] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[364.491679] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[364.585251] [073/132] (659s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[364.673611] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[364.678006] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[364.770287] [074/132] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[364.867002] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[364.870366] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[364.960206] [075/132] (659s left) vgem_basic (mmap)
[365.001374] Starting subtest: mmap
[365.006757] Subtest mmap: SUCCESS (0.007s)
[365.063750] [076/132] (658s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[365.153013] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[365.156913] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[366.239406] [077/132] (657s left) i915_selftest (mock)
[367.939408] Starting subtest: mock
[367.941829] Starting dynamic subtest: sanitycheck
[368.615690] Dynamic subtest sanitycheck: SUCCESS (0.679s)
[368.625302] Starting dynamic subtest: shmem
[369.317980] Dynamic subtest shmem: SUCCESS (0.700s)
[369.327651] Starting dynamic subtest: fence
[377.524582] Dynamic subtest fence: SUCCESS (8.200s)
[377.534124] Starting dynamic subtest: scatterlist
[379.215600] Dynamic subtest scatterlist: SUCCESS (1.689s)
[379.226160] Starting dynamic subtest: syncmap
[382.405838] Dynamic subtest syncmap: SUCCESS (3.187s)
[382.416499] Starting dynamic subtest: uncore
[383.076811] Dynamic subtest uncore: SUCCESS (0.669s)
[383.086609] Starting dynamic subtest: ring
[383.741816] Dynamic subtest ring: SUCCESS (0.663s)
[383.750976] Starting dynamic subtest: engine
[384.436797] Dynamic subtest engine: SUCCESS (0.693s)
[384.446761] Starting dynamic subtest: timelines
[388.325865] Dynamic subtest timelines: SUCCESS (3.885s)
[388.335996] Starting dynamic subtest: requests
[392.073509] Dynamic subtest requests: SUCCESS (3.745s)
[392.083315] Starting dynamic subtest: objects
[392.826571] Dynamic subtest objects: SUCCESS (0.752s)
[392.836325] Starting dynamic subtest: phys
[393.639307] Dynamic subtest phys: SUCCESS (0.811s)
[393.648825] Starting dynamic subtest: dmabuf
[394.406738] Dynamic subtest dmabuf: SUCCESS (0.766s)
[394.416639] Starting dynamic subtest: vma
[400.161492] Dynamic subtest vma: SUCCESS (5.751s)
[400.176163] Starting dynamic subtest: evict
[401.644570] Dynamic subtest evict: SUCCESS (1.481s)
[401.654560] Starting dynamic subtest: gtt
[405.085916] Dynamic subtest gtt: SUCCESS (3.437s)
[405.095735] Starting dynamic subtest: hugepages
[405.981260] Dynamic subtest hugepages: SUCCESS (0.893s)
[405.991204] Starting dynamic subtest: memory_region
[408.494277] Dynamic subtest memory_region: SUCCESS (2.510s)
[408.497040] Subtest mock: SUCCESS (40.544s)
[408.527163] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[408.527904] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[408.531074] [078/132] (615s left) gem_exec_schedule (implicit-read-write)
[410.088887] Starting subtest: implicit-read-write
[410.092620] Starting dynamic subtest: rcs0
[410.207864] Dynamic subtest rcs0: SUCCESS (0.121s)
[410.218925] Starting dynamic subtest: vcs0
[410.288205] Dynamic subtest vcs0: SUCCESS (0.079s)
[410.299506] Starting dynamic subtest: vcs1
[410.377023] Dynamic subtest vcs1: SUCCESS (0.088s)
[410.390322] Starting dynamic subtest: vecs0
[410.459852] Dynamic subtest vecs0: SUCCESS (0.081s)
[410.472355] Starting dynamic subtest: ccs0
[410.559175] Dynamic subtest ccs0: SUCCESS (0.098s)
[410.562216] Subtest implicit-read-write: SUCCESS (0.473s)
[411.461356] [FACT gem_exec_schedule (implicit-read-write)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[411.462802] [FACT gem_exec_schedule (implicit-read-write)] new: kernel.kmod_is_loaded.i915: true
[411.466799] [079/132] (612s left) gem_exercise_blt (fast-copy)
[411.536554] Starting subtest: fast-copy
[411.539039] Starting dynamic subtest: linear-smem-smem
[411.562332] Dynamic subtest linear-smem-smem: SUCCESS (0.025s)
[411.575586] Starting dynamic subtest: xmajor-smem-smem
[411.581355] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[411.590105] Starting dynamic subtest: tile4-smem-smem
[411.598494] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[411.607044] Starting dynamic subtest: tile64-smem-smem
[411.616287] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[411.618558] Subtest fast-copy: SUCCESS (0.080s)
[411.735485] [080/132] (612s left) gem_exec_balancer (nohangcheck)
[411.990218] Starting subtest: nohangcheck
[412.937803] Subtest nohangcheck: SUCCESS (0.946s)
[413.075455] [081/132] (611s left) syncobj_wait (signal)
[413.131319] Starting subtest: signal
[413.133512] Subtest signal: SUCCESS (0.000s)
[413.248432] [082/132] (611s left) kms_psr (fbc-pr-cursor-render)
[413.360587] Starting subtest: fbc-pr-cursor-render
[413.365038] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[413.432899] [083/132] (610s left) gem_pipe_control_store_loop (fresh-buffer)
[413.509255] Starting subtest: fresh-buffer
[415.663336] Subtest fresh-buffer: SUCCESS (2.152s)
[415.786256] [084/132] (608s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[415.895843] Starting subtest: psr-1p-primscrn-spr-indfb-move
[423.468405] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.575s)
[423.596102] [085/132] (600s left) kms_prop_blob (blob-prop-core)
[423.652131] Starting subtest: blob-prop-core
[423.654108] Subtest blob-prop-core: SUCCESS (0.000s)
[423.739709] [086/132] (600s left) kms_force_connector_basic (force-load-detect)
[423.811604] Starting subtest: force-load-detect
[423.816192] Subtest force-load-detect: SKIP (0.000s)
[423.925080] [087/132] (600s left) syncobj_timeline (wait-for-submit-complex)
[423.985955] Starting subtest: wait-for-submit-complex
[424.047842] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[424.140275] [088/132] (600s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[424.186437] Starting subtest: multi-wait-available-submitted-signaled
[424.188605] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[424.293670] [089/132] (600s left) kms_lease (lease-uevent)
[424.379245] Starting subtest: lease-uevent
[425.389610] Subtest lease-uevent: SUCCESS (1.010s)
[425.469108] [090/132] (599s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[425.572188] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[425.574328] Starting dynamic subtest: pipe-A-eDP-1
[425.596197] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[425.608303] Starting dynamic subtest: pipe-B-eDP-1
[425.629477] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[425.638370] Starting dynamic subtest: pipe-C-eDP-1
[425.659203] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[425.667955] Starting dynamic subtest: pipe-D-eDP-1
[425.689441] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[425.693441] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[427.861793] [091/132] (596s left) i915_drm_fdinfo (virtual-busy-idle)
[427.909935] Starting subtest: virtual-busy-idle
[427.914028] Subtest virtual-busy-idle: SKIP (0.000s)
[427.972470] [092/132] (596s left) perf_pmu (busy-double-start)
[428.013059] Starting subtest: busy-double-start
[428.015238] Starting dynamic subtest: rcs0
[431.648750] Dynamic subtest rcs0: FAIL (3.573s)
[431.659197] Starting dynamic subtest: bcs0
[435.149465] Dynamic subtest bcs0: SUCCESS (3.567s)
[435.161058] Starting dynamic subtest: vcs0
[438.938198] Dynamic subtest vcs0: SUCCESS (3.788s)
[438.950509] Starting dynamic subtest: vcs1
[442.966322] Dynamic subtest vcs1: SUCCESS (4.027s)
[442.978555] Starting dynamic subtest: vecs0
[446.913418] Dynamic subtest vecs0: SUCCESS (3.946s)
[446.925441] Starting dynamic subtest: ccs0
[450.551821] Dynamic subtest ccs0: FAIL (3.567s)
[450.554139] Subtest busy-double-start: FAIL (22.481s)
[450.597141] [093/132] (574s left) kms_plane_lowres (tiling-y)
[450.705521] Starting subtest: tiling-y
[450.709782] Subtest tiling-y: SKIP (0.000s)
[450.779641] [094/132] (574s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[450.876897] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[451.934887] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.060s)
[452.073018] [095/132] (572s left) gem_exec_balancer (persistence)
[452.360324] Starting subtest: persistence
[453.698400] Subtest persistence: SUCCESS (1.337s)
[453.869196] [096/132] (571s left) gen7_exec_parse (bitmasks)
[453.925299] Subtest bitmasks: SKIP (0.000s)
[454.002362] [097/132] (570s left) kms_properties (plane-properties-legacy)
[454.093443] Starting subtest: plane-properties-legacy
[454.095701] Starting dynamic subtest: pipe-A-eDP-1
[454.641980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[454.652340] Starting dynamic subtest: pipe-B-eDP-1
[455.938362] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.294s)
[455.948321] Starting dynamic subtest: pipe-C-eDP-1
[457.164691] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[457.175104] Starting dynamic subtest: pipe-D-eDP-1
[458.400864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[458.403167] Subtest plane-properties-legacy: SUCCESS (4.309s)
[459.205545] [098/132] (565s left) sw_sync (alloc_merge_fence)
[459.242616] Starting subtest: alloc_merge_fence
[459.244945] Subtest alloc_merge_fence: SUCCESS (0.000s)
[459.292524] [099/132] (565s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[459.399331] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[459.403659] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[459.507577] [100/132] (565s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[459.611806] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[459.624145] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[459.708139] [101/132] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[459.823862] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[459.828110] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[459.922723] [102/132] (565s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[460.019392] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[460.023640] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[460.101921] [103/132] (565s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[460.196308] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[467.565750] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.372s)
[467.692197] [104/132] (557s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[467.783019] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[467.785254] Starting dynamic subtest: pipe-A-eDP-1
[467.870749] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[467.881061] Starting dynamic subtest: pipe-B-eDP-1
[469.007594] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[469.012052] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.226s)
[470.193215] [105/132] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[470.286153] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[470.290227] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[470.381988] [106/132] (554s left) gem_ctx_persistence (saturated-hostile)
[470.428883] Starting subtest: saturated-hostile
[470.431172] Starting dynamic subtest: rcs0
[471.236029] Dynamic subtest rcs0: SUCCESS (0.806s)
[471.249090] Starting dynamic subtest: bcs0
[472.025235] Dynamic subtest bcs0: SUCCESS (0.787s)
[472.036623] Starting dynamic subtest: vcs0
[472.819127] Dynamic subtest vcs0: SUCCESS (0.792s)
[472.828985] Starting dynamic subtest: vcs1
[473.623980] Dynamic subtest vcs1: SUCCESS (0.799s)
[473.634300] Starting dynamic subtest: vecs0
[474.429080] Dynamic subtest vecs0: SUCCESS (0.807s)
[474.441261] Starting dynamic subtest: ccs0
[475.273836] Dynamic subtest ccs0: SUCCESS (0.842s)
[475.276300] Subtest saturated-hostile: SUCCESS (4.845s)
[475.353377] [107/132] (550s left) kms_addfb_basic (addfb25-bad-modifier)
[475.450711] Starting subtest: addfb25-bad-modifier
[475.452924] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[475.545048] [108/132] (549s left) gem_ccs (ctrl-surf-copy)
[475.608062] Starting subtest: ctrl-surf-copy
[475.612478] Subtest ctrl-surf-copy: SKIP (0.000s)
[475.730282] [109/132] (549s left) syncobj_timeline (multi-wait-all-available-signaled)
[475.785476] Starting subtest: multi-wait-all-available-signaled
[475.787757] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[475.882761] [110/132] (549s left) perf_pmu (busy-no-semaphores)
[475.920106] Starting subtest: busy-no-semaphores
[475.922294] Starting dynamic subtest: rcs0
[476.493575] Dynamic subtest rcs0: SUCCESS (0.573s)
[476.508187] Starting dynamic subtest: bcs0
[477.044036] Dynamic subtest bcs0: SUCCESS (0.547s)
[477.056191] Starting dynamic subtest: vcs0
[477.595375] Dynamic subtest vcs0: SUCCESS (0.548s)
[477.607852] Starting dynamic subtest: vcs1
[478.917011] Dynamic subtest vcs1: SUCCESS (1.318s)
[478.929748] Starting dynamic subtest: vecs0
[480.902909] Dynamic subtest vecs0: SUCCESS (1.983s)
[480.914866] Starting dynamic subtest: ccs0
[482.947134] Dynamic subtest ccs0: SUCCESS (2.041s)
[482.950282] Subtest busy-no-semaphores: SUCCESS (7.028s)
[483.068294] [111/132] (542s left) template (b)
[483.134541] Starting subtest: B
[483.136829] Subtest B: SUCCESS (0.000s)
[483.238976] [112/132] (542s left) kms_color_pipeline (plane-ctm3x4)
[483.329572] Starting subtest: plane-ctm3x4
[483.452913] Starting dynamic subtest: pipe-A-plane-0
[483.796510] Dynamic subtest pipe-A-plane-0: FAIL (0.164s)
[483.805976] Starting dynamic subtest: pipe-A-plane-1
[484.012620] Dynamic subtest pipe-A-plane-1: FAIL (0.143s)
[484.022595] Starting dynamic subtest: pipe-A-plane-2
[484.226585] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[485.081483] Starting dynamic subtest: pipe-B-plane-0
[485.478801] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[485.489961] Starting dynamic subtest: pipe-B-plane-1
[485.788140] Dynamic subtest pipe-B-plane-1: FAIL (0.145s)
[485.799938] Starting dynamic subtest: pipe-B-plane-2
[486.100575] Dynamic subtest pipe-B-plane-2: FAIL (0.155s)
[486.721033] Starting dynamic subtest: pipe-C-plane-0
[487.178588] Dynamic subtest pipe-C-plane-0: FAIL (0.107s)
[487.189280] Starting dynamic subtest: pipe-C-plane-1
[487.577763] Dynamic subtest pipe-C-plane-1: FAIL (0.132s)
[487.588818] Starting dynamic subtest: pipe-C-plane-2
[487.942595] Dynamic subtest pipe-C-plane-2: FAIL (0.610s)
[488.743267] Starting dynamic subtest: pipe-D-plane-0
[489.287337] Dynamic subtest pipe-D-plane-0: FAIL (0.107s)
[489.299427] Starting dynamic subtest: pipe-D-plane-1
[489.753738] Dynamic subtest pipe-D-plane-1: FAIL (0.602s)
[489.763970] Starting dynamic subtest: pipe-D-plane-2
[490.174795] Dynamic subtest pipe-D-plane-2: FAIL (0.537s)
[490.284079] Subtest plane-ctm3x4: FAIL (6.955s)
[491.115015] [113/132] (534s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[491.224085] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[491.228241] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[491.309904] [114/132] (534s left) gem_pread (snoop)
[491.358694] Subtest snoop: SKIP (0.000s)
[491.424702] [115/132] (534s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[491.505474] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[491.507724] Starting dynamic subtest: pipe-A-eDP-1
[491.529480] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[491.541787] Starting dynamic subtest: pipe-B-eDP-1
[491.562206] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[491.571319] Starting dynamic subtest: pipe-C-eDP-1
[491.592107] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[491.603513] Starting dynamic subtest: pipe-D-eDP-1
[491.625665] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[491.630108] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[493.785204] [116/132] (531s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[494.026607] Starting subtest: cursor-rapid-movement-256x85
[494.073906] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[494.240701] [117/132] (531s left) api_intel_bb (full-batch)
[494.305803] Starting subtest: full-batch
[494.310705] Subtest full-batch: SUCCESS (0.005s)
[494.423816] [118/132] (531s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[494.533319] Starting subtest: short-busy-flip-before-cursor-toggle
[494.537627] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[494.678555] [119/132] (531s left) gem_wait (write-busy)
[494.734678] Starting subtest: write-busy
[494.736595] Starting dynamic subtest: all-engines
[495.352245] Dynamic subtest all-engines: SUCCESS (0.617s)
[495.368220] Starting dynamic subtest: rcs0
[495.908905] Dynamic subtest rcs0: SUCCESS (0.555s)
[495.925601] Starting dynamic subtest: bcs0
[496.459206] Dynamic subtest bcs0: SUCCESS (0.549s)
[496.476243] Starting dynamic subtest: vcs0
[498.433740] Dynamic subtest vcs0: SUCCESS (1.972s)
[498.453275] Starting dynamic subtest: vcs1
[500.417464] Dynamic subtest vcs1: SUCCESS (1.981s)
[500.433705] Starting dynamic subtest: vecs0
[502.400523] Dynamic subtest vecs0: SUCCESS (1.980s)
[502.416916] Starting dynamic subtest: ccs0
[502.950547] Dynamic subtest ccs0: SUCCESS (0.549s)
[502.952933] Subtest write-busy: SUCCESS (8.215s)
[503.167341] [120/132] (522s left) gem_readwrite (new-obj)
[503.222332] Subtest new-obj: SKIP (0.000s)
[503.289278] [121/132] (522s left) gem_pxp (reject-modify-context-protection-off-2)
[503.413142] Starting subtest: reject-modify-context-protection-off-2
[503.415489] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[503.532852] [122/132] (522s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[503.588312] Starting subtest: etime-single-wait-all-available-unsubmitted
[503.694035] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s)
[503.777580] [123/132] (522s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[503.876616] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[511.253803] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.378s)
[511.406377] [124/132] (514s left) gem_ctx_param (invalid-size-get)
[511.469313] Starting subtest: invalid-size-get
[511.471613] Subtest invalid-size-get: SUCCESS (0.002s)
[511.600664] [125/132] (514s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[511.717441] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[511.721495] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[511.813968] [126/132] (514s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[511.901527] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[511.905895] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[511.990395] [127/132] (514s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[512.563126] Starting subtest: syncobj-stationary-timeline-chain-engines
[512.665268] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.106s)
[513.497120] [128/132] (512s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[513.622809] Starting subtest: basic-busy-flip-before-cursor-varying-size
[513.627277] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[513.767432] [129/132] (512s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[513.881456] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[513.886004] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[513.986729] [130/132] (512s left) gem_tiled_partial_pwrite_pread (writes)
[514.050308] Subtest writes: SKIP (0.000s)
[514.124323] [131/132] (512s left) prime_busy (after)
[514.174513] Starting subtest: after
[514.179839] Starting dynamic subtest: rcs0
[514.223365] Dynamic subtest rcs0: SUCCESS (0.045s)
[514.234843] Starting dynamic subtest: bcs0
[514.281846] Dynamic subtest bcs0: SUCCESS (0.058s)
[514.292582] Starting dynamic subtest: vcs0
[514.322522] Dynamic subtest vcs0: SUCCESS (0.040s)
[514.332391] Starting dynamic subtest: vcs1
[514.363057] Dynamic subtest vcs1: SUCCESS (0.040s)
[514.372806] Starting dynamic subtest: vecs0
[514.402723] Dynamic subtest vecs0: SUCCESS (0.039s)
[514.412309] Starting dynamic subtest: ccs0
[514.444005] Dynamic subtest ccs0: SUCCESS (0.040s)
[514.553496] Subtest after: SUCCESS (0.377s)
[514.646299] [132/132] (511s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[514.746765] Starting subtest: plane-upscale-20x20-with-modifiers
[514.749146] Starting dynamic subtest: pipe-A
[515.082747] Dynamic subtest pipe-A: SUCCESS (0.338s)
[515.092456] Starting dynamic subtest: pipe-B
[516.493059] Dynamic subtest pipe-B: SUCCESS (1.409s)
[516.504969] Starting dynamic subtest: pipe-C
[517.927771] Dynamic subtest pipe-C: SUCCESS (1.433s)
[517.938043] Starting dynamic subtest: pipe-D
[519.361206] Dynamic subtest pipe-D: SUCCESS (1.432s)
[519.363370] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.617s)
[520.525688] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_flink_basic
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_ctx_isolation
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_getfb
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_chamelium_frames
results: parsing output: 16/ for test: kms_dsc
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_atomic_interruptible
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_properties
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: prime_vgem
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: gem_spin_batch
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_pipe_stress
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: kms_sequence
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: prime_vgem
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gen3_render_tiledy_blits
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: i915_pm_rpm
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_atomic_transition
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: gem_ctx_exec
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: device_reset
results: parsing output: 60/ for test: kms_async_flips
results: parsing output: 61/ for test: tools_test
results: parsing output: 62/ for test: gem_ringfill
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: i915_selftest
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: gem_exercise_blt
results: parsing output: 79/ for test: gem_exec_balancer
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_pipe_control_store_loop
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_prop_blob
results: parsing output: 85/ for test: kms_force_connector_basic
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: kms_plane_lowres
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: gen7_exec_parse
results: parsing output: 96/ for test: kms_properties
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: gem_ccs
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: template
results: parsing output: 111/ for test: kms_color_pipeline
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_pread
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: gem_wait
results: parsing output: 119/ for test: gem_readwrite
results: parsing output: 120/ for test: gem_pxp
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_ctx_param
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 130/ for test: prime_busy
results: parsing output: 131/ for test: kms_plane_scaling
Done.