[105.585376] Initializing watchdogs
[105.585447]   /dev/watchdog0
[105.600649] [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]
[105.604980] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[105.607333] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[105.610899] [001/133] (960s left) gem_ctx_isolation (dirty-create)
[105.689527] Starting subtest: dirty-create
[105.691942] Starting dynamic subtest: rcs0
[105.918755] Dynamic subtest rcs0: SUCCESS (0.229s)
[105.928901] Starting dynamic subtest: bcs0
[106.186681] Dynamic subtest bcs0: SUCCESS (0.267s)
[106.198440] Starting dynamic subtest: vcs0
[106.419804] Dynamic subtest vcs0: SUCCESS (0.234s)
[106.430230] Starting dynamic subtest: vcs1
[108.481768] Dynamic subtest vcs1: SUCCESS (2.060s)
[108.492513] Starting dynamic subtest: vecs0
[110.465042] Dynamic subtest vecs0: SUCCESS (1.982s)
[110.474211] Starting dynamic subtest: ccs0
[112.533528] Dynamic subtest ccs0: SUCCESS (2.067s)
[112.536131] Subtest dirty-create: SUCCESS (6.842s)
[112.767796] [002/133] (953s left) api_intel_bb (add-remove-objects)
[112.821037] Starting subtest: add-remove-objects
[112.831525] Subtest add-remove-objects: SUCCESS (0.011s)
[112.962190] [003/133] (953s left) gen3_render_mixed_blits
[113.084496] [004/133] (953s left) kms_cursor_crc (cursor-onscreen-64x21)
[113.287591] Starting subtest: cursor-onscreen-64x21
[113.344829] Subtest cursor-onscreen-64x21: SKIP (0.052s)
[113.563639] [005/133] (952s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[113.669999] Starting subtest: fbc-psr2-cursor-plane-update-sf
[113.672062] Starting dynamic subtest: pipe-A-eDP-1
[113.771346] Dynamic subtest pipe-A-eDP-1: SKIP (0.105s)
[113.780475] Starting dynamic subtest: pipe-B-eDP-1
[114.884954] Dynamic subtest pipe-B-eDP-1: SKIP (1.112s)
[114.889762] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.218s)
[116.060976] [006/133] (950s left) kms_getfb (getfb2-accept-nv12)
[116.150802] Starting subtest: getfb2-accept-nv12
[116.153084] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[116.251414] [007/133] (950s left) core_sysfs (read-all-entries)
[116.309110] Starting subtest: read-all-entries
[116.311473] Subtest read-all-entries: SUCCESS (0.003s)
[116.405936] [008/133] (949s left) fbdev (read)
[116.448461] Starting subtest: read
[116.979232] Subtest read: SUCCESS (0.529s)
[117.052087] [009/133] (949s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[117.157979] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[117.160377] Starting dynamic subtest: pipe-A-eDP-1
[123.033065] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.881s)
[123.042531] Starting dynamic subtest: pipe-B-eDP-1
[129.684902] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.650s)
[129.687325] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.533s)
[130.558414] [010/133] (935s left) kms_pm_backlight (brightness-with-dpms)
[130.645899] Starting subtest: brightness-with-dpms
[130.718853] Starting dynamic subtest: eDP-1
[133.164415] Dynamic subtest eDP-1: SUCCESS (2.444s)
[133.166845] Subtest brightness-with-dpms: SUCCESS (2.519s)
[134.026994] [011/133] (932s left) kms_psr (fbc-psr2-basic)
[134.114683] Starting subtest: fbc-psr2-basic
[134.116644] Starting dynamic subtest: eDP-1
[134.120830] Dynamic subtest eDP-1: SKIP (0.000s)
[134.125523] Subtest fbc-psr2-basic: SKIP (0.000s)
[134.186612] [012/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[134.284068] Starting subtest: fbcpsr-2p-rte
[134.288564] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[134.381520] [013/133] (932s left) gem_readwrite (read-bad-handle)
[134.441066] Subtest read-bad-handle: SKIP (0.000s)
[134.500256] [014/133] (932s left) kms_flip (2x-absolute-wf_vblank)
[134.594331] Starting subtest: 2x-absolute-wf_vblank
[134.603573] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[134.693065] [015/133] (931s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[134.786637] Starting subtest: fbcpsr-slowdraw
[159.997043] Subtest fbcpsr-slowdraw: SUCCESS (25.215s)
[160.158925] [016/133] (906s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[160.255286] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[160.259492] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[160.323716] [017/133] (906s left) sw_sync (sync_random_merge)
[160.359068] Starting subtest: sync_random_merge
[160.401875] Subtest sync_random_merge: SUCCESS (0.044s)
[160.474873] [018/133] (906s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[160.541986] Starting subtest: legacy-engines-hostile-preempt
[160.544704] Starting dynamic subtest: render
[160.610265] Dynamic subtest render: SUCCESS (0.069s)
[160.620882] Starting dynamic subtest: bsd1
[162.276550] Dynamic subtest bsd1: SUCCESS (1.662s)
[162.286204] Starting dynamic subtest: bsd2
[164.287421] Dynamic subtest bsd2: SUCCESS (2.008s)
[164.297575] Starting dynamic subtest: blt
[164.339826] Dynamic subtest blt: SUCCESS (0.052s)
[164.350712] Starting dynamic subtest: vebox
[166.264109] Dynamic subtest vebox: SUCCESS (1.921s)
[166.266688] Subtest legacy-engines-hostile-preempt: SUCCESS (5.721s)
[166.345708] [019/133] (900s left) kms_cursor_edge_walk (128x128-top-edge)
[166.439509] Starting subtest: 128x128-top-edge
[166.441891] Starting dynamic subtest: pipe-A-eDP-1
[169.948694] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[169.957393] Starting dynamic subtest: pipe-D-eDP-1
[173.079499] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[173.081853] Subtest 128x128-top-edge: SUCCESS (6.641s)
[173.877695] [020/133] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[173.975138] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[173.979740] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[174.069553] [021/133] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[174.162622] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[174.166987] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[174.262554] [022/133] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[174.351378] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[174.355753] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[174.439278] [023/133] (892s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[174.525720] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[174.528077] Starting dynamic subtest: pipe-A-eDP-1
[174.550411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.560751] Starting dynamic subtest: pipe-B-eDP-1
[174.581383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[174.589068] Starting dynamic subtest: pipe-C-eDP-1
[174.609779] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[174.617289] Starting dynamic subtest: pipe-D-eDP-1
[174.638071] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[174.642316] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[176.772696] [024/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[176.866335] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[176.870774] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[176.960034] [025/133] (890s left) gem_exec_flush (basic-wb-ro-before-default)
[177.012518] Starting subtest: basic-wb-ro-before-default
[182.466349] Subtest basic-wb-ro-before-default: SUCCESS (5.454s)
[182.655266] [026/133] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[182.757788] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[190.262285] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.507s)
[190.385579] [027/133] (876s left) gem_exec_fence (syncobj-import)
[190.841721] Starting subtest: syncobj-import
[190.846456] Subtest syncobj-import: SUCCESS (0.005s)
[192.403128] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[192.406404] [028/133] (874s left) api_intel_bb (destroy-bb)
[192.454853] Starting subtest: destroy-bb
[192.466588] Subtest destroy-bb: SUCCESS (0.010s)
[192.579909] [029/133] (874s left) gem_exec_schedule (deep)
[192.763851] Starting subtest: deep
[192.766228] Starting dynamic subtest: rcs0
[199.001073] Dynamic subtest rcs0: SKIP (6.232s)
[199.020065] Starting dynamic subtest: vcs0
[209.156798] Dynamic subtest vcs0: SUCCESS (10.158s)
[209.171909] Starting dynamic subtest: vcs1
[219.844675] Dynamic subtest vcs1: SUCCESS (10.686s)
[219.856628] Starting dynamic subtest: vecs0
[230.562489] Dynamic subtest vecs0: SUCCESS (10.717s)
[230.575537] Starting dynamic subtest: ccs0
[242.818891] Dynamic subtest ccs0: SUCCESS (12.255s)
[242.821463] Subtest deep: SUCCESS (50.052s)
[244.007293] [030/133] (823s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[244.104993] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[244.107361] Starting dynamic subtest: pipe-A-eDP-1
[244.131132] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.142699] Starting dynamic subtest: pipe-B-eDP-1
[244.164764] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.173645] Starting dynamic subtest: pipe-C-eDP-1
[244.196617] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.206851] Starting dynamic subtest: pipe-D-eDP-1
[244.229295] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.233427] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[246.435635] [031/133] (820s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[246.564606] Starting subtest: basic-flip-after-cursor-legacy
[247.481390] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.915s)
[248.359456] [032/133] (819s left) sysfs_heartbeat_interval (idempotent)
[248.412704] Starting subtest: idempotent
[248.415137] Starting dynamic subtest: vecs0
[248.417538] Dynamic subtest vecs0: SUCCESS (0.001s)
[248.427575] Starting dynamic subtest: ccs0
[248.429711] Dynamic subtest ccs0: SUCCESS (0.001s)
[248.437909] Starting dynamic subtest: vcs0
[248.440067] Dynamic subtest vcs0: SUCCESS (0.000s)
[248.448283] Starting dynamic subtest: bcs0
[248.450410] Dynamic subtest bcs0: SUCCESS (0.001s)
[248.458565] Starting dynamic subtest: rcs0
[248.460650] Dynamic subtest rcs0: SUCCESS (0.001s)
[248.469073] Starting dynamic subtest: vcs1
[248.471163] Dynamic subtest vcs1: SUCCESS (0.000s)
[248.473218] Subtest idempotent: SUCCESS (0.007s)
[248.534791] [033/133] (818s left) gen9_exec_parse (bb-start-far)
[248.600494] Subtest bb-start-far: SKIP (0.000s)
[248.660535] [034/133] (818s left) kms_chamelium_color (ctm-0-50)
[248.752481] Subtest ctm-0-50: SKIP (0.000s)
[248.798441] [035/133] (818s left) gem_softpin (allocator-nopin-reserve)
[248.849902] Starting subtest: allocator-nopin-reserve
[248.931520] Subtest allocator-nopin-reserve: SUCCESS (0.081s)
[249.068862] [036/133] (818s left) kms_invalid_mode (bad-hsync-start)
[249.160596] Starting subtest: bad-hsync-start
[249.162944] Starting dynamic subtest: pipe-A-eDP-1
[250.212082] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.053s)
[250.221170] Starting dynamic subtest: pipe-B-eDP-1
[250.223302] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[250.231565] Starting dynamic subtest: pipe-C-eDP-1
[250.233561] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[250.241771] Starting dynamic subtest: pipe-D-eDP-1
[250.244109] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[250.246505] Subtest bad-hsync-start: SUCCESS (1.061s)
[250.572747] [037/133] (816s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[250.623071] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[250.625219] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[250.718434] [038/133] (816s left) gem_exec_reloc (basic-cpu-read-active)
[250.779714] Subtest basic-cpu-read-active: SKIP (0.000s)
[250.853473] [039/133] (816s left) perf (non-system-wide-paranoid)
[250.989261] Starting subtest: non-system-wide-paranoid
[251.016469] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[251.067812] [040/133] (816s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[251.162175] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[251.164493] Starting dynamic subtest: pipe-A-default-mode
[252.347365] Dynamic subtest pipe-A-default-mode: SKIP (1.182s)
[252.351607] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.183s)
[252.489314] [041/133] (815s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[252.592939] Starting subtest: blocking-absolute-wf_vblank-interruptible
[252.595237] Starting dynamic subtest: A-eDP1
[261.288566] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[261.297678] Starting dynamic subtest: B-eDP1
[270.016185] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[270.025106] Starting dynamic subtest: C-eDP1
[278.740836] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[278.750749] Starting dynamic subtest: D-eDP1
[287.469822] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[287.474656] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.880s)
[288.696468] [042/133] (779s left) kms_selftest (drm_plane_helper)
[288.731413] Starting subtest: drm_plane_helper
[288.794090] Starting dynamic subtest: drm_test_check_plane_state
[288.901155] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.107s)
[288.911494] Starting dynamic subtest: drm_test_check_invalid_plane_state
[288.992678] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.093s)
[288.995120] Subtest drm_plane_helper: SUCCESS (0.263s)
[289.150100] [043/133] (778s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[289.210695] Starting subtest: multi-wait-for-submit-unsubmitted
[289.320884] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[289.396405] [044/133] (778s left) gem_mmap (bad-object)
[289.449622] Subtest bad-object: SKIP (0.000s)
[289.514711] [045/133] (778s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[289.610056] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[289.614402] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[289.704461] [046/133] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[289.807984] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[296.970206] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.167s)
[297.130195] [047/133] (770s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[297.228585] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[297.230815] Starting dynamic subtest: pipe-A
[297.293853] Dynamic subtest pipe-A: SUCCESS (0.067s)
[297.304853] Starting dynamic subtest: pipe-B
[298.439997] Dynamic subtest pipe-B: SUCCESS (1.144s)
[298.451202] Starting dynamic subtest: pipe-C
[299.545652] Dynamic subtest pipe-C: SUCCESS (1.105s)
[299.555615] Starting dynamic subtest: pipe-D
[300.674660] Dynamic subtest pipe-D: SUCCESS (1.128s)
[300.676980] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.448s)
[301.836539] [048/133] (766s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[301.943248] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[308.493083] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.553s)
[308.595237] [049/133] (759s left) gem_exec_schedule (u-lateslice)
[308.668706] Starting subtest: u-lateslice
[308.670608] Starting dynamic subtest: rcs0
[308.680035] Dynamic subtest rcs0: SUCCESS (0.022s)
[308.688968] Starting dynamic subtest: bcs0
[308.697295] Dynamic subtest bcs0: SUCCESS (0.017s)
[308.706347] Starting dynamic subtest: vcs0
[308.716270] Dynamic subtest vcs0: SUCCESS (0.018s)
[308.725179] Starting dynamic subtest: vcs1
[308.735066] Dynamic subtest vcs1: SUCCESS (0.018s)
[308.743916] Starting dynamic subtest: vecs0
[308.753479] Dynamic subtest vecs0: SUCCESS (0.018s)
[308.762336] Starting dynamic subtest: ccs0
[308.771574] Dynamic subtest ccs0: SUCCESS (0.017s)
[308.773810] Subtest u-lateslice: SUCCESS (0.114s)
[310.365545] [050/133] (757s left) gem_exec_balancer (indices)
[310.419738] Starting subtest: indices
[313.243217] Subtest indices: SUCCESS (2.821s)
[313.543604] [051/133] (754s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[313.596151] Subtest tiled-to-untiled: SKIP (0.000s)
[313.696789] [052/133] (754s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[313.802369] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[318.349551] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.550s)
[319.541598] [053/133] (748s left) kms_content_protection (type1)
[319.669971] Starting subtest: type1
[319.674601] Subtest type1: SKIP (0.000s)
[319.796951] [054/133] (748s left) gem_exec_gttfill (basic)
[319.856314] Starting subtest: basic
[324.285460] Subtest basic: SUCCESS (4.427s)
[324.475289] [055/133] (743s left) i915_pm_rpm (gem-execbuf-stress)
[326.390286] Starting subtest: gem-execbuf-stress
[326.392613] Starting dynamic subtest: smem0
[339.309384] Dynamic subtest smem0: SUCCESS (12.920s)
[339.322406] Starting dynamic subtest: extra-wait-smem0
[401.454782] Dynamic subtest extra-wait-smem0: SUCCESS (62.139s)
[401.459056] Subtest gem-execbuf-stress: SUCCESS (75.065s)
[401.830253] [056/133] (666s left) kms_big_fb (linear-64bpp-rotate-270)
[401.937860] Starting subtest: linear-64bpp-rotate-270
[401.957065] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[402.083319] [057/133] (666s left) gem_render_copy_redux (interruptible)
[402.155280] Starting subtest: interruptible
[402.429191] Subtest interruptible: SUCCESS (0.274s)
[402.562160] [058/133] (665s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[402.658128] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[403.304735] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[403.475991] [059/133] (665s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[403.562802] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[403.565082] Starting dynamic subtest: pipe-A-eDP-1
[403.623835] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[403.634746] Starting dynamic subtest: pipe-B-eDP-1
[403.691667] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[403.705211] Starting dynamic subtest: pipe-C-eDP-1
[403.762531] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[403.772470] Starting dynamic subtest: pipe-D-eDP-1
[403.830987] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[403.835400] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[405.885178] [060/133] (662s left) kms_lease (master-vs-lease)
[405.977413] Starting subtest: master-vs-lease
[405.979689] Subtest master-vs-lease: SUCCESS (0.001s)
[406.092066] [061/133] (662s left) syncobj_timeline (32bits-limit)
[406.156456] Starting subtest: 32bits-limit
[406.158686] Subtest 32bits-limit: SUCCESS (0.001s)
[406.251824] [062/133] (662s left) kms_prime (d3hot)
[406.332649] Subtest D3hot: SKIP (0.000s)
[406.429126] [063/133] (662s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[406.520418] Starting subtest: psr-rgb565-draw-blt
[413.536490] Subtest psr-rgb565-draw-blt: SUCCESS (7.019s)
[413.682885] [064/133] (655s left) gem_exec_nop (basic-series)
[413.767142] Starting subtest: basic-series
[430.272056] Subtest basic-series: SUCCESS (16.511s)
[430.499562] [065/133] (638s left) perf_pmu (rc6-all-gts)
[430.540383] Starting subtest: rc6-all-gts
[436.917498] Subtest rc6-all-gts: SUCCESS (6.378s)
[437.776470] [066/133] (631s left) kms_flip (2x-plain-flip)
[437.889027] Starting subtest: 2x-plain-flip
[437.898572] Subtest 2x-plain-flip: SKIP (0.011s)
[437.978008] [067/133] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[438.080185] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[444.816755] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.737s)
[444.966955] [068/133] (623s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[445.080977] Starting subtest: x-tiled-64bpp-rotate-270
[445.104405] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[445.231185] [069/133] (623s left) kms_psr (pr-sprite-render)
[445.317373] Starting subtest: pr-sprite-render
[445.321927] Subtest pr-sprite-render: SKIP (0.000s)
[445.396040] [070/133] (623s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[445.770060] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[446.548434] [071/133] (622s left) gem_ctx_param (invalid-size-get)
[446.603744] Starting subtest: invalid-size-get
[446.606282] Subtest invalid-size-get: SUCCESS (0.001s)
[446.707562] [072/133] (622s left) kms_dp_link_training (uhbr-mst)
[446.793695] Starting subtest: uhbr-mst
[446.802212] Subtest uhbr-mst: SKIP (0.000s)
[446.866825] [073/133] (622s left) gem_mmap_gtt (fault-concurrent-y)
[446.919217] Subtest fault-concurrent-Y: SKIP (0.000s)
[446.979538] [074/133] (622s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[447.080481] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[447.084779] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[447.180586] [075/133] (622s left) kms_psr (fbc-psr-primary-render)
[447.270839] Starting subtest: fbc-psr-primary-render
[447.273044] Starting dynamic subtest: eDP-1
[447.277124] Dynamic subtest eDP-1: SKIP (0.000s)
[447.281151] Subtest fbc-psr-primary-render: SKIP (0.001s)
[447.344040] [076/133] (621s left) i915_drm_fdinfo (basics)
[447.385160] Starting subtest: basics
[447.387061] Subtest basics: SUCCESS (0.000s)
[447.454140] [077/133] (621s left) gem_partial_pwrite_pread (write-snoop)
[447.507804] Subtest write-snoop: SKIP (0.000s)
[447.580431] [078/133] (621s left) gem_pread (display)
[447.630758] Subtest display: SKIP (0.000s)
[447.691466] [079/133] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[447.789282] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[447.792599] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[447.888062] [080/133] (621s left) perf (gen12-group-exclusive-stream-ctx-handle)
[447.995130] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[448.021054] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s)
[448.064914] [081/133] (621s left) kms_atomic (plane-invalid-params)
[449.285091] Starting subtest: plane-invalid-params
[449.287384] Starting dynamic subtest: pipe-A-eDP-1
[449.682234] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[449.684869] Subtest plane-invalid-params: SUCCESS (0.400s)
[450.490091] [082/133] (619s left) kms_feature_discovery (display-3x)
[450.574972] Starting subtest: display-3x
[450.579444] Subtest display-3x: SKIP (0.000s)
[450.653153] [083/133] (618s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[450.761794] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[450.893783] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.134s)
[451.014199] [084/133] (618s left) kms_rotation_crc (cursor-rotation-180)
[451.110777] Starting subtest: cursor-rotation-180
[452.663107] Subtest cursor-rotation-180: SUCCESS (1.553s)
[453.865123] [085/133] (615s left) gem_exec_capture (capture)
[453.917240] Starting subtest: capture
[453.919586] Starting dynamic subtest: rcs0-smem
[454.762607] Dynamic subtest rcs0-smem: SUCCESS (0.842s)
[454.772517] Starting dynamic subtest: bcs0-smem
[456.092511] Dynamic subtest bcs0-smem: SUCCESS (1.331s)
[456.104475] Starting dynamic subtest: vcs0-smem
[456.921817] Dynamic subtest vcs0-smem: SUCCESS (0.826s)
[456.933779] Starting dynamic subtest: vcs1-smem
[458.246947] Dynamic subtest vcs1-smem: SUCCESS (1.325s)
[458.256348] Starting dynamic subtest: vecs0-smem
[459.139763] Dynamic subtest vecs0-smem: FAIL (0.830s)
[459.151072] Starting dynamic subtest: ccs0-smem
[460.397359] Dynamic subtest ccs0-smem: SUCCESS (1.319s)
[460.399640] Subtest capture: FAIL (6.477s)
[460.532415] [086/133] (609s left) i915_pm_rps (thresholds-park)
[460.601647] Starting subtest: thresholds-park
[460.606188] Subtest thresholds-park: SKIP (0.001s)
[460.679778] [087/133] (609s left) syncobj_timeline (invalid-transfer-bad-pad)
[460.745667] Starting subtest: invalid-transfer-bad-pad
[460.748043] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[460.853112] [088/133] (608s left) i915_hangman (gt-engine-hang)
[460.937387] Starting subtest: gt-engine-hang
[460.939811] Starting dynamic subtest: rcs0
[462.235690] Dynamic subtest rcs0: SUCCESS (1.297s)
[462.247562] Starting dynamic subtest: bcs0
[464.219632] Dynamic subtest bcs0: SUCCESS (1.981s)
[464.231032] Starting dynamic subtest: vcs0
[466.267235] Dynamic subtest vcs0: SUCCESS (2.044s)
[466.279868] Starting dynamic subtest: vcs1
[468.251227] Dynamic subtest vcs1: SUCCESS (1.981s)
[468.266557] Starting dynamic subtest: vecs0
[470.235293] Dynamic subtest vecs0: SUCCESS (1.981s)
[470.250162] Starting dynamic subtest: ccs0
[472.283496] Dynamic subtest ccs0: SUCCESS (2.045s)
[472.286485] Subtest gt-engine-hang: SUCCESS (11.348s)
[472.367047] [089/133] (597s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[472.464073] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[472.466423] Starting dynamic subtest: pipe-A-eDP-1
[472.489257] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[472.501351] Starting dynamic subtest: pipe-B-eDP-1
[472.522764] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[472.532595] Starting dynamic subtest: pipe-C-eDP-1
[472.554376] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[472.563842] Starting dynamic subtest: pipe-D-eDP-1
[472.585904] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[472.590246] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[474.704204] [090/133] (595s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[474.798754] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[474.801057] Starting dynamic subtest: pipe-A
[475.037050] Dynamic subtest pipe-A: SUCCESS (0.240s)
[475.047804] Starting dynamic subtest: pipe-B
[476.382087] Dynamic subtest pipe-B: SUCCESS (1.344s)
[476.395084] Starting dynamic subtest: pipe-C
[477.709762] Dynamic subtest pipe-C: SUCCESS (1.326s)
[477.727189] Starting dynamic subtest: pipe-D
[479.033204] Dynamic subtest pipe-D: SUCCESS (1.321s)
[479.035549] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.237s)
[480.220541] [091/133] (589s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[480.328654] Starting subtest: addfb25-yf-tiled-legacy
[480.331070] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[480.434366] [092/133] (589s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[480.535527] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[480.537651] Starting dynamic subtest: pipe-A-default-mode
[483.276762] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[483.279237] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.742s)
[484.114572] [093/133] (585s left) gem_mmap_offset (perf)
[484.175650] Starting subtest: perf
[484.178049] Starting dynamic subtest: smem0
[484.514501] Dynamic subtest smem0: SUCCESS (0.337s)
[484.516996] Subtest perf: SUCCESS (0.339s)
[484.615993] [094/133] (585s left) gem_exec_params (sol-reset-invalid)
[484.672760] Starting subtest: sol-reset-invalid
[484.675199] Subtest sol-reset-invalid: SUCCESS (0.002s)
[486.339448] [095/133] (583s left) syncobj_timeline (single-wait-signaled)
[486.395516] Starting subtest: single-wait-signaled
[486.399962] Subtest single-wait-signaled: SUCCESS (0.000s)
[486.488799] [096/133] (583s left) gem_madvise (dontneed-before-mmap)
[486.527084] Starting subtest: dontneed-before-mmap
[486.541260] Subtest dontneed-before-mmap: SUCCESS (0.013s)
[486.640744] [097/133] (583s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[486.694057] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[486.698332] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[486.883113] [098/133] (583s left) gem_eio (create)
[487.095147] Starting subtest: create
[487.391837] Subtest create: SUCCESS (0.296s)
[487.539248] [099/133] (582s left) kms_flip (2x-flip-vs-panning)
[487.624073] Starting subtest: 2x-flip-vs-panning
[487.634068] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[487.727442] [100/133] (582s left) gem_pxp (protected-raw-src-copy-not-readible)
[487.789985] Starting subtest: protected-raw-src-copy-not-readible
[487.848798] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[487.956338] [101/133] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[488.058837] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[488.062633] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.172131] [102/133] (582s left) prime_busy (before)
[488.231339] Starting subtest: before
[488.233417] Starting dynamic subtest: rcs0
[488.287738] Dynamic subtest rcs0: SUCCESS (0.055s)
[488.299825] Starting dynamic subtest: bcs0
[488.343159] Dynamic subtest bcs0: SUCCESS (0.055s)
[488.352973] Starting dynamic subtest: vcs0
[488.383496] Dynamic subtest vcs0: SUCCESS (0.039s)
[488.394964] Starting dynamic subtest: vcs1
[488.422457] Dynamic subtest vcs1: SUCCESS (0.037s)
[488.432074] Starting dynamic subtest: vecs0
[488.461816] Dynamic subtest vecs0: SUCCESS (0.039s)
[488.472961] Starting dynamic subtest: ccs0
[488.502542] Dynamic subtest ccs0: SUCCESS (0.039s)
[488.608846] Subtest before: SUCCESS (0.377s)
[488.685672] [103/133] (581s left) gem_linear_blits (normal)
[488.921396] Starting subtest: normal
[492.933791] Subtest normal: SUCCESS (4.015s)
[493.104642] [104/133] (577s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[493.263150] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[493.267317] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[493.334942] [105/133] (577s left) gem_exec_whisper (basic-sync)
[493.395568] Starting subtest: basic-sync
[501.876729] Subtest basic-sync: SUCCESS (8.478s)
[502.062663] [106/133] (568s left) kms_cursor_crc (cursor-sliding-128x42)
[502.307742] Starting subtest: cursor-sliding-128x42
[502.364456] Subtest cursor-sliding-128x42: SKIP (0.052s)
[502.569733] [107/133] (567s left) syncobj_timeline (host-signal-points)
[502.627838] Starting subtest: host-signal-points
[502.633256] Subtest host-signal-points: SUCCESS (0.004s)
[502.710908] [108/133] (567s left) gem_softpin (overlap)
[502.775806] Starting subtest: overlap
[503.726887] Subtest overlap: SUCCESS (0.949s)
[503.873599] [109/133] (566s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[504.260732] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[505.136687] [110/133] (565s left) kms_panel_fitting (atomic-fastset)
[505.241788] Starting subtest: atomic-fastset
[505.243987] Starting dynamic subtest: pipe-A-eDP-1
[505.379292] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[505.392208] Starting dynamic subtest: pipe-B-eDP-1
[506.604196] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.224s)
[506.618790] Starting dynamic subtest: pipe-C-eDP-1
[507.797976] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.193s)
[507.808831] Starting dynamic subtest: pipe-D-eDP-1
[509.023890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[509.026138] Subtest atomic-fastset: SUCCESS (3.784s)
[510.283783] [111/133] (560s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[510.398168] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[510.402777] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[510.493575] [112/133] (560s left) sw_sync (sync_busy_fork)
[510.536446] Starting subtest: sync_busy_fork
[511.548820] Subtest sync_busy_fork: SUCCESS (1.012s)
[511.615547] [113/133] (559s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[511.745278] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[511.750049] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[511.841011] [114/133] (559s left) kms_plane_alpha_blend (constant-alpha-max)
[511.929346] Starting subtest: constant-alpha-max
[512.217208] Starting dynamic subtest: pipe-A-eDP-1
[513.462778] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.243s)
[513.476026] Starting dynamic subtest: pipe-D-eDP-1
[515.246788] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.782s)
[515.249460] Subtest constant-alpha-max: SUCCESS (3.315s)
[516.069833] [115/133] (554s left) kms_color_pipeline (plane-lut1d)
[516.167796] Starting subtest: plane-lut1d
[516.335049] Starting dynamic subtest: pipe-A-plane-0
[516.524801] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[516.535357] Starting dynamic subtest: pipe-A-plane-1
[516.690809] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[516.702019] Starting dynamic subtest: pipe-A-plane-2
[516.868879] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[518.059317] Starting dynamic subtest: pipe-B-plane-0
[518.250563] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[518.266613] Starting dynamic subtest: pipe-B-plane-1
[518.439385] Dynamic subtest pipe-B-plane-1: SUCCESS (0.187s)
[518.450313] Starting dynamic subtest: pipe-B-plane-2
[518.629738] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[519.883910] Starting dynamic subtest: pipe-C-plane-0
[520.041126] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[520.054808] Starting dynamic subtest: pipe-C-plane-1
[520.209107] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[520.219854] Starting dynamic subtest: pipe-C-plane-2
[520.374835] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[521.634219] Starting dynamic subtest: pipe-D-plane-0
[521.791408] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[521.802365] Starting dynamic subtest: pipe-D-plane-1
[521.957691] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[521.968521] Starting dynamic subtest: pipe-D-plane-2
[522.124439] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[522.413844] Subtest plane-lut1d: SUCCESS (6.248s)
[523.275129] [116/133] (547s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[523.381228] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[527.107082] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.730s)
[528.300644] [117/133] (542s left) kms_plane_multiple (tiling-yf)
[528.391034] Starting subtest: tiling-yf
[528.395482] Subtest tiling-yf: SKIP (0.000s)
[528.475952] [118/133] (542s left) prime_mmap (test_dup)
[528.535071] Starting subtest: test_dup
[528.536947] Starting dynamic subtest: test_dup-smem
[528.566523] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[528.568883] Subtest test_dup: SUCCESS (0.035s)
[528.643341] [119/133] (542s left) gem_vm_create (create-ext)
[528.710294] Starting subtest: create-ext
[528.712282] Subtest create-ext: SUCCESS (0.005s)
[528.848183] [120/133] (542s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[528.959779] Starting subtest: cursorA-vs-flipB-legacy
[528.964327] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[529.117861] [121/133] (542s left) kms_properties (get_properties-sanity-non-atomic)
[529.209733] Starting subtest: get_properties-sanity-non-atomic
[529.211979] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[529.297896] [122/133] (541s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[529.392777] Starting subtest: multiplane-rotation-cropping-bottom
[546.897734] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.505s)
[547.014492] [123/133] (524s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[547.124767] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[551.990658] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.869s)
[553.184726] [124/133] (518s left) perf (invalid-remove-userspace-config)
[553.306986] Starting subtest: invalid-remove-userspace-config
[553.313043] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[553.359076] [125/133] (518s left) gem_exec_reloc (basic-write-cpu-active)
[553.418031] Subtest basic-write-cpu-active: SKIP (0.000s)
[553.490467] [126/133] (517s left) gem_exec_schedule (noreorder-priority)
[553.668691] Starting subtest: noreorder-priority
[553.671098] Starting dynamic subtest: rcs0
[554.814921] Dynamic subtest rcs0: SUCCESS (1.146s)
[554.826702] Starting dynamic subtest: vcs0
[556.281733] Dynamic subtest vcs0: SUCCESS (1.462s)
[556.294781] Starting dynamic subtest: vcs1
[558.243591] Dynamic subtest vcs1: SUCCESS (1.959s)
[558.256135] Starting dynamic subtest: vecs0
[560.312551] Dynamic subtest vecs0: SUCCESS (2.065s)
[560.332275] Starting dynamic subtest: ccs0
[561.455485] Dynamic subtest ccs0: SUCCESS (1.142s)
[561.457897] Subtest noreorder-priority: SUCCESS (7.787s)
[561.640605] [127/133] (509s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[561.745438] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[562.603601] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.860s)
[562.778860] [128/133] (508s left) gem_create (create-ext-cpu-access-sanity-check)
[562.951566] Starting subtest: create-ext-cpu-access-sanity-check
[562.956230] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[563.029417] [129/133] (508s left) kms_addfb_basic (clobberred-modifier)
[563.089826] Starting subtest: clobberred-modifier
[563.094518] Subtest clobberred-modifier: SKIP (0.000s)
[563.241297] [130/133] (508s left) syncobj_wait (wait-delayed-signal)
[563.292271] Starting subtest: wait-delayed-signal
[563.395070] Subtest wait-delayed-signal: SUCCESS (0.103s)
[563.477440] [131/133] (508s left) kms_psr (psr2-primary-page-flip)
[563.567511] Starting subtest: psr2-primary-page-flip
[563.569832] Starting dynamic subtest: eDP-1
[565.256678] Dynamic subtest eDP-1: SUCCESS (1.687s)
[565.258587] Subtest psr2-primary-page-flip: SUCCESS (1.688s)
[566.144620] [132/133] (505s left) gem_exec_store (cachelines)
[566.201346] Starting subtest: cachelines
[566.203826] Starting dynamic subtest: rcs0
[566.266800] Dynamic subtest rcs0: SUCCESS (0.066s)
[566.280041] Starting dynamic subtest: bcs0
[566.321163] Dynamic subtest bcs0: SUCCESS (0.053s)
[566.335890] Starting dynamic subtest: vcs0
[566.377673] Dynamic subtest vcs0: SUCCESS (0.053s)
[566.389541] Starting dynamic subtest: vcs1
[566.430263] Dynamic subtest vcs1: SUCCESS (0.051s)
[566.445491] Starting dynamic subtest: vecs0
[566.482313] Dynamic subtest vecs0: SUCCESS (0.049s)
[566.493095] Starting dynamic subtest: ccs0
[566.538606] Dynamic subtest ccs0: SUCCESS (0.054s)
[566.541214] Subtest cachelines: SUCCESS (0.339s)
[566.724914] [133/133] (504s left) kms_vblank (wait-busy-hang)
[566.811862] Starting subtest: wait-busy-hang
[566.814205] Starting dynamic subtest: pipe-A-eDP-1
[593.026407] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.212s)
[593.049528] Starting dynamic subtest: pipe-D-eDP-1
[608.058986] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.028s)
[608.061765] Subtest wait-busy-hang: SUCCESS (41.246s)
[608.899629] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_isolation
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: gen3_render_mixed_blits
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: core_sysfs
results: parsing output: 7/ for test: fbdev
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_pm_backlight
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_readwrite
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: sw_sync
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: kms_cursor_edge_walk
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: sysfs_heartbeat_interval
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: kms_chamelium_color
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: kms_invalid_mode
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_selftest
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: gem_set_tiling_vs_blt
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_content_protection
results: parsing output: 53/ for test: gem_exec_gttfill
results: parsing output: 54/ for test: i915_pm_rpm
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_render_copy_redux
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_prime
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_nop
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: gem_ctx_param
results: parsing output: 71/ for test: kms_dp_link_training
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: i915_drm_fdinfo
results: parsing output: 76/ for test: gem_partial_pwrite_pread
results: parsing output: 77/ for test: gem_pread
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_atomic
results: parsing output: 81/ for test: kms_feature_discovery
results: parsing output: 82/ for test: gem_pxp
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: gem_exec_capture
results: parsing output: 85/ for test: i915_pm_rps
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: i915_hangman
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: gem_mmap_offset
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_madvise
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gem_pxp
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: prime_busy
results: parsing output: 102/ for test: gem_linear_blits
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: kms_chamelium_frames
results: parsing output: 109/ for test: kms_panel_fitting
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: sw_sync
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_plane_alpha_blend
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane_multiple
results: parsing output: 117/ for test: prime_mmap
results: parsing output: 118/ for test: gem_vm_create
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_properties
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_exec_store
results: parsing output: 132/ for test: kms_vblank
Done.