[81.232240] Initializing watchdogs
[81.232368]   /dev/watchdog0
[81.252895] [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)
[81.260729] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[81.264924] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[81.268205] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[81.359369] Starting subtest: invalid-bad-pad
[81.360045] Subtest invalid-bad-pad: SUCCESS (0.000s)
[81.484204] [002/131] (960s left) tools_test (tools_test)
[81.546428] Starting subtest: tools_test
[81.660678] Subtest tools_test: SUCCESS (0.119s)
[81.767586] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[81.822522] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[81.872954] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[81.948823] Starting subtest: sync-unmap-cycles
[87.327382] Subtest sync-unmap-cycles: SUCCESS (5.378s)
[87.503153] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[87.812211] Starting subtest: stress-xrgb8888-ytiled
[87.813688] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[88.029924] [006/131] (953s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[88.083380] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[88.126609] [007/131] (953s left) api_intel_allocator (gem-pool)
[88.178524] Starting subtest: gem-pool
[88.182347] Subtest gem-pool: SUCCESS (0.004s)
[88.351995] [008/131] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[88.652403] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[88.653773] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[89.048714] [009/131] (953s left) kms_atomic_interruptible (universal-setplane-primary)
[89.351446] Starting subtest: universal-setplane-primary
[89.352045] Starting dynamic subtest: pipe-A-HDMI-A-1
[95.667355] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.315s)
[95.667993] Subtest universal-setplane-primary: SUCCESS (6.316s)
[96.180616] [010/131] (945s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[96.492198] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[99.164493] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.672s)
[99.627208] [011/131] (942s left) gem_eio (in-flight-contexts-1us)
[99.691933] Starting subtest: in-flight-contexts-1us
[103.046670] Subtest in-flight-contexts-1us: SUCCESS (3.356s)
[103.701521] [012/131] (938s left) gem_exec_balancer (semaphore)
[103.761525] Subtest semaphore: SKIP (0.000s)
[103.879927] [013/131] (938s left) kms_chamelium_hpd (hdmi-hpd)
[104.254413] Subtest hdmi-hpd: SKIP (0.000s)
[104.553865] [014/131] (937s left) kms_flip (wf_vblank-ts-check)
[104.848240] Starting subtest: wf_vblank-ts-check
[104.849080] Starting dynamic subtest: A-VGA1
[112.947535] Dynamic subtest A-VGA1: SUCCESS (8.099s)
[112.959943] Starting dynamic subtest: B-VGA1
[120.955696] Dynamic subtest B-VGA1: SUCCESS (8.007s)
[120.969458] Starting dynamic subtest: A-HDMI-A1
[129.127221] Dynamic subtest A-HDMI-A1: SUCCESS (8.170s)
[129.137826] Starting dynamic subtest: B-HDMI-A1
[137.333060] Dynamic subtest B-HDMI-A1: SUCCESS (8.204s)
[137.334284] Subtest wf_vblank-ts-check: SUCCESS (32.486s)
[137.916094] [015/131] (904s left) gem_exec_reloc (basic-gtt)
[137.981714] Starting subtest: basic-gtt
[137.985858] Subtest basic-gtt: SUCCESS (0.004s)
[138.634912] [016/131] (903s left) gem_exec_schedule (reorder-wide)
[138.701874] Subtest reorder-wide: SKIP (0.000s)
[138.927718] [017/131] (903s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[138.982939] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[139.038518] [018/131] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[139.333892] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[139.335380] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[139.743016] [019/131] (902s left) perf (polling)
[139.890287] Subtest polling: SKIP (0.000s)
[139.935764] [020/131] (902s left) gem_userptr_blits (probe)
[140.018496] Starting subtest: probe
[140.213075] Subtest probe: SUCCESS (0.195s)
[140.343932] [021/131] (902s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[140.639869] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[140.641477] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[141.043118] [022/131] (901s left) gem_mmap_offset (pf-nonblock)
[141.098352] Starting subtest: pf-nonblock
[141.100224] Subtest pf-nonblock: SUCCESS (0.003s)
[141.254424] [023/131] (901s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[141.308782] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[141.366759] [024/131] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[141.659253] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[141.660988] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[142.059460] [025/131] (900s left) core_getstats (basic)
[142.118562] Starting subtest: basic
[142.119360] Subtest basic: SUCCESS (0.000s)
[142.237915] [026/131] (900s left) core_getclient (basic)
[142.290083] Starting subtest: basic
[142.290915] Subtest basic: SUCCESS (0.000s)
[142.406819] [027/131] (900s left) syncobj_timeline (multi-wait-all-available-submitted)
[142.461525] Starting subtest: multi-wait-all-available-submitted
[142.463060] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[142.588993] [028/131] (900s left) gem_exec_reloc (basic-write-wc)
[142.645787] Starting subtest: basic-write-wc
[142.648858] Subtest basic-write-wc: SUCCESS (0.003s)
[143.286025] [029/131] (899s left) kms_invalid_mode (clock-too-high)
[143.583412] Starting subtest: clock-too-high
[143.584271] Starting dynamic subtest: pipe-A-HDMI-A-1
[143.655615] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.073s)
[143.668103] Starting dynamic subtest: pipe-B-HDMI-A-1
[143.668866] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[143.669683] Subtest clock-too-high: SUCCESS (0.076s)
[144.040547] [030/131] (899s left) gem_mmap_offset (bad-object)
[144.094900] Starting subtest: bad-object
[144.096598] Subtest bad-object: SUCCESS (0.002s)
[144.231226] [031/131] (898s left) syncobj_timeline (wait-all-delayed-signal)
[144.285769] Starting subtest: wait-all-delayed-signal
[144.388580] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[144.510754] [032/131] (898s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[144.809210] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[144.812079] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.001s)
[145.207766] [033/131] (898s left) gem_exec_suspend (basic-s3)
[145.274631] Starting subtest: basic-S3
[145.275548] Starting dynamic subtest: smem
[162.643460] Dynamic subtest smem: SUCCESS (1.361s)
[162.644800] Subtest basic-S3: SUCCESS (1.362s)
[168.888489] [034/131] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[169.223544] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[169.225158] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[169.653163] [035/131] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[169.964586] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[169.965896] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[170.389949] [036/131] (879s left) kms_chamelium_frames (hdmi-crc-multiple)
[170.766632] Subtest hdmi-crc-multiple: SKIP (0.000s)
[171.086118] [037/131] (878s left) gem_exec_fence (syncobj-import)
[171.323518] Starting subtest: syncobj-import
[171.325164] Subtest syncobj-import: SUCCESS (0.002s)
[171.704844] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[171.709027] [038/131] (877s left) kms_legacy_colorkey (basic)
[172.012343] Starting subtest: basic
[172.013168] Starting dynamic subtest: pipe-A
[172.013897] Dynamic subtest pipe-A: SUCCESS (0.000s)
[172.026956] Starting dynamic subtest: pipe-B
[172.027743] Dynamic subtest pipe-B: SUCCESS (0.000s)
[172.028359] Subtest basic: SUCCESS (0.002s)
[172.440255] [039/131] (877s left) gem_softpin (allocator-nopin-reserve)
[172.503964] Subtest allocator-nopin-reserve: SKIP (0.000s)
[172.643546] [040/131] (876s left) perf_pmu (enable-race)
[172.702729] Starting subtest: enable-race
[172.703704] Starting dynamic subtest: rcs0
[172.705302] Dynamic subtest rcs0: SKIP (0.000s)
[172.722425] Starting dynamic subtest: bcs0
[172.725240] Dynamic subtest bcs0: SKIP (0.000s)
[172.741242] Starting dynamic subtest: vcs0
[172.743665] Dynamic subtest vcs0: SKIP (0.000s)
[172.745729] Subtest enable-race: SKIP (0.002s)
[172.846940] [041/131] (876s left) syncobj_timeline (signal-point-0)
[172.900428] Starting subtest: signal-point-0
[172.901354] Subtest signal-point-0: SUCCESS (0.000s)
[173.033086] [042/131] (876s left) gem_tiled_wb
[181.520472] [043/131] (868s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[181.576397] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[181.629265] [044/131] (868s left) gem_ctx_param (set-priority-invalid-size)
[181.683075] Subtest set-priority-invalid-size: SKIP (0.000s)
[181.802931] [045/131] (868s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[182.097425] Starting subtest: plane-ctm3x4-lut1d
[182.371017] Subtest plane-ctm3x4-lut1d: SKIP (0.271s)
[182.895103] [046/131] (867s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[183.194562] Starting subtest: 2x-long-cursor-vs-flip-atomic
[183.196316] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[183.614091] [047/131] (866s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[183.925065] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[185.767784] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.834s)
[186.225379] [048/131] (863s left) kms_feature_discovery (display-1x)
[186.523981] Starting subtest: display-1x
[186.524806] Subtest display-1x: SUCCESS (0.000s)
[186.942002] [049/131] (863s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[187.250969] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[187.252615] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[187.659855] [050/131] (862s left) i915_drm_fdinfo (most-busy-idle-check-all)
[187.717223] Subtest most-busy-idle-check-all: SKIP (0.000s)
[187.782048] [051/131] (862s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[188.081196] Starting subtest: x-tiled-32bpp-rotate-270
[188.089153] Subtest x-tiled-32bpp-rotate-270: SKIP (0.007s)
[188.523371] [052/131] (861s left) gem_exec_schedule (u-submit-early-slice)
[188.591036] Subtest u-submit-early-slice: SKIP (0.000s)
[188.825612] [053/131] (861s left) gem_pxp (regular-baseline-src-copy-readible)
[191.398504] Starting subtest: regular-baseline-src-copy-readible
[191.400311] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[191.525042] [054/131] (858s left) gem_exec_balancer (full-late-pulse)
[191.582600] Subtest full-late-pulse: SKIP (0.000s)
[191.708127] [055/131] (858s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[192.005884] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[192.007307] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[192.407001] [056/131] (858s left) fbdev (read)
[192.476133] Starting subtest: read
[192.895670] Subtest read: SUCCESS (0.418s)
[193.012546] [057/131] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[193.313946] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[193.315459] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[193.722249] [058/131] (856s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[194.016509] Starting subtest: multiplane-rotation-cropping-top
[194.018139] Subtest multiplane-rotation-cropping-top: SKIP (0.000s)
[194.409100] [059/131] (856s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[194.706952] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[194.708445] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[195.127240] [060/131] (855s left) i915_selftest (mock)
[196.020377] Starting subtest: mock
[196.021386] Starting dynamic subtest: sanitycheck
[197.142019] Dynamic subtest sanitycheck: SUCCESS (1.120s)
[197.154005] Starting dynamic subtest: shmem
[198.228837] Dynamic subtest shmem: SUCCESS (1.084s)
[198.240772] Starting dynamic subtest: fence
[206.060876] Dynamic subtest fence: SUCCESS (7.825s)
[206.073397] Starting dynamic subtest: scatterlist
[208.201649] Dynamic subtest scatterlist: SUCCESS (2.138s)
[208.213376] Starting dynamic subtest: syncmap
[211.347852] Dynamic subtest syncmap: SUCCESS (3.143s)
[211.360404] Starting dynamic subtest: uncore
[212.491022] Dynamic subtest uncore: SUCCESS (1.141s)
[212.502876] Starting dynamic subtest: ring
[213.653981] Dynamic subtest ring: SUCCESS (1.161s)
[213.670289] Starting dynamic subtest: engine
[214.829867] Dynamic subtest engine: SUCCESS (1.174s)
[214.846156] Starting dynamic subtest: timelines
[221.098832] Dynamic subtest timelines: SUCCESS (6.264s)
[221.110747] Starting dynamic subtest: requests
[224.407867] Dynamic subtest requests: SUCCESS (3.306s)
[224.420409] Starting dynamic subtest: objects
[225.629044] Dynamic subtest objects: SUCCESS (1.219s)
[225.640981] Starting dynamic subtest: phys
[226.921148] Dynamic subtest phys: SUCCESS (1.290s)
[226.933975] Starting dynamic subtest: dmabuf
[228.187028] Dynamic subtest dmabuf: SUCCESS (1.264s)
[228.199293] Starting dynamic subtest: vma
[239.842998] Dynamic subtest vma: SUCCESS (11.649s)
[239.855125] Starting dynamic subtest: evict
[242.462820] Dynamic subtest evict: SUCCESS (2.617s)
[242.475701] Starting dynamic subtest: gtt
[246.806950] Dynamic subtest gtt: SUCCESS (4.341s)
[246.819634] Starting dynamic subtest: hugepages
[248.354911] Dynamic subtest hugepages: SUCCESS (1.546s)
[248.367588] Starting dynamic subtest: memory_region
[253.532754] Dynamic subtest memory_region: SUCCESS (5.174s)
[253.533628] Subtest mock: SUCCESS (57.479s)
[253.569947] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[253.571157] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[253.573468] [061/131] (797s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[255.641846] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[255.848452] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[255.850093] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[255.853971] [062/131] (794s left) gem_render_copy_redux (normal)
[255.917612] Starting subtest: normal
[256.459887] Subtest normal: SUCCESS (0.541s)
[256.631016] [063/131] (794s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[256.690871] Starting subtest: basic-cpu-wc-noreloc
[256.693888] Subtest basic-cpu-wc-noreloc: SUCCESS (0.003s)
[257.357758] [064/131] (793s left) gem_ctx_param (invalid-set-no-zeromap)
[257.412517] Starting subtest: invalid-set-no-zeromap
[257.413243] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[257.540622] [065/131] (793s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[257.837979] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[257.839392] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[258.259121] [066/131] (792s left) i915_pm_rps (reset)
[258.324638] Starting subtest: reset
[262.861921] Subtest reset: SUCCESS (4.534s)
[263.038054] [067/131] (788s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[263.335483] Starting subtest: async-flip-with-page-flip-events-linear
[263.481754] Subtest async-flip-with-page-flip-events-linear: SKIP (0.147s)
[264.007107] [068/131] (787s left) perf_pmu (module-unload)
[264.068899] Starting subtest: module-unload
[270.435320] Subtest module-unload: FAIL (6.346s)
[270.466825] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[270.468021] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[270.470076] [069/131] (780s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[272.559202] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[272.560771] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[273.019643] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[273.021356] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[273.025567] [070/131] (778s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[273.092093] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[273.193861] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[273.321128] [071/131] (777s left) kms_cursor_crc (cursor-random-256x85)
[273.625043] Starting subtest: cursor-random-256x85
[273.686703] Subtest cursor-random-256x85: SKIP (0.060s)
[274.117832] [072/131] (777s left) kms_psr (psr-sprite-plane-move)
[274.413052] Subtest psr-sprite-plane-move: SKIP (0.000s)
[274.613133] [073/131] (776s left) kms_psr (fbc-pr-sprite-plane-onoff)
[274.907451] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[275.116753] [074/131] (776s left) kms_pm_rpm (pm-tiling)
[286.620241] Subtest pm-tiling: SKIP (0.000s)
[286.820326] [075/131] (764s left) gem_userptr_blits (invalid-null-pointer)
[286.883621] Starting subtest: invalid-null-pointer
[286.887452] Subtest invalid-null-pointer: SUCCESS (0.004s)
[287.074363] [076/131] (764s left) kms_content_protection (lic-type-1)
[287.381849] Starting subtest: lic-type-1
[287.383435] Subtest lic-type-1: SKIP (0.000s)
[287.808278] [077/131] (763s left) kms_atomic (plane-immutable-zpos)
[288.100543] Starting subtest: plane-immutable-zpos
[288.101497] Starting dynamic subtest: pipe-A-HDMI-A-1
[288.610596] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.509s)
[288.611381] Subtest plane-immutable-zpos: SUCCESS (0.511s)
[289.152268] [078/131] (762s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[289.449676] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[289.451426] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[289.854509] [079/131] (761s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[290.149669] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[290.150515] Starting dynamic subtest: pipe-A
[290.152634] Dynamic subtest pipe-A: SKIP (0.001s)
[290.165403] Starting dynamic subtest: pipe-B
[290.167318] Dynamic subtest pipe-B: SKIP (0.001s)
[290.168739] Subtest plane-upscale-factor-0-25-with-pixel-format: SKIP (0.005s)
[290.557853] [080/131] (761s left) kms_psr (pr-sprite-mmap-cpu)
[290.856643] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[291.064872] [081/131] (760s left) gem_ctx_persistence (legacy-engines-cleanup)
[291.133544] Subtest legacy-engines-cleanup: SKIP (0.000s)
[291.196018] [082/131] (760s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[291.494189] Starting subtest: cursor-tearing-framebuffer-change
[291.495377] Starting dynamic subtest: pipe-A-HDMI-A-1
[291.851609] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.355s)
[291.865480] Starting dynamic subtest: pipe-B-HDMI-A-1
[292.215979] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.362s)
[292.216752] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.722s)
[292.745538] [083/131] (759s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[293.041557] Starting subtest: 2x-cursor-vs-flip-atomic
[293.043107] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[293.458208] [084/131] (758s left) kms_cursor_crc (cursor-random-32x10)
[293.756431] Starting subtest: cursor-random-32x10
[293.811471] Subtest cursor-random-32x10: SKIP (0.054s)
[294.228310] [085/131] (757s left) kms_psr (fbc-psr-primary-mmap-gtt)
[294.520535] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[294.720087] [086/131] (757s left) kms_big_fb (linear-8bpp-rotate-0)
[295.023703] Starting subtest: linear-8bpp-rotate-0
[296.269357] Subtest linear-8bpp-rotate-0: SUCCESS (1.246s)
[296.722020] [087/131] (755s left) gem_create (create-ext-cpu-access-sanity-check)
[296.890267] Starting subtest: create-ext-cpu-access-sanity-check
[296.892288] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[297.026248] [088/131] (755s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[297.324746] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[298.816167] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.491s)
[299.268460] [089/131] (752s left) kms_pm_rpm (cursor-dpms)
[310.761741] Subtest cursor-dpms: SKIP (0.000s)
[310.957509] [090/131] (741s left) gem_lmem_swapping (verify-random-ccs)
[311.019254] Subtest verify-random-ccs: SKIP (0.000s)
[311.090342] [091/131] (741s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[311.381893] Starting subtest: flip-vs-cursor-toggle
[325.845942] Subtest flip-vs-cursor-toggle: SUCCESS (14.459s)
[326.361535] [092/131] (726s left) gem_lmem_swapping (heavy-verify-multi)
[326.429978] Subtest heavy-verify-multi: SKIP (0.000s)
[326.491508] [093/131] (725s left) i915_pm_freq_api (freq-reset)
[326.548648] Subtest freq-reset: SKIP (0.000s)
[326.606648] [094/131] (725s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[326.907851] Starting subtest: y-tiled-64bpp-rotate-90
[326.909314] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[327.344139] [095/131] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[327.641546] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[327.642934] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[328.062535] [096/131] (724s left) kms_dirtyfb (default-dirtyfb-ioctl)
[328.356552] Starting subtest: default-dirtyfb-ioctl
[328.357410] Starting dynamic subtest: A-HDMI-A-1
[329.702016] Dynamic subtest A-HDMI-A-1: SUCCESS (1.344s)
[329.702833] Subtest default-dirtyfb-ioctl: SUCCESS (1.346s)
[330.221124] [097/131] (722s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[330.514045] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[330.514816] Starting dynamic subtest: pipe-A
[330.516981] Dynamic subtest pipe-A: SKIP (0.001s)
[330.531357] Starting dynamic subtest: pipe-B
[330.556951] Dynamic subtest pipe-B: SKIP (0.001s)
[330.560005] Subtest plane-downscale-factor-0-75-with-modifiers: SKIP (0.005s)
[330.937463] [098/131] (721s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[330.996216] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[331.067778] [099/131] (721s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[331.357838] Starting subtest: 2x-cursor-vs-flip-legacy
[331.360936] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[331.764951] [100/131] (721s left) gem_readwrite (write-bad-handle)
[331.820590] Starting subtest: write-bad-handle
[331.822157] Subtest write-bad-handle: SUCCESS (0.000s)
[331.966924] [101/131] (720s left) gem_reg_read (timestamp-monotonic)
[332.020214] Starting subtest: timestamp-monotonic
[336.124432] Subtest timestamp-monotonic: SUCCESS (4.103s)
[336.260139] [102/131] (716s left) kms_psr (fbc-psr2-cursor-plane-move)
[336.553838] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[336.756412] [103/131] (716s left) kms_plane_lowres (tiling-x)
[337.045287] Starting subtest: tiling-x
[337.046051] Starting dynamic subtest: pipe-A-HDMI-A-1
[339.635691] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.588s)
[339.731440] Starting dynamic subtest: pipe-B-HDMI-A-1
[342.221763] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.501s)
[342.303565] Subtest tiling-x: SUCCESS (5.257s)
[342.854089] [104/131] (710s left) kms_force_connector_basic (force-edid)
[342.948030] Starting subtest: force-edid
[342.968058] Subtest force-edid: SUCCESS (0.019s)
[343.425844] [105/131] (709s left) kms_getfb (getfb-handle-zero)
[343.718563] Starting subtest: getfb-handle-zero
[343.719238] Subtest getfb-handle-zero: SUCCESS (0.000s)
[344.138254] [106/131] (709s left) perf (missing-sample-flags)
[344.274926] Subtest missing-sample-flags: SKIP (0.000s)
[344.332840] [107/131] (708s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[344.631629] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[344.633127] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[345.039622] [108/131] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[345.342286] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[345.343617] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[345.750607] [109/131] (707s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[346.048816] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[346.050527] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[346.479042] [110/131] (706s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[346.786520] Starting subtest: 4-tiled-8bpp-rotate-180
[346.787987] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[347.202361] [111/131] (706s left) gem_exec_fence (syncobj-timeline-repeat)
[347.519280] Starting subtest: syncobj-timeline-repeat
[348.089846] Subtest syncobj-timeline-repeat: SUCCESS (0.570s)
[348.364817] [112/131] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[348.665539] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[348.667097] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[349.089235] [113/131] (704s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[349.147690] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[349.148377] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[349.280170] [114/131] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[349.577642] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[351.523280] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.944s)
[351.970489] [115/131] (701s left) gem_exec_schedule (lateslice)
[352.043900] Subtest lateslice: SKIP (0.000s)
[352.272434] [116/131] (701s left) kms_vblank (query-idle-hang)
[352.567011] Starting subtest: query-idle-hang
[352.568112] Starting dynamic subtest: pipe-A-HDMI-A-1
[358.974504] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.405s)
[358.990283] Starting dynamic subtest: pipe-B-HDMI-A-1
[364.926492] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.948s)
[364.929390] Subtest query-idle-hang: SUCCESS (12.359s)
[365.445445] [117/131] (688s left) syncobj_wait (reset-multiple-signaled)
[365.516121] Starting subtest: reset-multiple-signaled
[365.516996] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[365.649156] [118/131] (688s left) kms_flip_event_leak (basic)
[365.945760] Starting subtest: basic
[365.946986] Starting dynamic subtest: pipe-A-HDMI-A-1
[366.177531] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.232s)
[366.201473] Starting dynamic subtest: pipe-B-HDMI-A-1
[366.430103] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.250s)
[366.430799] Subtest basic: SUCCESS (0.487s)
[366.951549] [119/131] (686s left) gem_pwrite_snooped
[367.204517] [120/131] (686s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[367.267118] Starting subtest: yf-tiled-ccs-to-y-tiled
[367.267925] Starting dynamic subtest: smem
[367.269634] Dynamic subtest smem: SKIP (0.000s)
[367.271337] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.002s)
[367.511344] [121/131] (686s left) gem_ctx_shared (q-independent)
[367.568842] Subtest Q-independent: SKIP (0.000s)
[367.695389] [122/131] (686s left) prime_mmap (test_userptr)
[367.747516] Starting subtest: test_userptr
[367.748150] Starting dynamic subtest: test_userptr-smem
[367.748907] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[367.749534] Subtest test_userptr: SUCCESS (0.002s)
[367.899151] [123/131] (686s left) kms_addfb_basic (bad-pitch-65536)
[367.955427] Starting subtest: bad-pitch-65536
[367.956106] Subtest bad-pitch-65536: SUCCESS (0.000s)
[368.610027] [124/131] (685s left) prime_self_import (basic-with_fd_dup)
[368.665427] Starting subtest: basic-with_fd_dup
[368.669159] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[368.810024] [125/131] (685s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[369.098652] Starting subtest: primary-y-tiled-reflect-x-0
[369.100244] Subtest primary-y-tiled-reflect-x-0: SKIP (0.001s)
[369.509889] [126/131] (684s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[369.569109] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[369.638497] [127/131] (684s left) kms_addfb_basic (unused-modifier)
[369.694779] Starting subtest: unused-modifier
[369.695585] Subtest unused-modifier: SUCCESS (0.000s)
[370.343265] [128/131] (684s left) kms_vblank (wait-idle)
[370.643517] Starting subtest: wait-idle
[370.644733] Starting dynamic subtest: pipe-A-HDMI-A-1
[372.867189] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.221s)
[372.884718] Starting dynamic subtest: pipe-B-HDMI-A-1
[375.107179] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.238s)
[375.109271] Subtest wait-idle: SUCCESS (4.465s)
[375.631420] [129/131] (678s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[375.927924] Starting subtest: cursorA-vs-flipA-toggle
[386.820092] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.889s)
[387.357195] [130/131] (667s left) gen9_exec_parse (bb-start-far)
[387.418552] Subtest bb-start-far: SKIP (0.000s)
[387.482762] [131/131] (667s left) kms_addfb_basic (basic)
[387.535914] Starting subtest: basic
[387.536710] Subtest basic: SUCCESS (0.000s)
[388.185806] 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.