[57.234355] Initializing watchdogs
[57.234400]   /dev/watchdog0
[57.248237] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.252390] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.254399] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.257712] [001/130] (960s left) kms_chamelium_frames (hdmi-crc-fast)
[57.719139] Subtest hdmi-crc-fast: SKIP (0.000s)
[58.571885] [002/130] (959s left) gem_ctx_persistence (engines-hostile)
[58.644684] Starting subtest: engines-hostile
[58.647198] Starting dynamic subtest: rcs0
[58.768854] Dynamic subtest rcs0: SUCCESS (0.122s)
[58.778792] Starting dynamic subtest: bcs0
[58.875620] Dynamic subtest bcs0: SUCCESS (0.104s)
[58.885628] Starting dynamic subtest: vcs0
[58.982556] Dynamic subtest vcs0: SUCCESS (0.106s)
[58.992526] Starting dynamic subtest: vcs1
[59.076753] Dynamic subtest vcs1: SUCCESS (0.093s)
[59.085905] Starting dynamic subtest: vecs0
[59.157964] Dynamic subtest vecs0: SUCCESS (0.080s)
[59.166275] Starting dynamic subtest: ccs0
[59.289849] Dynamic subtest ccs0: SUCCESS (0.130s)
[59.292448] Subtest engines-hostile: SUCCESS (0.637s)
[59.359875] [003/130] (958s left) kms_rotation_crc (bad-pixel-format)
[59.465366] Starting subtest: bad-pixel-format
[59.469421] Subtest bad-pixel-format: SKIP (0.001s)
[59.532811] [004/130] (958s left) gem_create (create-clear)
[59.592202] Starting subtest: create-clear
[59.594430] Starting dynamic subtest: smem0
[93.125595] Dynamic subtest smem0: SUCCESS (33.435s)
[93.127861] Subtest create-clear: SUCCESS (33.436s)
[93.335884] [005/130] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[93.452664] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[93.456848] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[93.559508] [006/130] (924s left) kms_setmode (basic)
[93.615064] Starting subtest: basic
[93.975063] Starting dynamic subtest: pipe-A-eDP-1
[96.000804] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.020s)
[96.352455] Starting dynamic subtest: pipe-B-eDP-1
[98.421664] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.070s)
[98.730024] Subtest basic: SUCCESS (5.110s)
[99.551035] [007/130] (918s left) kms_prop_blob (invalid-set-prop)
[99.613939] Starting subtest: invalid-set-prop
[99.616035] Subtest invalid-set-prop: SUCCESS (0.000s)
[99.706601] [008/130] (918s left) kms_big_fb (x-tiled-addfb)
[99.813522] Starting subtest: x-tiled-addfb
[99.815576] Subtest x-tiled-addfb: SUCCESS (0.000s)
[99.917295] [009/130] (918s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[99.988427] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[100.059044] [010/130] (918s left) kms_vblank (wait-forked-busy-hang)
[100.151929] Starting subtest: wait-forked-busy-hang
[100.154317] Starting dynamic subtest: pipe-A-eDP-1
[127.651058] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.491s)
[127.663437] Starting dynamic subtest: pipe-D-eDP-1
[142.688682] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.035s)
[142.691148] Subtest wait-forked-busy-hang: SUCCESS (42.529s)
[143.508037] [011/130] (874s left) vgem_basic (bad-fence)
[143.602879] Starting subtest: bad-fence
[143.604896] Subtest bad-fence: SUCCESS (0.000s)
[143.652728] [FACT vgem_basic (bad-fence)] new: kernel.kmod_is_loaded.vgem: true
[143.655850] [012/130] (874s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[143.753104] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[143.757611] Starting dynamic subtest: pipe-A-default-mode
[146.412437] Dynamic subtest pipe-A-default-mode: SUCCESS (2.656s)
[146.414432] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.658s)
[147.195131] [013/130] (871s left) gem_userptr_blits (readonly-pwrite-unsync)
[147.269050] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[147.404810] [014/130] (870s left) syncobj_wait (wait-all-delayed-signal)
[147.454821] Starting subtest: wait-all-delayed-signal
[147.558975] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[147.626472] [015/130] (870s left) kms_dp_linktrain_fallback (dsc-fallback)
[147.713896] Starting subtest: dsc-fallback
[147.720718] Subtest dsc-fallback: SKIP (0.000s)
[147.776346] [016/130] (870s left) gem_render_copy_redux (flink-interruptible)
[147.837478] Starting subtest: flink-interruptible
[148.705789] Subtest flink-interruptible: SUCCESS (0.870s)
[148.846189] [017/130] (869s left) kms_invalid_mode (zero-vdisplay)
[148.938338] Starting subtest: zero-vdisplay
[148.940135] Starting dynamic subtest: pipe-A-eDP-1
[149.232151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[149.240068] Starting dynamic subtest: pipe-B-eDP-1
[149.241911] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[149.248158] Starting dynamic subtest: pipe-C-eDP-1
[149.250550] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[149.257078] Starting dynamic subtest: pipe-D-eDP-1
[149.259402] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[149.261693] Subtest zero-vdisplay: SUCCESS (0.300s)
[150.016035] [018/130] (868s left) perf_pmu (rc6-all-gts)
[150.056789] Starting subtest: rc6-all-gts
[156.437890] Subtest rc6-all-gts: SUCCESS (6.381s)
[157.340620] [019/130] (861s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[157.440758] Starting subtest: flip-primary-invalidate-overlay
[169.888446] Subtest flip-primary-invalidate-overlay: SUCCESS (12.449s)
[170.197528] [020/130] (848s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[170.310465] Starting subtest: y-tiled-8bpp-rotate-270
[170.315205] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[170.408210] [021/130] (848s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[170.506751] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[170.511247] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[170.610119] [022/130] (847s left) kms_cursor_crc (cursor-dpms)
[170.736825] Starting subtest: cursor-dpms
[170.739153] Starting dynamic subtest: pipe-A-eDP-1
[173.682272] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.942s)
[173.690483] Starting dynamic subtest: pipe-D-eDP-1
[177.215660] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.531s)
[177.218341] Subtest cursor-dpms: SUCCESS (6.475s)
[178.053614] [023/130] (840s left) gem_lmem_swapping (verify-random)
[178.096122] Subtest verify-random: SKIP (0.000s)
[178.135863] [024/130] (840s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[178.237632] Starting subtest: fbc-modesetfrombusy
[180.883862] Subtest fbc-modesetfrombusy: SUCCESS (2.651s)
[181.000174] [025/130] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[181.101837] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[181.105368] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[181.198654] [026/130] (837s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[181.267895] Starting subtest: stress-mm-invalidate-close-overlap
[183.417856] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[183.539628] [027/130] (835s left) gem_softpin (allocator-nopin-reserve)
[183.602746] Starting subtest: allocator-nopin-reserve
[183.689284] Subtest allocator-nopin-reserve: SUCCESS (0.086s)
[183.825754] [028/130] (834s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[183.925822] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[183.937778] Starting dynamic subtest: pipe-A-eDP-1
[183.958521] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[183.965233] Starting dynamic subtest: pipe-B-eDP-1
[183.985798] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[183.992179] Starting dynamic subtest: pipe-C-eDP-1
[184.013075] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[184.019630] Starting dynamic subtest: pipe-D-eDP-1
[184.041325] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[184.045723] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[186.156258] [029/130] (832s left) i915_hangman (hangcheck-unterminated)
[186.218155] Starting subtest: hangcheck-unterminated
[197.895823] Subtest hangcheck-unterminated: SUCCESS (11.675s)
[198.036539] [030/130] (820s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[198.147502] Starting subtest: 4-tiled-32bpp-rotate-180
[199.780721] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.633s)
[199.942498] [031/130] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[200.064911] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[200.068404] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[200.181079] [032/130] (818s left) kms_color (invalid-gamma-lut-sizes)
[200.276637] Starting subtest: invalid-gamma-lut-sizes
[200.278510] Starting dynamic subtest: pipe-A
[200.562454] Dynamic subtest pipe-A: SUCCESS (0.283s)
[200.570741] Starting dynamic subtest: pipe-B
[200.573075] Dynamic subtest pipe-B: SUCCESS (0.001s)
[200.580623] Starting dynamic subtest: pipe-C
[200.582887] Dynamic subtest pipe-C: SUCCESS (0.000s)
[200.590178] Starting dynamic subtest: pipe-D
[200.592055] Dynamic subtest pipe-D: SUCCESS (0.001s)
[200.593966] Subtest invalid-gamma-lut-sizes: SUCCESS (0.286s)
[201.370534] [033/130] (817s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[201.434776] Starting subtest: framebuffer-vs-set-tiling
[201.439924] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[201.583790] [034/130] (817s left) prime_vgem (busy)
[201.648124] Starting subtest: busy
[201.650392] Starting dynamic subtest: rcs0
[201.716836] Dynamic subtest rcs0: SUCCESS (0.068s)
[201.724644] Starting dynamic subtest: bcs0
[201.789110] Dynamic subtest bcs0: SUCCESS (0.072s)
[201.797200] Starting dynamic subtest: vcs0
[201.839973] Dynamic subtest vcs0: SUCCESS (0.051s)
[201.847495] Starting dynamic subtest: vcs1
[201.883209] Dynamic subtest vcs1: SUCCESS (0.043s)
[201.890569] Starting dynamic subtest: vecs0
[201.927131] Dynamic subtest vecs0: SUCCESS (0.043s)
[201.934299] Starting dynamic subtest: ccs0
[201.971092] Dynamic subtest ccs0: SUCCESS (0.043s)
[201.973378] Subtest busy: SUCCESS (0.323s)
[202.089314] [035/130] (816s left) gem_exec_schedule (smoketest-all)
[202.155458] Starting subtest: smoketest-all
[234.538863] Subtest smoketest-all: SUCCESS (32.340s)
[235.920453] [036/130] (783s left) kms_cursor_crc (cursor-onscreen-32x32)
[236.052345] Starting subtest: cursor-onscreen-32x32
[236.091811] Subtest cursor-onscreen-32x32: SKIP (0.033s)
[236.382871] [037/130] (782s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-different-formats)
[236.705024] Subtest fbc-dirty-rectangle-different-formats: SKIP (0.000s)
[236.753874] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-different-formats)] new: kernel.kmod_is_loaded.xe: true
[236.756958] [038/130] (782s left) perf (enable-disable)
[236.864950] Starting subtest: enable-disable
[236.866936] Starting dynamic subtest: 0-rcs0
[239.134055] Dynamic subtest 0-rcs0: SUCCESS (2.269s)
[239.145869] Starting dynamic subtest: 1-vcs0
[243.604306] Dynamic subtest 1-vcs0: SUCCESS (4.470s)
[243.606998] Subtest enable-disable: SUCCESS (6.739s)
[243.644976] [039/130] (775s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[243.744241] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[243.820271] [040/130] (775s left) syncobj_timeline (invalid-query-illegal-handle)
[243.878186] Starting subtest: invalid-query-illegal-handle
[243.880455] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[243.984734] [041/130] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[244.086717] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[244.091239] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[244.194498] [042/130] (775s left) kms_plane_scaling (planes-downscale-factor-0-75)
[244.291041] Starting subtest: planes-downscale-factor-0-75
[244.293395] Starting dynamic subtest: pipe-A
[244.311318] Dynamic subtest pipe-A: SKIP (0.015s)
[244.320978] Starting dynamic subtest: pipe-B
[244.337512] Dynamic subtest pipe-B: SKIP (0.026s)
[244.347464] Starting dynamic subtest: pipe-C
[244.365264] Dynamic subtest pipe-C: SKIP (0.028s)
[244.372911] Starting dynamic subtest: pipe-D
[244.391978] Dynamic subtest pipe-D: SKIP (0.025s)
[244.395847] Subtest planes-downscale-factor-0-75: SKIP (0.096s)
[244.486720] [043/130] (774s left) gem_exec_fence (syncobj-repeat)
[244.927478] Starting subtest: syncobj-repeat
[245.093352] Subtest syncobj-repeat: SUCCESS (0.164s)
[246.022470] [044/130] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[246.133305] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[246.137285] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[246.240844] [045/130] (773s left) gem_exec_params (rel-constants-invalid-ring)
[246.307217] Starting subtest: rel-constants-invalid-ring
[246.309675] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[246.418489] [046/130] (772s left) gen7_exec_parse (basic-allowed)
[246.487429] Subtest basic-allowed: SKIP (0.000s)
[246.575945] [047/130] (772s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[246.694484] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[246.698854] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[246.800350] [048/130] (772s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[246.912926] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[248.148815] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.238s)
[248.276751] [049/130] (771s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[248.380700] Starting subtest: extended-pageflip-modeset-hang-oldfb
[248.382835] Starting dynamic subtest: pipe-A
[256.278813] Dynamic subtest pipe-A: SUCCESS (7.895s)
[256.291211] Starting dynamic subtest: pipe-D
[264.869446] Dynamic subtest pipe-D: SUCCESS (8.586s)
[264.872093] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.488s)
[265.718754] [050/130] (753s left) kms_pm_rpm (drm-resources-equal)
[267.274589] Starting subtest: drm-resources-equal
[272.590883] Subtest drm-resources-equal: SUCCESS (5.317s)
[272.672539] [051/130] (746s left) gem_exec_schedule (independent)
[272.746404] Starting subtest: independent
[272.748298] Starting dynamic subtest: rcs0
[273.963404] Dynamic subtest rcs0: SUCCESS (1.224s)
[273.975015] Starting dynamic subtest: vcs0
[275.979409] Dynamic subtest vcs0: SUCCESS (2.015s)
[275.990241] Starting dynamic subtest: vcs1
[277.977060] Dynamic subtest vcs1: SUCCESS (1.996s)
[277.988365] Starting dynamic subtest: vecs0
[279.938604] Dynamic subtest vecs0: SUCCESS (1.961s)
[279.949917] Starting dynamic subtest: ccs0
[281.897618] Dynamic subtest ccs0: SUCCESS (1.958s)
[281.900549] Subtest independent: SUCCESS (9.159s)
[282.194119] [052/130] (737s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[282.388705] Starting subtest: cursor-rapid-movement-128x128
[282.393546] Starting dynamic subtest: pipe-A-eDP-1
[282.943926] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[282.973639] Starting dynamic subtest: pipe-D-eDP-1
[284.112847] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[284.115315] Subtest cursor-rapid-movement-128x128: SUCCESS (1.722s)
[284.951098] [053/130] (734s left) kms_flip (2x-flip-vs-modeset)
[285.057701] Starting subtest: 2x-flip-vs-modeset
[285.066066] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[285.141740] [054/130] (734s left) kms_psr (psr-sprite-mmap-gtt)
[285.239384] Starting subtest: psr-sprite-mmap-gtt
[285.241729] Starting dynamic subtest: eDP-1
[286.671634] Dynamic subtest eDP-1: SKIP (1.427s)
[286.676282] Subtest psr-sprite-mmap-gtt: SKIP (1.428s)
[286.864349] [055/130] (732s left) gem_flink_basic (flink-lifetime)
[286.919217] Starting subtest: flink-lifetime
[286.921059] Subtest flink-lifetime: SUCCESS (0.002s)
[287.023769] [056/130] (732s left) gem_ctx_persistence (smoketest)
[287.077675] Starting subtest: smoketest
[327.817064] Subtest smoketest: SUCCESS (40.737s)
[327.888072] [057/130] (691s left) kms_psr (fbc-psr2-cursor-render)
[327.994356] Starting subtest: fbc-psr2-cursor-render
[327.996740] Starting dynamic subtest: eDP-1
[328.000821] Dynamic subtest eDP-1: SKIP (0.000s)
[328.004834] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[328.061302] [058/130] (691s left) gem_exec_params (secure-non-master)
[328.121473] Starting subtest: secure-non-master
[328.126254] Subtest secure-non-master: SKIP (0.000s)
[328.233304] [059/130] (691s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[328.331057] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[328.333420] Starting dynamic subtest: pipe-A-eDP-1
[328.354254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[328.364308] Starting dynamic subtest: pipe-B-eDP-1
[328.384031] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[328.391370] Starting dynamic subtest: pipe-C-eDP-1
[328.410381] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[328.417504] Starting dynamic subtest: pipe-D-eDP-1
[328.437090] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[328.439059] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[330.520609] [060/130] (689s left) kms_psr (fbc-psr-primary-page-flip)
[330.626866] Starting subtest: fbc-psr-primary-page-flip
[330.629015] Starting dynamic subtest: eDP-1
[330.634229] Dynamic subtest eDP-1: SKIP (0.000s)
[330.639094] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[330.692915] [061/130] (689s left) gem_partial_pwrite_pread (reads-uncached)
[330.748186] Subtest reads-uncached: SKIP (0.000s)
[330.825181] [062/130] (689s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[335.878519] Starting subtest: pr-cursor-plane-update-sf
[335.882954] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[336.729481] [063/130] (683s left) kms_psr2_su (page_flip-nv12)
[336.781744] Subtest page_flip-NV12: SKIP (0.000s)
[336.833917] [064/130] (683s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[336.931873] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[337.943559] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.013s)
[338.093206] [065/130] (681s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[338.180801] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[338.183053] Starting dynamic subtest: pipe-A-default-mode
[338.474072] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[338.479069] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.290s)
[339.255643] [066/130] (680s left) kms_addfb_basic (bad-pitch-128)
[339.318725] Starting subtest: bad-pitch-128
[339.321234] Subtest bad-pitch-128: SUCCESS (0.000s)
[339.467571] [067/130] (680s left) kms_force_connector_basic (force-load-detect)
[339.551666] Starting subtest: force-load-detect
[339.556374] Subtest force-load-detect: SKIP (0.000s)
[339.670407] [068/130] (680s left) kms_atomic (plane-cursor-legacy)
[339.762991] Starting subtest: plane-cursor-legacy
[339.765381] Starting dynamic subtest: pipe-A-eDP-1
[340.121284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s)
[340.123673] Subtest plane-cursor-legacy: SUCCESS (0.357s)
[340.982036] [069/130] (679s left) gem_ppgtt (shrink-vs-evict-any)
[341.043484] Starting subtest: shrink-vs-evict-any
[346.904931] Subtest shrink-vs-evict-any: SUCCESS (5.860s)
[346.988074] [070/130] (673s left) drm_fdinfo (virtual-idle)
[347.027590] Starting subtest: virtual-idle
[350.111043] Subtest virtual-idle: SUCCESS (3.083s)
[350.182899] [071/130] (670s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[350.247113] Starting subtest: basic-batch-kernel-default-cmd
[350.251679] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[350.428907] [072/130] (669s left) gem_exec_reloc (basic-cpu-gtt)
[350.493780] Subtest basic-cpu-gtt: SKIP (0.000s)
[350.564628] [073/130] (669s left) api_intel_allocator (two-level-inception-interruptible)
[350.620752] Starting subtest: two-level-inception-interruptible
[356.032476] Subtest two-level-inception-interruptible: SUCCESS (5.414s)
[356.161330] [074/130] (664s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[356.226532] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[356.231044] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[356.408893] [075/130] (663s left) gem_exec_fence (basic-wait-all)
[356.481600] Starting subtest: basic-wait-all
[356.609243] Subtest basic-wait-all: SUCCESS (0.127s)
[359.058778] [076/130] (661s left) syncobj_wait (signal)
[359.125709] Starting subtest: signal
[359.128089] Subtest signal: SUCCESS (0.000s)
[359.241320] [077/130] (661s left) gem_mmap (basic-small-bo)
[359.302836] Subtest basic-small-bo: SKIP (0.000s)
[359.363648] [078/130] (661s left) dmabuf_sync_file (import-multiple-read-only)
[359.411142] Starting subtest: import-multiple-read-only
[359.415570] Subtest import-multiple-read-only: SUCCESS (0.005s)
[359.464348] [079/130] (661s left) syncobj_basic (test-valid-cycle)
[359.525824] Starting subtest: test-valid-cycle
[359.528173] Subtest test-valid-cycle: SUCCESS (0.000s)
[359.644800] [080/130] (660s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[359.755710] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[359.759914] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[359.880048] [081/130] (660s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[359.992680] Starting subtest: fbcpsr-suspend
[397.905226] Subtest fbcpsr-suspend: SUCCESS (7.674s)
[398.023359] [082/130] (652s left) gem_exec_balancer (sequential)
[398.090905] Starting subtest: sequential
[401.069207] Subtest sequential: SUCCESS (2.911s)
[401.353552] [083/130] (649s left) kms_psr (psr2-sprite-mmap-cpu)
[401.457049] Starting subtest: psr2-sprite-mmap-cpu
[401.459464] Starting dynamic subtest: eDP-1
[403.188918] Dynamic subtest eDP-1: SUCCESS (1.703s)
[403.191303] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.704s)
[404.077226] [084/130] (647s left) kms_hdmi_inject (inject-4k)
[404.412250] Starting subtest: inject-4k
[404.719907] Subtest inject-4k: SUCCESS (0.304s)
[405.255762] [085/130] (645s left) perf_pmu (busy-idle-check-all)
[405.300545] Starting subtest: busy-idle-check-all
[405.302688] Starting dynamic subtest: rcs0
[405.974270] Dynamic subtest rcs0: SUCCESS (0.667s)
[405.985357] Starting dynamic subtest: bcs0
[406.631263] Dynamic subtest bcs0: SUCCESS (0.649s)
[406.642893] Starting dynamic subtest: vcs0
[408.092629] Dynamic subtest vcs0: SUCCESS (1.445s)
[408.104788] Starting dynamic subtest: vcs1
[408.808466] Dynamic subtest vcs1: FAIL (0.635s)
[408.818723] Starting dynamic subtest: vecs0
[409.442926] Dynamic subtest vecs0: FAIL (0.624s)
[409.453194] Starting dynamic subtest: ccs0
[410.071929] Dynamic subtest ccs0: FAIL (0.623s)
[410.075537] Subtest busy-idle-check-all: FAIL (4.653s)
[410.154211] [086/130] (641s left) syncobj_wait (single-wait-for-submit-submitted)
[410.206024] Starting subtest: single-wait-for-submit-submitted
[410.310792] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[410.382787] [087/130] (640s left) gen9_exec_parse (bb-large)
[410.446269] Subtest bb-large: SKIP (0.000s)
[410.511025] [088/130] (640s left) gem_mmap_wc (write-prefaulted)
[410.574574] Subtest write-prefaulted: SKIP (0.000s)
[410.633552] [089/130] (640s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[410.737244] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[410.739639] Starting dynamic subtest: pipe-A-eDP-1
[411.015813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.242s)
[411.026976] Starting dynamic subtest: pipe-B-eDP-1
[412.314068] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.293s)
[412.325164] Starting dynamic subtest: pipe-C-eDP-1
[413.586793] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.264s)
[413.597991] Starting dynamic subtest: pipe-D-eDP-1
[414.787314] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s)
[414.789474] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.002s)
[415.980611] [090/130] (635s left) sysfs_defaults (readonly)
[416.051006] Starting subtest: readonly
[416.053293] Starting dynamic subtest: vecs0
[416.055246] Dynamic subtest vecs0: SUCCESS (0.000s)
[416.066079] Starting dynamic subtest: ccs0
[416.068253] Dynamic subtest ccs0: SUCCESS (0.000s)
[416.076609] Starting dynamic subtest: vcs0
[416.078834] Dynamic subtest vcs0: SUCCESS (0.000s)
[416.086970] Starting dynamic subtest: bcs0
[416.089278] Dynamic subtest bcs0: SUCCESS (0.000s)
[416.097526] Starting dynamic subtest: rcs0
[416.099774] Dynamic subtest rcs0: SUCCESS (0.000s)
[416.109162] Starting dynamic subtest: vcs1
[416.111519] Dynamic subtest vcs1: SUCCESS (0.000s)
[416.113687] Subtest readonly: SUCCESS (0.005s)
[416.158328] [091/130] (635s left) kms_plane_multiple (tiling-x)
[416.252501] Starting subtest: tiling-x
[416.254626] Starting dynamic subtest: pipe-A-eDP-1
[420.022701] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.758s)
[420.032008] Starting dynamic subtest: pipe-B-eDP-1
[424.616016] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.586s)
[424.625804] Starting dynamic subtest: pipe-C-eDP-1
[429.114393] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.499s)
[429.122946] Starting dynamic subtest: pipe-D-eDP-1
[433.597766] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.485s)
[433.599695] Subtest tiling-x: SUCCESS (17.333s)
[434.386034] [092/130] (617s left) gem_exec_whisper (basic-sync)
[434.457491] Starting subtest: basic-sync
[441.126683] Subtest basic-sync: SUCCESS (6.671s)
[441.303910] [093/130] (610s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[441.413069] Starting subtest: psr-rgb565-draw-render
[446.190692] Subtest psr-rgb565-draw-render: SUCCESS (4.783s)
[446.320767] [094/130] (605s left) kms_hdr (static-toggle-dpms)
[446.428483] Starting subtest: static-toggle-dpms
[446.435237] Subtest static-toggle-dpms: SKIP (0.000s)
[446.495417] [095/130] (605s left) perf (oa-formats)
[446.577416] Starting subtest: oa-formats
[446.580007] Starting dynamic subtest: 0-rcs0
[446.596476] Dynamic subtest 0-rcs0: SUCCESS (0.019s)
[446.606085] Starting dynamic subtest: 1-vcs0
[446.630005] Dynamic subtest 1-vcs0: SUCCESS (0.033s)
[446.632364] Subtest oa-formats: SUCCESS (0.053s)
[446.676484] [096/130] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[446.770545] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[446.774684] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[446.851192] [097/130] (604s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[446.975023] Starting subtest: cursor-vs-flip-atomic
[476.316779] Subtest cursor-vs-flip-atomic: SUCCESS (29.338s)
[477.178831] [098/130] (574s left) api_intel_bb (misplaced-blitter)
[477.235141] Starting subtest: misplaced-blitter
[477.240578] Subtest misplaced-blitter: SUCCESS (0.006s)
[477.362948] [099/130] (574s left) gem_create (create-ext-placement-sanity-check)
[477.532419] Starting subtest: create-ext-placement-sanity-check
[477.535409] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[477.649922] [100/130] (574s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[477.714047] Starting subtest: multi-wait-for-submit-available-submitted
[477.716392] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[477.819775] [101/130] (573s left) kms_pipe_crc_basic (suspend-read-crc)
[477.923582] Starting subtest: suspend-read-crc
[477.925814] Starting dynamic subtest: pipe-A-eDP-1
[495.402122] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.549s)
[495.412682] Starting dynamic subtest: pipe-B-eDP-1
[513.097641] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s)
[513.108356] Starting dynamic subtest: pipe-C-eDP-1
[531.059722] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.722s)
[531.069936] Starting dynamic subtest: pipe-D-eDP-1
[549.044973] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.730s)
[549.047603] Subtest suspend-read-crc: SUCCESS (10.761s)
[549.938037] [102/130] (562s left) gem_unref_active_buffers
[550.141430] [103/130] (562s left) gem_exec_balancer (persistence)
[550.406247] Starting subtest: persistence
[551.155626] Subtest persistence: SUCCESS (0.728s)
[551.262743] [104/130] (561s left) gem_mmap_gtt (fault-concurrent-y)
[551.314463] Subtest fault-concurrent-Y: SKIP (0.000s)
[551.373864] [105/130] (560s left) kms_pm_dc (dc5-retention-flops)
[552.476932] Starting subtest: dc5-retention-flops
[552.481470] Subtest dc5-retention-flops: SKIP (0.000s)
[552.542270] [106/130] (559s left) gem_exec_params (no-vebox)
[552.605829] Starting subtest: no-vebox
[552.608468] Subtest no-vebox: SUCCESS (0.002s)
[554.213847] [107/130] (558s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[554.318469] Starting subtest: crc-primary-basic-y-tiled-ccs
[554.320838] Starting dynamic subtest: pipe-A-eDP-1
[554.346487] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[554.358929] Starting dynamic subtest: pipe-B-eDP-1
[554.380156] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[554.388888] Starting dynamic subtest: pipe-C-eDP-1
[554.410712] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[554.419157] Starting dynamic subtest: pipe-D-eDP-1
[554.441923] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[554.446043] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[556.576433] [108/130] (555s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[556.693249] Starting subtest: yf-tiled-16bpp-rotate-90
[556.697718] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[556.808505] [109/130] (555s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[556.913317] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[559.929263] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.987s)
[560.038129] [110/130] (552s left) kms_chamelium_color (ctm-0-75)
[560.137745] Subtest ctm-0-75: SKIP (0.000s)
[560.177283] [111/130] (552s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[560.240993] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[560.349675] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[560.420765] [112/130] (552s left) i915_selftest (live)
[563.977075] Starting subtest: live
[563.979560] Starting dynamic subtest: sanitycheck
[568.407262] Dynamic subtest sanitycheck: SUCCESS (4.411s)
[568.416635] Starting dynamic subtest: uncore
[572.805875] Dynamic subtest uncore: SUCCESS (4.386s)
[572.815583] Starting dynamic subtest: workarounds
[576.011001] Dynamic subtest workarounds: SUCCESS (3.198s)
[576.020634] Starting dynamic subtest: gt_engines
[580.642525] Dynamic subtest gt_engines: SUCCESS (4.627s)
[580.652101] Starting dynamic subtest: gt_timelines
[595.069856] Dynamic subtest gt_timelines: SUCCESS (14.430s)
[595.079065] Starting dynamic subtest: gt_contexts
[599.429990] Dynamic subtest gt_contexts: SUCCESS (4.358s)
[599.440030] Starting dynamic subtest: gt_lrc
[605.722888] Dynamic subtest gt_lrc: SUCCESS (6.290s)
[605.732236] Starting dynamic subtest: gt_mocs
[608.759558] Dynamic subtest gt_mocs: SUCCESS (3.035s)
[608.766933] Starting dynamic subtest: gt_pm
[615.541320] Dynamic subtest gt_pm: SUCCESS (6.779s)
[615.551038] Starting dynamic subtest: gt_heartbeat
[619.867161] Dynamic subtest gt_heartbeat: SUCCESS (4.323s)
[619.877292] Starting dynamic subtest: gt_tlb
[628.066907] Dynamic subtest gt_tlb: SUCCESS (8.195s)
[628.076485] Starting dynamic subtest: requests
[641.469911] Dynamic subtest requests: SUCCESS (13.397s)
[641.480170] Starting dynamic subtest: migrate
[649.374690] Dynamic subtest migrate: SUCCESS (7.905s)
[649.384761] Starting dynamic subtest: active
[653.742621] Dynamic subtest active: SUCCESS (4.367s)
[653.756281] Starting dynamic subtest: objects
[658.504592] Dynamic subtest objects: SUCCESS (4.761s)
[658.514241] Starting dynamic subtest: mman
[663.422752] Dynamic subtest mman: SUCCESS (4.917s)
[663.432503] Starting dynamic subtest: dmabuf
[667.791926] Dynamic subtest dmabuf: SUCCESS (4.367s)
[667.801594] Starting dynamic subtest: vma
[672.153294] Dynamic subtest vma: SUCCESS (4.360s)
[672.162594] Starting dynamic subtest: coherency
[677.067664] Dynamic subtest coherency: SUCCESS (4.912s)
[677.077653] Starting dynamic subtest: gtt
[688.683582] Dynamic subtest gtt: SUCCESS (11.613s)
[688.693608] Starting dynamic subtest: gem
[697.032829] Dynamic subtest gem: SUCCESS (8.347s)
[697.042820] Starting dynamic subtest: evict
[702.396621] Dynamic subtest evict: SUCCESS (5.361s)
[702.406178] Starting dynamic subtest: hugepages
[713.333084] Dynamic subtest hugepages: SUCCESS (10.933s)
[713.342398] Starting dynamic subtest: gem_contexts
[741.071931] Dynamic subtest gem_contexts: SUCCESS (27.732s)
[741.081196] Starting dynamic subtest: client
[745.496870] Dynamic subtest client: SUCCESS (4.422s)
[745.507024] Starting dynamic subtest: gem_migrate
[749.858455] Dynamic subtest gem_migrate: SUCCESS (4.360s)
[749.867928] Starting dynamic subtest: reset
[752.642730] Dynamic subtest reset: SUCCESS (2.781s)
[752.652376] Starting dynamic subtest: memory_region
[756.956607] Dynamic subtest memory_region: SUCCESS (4.311s)
[756.969445] Starting dynamic subtest: hangcheck
[770.027982] Dynamic subtest hangcheck: SUCCESS (13.066s)
[770.039429] Starting dynamic subtest: execlists
[774.460685] Dynamic subtest execlists: SUCCESS (4.432s)
[774.470062] Starting dynamic subtest: ring_submission
[778.840639] Dynamic subtest ring_submission: SUCCESS (4.379s)
[778.849973] Starting dynamic subtest: perf
[781.708480] Dynamic subtest perf: SUCCESS (2.867s)
[781.718657] Starting dynamic subtest: slpc
[795.770804] Dynamic subtest slpc: SUCCESS (14.062s)
[795.778148] Starting dynamic subtest: guc
[799.686828] Dynamic subtest guc: SUCCESS (3.915s)
[799.696525] Starting dynamic subtest: guc_multi_lrc
[804.047190] Dynamic subtest guc_multi_lrc: SUCCESS (4.359s)
[804.056764] Starting dynamic subtest: guc_hang
[809.080121] Dynamic subtest guc_hang: SUCCESS (5.031s)
[809.089845] Starting dynamic subtest: late_gt_pm
[813.462659] Dynamic subtest late_gt_pm: SUCCESS (4.381s)
[813.465596] Subtest live: SUCCESS (249.433s)
[813.491312] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[813.492026] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[813.495031] [113/130] (299s left) gem_readwrite (beyond-eob)
[814.827175] Subtest beyond-EOB: SKIP (0.000s)
[814.886909] [FACT gem_readwrite (beyond-eob)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[814.888788] [FACT gem_readwrite (beyond-eob)] new: kernel.kmod_is_loaded.i915: true
[814.893058] [114/130] (297s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[815.005661] Starting subtest: basic-busy-flip-before-cursor-varying-size
[815.009657] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[815.097448] [115/130] (297s left) sw_sync (sync_multi_consumer_producer)
[815.135141] Starting subtest: sync_multi_consumer_producer
[815.482475] Subtest sync_multi_consumer_producer: SUCCESS (0.345s)
[815.535848] [116/130] (297s left) kms_rotation_crc (sprite-rotation-180)
[815.629439] Starting subtest: sprite-rotation-180
[820.518764] Subtest sprite-rotation-180: SUCCESS (4.888s)
[821.710158] [117/130] (291s left) api_intel_allocator (alloc-simple)
[821.765604] Starting subtest: alloc-simple
[821.767909] Subtest alloc-simple: SUCCESS (0.003s)
[821.872212] [118/130] (291s left) kms_atomic_transition (plane-all-transition-fencing)
[821.963626] Starting subtest: plane-all-transition-fencing
[821.965878] Starting dynamic subtest: pipe-A-eDP-1
[824.467478] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[824.754252] Starting dynamic subtest: pipe-B-eDP-1
[827.946640] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.199s)
[828.226475] Subtest plane-all-transition-fencing: SUCCESS (6.259s)
[829.052513] [119/130] (283s left) syncobj_timeline (invalid-signal-zero-handles)
[829.113564] Starting subtest: invalid-signal-zero-handles
[829.115722] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[829.208518] [120/130] (283s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[829.305359] Starting subtest: fbc-pr-sprite-mmap-cpu
[829.310035] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[829.371043] [121/130] (283s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[829.467154] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[829.471532] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[829.556057] [122/130] (283s left) prime_self_import (basic-with_one_bo_two_files)
[829.591658] Starting subtest: basic-with_one_bo_two_files
[829.604921] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[829.703958] [123/130] (283s left) gem_exec_schedule (pi-common)
[829.886783] Starting subtest: pi-common
[829.890162] Starting dynamic subtest: rcs0
[829.966151] Dynamic subtest rcs0: SUCCESS (0.082s)
[829.982114] Starting dynamic subtest: bcs0
[830.048912] Dynamic subtest bcs0: SUCCESS (0.082s)
[830.064768] Starting dynamic subtest: vcs0
[830.126646] Dynamic subtest vcs0: SUCCESS (0.077s)
[830.142842] Starting dynamic subtest: vcs1
[830.203809] Dynamic subtest vcs1: SUCCESS (0.076s)
[830.219657] Starting dynamic subtest: vecs0
[830.281285] Dynamic subtest vecs0: SUCCESS (0.076s)
[830.297200] Starting dynamic subtest: ccs0
[830.356352] Dynamic subtest ccs0: SUCCESS (0.074s)
[830.359341] Subtest pi-common: SUCCESS (0.473s)
[830.595836] [124/130] (282s left) gem_exec_reloc (basic-cpu)
[830.663660] Subtest basic-cpu: SKIP (0.000s)
[830.748283] [125/130] (282s left) i915_pm_rpm (system-suspend-execbuf)
[832.274786] Starting subtest: system-suspend-execbuf
[890.513555] Subtest system-suspend-execbuf: SUCCESS (43.108s)
[890.863815] [126/130] (237s left) kms_vblank (query-idle-hang)
[890.958793] Starting subtest: query-idle-hang
[890.961401] Starting dynamic subtest: pipe-A-eDP-1
[917.033119] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.070s)
[917.049174] Starting dynamic subtest: pipe-D-eDP-1
[942.049046] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.014s)
[942.051767] Subtest query-idle-hang: SUCCESS (51.088s)
[942.900604] [127/130] (185s left) gem_exec_schedule (thriceslice)
[942.985202] Starting subtest: thriceslice
[942.987983] Starting dynamic subtest: rcs0
[943.030294] Dynamic subtest rcs0: SUCCESS (0.054s)
[943.041275] Starting dynamic subtest: bcs0
[943.061036] Dynamic subtest bcs0: SUCCESS (0.029s)
[943.069430] Starting dynamic subtest: vcs0
[943.090972] Dynamic subtest vcs0: SUCCESS (0.029s)
[943.099278] Starting dynamic subtest: vcs1
[943.118644] Dynamic subtest vcs1: SUCCESS (0.027s)
[943.127289] Starting dynamic subtest: vecs0
[943.146534] Dynamic subtest vecs0: SUCCESS (0.028s)
[943.154919] Starting dynamic subtest: ccs0
[943.177255] Dynamic subtest ccs0: SUCCESS (0.030s)
[943.180121] Subtest thriceslice: SUCCESS (0.202s)
[944.344575] [128/130] (184s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[944.454291] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[949.603840] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.154s)
[949.713934] [129/130] (178s left) kms_lease (lease-invalid-plane)
[949.811985] Starting subtest: lease-invalid-plane
[949.814376] Starting dynamic subtest: pipe-A-eDP-1
[949.817086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[949.826144] Starting dynamic subtest: pipe-B-eDP-1
[949.829056] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[949.837203] Starting dynamic subtest: pipe-C-eDP-1
[949.840157] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[949.848762] Starting dynamic subtest: pipe-D-eDP-1
[949.851193] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[949.854076] Subtest lease-invalid-plane: SUCCESS (0.003s)
[949.886323] [130/130] (178s left) gem_softpin (zero)
[949.943363] Starting subtest: zero
[949.949031] Subtest zero: SUCCESS (0.005s)
[950.081318] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: gem_create
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_setmode
results: parsing output: 6/ for test: kms_prop_blob
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_vblank
results: parsing output: 10/ for test: vgem_basic
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_dp_linktrain_fallback
results: parsing output: 15/ for test: gem_render_copy_redux
results: parsing output: 16/ for test: kms_invalid_mode
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_psr_stress_test
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: i915_hangman
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_fbc_dirty_rect
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: gem_exec_fence
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: gen7_exec_parse
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_busy
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_flink_basic
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_partial_pwrite_pread
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_psr2_su
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_force_connector_basic
results: parsing output: 67/ for test: kms_atomic
results: parsing output: 68/ for test: gem_ppgtt
results: parsing output: 69/ for test: drm_fdinfo
results: parsing output: 70/ for test: gem_exec_flush
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: api_intel_allocator
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_mmap
results: parsing output: 77/ for test: dmabuf_sync_file
results: parsing output: 78/ for test: syncobj_basic
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_hdmi_inject
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: gen9_exec_parse
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: sysfs_defaults
results: parsing output: 90/ for test: kms_plane_multiple
results: parsing output: 91/ for test: gem_exec_whisper
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_hdr
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: gem_create
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_pipe_crc_basic
results: parsing output: 101/ for test: gem_unref_active_buffers
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_pm_dc
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_selftest
results: parsing output: 112/ for test: gem_readwrite
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: sw_sync
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: api_intel_allocator
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_self_import
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: gem_softpin
Done.