[59.410309] Initializing watchdogs
[59.410357]   /dev/watchdog0
[59.426388] [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.431457] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.433839] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.436151] [001/156] (960s left) kms_content_protection (srm)
[59.591105] Starting subtest: srm
[59.594245] Subtest srm: SKIP (0.002s)
[59.709577] [002/156] (960s left) kms_atomic_transition (plane-toggle-modeset-transition)
[59.802511] Starting subtest: plane-toggle-modeset-transition
[59.803632] Starting dynamic subtest: pipe-A-eDP-1
[72.765813] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.963s)
[72.776776] Starting dynamic subtest: pipe-B-eDP-1
[85.257760] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.485s)
[85.260753] Subtest plane-toggle-modeset-transition: SUCCESS (25.457s)
[86.073579] [003/156] (933s left) gem_exec_whisper (basic-queues-all)
[86.133083] Starting subtest: basic-queues-all
[96.762472] Subtest basic-queues-all: SUCCESS (10.627s)
[96.941682] [004/156] (923s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[97.046890] Starting subtest: x-tiled-64bpp-rotate-90
[97.069253] Subtest x-tiled-64bpp-rotate-90: SKIP (0.022s)
[97.166995] [005/156] (922s left) kms_draw_crc (fill-fb)
[97.249990] Starting subtest: fill-fb
[97.714193] Subtest fill-fb: SUCCESS (0.465s)
[97.800351] [006/156] (922s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt)
[97.885822] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt
[97.887720] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[97.969553] [007/156] (922s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[98.065957] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[98.067873] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[98.157702] [008/156] (922s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[98.247261] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[98.258934] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[98.326658] [009/156] (921s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[98.423131] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[98.424949] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[98.511213] [010/156] (921s left) gem_exec_parallel (fds)
[98.574202] Starting subtest: fds
[98.575086] Starting dynamic subtest: rcs0
[101.016942] Dynamic subtest rcs0: SUCCESS (2.443s)
[101.024206] Starting dynamic subtest: bcs0
[104.485634] Dynamic subtest bcs0: SUCCESS (3.458s)
[104.495474] Starting dynamic subtest: vcs0
[108.553046] Dynamic subtest vcs0: SUCCESS (4.067s)
[108.562942] Starting dynamic subtest: vcs1
[112.596106] Dynamic subtest vcs1: SUCCESS (4.042s)
[112.604166] Starting dynamic subtest: vecs0
[116.580853] Dynamic subtest vecs0: SUCCESS (3.984s)
[116.594568] Starting dynamic subtest: ccs0
[119.879896] Dynamic subtest ccs0: SUCCESS (3.298s)
[119.881861] Subtest fds: SUCCESS (21.296s)
[120.070964] [011/156] (900s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[120.175569] Starting subtest: psr-rgb565-draw-mmap-wc
[127.049105] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.876s)
[127.154820] [012/156] (893s left) gen3_mixed_blits
[127.260944] [013/156] (893s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[127.355056] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[127.357027] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[127.424502] [014/156] (892s left) gem_ctx_param (invalid-ctx-set)
[127.471338] Starting subtest: invalid-ctx-set
[127.472440] Subtest invalid-ctx-set: SUCCESS (0.001s)
[127.563837] [015/156] (892s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[127.645964] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[134.861863] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.210s)
[134.970071] [016/156] (885s left) kms_chamelium_hpd (dp-hpd)
[135.348569] Subtest dp-hpd: SKIP (0.000s)
[136.129410] [017/156] (884s left) gem_userptr_blits (map-fixed-invalidate-busy)
[136.197528] Starting subtest: map-fixed-invalidate-busy
[136.199331] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[136.327564] [018/156] (884s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[136.418056] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[136.418974] Starting dynamic subtest: pipe-A-eDP-1
[138.708782] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.290s)
[138.721741] Starting dynamic subtest: pipe-B-eDP-1
[141.148022] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.438s)
[141.156588] Starting dynamic subtest: pipe-C-eDP-1
[143.275974] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.127s)
[143.285607] Starting dynamic subtest: pipe-D-eDP-1
[145.400064] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.123s)
[145.400840] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.982s)
[146.563368] [019/156] (873s left) kms_cursor_crc (cursor-offscreen-256x256)
[146.796278] Starting subtest: cursor-offscreen-256x256
[146.800484] Starting dynamic subtest: pipe-A-eDP-1
[148.742208] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[148.774188] Starting dynamic subtest: pipe-D-eDP-1
[151.375523] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.608s)
[151.376427] Subtest cursor-offscreen-256x256: SUCCESS (4.578s)
[152.239911] [020/156] (868s left) i915_pm_freq_api (freq-basic-api)
[152.299299] Starting subtest: freq-basic-api
[152.300241] Starting dynamic subtest: gt0
[152.302868] Dynamic subtest gt0: SUCCESS (0.003s)
[152.310831] Starting dynamic subtest: gt1
[152.311629] Dynamic subtest gt1: SUCCESS (0.003s)
[152.312538] Subtest freq-basic-api: SUCCESS (0.008s)
[152.390517] [021/156] (868s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[152.492270] Starting subtest: extended-modeset-hang-newfb-with-reset
[152.493225] Starting dynamic subtest: pipe-A
[166.846878] Dynamic subtest pipe-A: SUCCESS (14.352s)
[166.859121] Starting dynamic subtest: pipe-D
[182.438054] Dynamic subtest pipe-D: SUCCESS (15.588s)
[182.439124] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.944s)
[183.241551] [022/156] (837s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[183.332165] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[183.334046] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[183.418844] [023/156] (837s left) gem_mmap_wc (write)
[183.473104] Subtest write: SKIP (0.000s)
[183.529955] [024/156] (837s left) gem_exec_schedule (u-fairslice)
[183.577749] Starting subtest: u-fairslice
[183.578938] Starting dynamic subtest: rcs0
[185.605912] Dynamic subtest rcs0: SUCCESS (2.025s)
[185.613683] Starting dynamic subtest: bcs0
[187.629293] Dynamic subtest bcs0: SUCCESS (2.020s)
[187.637072] Starting dynamic subtest: vcs0
[189.651071] Dynamic subtest vcs0: SUCCESS (2.021s)
[189.659280] Starting dynamic subtest: vcs1
[191.673331] Dynamic subtest vcs1: SUCCESS (2.020s)
[191.681486] Starting dynamic subtest: vecs0
[193.692955] Dynamic subtest vecs0: SUCCESS (2.020s)
[193.703593] Starting dynamic subtest: ccs0
[195.715627] Dynamic subtest ccs0: SUCCESS (2.025s)
[195.716657] Subtest u-fairslice: SUCCESS (12.136s)
[196.024217] [025/156] (824s left) kms_big_fb (y-tiled-addfb)
[196.124211] Starting subtest: y-tiled-addfb
[196.125894] Subtest y-tiled-addfb: SKIP (0.000s)
[196.218671] [026/156] (824s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[196.329764] Starting subtest: basic-flip-before-cursor-varying-size
[197.254050] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.924s)
[198.068499] [027/156] (822s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[198.447444] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[199.273356] [028/156] (821s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[199.317296] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[199.318301] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[199.418246] [029/156] (821s left) gem_render_copy (y-tiled)
[199.467660] Starting subtest: y-tiled
[199.469304] Subtest y-tiled: SKIP (0.000s)
[199.659349] [030/156] (821s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[199.704591] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[199.824920] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[199.883670] [031/156] (821s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[199.967663] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc
[199.969507] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[200.060121] [032/156] (820s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[200.148958] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[203.841999] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.695s)
[205.010079] [033/156] (815s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[205.057059] Starting subtest: multi-wait-available-submitted-signaled
[205.057918] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[205.143470] [034/156] (815s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[205.233144] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[205.234640] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[205.331135] [035/156] (815s left) kms_async_flips (alternate-sync-async-flip-atomic)
[205.408281] Starting subtest: alternate-sync-async-flip-atomic
[205.792388] Starting dynamic subtest: pipe-A-eDP-1
[208.596466] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.804s)
[208.976185] Starting dynamic subtest: pipe-B-eDP-1
[211.726536] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[212.112848] Starting dynamic subtest: pipe-C-eDP-1
[214.871275] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[215.233705] Starting dynamic subtest: pipe-D-eDP-1
[218.000936] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[218.001899] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.594s)
[219.158290] [036/156] (801s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[219.244449] Starting subtest: basic-max-pipe-crc-check
[219.246458] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[219.283652] [037/156] (801s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[219.377452] Starting subtest: crc-primary-basic-yf-tiled-ccs
[219.378278] Starting dynamic subtest: pipe-A-eDP-1
[219.386756] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[219.396524] Starting dynamic subtest: pipe-B-eDP-1
[219.404410] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[219.412278] Starting dynamic subtest: pipe-C-eDP-1
[219.419894] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[219.427788] Starting dynamic subtest: pipe-D-eDP-1
[219.436226] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[219.437809] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[221.634166] [038/156] (799s left) gem_exercise_blt (fast-copy-emit)
[221.685685] Starting subtest: fast-copy-emit
[221.686790] Starting dynamic subtest: linear-smem-smem-emit
[221.707389] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[221.718234] Starting dynamic subtest: xmajor-smem-smem-emit
[221.724645] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[221.732979] Starting dynamic subtest: tile4-smem-smem-emit
[221.741604] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[221.749352] Starting dynamic subtest: tile64-smem-smem-emit
[221.758532] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[221.759463] Subtest fast-copy-emit: SUCCESS (0.073s)
[221.879176] [039/156] (799s left) gem_reg_read (timestamp-monotonic)
[221.928685] Starting subtest: timestamp-monotonic
[226.729765] Subtest timestamp-monotonic: SUCCESS (4.756s)
[226.760802] [040/156] (794s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[226.854123] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[226.856074] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[226.918987] [041/156] (794s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[227.023153] Starting subtest: psrhdr-indfb-scaledprimary
[227.024823] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[227.138821] [042/156] (794s left) syncobj_timeline (single-wait-available-submitted)
[227.183852] Starting subtest: single-wait-available-submitted
[227.184858] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[227.277880] [043/156] (794s left) sysfs_heartbeat_interval (nopreempt)
[227.328406] Starting subtest: nopreempt
[227.329359] Starting dynamic subtest: vecs0
[236.321865] Dynamic subtest vecs0: SUCCESS (8.993s)
[236.333366] Starting dynamic subtest: ccs0
[240.298898] Dynamic subtest ccs0: SUCCESS (3.975s)
[240.309555] Starting dynamic subtest: vcs0
[249.321556] Dynamic subtest vcs0: SUCCESS (9.012s)
[249.329794] Starting dynamic subtest: bcs0
[253.230489] Dynamic subtest bcs0: SUCCESS (3.916s)
[253.240518] Starting dynamic subtest: rcs0
[257.284789] Dynamic subtest rcs0: SUCCESS (4.051s)
[257.294683] Starting dynamic subtest: vcs1
[266.340711] Dynamic subtest vcs1: SUCCESS (9.057s)
[266.343746] Subtest nopreempt: SUCCESS (39.014s)
[266.440984] [044/156] (754s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[266.543890] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[266.545601] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[266.635454] [045/156] (754s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[266.679269] Starting subtest: rel-constants-invalid-rel-gen5
[266.680202] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[266.764367] [046/156] (754s left) prime_vgem (busy)
[266.886533] Starting subtest: busy
[266.887601] Starting dynamic subtest: rcs0
[266.926492] Dynamic subtest rcs0: SUCCESS (0.040s)
[266.934967] Starting dynamic subtest: bcs0
[266.982654] Dynamic subtest bcs0: SUCCESS (0.055s)
[266.991595] Starting dynamic subtest: vcs0
[267.029584] Dynamic subtest vcs0: SUCCESS (0.046s)
[267.037990] Starting dynamic subtest: vcs1
[267.076294] Dynamic subtest vcs1: SUCCESS (0.046s)
[267.084490] Starting dynamic subtest: vecs0
[267.126142] Dynamic subtest vecs0: SUCCESS (0.049s)
[267.134631] Starting dynamic subtest: ccs0
[267.172160] Dynamic subtest ccs0: SUCCESS (0.045s)
[267.172990] Subtest busy: SUCCESS (0.286s)
[267.282703] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[267.284858] [047/156] (754s left) gen7_exec_parse (cmd-crossing-page)
[267.338721] Subtest cmd-crossing-page: SKIP (0.000s)
[267.416252] [048/156] (754s left) gem_mmap_wc (write-wc-read-gtt)
[267.458724] Subtest write-wc-read-gtt: SKIP (0.000s)
[267.514933] [049/156] (753s left) sw_sync (alloc_merge_fence)
[267.545926] Starting subtest: alloc_merge_fence
[267.547067] Subtest alloc_merge_fence: SUCCESS (0.000s)
[267.595295] [050/156] (753s left) kms_fbcon_fbt (fbc)
[267.645825] Starting subtest: fbc
[274.105813] Subtest fbc: SUCCESS (6.447s)
[275.194327] [051/156] (746s left) kms_pm_rpm (modeset-non-lpsp-stress)
[277.536826] Starting subtest: modeset-non-lpsp-stress
[278.696380] Subtest modeset-non-lpsp-stress: SKIP (1.157s)
[279.085587] [052/156] (742s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[279.185459] Starting subtest: invalidate-primary-flip-overlay
[289.955067] Subtest invalidate-primary-flip-overlay: SUCCESS (10.769s)
[290.076138] [053/156] (731s left) gem_userptr_blits (usage-restrictions)
[290.140243] Starting subtest: usage-restrictions
[290.141182] Subtest usage-restrictions: SUCCESS (0.000s)
[290.247841] [054/156] (731s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[290.337660] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[290.339277] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[290.429449] [055/156] (731s left) gem_mmap_wc (copy)
[290.472790] Subtest copy: SKIP (0.000s)
[290.529469] [056/156] (731s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[290.725319] Starting subtest: cursor-rapid-movement-64x21
[290.769309] Subtest cursor-rapid-movement-64x21: SKIP (0.043s)
[290.987923] [057/156] (730s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[291.075843] Starting subtest: yf-tiled-32bpp-rotate-180
[291.077996] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[291.175622] [058/156] (730s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[291.214837] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[291.280769] [059/156] (730s left) gem_exec_fence (nb-await)
[291.455355] Starting subtest: nb-await
[291.456540] Starting dynamic subtest: rcs0
[291.517983] Dynamic subtest rcs0: SUCCESS (0.067s)
[291.531650] Starting dynamic subtest: bcs0
[291.576422] Dynamic subtest bcs0: SUCCESS (0.056s)
[291.588987] Starting dynamic subtest: vcs0
[291.635879] Dynamic subtest vcs0: SUCCESS (0.057s)
[291.650290] Starting dynamic subtest: vcs1
[291.695189] Dynamic subtest vcs1: SUCCESS (0.057s)
[291.707037] Starting dynamic subtest: vecs0
[291.755941] Dynamic subtest vecs0: SUCCESS (0.058s)
[291.767677] Starting dynamic subtest: ccs0
[291.814748] Dynamic subtest ccs0: SUCCESS (0.057s)
[291.816027] Subtest nb-await: SUCCESS (0.364s)
[293.420969] [060/156] (728s left) gem_busy (close-race)
[293.477350] Starting subtest: close-race
[317.308703] Subtest close-race: SUCCESS (23.831s)
[317.663550] [061/156] (704s left) sw_sync (sync_merge_invalid)
[317.739959] Starting subtest: sync_merge_invalid
[317.760050] Subtest sync_merge_invalid: SUCCESS (0.022s)
[317.830927] [062/156] (704s left) syncobj_basic (create-signaled)
[317.886499] Starting subtest: create-signaled
[317.887429] Subtest create-signaled: SUCCESS (0.000s)
[317.987834] [063/156] (704s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[318.079886] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[318.080838] Starting dynamic subtest: pipe-A-eDP-1
[318.571363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s)
[318.583345] Starting dynamic subtest: pipe-B-eDP-1
[318.591465] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[318.602651] Starting dynamic subtest: pipe-C-eDP-1
[318.610654] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[318.620917] Starting dynamic subtest: pipe-D-eDP-1
[318.627906] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[318.628734] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.508s)
[320.844871] [064/156] (701s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[320.948534] Starting subtest: psr-farfromfence-mmap-gtt
[320.950341] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[321.053880] [065/156] (701s left) kms_prop_blob (invalid-set-prop-any)
[321.099304] Starting subtest: invalid-set-prop-any
[321.100615] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[321.214170] [066/156] (700s left) gem_exec_alignment (forked)
[321.276892] Starting subtest: forked
[364.180539] Subtest forked: SUCCESS (42.894s)
[364.258476] [067/156] (657s left) kms_big_fb (linear-8bpp-rotate-180)
[364.405109] Starting subtest: linear-8bpp-rotate-180
[365.731969] Subtest linear-8bpp-rotate-180: SUCCESS (1.327s)
[365.896391] [068/156] (656s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[365.989232] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[365.990930] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[366.077950] [069/156] (656s left) gem_softpin (allocator-basic)
[366.130357] Starting subtest: allocator-basic
[366.202816] Subtest allocator-basic: SUCCESS (0.072s)
[366.330507] [070/156] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[366.422984] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[366.424739] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[366.521512] [071/156] (655s left) kms_properties (crtc-properties-atomic)
[366.613414] Starting subtest: crtc-properties-atomic
[366.614260] Starting dynamic subtest: pipe-A-eDP-1
[367.063617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[367.074243] Starting dynamic subtest: pipe-B-eDP-1
[368.219662] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s)
[368.229304] Starting dynamic subtest: pipe-C-eDP-1
[369.337893] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[369.347035] Starting dynamic subtest: pipe-D-eDP-1
[370.469096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[370.470327] Subtest crtc-properties-atomic: SUCCESS (3.857s)
[371.272370] [072/156] (651s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[371.373910] Starting subtest: hdr-rgb101010-draw-pwrite
[371.375792] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[371.478043] [073/156] (650s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-fullscreen)
[371.569964] Starting subtest: psrhdr-1p-primscrn-spr-indfb-fullscreen
[371.572207] Subtest psrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[371.654161] [074/156] (650s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[371.746461] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[371.748273] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[371.833364] [075/156] (650s left) kms_joiner (basic-max-non-joiner)
[371.921171] Starting subtest: basic-max-non-joiner
[371.922822] Subtest basic-max-non-joiner: SKIP (0.000s)
[371.990653] [076/156] (650s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[372.088274] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[372.090380] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[372.198197] [077/156] (650s left) gen7_exec_parse (basic-offset)
[372.257931] Subtest basic-offset: SKIP (0.000s)
[372.326746] [078/156] (650s left) gem_exec_reloc (basic-gtt)
[372.386652] Subtest basic-gtt: SKIP (0.000s)
[372.463575] [079/156] (650s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[372.550660] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[372.552646] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[372.652846] [080/156] (650s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[372.747978] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[379.912430] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.166s)
[380.064242] [081/156] (642s left) perf_pmu (render-node-busy-idle)
[380.134860] Starting subtest: render-node-busy-idle
[380.135969] Starting dynamic subtest: rcs0
[380.828552] Dynamic subtest rcs0: SUCCESS (0.693s)
[380.841333] Starting dynamic subtest: bcs0
[381.500728] Dynamic subtest bcs0: SUCCESS (0.670s)
[381.515871] Starting dynamic subtest: vcs0
[383.338711] Dynamic subtest vcs0: SUCCESS (1.826s)
[383.352559] Starting dynamic subtest: vcs1
[385.322055] Dynamic subtest vcs1: SUCCESS (1.981s)
[385.333287] Starting dynamic subtest: vecs0
[387.370206] Dynamic subtest vecs0: SUCCESS (2.045s)
[387.380210] Starting dynamic subtest: ccs0
[388.038022] Dynamic subtest ccs0: SUCCESS (0.674s)
[388.039441] Subtest render-node-busy-idle: SUCCESS (7.904s)
[388.125475] [082/156] (634s left) gem_exec_parallel (userptr)
[388.180642] Starting subtest: userptr
[388.181969] Starting dynamic subtest: rcs0
[389.748056] Dynamic subtest rcs0: SUCCESS (1.567s)
[389.762062] Starting dynamic subtest: bcs0
[391.267834] Dynamic subtest bcs0: SUCCESS (1.517s)
[391.280063] Starting dynamic subtest: vcs0
[393.322386] Dynamic subtest vcs0: SUCCESS (2.042s)
[393.336449] Starting dynamic subtest: vcs1
[395.306921] Dynamic subtest vcs1: SUCCESS (1.982s)
[395.318824] Starting dynamic subtest: vecs0
[397.289710] Dynamic subtest vecs0: SUCCESS (1.980s)
[397.301158] Starting dynamic subtest: ccs0
[398.791472] Dynamic subtest ccs0: SUCCESS (1.508s)
[398.792557] Subtest userptr: SUCCESS (10.611s)
[398.988934] [083/156] (623s left) gem_exec_schedule (lateslice)
[399.052489] Starting subtest: lateslice
[399.053876] Starting dynamic subtest: rcs0
[399.083054] Dynamic subtest rcs0: SUCCESS (0.030s)
[399.093679] Starting dynamic subtest: bcs0
[399.106189] Dynamic subtest bcs0: SUCCESS (0.022s)
[399.116658] Starting dynamic subtest: vcs0
[399.130191] Dynamic subtest vcs0: SUCCESS (0.024s)
[399.139043] Starting dynamic subtest: vcs1
[399.153742] Dynamic subtest vcs1: SUCCESS (0.023s)
[399.162650] Starting dynamic subtest: vecs0
[399.177097] Dynamic subtest vecs0: SUCCESS (0.023s)
[399.185613] Starting dynamic subtest: ccs0
[399.205201] Dynamic subtest ccs0: SUCCESS (0.027s)
[399.206159] Subtest lateslice: SUCCESS (0.152s)
[400.455686] [084/156] (622s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[400.547572] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[400.549100] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[400.642504] [085/156] (622s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[400.733346] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[400.734926] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[400.829976] [086/156] (622s left) i915_drm_fdinfo (most-busy-check-all)
[400.869508] Starting subtest: most-busy-check-all
[400.870392] Starting dynamic subtest: rcs0
[400.875333] Dynamic subtest rcs0: SKIP (0.005s)
[400.886871] Starting dynamic subtest: bcs0
[400.888515] Dynamic subtest bcs0: SKIP (0.000s)
[400.897378] Starting dynamic subtest: vcs0
[400.898901] Dynamic subtest vcs0: SKIP (0.000s)
[400.907686] Starting dynamic subtest: vcs1
[400.909412] Dynamic subtest vcs1: SKIP (0.000s)
[400.918023] Starting dynamic subtest: vecs0
[400.919822] Dynamic subtest vecs0: SKIP (0.000s)
[400.928456] Starting dynamic subtest: ccs0
[400.930416] Dynamic subtest ccs0: SKIP (0.000s)
[400.932281] Subtest most-busy-check-all: SKIP (0.010s)
[400.974577] [087/156] (621s left) kms_color (ctm-max)
[401.085976] Starting subtest: ctm-max
[401.086801] Starting dynamic subtest: pipe-A-eDP-1
[401.797256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[401.806081] Starting dynamic subtest: pipe-B-eDP-1
[403.201475] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[403.211049] Starting dynamic subtest: pipe-C-eDP-1
[404.587472] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[404.597136] Starting dynamic subtest: pipe-D-eDP-1
[406.004398] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.415s)
[406.005670] Subtest ctm-max: SUCCESS (4.917s)
[406.811605] [088/156] (616s left) kms_pm_backlight (fade-with-dpms)
[406.908155] Starting subtest: fade-with-dpms
[409.084074] Starting dynamic subtest: eDP-1
[412.076081] Dynamic subtest eDP-1: SUCCESS (2.992s)
[412.077086] Subtest fade-with-dpms: SUCCESS (5.168s)
[412.960571] [089/156] (610s left) kms_selftest (drm_framebuffer)
[413.004327] Starting subtest: drm_framebuffer
[413.064088] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[413.170018] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.106s)
[413.180349] Starting dynamic subtest: drm_test_framebuffer_cleanup
[413.270017] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.099s)
[413.282507] Starting dynamic subtest: drm_test_framebuffer_create
[413.454505] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.183s)
[413.467546] Starting dynamic subtest: drm_test_framebuffer_free
[413.612978] Dynamic subtest drm_test_framebuffer_free: FAIL (0.142s)
[413.614626] Subtest drm_framebuffer: FAIL (0.594s)
[413.745990] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[413.764612] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[413.765615] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_atomic_transition
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_draw_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_parallel
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gen3_mixed_blits
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_ctx_param
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: i915_pm_freq_api
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_chamelium_frames
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_async_flips
results: parsing output: 35/ for test: kms_multipipe_modeset
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_exercise_blt
results: parsing output: 38/ for test: gem_reg_read
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: sysfs_heartbeat_interval
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: prime_vgem
results: parsing output: 46/ for test: gen7_exec_parse
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: sw_sync
results: parsing output: 49/ for test: kms_fbcon_fbt
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_psr_stress_test
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_busy
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: syncobj_basic
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: gem_exec_alignment
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_properties
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_joiner
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gen7_exec_parse
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: gem_exec_parallel
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: kms_color
results: parsing output: 87/ for test: kms_pm_backlight
results: parsing output: 88/ for test: kms_selftest
results: parsing output: 89/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 90/ for test: gem_create
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: gem_spin_batch
results: no output, setting notrun
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 98/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 99/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 100/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 101/ for test: perf_pmu
results: no output, setting notrun
results: parsing output: 102/ for test: api_intel_bb
results: no output, setting notrun
results: parsing output: 103/ for test: kms_display_modes
results: no output, setting notrun
results: parsing output: 104/ for test: gem_ctx_persistence
results: no output, setting notrun
results: parsing output: 105/ for test: sw_sync
results: no output, setting notrun
results: parsing output: 106/ for test: i915_suspend
results: no output, setting notrun
results: parsing output: 107/ for test: gem_mmap_offset
results: no output, setting notrun
results: parsing output: 108/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 109/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 111/ for test: i915_pm_rpm
results: no output, setting notrun
results: parsing output: 112/ for test: gem_ppgtt
results: no output, setting notrun
results: parsing output: 113/ for test: gem_bad_reloc
results: no output, setting notrun
results: parsing output: 114/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 115/ for test: kms_vblank
results: no output, setting notrun
results: parsing output: 116/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 117/ for test: vgem_basic
results: no output, setting notrun
results: parsing output: 118/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 121/ for test: gem_fence_thrash
results: no output, setting notrun
results: parsing output: 122/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 124/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 126/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 127/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 128/ for test: kms_psr2_sf
results: no output, setting notrun
results: parsing output: 129/ for test: kms_frontbuffer_tracking
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: gem_ctx_isolation
results: no output, setting notrun
results: parsing output: 132/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 133/ for test: gem_exec_balancer
results: no output, setting notrun
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 135/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 136/ for test: kms_chamelium_color
results: no output, setting notrun
results: parsing output: 137/ for test: kms_dsc
results: no output, setting notrun
results: parsing output: 138/ for test: kms_rotation_crc
results: no output, setting notrun
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 140/ for test: kms_atomic
results: no output, setting notrun
results: parsing output: 141/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 142/ for test: sw_sync
results: no output, setting notrun
results: parsing output: 143/ for test: kms_pm_rpm
results: no output, setting notrun
results: parsing output: 144/ for test: kms_plane
results: no output, setting notrun
results: parsing output: 145/ for test: kms_flip_scaled_crc
results: no output, setting notrun
results: parsing output: 146/ for test: kms_hdr
results: no output, setting notrun
results: parsing output: 147/ for test: dumb_buffer
results: no output, setting notrun
results: parsing output: 148/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 150/ for test: gem_pxp
results: no output, setting notrun
results: parsing output: 151/ for test: gem_exec_endless
results: no output, setting notrun
results: parsing output: 152/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 153/ for test: kms_pipe_crc_basic
results: no output, setting notrun
results: parsing output: 154/ for test: api_intel_bb
results: no output, setting notrun
results: parsing output: 155/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
Done.