[45.822345] Initializing watchdogs
[45.822413]   /dev/watchdog0
[45.838672] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[45.844680] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.847630] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.850348] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[45.890382] Starting subtest: invalid-bad-pad
[45.891108] Subtest invalid-bad-pad: SUCCESS (0.000s)
[45.979912] [002/131] (960s left) tools_test (tools_test)
[46.016204] Starting subtest: tools_test
[46.093779] Subtest tools_test: SUCCESS (0.078s)
[46.176864] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[46.212115] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[46.251585] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[46.298788] Starting subtest: sync-unmap-cycles
[51.864079] Subtest sync-unmap-cycles: SUCCESS (5.381s)
[51.995538] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[52.087628] Starting subtest: stress-xrgb8888-ytiled
[59.355956] Subtest stress-xrgb8888-ytiled: SUCCESS (7.170s)
[59.490801] [006/131] (947s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[59.580429] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[59.581162] Starting dynamic subtest: pipe-A-HDMI-A-1
[59.583946] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[59.591087] Starting dynamic subtest: pipe-B-HDMI-A-1
[59.593918] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[59.600908] Starting dynamic subtest: pipe-C-HDMI-A-1
[59.603686] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[59.610679] Starting dynamic subtest: pipe-D-HDMI-A-1
[59.613435] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[59.614820] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[59.830097] [007/131] (946s left) api_intel_allocator (gem-pool)
[59.862357] Starting subtest: gem-pool
[59.868066] Subtest gem-pool: SUCCESS (0.006s)
[60.013138] [008/131] (946s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[60.102822] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[60.104320] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[60.212930] [009/131] (946s left) kms_atomic_interruptible (universal-setplane-primary)
[60.297044] Starting subtest: universal-setplane-primary
[60.305687] Starting dynamic subtest: pipe-A-HDMI-A-1
[66.539835] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.211s)
[66.540563] Subtest universal-setplane-primary: SUCCESS (6.213s)
[66.710883] [010/131] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[66.805386] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[68.739893] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (1.929s)
[68.893935] [011/131] (937s left) gem_eio (in-flight-contexts-1us)
[68.936587] Starting subtest: in-flight-contexts-1us
[82.857207] Subtest in-flight-contexts-1us: SUCCESS (13.903s)
[82.994437] [012/131] (923s left) gem_exec_balancer (semaphore)
[83.034386] Starting subtest: semaphore
[84.283502] Subtest semaphore: SUCCESS (1.248s)
[84.481333] [013/131] (922s left) kms_chamelium_hpd (hdmi-hpd)
[84.618927] Subtest hdmi-hpd: SKIP (0.000s)
[84.702969] [014/131] (922s left) kms_flip (wf_vblank-ts-check)
[84.791287] Starting subtest: wf_vblank-ts-check
[84.792994] Starting dynamic subtest: A-HDMI-A1
[92.608941] Dynamic subtest A-HDMI-A1: SUCCESS (7.811s)
[92.617833] Starting dynamic subtest: B-HDMI-A1
[100.432459] Dynamic subtest B-HDMI-A1: SUCCESS (7.793s)
[100.438369] Starting dynamic subtest: C-HDMI-A1
[108.226298] Dynamic subtest C-HDMI-A1: SUCCESS (7.791s)
[108.231850] Starting dynamic subtest: D-HDMI-A1
[115.995289] Dynamic subtest D-HDMI-A1: SUCCESS (7.792s)
[115.995995] Subtest wf_vblank-ts-check: SUCCESS (31.194s)
[116.154212] [015/131] (890s left) gem_exec_reloc (basic-gtt)
[116.191852] Starting subtest: basic-gtt
[116.199288] Subtest basic-gtt: SUCCESS (0.007s)
[116.338603] [016/131] (890s left) gem_exec_schedule (reorder-wide)
[116.503350] Starting subtest: reorder-wide
[116.504346] Starting dynamic subtest: rcs0
[116.601964] Dynamic subtest rcs0: SUCCESS (0.099s)
[116.610217] Starting dynamic subtest: bcs0
[116.672340] Dynamic subtest bcs0: SUCCESS (0.070s)
[116.681033] Starting dynamic subtest: vcs0
[116.743455] Dynamic subtest vcs0: SUCCESS (0.070s)
[116.757146] Starting dynamic subtest: vcs1
[116.817028] Dynamic subtest vcs1: SUCCESS (0.073s)
[116.826800] Starting dynamic subtest: vecs0
[116.889126] Dynamic subtest vecs0: SUCCESS (0.072s)
[116.890117] Subtest reorder-wide: SUCCESS (0.387s)
[117.085821] [FACT gem_exec_schedule (reorder-wide)] new: kernel.kmod_is_loaded.vgem: true
[117.087393] [017/131] (889s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[117.170396] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[117.171098] Starting dynamic subtest: pipe-A-HDMI-A-1
[117.312060] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.139s)
[117.318620] Starting dynamic subtest: pipe-B-HDMI-A-1
[117.413046] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.100s)
[117.419108] Starting dynamic subtest: pipe-C-HDMI-A-1
[117.514690] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.100s)
[117.521064] Starting dynamic subtest: pipe-D-HDMI-A-1
[117.620400] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.104s)
[117.621118] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.448s)
[117.912489] [018/131] (889s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[118.000325] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[118.001731] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[118.122877] [019/131] (888s left) perf (polling)
[118.224185] Starting subtest: polling
[118.224888] Starting dynamic subtest: 0-rcs0
[128.248021] Dynamic subtest 0-rcs0: SUCCESS (10.014s)
[128.248763] Subtest polling: SUCCESS (10.015s)
[128.278531] [020/131] (878s left) gem_userptr_blits (probe)
[128.351489] Starting subtest: probe
[128.455193] Subtest probe: SUCCESS (0.104s)
[128.592776] [021/131] (878s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[128.686451] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[128.687806] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[128.808590] [022/131] (878s left) gem_mmap_offset (pf-nonblock)
[128.840199] Starting subtest: pf-nonblock
[128.844457] Subtest pf-nonblock: SUCCESS (0.005s)
[128.992338] [023/131] (878s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[129.074722] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[129.076239] Starting dynamic subtest: pipe-A-HDMI-A-1
[129.083587] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[129.089927] Starting dynamic subtest: pipe-B-HDMI-A-1
[129.097373] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[129.103560] Starting dynamic subtest: pipe-C-HDMI-A-1
[129.111072] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[129.116922] Starting dynamic subtest: pipe-D-HDMI-A-1
[129.124311] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[129.125660] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[129.325976] [024/131] (877s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[129.419558] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[129.420953] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[129.533946] [025/131] (877s left) core_getstats (basic)
[129.565432] Starting subtest: basic
[129.566176] Subtest basic: SUCCESS (0.000s)
[129.649500] [026/131] (877s left) core_getclient (basic)
[129.681159] Starting subtest: basic
[129.681887] Subtest basic: SUCCESS (0.000s)
[129.765548] [027/131] (877s left) syncobj_timeline (multi-wait-all-available-submitted)
[129.798222] Starting subtest: multi-wait-all-available-submitted
[129.798935] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[129.881884] [028/131] (877s left) gem_exec_reloc (basic-write-wc)
[129.918123] Starting subtest: basic-write-wc
[129.923570] Subtest basic-write-wc: SUCCESS (0.005s)
[130.064648] [029/131] (877s left) kms_invalid_mode (clock-too-high)
[130.149116] Starting subtest: clock-too-high
[130.149804] Starting dynamic subtest: pipe-A-HDMI-A-1
[130.209072] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.060s)
[130.216109] Starting dynamic subtest: pipe-B-HDMI-A-1
[130.218856] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.008s)
[130.226070] Starting dynamic subtest: pipe-C-HDMI-A-1
[130.228821] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.009s)
[130.234980] Starting dynamic subtest: pipe-D-HDMI-A-1
[130.238611] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.009s)
[130.239319] Subtest clock-too-high: SUCCESS (0.090s)
[130.381942] [030/131] (877s left) gem_mmap_offset (bad-object)
[130.415106] Starting subtest: bad-object
[130.416665] Subtest bad-object: SUCCESS (0.001s)
[130.538061] [031/131] (876s left) syncobj_timeline (wait-all-delayed-signal)
[130.571435] Starting subtest: wait-all-delayed-signal
[130.672925] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[130.765321] [032/131] (876s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[130.858460] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[131.164463] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.306s)
[131.330867] [033/131] (876s left) gem_exec_suspend (basic-s3)
[131.371257] Starting subtest: basic-S3
[131.371972] Starting dynamic subtest: smem
[148.883752] Dynamic subtest smem: SUCCESS (3.145s)
[148.884496] Subtest basic-S3: SUCCESS (3.146s)
[157.130796] [034/131] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[157.245869] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[157.247330] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[157.357572] [035/131] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[157.449608] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[157.451084] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[157.567275] [036/131] (858s left) kms_chamelium_frames (hdmi-crc-multiple)
[157.708004] Subtest hdmi-crc-multiple: SKIP (0.000s)
[157.805931] [037/131] (858s left) gem_exec_fence (syncobj-import)
[158.146414] Starting subtest: syncobj-import
[158.147978] Subtest syncobj-import: SUCCESS (0.002s)
[158.470001] [038/131] (857s left) kms_legacy_colorkey (basic)
[158.556663] Starting subtest: basic
[158.557363] Starting dynamic subtest: pipe-A
[158.600490] Dynamic subtest pipe-A: SUCCESS (0.042s)
[158.608959] Starting dynamic subtest: pipe-B
[158.609717] Dynamic subtest pipe-B: SUCCESS (0.001s)
[158.619148] Starting dynamic subtest: pipe-C
[158.619892] Dynamic subtest pipe-C: SUCCESS (0.001s)
[158.626657] Starting dynamic subtest: pipe-D
[158.627345] Dynamic subtest pipe-D: SUCCESS (0.001s)
[158.628033] Subtest basic: SUCCESS (0.046s)
[158.720470] [039/131] (857s left) gem_softpin (allocator-nopin-reserve)
[158.757166] Starting subtest: allocator-nopin-reserve
[158.838462] Subtest allocator-nopin-reserve: SUCCESS (0.078s)
[158.979685] [040/131] (856s left) perf_pmu (enable-race)
[159.015070] Starting subtest: enable-race
[159.015810] Starting dynamic subtest: rcs0
[171.621626] Dynamic subtest rcs0: SUCCESS (12.367s)
[171.635522] Starting dynamic subtest: bcs0
[184.192427] Dynamic subtest bcs0: SUCCESS (12.523s)
[184.201951] Starting dynamic subtest: vcs0
[196.758237] Dynamic subtest vcs0: SUCCESS (12.570s)
[196.768392] Starting dynamic subtest: vcs1
[209.337268] Dynamic subtest vcs1: SUCCESS (12.565s)
[209.347437] Starting dynamic subtest: vecs0
[221.877271] Dynamic subtest vecs0: SUCCESS (12.559s)
[221.877958] Subtest enable-race: SUCCESS (62.586s)
[221.960549] [041/131] (794s left) syncobj_timeline (signal-point-0)
[221.992155] Starting subtest: signal-point-0
[221.992846] Subtest signal-point-0: SUCCESS (0.000s)
[222.080328] [042/131] (793s left) gem_tiled_wb
[226.804766] [043/131] (789s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[226.892313] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[226.893016] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.420849] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s)
[227.427814] Starting dynamic subtest: pipe-B-HDMI-A-1
[228.005852] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.583s)
[228.012922] Starting dynamic subtest: pipe-C-HDMI-A-1
[228.581510] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.574s)
[228.588405] Starting dynamic subtest: pipe-D-HDMI-A-1
[229.164899] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.582s)
[229.165753] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.270s)
[229.347654] [044/131] (786s left) gem_ctx_param (set-priority-invalid-size)
[229.380452] Starting subtest: set-priority-invalid-size
[229.381138] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[229.467989] [045/131] (786s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[229.556256] Starting subtest: plane-ctm3x4-lut1d
[229.570772] Starting dynamic subtest: pipe-A-HDMI-A-1
[229.737595] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.166s)
[229.884253] Starting dynamic subtest: pipe-B-HDMI-A-1
[230.033556] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.157s)
[230.153894] Starting dynamic subtest: pipe-C-HDMI-A-1
[230.295965] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.148s)
[230.452078] Starting dynamic subtest: pipe-D-HDMI-A-1
[230.592520] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.148s)
[230.656793] Subtest plane-ctm3x4-lut1d: SUCCESS (1.100s)
[230.776156] [046/131] (785s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[230.865504] Starting subtest: 2x-long-cursor-vs-flip-atomic
[230.868045] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[230.953034] [047/131] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[231.041315] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[232.334286] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.292s)
[232.483183] [048/131] (783s left) kms_feature_discovery (display-1x)
[232.570325] Starting subtest: display-1x
[232.571039] Subtest display-1x: SUCCESS (0.000s)
[232.652672] [049/131] (783s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[232.747334] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[233.017456] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.270s)
[233.201112] [050/131] (783s left) i915_drm_fdinfo (most-busy-idle-check-all)
[233.236122] Starting subtest: most-busy-idle-check-all
[233.236882] Starting dynamic subtest: rcs0
[233.873394] Dynamic subtest rcs0: SUCCESS (0.636s)
[233.884210] Starting dynamic subtest: bcs0
[234.507988] Dynamic subtest bcs0: SUCCESS (0.632s)
[234.522254] Starting dynamic subtest: vcs0
[235.144348] Dynamic subtest vcs0: SUCCESS (0.634s)
[235.155011] Starting dynamic subtest: vcs1
[235.780138] Dynamic subtest vcs1: SUCCESS (0.634s)
[235.791146] Starting dynamic subtest: vecs0
[236.414145] Dynamic subtest vecs0: SUCCESS (0.631s)
[236.415311] Subtest most-busy-idle-check-all: SUCCESS (3.177s)
[236.506972] [051/131] (779s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[236.603258] Starting subtest: x-tiled-32bpp-rotate-270
[236.683102] Subtest x-tiled-32bpp-rotate-270: SKIP (0.079s)
[236.801536] [052/131] (779s left) gem_exec_schedule (u-submit-early-slice)
[236.847887] Starting subtest: u-submit-early-slice
[236.848579] Starting dynamic subtest: rcs0
[236.876710] Dynamic subtest rcs0: SUCCESS (0.030s)
[236.884136] Starting dynamic subtest: bcs0
[236.903652] Dynamic subtest bcs0: SUCCESS (0.026s)
[236.912851] Starting dynamic subtest: vcs0
[236.932549] Dynamic subtest vcs0: SUCCESS (0.028s)
[236.940059] Starting dynamic subtest: vcs1
[236.958554] Dynamic subtest vcs1: SUCCESS (0.025s)
[236.965960] Starting dynamic subtest: vecs0
[236.988801] Dynamic subtest vecs0: SUCCESS (0.030s)
[236.989529] Subtest u-submit-early-slice: SUCCESS (0.143s)
[237.313388] [053/131] (779s left) gem_pxp (regular-baseline-src-copy-readible)
[237.414964] Starting subtest: regular-baseline-src-copy-readible
[237.460402] Subtest regular-baseline-src-copy-readible: SUCCESS (0.047s)
[237.594909] [054/131] (778s left) gem_exec_balancer (full-late-pulse)
[237.634389] Starting subtest: full-late-pulse
[239.205576] Subtest full-late-pulse: SUCCESS (1.570s)
[239.406905] [055/131] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[239.507394] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[239.508747] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[239.623448] [056/131] (776s left) fbdev (read)
[239.664095] Starting subtest: read
[240.329872] Subtest read: SUCCESS (0.657s)
[240.398683] [057/131] (776s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[240.489433] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[240.490779] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[240.614019] [058/131] (776s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[240.699403] Starting subtest: multiplane-rotation-cropping-top
[266.767273] Subtest multiplane-rotation-cropping-top: SUCCESS (26.070s)
[266.908917] [059/131] (749s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[267.008709] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[267.010112] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[267.116368] [060/131] (749s left) i915_selftest (mock)
[268.127057] Starting subtest: mock
[268.134936] Starting dynamic subtest: sanitycheck
[268.845583] Dynamic subtest sanitycheck: SUCCESS (0.720s)
[268.857056] Starting dynamic subtest: shmem
[269.566347] Dynamic subtest shmem: SUCCESS (0.716s)
[269.576729] Starting dynamic subtest: fence
[277.401508] Dynamic subtest fence: SUCCESS (7.834s)
[277.410109] Starting dynamic subtest: scatterlist
[279.125594] Dynamic subtest scatterlist: SUCCESS (1.722s)
[279.134520] Starting dynamic subtest: syncmap
[282.072532] Dynamic subtest syncmap: SUCCESS (2.945s)
[282.081224] Starting dynamic subtest: uncore
[282.796458] Dynamic subtest uncore: SUCCESS (0.722s)
[282.806741] Starting dynamic subtest: ring
[283.517394] Dynamic subtest ring: SUCCESS (0.719s)
[283.527624] Starting dynamic subtest: engine
[284.249500] Dynamic subtest engine: SUCCESS (0.730s)
[284.259808] Starting dynamic subtest: timelines
[288.728480] Dynamic subtest timelines: SUCCESS (4.477s)
[288.737074] Starting dynamic subtest: requests
[291.446401] Dynamic subtest requests: SUCCESS (2.715s)
[291.457017] Starting dynamic subtest: objects
[292.298410] Dynamic subtest objects: SUCCESS (0.849s)
[292.312530] Starting dynamic subtest: phys
[293.141388] Dynamic subtest phys: SUCCESS (0.840s)
[293.150916] Starting dynamic subtest: dmabuf
[293.968398] Dynamic subtest dmabuf: SUCCESS (0.825s)
[293.978782] Starting dynamic subtest: vma
[301.424937] Dynamic subtest vma: SUCCESS (7.453s)
[301.433671] Starting dynamic subtest: evict
[303.117637] Dynamic subtest evict: SUCCESS (1.689s)
[303.131569] Starting dynamic subtest: gtt
[306.833316] Dynamic subtest gtt: SUCCESS (3.713s)
[306.843649] Starting dynamic subtest: hugepages
[307.875287] Dynamic subtest hugepages: SUCCESS (1.039s)
[307.883954] Starting dynamic subtest: memory_region
[311.196309] Dynamic subtest memory_region: SUCCESS (3.318s)
[311.197313] Subtest mock: SUCCESS (43.068s)
[311.227661] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[311.228460] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[311.232561] [061/131] (705s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[312.330731] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[312.388279] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[312.389742] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[312.392259] [062/131] (704s left) gem_render_copy_redux (normal)
[312.435342] Starting subtest: normal
[312.778895] Subtest normal: SUCCESS (0.335s)
[312.918347] [063/131] (703s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[312.953768] Starting subtest: basic-cpu-wc-noreloc
[312.957445] Subtest basic-cpu-wc-noreloc: SUCCESS (0.004s)
[313.089526] [064/131] (703s left) gem_ctx_param (invalid-set-no-zeromap)
[313.122844] Starting subtest: invalid-set-no-zeromap
[313.123542] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[313.216439] [065/131] (703s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[313.305743] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[313.307196] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[313.436213] [066/131] (703s left) i915_pm_rps (reset)
[313.473255] Starting subtest: reset
[318.038951] Subtest reset: SUCCESS (4.533s)
[318.162629] [067/131] (698s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[318.252374] Starting subtest: async-flip-with-page-flip-events-linear
[318.379781] Starting dynamic subtest: pipe-A-HDMI-A-1
[320.463982] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.075s)
[320.591989] Starting dynamic subtest: pipe-B-HDMI-A-1
[322.655203] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.061s)
[322.761405] Starting dynamic subtest: pipe-C-HDMI-A-1
[324.838907] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.075s)
[324.961059] Starting dynamic subtest: pipe-D-HDMI-A-1
[327.033793] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.070s)
[327.034756] Subtest async-flip-with-page-flip-events-linear: SUCCESS (8.771s)
[327.258698] [068/131] (689s left) perf_pmu (module-unload)
[327.305239] Starting subtest: module-unload
[330.107559] Subtest module-unload: FAIL (2.775s)
[330.130242] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[330.131043] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[330.132775] [069/131] (687s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[331.264366] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[331.267271] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[331.351312] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[331.352695] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[331.355056] [070/131] (685s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[331.391567] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[331.494475] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[331.586441] [071/131] (685s left) kms_cursor_crc (cursor-random-256x85)
[331.673898] Starting subtest: cursor-random-256x85
[331.688109] Starting dynamic subtest: pipe-A-HDMI-A-1
[332.913659] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.050s)
[332.923653] Starting dynamic subtest: pipe-D-HDMI-A-1
[334.743780] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.965s)
[334.744601] Subtest cursor-random-256x85: FAIL (3.068s)
[334.927109] [072/131] (682s left) kms_psr (psr-sprite-plane-move)
[335.020107] Subtest psr-sprite-plane-move: SKIP (0.000s)
[335.062789] [073/131] (682s left) kms_psr (fbc-pr-sprite-plane-onoff)
[335.148800] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[335.192531] [074/131] (682s left) kms_pm_rpm (pm-tiling)
[336.586502] Starting subtest: pm-tiling
[340.522977] Subtest pm-tiling: SUCCESS (3.936s)
[340.615532] [075/131] (676s left) gem_userptr_blits (invalid-null-pointer)
[340.658897] Starting subtest: invalid-null-pointer
[340.661112] Subtest invalid-null-pointer: SUCCESS (0.003s)
[340.814069] [076/131] (676s left) kms_content_protection (lic-type-1)
[340.902568] Starting subtest: lic-type-1
[340.914515] Subtest lic-type-1: SKIP (0.011s)
[341.029772] [077/131] (676s left) kms_atomic (plane-immutable-zpos)
[341.112822] Starting subtest: plane-immutable-zpos
[341.114597] Starting dynamic subtest: pipe-A-HDMI-A-1
[341.428699] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.314s)
[341.429514] Subtest plane-immutable-zpos: SUCCESS (0.316s)
[341.590853] [078/131] (675s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[341.677941] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[341.680594] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[341.768325] [079/131] (675s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[341.851787] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[341.852560] Starting dynamic subtest: pipe-A
[342.955652] Dynamic subtest pipe-A: SUCCESS (1.104s)
[342.967067] Starting dynamic subtest: pipe-B
[344.123428] Dynamic subtest pipe-B: SUCCESS (1.166s)
[344.134020] Starting dynamic subtest: pipe-C
[344.328240] Dynamic subtest pipe-C: SUCCESS (0.204s)
[344.346833] Starting dynamic subtest: pipe-D
[344.538003] Dynamic subtest pipe-D: SUCCESS (0.208s)
[344.538769] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.687s)
[344.786648] [080/131] (672s left) kms_psr (pr-sprite-mmap-cpu)
[344.876521] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[344.919605] [081/131] (672s left) gem_ctx_persistence (legacy-engines-cleanup)
[344.958679] Starting subtest: legacy-engines-cleanup
[344.959368] Starting dynamic subtest: render
[345.006595] Dynamic subtest render: SUCCESS (0.048s)
[345.027056] Starting dynamic subtest: bsd1
[345.056493] Dynamic subtest bsd1: SUCCESS (0.046s)
[345.075388] Starting dynamic subtest: bsd2
[345.099428] Dynamic subtest bsd2: SUCCESS (0.039s)
[345.116508] Starting dynamic subtest: blt
[345.147465] Dynamic subtest blt: SUCCESS (0.044s)
[345.165932] Starting dynamic subtest: vebox
[345.193872] Dynamic subtest vebox: SUCCESS (0.043s)
[345.194683] Subtest legacy-engines-cleanup: SUCCESS (0.237s)
[345.283440] [082/131] (672s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[345.369122] Starting subtest: cursor-tearing-framebuffer-change
[345.370922] Starting dynamic subtest: pipe-A-HDMI-A-1
[345.632522] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.261s)
[345.643501] Starting dynamic subtest: pipe-D-HDMI-A-1
[345.853808] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.218s)
[345.854572] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.484s)
[346.007019] [083/131] (671s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[346.095005] Starting subtest: 2x-cursor-vs-flip-atomic
[346.097262] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.003s)
[346.183742] [084/131] (671s left) kms_cursor_crc (cursor-random-32x10)
[346.273000] Starting subtest: cursor-random-32x10
[346.323421] Subtest cursor-random-32x10: SKIP (0.050s)
[346.434058] [085/131] (671s left) kms_psr (fbc-psr-primary-mmap-gtt)
[346.518977] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[346.563310] [086/131] (671s left) kms_big_fb (linear-8bpp-rotate-0)
[346.661619] Starting subtest: linear-8bpp-rotate-0
[347.772216] Subtest linear-8bpp-rotate-0: SUCCESS (1.110s)
[347.931253] [087/131] (669s left) gem_create (create-ext-cpu-access-sanity-check)
[348.074680] Starting subtest: create-ext-cpu-access-sanity-check
[348.076177] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s)
[348.172193] [088/131] (669s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[348.264568] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[349.375172] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.110s)
[349.547837] [089/131] (668s left) kms_pm_rpm (cursor-dpms)
[350.946005] Starting subtest: cursor-dpms
[363.153786] Subtest cursor-dpms: SUCCESS (12.207s)
[363.364921] [090/131] (654s left) gem_lmem_swapping (verify-random-ccs)
[363.403390] Subtest verify-random-ccs: SKIP (0.000s)
[363.445977] [091/131] (654s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[363.530855] Starting subtest: flip-vs-cursor-toggle
[371.920877] Subtest flip-vs-cursor-toggle: SUCCESS (8.388s)
[372.085383] [092/131] (646s left) gem_lmem_swapping (heavy-verify-multi)
[372.123762] Subtest heavy-verify-multi: SKIP (0.000s)
[372.172191] [093/131] (645s left) i915_pm_freq_api (freq-reset)
[372.207666] Subtest freq-reset: SKIP (0.000s)
[372.252013] [094/131] (645s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[372.346556] Starting subtest: y-tiled-64bpp-rotate-90
[372.387849] Subtest y-tiled-64bpp-rotate-90: SKIP (0.040s)
[372.529768] [095/131] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[372.617533] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[372.618885] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[372.747901] [096/131] (645s left) kms_dirtyfb (default-dirtyfb-ioctl)
[372.833879] Starting subtest: default-dirtyfb-ioctl
[372.835685] Starting dynamic subtest: A-HDMI-A-1
[374.056003] Dynamic subtest A-HDMI-A-1: SUCCESS (1.219s)
[374.056735] Subtest default-dirtyfb-ioctl: SUCCESS (1.221s)
[374.177095] [097/131] (644s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[374.270690] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[374.271389] Starting dynamic subtest: pipe-A
[374.733214] Dynamic subtest pipe-A: SUCCESS (0.462s)
[374.741809] Starting dynamic subtest: pipe-B
[375.184738] Dynamic subtest pipe-B: SUCCESS (0.450s)
[375.197198] Starting dynamic subtest: pipe-C
[375.619099] Dynamic subtest pipe-C: SUCCESS (0.433s)
[375.630477] Starting dynamic subtest: pipe-D
[376.054661] Dynamic subtest pipe-D: SUCCESS (0.434s)
[376.055374] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (1.784s)
[376.250674] [098/131] (642s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[376.337657] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[376.339451] Starting dynamic subtest: pipe-A-valid-mode
[376.389882] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[376.391361] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.052s)
[376.513895] [099/131] (641s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[376.599600] Starting subtest: 2x-cursor-vs-flip-legacy
[376.601313] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[376.687231] [100/131] (641s left) gem_readwrite (write-bad-handle)
[376.720652] Starting subtest: write-bad-handle
[376.721965] Subtest write-bad-handle: SUCCESS (0.000s)
[376.834416] [101/131] (641s left) gem_reg_read (timestamp-monotonic)
[376.866686] Starting subtest: timestamp-monotonic
[381.622206] Subtest timestamp-monotonic: SUCCESS (4.747s)
[381.692952] [102/131] (636s left) kms_psr (fbc-psr2-cursor-plane-move)
[381.780403] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[381.825740] [103/131] (636s left) kms_plane_lowres (tiling-x)
[381.911759] Starting subtest: tiling-x
[381.912546] Starting dynamic subtest: pipe-A-HDMI-A-1
[388.844167] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.935s)
[388.919867] Starting dynamic subtest: pipe-B-HDMI-A-1
[395.706386] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.799s)
[395.753710] Starting dynamic subtest: pipe-C-HDMI-A-1
[402.587887] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.843s)
[402.666144] Starting dynamic subtest: pipe-D-HDMI-A-1
[409.497659] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (6.842s)
[409.547950] Subtest tiling-x: SUCCESS (27.646s)
[409.723471] [104/131] (608s left) kms_force_connector_basic (force-edid)
[409.853964] Starting subtest: force-edid
[410.000831] Subtest force-edid: SUCCESS (0.147s)
[410.177897] [105/131] (608s left) kms_getfb (getfb-handle-zero)
[410.263228] Starting subtest: getfb-handle-zero
[410.263975] Subtest getfb-handle-zero: SUCCESS (0.000s)
[410.387382] [106/131] (608s left) perf (missing-sample-flags)
[410.481986] Starting subtest: missing-sample-flags
[410.482726] Subtest missing-sample-flags: SUCCESS (0.000s)
[410.526615] [107/131] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[410.616577] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[410.617928] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[410.736640] [108/131] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[410.827489] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[410.828830] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[410.944945] [109/131] (607s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[411.034727] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[411.036131] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[411.144875] [110/131] (607s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[411.238723] Starting subtest: 4-tiled-8bpp-rotate-180
[411.240043] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[411.370991] [111/131] (607s left) gem_exec_fence (syncobj-timeline-repeat)
[411.838517] Starting subtest: syncobj-timeline-repeat
[412.173404] Subtest syncobj-timeline-repeat: SUCCESS (0.337s)
[412.362419] [112/131] (606s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[412.455987] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[412.457447] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[412.560454] [113/131] (606s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[412.595562] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[412.596241] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[412.685871] [114/131] (606s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[412.776151] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[414.012097] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.237s)
[414.161010] [115/131] (604s left) gem_exec_schedule (lateslice)
[414.203581] Starting subtest: lateslice
[414.204251] Starting dynamic subtest: rcs0
[414.217800] Dynamic subtest rcs0: SUCCESS (0.015s)
[414.226812] Starting dynamic subtest: bcs0
[414.233776] Dynamic subtest bcs0: SUCCESS (0.015s)
[414.243303] Starting dynamic subtest: vcs0
[414.250879] Dynamic subtest vcs0: SUCCESS (0.016s)
[414.259907] Starting dynamic subtest: vcs1
[414.267755] Dynamic subtest vcs1: SUCCESS (0.016s)
[414.276830] Starting dynamic subtest: vecs0
[414.284802] Dynamic subtest vecs0: SUCCESS (0.016s)
[414.285577] Subtest lateslice: SUCCESS (0.083s)
[414.604496] [116/131] (604s left) kms_vblank (query-idle-hang)
[414.692775] Starting subtest: query-idle-hang
[414.694566] Starting dynamic subtest: pipe-A-HDMI-A-1
[429.228226] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.535s)
[429.238978] Starting dynamic subtest: pipe-D-HDMI-A-1
[443.040748] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.809s)
[443.041499] Subtest query-idle-hang: SUCCESS (28.350s)
[443.199847] [117/131] (575s left) syncobj_wait (reset-multiple-signaled)
[443.235554] Starting subtest: reset-multiple-signaled
[443.236255] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[443.327899] [118/131] (575s left) kms_flip_event_leak (basic)
[443.413762] Starting subtest: basic
[443.414503] Starting dynamic subtest: pipe-A-HDMI-A-1
[443.596348] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.182s)
[443.607488] Starting dynamic subtest: pipe-B-HDMI-A-1
[443.747004] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.148s)
[443.758265] Starting dynamic subtest: pipe-C-HDMI-A-1
[443.909298] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.160s)
[443.917906] Starting dynamic subtest: pipe-D-HDMI-A-1
[444.058558] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.147s)
[444.059288] Subtest basic: SUCCESS (0.646s)
[444.231196] [119/131] (575s left) gem_pwrite_snooped
[444.395227] [120/131] (574s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[444.432025] Starting subtest: yf-tiled-ccs-to-y-tiled
[444.432760] Starting dynamic subtest: smem
[444.534219] Dynamic subtest smem: SUCCESS (0.102s)
[444.534937] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.103s)
[444.737812] [121/131] (574s left) gem_ctx_shared (q-independent)
[444.778565] Starting subtest: Q-independent
[444.779260] Starting dynamic subtest: rcs0
[444.799921] Dynamic subtest rcs0: SUCCESS (0.021s)
[444.809371] Starting dynamic subtest: bcs0
[444.819913] Dynamic subtest bcs0: SUCCESS (0.019s)
[444.829331] Starting dynamic subtest: vcs0
[444.839892] Dynamic subtest vcs0: SUCCESS (0.019s)
[444.848958] Starting dynamic subtest: vcs1
[444.858726] Dynamic subtest vcs1: SUCCESS (0.018s)
[444.867971] Starting dynamic subtest: vecs0
[444.880240] Dynamic subtest vecs0: SUCCESS (0.020s)
[444.882568] Subtest Q-independent: SUCCESS (0.103s)
[445.088639] [122/131] (574s left) prime_mmap (test_userptr)
[445.120556] Starting subtest: test_userptr
[445.121218] Starting dynamic subtest: test_userptr-smem
[445.121904] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[445.122578] Subtest test_userptr: SUCCESS (0.001s)
[445.245335] [123/131] (574s left) kms_addfb_basic (bad-pitch-65536)
[445.279101] Starting subtest: bad-pitch-65536
[445.279845] Subtest bad-pitch-65536: SUCCESS (0.000s)
[445.456716] [124/131] (574s left) prime_self_import (basic-with_fd_dup)
[445.489124] Starting subtest: basic-with_fd_dup
[445.491658] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[445.621317] [125/131] (573s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[445.706755] Starting subtest: primary-y-tiled-reflect-x-0
[450.749059] Subtest primary-y-tiled-reflect-x-0: SUCCESS (5.042s)
[450.956242] [126/131] (568s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[451.043673] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[451.045421] Starting dynamic subtest: pipe-A-HDMI-A-1
[451.051897] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[451.059565] Starting dynamic subtest: pipe-B-HDMI-A-1
[451.066049] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[451.073482] Starting dynamic subtest: pipe-C-HDMI-A-1
[451.079931] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[451.087355] Starting dynamic subtest: pipe-D-HDMI-A-1
[451.093936] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[451.095232] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[451.290841] [127/131] (568s left) kms_addfb_basic (unused-modifier)
[451.324617] Starting subtest: unused-modifier
[451.325318] Subtest unused-modifier: SUCCESS (0.000s)
[451.495562] [128/131] (568s left) kms_vblank (wait-idle)
[451.578821] Starting subtest: wait-idle
[451.579718] Starting dynamic subtest: pipe-A-HDMI-A-1
[452.761283] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.181s)
[452.773229] Starting dynamic subtest: pipe-D-HDMI-A-1
[453.911927] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.146s)
[453.912666] Subtest wait-idle: SUCCESS (2.333s)
[454.081510] [129/131] (565s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[454.172694] Starting subtest: cursorA-vs-flipA-toggle
[465.023129] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.849s)
[465.169576] [130/131] (554s left) gen9_exec_parse (bb-start-far)
[465.210478] Subtest bb-start-far: SKIP (0.000s)
[465.254015] [131/131] (554s left) kms_addfb_basic (basic)
[465.286716] Starting subtest: basic
[465.287466] Subtest basic: SUCCESS (0.000s)
[465.461608] 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.