[58.937264] Initializing watchdogs
[58.937311]   /dev/watchdog0
[58.951798] [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]
[58.956418] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.958728] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.962214] [001/133] (960s left) gem_ctx_persistence (heartbeat-hang)
[59.040074] Starting subtest: heartbeat-hang
[59.044624] Subtest heartbeat-hang: SKIP (0.000s)
[59.137417] [002/133] (960s left) gen9_exec_parse (bb-start-cmd)
[59.198089] Subtest bb-start-cmd: SKIP (0.000s)
[59.257267] [003/133] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[59.373258] Starting subtest: primary-yf-tiled-reflect-x-90
[59.377763] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[59.460773] [004/133] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[59.583102] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[63.755125] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.155s)
[64.876777] [005/133] (954s left) kms_atomic_transition (modeset-transition-nonblocking)
[64.972284] Starting subtest: modeset-transition-nonblocking
[64.974143] Starting dynamic subtest: 1x-outputs
[76.192739] Dynamic subtest 1x-outputs: SUCCESS (11.201s)
[76.195301] Subtest modeset-transition-nonblocking: SUCCESS (11.202s)
[77.044223] [006/133] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[77.149207] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[77.153871] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[77.255895] [007/133] (942s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[77.352135] Starting subtest: fbc-psr-cursor-mmap-cpu
[77.354523] Starting dynamic subtest: eDP-1
[77.358985] Dynamic subtest eDP-1: SKIP (0.000s)
[77.363615] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[77.426499] [008/133] (942s left) kms_hdr (invalid-metadata-sizes)
[77.528705] Starting subtest: invalid-metadata-sizes
[77.535060] Subtest invalid-metadata-sizes: SKIP (0.000s)
[77.604223] [009/133] (942s left) kms_cursor_crc (cursor-random-64x64)
[77.793710] Starting subtest: cursor-random-64x64
[77.798613] Starting dynamic subtest: pipe-A-eDP-1
[81.188710] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.387s)
[81.221234] Starting dynamic subtest: pipe-D-eDP-1
[85.159656] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.941s)
[85.161848] Subtest cursor-random-64x64: SUCCESS (7.357s)
[86.040034] [010/133] (933s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[86.433510] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[87.245546] [011/133] (932s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[87.336166] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[87.340416] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[87.399843] [012/133] (932s left) i915_pm_freq_api (freq-reset)
[87.453099] Starting subtest: freq-reset
[87.455526] Starting dynamic subtest: gt0
[87.650673] Dynamic subtest gt0: SUCCESS (0.197s)
[87.661058] Starting dynamic subtest: gt1
[87.815235] Dynamic subtest gt1: SUCCESS (0.162s)
[87.818234] Subtest freq-reset: SUCCESS (0.361s)
[87.896291] [013/133] (932s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[87.997874] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[92.605357] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.610s)
[93.775226] [014/133] (926s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[93.876525] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[93.878724] Starting dynamic subtest: pipe-A-eDP-1
[93.903399] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.914561] Starting dynamic subtest: pipe-B-eDP-1
[93.938189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.945530] Starting dynamic subtest: pipe-C-eDP-1
[93.968738] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.976433] Starting dynamic subtest: pipe-D-eDP-1
[93.999961] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[94.004229] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[96.138196] [015/133] (923s left) gem_userptr_blits (dmabuf-unsync)
[96.207578] Subtest dmabuf-unsync: SKIP (0.000s)
[96.315316] [016/133] (923s left) gem_userptr_blits (unsync-overlap)
[96.394647] Subtest unsync-overlap: SKIP (0.000s)
[96.523688] [017/133] (923s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[96.620306] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[96.622766] Starting dynamic subtest: pipe-A-eDP-1
[96.649575] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[96.663091] Starting dynamic subtest: pipe-B-eDP-1
[96.685642] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[96.695286] Starting dynamic subtest: pipe-C-eDP-1
[96.717091] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[96.725236] Starting dynamic subtest: pipe-D-eDP-1
[96.747986] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[96.752418] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[98.894607] [018/133] (921s left) gem_exec_alignment (pi)
[98.961103] Starting subtest: pi
[150.577024] Subtest pi: SUCCESS (51.603s)
[151.755232] [019/133] (868s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[151.840448] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[151.842774] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[151.941647] [020/133] (868s left) gem_exec_capture (capture)
[151.996985] Starting subtest: capture
[151.999292] Starting dynamic subtest: rcs0-smem
[152.844382] Dynamic subtest rcs0-smem: SUCCESS (0.847s)
[152.854597] Starting dynamic subtest: bcs0-smem
[153.669991] Dynamic subtest bcs0-smem: SUCCESS (0.824s)
[153.678370] Starting dynamic subtest: vcs0-smem
[154.495143] Dynamic subtest vcs0-smem: SUCCESS (0.824s)
[154.503247] Starting dynamic subtest: vcs1-smem
[155.816063] Dynamic subtest vcs1-smem: SUCCESS (1.322s)
[155.824916] Starting dynamic subtest: vecs0-smem
[156.707684] Dynamic subtest vecs0-smem: FAIL (0.833s)
[156.718216] Starting dynamic subtest: ccs0-smem
[157.977455] Dynamic subtest ccs0-smem: SUCCESS (1.328s)
[157.979836] Subtest capture: FAIL (5.980s)
[158.093207] [021/133] (862s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[158.202857] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[158.207991] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[158.298444] [022/133] (862s left) prime_self_import (reimport-vs-gem_close-race)
[158.335403] Starting subtest: reimport-vs-gem_close-race
[163.434063] Subtest reimport-vs-gem_close-race: SUCCESS (5.099s)
[163.507751] [023/133] (856s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[163.599062] Starting subtest: crc-primary-suspend-y-tiled-ccs
[163.601270] Starting dynamic subtest: pipe-A-eDP-1
[163.610674] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[163.619708] Starting dynamic subtest: pipe-B-eDP-1
[163.628857] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[163.637431] Starting dynamic subtest: pipe-C-eDP-1
[163.645743] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[163.653560] Starting dynamic subtest: pipe-D-eDP-1
[163.661781] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[163.665784] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[165.875077] [024/133] (854s left) gem_flink_basic (bad-flink)
[165.926920] Starting subtest: bad-flink
[165.929264] Subtest bad-flink: SUCCESS (0.000s)
[166.012391] [025/133] (854s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[166.074767] Starting subtest: y-tiled-to-vebox-y-tiled
[166.079410] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[166.282210] [026/133] (854s left) kms_hdr (static-toggle)
[166.383506] Starting subtest: static-toggle
[166.389962] Subtest static-toggle: SKIP (0.000s)
[166.454473] [027/133] (854s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[166.556730] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[167.447322] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.892s)
[167.618832] [028/133] (852s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[167.675739] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[167.678034] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[167.781697] [029/133] (852s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[167.880766] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[167.885056] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[167.975741] [030/133] (852s left) kms_vblank (query-forked-busy-hang)
[168.080166] Starting subtest: query-forked-busy-hang
[168.082537] Starting dynamic subtest: pipe-A-eDP-1
[194.650075] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.566s)
[194.665173] Starting dynamic subtest: pipe-D-eDP-1
[209.766157] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.112s)
[209.768163] Subtest query-forked-busy-hang: SUCCESS (41.681s)
[210.624167] [031/133] (810s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[210.699442] Subtest writes-after-reads: SKIP (0.000s)
[210.765638] [032/133] (809s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[210.859467] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[218.375409] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.519s)
[218.502812] [033/133] (802s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[218.605301] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[218.609203] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[218.692526] [034/133] (802s left) api_intel_allocator (reopen)
[218.754131] Starting subtest: reopen
[218.760731] Subtest reopen: SUCCESS (0.007s)
[218.876645] [035/133] (801s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[218.979951] Starting subtest: 4-tiled-8bpp-rotate-0
[220.238645] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.260s)
[220.383171] [036/133] (800s left) gem_exec_fence (basic-busy-all)
[220.446517] Starting subtest: basic-busy-all
[220.527344] Subtest basic-busy-all: SUCCESS (0.082s)
[223.034565] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[223.037973] [037/133] (797s left) core_auth (getclient-simple)
[223.073752] Starting subtest: getclient-simple
[223.098661] Subtest getclient-simple: SUCCESS (0.026s)
[223.203882] [038/133] (797s left) gem_render_copy_redux (flink-interruptible)
[223.261939] Starting subtest: flink-interruptible
[224.551488] Subtest flink-interruptible: SUCCESS (1.290s)
[224.675795] [039/133] (796s left) perf_pmu (init-sema)
[224.714293] Starting subtest: init-sema
[224.716088] Starting dynamic subtest: rcs0
[224.718087] Dynamic subtest rcs0: SUCCESS (0.002s)
[224.727264] Starting dynamic subtest: bcs0
[224.728848] Dynamic subtest bcs0: SUCCESS (0.000s)
[224.737091] Starting dynamic subtest: vcs0
[224.738617] Dynamic subtest vcs0: SUCCESS (0.001s)
[224.746800] Starting dynamic subtest: vcs1
[224.748436] Dynamic subtest vcs1: SUCCESS (0.001s)
[224.756434] Starting dynamic subtest: vecs0
[224.758051] Dynamic subtest vecs0: SUCCESS (0.001s)
[224.765841] Starting dynamic subtest: ccs0
[224.767463] Dynamic subtest ccs0: SUCCESS (0.000s)
[224.769055] Subtest init-sema: SUCCESS (0.007s)
[224.853593] [040/133] (796s left) kms_chamelium_color (ctm-negative)
[224.950879] Subtest ctm-negative: SKIP (0.000s)
[224.994934] [041/133] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[225.096228] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[225.099701] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[225.194391] [042/133] (795s left) kms_cursor_crc (cursor-onscreen-128x42)
[225.410592] Starting subtest: cursor-onscreen-128x42
[225.456911] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[225.652462] [043/133] (795s left) gem_mmap_gtt (coherency)
[225.707591] Subtest coherency: SKIP (0.000s)
[225.770218] [044/133] (795s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[225.891351] Starting subtest: x-tiled-16bpp-rotate-0
[227.215189] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.324s)
[227.340925] [045/133] (793s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[227.435527] Starting subtest: psr2-overlay-plane-update-continuous-sf
[227.437501] Starting dynamic subtest: pipe-A-eDP-1
[228.555769] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.121s)
[228.564909] Starting dynamic subtest: pipe-B-eDP-1
[230.325849] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.768s)
[230.328155] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.891s)
[231.130496] [046/133] (790s left) kms_big_fb (y-tiled-addfb-size-overflow)
[231.229732] Starting subtest: y-tiled-addfb-size-overflow
[231.234173] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[231.328278] [047/133] (789s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[231.443307] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[232.268822] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[232.429943] [048/133] (788s left) prime_self_import (basic-with_fd_dup)
[232.470447] Starting subtest: basic-with_fd_dup
[232.485940] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[232.597896] [049/133] (788s left) kms_flip (2x-wf_vblank-ts-check)
[232.688871] Starting subtest: 2x-wf_vblank-ts-check
[232.698150] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[232.782626] [050/133] (788s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[232.884302] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[232.888501] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[232.971438] [051/133] (788s left) gem_bad_reloc (negative-reloc-lut)
[233.034423] Subtest negative-reloc-lut: SKIP (0.000s)
[233.114521] [052/133] (788s left) kms_psr (pr-cursor-plane-move)
[233.210216] Starting subtest: pr-cursor-plane-move
[233.213797] Subtest pr-cursor-plane-move: SKIP (0.000s)
[233.286904] [053/133] (788s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[233.353973] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[233.458643] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[233.538573] [054/133] (788s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[233.603255] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[233.706605] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[233.783976] [055/133] (787s left) gem_exec_whisper (basic-queues)
[233.853068] Starting subtest: basic-queues
[239.913843] Subtest basic-queues: SUCCESS (6.058s)
[240.099715] [056/133] (781s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[240.163760] Starting subtest: single-wait-all-for-submit-signaled
[240.165983] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[240.270442] [057/133] (781s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[240.358730] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[240.361053] Starting dynamic subtest: pipe-A-eDP-1
[240.381261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[240.392781] Starting dynamic subtest: pipe-B-eDP-1
[240.411754] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[240.420786] Starting dynamic subtest: pipe-C-eDP-1
[240.441224] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[240.450068] Starting dynamic subtest: pipe-D-eDP-1
[240.469799] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[240.471703] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[242.589790] [058/133] (779s left) kms_addfb_basic (legacy-format)
[242.660387] Starting subtest: legacy-format
[242.687857] Subtest legacy-format: SUCCESS (0.026s)
[242.816802] [059/133] (779s left) kms_rotation_crc (primary-rotation-180)
[242.905634] Starting subtest: primary-rotation-180
[249.911554] Subtest primary-rotation-180: SUCCESS (7.007s)
[251.069228] [060/133] (770s left) gem_userptr_blits (relocations)
[251.157827] Starting subtest: relocations
[251.162281] Subtest relocations: SKIP (0.001s)
[251.289309] [061/133] (770s left) gem_close_race (multigpu-basic-threads)
[251.359613] Starting subtest: multigpu-basic-threads
[251.364228] Subtest multigpu-basic-threads: SKIP (0.000s)
[251.600674] [062/133] (770s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[251.702931] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[251.705187] Starting dynamic subtest: pipe-A-default-mode
[252.827593] Dynamic subtest pipe-A-default-mode: SKIP (1.122s)
[252.832038] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.124s)
[252.982207] [063/133] (769s left) gem_vm_create (invalid-destroy)
[253.043458] Starting subtest: invalid-destroy
[253.045737] Subtest invalid-destroy: SUCCESS (0.002s)
[253.151747] [064/133] (768s left) kms_properties (plane-properties-atomic)
[253.254009] Starting subtest: plane-properties-atomic
[253.256246] Starting dynamic subtest: pipe-A-eDP-1
[253.822925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[253.833385] Starting dynamic subtest: pipe-B-eDP-1
[255.078857] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[255.091793] Starting dynamic subtest: pipe-C-eDP-1
[256.401381] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.320s)
[256.410965] Starting dynamic subtest: pipe-D-eDP-1
[257.650891] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[257.652854] Subtest plane-properties-atomic: SUCCESS (4.396s)
[258.465140] [065/133] (763s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[258.550298] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[258.552571] Starting dynamic subtest: pipe-A-eDP-1
[258.575304] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[258.586829] Starting dynamic subtest: pipe-B-eDP-1
[258.608830] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[258.619043] Starting dynamic subtest: pipe-C-eDP-1
[258.640253] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[258.649228] Starting dynamic subtest: pipe-D-eDP-1
[258.671265] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[258.675689] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[260.812113] [066/133] (761s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[260.944480] Starting subtest: flip-vs-cursor-toggle
[270.003055] Subtest flip-vs-cursor-toggle: SUCCESS (9.058s)
[270.826461] [067/133] (751s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[270.940612] Starting subtest: plane-use-after-nonblocking-unbind
[270.942753] Starting dynamic subtest: pipe-A-eDP-1
[270.999793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[271.299771] Starting dynamic subtest: pipe-B-eDP-1
[272.126426] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.835s)
[272.415633] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.477s)
[273.280633] [068/133] (748s left) kms_properties (colorop-properties-atomic)
[273.381860] Starting subtest: colorop-properties-atomic
[273.383720] Starting dynamic subtest: pipe-A-eDP-1
[273.744607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[273.754247] Starting dynamic subtest: pipe-B-eDP-1
[274.883277] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s)
[274.893430] Starting dynamic subtest: pipe-C-eDP-1
[275.985497] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[275.996075] Starting dynamic subtest: pipe-D-eDP-1
[277.021560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.034s)
[277.024071] Subtest colorop-properties-atomic: SUCCESS (3.641s)
[277.827350] [069/133] (744s left) kms_force_connector_basic (force-connector-state)
[277.907978] Starting subtest: force-connector-state
[278.516504] Subtest force-connector-state: SUCCESS (0.611s)
[279.463355] [070/133] (742s left) gem_exec_suspend (basic-s3)
[279.525912] Starting subtest: basic-S3
[279.528484] Starting dynamic subtest: smem
[299.374840] Dynamic subtest smem: SUCCESS (6.335s)
[299.377911] Subtest basic-S3: SUCCESS (6.337s)
[299.570226] [071/133] (722s left) kms_psr (psr2-cursor-plane-onoff)
[299.687099] Starting subtest: psr2-cursor-plane-onoff
[299.689649] Starting dynamic subtest: eDP-1
[301.394450] Dynamic subtest eDP-1: SUCCESS (1.661s)
[301.397204] Subtest psr2-cursor-plane-onoff: SUCCESS (1.663s)
[302.278138] [072/133] (720s left) core_setmaster (master-drop-set-user)
[302.374621] Starting subtest: master-drop-set-user
[302.387210] Subtest master-drop-set-user: SUCCESS (0.015s)
[302.430698] [073/133] (720s left) kms_selftest (drm_format_helper)
[302.480811] Starting subtest: drm_format_helper
[302.542290] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[302.634738] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.092s)
[302.644670] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[302.724291] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.088s)
[302.734573] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[302.816332] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.087s)
[302.827934] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[302.911973] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.093s)
[302.922347] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[303.000162] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.087s)
[303.012058] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[303.090975] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.087s)
[303.104783] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[303.175490] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.083s)
[303.185650] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[303.260074] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.083s)
[303.271777] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[303.355771] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.092s)
[303.365901] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[303.440376] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.083s)
[303.450181] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[303.531624] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.089s)
[303.541606] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[303.618804] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.084s)
[303.628870] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[303.716426] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.094s)
[303.726656] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[303.810428] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.092s)
[303.821141] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[303.895878] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.083s)
[303.905916] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[303.978467] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.080s)
[303.988481] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[304.081549] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.100s)
[304.084458] Subtest drm_format_helper: SUCCESS (1.571s)
[304.225091] [074/133] (718s left) prime_mmap (test_forked_cpu_write)
[304.273335] Starting subtest: test_forked_cpu_write
[304.275391] Starting dynamic subtest: test_forked_cpu_write-smem
[304.281235] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.010s)
[304.283658] Subtest test_forked_cpu_write: SUCCESS (0.011s)
[304.395994] [075/133] (718s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[304.497391] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[304.502345] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[304.604954] [076/133] (717s left) i915_pm_rps (min-max-config-idle)
[304.676495] Starting subtest: min-max-config-idle
[304.681639] Subtest min-max-config-idle: SKIP (0.001s)
[304.755070] [077/133] (717s left) gem_exec_balancer (fairslice)
[304.803121] Starting subtest: fairslice
[307.766603] Subtest fairslice: SUCCESS (2.923s)
[308.406145] [078/133] (714s left) kms_pm_rpm (modeset-non-lpsp)
[310.557904] Starting subtest: modeset-non-lpsp
[311.710731] Subtest modeset-non-lpsp: SKIP (1.145s)
[312.096309] [079/133] (710s left) gem_exec_reloc (basic-scanout)
[312.154202] Subtest basic-scanout: SKIP (0.000s)
[312.233605] [080/133] (710s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[312.317258] Starting subtest: primary-4-tiled-reflect-x-0
[319.479344] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.135s)
[320.641644] [081/133] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[320.737752] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[320.742414] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[320.839451] [082/133] (701s left) gem_exec_fence (syncobj-timeline-chain-engines)
[321.398852] Starting subtest: syncobj-timeline-chain-engines
[321.514645] Subtest syncobj-timeline-chain-engines: SUCCESS (0.120s)
[322.452724] [083/133] (700s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[322.541320] Starting subtest: compare-crc-sanitycheck-xr24
[322.544097] Starting dynamic subtest: pipe-A-eDP-1
[323.190177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.646s)
[323.201493] Starting dynamic subtest: pipe-B-eDP-1
[324.510554] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.319s)
[324.521863] Starting dynamic subtest: pipe-C-eDP-1
[325.719324] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.204s)
[325.731925] Starting dynamic subtest: pipe-D-eDP-1
[326.926470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[326.929372] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.382s)
[327.746243] [084/133] (695s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[327.850644] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[327.856274] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[327.924325] [085/133] (695s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[328.019397] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[328.021778] Starting dynamic subtest: pipe-A-eDP-1
[328.137605] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[328.148652] Starting dynamic subtest: pipe-B-eDP-1
[329.282168] Dynamic subtest pipe-B-eDP-1: SKIP (1.142s)
[329.287272] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.267s)
[330.456549] [086/133] (692s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[330.507166] Starting subtest: rel-constants-invalid-rel-gen5
[330.509659] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[330.602804] [087/133] (692s left) syncobj_timeline (device-submit-unordered)
[330.659152] Starting subtest: device-submit-unordered
[330.661554] Subtest device-submit-unordered: SUCCESS (0.001s)
[330.759542] [088/133] (692s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[330.851406] Starting subtest: fbcpsr-tiling-y
[330.856424] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[330.949536] [089/133] (692s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[331.047443] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[331.049866] Starting dynamic subtest: pipe-A-eDP-1
[332.378668] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.331s)
[332.656409] Starting dynamic subtest: pipe-B-eDP-1
[333.661666] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.015s)
[333.942634] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.897s)
[334.758034] [090/133] (688s left) kms_addfb_basic (too-high)
[334.849156] Starting subtest: too-high
[334.851441] Subtest too-high: SUCCESS (0.001s)
[334.953161] [091/133] (688s left) kms_pm_backlight (brightness-with-dpms)
[335.051223] Starting subtest: brightness-with-dpms
[335.107500] Starting dynamic subtest: eDP-1
[337.495651] Dynamic subtest eDP-1: SUCCESS (2.392s)
[337.498324] Subtest brightness-with-dpms: SUCCESS (2.447s)
[338.332820] [092/133] (684s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[338.434522] Starting subtest: fbc-psr2-cursor-mmap-gtt
[338.437188] Starting dynamic subtest: eDP-1
[338.442120] Dynamic subtest eDP-1: SKIP (0.000s)
[338.446844] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[338.510168] [093/133] (684s left) kms_plane (pixel-format-y-tiled-modifier)
[338.605634] Starting subtest: pixel-format-y-tiled-modifier
[338.610836] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[338.682580] [094/133] (684s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[338.805880] Starting subtest: 2x-cursor-vs-flip-legacy
[338.811352] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[338.953543] [095/133] (684s left) gem_mmap_wc (write-gtt-read-wc)
[339.020367] Subtest write-gtt-read-wc: SKIP (0.000s)
[339.089499] [096/133] (684s left) prime_self_import (basic-with_two_bos)
[339.135084] Starting subtest: basic-with_two_bos
[339.146411] Subtest basic-with_two_bos: SUCCESS (0.014s)
[339.247288] [097/133] (684s left) kms_feature_discovery (display)
[339.335442] Starting subtest: display
[339.337757] Subtest display: SUCCESS (0.000s)
[339.409606] [098/133] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[339.502931] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[346.493344] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.990s)
[346.630696] [099/133] (676s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[346.710863] Starting subtest: wait-all-for-submit-delayed-submit
[346.811087] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[346.897051] [100/133] (676s left) gem_ctx_isolation (preservation)
[346.957264] Starting subtest: preservation
[346.960254] Starting dynamic subtest: rcs0
[347.071308] Dynamic subtest rcs0: SUCCESS (0.113s)
[347.085474] Starting dynamic subtest: bcs0
[347.226331] Dynamic subtest bcs0: SUCCESS (0.154s)
[347.241640] Starting dynamic subtest: vcs0
[347.389551] Dynamic subtest vcs0: SUCCESS (0.162s)
[347.403625] Starting dynamic subtest: vcs1
[348.441222] Dynamic subtest vcs1: SUCCESS (1.050s)
[348.455597] Starting dynamic subtest: vecs0
[350.502494] Dynamic subtest vecs0: SUCCESS (2.059s)
[350.517449] Starting dynamic subtest: ccs0
[352.500355] Dynamic subtest ccs0: SUCCESS (1.996s)
[352.504079] Subtest preservation: SUCCESS (5.541s)
[352.769452] [101/133] (670s left) gem_exec_params (invalid-fence-in)
[352.823645] Starting subtest: invalid-fence-in
[352.826959] Subtest invalid-fence-in: SUCCESS (0.000s)
[352.945277] [102/133] (670s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[353.045673] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[353.050667] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[353.167162] [103/133] (670s left) sysfs_heartbeat_interval (precise)
[353.238406] Starting subtest: precise
[353.240596] Starting dynamic subtest: vecs0
[360.357623] Dynamic subtest vecs0: SUCCESS (7.118s)
[360.370883] Starting dynamic subtest: ccs0
[361.447912] Dynamic subtest ccs0: SUCCESS (1.088s)
[361.461441] Starting dynamic subtest: vcs0
[369.387372] Dynamic subtest vcs0: SUCCESS (7.931s)
[369.400603] Starting dynamic subtest: bcs0
[370.469617] Dynamic subtest bcs0: SUCCESS (1.080s)
[370.480344] Starting dynamic subtest: rcs0
[373.355386] Dynamic subtest rcs0: SUCCESS (2.886s)
[373.369221] Starting dynamic subtest: vcs1
[380.392550] Dynamic subtest vcs1: SUCCESS (7.032s)
[380.395538] Subtest precise: SUCCESS (27.146s)
[380.485350] [104/133] (643s left) gem_render_copy (yf-tiled-ccs-to-linear)
[380.558917] Starting subtest: yf-tiled-ccs-to-linear
[380.564225] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[380.760503] [105/133] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[380.859277] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[380.864198] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[380.955518] [106/133] (643s left) kms_dirtyfb (default-dirtyfb-ioctl)
[381.073615] Starting subtest: default-dirtyfb-ioctl
[381.076382] Starting dynamic subtest: A-eDP-1
[382.696877] Dynamic subtest A-eDP-1: SUCCESS (1.622s)
[382.699604] Subtest default-dirtyfb-ioctl: SUCCESS (1.625s)
[383.550131] [107/133] (640s left) kms_lease (page-flip-implicit-plane)
[383.653079] Starting subtest: page-flip-implicit-plane
[383.655536] Starting dynamic subtest: pipe-A-eDP-1
[384.138533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[384.149782] Starting dynamic subtest: pipe-B-eDP-1
[385.268061] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[385.278752] Starting dynamic subtest: pipe-C-eDP-1
[386.362479] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.092s)
[386.373848] Starting dynamic subtest: pipe-D-eDP-1
[387.463877] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s)
[387.466297] Subtest page-flip-implicit-plane: SUCCESS (3.807s)
[388.262014] [108/133] (635s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[388.367388] Starting subtest: plane-upscale-factor-0-25-with-rotation
[388.370200] Starting dynamic subtest: pipe-A
[388.595072] Dynamic subtest pipe-A: SUCCESS (0.229s)
[388.606215] Starting dynamic subtest: pipe-B
[389.903608] Dynamic subtest pipe-B: SUCCESS (1.307s)
[389.914810] Starting dynamic subtest: pipe-C
[391.205438] Dynamic subtest pipe-C: SUCCESS (1.300s)
[391.219917] Starting dynamic subtest: pipe-D
[392.506323] Dynamic subtest pipe-D: SUCCESS (1.298s)
[392.509424] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.140s)
[393.662166] [109/133] (630s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[394.058302] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[394.830471] [110/133] (629s left) gem_madvise (dontneed-after-mmap)
[394.875550] Starting subtest: dontneed-after-mmap
[394.885493] Subtest dontneed-after-mmap: SUCCESS (0.016s)
[394.979873] [111/133] (629s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[395.075401] Starting subtest: fbc-shrfb-scaledprimary
[397.972351] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.903s)
[399.165905] [112/133] (625s left) kms_content_protection (lic-type-1)
[399.311843] Starting subtest: lic-type-1
[399.316507] Subtest lic-type-1: SKIP (0.000s)
[399.608267] [113/133] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[399.729831] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[399.735165] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[399.834996] [114/133] (624s left) kms_cursor_edge_walk (64x64-top-bottom)
[399.930822] Starting subtest: 64x64-top-bottom
[399.933360] Starting dynamic subtest: pipe-A-eDP-1
[403.390222] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[403.401471] Starting dynamic subtest: pipe-D-eDP-1
[406.569580] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.180s)
[406.572427] Subtest 64x64-top-bottom: SUCCESS (6.643s)
[407.459506] [115/133] (616s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[407.561886] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[407.566582] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[407.665103] [116/133] (616s left) gem_exec_schedule (implicit-read-write)
[407.734952] Starting subtest: implicit-read-write
[407.737400] Starting dynamic subtest: rcs0
[407.844827] Dynamic subtest rcs0: SUCCESS (0.121s)
[407.857443] Starting dynamic subtest: vcs0
[407.929165] Dynamic subtest vcs0: SUCCESS (0.083s)
[407.941270] Starting dynamic subtest: vcs1
[408.019553] Dynamic subtest vcs1: SUCCESS (0.090s)
[408.033135] Starting dynamic subtest: vecs0
[408.111914] Dynamic subtest vecs0: SUCCESS (0.090s)
[408.126479] Starting dynamic subtest: ccs0
[408.202373] Dynamic subtest ccs0: SUCCESS (0.088s)
[408.205180] Subtest implicit-read-write: SUCCESS (0.480s)
[409.474232] [117/133] (614s left) i915_drm_fdinfo (most-busy-check-all)
[409.531614] Starting subtest: most-busy-check-all
[409.534838] Starting dynamic subtest: rcs0
[409.540484] Dynamic subtest rcs0: SKIP (0.004s)
[409.553428] Starting dynamic subtest: bcs0
[409.559105] Dynamic subtest bcs0: SKIP (0.000s)
[409.569845] Starting dynamic subtest: vcs0
[409.574606] Dynamic subtest vcs0: SKIP (0.000s)
[409.585021] Starting dynamic subtest: vcs1
[409.590190] Dynamic subtest vcs1: SKIP (0.000s)
[409.600440] Starting dynamic subtest: vecs0
[409.605524] Dynamic subtest vecs0: SKIP (0.000s)
[409.617496] Starting dynamic subtest: ccs0
[409.622530] Dynamic subtest ccs0: SKIP (0.000s)
[409.627646] Subtest most-busy-check-all: SKIP (0.010s)
[409.667978] [118/133] (614s left) gem_eio (reset-stress)
[409.918036] Starting subtest: reset-stress
[409.920600] Starting dynamic subtest: render
[414.959504] Dynamic subtest render: SUCCESS (5.040s)
[414.976938] Starting dynamic subtest: bsd1
[432.882266] Dynamic subtest bsd1: SUCCESS (17.921s)
[432.899752] Starting dynamic subtest: bsd2
[450.888125] Dynamic subtest bsd2: SUCCESS (18.002s)
[450.905141] Starting dynamic subtest: blt
[450.910235] Dynamic subtest blt: SKIP (0.000s)
[450.920629] Starting dynamic subtest: vebox
[468.895138] Dynamic subtest vebox: SUCCESS (18.001s)
[468.897552] Subtest reset-stress: SUCCESS (58.968s)
[470.423363] [119/133] (554s left) gem_tiled_partial_pwrite_pread (writes)
[470.486773] Subtest writes: SKIP (0.000s)
[470.556898] [120/133] (554s left) sriov_basic (bind-unbind-vf)
[470.620484] Starting subtest: bind-unbind-vf
[470.623320] Starting dynamic subtest: vf-1
[470.710399] Dynamic subtest vf-1: FAIL (0.005s)
[470.722512] Starting dynamic subtest: vf-2
[470.805089] Dynamic subtest vf-2: FAIL (0.004s)
[470.817506] Starting dynamic subtest: vf-3
[470.906535] Dynamic subtest vf-3: FAIL (0.003s)
[470.918978] Starting dynamic subtest: vf-4
[471.009076] Dynamic subtest vf-4: FAIL (0.003s)
[471.020541] Starting dynamic subtest: vf-5
[471.110222] Dynamic subtest vf-5: FAIL (0.004s)
[471.122333] Starting dynamic subtest: vf-6
[471.200941] Dynamic subtest vf-6: FAIL (0.003s)
[471.210909] Starting dynamic subtest: vf-7
[471.288528] Dynamic subtest vf-7: FAIL (0.004s)
[471.298798] Starting dynamic subtest: vf-random
[471.387232] Dynamic subtest vf-random: FAIL (0.003s)
[471.399100] Starting dynamic subtest: vf-last
[471.472635] Dynamic subtest vf-last: FAIL (0.598s)
[471.474842] Subtest bind-unbind-vf: FAIL (0.635s)
[471.516984] [121/133] (553s left) gem_mmap_offset (oob-read)
[471.578851] Starting subtest: oob-read
[471.580912] Subtest oob-read: SUCCESS (0.000s)
[471.695506] [122/133] (552s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[471.756259] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[471.758495] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[471.877005] [123/133] (552s left) gem_pwrite (basic-self)
[471.936887] Subtest basic-self: SKIP (0.000s)
[472.009147] [124/133] (552s left) kms_color (ctm-0-75)
[472.098969] Starting subtest: ctm-0-75
[472.101301] Starting dynamic subtest: pipe-A-eDP-1
[476.998463] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.896s)
[477.009915] Starting dynamic subtest: pipe-B-eDP-1
[482.597521] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.598s)
[482.609142] Starting dynamic subtest: pipe-C-eDP-1
[487.974541] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.374s)
[487.986251] Starting dynamic subtest: pipe-D-eDP-1
[493.560431] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.583s)
[493.563209] Subtest ctm-0-75: SUCCESS (21.454s)
[494.365380] [125/133] (530s left) perf_pmu (busy)
[494.420796] Starting subtest: busy
[494.423666] Starting dynamic subtest: rcs0
[495.003194] Dynamic subtest rcs0: SUCCESS (0.582s)
[495.016618] Starting dynamic subtest: bcs0
[495.572507] Dynamic subtest bcs0: SUCCESS (0.566s)
[495.584673] Starting dynamic subtest: vcs0
[497.389604] Dynamic subtest vcs0: SUCCESS (1.813s)
[497.403746] Starting dynamic subtest: vcs1
[499.373813] Dynamic subtest vcs1: SUCCESS (1.980s)
[499.385927] Starting dynamic subtest: vecs0
[501.357981] Dynamic subtest vecs0: SUCCESS (1.980s)
[501.377073] Starting dynamic subtest: ccs0
[501.927126] Dynamic subtest ccs0: SUCCESS (0.567s)
[501.930143] Subtest busy: SUCCESS (7.506s)
[502.048710] [126/133] (522s left) i915_selftest (perf)
[503.789376] Starting subtest: perf
[503.792769] Starting dynamic subtest: engine_cs
[507.455757] Dynamic subtest engine_cs: SUCCESS (3.664s)
[507.466954] Starting dynamic subtest: request
[513.705887] Dynamic subtest request: SUCCESS (6.247s)
[513.723012] Starting dynamic subtest: migrate
[517.483488] Dynamic subtest migrate: SUCCESS (3.775s)
[517.493369] Starting dynamic subtest: region
[522.526940] Dynamic subtest region: SUCCESS (5.041s)
[522.529620] Subtest perf: SUCCESS (18.733s)
[522.558805] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[522.559553] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[522.563110] [127/133] (502s left) gem_lmem_swapping (verify-random)
[524.936431] Subtest verify-random: SKIP (0.000s)
[524.988714] [FACT gem_lmem_swapping (verify-random)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[524.990493] [FACT gem_lmem_swapping (verify-random)] new: kernel.kmod_is_loaded.i915: true
[524.995384] [128/133] (499s left) gem_exec_schedule (u-independent)
[525.077648] Starting subtest: u-independent
[525.080462] Starting dynamic subtest: rcs0
[526.386325] Dynamic subtest rcs0: SUCCESS (1.321s)
[526.401118] Starting dynamic subtest: vcs0
[528.370949] Dynamic subtest vcs0: SUCCESS (1.982s)
[528.383174] Starting dynamic subtest: vcs1
[530.424662] Dynamic subtest vcs1: SUCCESS (2.052s)
[530.437416] Starting dynamic subtest: vecs0
[532.340476] Dynamic subtest vecs0: SUCCESS (1.914s)
[532.353505] Starting dynamic subtest: ccs0
[534.383431] Dynamic subtest ccs0: SUCCESS (2.042s)
[534.386633] Subtest u-independent: SUCCESS (9.322s)
[534.688927] [129/133] (490s left) gem_spin_batch (user-each)
[534.751394] Starting subtest: user-each
[538.039473] Subtest user-each: SUCCESS (3.281s)
[538.437157] [130/133] (486s left) gem_userptr_blits (sync-unmap-cycles)
[538.502421] Starting subtest: sync-unmap-cycles
[543.875589] Subtest sync-unmap-cycles: SUCCESS (5.378s)
[544.021273] [131/133] (481s left) gem_lmem_swapping (parallel-random-engines)
[544.065146] Subtest parallel-random-engines: SKIP (0.000s)
[544.114216] [132/133] (481s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[544.216347] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[544.220634] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[544.311711] [133/133] (480s left) kms_flip (plain-flip-fb-recreate-interruptible)
[544.411492] Starting subtest: plain-flip-fb-recreate-interruptible
[544.414205] Starting dynamic subtest: A-eDP1
[553.300525] Dynamic subtest A-eDP1: SUCCESS (8.887s)
[553.311394] Starting dynamic subtest: B-eDP1
[562.121615] Dynamic subtest B-eDP1: SUCCESS (8.820s)
[562.132863] Starting dynamic subtest: C-eDP1
[570.951783] Dynamic subtest C-eDP1: SUCCESS (8.830s)
[570.961417] Starting dynamic subtest: D-eDP1
[579.776069] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[579.780785] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.373s)
[580.948421] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: gen9_exec_parse
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_hdr
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_chamelium_edid
results: parsing output: 10/ for test: kms_plane
results: parsing output: 11/ for test: i915_pm_freq_api
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_exec_alignment
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_exec_capture
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_flink_basic
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: kms_hdr
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: api_intel_allocator
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: core_auth
results: parsing output: 37/ for test: gem_render_copy_redux
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_chamelium_color
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: prime_self_import
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_bad_reloc
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_exec_whisper
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: gem_close_race
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: gem_vm_create
results: parsing output: 63/ for test: kms_properties
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_atomic_transition
results: parsing output: 67/ for test: kms_properties
results: parsing output: 68/ for test: kms_force_connector_basic
results: parsing output: 69/ for test: gem_exec_suspend
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: core_setmaster
results: parsing output: 72/ for test: kms_selftest
results: parsing output: 73/ for test: prime_mmap
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: i915_pm_rps
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_pipe_crc_basic
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_atomic_transition
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_pm_backlight
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: gem_mmap_wc
results: parsing output: 95/ for test: prime_self_import
results: parsing output: 96/ for test: kms_feature_discovery
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_ctx_isolation
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: sysfs_heartbeat_interval
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_dirtyfb
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: gem_madvise
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 119/ for test: sriov_basic
results: parsing output: 120/ for test: gem_mmap_offset
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_pwrite
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: i915_selftest
results: parsing output: 126/ for test: gem_lmem_swapping
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_spin_batch
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: gem_lmem_swapping
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_flip
Done.