[68.980203] Initializing watchdogs
[68.980335]   /dev/watchdog0
[69.002817] [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)
[69.010612] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.014590] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.017978] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[69.086292] Starting subtest: invalid-bad-pad
[69.087363] Subtest invalid-bad-pad: SUCCESS (0.000s)
[69.209453] [002/131] (960s left) tools_test (tools_test)
[69.271305] Starting subtest: tools_test
[69.381959] Subtest tools_test: SUCCESS (0.118s)
[69.491485] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[69.547935] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[69.612460] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[69.689088] Starting subtest: sync-unmap-cycles
[75.068236] Subtest sync-unmap-cycles: SUCCESS (5.378s)
[75.231411] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[75.531928] Starting subtest: stress-xrgb8888-ytiled
[75.534165] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[75.724138] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[75.783984] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[75.844517] [007/131] (953s left) api_intel_allocator (gem-pool)
[75.900509] Starting subtest: gem-pool
[75.904235] Subtest gem-pool: SUCCESS (0.004s)
[76.050433] [008/131] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[76.352451] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[76.354579] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[76.763650] [009/131] (953s left) kms_atomic_interruptible (universal-setplane-primary)
[77.063334] Starting subtest: universal-setplane-primary
[77.064356] Starting dynamic subtest: pipe-A-HDMI-A-1
[83.397349] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.332s)
[83.398514] Subtest universal-setplane-primary: SUCCESS (6.334s)
[83.908787] [010/131] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[84.208446] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[86.877878] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.669s)
[87.340076] [011/131] (942s left) gem_eio (in-flight-contexts-1us)
[87.404801] Starting subtest: in-flight-contexts-1us
[90.716355] Subtest in-flight-contexts-1us: SUCCESS (3.311s)
[91.366656] [012/131] (938s left) gem_exec_balancer (semaphore)
[91.424229] Subtest semaphore: SKIP (0.000s)
[91.543940] [013/131] (938s left) kms_chamelium_hpd (hdmi-hpd)
[91.917970] Subtest hdmi-hpd: SKIP (0.000s)
[92.238421] [014/131] (937s left) kms_flip (wf_vblank-ts-check)
[92.536484] Starting subtest: wf_vblank-ts-check
[92.537462] Starting dynamic subtest: A-VGA1
[100.657088] Dynamic subtest A-VGA1: SUCCESS (8.119s)
[100.667659] Starting dynamic subtest: B-VGA1
[108.664238] Dynamic subtest B-VGA1: SUCCESS (8.006s)
[108.675610] Starting dynamic subtest: A-HDMI-A1
[116.854049] Dynamic subtest A-HDMI-A1: SUCCESS (8.188s)
[116.864517] Starting dynamic subtest: B-HDMI-A1
[125.070382] Dynamic subtest B-HDMI-A1: SUCCESS (8.215s)
[125.071697] Subtest wf_vblank-ts-check: SUCCESS (32.535s)
[125.683565] [015/131] (904s left) gem_exec_reloc (basic-gtt)
[125.740750] Starting subtest: basic-gtt
[125.745184] Subtest basic-gtt: SUCCESS (0.004s)
[126.382108] [016/131] (903s left) gem_exec_schedule (reorder-wide)
[126.450156] Subtest reorder-wide: SKIP (0.000s)
[126.684620] [017/131] (903s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[126.740227] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[126.793458] [018/131] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[127.091507] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[127.093636] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[127.497139] [019/131] (902s left) perf (polling)
[127.643247] Subtest polling: SKIP (0.000s)
[127.691701] [020/131] (902s left) gem_userptr_blits (probe)
[127.773459] Starting subtest: probe
[127.959456] Subtest probe: SUCCESS (0.186s)
[128.095303] [021/131] (902s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[128.399644] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[128.401901] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[128.794086] [022/131] (901s left) gem_mmap_offset (pf-nonblock)
[128.853744] Starting subtest: pf-nonblock
[128.856021] Subtest pf-nonblock: SUCCESS (0.003s)
[129.004138] [023/131] (901s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[129.059740] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[129.123052] [024/131] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[129.421304] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[129.423414] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[129.827278] [025/131] (900s left) core_getstats (basic)
[129.882560] Starting subtest: basic
[129.883622] Subtest basic: SUCCESS (0.000s)
[130.011908] [026/131] (900s left) core_getclient (basic)
[130.070040] Starting subtest: basic
[130.071169] Subtest basic: SUCCESS (0.000s)
[130.192734] [027/131] (900s left) syncobj_timeline (multi-wait-all-available-submitted)
[130.246440] Starting subtest: multi-wait-all-available-submitted
[130.248502] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[130.377313] [028/131] (900s left) gem_exec_reloc (basic-write-wc)
[130.436383] Starting subtest: basic-write-wc
[130.439285] Subtest basic-write-wc: SUCCESS (0.003s)
[131.072641] [029/131] (899s left) kms_invalid_mode (clock-too-high)
[131.371856] Starting subtest: clock-too-high
[131.372915] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.444178] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.073s)
[131.454495] Starting dynamic subtest: pipe-B-HDMI-A-1
[131.455584] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[131.456655] Subtest clock-too-high: SUCCESS (0.076s)
[131.834971] [030/131] (899s left) gem_mmap_offset (bad-object)
[131.890655] Starting subtest: bad-object
[131.893043] Subtest bad-object: SUCCESS (0.002s)
[132.031244] [031/131] (898s left) syncobj_timeline (wait-all-delayed-signal)
[132.090505] Starting subtest: wait-all-delayed-signal
[132.192070] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[132.320885] [032/131] (898s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[132.621613] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[132.626176] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.001s)
[133.043988] [033/131] (897s left) gem_exec_suspend (basic-s3)
[133.108649] Starting subtest: basic-S3
[133.109751] Starting dynamic subtest: smem
[150.668274] Dynamic subtest smem: SUCCESS (1.381s)
[150.669748] Subtest basic-S3: SUCCESS (1.382s)
[159.907812] [034/131] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[160.217368] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[160.219594] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[160.631529] [035/131] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[160.949446] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[160.951694] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[161.367158] [036/131] (878s left) kms_chamelium_frames (hdmi-crc-multiple)
[161.746959] Subtest hdmi-crc-multiple: SKIP (0.000s)
[162.057518] [037/131] (878s left) gem_exec_fence (syncobj-import)
[162.295909] Starting subtest: syncobj-import
[162.298319] Subtest syncobj-import: SUCCESS (0.002s)
[162.682765] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[162.685947] [038/131] (877s left) kms_legacy_colorkey (basic)
[162.994090] Starting subtest: basic
[162.995190] Starting dynamic subtest: pipe-A
[162.996279] Dynamic subtest pipe-A: SUCCESS (0.000s)
[163.009336] Starting dynamic subtest: pipe-B
[163.010405] Dynamic subtest pipe-B: SUCCESS (0.000s)
[163.011454] Subtest basic: SUCCESS (0.003s)
[163.413362] [039/131] (876s left) gem_softpin (allocator-nopin-reserve)
[163.473060] Subtest allocator-nopin-reserve: SKIP (0.000s)
[163.608413] [040/131] (876s left) perf_pmu (enable-race)
[163.668846] Starting subtest: enable-race
[163.669944] Starting dynamic subtest: rcs0
[163.671978] Dynamic subtest rcs0: SKIP (0.000s)
[163.688604] Starting dynamic subtest: bcs0
[163.691322] Dynamic subtest bcs0: SKIP (0.000s)
[163.711002] Starting dynamic subtest: vcs0
[163.713739] Dynamic subtest vcs0: SKIP (0.000s)
[163.716223] Subtest enable-race: SKIP (0.002s)
[163.806161] [041/131] (876s left) syncobj_timeline (signal-point-0)
[163.861161] Starting subtest: signal-point-0
[163.862316] Subtest signal-point-0: SUCCESS (0.001s)
[164.005995] [042/131] (876s left) gem_tiled_wb
[171.719124] [043/131] (868s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[171.779109] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[171.844437] [044/131] (868s left) gem_ctx_param (set-priority-invalid-size)
[171.900957] Subtest set-priority-invalid-size: SKIP (0.000s)
[172.034633] [045/131] (868s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[172.335378] Starting subtest: plane-ctm3x4-lut1d
[172.615898] Subtest plane-ctm3x4-lut1d: SKIP (0.278s)
[173.161539] [046/131] (867s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[173.453426] Starting subtest: 2x-long-cursor-vs-flip-atomic
[173.455644] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[173.876020] [047/131] (866s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[174.178765] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[176.013285] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.826s)
[176.466228] [048/131] (864s left) kms_feature_discovery (display-1x)
[176.763068] Starting subtest: display-1x
[176.764335] Subtest display-1x: SUCCESS (0.000s)
[177.169203] [049/131] (863s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[177.478945] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[177.481300] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[177.884741] [050/131] (863s left) i915_drm_fdinfo (most-busy-idle-check-all)
[177.941425] Subtest most-busy-idle-check-all: SKIP (0.000s)
[177.996774] [051/131] (863s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[178.302894] Starting subtest: x-tiled-32bpp-rotate-270
[178.319935] Subtest x-tiled-32bpp-rotate-270: SKIP (0.015s)
[178.755267] [052/131] (862s left) gem_exec_schedule (u-submit-early-slice)
[178.823894] Subtest u-submit-early-slice: SKIP (0.000s)
[179.054036] [053/131] (862s left) gem_pxp (regular-baseline-src-copy-readible)
[181.627009] Starting subtest: regular-baseline-src-copy-readible
[181.629584] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[181.755247] [054/131] (859s left) gem_exec_balancer (full-late-pulse)
[181.813788] Subtest full-late-pulse: SKIP (0.000s)
[181.943963] [055/131] (859s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[182.247787] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[182.249921] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[182.658493] [056/131] (858s left) fbdev (read)
[182.724491] Starting subtest: read
[183.117989] Subtest read: SUCCESS (0.392s)
[183.245342] [057/131] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[183.540420] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[183.542636] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[183.959057] [058/131] (857s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[184.257779] Starting subtest: multiplane-rotation-cropping-top
[184.259892] Subtest multiplane-rotation-cropping-top: SKIP (0.000s)
[184.674159] [059/131] (856s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[184.984323] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[184.986558] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[185.391153] [060/131] (856s left) i915_selftest (mock)
[186.278017] Starting subtest: mock
[186.279251] Starting dynamic subtest: sanitycheck
[187.452632] Dynamic subtest sanitycheck: SUCCESS (1.173s)
[187.470237] Starting dynamic subtest: shmem
[188.623809] Dynamic subtest shmem: SUCCESS (1.168s)
[188.636960] Starting dynamic subtest: fence
[197.198801] Dynamic subtest fence: SUCCESS (8.568s)
[197.211661] Starting dynamic subtest: scatterlist
[199.355791] Dynamic subtest scatterlist: SUCCESS (2.155s)
[199.368413] Starting dynamic subtest: syncmap
[202.533742] Dynamic subtest syncmap: SUCCESS (3.175s)
[202.547350] Starting dynamic subtest: uncore
[203.643804] Dynamic subtest uncore: SUCCESS (1.108s)
[203.656128] Starting dynamic subtest: ring
[204.752876] Dynamic subtest ring: SUCCESS (1.107s)
[204.766086] Starting dynamic subtest: engine
[205.931647] Dynamic subtest engine: SUCCESS (1.177s)
[205.949436] Starting dynamic subtest: timelines
[212.118712] Dynamic subtest timelines: SUCCESS (6.182s)
[212.131690] Starting dynamic subtest: requests
[215.570708] Dynamic subtest requests: SUCCESS (3.446s)
[215.583314] Starting dynamic subtest: objects
[216.822837] Dynamic subtest objects: SUCCESS (1.253s)
[216.835895] Starting dynamic subtest: phys
[218.031851] Dynamic subtest phys: SUCCESS (1.207s)
[218.044924] Starting dynamic subtest: dmabuf
[219.306777] Dynamic subtest dmabuf: SUCCESS (1.273s)
[219.324495] Starting dynamic subtest: vma
[230.898862] Dynamic subtest vma: SUCCESS (11.585s)
[230.911893] Starting dynamic subtest: evict
[233.512767] Dynamic subtest evict: SUCCESS (2.611s)
[233.530387] Starting dynamic subtest: gtt
[237.827777] Dynamic subtest gtt: SUCCESS (4.312s)
[237.839888] Starting dynamic subtest: hugepages
[239.440731] Dynamic subtest hugepages: SUCCESS (1.611s)
[239.456380] Starting dynamic subtest: memory_region
[244.546681] Dynamic subtest memory_region: SUCCESS (5.102s)
[244.547839] Subtest mock: SUCCESS (58.235s)
[244.585786] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[244.587107] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[244.589388] [061/131] (796s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[246.655295] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[246.849074] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[246.850761] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[246.854712] [062/131] (794s left) gem_render_copy_redux (normal)
[246.917929] Starting subtest: normal
[247.466592] Subtest normal: SUCCESS (0.548s)
[247.628245] [063/131] (794s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[247.690545] Starting subtest: basic-cpu-wc-noreloc
[247.692876] Subtest basic-cpu-wc-noreloc: SUCCESS (0.003s)
[248.339921] [064/131] (793s left) gem_ctx_param (invalid-set-no-zeromap)
[248.392961] Starting subtest: invalid-set-no-zeromap
[248.394021] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[248.523896] [065/131] (793s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[248.821887] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[248.823903] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[249.253199] [066/131] (792s left) i915_pm_rps (reset)
[249.318287] Starting subtest: reset
[253.854838] Subtest reset: SUCCESS (4.532s)
[254.014412] [067/131] (787s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[254.308616] Starting subtest: async-flip-with-page-flip-events-linear
[254.449526] Subtest async-flip-with-page-flip-events-linear: SKIP (0.141s)
[254.968526] [068/131] (786s left) perf_pmu (module-unload)
[255.035712] Starting subtest: module-unload
[261.388068] Subtest module-unload: FAIL (6.316s)
[261.431682] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[261.432957] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[261.435396] [069/131] (780s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[263.524313] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[263.526468] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[263.970355] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[263.972004] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[263.976110] [070/131] (778s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[264.036032] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[264.140643] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[264.283764] [071/131] (777s left) kms_cursor_crc (cursor-random-256x85)
[264.585110] Starting subtest: cursor-random-256x85
[264.645765] Subtest cursor-random-256x85: SKIP (0.056s)
[265.056932] [072/131] (777s left) kms_psr (psr-sprite-plane-move)
[265.352967] Subtest psr-sprite-plane-move: SKIP (0.000s)
[265.548610] [073/131] (776s left) kms_psr (fbc-pr-sprite-plane-onoff)
[265.843833] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[266.046320] [074/131] (776s left) kms_pm_rpm (pm-tiling)
[277.545984] Subtest pm-tiling: SKIP (0.000s)
[277.746173] [075/131] (764s left) gem_userptr_blits (invalid-null-pointer)
[277.810937] Starting subtest: invalid-null-pointer
[277.813349] Subtest invalid-null-pointer: SUCCESS (0.003s)
[278.011990] [076/131] (764s left) kms_content_protection (lic-type-1)
[278.321124] Starting subtest: lic-type-1
[278.323308] Subtest lic-type-1: SKIP (0.000s)
[278.725170] [077/131] (763s left) kms_atomic (plane-immutable-zpos)
[279.018621] Starting subtest: plane-immutable-zpos
[279.019687] Starting dynamic subtest: pipe-A-HDMI-A-1
[279.390210] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.370s)
[279.391309] Subtest plane-immutable-zpos: SUCCESS (0.372s)
[279.908534] [078/131] (762s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[280.198029] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[280.201703] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[280.632438] [079/131] (761s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[280.927800] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[280.928823] Starting dynamic subtest: pipe-A
[280.931899] Dynamic subtest pipe-A: SKIP (0.001s)
[280.944553] Starting dynamic subtest: pipe-B
[280.947691] Dynamic subtest pipe-B: SKIP (0.001s)
[280.949732] Subtest plane-upscale-factor-0-25-with-pixel-format: SKIP (0.005s)
[281.338787] [080/131] (761s left) kms_psr (pr-sprite-mmap-cpu)
[281.638019] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[281.834178] [081/131] (760s left) gem_ctx_persistence (legacy-engines-cleanup)
[281.891846] Subtest legacy-engines-cleanup: SKIP (0.000s)
[281.948328] [082/131] (760s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[282.244165] Starting subtest: cursor-tearing-framebuffer-change
[282.245446] Starting dynamic subtest: pipe-A-HDMI-A-1
[282.600178] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.354s)
[282.614579] Starting dynamic subtest: pipe-B-HDMI-A-1
[282.963332] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.361s)
[282.964411] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.720s)
[283.494245] [083/131] (759s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[283.785866] Starting subtest: 2x-cursor-vs-flip-atomic
[283.787980] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[284.208317] [084/131] (758s left) kms_cursor_crc (cursor-random-32x10)
[284.506676] Starting subtest: cursor-random-32x10
[284.561713] Subtest cursor-random-32x10: SKIP (0.054s)
[284.970542] [085/131] (757s left) kms_psr (fbc-psr-primary-mmap-gtt)
[285.263730] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[285.463302] [086/131] (757s left) kms_big_fb (linear-8bpp-rotate-0)
[285.766749] Starting subtest: linear-8bpp-rotate-0
[287.014598] Subtest linear-8bpp-rotate-0: SUCCESS (1.248s)
[287.450159] [087/131] (755s left) gem_create (create-ext-cpu-access-sanity-check)
[287.622036] Starting subtest: create-ext-cpu-access-sanity-check
[287.624215] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[287.747420] [088/131] (755s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[288.040984] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[289.528225] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.489s)
[289.976795] [089/131] (753s left) kms_pm_rpm (cursor-dpms)
[301.477586] Subtest cursor-dpms: SKIP (0.000s)
[301.686637] [090/131] (741s left) gem_lmem_swapping (verify-random-ccs)
[301.753672] Subtest verify-random-ccs: SKIP (0.000s)
[301.818456] [091/131] (741s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[302.113887] Starting subtest: flip-vs-cursor-toggle
[316.640264] Subtest flip-vs-cursor-toggle: SUCCESS (14.524s)
[317.161347] [092/131] (726s left) gem_lmem_swapping (heavy-verify-multi)
[317.219516] Subtest heavy-verify-multi: SKIP (0.000s)
[317.288330] [093/131] (726s left) i915_pm_freq_api (freq-reset)
[317.343669] Subtest freq-reset: SKIP (0.000s)
[317.404561] [094/131] (725s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[317.706584] Starting subtest: y-tiled-64bpp-rotate-90
[317.708851] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[318.139180] [095/131] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[318.434738] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[318.436901] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[318.839928] [096/131] (724s left) kms_dirtyfb (default-dirtyfb-ioctl)
[319.132386] Starting subtest: default-dirtyfb-ioctl
[319.133544] Starting dynamic subtest: A-HDMI-A-1
[320.484851] Dynamic subtest A-HDMI-A-1: SUCCESS (1.351s)
[320.485894] Subtest default-dirtyfb-ioctl: SUCCESS (1.354s)
[321.005414] [097/131] (722s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[321.301405] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[321.302532] Starting dynamic subtest: pipe-A
[321.305904] Dynamic subtest pipe-A: SKIP (0.001s)
[321.319573] Starting dynamic subtest: pipe-B
[321.322760] Dynamic subtest pipe-B: SKIP (0.001s)
[321.324796] Subtest plane-downscale-factor-0-75-with-modifiers: SKIP (0.005s)
[321.725571] [098/131] (721s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[321.782354] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[321.861968] [099/131] (721s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[322.152714] Starting subtest: 2x-cursor-vs-flip-legacy
[322.156555] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[322.571714] [100/131] (721s left) gem_readwrite (write-bad-handle)
[322.627755] Starting subtest: write-bad-handle
[322.629791] Subtest write-bad-handle: SUCCESS (0.000s)
[322.768421] [101/131] (721s left) gem_reg_read (timestamp-monotonic)
[322.820917] Starting subtest: timestamp-monotonic
[327.118912] Subtest timestamp-monotonic: SUCCESS (4.297s)
[327.245061] [102/131] (716s left) kms_psr (fbc-psr2-cursor-plane-move)
[327.541939] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[327.740320] [103/131] (716s left) kms_plane_lowres (tiling-x)
[328.032939] Starting subtest: tiling-x
[328.034064] Starting dynamic subtest: pipe-A-HDMI-A-1
[330.645630] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.611s)
[330.743239] Starting dynamic subtest: pipe-B-HDMI-A-1
[333.184121] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.454s)
[333.266915] Subtest tiling-x: SUCCESS (5.234s)
[333.832285] [104/131] (710s left) kms_force_connector_basic (force-edid)
[333.904116] Starting subtest: force-edid
[333.926381] Subtest force-edid: SUCCESS (0.022s)
[334.380714] [105/131] (709s left) kms_getfb (getfb-handle-zero)
[334.674670] Starting subtest: getfb-handle-zero
[334.675778] Subtest getfb-handle-zero: SUCCESS (0.000s)
[335.081494] [106/131] (708s left) perf (missing-sample-flags)
[335.233567] Subtest missing-sample-flags: SKIP (0.000s)
[335.292700] [107/131] (708s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[335.595516] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[335.597740] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[336.012749] [108/131] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[336.314822] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[336.317058] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[336.726897] [109/131] (707s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[337.029800] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[337.031888] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[337.446020] [110/131] (706s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[337.756732] Starting subtest: 4-tiled-8bpp-rotate-180
[337.758858] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[338.159192] [111/131] (706s left) gem_exec_fence (syncobj-timeline-repeat)
[338.476021] Starting subtest: syncobj-timeline-repeat
[339.051816] Subtest syncobj-timeline-repeat: SUCCESS (0.576s)
[339.323638] [112/131] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[339.622652] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[339.624651] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[340.040140] [113/131] (704s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[340.097169] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[340.098277] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[340.220319] [114/131] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[340.523546] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[342.464782] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.941s)
[342.917014] [115/131] (701s left) gem_exec_schedule (lateslice)
[342.983469] Subtest lateslice: SKIP (0.000s)
[343.217050] [116/131] (701s left) kms_vblank (query-idle-hang)
[343.510846] Starting subtest: query-idle-hang
[343.511904] Starting dynamic subtest: pipe-A-HDMI-A-1
[350.133895] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.619s)
[350.149658] Starting dynamic subtest: pipe-B-HDMI-A-1
[356.134609] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.997s)
[356.135791] Subtest query-idle-hang: SUCCESS (12.622s)
[356.655800] [117/131] (687s left) syncobj_wait (reset-multiple-signaled)
[356.714940] Starting subtest: reset-multiple-signaled
[356.715972] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[356.854809] [118/131] (687s left) kms_flip_event_leak (basic)
[357.148013] Starting subtest: basic
[357.149313] Starting dynamic subtest: pipe-A-HDMI-A-1
[357.350192] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.201s)
[357.366033] Starting dynamic subtest: pipe-B-HDMI-A-1
[357.609564] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.258s)
[357.610681] Subtest basic: SUCCESS (0.464s)
[358.128933] [119/131] (686s left) gem_pwrite_snooped
[358.362273] [120/131] (686s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[358.424766] Starting subtest: yf-tiled-ccs-to-y-tiled
[358.425833] Starting dynamic subtest: smem
[358.427917] Dynamic subtest smem: SKIP (0.000s)
[358.430223] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.002s)
[358.660116] [121/131] (686s left) gem_ctx_shared (q-independent)
[358.715764] Subtest Q-independent: SKIP (0.000s)
[358.842264] [122/131] (686s left) prime_mmap (test_userptr)
[358.897675] Starting subtest: test_userptr
[358.898707] Starting dynamic subtest: test_userptr-smem
[358.899785] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[358.900810] Subtest test_userptr: SUCCESS (0.003s)
[359.046099] [123/131] (685s left) kms_addfb_basic (bad-pitch-65536)
[359.102175] Starting subtest: bad-pitch-65536
[359.103303] Subtest bad-pitch-65536: SUCCESS (0.000s)
[359.761177] [124/131] (685s left) prime_self_import (basic-with_fd_dup)
[359.816093] Starting subtest: basic-with_fd_dup
[359.819879] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[359.960605] [125/131] (685s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[360.257486] Starting subtest: primary-y-tiled-reflect-x-0
[360.259724] Subtest primary-y-tiled-reflect-x-0: SKIP (0.001s)
[360.675975] [126/131] (684s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[360.736814] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[360.803993] [127/131] (684s left) kms_addfb_basic (unused-modifier)
[360.859001] Starting subtest: unused-modifier
[360.860096] Subtest unused-modifier: SUCCESS (0.000s)
[361.507759] [128/131] (683s left) kms_vblank (wait-idle)
[361.796854] Starting subtest: wait-idle
[361.800027] Starting dynamic subtest: pipe-A-HDMI-A-1
[363.997765] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.199s)
[364.013697] Starting dynamic subtest: pipe-B-HDMI-A-1
[366.241390] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.241s)
[366.242547] Subtest wait-idle: SUCCESS (4.445s)
[366.775004] [129/131] (678s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[367.069075] Starting subtest: cursorA-vs-flipA-toggle
[377.963366] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.891s)
[378.493044] [130/131] (666s left) gen9_exec_parse (bb-start-far)
[378.552486] Subtest bb-start-far: SKIP (0.000s)
[378.622839] [131/131] (666s left) kms_addfb_basic (basic)
[378.680303] Starting subtest: basic
[378.681393] Subtest basic: SUCCESS (0.000s)
[379.324600] 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.