[73.791902] Initializing watchdogs
[73.792126]   /dev/watchdog0
[73.813312] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[73.821252] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.824906] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.828366] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[73.916142] Starting subtest: invalid-bad-pad
[73.916886] Subtest invalid-bad-pad: SUCCESS (0.000s)
[74.045752] [002/131] (960s left) tools_test (tools_test)
[74.108808] Starting subtest: tools_test
[74.210213] Subtest tools_test: SUCCESS (0.107s)
[74.310764] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[74.369588] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[74.424767] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[74.496301] Starting subtest: sync-unmap-cycles
[79.867795] Subtest sync-unmap-cycles: SUCCESS (5.369s)
[80.017769] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[80.315378] Starting subtest: stress-xrgb8888-ytiled
[80.317930] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[80.510952] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[80.567422] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[80.626733] [007/131] (953s left) api_intel_allocator (gem-pool)
[80.683042] Starting subtest: gem-pool
[80.686508] Subtest gem-pool: SUCCESS (0.004s)
[80.834865] [008/131] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[81.134421] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[81.136054] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[81.534054] [009/131] (953s left) kms_atomic_interruptible (universal-setplane-primary)
[81.836640] Starting subtest: universal-setplane-primary
[81.839297] Starting dynamic subtest: pipe-A-HDMI-A-1
[88.191784] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.352s)
[88.192584] Subtest universal-setplane-primary: SUCCESS (6.354s)
[88.702759] [010/131] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[89.018470] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[91.706369] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.688s)
[92.172712] [011/131] (942s left) gem_eio (in-flight-contexts-1us)
[92.238166] Starting subtest: in-flight-contexts-1us
[95.636417] Subtest in-flight-contexts-1us: SUCCESS (3.398s)
[96.292255] [012/131] (938s left) gem_exec_balancer (semaphore)
[96.357365] Subtest semaphore: SKIP (0.000s)
[96.470575] [013/131] (938s left) kms_chamelium_hpd (hdmi-hpd)
[96.849198] Subtest hdmi-hpd: SKIP (0.000s)
[97.183870] [014/131] (937s left) kms_flip (wf_vblank-ts-check)
[97.476882] Starting subtest: wf_vblank-ts-check
[97.477793] Starting dynamic subtest: A-VGA1
[105.577329] Dynamic subtest A-VGA1: SUCCESS (8.098s)
[105.587549] Starting dynamic subtest: B-VGA1
[113.585331] Dynamic subtest B-VGA1: SUCCESS (8.006s)
[113.596023] Starting dynamic subtest: A-HDMI-A1
[121.761351] Dynamic subtest A-HDMI-A1: SUCCESS (8.174s)
[121.772102] Starting dynamic subtest: B-HDMI-A1
[129.963760] Dynamic subtest B-HDMI-A1: SUCCESS (8.201s)
[129.964587] Subtest wf_vblank-ts-check: SUCCESS (32.485s)
[130.544564] [015/131] (904s left) gem_exec_reloc (basic-gtt)
[130.608446] Starting subtest: basic-gtt
[130.612861] Subtest basic-gtt: SUCCESS (0.004s)
[131.243997] [016/131] (903s left) gem_exec_schedule (reorder-wide)
[131.309933] Subtest reorder-wide: SKIP (0.000s)
[131.544185] [017/131] (903s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[131.595291] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[131.654291] [018/131] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[131.950265] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[131.951640] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[132.355561] [019/131] (902s left) perf (polling)
[132.504452] Subtest polling: SKIP (0.000s)
[132.554635] [020/131] (902s left) gem_userptr_blits (probe)
[132.636785] Starting subtest: probe
[132.819513] Subtest probe: SUCCESS (0.184s)
[132.962337] [021/131] (902s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[133.266808] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[133.268314] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[133.670906] [022/131] (901s left) gem_mmap_offset (pf-nonblock)
[133.725691] Starting subtest: pf-nonblock
[133.728320] Subtest pf-nonblock: SUCCESS (0.003s)
[133.886500] [023/131] (901s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[133.940205] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[134.000214] [024/131] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[134.292616] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[134.294056] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[134.704027] [025/131] (900s left) core_getstats (basic)
[134.759981] Starting subtest: basic
[134.760940] Subtest basic: SUCCESS (0.000s)
[134.885548] [026/131] (900s left) core_getclient (basic)
[134.937893] Starting subtest: basic
[134.939061] Subtest basic: SUCCESS (0.000s)
[135.053304] [027/131] (900s left) syncobj_timeline (multi-wait-all-available-submitted)
[135.106583] Starting subtest: multi-wait-all-available-submitted
[135.107338] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[135.236486] [028/131] (900s left) gem_exec_reloc (basic-write-wc)
[135.293650] Starting subtest: basic-write-wc
[135.296332] Subtest basic-write-wc: SUCCESS (0.003s)
[135.936072] [029/131] (899s left) kms_invalid_mode (clock-too-high)
[136.226856] Starting subtest: clock-too-high
[136.227713] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.304904] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.079s)
[136.314734] Starting dynamic subtest: pipe-B-HDMI-A-1
[136.315687] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[136.316470] Subtest clock-too-high: SUCCESS (0.082s)
[136.698977] [030/131] (898s left) gem_mmap_offset (bad-object)
[136.751312] Starting subtest: bad-object
[136.753215] Subtest bad-object: SUCCESS (0.002s)
[136.884481] [031/131] (898s left) syncobj_timeline (wait-all-delayed-signal)
[136.941502] Starting subtest: wait-all-delayed-signal
[137.044581] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[137.173033] [032/131] (898s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[137.476013] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[137.478945] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.001s)
[137.885914] [033/131] (897s left) gem_exec_suspend (basic-s3)
[137.951774] Starting subtest: basic-S3
[137.952597] Starting dynamic subtest: smem
[155.101849] Dynamic subtest smem: SUCCESS (1.372s)
[155.103226] Subtest basic-S3: SUCCESS (1.373s)
[163.352433] [034/131] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[163.681105] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[163.683840] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[164.093421] [035/131] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[164.395159] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[164.396491] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[164.793959] [036/131] (879s left) kms_chamelium_frames (hdmi-crc-multiple)
[165.161900] Subtest hdmi-crc-multiple: SKIP (0.000s)
[165.470342] [037/131] (878s left) gem_exec_fence (syncobj-import)
[165.708885] Starting subtest: syncobj-import
[165.711404] Subtest syncobj-import: SUCCESS (0.003s)
[166.098028] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[166.100636] [038/131] (877s left) kms_legacy_colorkey (basic)
[166.399870] Starting subtest: basic
[166.400489] Starting dynamic subtest: pipe-A
[166.401145] Dynamic subtest pipe-A: SUCCESS (0.000s)
[166.413701] Starting dynamic subtest: pipe-B
[166.414397] Dynamic subtest pipe-B: SUCCESS (0.000s)
[166.415130] Subtest basic: SUCCESS (0.002s)
[166.812899] [039/131] (877s left) gem_softpin (allocator-nopin-reserve)
[166.872490] Subtest allocator-nopin-reserve: SKIP (0.000s)
[166.997795] [040/131] (877s left) perf_pmu (enable-race)
[167.055155] Starting subtest: enable-race
[167.055908] Starting dynamic subtest: rcs0
[167.057145] Dynamic subtest rcs0: SKIP (0.000s)
[167.071523] Starting dynamic subtest: bcs0
[167.073356] Dynamic subtest bcs0: SKIP (0.000s)
[167.090872] Starting dynamic subtest: vcs0
[167.093173] Dynamic subtest vcs0: SKIP (0.000s)
[167.095003] Subtest enable-race: SKIP (0.002s)
[167.193015] [041/131] (877s left) syncobj_timeline (signal-point-0)
[167.248313] Starting subtest: signal-point-0
[167.249044] Subtest signal-point-0: SUCCESS (0.000s)
[167.375584] [042/131] (876s left) gem_tiled_wb
[176.013530] [043/131] (868s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[176.070284] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[176.135966] [044/131] (868s left) gem_ctx_param (set-priority-invalid-size)
[176.188433] Subtest set-priority-invalid-size: SKIP (0.000s)
[176.327034] [045/131] (868s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[176.621401] Starting subtest: plane-ctm3x4-lut1d
[176.918460] Subtest plane-ctm3x4-lut1d: SKIP (0.297s)
[177.427997] [046/131] (867s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[177.729040] Starting subtest: 2x-long-cursor-vs-flip-atomic
[177.730542] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[178.143867] [047/131] (866s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[178.440537] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[180.284338] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.843s)
[180.735040] [048/131] (863s left) kms_feature_discovery (display-1x)
[181.032066] Starting subtest: display-1x
[181.032936] Subtest display-1x: SUCCESS (0.000s)
[181.449782] [049/131] (863s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[181.755640] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[181.757216] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[182.169437] [050/131] (862s left) i915_drm_fdinfo (most-busy-idle-check-all)
[182.227323] Subtest most-busy-idle-check-all: SKIP (0.000s)
[182.299706] [051/131] (862s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[182.604019] Starting subtest: x-tiled-32bpp-rotate-270
[182.613254] Subtest x-tiled-32bpp-rotate-270: SKIP (0.008s)
[183.036508] [052/131] (861s left) gem_exec_schedule (u-submit-early-slice)
[183.108118] Subtest u-submit-early-slice: SKIP (0.000s)
[183.344646] [053/131] (861s left) gem_pxp (regular-baseline-src-copy-readible)
[185.915553] Starting subtest: regular-baseline-src-copy-readible
[185.917633] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[186.046601] [054/131] (858s left) gem_exec_balancer (full-late-pulse)
[186.104085] Subtest full-late-pulse: SKIP (0.000s)
[186.237945] [055/131] (858s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[186.542091] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[186.543510] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[186.954708] [056/131] (858s left) fbdev (read)
[187.023216] Starting subtest: read
[187.413734] Subtest read: SUCCESS (0.390s)
[187.520720] [057/131] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[187.815345] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[187.816639] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.223686] [058/131] (856s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[188.518937] Starting subtest: multiplane-rotation-cropping-top
[188.520298] Subtest multiplane-rotation-cropping-top: SKIP (0.000s)
[188.945451] [059/131] (856s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[189.257726] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[189.259514] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[189.672570] [060/131] (855s left) i915_selftest (mock)
[190.593131] Starting subtest: mock
[190.594110] Starting dynamic subtest: sanitycheck
[191.739365] Dynamic subtest sanitycheck: SUCCESS (1.146s)
[191.751161] Starting dynamic subtest: shmem
[192.874393] Dynamic subtest shmem: SUCCESS (1.134s)
[192.886130] Starting dynamic subtest: fence
[200.870478] Dynamic subtest fence: SUCCESS (7.997s)
[200.886515] Starting dynamic subtest: scatterlist
[202.981337] Dynamic subtest scatterlist: SUCCESS (2.110s)
[202.992989] Starting dynamic subtest: syncmap
[206.167447] Dynamic subtest syncmap: SUCCESS (3.185s)
[206.179633] Starting dynamic subtest: uncore
[207.305363] Dynamic subtest uncore: SUCCESS (1.137s)
[207.317741] Starting dynamic subtest: ring
[208.429469] Dynamic subtest ring: SUCCESS (1.123s)
[208.441806] Starting dynamic subtest: engine
[209.554507] Dynamic subtest engine: SUCCESS (1.124s)
[209.566316] Starting dynamic subtest: timelines
[215.760267] Dynamic subtest timelines: SUCCESS (6.205s)
[215.771966] Starting dynamic subtest: requests
[219.020448] Dynamic subtest requests: SUCCESS (3.259s)
[219.036736] Starting dynamic subtest: objects
[220.305499] Dynamic subtest objects: SUCCESS (1.284s)
[220.317214] Starting dynamic subtest: phys
[221.595563] Dynamic subtest phys: SUCCESS (1.289s)
[221.607422] Starting dynamic subtest: dmabuf
[222.837595] Dynamic subtest dmabuf: SUCCESS (1.241s)
[222.849378] Starting dynamic subtest: vma
[234.542326] Dynamic subtest vma: SUCCESS (11.704s)
[234.554240] Starting dynamic subtest: evict
[237.153587] Dynamic subtest evict: SUCCESS (2.610s)
[237.166264] Starting dynamic subtest: gtt
[241.526396] Dynamic subtest gtt: SUCCESS (4.372s)
[241.542338] Starting dynamic subtest: hugepages
[243.014302] Dynamic subtest hugepages: SUCCESS (1.487s)
[243.026362] Starting dynamic subtest: memory_region
[248.273315] Dynamic subtest memory_region: SUCCESS (5.258s)
[248.274150] Subtest mock: SUCCESS (57.686s)
[248.309953] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[248.311169] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[248.313336] [061/131] (796s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[250.386008] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[250.593410] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[250.595018] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[250.598808] [062/131] (794s left) gem_render_copy_redux (normal)
[250.664724] Starting subtest: normal
[251.214751] Subtest normal: SUCCESS (0.549s)
[251.385265] [063/131] (794s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[251.441347] Starting subtest: basic-cpu-wc-noreloc
[251.443410] Subtest basic-cpu-wc-noreloc: SUCCESS (0.002s)
[252.087007] [064/131] (793s left) gem_ctx_param (invalid-set-no-zeromap)
[252.141716] Starting subtest: invalid-set-no-zeromap
[252.142506] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[252.267657] [065/131] (793s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[252.564156] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[252.565671] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[252.981356] [066/131] (792s left) i915_pm_rps (reset)
[253.042708] Starting subtest: reset
[257.580593] Subtest reset: SUCCESS (4.537s)
[257.742137] [067/131] (787s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[258.033969] Starting subtest: async-flip-with-page-flip-events-linear
[258.175153] Subtest async-flip-with-page-flip-events-linear: SKIP (0.141s)
[258.710027] [068/131] (786s left) perf_pmu (module-unload)
[258.785970] Starting subtest: module-unload
[265.116200] Subtest module-unload: FAIL (6.311s)
[265.147001] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[265.148267] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[265.150584] [069/131] (780s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[267.232701] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[267.234223] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[267.697329] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[267.698930] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[267.702691] [070/131] (778s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[267.762400] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[267.869410] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[267.998733] [071/131] (777s left) kms_cursor_crc (cursor-random-256x85)
[268.299045] Starting subtest: cursor-random-256x85
[268.359690] Subtest cursor-random-256x85: SKIP (0.060s)
[268.803600] [072/131] (777s left) kms_psr (psr-sprite-plane-move)
[269.108804] Subtest psr-sprite-plane-move: SKIP (0.000s)
[269.310694] [073/131] (776s left) kms_psr (fbc-pr-sprite-plane-onoff)
[269.605698] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[269.806750] [074/131] (776s left) kms_pm_rpm (pm-tiling)
[281.304179] Subtest pm-tiling: SKIP (0.000s)
[281.503628] [075/131] (764s left) gem_userptr_blits (invalid-null-pointer)
[281.570843] Starting subtest: invalid-null-pointer
[281.573346] Subtest invalid-null-pointer: SUCCESS (0.004s)
[281.760900] [076/131] (764s left) kms_content_protection (lic-type-1)
[282.065439] Starting subtest: lic-type-1
[282.066876] Subtest lic-type-1: SKIP (0.000s)
[282.474665] [077/131] (763s left) kms_atomic (plane-immutable-zpos)
[282.773962] Starting subtest: plane-immutable-zpos
[282.774748] Starting dynamic subtest: pipe-A-HDMI-A-1
[283.288948] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.514s)
[283.289593] Subtest plane-immutable-zpos: SUCCESS (0.516s)
[283.808873] [078/131] (762s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[284.106525] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[284.109101] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[284.522790] [079/131] (761s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[284.819731] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[284.820420] Starting dynamic subtest: pipe-A
[284.822446] Dynamic subtest pipe-A: SKIP (0.001s)
[284.835479] Starting dynamic subtest: pipe-B
[284.837255] Dynamic subtest pipe-B: SKIP (0.001s)
[284.838336] Subtest plane-upscale-factor-0-25-with-pixel-format: SKIP (0.005s)
[285.235417] [080/131] (761s left) kms_psr (pr-sprite-mmap-cpu)
[285.524688] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[285.733028] [081/131] (760s left) gem_ctx_persistence (legacy-engines-cleanup)
[285.791026] Subtest legacy-engines-cleanup: SKIP (0.000s)
[285.846038] [082/131] (760s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[286.141999] Starting subtest: cursor-tearing-framebuffer-change
[286.142876] Starting dynamic subtest: pipe-A-HDMI-A-1
[286.499210] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.357s)
[286.513233] Starting dynamic subtest: pipe-B-HDMI-A-1
[286.863972] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.361s)
[286.864797] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.722s)
[287.398965] [083/131] (759s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[287.693799] Starting subtest: 2x-cursor-vs-flip-atomic
[287.695334] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[288.113006] [084/131] (758s left) kms_cursor_crc (cursor-random-32x10)
[288.409855] Starting subtest: cursor-random-32x10
[288.465378] Subtest cursor-random-32x10: SKIP (0.054s)
[288.889906] [085/131] (757s left) kms_psr (fbc-psr-primary-mmap-gtt)
[289.186354] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[289.390486] [086/131] (757s left) kms_big_fb (linear-8bpp-rotate-0)
[289.693132] Starting subtest: linear-8bpp-rotate-0
[290.922944] Subtest linear-8bpp-rotate-0: SUCCESS (1.230s)
[291.373080] [087/131] (755s left) gem_create (create-ext-cpu-access-sanity-check)
[291.546955] Starting subtest: create-ext-cpu-access-sanity-check
[291.548734] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[291.671778] [088/131] (755s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[291.967637] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[293.469926] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.502s)
[293.924931] [089/131] (752s left) kms_pm_rpm (cursor-dpms)
[305.418580] Subtest cursor-dpms: SKIP (0.000s)
[305.624144] [090/131] (741s left) gem_lmem_swapping (verify-random-ccs)
[305.683887] Subtest verify-random-ccs: SKIP (0.000s)
[305.740024] [091/131] (741s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[306.045226] Starting subtest: flip-vs-cursor-toggle
[320.646013] Subtest flip-vs-cursor-toggle: SUCCESS (14.599s)
[321.164615] [092/131] (725s left) gem_lmem_swapping (heavy-verify-multi)
[321.222975] Subtest heavy-verify-multi: SKIP (0.000s)
[321.292935] [093/131] (725s left) i915_pm_freq_api (freq-reset)
[321.352488] Subtest freq-reset: SKIP (0.000s)
[321.422668] [094/131] (725s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[321.719585] Starting subtest: y-tiled-64bpp-rotate-90
[321.721153] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[322.135852] [095/131] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[322.431337] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[322.432852] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[322.841943] [096/131] (724s left) kms_dirtyfb (default-dirtyfb-ioctl)
[323.132153] Starting subtest: default-dirtyfb-ioctl
[323.133039] Starting dynamic subtest: A-HDMI-A-1
[324.472369] Dynamic subtest A-HDMI-A-1: SUCCESS (1.338s)
[324.473065] Subtest default-dirtyfb-ioctl: SUCCESS (1.342s)
[325.010832] [097/131] (722s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[325.310604] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[325.311485] Starting dynamic subtest: pipe-A
[325.313334] Dynamic subtest pipe-A: SKIP (0.001s)
[325.328795] Starting dynamic subtest: pipe-B
[325.330755] Dynamic subtest pipe-B: SKIP (0.001s)
[325.332083] Subtest plane-downscale-factor-0-75-with-modifiers: SKIP (0.005s)
[325.725073] [098/131] (721s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[325.784041] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[325.853736] [099/131] (721s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[326.150540] Starting subtest: 2x-cursor-vs-flip-legacy
[326.153294] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[326.570660] [100/131] (720s left) gem_readwrite (write-bad-handle)
[326.630332] Starting subtest: write-bad-handle
[326.631627] Subtest write-bad-handle: SUCCESS (0.000s)
[326.771669] [101/131] (720s left) gem_reg_read (timestamp-monotonic)
[326.826168] Starting subtest: timestamp-monotonic
[331.108766] Subtest timestamp-monotonic: SUCCESS (4.283s)
[331.250909] [102/131] (716s left) kms_psr (fbc-psr2-cursor-plane-move)
[331.545020] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[331.742984] [103/131] (715s left) kms_plane_lowres (tiling-x)
[332.040757] Starting subtest: tiling-x
[332.041588] Starting dynamic subtest: pipe-A-HDMI-A-1
[334.597308] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.555s)
[334.692432] Starting dynamic subtest: pipe-B-HDMI-A-1
[337.172666] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.491s)
[337.255518] Subtest tiling-x: SUCCESS (5.215s)
[337.808983] [104/131] (709s left) kms_force_connector_basic (force-edid)
[337.887487] Starting subtest: force-edid
[337.905894] Subtest force-edid: SUCCESS (0.018s)
[338.374036] [105/131] (709s left) kms_getfb (getfb-handle-zero)
[338.668147] Starting subtest: getfb-handle-zero
[338.668928] Subtest getfb-handle-zero: SUCCESS (0.000s)
[339.087005] [106/131] (708s left) perf (missing-sample-flags)
[339.236693] Subtest missing-sample-flags: SKIP (0.000s)
[339.298067] [107/131] (708s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[339.593985] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[339.595423] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[339.998055] [108/131] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[340.294469] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[340.295675] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[340.709624] [109/131] (707s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[341.008802] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[341.010194] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[341.416680] [110/131] (706s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[341.720367] Starting subtest: 4-tiled-8bpp-rotate-180
[341.721878] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[342.126750] [111/131] (705s left) gem_exec_fence (syncobj-timeline-repeat)
[342.443009] Starting subtest: syncobj-timeline-repeat
[343.022366] Subtest syncobj-timeline-repeat: SUCCESS (0.579s)
[343.293050] [112/131] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[343.587176] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[343.588651] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[344.006472] [113/131] (704s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[344.063277] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[344.063928] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[344.192883] [114/131] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[344.489388] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[346.400553] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.910s)
[346.847563] [115/131] (701s left) gem_exec_schedule (lateslice)
[346.920148] Subtest lateslice: SKIP (0.000s)
[347.151776] [116/131] (701s left) kms_vblank (query-idle-hang)
[347.445021] Starting subtest: query-idle-hang
[347.446081] Starting dynamic subtest: pipe-A-HDMI-A-1
[353.699623] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.254s)
[353.716080] Starting dynamic subtest: pipe-B-HDMI-A-1
[359.717329] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.015s)
[359.718265] Subtest query-idle-hang: SUCCESS (12.274s)
[360.241457] [117/131] (688s left) syncobj_wait (reset-multiple-signaled)
[360.302794] Starting subtest: reset-multiple-signaled
[360.305897] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[360.439066] [118/131] (687s left) kms_flip_event_leak (basic)
[360.733055] Starting subtest: basic
[360.734073] Starting dynamic subtest: pipe-A-HDMI-A-1
[360.966586] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.232s)
[360.986057] Starting dynamic subtest: pipe-B-HDMI-A-1
[361.235835] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.266s)
[361.239120] Subtest basic: SUCCESS (0.505s)
[361.759413] [119/131] (686s left) gem_pwrite_snooped
[361.990029] [120/131] (686s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[362.050106] Starting subtest: yf-tiled-ccs-to-y-tiled
[362.050985] Starting dynamic subtest: smem
[362.052691] Dynamic subtest smem: SKIP (0.000s)
[362.054395] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.002s)
[362.288037] [121/131] (686s left) gem_ctx_shared (q-independent)
[362.341995] Subtest Q-independent: SKIP (0.000s)
[362.470971] [122/131] (686s left) prime_mmap (test_userptr)
[362.526015] Starting subtest: test_userptr
[362.526783] Starting dynamic subtest: test_userptr-smem
[362.527558] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[362.528217] Subtest test_userptr: SUCCESS (0.002s)
[362.670064] [123/131] (685s left) kms_addfb_basic (bad-pitch-65536)
[362.728652] Starting subtest: bad-pitch-65536
[362.729442] Subtest bad-pitch-65536: SUCCESS (0.000s)
[363.390816] [124/131] (685s left) prime_self_import (basic-with_fd_dup)
[363.442991] Starting subtest: basic-with_fd_dup
[363.447127] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[363.603705] [125/131] (685s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[363.892855] Starting subtest: primary-y-tiled-reflect-x-0
[363.894331] Subtest primary-y-tiled-reflect-x-0: SKIP (0.001s)
[364.323172] [126/131] (684s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[364.377618] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[364.455046] [127/131] (684s left) kms_addfb_basic (unused-modifier)
[364.509931] Starting subtest: unused-modifier
[364.510707] Subtest unused-modifier: SUCCESS (0.000s)
[365.163506] [128/131] (683s left) kms_vblank (wait-idle)
[365.456848] Starting subtest: wait-idle
[365.457682] Starting dynamic subtest: pipe-A-HDMI-A-1
[367.657597] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.200s)
[367.672443] Starting dynamic subtest: pipe-B-HDMI-A-1
[369.901813] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.242s)
[369.903901] Subtest wait-idle: SUCCESS (4.447s)
[370.427843] [129/131] (678s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[370.719768] Starting subtest: cursorA-vs-flipA-toggle
[381.614742] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.895s)
[382.137959] [130/131] (666s left) gen9_exec_parse (bb-start-far)
[382.198011] Subtest bb-start-far: SKIP (0.000s)
[382.261693] [131/131] (666s left) kms_addfb_basic (basic)
[382.317724] Starting subtest: basic
[382.318437] Subtest basic: SUCCESS (0.000s)
[382.962390] Closing watchdogs
results: parsing output: 0/ for test: syncobj_eventfd
results: parsing output: 1/ for test: tools_test
results: parsing output: 2/ for test: kms_psr2_su
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_pipe_stress
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_mmap_offset
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: core_getstats
results: parsing output: 25/ for test: core_getclient
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: gem_mmap_offset
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_exec_suspend
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_frames
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_legacy_colorkey
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_tiled_wb
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: kms_color_pipeline
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_feature_discovery
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: gem_pxp
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: fbdev
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_rotation_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_selftest
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_render_copy_redux
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_pm_rps
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_content_protection
results: parsing output: 76/ for test: kms_atomic
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: gem_lmem_swapping
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_lmem_swapping
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_dirtyfb
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_readwrite
results: parsing output: 100/ for test: gem_reg_read
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_plane_lowres
results: parsing output: 103/ for test: kms_force_connector_basic
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_frontbuffer_tracking
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_big_fb
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_flip_event_leak
results: parsing output: 118/ for test: gem_pwrite_snooped
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: gem_ctx_shared
results: parsing output: 121/ for test: prime_mmap
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: gen9_exec_parse
results: parsing output: 130/ for test: kms_addfb_basic
Done.