[89.633503] Initializing watchdogs
[89.633670]   /dev/watchdog0
[89.675718] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.690623] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.698232] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.706366] [001/154] (960s left) gem_spin_batch (engines)
[89.864623] Starting subtest: engines
[89.868310] Starting dynamic subtest: rcs0
[93.103590] Dynamic subtest rcs0: SUCCESS (3.233s)
[93.123755] Starting dynamic subtest: bcs0
[96.339357] Dynamic subtest bcs0: SUCCESS (3.232s)
[96.359349] Starting dynamic subtest: vcs0
[99.670440] Dynamic subtest vcs0: SUCCESS (3.327s)
[99.689952] Starting dynamic subtest: vecs0
[103.001516] Dynamic subtest vecs0: SUCCESS (3.328s)
[103.005748] Subtest engines: SUCCESS (13.124s)
[103.262325] [002/154] (947s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[103.482342] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[103.488961] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[103.622936] [003/154] (946s left) kms_pm_rpm (package-g7)
[105.603249] Starting subtest: package-g7
[105.616032] Subtest package-g7: SKIP (0.001s)
[106.037502] [004/154] (944s left) kms_setmode (basic-clone-single-crtc)
[106.153645] Starting subtest: basic-clone-single-crtc
[106.626257] Subtest basic-clone-single-crtc: SKIP (0.470s)
[106.961453] [005/154] (943s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[107.175110] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[107.182601] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[107.313370] [006/154] (943s left) gem_exec_fence (basic-wait)
[107.587328] Starting subtest: basic-wait
[107.592568] Starting dynamic subtest: rcs0
[107.609963] Dynamic subtest rcs0: SUCCESS (0.023s)
[107.635160] Starting dynamic subtest: bcs0
[107.640206] Dynamic subtest bcs0: SUCCESS (0.032s)
[107.662618] Starting dynamic subtest: vcs0
[107.666409] Dynamic subtest vcs0: SUCCESS (0.018s)
[107.689403] Starting dynamic subtest: vecs0
[107.693591] Dynamic subtest vecs0: SUCCESS (0.019s)
[107.697683] Subtest basic-wait: SUCCESS (0.096s)
[108.452799] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[108.459535] [007/154] (942s left) gem_ctx_param (basic)
[108.572972] Starting subtest: basic
[108.577142] Subtest basic: SUCCESS (0.000s)
[108.725752] [008/154] (942s left) kms_addfb_basic (basic)
[108.840073] Starting subtest: basic
[108.844167] Subtest basic: SUCCESS (0.000s)
[109.091883] [009/154] (941s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[109.286638] Starting subtest: cursor-tearing-framebuffer-change
[109.290253] Starting dynamic subtest: pipe-A-HDMI-A-1
[110.128553] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.840s)
[110.157472] Starting dynamic subtest: pipe-C-HDMI-A-1
[110.695476] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.559s)
[110.698868] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.411s)
[111.060195] [010/154] (940s left) perf_pmu (event-wait)
[111.196373] Starting subtest: event-wait
[111.199800] Starting dynamic subtest: rcs0
[111.208098] Dynamic subtest rcs0: SKIP (0.000s)
[111.218140] Subtest event-wait: SKIP (0.001s)
[111.351281] [011/154] (939s left) gem_media_vme
[111.590291] [012/154] (939s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[111.804247] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[111.810784] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[111.955255] [013/154] (939s left) gem_ccs (block-copy-uncompressed)
[112.083949] Subtest block-copy-uncompressed: SKIP (0.000s)
[112.194313] [014/154] (939s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[112.400637] Starting subtest: psr-rgb101010-draw-blt
[112.409641] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[112.539563] [015/154] (939s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[112.747484] Starting subtest: cursor-rapid-movement-32x32
[112.976599] Subtest cursor-rapid-movement-32x32: SKIP (0.225s)
[113.158837] [016/154] (938s left) api_intel_bb (add-remove-objects)
[113.278762] Starting subtest: add-remove-objects
[113.291515] Subtest add-remove-objects: SUCCESS (0.015s)
[113.456911] [017/154] (938s left) gem_eio (wait-1us)
[113.612066] Starting subtest: wait-1us
[113.719533] Subtest wait-1us: SUCCESS (0.110s)
[113.983789] [018/154] (937s left) kms_flip (2x-blocking-wf_vblank)
[114.175569] Starting subtest: 2x-blocking-wf_vblank
[114.189380] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[125.282158] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.096s)
[125.307111] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[136.337943] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.047s)
[136.360967] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[147.333490] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.992s)
[147.339501] Subtest 2x-blocking-wf_vblank: SUCCESS (33.153s)
[148.011054] [019/154] (904s left) gem_ctx_persistence (engines-cleanup)
[148.136520] Starting subtest: engines-cleanup
[148.140829] Starting dynamic subtest: rcs0
[148.166990] Dynamic subtest rcs0: SUCCESS (0.029s)
[148.194485] Starting dynamic subtest: bcs0
[148.198272] Dynamic subtest bcs0: SUCCESS (0.028s)
[148.223596] Starting dynamic subtest: vcs0
[148.226774] Dynamic subtest vcs0: SUCCESS (0.023s)
[148.253433] Starting dynamic subtest: vecs0
[148.257651] Dynamic subtest vecs0: SUCCESS (0.015s)
[148.261905] Subtest engines-cleanup: SUCCESS (0.099s)
[148.426157] [020/154] (903s left) kms_big_fb (linear-64bpp-rotate-270)
[148.638878] Starting subtest: linear-64bpp-rotate-270
[148.942189] Subtest linear-64bpp-rotate-270: SKIP (0.301s)
[149.218070] [021/154] (903s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[149.469641] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[149.477347] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[149.598687] [022/154] (902s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[149.785124] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[149.789184] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.843430] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[149.893559] Starting dynamic subtest: pipe-A-HDMI-A-2
[149.933255] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[149.956385] Starting dynamic subtest: pipe-B-HDMI-A-1
[149.987681] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[150.009567] Starting dynamic subtest: pipe-B-HDMI-A-2
[150.039200] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[150.060918] Starting dynamic subtest: pipe-C-HDMI-A-1
[150.092777] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[150.115541] Starting dynamic subtest: pipe-C-HDMI-A-2
[150.144823] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[150.150807] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.018s)
[151.285876] [023/154] (901s left) gem_exec_balancer (noheartbeat)
[151.839313] Starting subtest: noheartbeat
[156.188493] Subtest noheartbeat: SUCCESS (4.495s)
[156.342395] [024/154] (896s left) kms_flip (dpms-off-confusion)
[156.528781] Starting subtest: dpms-off-confusion
[156.533125] Starting dynamic subtest: A-HDMI-A1
[162.235107] Dynamic subtest A-HDMI-A1: SUCCESS (5.702s)
[162.258560] Starting dynamic subtest: B-HDMI-A1
[167.648215] Dynamic subtest B-HDMI-A1: SUCCESS (5.408s)
[167.671514] Starting dynamic subtest: C-HDMI-A1
[173.058116] Dynamic subtest C-HDMI-A1: SUCCESS (5.409s)
[173.082541] Starting dynamic subtest: A-HDMI-A2
[178.488084] Dynamic subtest A-HDMI-A2: SUCCESS (5.428s)
[178.512656] Starting dynamic subtest: B-HDMI-A2
[183.913965] Dynamic subtest B-HDMI-A2: SUCCESS (5.422s)
[183.938584] Starting dynamic subtest: C-HDMI-A2
[189.335503] Dynamic subtest C-HDMI-A2: SUCCESS (5.414s)
[189.340581] Subtest dpms-off-confusion: SUCCESS (32.807s)
[189.900551] [025/154] (863s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[190.129647] Starting subtest: y-tiled-8bpp-rotate-270
[190.453432] Subtest y-tiled-8bpp-rotate-270: SKIP (0.322s)
[190.749717] [026/154] (862s left) kms_async_flips (alternate-sync-async-flip-atomic)
[190.949192] Starting subtest: alternate-sync-async-flip-atomic
[191.552683] Starting dynamic subtest: pipe-A-HDMI-A-1
[193.789666] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.238s)
[194.154255] Starting dynamic subtest: pipe-A-HDMI-A-2
[196.342521] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.211s)
[196.707889] Starting dynamic subtest: pipe-B-HDMI-A-1
[198.885946] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.199s)
[199.225959] Starting dynamic subtest: pipe-B-HDMI-A-2
[201.468368] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.264s)
[201.818930] Starting dynamic subtest: pipe-C-HDMI-A-1
[203.971702] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.187s)
[204.335202] Starting dynamic subtest: pipe-C-HDMI-A-2
[206.499536] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.197s)
[206.503684] Subtest alternate-sync-async-flip-atomic: SUCCESS (15.551s)
[207.215803] [027/154] (846s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[207.334449] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[207.441833] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[207.599599] [028/154] (845s left) prime_vgem (shrink)
[207.733739] Starting subtest: shrink
[207.761022] Subtest shrink: SUCCESS (0.027s)
[207.928177] [029/154] (845s left) gem_ctx_create (basic)
[208.057574] Starting subtest: basic
[208.062074] Subtest basic: SUCCESS (0.000s)
[208.328608] [030/154] (845s left) kms_chamelium_edid (vga-edid-read)
[208.930531] Subtest vga-edid-read: SKIP (0.000s)
[209.275284] [031/154] (844s left) sysfs_heartbeat_interval (nopreempt)
[209.405734] Starting subtest: nopreempt
[209.412160] Starting dynamic subtest: vecs0
[213.036913] Dynamic subtest vecs0: SUCCESS (3.624s)
[213.124897] Starting dynamic subtest: vcs0
[216.674911] Dynamic subtest vcs0: SUCCESS (3.637s)
[216.764908] Starting dynamic subtest: bcs0
[220.303937] Dynamic subtest bcs0: SUCCESS (3.626s)
[220.422325] Starting dynamic subtest: rcs0
[224.079724] Dynamic subtest rcs0: SUCCESS (3.773s)
[224.083386] Subtest nopreempt: SUCCESS (14.670s)
[224.241759] [032/154] (829s left) kms_addfb_basic (unused-modifier)
[224.366142] Starting subtest: unused-modifier
[224.370075] Subtest unused-modifier: SUCCESS (0.000s)
[224.620101] [033/154] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[224.831679] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[227.301358] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.477s)
[227.636385] [034/154] (826s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[227.849538] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[227.855948] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[228.006727] [035/154] (826s left) syncobj_basic (test-valid-cycle)
[228.121228] Starting subtest: test-valid-cycle
[228.124600] Subtest test-valid-cycle: SUCCESS (0.000s)
[228.302181] [036/154] (825s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[228.519485] Starting subtest: fbc-rgb101010-draw-render
[229.403455] Subtest fbc-rgb101010-draw-render: SUCCESS (0.894s)
[229.687344] [037/154] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[229.913740] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[229.923938] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[230.060022] [038/154] (824s left) kms_psr (fbc-psr-cursor-plane-move)
[230.261625] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[230.385123] [039/154] (824s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[230.576087] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[230.699828] [040/154] (824s left) gem_pread (bench)
[230.813942] Starting subtest: bench
[233.906646] Subtest bench: SUCCESS (3.092s)
[234.055669] [041/154] (820s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[234.255479] Starting subtest: 4-tiled-16bpp-rotate-90
[234.262649] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[234.405587] [042/154] (820s left) kms_cursor_crc (cursor-onscreen-128x42)
[234.616580] Starting subtest: cursor-onscreen-128x42
[234.670137] Starting dynamic subtest: pipe-A-HDMI-A-1
[237.375523] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.703s)
[237.494331] Starting dynamic subtest: pipe-C-HDMI-A-1
[239.901575] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.449s)
[239.905689] Subtest cursor-onscreen-128x42: SUCCESS (5.278s)
[240.293058] [043/154] (814s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt)
[240.522679] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt
[240.529330] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[240.681327] [044/154] (814s left) perf (buffer-fill)
[240.908434] Starting subtest: buffer-fill
[240.914187] Starting dynamic subtest: 0-rcs0
[243.997158] Dynamic subtest 0-rcs0: SUCCESS (3.089s)
[244.001137] Subtest buffer-fill: SUCCESS (3.091s)
[244.123317] [045/154] (811s left) kms_invalid_mode (bad-vtotal)
[244.319710] Starting subtest: bad-vtotal
[244.325509] Starting dynamic subtest: pipe-A-HDMI-A-1
[244.748701] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.441s)
[244.808107] Starting dynamic subtest: pipe-A-HDMI-A-2
[244.811561] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s)
[244.862207] Starting dynamic subtest: pipe-B-HDMI-A-1
[244.867390] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[244.912203] Starting dynamic subtest: pipe-B-HDMI-A-2
[244.915774] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[244.941788] Starting dynamic subtest: pipe-C-HDMI-A-1
[244.945101] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[244.969270] Starting dynamic subtest: pipe-C-HDMI-A-2
[244.972981] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[244.976465] Subtest bad-vtotal: SUCCESS (0.476s)
[245.153627] [046/154] (810s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[245.386409] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[245.393088] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[245.543444] [047/154] (809s left) i915_module_load (resize-bar)
[245.651351] Starting subtest: resize-bar
[245.671867] Subtest resize-bar: SKIP (0.018s)
[245.794651] [048/154] (809s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[245.997962] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[246.005730] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[246.150478] [049/154] (809s left) tools_test (sysfs_l3_parity)
[246.288189] Starting subtest: sysfs_l3_parity
[246.408938] Subtest sysfs_l3_parity: SKIP (0.147s)
[246.566235] [050/154] (809s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[246.784698] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[246.792100] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[246.943763] [051/154] (808s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[247.065360] Starting subtest: multi-wait-for-submit-available-submitted
[247.068714] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[247.216877] [052/154] (808s left) gem_exec_fence (submit)
[247.486810] Starting subtest: submit
[247.492374] Starting dynamic subtest: rcs0
[247.507653] Dynamic subtest rcs0: SUCCESS (0.023s)
[247.535584] Starting dynamic subtest: bcs0
[247.540582] Dynamic subtest bcs0: SUCCESS (0.026s)
[247.575832] Starting dynamic subtest: vcs0
[247.579533] Dynamic subtest vcs0: SUCCESS (0.021s)
[247.614161] Starting dynamic subtest: vecs0
[247.618067] Dynamic subtest vecs0: SUCCESS (0.024s)
[247.622147] Subtest submit: SUCCESS (0.113s)
[248.298625] [053/154] (807s left) kms_getfb (getfb-handle-not-fb)
[248.480363] Starting subtest: getfb-handle-not-fb
[248.483771] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[248.668887] [054/154] (807s left) gem_softpin (softpin)
[248.789265] Starting subtest: softpin
[281.114060] Subtest softpin: SUCCESS (32.320s)
[281.267951] [055/154] (775s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[281.388973] Starting subtest: basic-wc-cpu-noreloc
[281.396961] Subtest basic-wc-cpu-noreloc: SUCCESS (0.009s)
[281.639612] [056/154] (774s left) kms_atomic_transition (modeset-transition)
[281.846831] Starting subtest: modeset-transition
[281.852896] Starting dynamic subtest: 1x-outputs
[285.604934] Dynamic subtest 1x-outputs: SUCCESS (3.754s)
[285.631384] Starting dynamic subtest: 2x-outputs
[293.320140] Dynamic subtest 2x-outputs: SUCCESS (7.710s)
[293.324711] Subtest modeset-transition: SUCCESS (11.475s)
[293.675448] [057/154] (762s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[293.809321] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[293.813265] Starting dynamic subtest: smem
[294.169572] Dynamic subtest smem: SUCCESS (0.359s)
[294.173546] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.362s)
[294.443548] [058/154] (762s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[294.665979] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[294.672600] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[294.826758] [059/154] (761s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[295.048613] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[295.057465] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[295.195449] [060/154] (761s left) syncobj_timeline (invalid-signal-bad-pad)
[295.315082] Starting subtest: invalid-signal-bad-pad
[295.318752] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[295.459153] [061/154] (761s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[295.651463] Starting subtest: primary-yf-tiled-reflect-x-180
[295.659636] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.003s)
[295.826408] [062/154] (761s left) gen3_render_mixed_blits
[296.052822] [063/154] (761s left) gem_exec_parallel (contexts)
[296.188401] Starting subtest: contexts
[296.192201] Starting dynamic subtest: rcs0
[300.353627] Dynamic subtest rcs0: SUCCESS (4.167s)
[300.381203] Starting dynamic subtest: bcs0
[304.960103] Dynamic subtest bcs0: SUCCESS (4.601s)
[304.987823] Starting dynamic subtest: vcs0
[314.715251] Dynamic subtest vcs0: SUCCESS (9.752s)
[314.748511] Starting dynamic subtest: vecs0
[319.336057] Dynamic subtest vecs0: SUCCESS (4.617s)
[319.339807] Subtest contexts: SUCCESS (23.152s)
[319.610189] [064/154] (737s left) kms_rotation_crc (bad-tiling)
[319.815493] Starting subtest: bad-tiling
[326.853373] Subtest bad-tiling: SUCCESS (7.040s)
[327.251553] [065/154] (730s left) gem_softpin (evict-active-interruptible)
[327.391429] Starting subtest: evict-active-interruptible
[327.416834] Subtest evict-active-interruptible: SUCCESS (0.025s)
[327.589066] [066/154] (729s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[327.782147] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[327.793929] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[328.544545] [067/154] (729s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[328.766288] Starting subtest: x-tiled-16bpp-rotate-90
[329.134357] Subtest x-tiled-16bpp-rotate-90: SKIP (0.358s)
[329.427239] [068/154] (728s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[329.639742] Starting subtest: plane-ctm3x4-lut1d
[331.382348] Subtest plane-ctm3x4-lut1d: SKIP (1.609s)
[331.639059] [069/154] (726s left) gem_flink_basic (double-flink)
[331.756666] Starting subtest: double-flink
[331.761072] Subtest double-flink: SUCCESS (0.001s)
[331.918994] [070/154] (726s left) gem_exec_fence (syncobj-unused-fence)
[332.548495] Starting subtest: syncobj-unused-fence
[332.559752] Subtest syncobj-unused-fence: SUCCESS (0.008s)
[332.988619] [071/154] (725s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[333.112359] Starting subtest: invalid-multi-wait-unsubmitted
[333.116486] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[333.263402] [072/154] (724s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[333.478557] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[336.394681] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.930s)
[336.647136] [073/154] (721s left) api_intel_bb (object-reloc-keep-cache)
[336.759649] Starting subtest: object-reloc-keep-cache
[336.764105] Subtest object-reloc-keep-cache: SUCCESS (0.011s)
[336.916689] [074/154] (721s left) i915_pm_rpm (gem-mmap-type)
[338.862244] Starting subtest: gem-mmap-type
[338.868382] Starting dynamic subtest: gtt-smem0
[341.366432] Dynamic subtest gtt-smem0: SUCCESS (2.495s)
[341.411218] Starting dynamic subtest: wb-smem0
[342.626458] Dynamic subtest wb-smem0: SUCCESS (1.253s)
[342.659486] Starting dynamic subtest: wc-smem0
[343.960119] Dynamic subtest wc-smem0: SUCCESS (1.321s)
[344.014961] Starting dynamic subtest: uc-smem0
[345.288028] Dynamic subtest uc-smem0: SUCCESS (1.318s)
[345.298084] Subtest gem-mmap-type: SUCCESS (6.423s)
[345.660382] [075/154] (712s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[345.883569] Starting subtest: fbcpsr-slowdraw
[345.890122] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[346.051661] [076/154] (712s left) kms_mmap_write_crc (main)
[346.252580] Starting subtest: main
[346.258303] Starting dynamic subtest: pipe-A-HDMI-A-1
[349.721752] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.464s)
[349.727237] Subtest main: SUCCESS (3.472s)
[350.094539] [077/154] (708s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[350.320961] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[350.327488] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[350.476237] [078/154] (708s left) gem_mmap_offset (partial-mmap)
[350.594600] Starting subtest: partial-mmap
[350.598759] Starting dynamic subtest: smem0
[350.603719] Dynamic subtest smem0: SUCCESS (0.009s)
[350.607338] Subtest partial-mmap: SUCCESS (0.013s)
[350.772122] [079/154] (708s left) i915_drm_fdinfo (all-busy-idle-check-all)
[350.889618] Starting subtest: all-busy-idle-check-all
[351.517044] Subtest all-busy-idle-check-all: SUCCESS (0.623s)
[351.674300] [080/154] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[351.899600] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[351.905682] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.001s)
[352.057438] [081/154] (707s left) gem_exec_flush (basic-uc-ro-default)
[352.187617] Starting subtest: basic-uc-ro-default
[357.607264] Subtest basic-uc-ro-default: SUCCESS (5.419s)
[357.872327] [082/154] (701s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[358.050813] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[358.054355] Starting dynamic subtest: pipe-A
[358.414626] Dynamic subtest pipe-A: SUCCESS (0.362s)
[358.468068] Starting dynamic subtest: pipe-B
[358.814114] Dynamic subtest pipe-B: SUCCESS (0.394s)
[358.859089] Starting dynamic subtest: pipe-C
[358.882071] Dynamic subtest pipe-C: SUCCESS (0.056s)
[358.886058] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.824s)
[359.397527] [083/154] (699s left) gem_mmap_gtt (big-copy-odd)
[359.511212] Starting subtest: big-copy-odd
[369.326269] Subtest big-copy-odd: SUCCESS (9.813s)
[369.508154] [084/154] (689s left) syncobj_timeline (single-wait-available-signaled)
[369.791925] Starting subtest: single-wait-available-signaled
[369.795600] Subtest single-wait-available-signaled: SUCCESS (0.002s)
[369.949100] [085/154] (689s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[370.164263] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[370.167803] Starting dynamic subtest: pipe-A-HDMI-A-1
[370.182563] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[370.236382] Starting dynamic subtest: pipe-A-HDMI-A-2
[370.254252] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[370.304542] Starting dynamic subtest: pipe-B-HDMI-A-1
[370.321539] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[370.369313] Starting dynamic subtest: pipe-B-HDMI-A-2
[370.387323] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[370.413822] Starting dynamic subtest: pipe-C-HDMI-A-1
[370.428305] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[370.454878] Starting dynamic subtest: pipe-C-HDMI-A-2
[370.467524] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[370.473906] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.047s)
[371.314412] [086/154] (688s left) kms_psr (psr2-sprite-plane-move)
[371.520264] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[371.636332] [087/154] (688s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[371.879618] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[371.887921] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[372.070190] [088/154] (687s left) kms_getfb (getfb-handle-protection)
[372.269718] Starting subtest: getfb-handle-protection
[372.293341] Subtest getfb-handle-protection: SUCCESS (0.028s)
[372.472398] [089/154] (687s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[372.683042] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[375.679583] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.008s)
[376.003189] [090/154] (684s left) kms_psr (psr2-cursor-mmap-gtt)
[376.201051] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[376.336029] [091/154] (683s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[376.532584] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[376.539462] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[376.688076] [092/154] (683s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[376.895851] Starting subtest: multiplane-rotation-cropping-top
[506.408627] Disk usage limit exceeded.
[508.047289] Closing watchdogs
[508.055888] Initializing watchdogs
[508.056058]   /dev/watchdog0
[508.102129] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[508.126370] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[508.129330] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[508.131173] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[508.139546] [093/154] (552s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[508.346431] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[508.353171] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[508.506713] [094/154] (552s left) gem_mmap_gtt (basic-read)
[508.626551] Starting subtest: basic-read
[508.648283] Subtest basic-read: SUCCESS (0.027s)
[508.804299] [095/154] (551s left) kms_content_protection (dp-mst-lic-type-0)
[509.023818] Starting subtest: dp-mst-lic-type-0
[509.032639] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[509.189401] [096/154] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[509.416785] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[509.423701] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[509.557630] [097/154] (551s left) gen9_exec_parse (batch-zero-length)
[509.698322] Starting subtest: batch-zero-length
[509.702575] Subtest batch-zero-length: SUCCESS (0.002s)
[510.329856] [098/154] (550s left) perf (gen12-group-exclusive-stream-ctx-handle)
[511.440691] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[511.448997] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s)
[511.558363] [099/154] (549s left) gem_sync (basic-store-each)
[511.711295] Starting subtest: basic-store-each
[514.164058] Subtest basic-store-each: SUCCESS (2.311s)
[514.647130] [100/154] (547s left) kms_plane_alpha_blend (alpha-transparent-fb)
[514.982079] Starting subtest: alpha-transparent-fb
[515.149431] Starting dynamic subtest: pipe-A-HDMI-A-1
[516.609625] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.485s)
[516.635438] Starting dynamic subtest: pipe-C-HDMI-A-1
[517.696564] Dynamic subtest pipe-C-HDMI-A-1: FAIL (1.382s)
[517.700553] Subtest alpha-transparent-fb: FAIL (2.054s)
[517.820169] [101/154] (544s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[518.051201] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[518.056967] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[518.200878] [102/154] (543s left) kms_dp_linktrain_fallback (dsc-fallback)
[518.407238] Starting subtest: dsc-fallback
[518.416923] Subtest dsc-fallback: SKIP (0.001s)
[518.571089] [103/154] (543s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[518.785165] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[518.794052] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[518.936849] [104/154] (543s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[519.158865] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[519.164936] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[519.318904] [105/154] (543s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[519.538540] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[519.547984] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[519.690783] [106/154] (542s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[519.908547] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[519.922611] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.004s)
[520.067863] [107/154] (542s left) gem_huc_copy (huc-copy)
[520.201164] Starting subtest: huc-copy
[520.209740] Subtest huc-copy: SKIP (0.000s)
[520.366419] [108/154] (542s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move)
[520.588517] Starting subtest: hdr-1p-primscrn-cur-indfb-move
[520.596354] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[520.735884] [109/154] (542s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move)
[520.954055] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move
[520.961148] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[521.103674] [110/154] (541s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[521.333151] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[521.339022] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[521.484556] [111/154] (541s left) syncobj_basic (bad-flags-handle-to-fd)
[521.597937] Starting subtest: bad-flags-handle-to-fd
[521.601986] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[521.783413] [112/154] (541s left) kms_pipe_crc_basic (bad-source)
[522.004907] Starting subtest: bad-source
[522.008500] Subtest bad-source: SUCCESS (0.001s)
[522.153126] [113/154] (541s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[522.369726] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[522.377319] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[522.537480] [114/154] (540s left) gem_exec_store (dword)
[522.672586] Starting subtest: dword
[522.677258] Starting dynamic subtest: rcs0
[522.708298] Dynamic subtest rcs0: SUCCESS (0.031s)
[522.740593] Starting dynamic subtest: bcs0
[522.743962] Dynamic subtest bcs0: SUCCESS (0.014s)
[522.773142] Starting dynamic subtest: vcs0
[522.777466] Dynamic subtest vcs0: SUCCESS (0.019s)
[522.802646] Starting dynamic subtest: vecs0
[522.806658] Dynamic subtest vecs0: SUCCESS (0.018s)
[522.810795] Subtest dword: SUCCESS (0.101s)
[523.052518] [115/154] (540s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[523.282955] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[523.289328] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[523.436498] [116/154] (540s left) kms_pm_rpm (dpms-lpsp)
[525.425735] Starting subtest: dpms-lpsp
[525.435314] Subtest dpms-lpsp: SKIP (0.001s)
[525.934830] [117/154] (537s left) gem_basic (create-fd-close)
[526.050185] Starting subtest: create-fd-close
[526.058262] Subtest create-fd-close: SUCCESS (0.001s)
[526.200378] [118/154] (537s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[526.413652] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[526.422068] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[526.572618] [119/154] (537s left) syncobj_timeline (etime-single-wait-all-submitted)
[526.687762] Starting subtest: etime-single-wait-all-submitted
[526.793246] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[526.951174] [120/154] (537s left) gem_softpin (noreloc-interruptible)
[527.090330] Starting subtest: noreloc-interruptible
[532.571062] Subtest noreloc-interruptible: SUCCESS (5.464s)
[532.737362] [121/154] (531s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[532.936224] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[532.940582] Starting dynamic subtest: pipe-A-HDMI-A-1
[532.988415] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[533.037582] Starting dynamic subtest: pipe-A-HDMI-A-2
[533.086434] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[533.134306] Starting dynamic subtest: pipe-B-HDMI-A-1
[533.174564] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[533.201250] Starting dynamic subtest: pipe-B-HDMI-A-2
[533.238548] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[533.264070] Starting dynamic subtest: pipe-C-HDMI-A-1
[533.301111] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[533.331283] Starting dynamic subtest: pipe-C-HDMI-A-2
[533.370610] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[533.377776] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.041s)
[534.103040] [122/154] (530s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[534.295503] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[534.299131] Starting dynamic subtest: pipe-A-HDMI-A-1
[534.504088] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[534.529390] Starting dynamic subtest: pipe-A-HDMI-A-2
[534.667885] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.012s)
[534.696666] Starting dynamic subtest: pipe-B-HDMI-A-1
[534.824951] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.013s)
[534.850836] Starting dynamic subtest: pipe-B-HDMI-A-2
[535.050457] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s)
[535.076543] Starting dynamic subtest: pipe-C-HDMI-A-1
[535.203686] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.012s)
[535.230128] Starting dynamic subtest: pipe-C-HDMI-A-2
[535.382540] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.012s)
[535.390976] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.108s)
[535.517435] [123/154] (528s left) gem_exec_suspend (basic-s3-devices)
[535.657963] Starting subtest: basic-S3-devices
[535.672997] Starting dynamic subtest: smem
[545.483871] Dynamic subtest smem: SUCCESS (9.830s)
[545.488450] Subtest basic-S3-devices: SUCCESS (9.834s)
[550.772240] [124/154] (518s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[550.988128] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[551.108987] [125/154] (518s left) gem_exec_schedule (preempt-other)
[551.263404] Starting subtest: preempt-other
[551.267740] Starting dynamic subtest: rcs0
[551.320636] Dynamic subtest rcs0: SUCCESS (0.062s)
[551.358334] Starting dynamic subtest: bcs0
[551.382803] Dynamic subtest bcs0: SUCCESS (0.060s)
[551.420338] Starting dynamic subtest: vcs0
[551.445658] Dynamic subtest vcs0: SUCCESS (0.058s)
[551.483052] Starting dynamic subtest: vecs0
[551.510782] Dynamic subtest vecs0: SUCCESS (0.061s)
[551.515628] Subtest preempt-other: SUCCESS (0.254s)
[551.941866] [126/154] (517s left) kms_frontbuffer_tracking (fbchdr-tiling-linear)
[552.147851] Starting subtest: fbchdr-tiling-linear
[552.155579] Subtest fbchdr-tiling-linear: SKIP (0.000s)
[552.316106] [127/154] (517s left) gem_mmap_gtt (basic-small-bo-tiledx)
[552.433393] Starting subtest: basic-small-bo-tiledX
[553.016552] Subtest basic-small-bo-tiledX: SUCCESS (0.585s)
[553.215368] [128/154] (516s left) gem_create (create-ext-placement-each)
[553.625819] Starting subtest: create-ext-placement-each
[553.631736] Subtest create-ext-placement-each: SUCCESS (0.000s)
[553.778407] [129/154] (516s left) gem_ctx_persistence (heartbeat-hang)
[553.927645] Starting subtest: heartbeat-hang
[555.113284] Subtest heartbeat-hang: SUCCESS (1.183s)
[555.299341] [130/154] (514s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[555.535557] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[555.541255] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[555.697199] [131/154] (514s left) kms_feature_discovery (psr2)
[555.895446] Starting subtest: psr2
[555.903802] Subtest psr2: SKIP (0.002s)
[556.063389] [132/154] (514s left) dumb_buffer (map-uaf)
[556.181328] Starting subtest: map-uaf
[556.191665] Subtest map-uaf: SUCCESS (0.018s)
[556.345158] [133/154] (514s left) kms_vblank (ts-continuation-modeset)
[556.538268] Starting subtest: ts-continuation-modeset
[556.541514] Starting dynamic subtest: pipe-A-HDMI-A-1
[557.619438] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.071s)
[557.683826] Starting dynamic subtest: pipe-A-HDMI-A-2
[558.474266] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.851s)
[558.547548] Starting dynamic subtest: pipe-C-HDMI-A-1
[559.261611] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.767s)
[559.325120] Starting dynamic subtest: pipe-C-HDMI-A-2
[560.037706] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.768s)
[560.041395] Subtest ts-continuation-modeset: SUCCESS (3.499s)
[560.438629] [134/154] (510s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[560.659344] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[560.666514] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[560.827044] [135/154] (509s left) i915_pm_rps (waitboost)
[560.957661] Starting subtest: waitboost
[564.538946] Subtest waitboost: SUCCESS (3.583s)
[564.709260] [136/154] (506s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[564.902570] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[565.148178] Starting dynamic subtest: pipe-A-plane-0
[565.581055] Dynamic subtest pipe-A-plane-0: SUCCESS (0.431s)
[565.609601] Starting dynamic subtest: pipe-A-plane-1
[565.945577] Dynamic subtest pipe-A-plane-1: SUCCESS (0.363s)
[565.974493] Starting dynamic subtest: pipe-A-plane-2
[566.296085] Dynamic subtest pipe-A-plane-2: SUCCESS (0.346s)
[566.324966] Starting dynamic subtest: pipe-A-plane-3
[566.646938] Dynamic subtest pipe-A-plane-3: SUCCESS (0.346s)
[567.089137] Starting dynamic subtest: pipe-B-plane-0
[567.396149] Dynamic subtest pipe-B-plane-0: SUCCESS (0.331s)
[567.424557] Starting dynamic subtest: pipe-B-plane-1
[567.765279] Dynamic subtest pipe-B-plane-1: SUCCESS (0.364s)
[567.793435] Starting dynamic subtest: pipe-B-plane-2
[568.128783] Dynamic subtest pipe-B-plane-2: SUCCESS (0.362s)
[568.166164] Starting dynamic subtest: pipe-B-plane-3
[568.495736] Dynamic subtest pipe-B-plane-3: SUCCESS (0.362s)
[568.727765] Subtest pixel-format-yf-tiled-modifier-source-clamping: SUCCESS (3.825s)
[569.125833] [137/154] (501s left) kms_selftest (drm_plane_helper)
[569.290502] Starting subtest: drm_plane_helper
[569.315334] Starting dynamic subtest: drm_test_check_plane_state
[569.373875] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.062s)
[569.412489] Starting dynamic subtest: drm_test_check_invalid_plane_state
[569.424263] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.044s)
[569.435990] Subtest drm_plane_helper: SUCCESS (0.143s)
[569.627164] [138/154] (501s left) syncobj_basic (bad-create-flags)
[569.740819] Starting subtest: bad-create-flags
[569.744116] Subtest bad-create-flags: SUCCESS (0.000s)
[569.896172] [139/154] (501s left) kms_frontbuffer_tracking (psrhdr-2p-pri-indfb-multidraw)
[570.109157] Starting subtest: psrhdr-2p-pri-indfb-multidraw
[570.115550] Subtest psrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[570.262225] [140/154] (501s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[570.473633] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[570.481559] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[570.630979] [141/154] (500s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[571.216800] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[571.572266] [142/154] (499s left) kms_psr2_su (page_flip-nv12)
[571.699470] Subtest page_flip-NV12: SKIP (0.000s)
[571.822900] [143/154] (499s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[572.030621] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[572.037687] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[572.197309] [144/154] (499s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[572.415697] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[572.422531] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[572.577965] [145/154] (499s left) gem_mmap_gtt (medium-copy)
[572.692756] Starting subtest: medium-copy
[576.453249] Subtest medium-copy: SUCCESS (3.764s)
[576.635388] [146/154] (495s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[577.025099] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[580.003359] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (2.983s)
[580.246949] [147/154] (491s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[580.476612] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[580.483517] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[580.651413] [148/154] (491s left) gem_wait (await)
[580.806332] Starting subtest: await
[580.811406] Starting dynamic subtest: all-engines
[581.855949] Dynamic subtest all-engines: SUCCESS (1.046s)
[581.910677] Starting dynamic subtest: rcs0
[582.910916] Dynamic subtest rcs0: SUCCESS (1.047s)
[582.942542] Starting dynamic subtest: bcs0
[583.946898] Dynamic subtest bcs0: SUCCESS (1.034s)
[583.982512] Starting dynamic subtest: vcs0
[584.984116] Dynamic subtest vcs0: SUCCESS (1.032s)
[585.015689] Starting dynamic subtest: vecs0
[586.020549] Dynamic subtest vecs0: SUCCESS (1.033s)
[586.024032] Subtest await: SUCCESS (5.218s)
[586.327472] [149/154] (486s left) gem_exec_schedule (promotion)
[586.491294] Starting subtest: promotion
[586.495119] Starting dynamic subtest: rcs0
[586.613326] Dynamic subtest rcs0: SUCCESS (0.119s)
[586.654361] Starting dynamic subtest: bcs0
[586.749823] Dynamic subtest bcs0: SUCCESS (0.138s)
[586.786154] Starting dynamic subtest: vcs0
[586.886736] Dynamic subtest vcs0: SUCCESS (0.129s)
[586.922296] Starting dynamic subtest: vecs0
[587.014746] Dynamic subtest vecs0: SUCCESS (0.123s)
[587.021371] Subtest promotion: SUCCESS (0.525s)
[587.428162] [150/154] (485s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[587.636138] Starting subtest: fbcpsrhdr-slowdraw
[587.643389] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[587.796171] [151/154] (484s left) kms_psr (fbc-psr2-sprite-render)
[588.001032] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[588.136507] [152/154] (484s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[588.365486] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[588.380665] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[588.531567] [153/154] (484s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[588.725101] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[588.729841] Starting dynamic subtest: pipe-A
[589.583787] Dynamic subtest pipe-A: SUCCESS (0.857s)
[589.636831] Starting dynamic subtest: pipe-B
[590.495877] Dynamic subtest pipe-B: SUCCESS (0.908s)
[590.528213] Starting dynamic subtest: pipe-C
[591.358736] Dynamic subtest pipe-C: SUCCESS (0.859s)
[591.363691] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (2.636s)
[591.945712] [154/154] (480s left) gem_render_copy (linear-to-vebox-y-tiled)
[592.082536] Starting subtest: linear-to-vebox-y-tiled
[592.090509] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[592.340616] Closing watchdogs
results: parsing output: 0/ for test: gem_spin_batch
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_setmode
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: gem_ctx_param
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: gem_media_vme
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: gem_eio
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_ctx_persistence
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: gem_ctx_create
results: parsing output: 29/ for test: kms_chamelium_edid
results: parsing output: 30/ for test: sysfs_heartbeat_interval
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_basic
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: gem_pread
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_module_load
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: tools_test
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_atomic_transition
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: gen3_render_mixed_blits
results: parsing output: 62/ for test: gem_exec_parallel
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: gem_softpin
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_color_pipeline
results: parsing output: 68/ for test: gem_flink_basic
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_mmap_write_crc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_getfb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: gem_sync
results: parsing output: 99/ for test: kms_plane_alpha_blend
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_dp_linktrain_fallback
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_huc_copy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_basic
results: parsing output: 111/ for test: kms_pipe_crc_basic
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_store
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: gem_basic
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: gem_exec_suspend
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_feature_discovery
results: parsing output: 131/ for test: dumb_buffer
results: parsing output: 132/ for test: kms_vblank
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: i915_pm_rps
results: parsing output: 135/ for test: kms_plane
results: parsing output: 136/ for test: kms_selftest
results: parsing output: 137/ for test: syncobj_basic
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_chamelium_hpd
results: parsing output: 141/ for test: kms_psr2_su
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: gem_mmap_gtt
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_wait
results: parsing output: 148/ for test: gem_exec_schedule
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_psr
results: parsing output: 151/ for test: kms_big_fb
results: parsing output: 152/ for test: kms_plane_scaling
results: parsing output: 153/ for test: gem_render_copy
Done.