[67.695798] Initializing watchdogs
[67.695944]   /dev/watchdog0
[67.718497] [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)
[67.728876] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[67.732682] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.736947] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[67.812374] Starting subtest: invalid-bad-pad
[67.814068] Subtest invalid-bad-pad: SUCCESS (0.000s)
[67.929549] [002/131] (960s left) tools_test (tools_test)
[67.996015] Starting subtest: tools_test
[68.098196] Subtest tools_test: SUCCESS (0.113s)
[68.212904] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[68.272339] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[68.335251] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[68.408837] Starting subtest: sync-unmap-cycles
[73.795000] Subtest sync-unmap-cycles: SUCCESS (5.378s)
[73.962228] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[74.262662] Starting subtest: stress-xrgb8888-ytiled
[74.265864] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[74.449511] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[74.511268] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[74.568557] [007/131] (953s left) api_intel_allocator (gem-pool)
[74.643195] Starting subtest: gem-pool
[74.645277] Subtest gem-pool: SUCCESS (0.004s)
[74.776770] [008/131] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[75.083952] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[75.087340] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[75.490293] [009/131] (953s left) kms_atomic_interruptible (universal-setplane-primary)
[75.789612] Starting subtest: universal-setplane-primary
[75.791427] Starting dynamic subtest: pipe-A-HDMI-A-1
[82.127178] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.335s)
[82.128916] Subtest universal-setplane-primary: SUCCESS (6.336s)
[82.641429] [010/131] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[82.946050] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[85.628926] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.684s)
[86.088408] [011/131] (942s left) gem_eio (in-flight-contexts-1us)
[86.162742] Starting subtest: in-flight-contexts-1us
[89.547443] Subtest in-flight-contexts-1us: SUCCESS (3.383s)
[90.209926] [012/131] (938s left) gem_exec_balancer (semaphore)
[90.278983] Subtest semaphore: SKIP (0.000s)
[90.405114] [013/131] (938s left) kms_chamelium_hpd (hdmi-hpd)
[90.786806] Subtest hdmi-hpd: SKIP (0.000s)
[91.095237] [014/131] (937s left) kms_flip (wf_vblank-ts-check)
[91.392157] Starting subtest: wf_vblank-ts-check
[91.394049] Starting dynamic subtest: A-VGA1
[99.485121] Dynamic subtest A-VGA1: SUCCESS (8.090s)
[99.495925] Starting dynamic subtest: B-VGA1
[107.491263] Dynamic subtest B-VGA1: SUCCESS (8.004s)
[107.502137] Starting dynamic subtest: A-HDMI-A1
[115.684420] Dynamic subtest A-HDMI-A1: SUCCESS (8.191s)
[115.695804] Starting dynamic subtest: B-HDMI-A1
[123.886612] Dynamic subtest B-HDMI-A1: SUCCESS (8.200s)
[123.888472] Subtest wf_vblank-ts-check: SUCCESS (32.492s)
[124.475637] [015/131] (904s left) gem_exec_reloc (basic-gtt)
[124.536352] Starting subtest: basic-gtt
[124.539120] Subtest basic-gtt: SUCCESS (0.004s)
[125.182634] [016/131] (903s left) gem_exec_schedule (reorder-wide)
[125.252989] Subtest reorder-wide: SKIP (0.000s)
[125.488886] [017/131] (903s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[125.551884] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[125.613290] [018/131] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[125.917145] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[125.920523] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[126.317598] [019/131] (902s left) perf (polling)
[126.459808] Subtest polling: SKIP (0.000s)
[126.516213] [020/131] (902s left) gem_userptr_blits (probe)
[126.596304] Starting subtest: probe
[126.787679] Subtest probe: SUCCESS (0.190s)
[126.936026] [021/131] (902s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[127.241411] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[127.244741] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[127.651653] [022/131] (901s left) gem_mmap_offset (pf-nonblock)
[127.709603] Starting subtest: pf-nonblock
[127.711279] Subtest pf-nonblock: SUCCESS (0.003s)
[127.867510] [023/131] (901s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[127.926979] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[127.975515] [024/131] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[128.278925] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[128.282385] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[128.682055] [025/131] (900s left) core_getstats (basic)
[128.737417] Starting subtest: basic
[128.739107] Subtest basic: SUCCESS (0.000s)
[128.865476] [026/131] (900s left) core_getclient (basic)
[128.920600] Starting subtest: basic
[128.922395] Subtest basic: SUCCESS (0.000s)
[129.053470] [027/131] (900s left) syncobj_timeline (multi-wait-all-available-submitted)
[129.112423] Starting subtest: multi-wait-all-available-submitted
[129.114179] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[129.248274] [028/131] (900s left) gem_exec_reloc (basic-write-wc)
[129.308503] Starting subtest: basic-write-wc
[129.310131] Subtest basic-write-wc: SUCCESS (0.003s)
[129.963108] [029/131] (899s left) kms_invalid_mode (clock-too-high)
[130.264615] Starting subtest: clock-too-high
[130.266492] Starting dynamic subtest: pipe-A-HDMI-A-1
[130.344510] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.083s)
[130.375047] Starting dynamic subtest: pipe-B-HDMI-A-1
[130.377206] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[130.379117] Subtest clock-too-high: SUCCESS (0.086s)
[130.744081] [030/131] (898s left) gem_mmap_offset (bad-object)
[130.807830] Starting subtest: bad-object
[130.809452] Subtest bad-object: SUCCESS (0.003s)
[130.946533] [031/131] (898s left) syncobj_timeline (wait-all-delayed-signal)
[131.005666] Starting subtest: wait-all-delayed-signal
[131.109197] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[131.243475] [032/131] (898s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[131.553885] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[131.563426] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.001s)
[131.959942] [033/131] (897s left) gem_exec_suspend (basic-s3)
[132.031455] Starting subtest: basic-S3
[132.033145] Starting dynamic subtest: smem
[149.122238] Dynamic subtest smem: SUCCESS (1.345s)
[149.124332] Subtest basic-S3: SUCCESS (1.346s)
[156.371230] [034/131] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[156.683075] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[156.686542] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[157.099672] [035/131] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[157.405887] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[157.409023] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[157.810170] [036/131] (879s left) kms_chamelium_frames (hdmi-crc-multiple)
[158.194178] Subtest hdmi-crc-multiple: SKIP (0.000s)
[158.502595] [037/131] (878s left) gem_exec_fence (syncobj-import)
[158.745278] Starting subtest: syncobj-import
[158.749076] Subtest syncobj-import: SUCCESS (0.003s)
[159.145113] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[159.150879] [038/131] (878s left) kms_legacy_colorkey (basic)
[159.444329] Starting subtest: basic
[159.446046] Starting dynamic subtest: pipe-A
[159.447693] Dynamic subtest pipe-A: SUCCESS (0.000s)
[159.461022] Starting dynamic subtest: pipe-B
[159.462617] Dynamic subtest pipe-B: SUCCESS (0.000s)
[159.464207] Subtest basic: SUCCESS (0.002s)
[159.859867] [039/131] (877s left) gem_softpin (allocator-nopin-reserve)
[159.929863] Subtest allocator-nopin-reserve: SKIP (0.000s)
[160.058805] [040/131] (877s left) perf_pmu (enable-race)
[160.118800] Starting subtest: enable-race
[160.120568] Starting dynamic subtest: rcs0
[160.124431] Dynamic subtest rcs0: SKIP (0.000s)
[160.144259] Starting dynamic subtest: bcs0
[160.148164] Dynamic subtest bcs0: SKIP (0.000s)
[160.168236] Starting dynamic subtest: vcs0
[160.172150] Dynamic subtest vcs0: SKIP (0.000s)
[160.175971] Subtest enable-race: SKIP (0.002s)
[160.255404] [041/131] (877s left) syncobj_timeline (signal-point-0)
[160.314508] Starting subtest: signal-point-0
[160.316080] Subtest signal-point-0: SUCCESS (0.001s)
[160.441300] [042/131] (877s left) gem_tiled_wb
[170.413740] [043/131] (867s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[170.476176] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[170.558534] [044/131] (867s left) gem_ctx_param (set-priority-invalid-size)
[170.618884] Subtest set-priority-invalid-size: SKIP (0.000s)
[170.761790] [045/131] (866s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[171.053813] Starting subtest: plane-ctm3x4-lut1d
[171.326896] Subtest plane-ctm3x4-lut1d: SKIP (0.274s)
[171.851676] [046/131] (865s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[172.153492] Starting subtest: 2x-long-cursor-vs-flip-atomic
[172.156795] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[172.564010] [047/131] (865s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[172.869059] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[174.703106] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.837s)
[175.160494] [048/131] (862s left) kms_feature_discovery (display-1x)
[175.462568] Starting subtest: display-1x
[175.464268] Subtest display-1x: SUCCESS (0.000s)
[175.876866] [049/131] (862s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[176.177524] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[176.180654] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[176.588658] [050/131] (861s left) i915_drm_fdinfo (most-busy-idle-check-all)
[176.652292] Subtest most-busy-idle-check-all: SKIP (0.000s)
[176.717233] [051/131] (861s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[177.016221] Starting subtest: x-tiled-32bpp-rotate-270
[177.031104] Subtest x-tiled-32bpp-rotate-270: SKIP (0.014s)
[177.470538] [052/131] (860s left) gem_exec_schedule (u-submit-early-slice)
[177.540259] Subtest u-submit-early-slice: SKIP (0.000s)
[177.787189] [053/131] (860s left) gem_pxp (regular-baseline-src-copy-readible)
[180.359038] Starting subtest: regular-baseline-src-copy-readible
[180.362654] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[180.500376] [054/131] (857s left) gem_exec_balancer (full-late-pulse)
[180.561237] Subtest full-late-pulse: SKIP (0.000s)
[180.705436] [055/131] (857s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[181.014848] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[181.018238] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[181.437665] [056/131] (856s left) fbdev (read)
[181.509021] Starting subtest: read
[181.898017] Subtest read: SUCCESS (0.390s)
[182.012640] [057/131] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[182.352771] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[182.356293] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[182.740537] [058/131] (855s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[183.034574] Starting subtest: multiplane-rotation-cropping-top
[183.038024] Subtest multiplane-rotation-cropping-top: SKIP (0.000s)
[183.455207] [059/131] (855s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[183.759214] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[183.762617] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[184.174152] [060/131] (854s left) i915_selftest (mock)
[185.078366] Starting subtest: mock
[185.080384] Starting dynamic subtest: sanitycheck
[186.221872] Dynamic subtest sanitycheck: SUCCESS (1.143s)
[186.239267] Starting dynamic subtest: shmem
[187.375727] Dynamic subtest shmem: SUCCESS (1.153s)
[187.389974] Starting dynamic subtest: fence
[195.800720] Dynamic subtest fence: SUCCESS (8.425s)
[195.814758] Starting dynamic subtest: scatterlist
[197.974808] Dynamic subtest scatterlist: SUCCESS (2.173s)
[197.988473] Starting dynamic subtest: syncmap
[201.143703] Dynamic subtest syncmap: SUCCESS (3.168s)
[201.158688] Starting dynamic subtest: uncore
[202.274964] Dynamic subtest uncore: SUCCESS (1.130s)
[202.288475] Starting dynamic subtest: ring
[203.401741] Dynamic subtest ring: SUCCESS (1.126s)
[203.415279] Starting dynamic subtest: engine
[204.529848] Dynamic subtest engine: SUCCESS (1.127s)
[204.543673] Starting dynamic subtest: timelines
[210.749717] Dynamic subtest timelines: SUCCESS (6.219s)
[210.767463] Starting dynamic subtest: requests
[214.092819] Dynamic subtest requests: SUCCESS (3.342s)
[214.106167] Starting dynamic subtest: objects
[215.375745] Dynamic subtest objects: SUCCESS (1.282s)
[215.389702] Starting dynamic subtest: phys
[216.625896] Dynamic subtest phys: SUCCESS (1.249s)
[216.639189] Starting dynamic subtest: dmabuf
[217.873026] Dynamic subtest dmabuf: SUCCESS (1.246s)
[217.886927] Starting dynamic subtest: vma
[229.567839] Dynamic subtest vma: SUCCESS (11.693s)
[229.581398] Starting dynamic subtest: evict
[232.142841] Dynamic subtest evict: SUCCESS (2.574s)
[232.156065] Starting dynamic subtest: gtt
[236.496875] Dynamic subtest gtt: SUCCESS (4.353s)
[236.510831] Starting dynamic subtest: hugepages
[238.030844] Dynamic subtest hugepages: SUCCESS (1.533s)
[238.044851] Starting dynamic subtest: memory_region
[243.128762] Dynamic subtest memory_region: SUCCESS (5.097s)
[243.130543] Subtest mock: SUCCESS (58.051s)
[243.165038] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[243.166290] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[243.169688] [061/131] (795s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[245.229733] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[245.432324] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[245.434073] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[245.439971] [062/131] (793s left) gem_render_copy_redux (normal)
[245.506063] Starting subtest: normal
[246.074332] Subtest normal: SUCCESS (0.567s)
[246.255841] [063/131] (792s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[246.315810] Starting subtest: basic-cpu-wc-noreloc
[246.317620] Subtest basic-cpu-wc-noreloc: SUCCESS (0.002s)
[246.968556] [064/131] (791s left) gem_ctx_param (invalid-set-no-zeromap)
[247.029679] Starting subtest: invalid-set-no-zeromap
[247.031526] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[247.168147] [065/131] (791s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[247.477068] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[247.482370] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[247.906945] [066/131] (791s left) i915_pm_rps (reset)
[247.970175] Starting subtest: reset
[253.045566] Subtest reset: SUCCESS (5.076s)
[253.220821] [067/131] (785s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[253.516479] Starting subtest: async-flip-with-page-flip-events-linear
[253.669069] Subtest async-flip-with-page-flip-events-linear: SKIP (0.153s)
[254.207851] [068/131] (784s left) perf_pmu (module-unload)
[254.290275] Starting subtest: module-unload
[260.619812] Subtest module-unload: FAIL (6.264s)
[260.654657] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[260.655907] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[260.659099] [069/131] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[262.743685] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[262.747121] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[263.179968] [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.181572] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[263.186181] [070/131] (776s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[263.248863] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[263.357595] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[263.499088] [071/131] (775s left) kms_cursor_crc (cursor-random-256x85)
[263.806223] Starting subtest: cursor-random-256x85
[263.876038] Subtest cursor-random-256x85: SKIP (0.066s)
[264.288655] [072/131] (775s left) kms_psr (psr-sprite-plane-move)
[264.591555] Subtest psr-sprite-plane-move: SKIP (0.000s)
[264.796214] [073/131] (774s left) kms_psr (fbc-pr-sprite-plane-onoff)
[265.121784] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[265.284983] [074/131] (774s left) kms_pm_rpm (pm-tiling)
[276.784683] Subtest pm-tiling: SKIP (0.000s)
[276.977863] [075/131] (762s left) gem_userptr_blits (invalid-null-pointer)
[277.047139] Starting subtest: invalid-null-pointer
[277.048813] Subtest invalid-null-pointer: SUCCESS (0.004s)
[277.246690] [076/131] (762s left) kms_content_protection (lic-type-1)
[277.554253] Starting subtest: lic-type-1
[277.557602] Subtest lic-type-1: SKIP (0.000s)
[277.964884] [077/131] (761s left) kms_atomic (plane-immutable-zpos)
[278.268479] Starting subtest: plane-immutable-zpos
[278.270683] Starting dynamic subtest: pipe-A-HDMI-A-1
[278.783772] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.515s)
[278.785573] Subtest plane-immutable-zpos: SUCCESS (0.518s)
[279.286880] [078/131] (760s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[279.583862] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[279.587519] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[280.008222] [079/131] (759s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[280.303419] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[280.305043] Starting dynamic subtest: pipe-A
[280.310000] Dynamic subtest pipe-A: SKIP (0.001s)
[280.323435] Starting dynamic subtest: pipe-B
[280.328439] Dynamic subtest pipe-B: SKIP (0.001s)
[280.331713] Subtest plane-upscale-factor-0-25-with-pixel-format: SKIP (0.005s)
[280.727433] [080/131] (759s left) kms_psr (pr-sprite-mmap-cpu)
[281.029058] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[281.237535] [081/131] (758s left) gem_ctx_persistence (legacy-engines-cleanup)
[281.300371] Subtest legacy-engines-cleanup: SKIP (0.000s)
[281.367237] [082/131] (758s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[281.663993] Starting subtest: cursor-tearing-framebuffer-change
[281.666107] Starting dynamic subtest: pipe-A-HDMI-A-1
[282.012159] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.346s)
[282.026282] Starting dynamic subtest: pipe-B-HDMI-A-1
[282.376784] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.362s)
[282.378722] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.713s)
[282.914133] [083/131] (757s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[283.219261] Starting subtest: 2x-cursor-vs-flip-atomic
[283.222642] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[283.643746] [084/131] (756s left) kms_cursor_crc (cursor-random-32x10)
[283.945093] Starting subtest: cursor-random-32x10
[284.000683] Subtest cursor-random-32x10: SKIP (0.053s)
[284.425717] [085/131] (755s left) kms_psr (fbc-psr-primary-mmap-gtt)
[284.720941] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[284.936710] [086/131] (755s left) kms_big_fb (linear-8bpp-rotate-0)
[285.245291] Starting subtest: linear-8bpp-rotate-0
[286.497212] Subtest linear-8bpp-rotate-0: SUCCESS (1.251s)
[286.954526] [087/131] (753s left) gem_create (create-ext-cpu-access-sanity-check)
[287.128744] Starting subtest: create-ext-cpu-access-sanity-check
[287.132736] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[287.269721] [088/131] (753s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[287.574766] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[289.061069] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.489s)
[289.515746] [089/131] (750s left) kms_pm_rpm (cursor-dpms)
[301.017633] Subtest cursor-dpms: SKIP (0.000s)
[301.220139] [090/131] (739s left) gem_lmem_swapping (verify-random-ccs)
[301.282855] Subtest verify-random-ccs: SKIP (0.000s)
[301.353039] [091/131] (739s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[301.649723] Starting subtest: flip-vs-cursor-toggle
[316.134641] Subtest flip-vs-cursor-toggle: SUCCESS (14.486s)
[316.664036] [092/131] (723s left) gem_lmem_swapping (heavy-verify-multi)
[316.728597] Subtest heavy-verify-multi: SKIP (0.000s)
[316.792941] [093/131] (723s left) i915_pm_freq_api (freq-reset)
[316.854798] Subtest freq-reset: SKIP (0.000s)
[316.922811] [094/131] (723s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[317.220164] Starting subtest: y-tiled-64bpp-rotate-90
[317.223645] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[317.635496] [095/131] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[317.940361] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[317.943775] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[318.353699] [096/131] (722s left) kms_dirtyfb (default-dirtyfb-ioctl)
[318.659199] Starting subtest: default-dirtyfb-ioctl
[318.660977] Starting dynamic subtest: A-HDMI-A-1
[320.015099] Dynamic subtest A-HDMI-A-1: SUCCESS (1.355s)
[320.016839] Subtest default-dirtyfb-ioctl: SUCCESS (1.358s)
[320.543317] [097/131] (720s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[320.840808] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[320.842721] Starting dynamic subtest: pipe-A
[320.847743] Dynamic subtest pipe-A: SKIP (0.001s)
[320.863132] Starting dynamic subtest: pipe-B
[320.867884] Dynamic subtest pipe-B: SKIP (0.001s)
[320.871044] Subtest plane-downscale-factor-0-75-with-modifiers: SKIP (0.005s)
[321.259275] [098/131] (719s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[321.321834] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[321.387461] [099/131] (719s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[321.684557] Starting subtest: 2x-cursor-vs-flip-legacy
[321.689176] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[322.105838] [100/131] (718s left) gem_readwrite (write-bad-handle)
[322.167582] Starting subtest: write-bad-handle
[322.171087] Subtest write-bad-handle: SUCCESS (0.000s)
[322.320562] [101/131] (718s left) gem_reg_read (timestamp-monotonic)
[322.380556] Starting subtest: timestamp-monotonic
[327.051033] Subtest timestamp-monotonic: SUCCESS (4.671s)
[327.188739] [102/131] (713s left) kms_psr (fbc-psr2-cursor-plane-move)
[327.486924] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[327.691518] [103/131] (713s left) kms_plane_lowres (tiling-x)
[327.989845] Starting subtest: tiling-x
[327.991708] Starting dynamic subtest: pipe-A-HDMI-A-1
[330.553377] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.563s)
[330.679419] Starting dynamic subtest: pipe-B-HDMI-A-1
[333.132489] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.495s)
[333.214953] Subtest tiling-x: SUCCESS (5.227s)
[333.772845] [104/131] (707s left) kms_force_connector_basic (force-edid)
[333.847568] Starting subtest: force-edid
[333.867670] Subtest force-edid: SUCCESS (0.020s)
[334.327928] [105/131] (706s left) kms_getfb (getfb-handle-zero)
[334.625330] Starting subtest: getfb-handle-zero
[334.626991] Subtest getfb-handle-zero: SUCCESS (0.000s)
[335.049985] [106/131] (706s left) perf (missing-sample-flags)
[335.191740] Subtest missing-sample-flags: SKIP (0.000s)
[335.255239] [107/131] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[335.663421] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[335.711592] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[336.073283] [108/131] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[336.536468] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[336.671567] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[336.837693] [109/131] (704s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[337.146668] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[337.149876] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[337.566597] [110/131] (704s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[337.868873] Starting subtest: 4-tiled-8bpp-rotate-180
[337.872245] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[338.286932] [111/131] (703s left) gem_exec_fence (syncobj-timeline-repeat)
[338.608014] Starting subtest: syncobj-timeline-repeat
[339.180847] Subtest syncobj-timeline-repeat: SUCCESS (0.572s)
[339.443578] [112/131] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[339.748925] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[339.752323] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[340.163611] [113/131] (701s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[340.228882] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[340.230658] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[340.361528] [114/131] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[340.659653] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[342.585412] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.928s)
[343.042774] [115/131] (698s left) gem_exec_schedule (lateslice)
[343.120219] Subtest lateslice: SKIP (0.000s)
[343.352463] [116/131] (698s left) kms_vblank (query-idle-hang)
[343.647116] Starting subtest: query-idle-hang
[343.649374] Starting dynamic subtest: pipe-A-HDMI-A-1
[349.701108] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.054s)
[349.718370] Starting dynamic subtest: pipe-B-HDMI-A-1
[355.724298] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.019s)
[355.725989] Subtest query-idle-hang: SUCCESS (12.080s)
[356.249655] [117/131] (685s left) syncobj_wait (reset-multiple-signaled)
[356.310871] Starting subtest: reset-multiple-signaled
[356.312938] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[356.450757] [118/131] (685s left) kms_flip_event_leak (basic)
[356.743999] Starting subtest: basic
[356.746040] Starting dynamic subtest: pipe-A-HDMI-A-1
[356.973101] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.230s)
[356.988098] Starting dynamic subtest: pipe-B-HDMI-A-1
[357.217294] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.242s)
[357.219064] Subtest basic: SUCCESS (0.476s)
[357.748290] [119/131] (684s left) gem_pwrite_snooped
[357.984842] [120/131] (684s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[358.052961] Starting subtest: yf-tiled-ccs-to-y-tiled
[358.054880] Starting dynamic subtest: smem
[358.059111] Dynamic subtest smem: SKIP (0.000s)
[358.063025] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.002s)
[358.301119] [121/131] (684s left) gem_ctx_shared (q-independent)
[358.365012] Subtest Q-independent: SKIP (0.000s)
[358.504251] [122/131] (683s left) prime_mmap (test_userptr)
[358.562428] Starting subtest: test_userptr
[358.564045] Starting dynamic subtest: test_userptr-smem
[358.565629] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[358.567260] Subtest test_userptr: SUCCESS (0.002s)
[358.733943] [123/131] (683s left) kms_addfb_basic (bad-pitch-65536)
[358.794823] Starting subtest: bad-pitch-65536
[358.796493] Subtest bad-pitch-65536: SUCCESS (0.000s)
[359.454250] [124/131] (683s left) prime_self_import (basic-with_fd_dup)
[359.514630] Starting subtest: basic-with_fd_dup
[359.518051] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[359.668817] [125/131] (682s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[359.966684] Starting subtest: primary-y-tiled-reflect-x-0
[359.970001] Subtest primary-y-tiled-reflect-x-0: SKIP (0.001s)
[360.387287] [126/131] (682s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[360.448813] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[360.516509] [127/131] (682s left) kms_addfb_basic (unused-modifier)
[360.574373] Starting subtest: unused-modifier
[360.576129] Subtest unused-modifier: SUCCESS (0.000s)
[361.232737] [128/131] (681s left) kms_vblank (wait-idle)
[361.534426] Starting subtest: wait-idle
[361.536586] Starting dynamic subtest: pipe-A-HDMI-A-1
[363.735843] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.201s)
[363.750918] Starting dynamic subtest: pipe-B-HDMI-A-1
[365.979705] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.242s)
[365.981409] Subtest wait-idle: SUCCESS (4.447s)
[366.506763] [129/131] (676s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[366.805167] Starting subtest: cursorA-vs-flipA-toggle
[377.708060] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.903s)
[378.214133] [130/131] (664s left) gen9_exec_parse (bb-start-far)
[378.275245] Subtest bb-start-far: SKIP (0.000s)
[378.345728] [131/131] (664s left) kms_addfb_basic (basic)
[378.404323] Starting subtest: basic
[378.405997] Subtest basic: SUCCESS (0.000s)
[379.060625] 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.