[57.177248] Initializing watchdogs
[57.177297]   /dev/watchdog0
[57.193030] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.197481] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.199990] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.203498] [001/155] (960s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[57.364180] Starting subtest: cursor-vs-flip-atomic-transitions
[87.906407] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.424s)
[88.710577] [002/155] (929s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[88.809154] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[88.813561] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[88.890866] [003/155] (928s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[88.990959] Starting subtest: plane-primary-toggle-with-vblank-wait
[88.993318] Starting dynamic subtest: pipe-A-eDP-1
[89.164060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[89.470112] Starting dynamic subtest: pipe-B-eDP-1
[90.412581] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.951s)
[90.715470] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.723s)
[91.574235] [004/155] (926s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-fullscreen)
[91.682321] Starting subtest: fbchdr-2p-primscrn-spr-indfb-fullscreen
[91.686473] Subtest fbchdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[91.774757] [005/155] (926s left) kms_rmfb (close-fd)
[91.862744] Starting subtest: close-fd
[91.864624] Starting dynamic subtest: pipe-A-eDP-1
[91.971840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[91.980542] Starting dynamic subtest: pipe-B-eDP-1
[93.358164] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[93.367965] Starting dynamic subtest: pipe-C-eDP-1
[94.585898] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s)
[94.595451] Starting dynamic subtest: pipe-D-eDP-1
[95.823851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[95.826275] Subtest close-fd: SUCCESS (3.960s)
[97.045189] [006/155] (920s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[97.150367] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[104.275978] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (7.129s)
[104.408916] [007/155] (913s left) gem_exec_params (sol-reset-not-gen7)
[104.475068] Starting subtest: sol-reset-not-gen7
[104.477485] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[104.595610] [008/155] (913s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[104.697283] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[104.701298] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[104.811454] [009/155] (913s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[104.905504] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[105.927637] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.023s)
[106.047785] [010/155] (911s left) gem_exec_balancer (full)
[106.106927] Starting subtest: full
[111.196464] Subtest full: SUCCESS (5.089s)
[111.525881] [011/155] (906s left) syncobj_timeline (invalid-wait-bad-flags)
[111.584650] Starting subtest: invalid-wait-bad-flags
[111.587083] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[111.684023] [012/155] (906s left) gem_mmap_offset (partial-remap)
[111.730760] Starting subtest: partial-remap
[111.732571] Starting dynamic subtest: smem0
[111.743656] Dynamic subtest smem0: SUCCESS (0.007s)
[111.745512] Subtest partial-remap: SUCCESS (0.008s)
[111.835134] [013/155] (906s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[111.948704] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[111.952924] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[112.047736] [014/155] (906s left) kms_chamelium_frames (vga-frame-dump)
[112.436071] Subtest vga-frame-dump: SKIP (0.000s)
[113.313200] [015/155] (904s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[113.366031] Starting subtest: etime-single-wait-all-available-unsubmitted
[113.468709] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[113.545059] [016/155] (904s left) gem_softpin (evict-active)
[113.610886] Starting subtest: evict-active
[113.615808] Subtest evict-active: SUCCESS (0.008s)
[113.760955] [017/155] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[113.854998] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[137.250981] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.401s)
[137.373201] [018/155] (881s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[137.478055] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[137.481458] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[137.572710] [019/155] (880s left) gem_ctx_persistence (heartbeat-hang)
[137.622234] Starting subtest: heartbeat-hang
[137.626237] Subtest heartbeat-hang: SKIP (0.000s)
[137.726645] [020/155] (880s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[137.783643] Starting subtest: yf-tiled-ccs-to-yf-tiled
[137.787358] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[137.960356] [021/155] (880s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[138.046996] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[138.049283] Starting dynamic subtest: pipe-A-eDP-1
[138.071314] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[138.080818] Starting dynamic subtest: pipe-B-eDP-1
[138.102583] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[138.111305] Starting dynamic subtest: pipe-C-eDP-1
[138.132513] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.140923] Starting dynamic subtest: pipe-D-eDP-1
[138.162914] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.166970] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[140.342089] [022/155] (878s left) gem_exec_fence (basic-busy)
[140.514573] Starting subtest: basic-busy
[140.517056] Starting dynamic subtest: rcs0
[140.604414] Dynamic subtest rcs0: SUCCESS (0.093s)
[140.615950] Starting dynamic subtest: bcs0
[140.675872] Dynamic subtest bcs0: SUCCESS (0.069s)
[140.686463] Starting dynamic subtest: vcs0
[140.736271] Dynamic subtest vcs0: SUCCESS (0.059s)
[140.747699] Starting dynamic subtest: vcs1
[140.795487] Dynamic subtest vcs1: SUCCESS (0.057s)
[140.806165] Starting dynamic subtest: vecs0
[140.855348] Dynamic subtest vecs0: SUCCESS (0.058s)
[140.867030] Starting dynamic subtest: ccs0
[140.914587] Dynamic subtest ccs0: SUCCESS (0.057s)
[140.917085] Subtest basic-busy: SUCCESS (0.405s)
[142.354324] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[142.357875] [023/155] (876s left) gem_ctx_param (non-root-set)
[142.409958] Starting subtest: non-root-set
[142.443721] Subtest non-root-set: SUCCESS (0.033s)
[142.539111] [024/155] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[142.585672] Starting subtest: basic-y-tiled-legacy
[142.590610] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[142.725095] [025/155] (875s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[142.827468] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[142.832022] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[142.946055] [026/155] (875s left) gem_exec_whisper (basic-fds-priority-all)
[143.005936] Starting subtest: basic-fds-priority-all
[166.380785] Subtest basic-fds-priority-all: SUCCESS (23.368s)
[166.580503] [027/155] (852s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move)
[166.683433] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move
[166.687714] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[166.780137] [028/155] (852s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[166.915517] Starting subtest: cursorB-vs-flipB-legacy
[166.920065] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[167.096130] [029/155] (851s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[167.198689] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[167.203201] Starting dynamic subtest: A-eDP1
[170.798095] Dynamic subtest A-eDP1: SUCCESS (3.595s)
[170.808243] Starting dynamic subtest: B-eDP1
[174.041627] Dynamic subtest B-eDP1: SUCCESS (3.243s)
[174.051231] Starting dynamic subtest: C-eDP1
[177.260486] Dynamic subtest C-eDP1: SUCCESS (3.214s)
[177.270978] Starting dynamic subtest: D-eDP1
[180.477905] Dynamic subtest D-eDP1: SUCCESS (3.217s)
[180.480214] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.277s)
[181.298428] [030/155] (837s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[181.403327] Starting subtest: pr-overlay-plane-update-continuous-sf
[181.407844] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[181.473093] [031/155] (837s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[181.566188] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[181.570536] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[181.654431] [032/155] (837s left) kms_pipe_crc_basic (hang-read-crc)
[181.754176] Starting subtest: hang-read-crc
[181.756036] Starting dynamic subtest: pipe-A-eDP-1
[183.889720] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.136s)
[183.900069] Starting dynamic subtest: pipe-B-eDP-1
[186.744511] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.850s)
[186.758181] Starting dynamic subtest: pipe-C-eDP-1
[189.497130] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.752s)
[189.507779] Starting dynamic subtest: pipe-D-eDP-1
[192.159449] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.662s)
[192.161697] Subtest hang-read-crc: SUCCESS (10.407s)
[192.989015] [033/155] (826s left) prime_mmap (test_errors)
[193.044882] Starting subtest: test_errors
[193.047357] Starting dynamic subtest: test_errors-smem
[193.142487] Dynamic subtest test_errors-smem: SUCCESS (0.099s)
[193.145324] Subtest test_errors: SUCCESS (0.100s)
[193.242941] [034/155] (825s left) kms_addfb_basic (bad-pitch-256)
[193.288907] Starting subtest: bad-pitch-256
[193.291022] Subtest bad-pitch-256: SUCCESS (0.000s)
[193.436752] [035/155] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[193.534757] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[193.538960] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[193.627068] [036/155] (825s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[193.712156] Starting subtest: fbc-psr2-cursor-mmap-gtt
[193.714340] Starting dynamic subtest: eDP-1
[193.718266] Dynamic subtest eDP-1: SKIP (0.000s)
[193.722287] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[193.800092] [037/155] (825s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[193.894194] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[193.896421] Starting dynamic subtest: pipe-A-eDP-1
[193.915765] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.926303] Starting dynamic subtest: pipe-B-eDP-1
[193.944492] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.953921] Starting dynamic subtest: pipe-C-eDP-1
[193.972079] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.981391] Starting dynamic subtest: pipe-D-eDP-1
[193.998493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.001877] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[196.155597] [038/155] (823s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[196.249778] Starting subtest: fbchdr-farfromfence-mmap-gtt
[196.254533] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[196.359954] [039/155] (822s left) fbdev (eof)
[196.407018] Starting subtest: eof
[196.409479] Subtest eof: SUCCESS (0.000s)
[196.477890] [040/155] (822s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[196.590042] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[196.594460] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[196.693399] [041/155] (822s left) gem_workarounds (suspend-resume-context)
[196.760753] Starting subtest: suspend-resume-context
[212.657267] Subtest suspend-resume-context: SUCCESS (1.712s)
[223.853630] [042/155] (806s left) kms_feature_discovery (display-4x)
[223.961847] Starting subtest: display-4x
[223.966205] Subtest display-4x: SKIP (0.000s)
[224.041107] [043/155] (806s left) i915_hangman (detector)
[224.115681] Starting subtest: detector
[224.118071] Starting dynamic subtest: rcs0
[234.466425] Dynamic subtest rcs0: SUCCESS (10.172s)
[234.479656] Starting dynamic subtest: bcs0
[246.497761] Dynamic subtest bcs0: SUCCESS (11.976s)
[246.513999] Starting dynamic subtest: vcs0
[258.400681] Dynamic subtest vcs0: SUCCESS (11.893s)
[258.413695] Starting dynamic subtest: vcs1
[268.449862] Dynamic subtest vcs1: SUCCESS (10.040s)
[268.463711] Starting dynamic subtest: vecs0
[278.499007] Dynamic subtest vecs0: SUCCESS (10.041s)
[278.513315] Starting dynamic subtest: ccs0
[289.503957] Dynamic subtest ccs0: SUCCESS (10.996s)
[289.506972] Subtest detector: SUCCESS (65.135s)
[289.631845] [044/155] (740s left) prime_self_import (basic-llseek-size)
[289.668471] Starting subtest: basic-llseek-size
[289.682447] Subtest basic-llseek-size: SUCCESS (0.014s)
[289.786687] [045/155] (740s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[289.898434] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[289.902532] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[289.984904] [046/155] (740s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[290.078750] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[290.082633] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[290.181051] [047/155] (740s left) i915_pm_rpm (reg-read-ioctl)
[291.716949] Starting subtest: reg-read-ioctl
[294.011254] Subtest reg-read-ioctl: SUCCESS (2.297s)
[294.417869] [048/155] (736s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt)
[294.526875] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt
[294.531363] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[294.632259] [049/155] (736s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[294.726592] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[294.728403] Starting dynamic subtest: pipe-A-eDP-1
[295.255209] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.498s)
[295.268302] Starting dynamic subtest: pipe-B-eDP-1
[296.796827] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.538s)
[296.810460] Starting dynamic subtest: pipe-C-eDP-1
[298.270562] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.476s)
[298.281597] Starting dynamic subtest: pipe-D-eDP-1
[299.678076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[299.680343] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.923s)
[300.846566] [050/155] (730s left) kms_atomic_interruptible (atomic-setmode)
[300.947651] Starting subtest: atomic-setmode
[300.949903] Starting dynamic subtest: pipe-A-eDP-1
[307.833419] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.881s)
[307.835882] Subtest atomic-setmode: SUCCESS (6.882s)
[308.733173] [051/155] (722s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[308.834333] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[308.838493] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[308.932353] [052/155] (722s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[309.017639] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[309.019968] Starting dynamic subtest: pipe-A-eDP-1
[309.029106] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.041613] Starting dynamic subtest: pipe-B-eDP-1
[309.050362] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.061298] Starting dynamic subtest: pipe-C-eDP-1
[309.069935] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.080539] Starting dynamic subtest: pipe-D-eDP-1
[309.088967] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.093099] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[311.285916] [053/155] (719s left) gem_tiled_pread_basic (basic)
[311.340811] Subtest basic: SKIP (0.000s)
[311.407140] [054/155] (719s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[311.504341] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[311.508542] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[311.600689] [055/155] (719s left) kms_addfb_basic (unused-handle)
[311.661389] Starting subtest: unused-handle
[311.663793] Subtest unused-handle: SUCCESS (0.000s)
[311.811055] [056/155] (719s left) gem_compute (compute-square)
[311.864071] Starting subtest: compute-square
[311.867764] Subtest compute-square: SUCCESS (0.006s)
[311.994312] [057/155] (719s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[312.086312] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[312.090486] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[312.185135] [058/155] (719s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[312.281699] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[312.285200] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[312.388655] [059/155] (718s left) gem_mmap (bad-object)
[312.438209] Subtest bad-object: SKIP (0.000s)
[312.499673] [060/155] (718s left) gem_ctx_persistence (engines-persistence)
[312.548063] Starting subtest: engines-persistence
[312.549930] Starting dynamic subtest: rcs0
[313.350348] Dynamic subtest rcs0: SUCCESS (0.804s)
[313.363940] Starting dynamic subtest: bcs0
[314.119221] Dynamic subtest bcs0: SUCCESS (0.767s)
[314.132077] Starting dynamic subtest: vcs0
[314.875847] Dynamic subtest vcs0: SUCCESS (0.754s)
[314.889258] Starting dynamic subtest: vcs1
[315.623511] Dynamic subtest vcs1: SUCCESS (0.746s)
[315.635784] Starting dynamic subtest: vecs0
[316.393833] Dynamic subtest vecs0: SUCCESS (0.768s)
[316.407691] Starting dynamic subtest: ccs0
[317.204252] Dynamic subtest ccs0: SUCCESS (0.809s)
[317.206844] Subtest engines-persistence: SUCCESS (4.661s)
[317.288906] [061/155] (714s left) kms_psr (pr-primary-mmap-cpu)
[317.380162] Starting subtest: pr-primary-mmap-cpu
[317.384424] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[317.460614] [062/155] (713s left) gem_exec_suspend (basic-s3-devices)
[317.519115] Starting subtest: basic-S3-devices
[317.521354] Starting dynamic subtest: smem
[328.515705] Dynamic subtest smem: SUCCESS (10.999s)
[328.518681] Subtest basic-S3-devices: SUCCESS (11.001s)
[333.767143] [063/155] (702s left) gem_wait (await)
[333.842878] Starting subtest: await
[333.845529] Starting dynamic subtest: all-engines
[334.971006] Dynamic subtest all-engines: SUCCESS (1.128s)
[334.987351] Starting dynamic subtest: rcs0
[336.044875] Dynamic subtest rcs0: SUCCESS (1.070s)
[336.063991] Starting dynamic subtest: bcs0
[337.108429] Dynamic subtest bcs0: SUCCESS (1.060s)
[337.128370] Starting dynamic subtest: vcs0
[338.164606] Dynamic subtest vcs0: SUCCESS (1.054s)
[338.182861] Starting dynamic subtest: vcs1
[339.222975] Dynamic subtest vcs1: SUCCESS (1.055s)
[339.242085] Starting dynamic subtest: vecs0
[340.277096] Dynamic subtest vecs0: SUCCESS (1.052s)
[340.296789] Starting dynamic subtest: ccs0
[341.334248] Dynamic subtest ccs0: SUCCESS (1.054s)
[341.336773] Subtest await: SUCCESS (7.491s)
[341.531982] [064/155] (695s left) kms_prime (basic-crc-vgem)
[341.623148] Starting subtest: basic-crc-vgem
[341.625060] Starting dynamic subtest: second-to-first
[342.613572] Dynamic subtest second-to-first: SUCCESS (0.994s)
[342.615734] Subtest basic-crc-vgem: SUCCESS (0.995s)
[342.723919] [065/155] (693s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[342.833882] Starting subtest: plane-upscale-20x20-with-modifiers
[342.835900] Starting dynamic subtest: pipe-A
[343.170544] Dynamic subtest pipe-A: SUCCESS (0.338s)
[343.181088] Starting dynamic subtest: pipe-B
[344.561589] Dynamic subtest pipe-B: SUCCESS (1.389s)
[344.572336] Starting dynamic subtest: pipe-C
[345.989572] Dynamic subtest pipe-C: SUCCESS (1.427s)
[346.000679] Starting dynamic subtest: pipe-D
[347.423575] Dynamic subtest pipe-D: SUCCESS (1.433s)
[347.425907] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.591s)
[348.618275] [066/155] (688s left) kms_plane (pixel-format-y-tiled-modifier)
[348.709654] Starting subtest: pixel-format-y-tiled-modifier
[348.713628] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[348.782336] [067/155] (687s left) gem_lmem_swapping (verify-ccs)
[348.822088] Subtest verify-ccs: SKIP (0.000s)
[348.869768] [068/155] (687s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[348.967089] Starting subtest: fbcpsrhdr-tiling-4
[348.971660] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[349.092800] [069/155] (687s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[349.192556] Starting subtest: y-tiled-16bpp-rotate-90
[349.197033] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[349.288406] [070/155] (687s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[349.388136] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[349.392227] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[349.490122] [071/155] (687s left) gem_exec_parallel (userptr)
[349.543400] Starting subtest: userptr
[349.545509] Starting dynamic subtest: rcs0
[351.010899] Dynamic subtest rcs0: SUCCESS (1.466s)
[351.024580] Starting dynamic subtest: bcs0
[352.519277] Dynamic subtest bcs0: SUCCESS (1.505s)
[352.530866] Starting dynamic subtest: vcs0
[354.498782] Dynamic subtest vcs0: SUCCESS (1.976s)
[354.511120] Starting dynamic subtest: vcs1
[356.483316] Dynamic subtest vcs1: SUCCESS (1.980s)
[356.496545] Starting dynamic subtest: vecs0
[358.530890] Dynamic subtest vecs0: SUCCESS (2.044s)
[358.544662] Starting dynamic subtest: ccs0
[360.031825] Dynamic subtest ccs0: SUCCESS (1.499s)
[360.034191] Subtest userptr: SUCCESS (10.486s)
[360.233846] [072/155] (676s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[360.330896] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[367.116218] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.788s)
[367.277188] [073/155] (669s left) perf_pmu (module-unload)
[367.369916] Starting subtest: module-unload
[385.922370] Killing the test because the kernel is tainted.
[386.561355] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         2320 [max: 8192]
 dynamic-keys:                          325
 direct dependencies:                 26972 [max: 524288]
 indirect dependencies:              195623
 all direct dependencies:            548844
 dependency chains:                   42855 [max: 524288]
 dependency chain hlocks used:       186555 [max: 2621440]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     265
 in-softirq chains:                     900
 in-process chains:                   41690
 stack-trace entries:                362213 [max: 524288]
 number of stack traces:              15609
 number of stack hash chains:         10022
 combined max dependencies:      1401980614
 hardirq-safe locks:                    121
 hardirq-unsafe locks:                 1352
 softirq-safe locks:                    236
 softirq-unsafe locks:                 1246
 irq-safe locks:                        265
 irq-unsafe locks:                     1352
 hardirq-read-safe locks:                 5
 hardirq-read-unsafe locks:             471
 softirq-read-safe locks:                 8
 softirq-read-unsafe locks:             468
 irq-read-safe locks:                     9
 irq-read-unsafe locks:                 471
 uncategorized locks:                   387
 unused locks:                            1
 max locking depth:                      18
 max bfs queue depth:                   609
 max lock class index:                 2488
 debug_locks:                             0

 zapped classes:                        319
 zapped lock chains:                  12244
 large chain blocks:                      1

[386.570426] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[386.570472] [FACT perf_pmu (module-unload)] new: kernel.is_tainted.taint_die: true
[386.571029] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[386.571120] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_atomic_transition
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_rmfb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_chamelium_frames
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_persistence
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_whisper
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: kms_pipe_crc_basic
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: fbdev
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_workarounds
results: parsing output: 41/ for test: kms_feature_discovery
results: parsing output: 42/ for test: i915_hangman
results: parsing output: 43/ for test: prime_self_import
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_pm_rpm
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_atomic_interruptible
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: gem_tiled_pread_basic
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: gem_compute
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_mmap
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_exec_suspend
results: parsing output: 62/ for test: gem_wait
results: parsing output: 63/ for test: kms_prime
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: kms_plane
results: parsing output: 66/ for test: gem_lmem_swapping
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_parallel
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_async_flips
results: no output, setting notrun
results: parsing output: 74/ for test: i915_drm_fdinfo
results: no output, setting notrun
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 77/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 78/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 80/ for test: kms_invalid_mode
results: no output, setting notrun
results: parsing output: 81/ for test: kms_psr2_sf
results: no output, setting notrun
results: parsing output: 82/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 83/ for test: prime_busy
results: no output, setting notrun
results: parsing output: 84/ for test: sysfs_heartbeat_interval
results: no output, setting notrun
results: parsing output: 85/ for test: kms_color
results: no output, setting notrun
results: parsing output: 86/ for test: api_intel_allocator
results: no output, setting notrun
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 88/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 89/ for test: perf
results: no output, setting notrun
results: parsing output: 90/ for test: kms_cursor_edge_walk
results: no output, setting notrun
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 93/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 94/ for test: gem_pipe_control_store_loop
results: no output, setting notrun
results: parsing output: 95/ for test: kms_content_protection
results: no output, setting notrun
results: parsing output: 96/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 97/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 98/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 101/ for test: gem_partial_pwrite_pread
results: no output, setting notrun
results: parsing output: 102/ for test: perf
results: no output, setting notrun
results: parsing output: 103/ for test: perf
results: no output, setting notrun
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 105/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 106/ for test: dmabuf_sync_file
results: no output, setting notrun
results: parsing output: 107/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: no output, setting notrun
results: parsing output: 110/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 111/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 112/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 114/ for test: kms_universal_plane
results: no output, setting notrun
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 116/ for test: gem_exec_flush
results: no output, setting notrun
results: parsing output: 117/ for test: kms_atomic_interruptible
results: no output, setting notrun
results: parsing output: 118/ for test: gem_mmap_wc
results: no output, setting notrun
results: parsing output: 119/ for test: kms_flip_event_leak
results: no output, setting notrun
results: parsing output: 120/ for test: gen7_exec_parse
results: no output, setting notrun
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 123/ for test: kms_getfb
results: no output, setting notrun
results: parsing output: 124/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 125/ for test: api_intel_bb
results: no output, setting notrun
results: parsing output: 126/ for test: kms_chamelium_color
results: no output, setting notrun
results: parsing output: 127/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 128/ for test: gem_lmem_swapping
results: no output, setting notrun
results: parsing output: 129/ for test: kms_getfb
results: no output, setting notrun
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 131/ for test: kms_addfb_basic
results: no output, setting notrun
results: parsing output: 132/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 133/ for test: kms_psr2_su
results: no output, setting notrun
results: parsing output: 134/ for test: kms_chamelium_hpd
results: no output, setting notrun
results: parsing output: 135/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 136/ for test: gem_madvise
results: no output, setting notrun
results: parsing output: 137/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 138/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 139/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 140/ for test: kms_dither
results: no output, setting notrun
results: parsing output: 141/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 142/ for test: kms_rotation_crc
results: no output, setting notrun
results: parsing output: 143/ for test: kms_plane_scaling
results: no output, setting notrun
results: parsing output: 144/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 145/ for test: gem_eio
results: no output, setting notrun
results: parsing output: 146/ for test: kms_vrr
results: no output, setting notrun
results: parsing output: 147/ for test: kms_lease
results: no output, setting notrun
results: parsing output: 148/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 149/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 150/ for test: intel_hwmon
results: no output, setting notrun
results: parsing output: 151/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
Done.