[62.527357] Initializing watchdogs
[62.527429]   /dev/watchdog0
[62.548305] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.558563] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.562454] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.564907] [001/131] (960s left) kms_feature_discovery (dp-mst)
[64.572478] Starting subtest: dp-mst
[64.574195] Subtest dp-mst: SKIP (0.000s)
[64.718592] [002/131] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[66.791869] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[66.793497] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[66.927080] [003/131] (956s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[69.171597] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[69.173271] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[69.325456] [004/131] (953s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[71.429247] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[71.521954] [005/131] (951s left) syncobj_wait (single-wait-all-submitted)
[71.599064] Starting subtest: single-wait-all-submitted
[71.714711] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[71.849101] [006/131] (951s left) kms_flip (2x-flip-vs-dpms)
[73.856874] Starting subtest: 2x-flip-vs-dpms
[73.869409] Subtest 2x-flip-vs-dpms: SKIP (0.013s)
[74.010679] [007/131] (949s left) gem_pxp (verify-pxp-stale-buf-execution)
[76.646120] Starting subtest: verify-pxp-stale-buf-execution
[76.649600] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[76.784164] [008/131] (946s left) fbdev (info)
[76.827261] Starting subtest: info
[76.828197] Subtest info: SUCCESS (0.000s)
[77.023712] [009/131] (946s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[79.029531] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[79.082358] [010/131] (944s left) kms_cursor_edge_walk (256x256-top-bottom)
[81.085993] Starting subtest: 256x256-top-bottom
[81.086969] Starting dynamic subtest: pipe-A-HDMI-A-3
[84.486844] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.400s)
[84.497836] Starting dynamic subtest: pipe-D-HDMI-A-3
[87.707110] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.218s)
[87.708155] Subtest 256x256-top-bottom: SUCCESS (6.621s)
[87.897566] [011/131] (935s left) gem_render_copy (yf-tiled-to-vebox-linear)
[87.973476] Starting subtest: yf-tiled-to-vebox-linear
[87.975592] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[88.229711] [012/131] (935s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[90.230187] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[90.231090] Starting dynamic subtest: pipe-A-valid-mode
[91.076140] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.845s)
[91.076952] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (0.846s)
[91.319288] [013/131] (932s left) kms_pm_rpm (fences)
[96.007560] Starting subtest: fences
[96.010029] Subtest fences: SKIP (0.000s)
[97.182608] [014/131] (926s left) kms_pm_rpm (pm-caching)
[102.004148] Starting subtest: pm-caching
[102.007640] Subtest pm-caching: SKIP (0.000s)
[103.257392] [015/131] (920s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[105.268961] Starting subtest: fbc-rgb565-draw-pwrite
[108.068931] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.800s)
[108.294702] [016/131] (915s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[110.302036] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[110.303813] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[110.518657] [017/131] (913s left) perf (invalid-oa-metric-set-id)
[110.934148] Starting subtest: invalid-oa-metric-set-id
[110.952419] Subtest invalid-oa-metric-set-id: SUCCESS (0.018s)
[111.006538] [018/131] (913s left) perf (unprivileged-single-ctx-counters)
[111.219303] Starting subtest: unprivileged-single-ctx-counters
[111.221150] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[111.273562] [019/131] (912s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[113.276485] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[113.278178] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[113.513584] [020/131] (910s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[115.528989] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[115.530647] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[115.728876] [021/131] (908s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[117.744198] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[117.745133] Starting dynamic subtest: pipe-A-valid-mode
[117.793181] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s)
[117.794990] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.049s)
[118.007148] [022/131] (906s left) kms_getfb (getfb-repeated-different-handles)
[120.011009] Starting subtest: getfb-repeated-different-handles
[120.011943] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[120.189542] [023/131] (904s left) i915_query (query-topology-coherent-slice-mask)
[120.297007] Starting subtest: query-topology-coherent-slice-mask
[120.298792] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[120.463602] [024/131] (904s left) gem_softpin (evict-active)
[120.537594] Starting subtest: evict-active
[120.559446] Subtest evict-active: SUCCESS (0.022s)
[120.762743] [025/131] (904s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[122.773109] Starting subtest: x-tiled-8bpp-rotate-180
[124.408086] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.634s)
[124.595702] [026/131] (900s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[126.608135] Starting subtest: stress-xrgb8888-yftiled
[126.609972] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[126.698470] [027/131] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[128.727086] Starting subtest: addfb25-yf-tiled-legacy
[128.727988] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[128.937909] [028/131] (896s left) gem_exec_reloc (basic-wc-cpu-active)
[129.030637] Subtest basic-wc-cpu-active: SKIP (0.000s)
[129.130076] [029/131] (895s left) gem_exec_gttfill (engines)
[129.209646] Starting subtest: engines
[129.210528] Starting dynamic subtest: rcs0
[155.001519] Dynamic subtest rcs0: SUCCESS (25.791s)
[155.009515] Starting dynamic subtest: bcs0
[181.036557] Dynamic subtest bcs0: SUCCESS (26.034s)
[181.044282] Starting dynamic subtest: vcs0
[207.040991] Dynamic subtest vcs0: SUCCESS (26.004s)
[207.048944] Starting dynamic subtest: vcs1
[233.078539] Dynamic subtest vcs1: SUCCESS (26.037s)
[233.086503] Starting dynamic subtest: vecs0
[259.012729] Dynamic subtest vecs0: SUCCESS (25.934s)
[259.020593] Starting dynamic subtest: vecs1
[284.991820] Dynamic subtest vecs1: SUCCESS (25.972s)
[285.000124] Starting dynamic subtest: ccs0
[310.995468] Dynamic subtest ccs0: SUCCESS (26.009s)
[310.996418] Subtest engines: SUCCESS (181.783s)
[311.272282] [030/131] (713s left) syncobj_wait (invalid-reset-one-illegal-handle)
[311.374584] Starting subtest: invalid-reset-one-illegal-handle
[311.375440] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[311.468965] [031/131] (713s left) i915_hangman (error-state-basic)
[311.559261] Starting subtest: error-state-basic
[311.761070] Subtest error-state-basic: SUCCESS (0.201s)
[311.879597] [032/131] (713s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[313.886918] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[313.887851] Starting dynamic subtest: pipe-A-HDMI-A-3
[313.896205] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[313.904538] Starting dynamic subtest: pipe-B-HDMI-A-3
[313.913291] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[313.921531] Starting dynamic subtest: pipe-C-HDMI-A-3
[313.930105] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[313.938163] Starting dynamic subtest: pipe-D-HDMI-A-3
[313.948412] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[313.950156] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[314.148204] [033/131] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[316.153197] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[316.154898] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[316.392166] [034/131] (708s left) prime_vgem (wait)
[316.566480] Starting subtest: wait
[316.567570] Starting dynamic subtest: rcs0
[316.629448] Dynamic subtest rcs0: SUCCESS (0.063s)
[316.639228] Starting dynamic subtest: bcs0
[316.685455] Dynamic subtest bcs0: SUCCESS (0.056s)
[316.696580] Starting dynamic subtest: vcs0
[316.727089] Dynamic subtest vcs0: SUCCESS (0.041s)
[316.746679] Starting dynamic subtest: vcs1
[316.771272] Dynamic subtest vcs1: SUCCESS (0.044s)
[316.791605] Starting dynamic subtest: vecs0
[316.815068] Dynamic subtest vecs0: SUCCESS (0.043s)
[316.835257] Starting dynamic subtest: vecs1
[316.858030] Dynamic subtest vecs1: SUCCESS (0.042s)
[316.878187] Starting dynamic subtest: ccs0
[316.901411] Dynamic subtest ccs0: SUCCESS (0.043s)
[316.902489] Subtest wait: SUCCESS (0.335s)
[317.118800] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[317.120448] [035/131] (708s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[319.144430] Starting subtest: yf-tiled-8bpp-rotate-90
[319.146213] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[319.328955] [036/131] (706s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[321.365169] Starting subtest: y-tiled-32bpp-rotate-0
[321.367159] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[321.494457] [037/131] (704s left) kms_force_connector_basic (prune-stale-modes)
[321.672146] Starting subtest: prune-stale-modes
[321.695158] Subtest prune-stale-modes: SUCCESS (0.023s)
[323.893891] [038/131] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[325.934227] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[325.935995] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[326.147461] [039/131] (699s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[328.171875] Starting subtest: fbc-1p-pri-indfb-multidraw
[338.345799] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (10.174s)
[338.556724] [040/131] (687s left) vgem_basic (bad-handle)
[338.612349] Starting subtest: bad-handle
[338.613369] Subtest bad-handle: SUCCESS (0.000s)
[338.731119] [041/131] (687s left) kms_selftest (drm_cmdline_parser)
[338.779506] Starting subtest: drm_cmdline_parser
[338.789106] Starting dynamic subtest: drm_test_cmdline_force_d_only
[338.870979] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.080s)
[338.891190] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[338.940622] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.070s)
[338.959502] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[339.022227] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.078s)
[339.059479] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[339.105706] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.082s)
[339.139167] Starting dynamic subtest: drm_test_cmdline_force_e_only
[339.174520] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.070s)
[339.197130] Starting dynamic subtest: drm_test_cmdline_res
[339.250654] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.074s)
[339.287104] Starting dynamic subtest: drm_test_cmdline_res_vesa
[339.320534] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.071s)
[339.340260] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[339.400965] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.078s)
[339.438723] Starting dynamic subtest: drm_test_cmdline_res_rblank
[339.476165] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.075s)
[339.510534] Starting dynamic subtest: drm_test_cmdline_res_bpp
[339.572048] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.092s)
[339.609424] Starting dynamic subtest: drm_test_cmdline_res_refresh
[339.648708] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.077s)
[339.683210] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[339.714277] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.066s)
[339.738547] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[339.811564] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.096s)
[339.849587] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[339.888303] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.075s)
[339.913455] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[339.975116] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.084s)
[340.008114] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[340.051921] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.078s)
[340.084925] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[340.120862] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.068s)
[340.150874] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[340.191278] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.069s)
[340.216156] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[340.263142] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.072s)
[340.300569] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[340.343439] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.078s)
[340.380120] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[340.424376] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.079s)
[340.458073] Starting dynamic subtest: drm_test_cmdline_name
[340.491679] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.068s)
[340.514846] Starting dynamic subtest: drm_test_cmdline_name_bpp
[340.567938] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.073s)
[340.601713] Starting dynamic subtest: drm_test_cmdline_name_option
[340.640792] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.072s)
[340.669516] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[340.727396] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.087s)
[340.765519] Starting dynamic subtest: drm_test_cmdline_rotate_0
[340.798566] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.070s)
[340.815479] Starting dynamic subtest: drm_test_cmdline_rotate_90
[340.869610] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.070s)
[340.905270] Starting dynamic subtest: drm_test_cmdline_rotate_180
[340.940236] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.069s)
[340.976745] Starting dynamic subtest: drm_test_cmdline_rotate_270
[341.027639] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.085s)
[341.037944] Starting dynamic subtest: drm_test_cmdline_hmirror
[341.095566] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.068s)
[341.120094] Starting dynamic subtest: drm_test_cmdline_vmirror
[341.175587] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.079s)
[341.212492] Starting dynamic subtest: drm_test_cmdline_margin_options
[341.252667] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.076s)
[341.287470] Starting dynamic subtest: drm_test_cmdline_multiple_options
[341.339350] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.085s)
[341.350375] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[341.428501] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.088s)
[341.466374] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[341.515906] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.084s)
[341.553720] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[341.600052] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.076s)
[341.633588] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[341.664575] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.073s)
[341.684025] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[341.743492] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.078s)
[341.783610] Starting dynamic subtest: drm_test_cmdline_invalid
[341.832293] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.088s)
[341.861777] Starting dynamic subtest: drm_test_cmdline_tv_options
[341.930539] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.097s)
[341.932331] Subtest drm_cmdline_parser: SUCCESS (3.151s)
[342.157848] [042/131] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[344.169956] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[344.171689] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[344.362213] [043/131] (681s left) kms_psr (psr2-no-drrs)
[346.394337] Subtest psr2-no-drrs: SKIP (0.000s)
[346.452520] [044/131] (679s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[348.466876] Starting subtest: fbcpsr-rgb565-draw-blt
[348.468567] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[348.716778] [045/131] (677s left) gem_exec_balancer (full)
[348.805748] Starting subtest: full
[350.754537] Subtest full: SUCCESS (1.948s)
[351.161621] [046/131] (675s left) gem_softpin (softpin)
[351.250980] Starting subtest: softpin
[383.590822] Subtest softpin: SUCCESS (32.338s)
[383.730581] [047/131] (642s left) perf (oa-exponents)
[383.958130] Starting subtest: oa-exponents
[383.959102] Starting dynamic subtest: 0-rcs0
[386.234753] Dynamic subtest 0-rcs0: SUCCESS (2.276s)
[386.235631] Subtest oa-exponents: SUCCESS (2.277s)
[386.298831] [048/131] (640s left) syncobj_timeline (reset-unsignaled)
[386.398070] Starting subtest: reset-unsignaled
[386.398989] Subtest reset-unsignaled: SUCCESS (0.000s)
[386.572432] [049/131] (639s left) kms_lease (possible-crtcs-filtering)
[388.584218] Starting subtest: possible-crtcs-filtering
[388.592612] Subtest possible-crtcs-filtering: SUCCESS (0.009s)
[388.788080] [050/131] (637s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[390.817176] Starting subtest: x-tiled-16bpp-rotate-270
[390.882016] Subtest x-tiled-16bpp-rotate-270: SKIP (0.063s)
[391.115225] [051/131] (635s left) kms_atomic_transition (plane-toggle-modeset-transition)
[393.127234] Starting subtest: plane-toggle-modeset-transition
[393.129378] Starting dynamic subtest: pipe-A-HDMI-A-3
[393.931887] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.802s)
[393.951649] Starting dynamic subtest: pipe-B-HDMI-A-3
[394.519858] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.581s)
[394.523874] Subtest plane-toggle-modeset-transition: SUCCESS (1.394s)
[394.718642] [052/131] (632s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[396.734204] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[397.007524] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.273s)
[397.280688] [053/131] (629s left) gem_exec_balancer (parallel-out-fence)
[397.625363] Starting subtest: parallel-out-fence
[399.812748] Subtest parallel-out-fence: SUCCESS (2.188s)
[399.978370] [054/131] (626s left) gem_mmap_wc (write-read)
[400.057201] Subtest write-read: SKIP (0.000s)
[400.155137] [055/131] (626s left) gem_exec_fence (submit67)
[400.363863] Starting subtest: submit67
[400.366211] Subtest submit67: SKIP (0.000s)
[401.074493] [056/131] (625s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[403.083353] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[403.084257] Starting dynamic subtest: pipe-A-HDMI-A-3
[403.092978] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[403.103058] Starting dynamic subtest: pipe-B-HDMI-A-3
[403.112177] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[403.122009] Starting dynamic subtest: pipe-C-HDMI-A-3
[403.130447] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[403.140356] Starting dynamic subtest: pipe-D-HDMI-A-3
[403.149857] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[403.151531] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[403.371679] [057/131] (623s left) kms_plane_lowres (tiling-4)
[405.385277] Starting subtest: tiling-4
[405.386250] Starting dynamic subtest: pipe-A-HDMI-A-3
[414.960098] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (9.573s)
[415.041049] Starting dynamic subtest: pipe-B-HDMI-A-3
[423.475905] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (8.443s)
[423.557447] Starting dynamic subtest: pipe-C-HDMI-A-3
[432.011802] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (8.463s)
[432.080893] Starting dynamic subtest: pipe-D-HDMI-A-3
[441.336954] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (9.266s)
[441.396230] Subtest tiling-4: SUCCESS (36.010s)
[441.608881] [058/131] (585s left) gem_mmap_gtt (big-copy)
[441.687193] Subtest big-copy: SKIP (0.000s)
[441.752969] [059/131] (585s left) gem_exec_parallel (contexts)
[441.839497] Starting subtest: contexts
[441.840412] Starting dynamic subtest: rcs0
[446.630891] Dynamic subtest rcs0: SUCCESS (4.791s)
[446.641247] Starting dynamic subtest: bcs0
[451.230611] Dynamic subtest bcs0: SUCCESS (4.599s)
[451.240901] Starting dynamic subtest: vcs0
[456.014587] Dynamic subtest vcs0: SUCCESS (4.783s)
[456.028130] Starting dynamic subtest: vcs1
[460.713752] Dynamic subtest vcs1: SUCCESS (4.698s)
[460.724629] Starting dynamic subtest: vecs0
[465.552822] Dynamic subtest vecs0: SUCCESS (4.838s)
[465.564247] Starting dynamic subtest: vecs1
[470.145902] Dynamic subtest vecs1: SUCCESS (4.592s)
[470.156579] Starting dynamic subtest: ccs0
[475.029494] Dynamic subtest ccs0: SUCCESS (4.883s)
[475.030566] Subtest contexts: SUCCESS (33.190s)
[475.325841] [060/131] (552s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[477.342713] Starting subtest: psr-rgb101010-draw-mmap-gtt
[477.344320] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[477.567457] [061/131] (549s left) gem_lmem_swapping (massive-random)
[482.812945] Starting subtest: massive-random
[482.813956] Starting dynamic subtest: lmem0
[483.166098] Dynamic subtest lmem0: SUCCESS (0.353s)
[483.167102] Subtest massive-random: SUCCESS (0.354s)
[486.616427] [FACT gem_lmem_swapping (massive-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[486.617425] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true
[486.619375] [062/131] (540s left) prime_self_import (export-vs-gem_close-race)
[486.658435] Starting subtest: export-vs-gem_close-race
[495.866282] Subtest export-vs-gem_close-race: SUCCESS (9.208s)
[495.928562] [FACT prime_self_import (export-vs-gem_close-race)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[495.931193] [FACT prime_self_import (export-vs-gem_close-race)] new: kernel.kmod_is_loaded.i915: true
[495.934048] [063/131] (531s left) gem_exec_fence (basic-wait-all)
[496.049013] Starting subtest: basic-wait-all
[496.188653] Subtest basic-wait-all: SUCCESS (0.139s)
[497.057741] [064/131] (530s left) syncobj_wait (multi-wait-all-submitted-signaled)
[497.137486] Starting subtest: multi-wait-all-submitted-signaled
[497.243780] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[497.372115] [065/131] (530s left) gem_exec_schedule (semaphore-user)
[497.466523] Starting subtest: semaphore-user
[497.550779] Subtest semaphore-user: SUCCESS (0.084s)
[497.948698] [066/131] (529s left) kms_draw_crc (draw-method-blt)
[499.963174] Starting subtest: draw-method-blt
[499.964039] Starting dynamic subtest: xrgb8888-untiled
[500.368257] Dynamic subtest xrgb8888-untiled: SUCCESS (0.405s)
[500.404236] Starting dynamic subtest: rgb565-untiled
[500.718475] Dynamic subtest rgb565-untiled: SUCCESS (0.346s)
[500.756921] Starting dynamic subtest: xrgb2101010-untiled
[501.018295] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.295s)
[501.053352] Starting dynamic subtest: xbgr16161616f-untiled
[501.318395] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.296s)
[501.356139] Starting dynamic subtest: xrgb8888-xtiled
[501.485820] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.163s)
[501.525531] Starting dynamic subtest: rgb565-xtiled
[501.651587] Dynamic subtest rgb565-xtiled: SUCCESS (0.162s)
[501.690867] Starting dynamic subtest: xrgb2101010-xtiled
[501.800376] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.145s)
[501.812487] Starting dynamic subtest: xbgr16161616f-xtiled
[501.935039] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[501.971371] Starting dynamic subtest: xrgb8888-4tiled
[502.101963] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.163s)
[502.141636] Starting dynamic subtest: rgb565-4tiled
[502.268370] Dynamic subtest rgb565-4tiled: SUCCESS (0.162s)
[502.304726] Starting dynamic subtest: xrgb2101010-4tiled
[502.418288] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.146s)
[502.453838] Starting dynamic subtest: xbgr16161616f-4tiled
[502.568347] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.146s)
[502.574115] Subtest draw-method-blt: SUCCESS (2.607s)
[502.798651] [067/131] (524s left) i915_pm_rps (engine-order)
[502.883268] Starting subtest: engine-order
[513.904609] Subtest engine-order: SUCCESS (11.021s)
[514.097296] [068/131] (513s left) gem_exec_schedule (u-fairslice)
[514.188697] Starting subtest: u-fairslice
[514.189587] Starting dynamic subtest: rcs0
[516.242920] Dynamic subtest rcs0: SUCCESS (2.051s)
[516.252551] Starting dynamic subtest: bcs0
[518.261289] Dynamic subtest bcs0: SUCCESS (2.019s)
[518.271242] Starting dynamic subtest: vcs0
[520.282932] Dynamic subtest vcs0: SUCCESS (2.021s)
[520.292747] Starting dynamic subtest: vcs1
[522.303555] Dynamic subtest vcs1: SUCCESS (2.020s)
[522.313670] Starting dynamic subtest: vecs0
[524.323227] Dynamic subtest vecs0: SUCCESS (2.019s)
[524.332809] Starting dynamic subtest: vecs1
[526.344431] Dynamic subtest vecs1: SUCCESS (2.020s)
[526.354559] Starting dynamic subtest: ccs0
[528.364302] Dynamic subtest ccs0: SUCCESS (2.019s)
[528.365158] Subtest u-fairslice: SUCCESS (14.175s)
[528.735431] [069/131] (499s left) gem_softpin (32b-excludes-last-page)
[528.817187] Starting subtest: 32b-excludes-last-page
[528.822480] Subtest 32b-excludes-last-page: SUCCESS (0.006s)
[529.037886] [070/131] (498s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[531.053057] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[531.054937] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[531.289100] [071/131] (496s left) kms_vblank (query-forked)
[533.304089] Starting subtest: query-forked
[533.305015] Starting dynamic subtest: pipe-A-HDMI-A-3
[535.675627] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.371s)
[535.688171] Starting dynamic subtest: pipe-D-HDMI-A-3
[537.923408] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.245s)
[537.924260] Subtest query-forked: SUCCESS (4.621s)
[538.160317] [072/131] (490s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[540.180989] Starting subtest: primary-x-tiled-reflect-x-180
[550.503906] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.323s)
[550.782198] [073/131] (477s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[552.804485] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[553.509571] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.704s)
[553.790302] [074/131] (474s left) kms_psr (psr-primary-blt)
[555.804784] Subtest psr-primary-blt: SKIP (0.000s)
[555.868802] [075/131] (472s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[555.956600] Starting subtest: invalid-signal-one-illegal-handle
[555.957510] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[556.152563] [076/131] (472s left) syncobj_wait (wait-all-snapshot)
[556.229374] Starting subtest: wait-all-snapshot
[556.312109] Subtest wait-all-snapshot: SUCCESS (0.082s)
[556.471514] [077/131] (472s left) perf (invalid-remove-userspace-config)
[556.905691] Starting subtest: invalid-remove-userspace-config
[556.919242] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[556.973914] [078/131] (471s left) kms_cursor_crc (cursor-random-64x64)
[559.126369] Starting subtest: cursor-random-64x64
[559.133149] Starting dynamic subtest: pipe-A-HDMI-A-3
[563.549006] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.417s)
[563.579529] Starting dynamic subtest: pipe-D-HDMI-A-3
[568.032380] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.461s)
[568.033237] Subtest cursor-random-64x64: SUCCESS (8.906s)
[568.565969] [079/131] (460s left) gem_cs_tlb (engines)
[568.649538] Starting subtest: engines
[568.650412] Starting dynamic subtest: rcs0
[570.804179] Dynamic subtest rcs0: SUCCESS (2.153s)
[570.814573] Starting dynamic subtest: bcs0
[572.959939] Dynamic subtest bcs0: SUCCESS (2.154s)
[572.970576] Starting dynamic subtest: vcs0
[575.112600] Dynamic subtest vcs0: SUCCESS (2.151s)
[575.122997] Starting dynamic subtest: vcs1
[577.266480] Dynamic subtest vcs1: SUCCESS (2.153s)
[577.276851] Starting dynamic subtest: vecs0
[579.419430] Dynamic subtest vecs0: SUCCESS (2.152s)
[579.429447] Starting dynamic subtest: vecs1
[581.573600] Dynamic subtest vecs1: SUCCESS (2.153s)
[581.583641] Starting dynamic subtest: ccs0
[583.726278] Dynamic subtest ccs0: SUCCESS (2.151s)
[583.727203] Subtest engines: SUCCESS (15.076s)
[583.892926] [080/131] (444s left) kms_vblank (ts-continuation-modeset)
[585.904210] Starting subtest: ts-continuation-modeset
[585.905141] Starting dynamic subtest: pipe-A-HDMI-A-3
[586.340709] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.436s)
[586.353556] Starting dynamic subtest: pipe-D-HDMI-A-3
[586.602385] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.258s)
[586.603251] Subtest ts-continuation-modeset: SUCCESS (0.700s)
[586.794491] [081/131] (442s left) gem_spin_batch (spin-all)
[586.885509] Starting subtest: spin-all
[586.936522] Subtest spin-all: SUCCESS (0.051s)
[587.221883] [082/131] (441s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[589.241137] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[589.242972] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[589.485748] [083/131] (439s left) syncobj_basic (bad-fd-to-handle)
[589.565245] Starting subtest: bad-fd-to-handle
[589.566167] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[589.740839] [084/131] (439s left) gem_exec_params (no-blt)
[589.826454] Starting subtest: no-blt
[589.828569] Subtest no-blt: SUCCESS (0.001s)
[589.998726] [085/131] (439s left) gen9_exec_parse (secure-batches)
[590.081150] Subtest secure-batches: SKIP (0.000s)
[590.163958] [086/131] (439s left) gem_ccs (ctrl-surf-copy-new-ctx)
[590.252183] Starting subtest: ctrl-surf-copy-new-ctx
[590.254506] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[590.312383] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.059s)
[590.322518] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[590.510415] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.197s)
[590.522127] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[590.540201] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s)
[590.550356] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[590.743757] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.202s)
[590.755306] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[590.772193] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.027s)
[590.783548] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[590.975799] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.202s)
[590.985907] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[591.005286] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s)
[591.016677] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[591.209553] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.203s)
[591.210467] Subtest ctrl-surf-copy-new-ctx: SUCCESS (0.958s)
[591.381382] [087/131] (437s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[593.390371] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[593.445488] [088/131] (435s left) gem_eio (wait-1us)
[593.734370] Starting subtest: wait-1us
[594.317346] Subtest wait-1us: SUCCESS (0.583s)
[596.418407] [089/131] (433s left) kms_plane_scaling (planes-upscale-factor-0-25)
[598.459130] Starting subtest: planes-upscale-factor-0-25
[598.459986] Starting dynamic subtest: pipe-A
[598.568436] Dynamic subtest pipe-A: SUCCESS (0.110s)
[598.585845] Starting dynamic subtest: pipe-B
[598.714528] Dynamic subtest pipe-B: SUCCESS (0.145s)
[598.729243] Starting dynamic subtest: pipe-C
[598.841030] Dynamic subtest pipe-C: SUCCESS (0.125s)
[598.852408] Starting dynamic subtest: pipe-D
[598.966337] Dynamic subtest pipe-D: SUCCESS (0.124s)
[598.967273] Subtest planes-upscale-factor-0-25: SUCCESS (0.509s)
[599.183376] [090/131] (430s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[599.262121] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[599.341704] [091/131] (430s left) gem_exec_schedule (lateslice)
[599.434585] Starting subtest: lateslice
[599.435439] Starting dynamic subtest: rcs0
[599.485573] Dynamic subtest rcs0: SUCCESS (0.050s)
[599.497507] Starting dynamic subtest: bcs0
[599.510920] Dynamic subtest bcs0: SUCCESS (0.024s)
[599.521566] Starting dynamic subtest: vcs0
[599.532011] Dynamic subtest vcs0: SUCCESS (0.020s)
[599.542557] Starting dynamic subtest: vcs1
[599.553126] Dynamic subtest vcs1: SUCCESS (0.020s)
[599.563728] Starting dynamic subtest: vecs0
[599.575538] Dynamic subtest vecs0: SUCCESS (0.021s)
[599.587756] Starting dynamic subtest: vecs1
[599.596823] Dynamic subtest vecs1: SUCCESS (0.020s)
[599.607723] Starting dynamic subtest: ccs0
[599.619887] Dynamic subtest ccs0: SUCCESS (0.022s)
[599.628035] Subtest lateslice: SUCCESS (0.186s)
[600.058926] [092/131] (429s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[602.073148] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[602.074083] Starting dynamic subtest: pipe-A
[603.989853] Dynamic subtest pipe-A: SUCCESS (1.917s)
[604.016691] Starting dynamic subtest: pipe-B
[605.964405] Dynamic subtest pipe-B: SUCCESS (1.972s)
[605.980817] Starting dynamic subtest: pipe-C
[606.188407] Dynamic subtest pipe-C: SUCCESS (0.223s)
[606.205428] Starting dynamic subtest: pipe-D
[606.413017] Dynamic subtest pipe-D: SUCCESS (0.223s)
[606.414219] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (4.342s)
[606.696461] [093/131] (423s left) kms_atomic_transition (modeset-transition)
[608.708248] Starting subtest: modeset-transition
[608.709129] Starting dynamic subtest: 1x-outputs
[610.581915] Dynamic subtest 1x-outputs: SUCCESS (1.872s)
[610.602387] Subtest modeset-transition: SUCCESS (1.894s)
[610.824905] [094/131] (418s left) gem_mmap_wc (bad-size)
[610.904217] Subtest bad-size: SKIP (0.000s)
[610.970391] [095/131] (418s left) gem_partial_pwrite_pread (writes-after-reads)
[611.056186] Subtest writes-after-reads: SKIP (0.000s)
[611.141341] [096/131] (418s left) perf_pmu (most-busy-check-all)
[611.211448] Starting subtest: most-busy-check-all
[611.212422] Starting dynamic subtest: rcs0
[611.797385] Dynamic subtest rcs0: SUCCESS (0.585s)
[611.810740] Starting dynamic subtest: bcs0
[612.350746] Dynamic subtest bcs0: SUCCESS (0.552s)
[612.361802] Starting dynamic subtest: vcs0
[612.900486] Dynamic subtest vcs0: SUCCESS (0.549s)
[612.912978] Starting dynamic subtest: vcs1
[613.454503] Dynamic subtest vcs1: SUCCESS (0.553s)
[613.466939] Starting dynamic subtest: vecs0
[614.004503] Dynamic subtest vecs0: SUCCESS (0.549s)
[614.015356] Starting dynamic subtest: vecs1
[614.555770] Dynamic subtest vecs1: SUCCESS (0.550s)
[614.566669] Starting dynamic subtest: ccs0
[615.108768] Dynamic subtest ccs0: SUCCESS (0.552s)
[615.109593] Subtest most-busy-check-all: SUCCESS (3.898s)
[615.251496] [097/131] (414s left) gen7_exec_parse (batch-without-end)
[615.338508] Subtest batch-without-end: SKIP (0.000s)
[615.422375] [098/131] (414s left) kms_hdr (static-toggle-suspend)
[617.436159] Starting subtest: static-toggle-suspend
[617.438867] Subtest static-toggle-suspend: SKIP (0.000s)
[617.595451] [099/131] (412s left) perf_pmu (busy-idle-check-all)
[617.695363] Starting subtest: busy-idle-check-all
[617.696359] Starting dynamic subtest: rcs0
[618.394671] Dynamic subtest rcs0: SUCCESS (0.698s)
[618.411609] Starting dynamic subtest: bcs0
[619.055536] Dynamic subtest bcs0: SUCCESS (0.658s)
[619.070903] Starting dynamic subtest: vcs0
[619.715461] Dynamic subtest vcs0: SUCCESS (0.657s)
[619.732391] Starting dynamic subtest: vcs1
[620.376740] Dynamic subtest vcs1: SUCCESS (0.656s)
[620.393557] Starting dynamic subtest: vecs0
[621.034507] Dynamic subtest vecs0: SUCCESS (0.654s)
[621.049645] Starting dynamic subtest: vecs1
[621.691875] Dynamic subtest vecs1: SUCCESS (0.655s)
[621.712152] Starting dynamic subtest: ccs0
[622.354825] Dynamic subtest ccs0: SUCCESS (0.658s)
[622.357557] Subtest busy-idle-check-all: SUCCESS (4.661s)
[622.551286] [100/131] (407s left) drm_read (short-buffer-block)
[624.644678] Starting subtest: short-buffer-block
[624.645575] Subtest short-buffer-block: SUCCESS (0.000s)
[624.930010] [101/131] (405s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[625.006493] Starting subtest: etime-single-wait-all-available-unsubmitted
[625.107610] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[625.257239] [102/131] (405s left) gem_ctx_persistence (legacy-engines-cleanup)
[625.351779] Starting subtest: legacy-engines-cleanup
[625.352984] Starting dynamic subtest: render
[625.456417] Dynamic subtest render: SUCCESS (0.105s)
[625.469953] Starting dynamic subtest: bsd1
[625.476267] Dynamic subtest bsd1: SUCCESS (0.018s)
[625.488736] Starting dynamic subtest: bsd2
[625.515245] Dynamic subtest bsd2: SUCCESS (0.038s)
[625.530908] Starting dynamic subtest: blt
[625.559264] Dynamic subtest blt: SUCCESS (0.043s)
[625.579485] Starting dynamic subtest: vebox
[625.623120] Dynamic subtest vebox: SUCCESS (0.061s)
[625.628761] Subtest legacy-engines-cleanup: SUCCESS (0.274s)
[625.800959] [103/131] (404s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[627.815515] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[627.822029] Starting dynamic subtest: A-HDMI-A3
[635.827622] Dynamic subtest A-HDMI-A3: SUCCESS (8.005s)
[635.848058] Starting dynamic subtest: B-HDMI-A3
[643.776380] Dynamic subtest B-HDMI-A3: SUCCESS (7.943s)
[643.789202] Starting dynamic subtest: C-HDMI-A3
[651.726509] Dynamic subtest C-HDMI-A3: SUCCESS (7.949s)
[651.740517] Starting dynamic subtest: D-HDMI-A3
[659.675239] Dynamic subtest D-HDMI-A3: SUCCESS (7.947s)
[659.676201] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (31.860s)
[659.932140] [104/131] (370s left) kms_properties (crtc-properties-legacy)
[661.943273] Starting subtest: crtc-properties-legacy
[661.944172] Starting dynamic subtest: pipe-A-HDMI-A-3
[662.255275] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.311s)
[662.289383] Starting dynamic subtest: pipe-B-HDMI-A-3
[662.553200] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.293s)
[662.564434] Starting dynamic subtest: pipe-C-HDMI-A-3
[662.822071] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.267s)
[662.833398] Starting dynamic subtest: pipe-D-HDMI-A-3
[663.089245] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.265s)
[663.090164] Subtest crtc-properties-legacy: SUCCESS (1.147s)
[663.316832] [105/131] (367s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[663.402367] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[663.507654] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[663.644806] [106/131] (366s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[665.657294] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[665.659142] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[665.883606] [107/131] (364s left) device_reset (cold-reset-bound)
[665.971011] Starting subtest: cold-reset-bound
[665.973152] Subtest cold-reset-bound: SKIP (0.000s)
[666.087037] [108/131] (364s left) kms_psr (pr-dpms)
[668.099447] Subtest pr-dpms: SKIP (0.000s)
[668.151354] [109/131] (362s left) kms_chamelium_audio (dp-audio-edid)
[670.217759] Subtest dp-audio-edid: SKIP (0.000s)
[670.319707] [110/131] (360s left) kms_cursor_crc (cursor-suspend)
[672.420053] Starting subtest: cursor-suspend
[672.422377] Starting dynamic subtest: pipe-A-HDMI-A-3
[710.974423] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (7.936s)
[711.002068] Starting dynamic subtest: pipe-D-HDMI-A-3
[749.905505] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (7.127s)
[749.906352] Subtest cursor-suspend: SUCCESS (15.069s)
[759.449982] [111/131] (280s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[761.227254] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[761.279212] [112/131] (278s left) kms_content_protection (lic-type-0)
[763.109403] Starting subtest: lic-type-0
[763.404111] Subtest lic-type-0: SKIP (0.283s)
[763.714631] [113/131] (276s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[765.642155] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[765.643078] Starting dynamic subtest: pipe-A-HDMI-A-3
[765.646474] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[765.659683] Starting dynamic subtest: pipe-B-HDMI-A-3
[765.663148] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[765.676251] Starting dynamic subtest: pipe-C-HDMI-A-3
[765.680094] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[765.692626] Starting dynamic subtest: pipe-D-HDMI-A-3
[765.696877] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[765.698516] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[765.941925] [114/131] (274s left) kms_color (degamma)
[767.953130] Starting subtest: degamma
[767.954009] Starting dynamic subtest: pipe-A-HDMI-A-3
[768.623751] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.663s)
[768.636396] Starting dynamic subtest: pipe-B-HDMI-A-3
[769.118410] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.488s)
[769.132584] Starting dynamic subtest: pipe-C-HDMI-A-3
[769.617400] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.493s)
[769.630175] Starting dynamic subtest: pipe-D-HDMI-A-3
[770.120565] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.498s)
[770.121424] Subtest degamma: SUCCESS (2.146s)
[770.314403] [115/131] (269s left) i915_module_load (reload-with-fault-injection)
[770.363300] Starting subtest: reload-with-fault-injection
[808.135192] Subtest reload-with-fault-injection: SUCCESS (37.706s)
[808.165614] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[808.166529] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[808.168415] [116/131] (232s left) sw_sync (sync_merge_invalid)
[808.207350] Starting subtest: sync_merge_invalid
[812.328662] Subtest sync_merge_invalid: SUCCESS (4.120s)
[812.405252] [FACT sw_sync (sync_merge_invalid)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[812.407588] [FACT sw_sync (sync_merge_invalid)] new: kernel.kmod_is_loaded.i915: true
[812.410613] [117/131] (227s left) kms_chamelium_hpd (dp-hpd-storm)
[814.459478] Subtest dp-hpd-storm: SKIP (0.000s)
[814.556234] [118/131] (225s left) kms_async_flips (alternate-sync-async-flip-atomic)
[817.466386] Starting subtest: alternate-sync-async-flip-atomic
[817.613310] Starting dynamic subtest: pipe-A-HDMI-A-3
[819.843644] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.228s)
[820.100720] Starting dynamic subtest: pipe-B-HDMI-A-3
[822.164861] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.079s)
[822.309921] Starting dynamic subtest: pipe-C-HDMI-A-3
[824.391044] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.091s)
[824.547434] Starting dynamic subtest: pipe-D-HDMI-A-3
[826.621509] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.084s)
[826.622209] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.153s)
[827.074194] [119/131] (213s left) gem_ctx_shared (q-smoketest)
[827.174640] Starting subtest: Q-smoketest
[827.175480] Starting dynamic subtest: rcs0
[832.637838] Dynamic subtest rcs0: SUCCESS (5.455s)
[832.649094] Starting dynamic subtest: bcs0
[838.058455] Dynamic subtest bcs0: SUCCESS (5.417s)
[838.069787] Starting dynamic subtest: vcs0
[843.483706] Dynamic subtest vcs0: SUCCESS (5.421s)
[843.495181] Starting dynamic subtest: vcs1
[848.907256] Dynamic subtest vcs1: SUCCESS (5.421s)
[848.918550] Starting dynamic subtest: vecs0
[854.327178] Dynamic subtest vecs0: SUCCESS (5.418s)
[854.339041] Starting dynamic subtest: vecs1
[859.743690] Dynamic subtest vecs1: SUCCESS (5.418s)
[859.755917] Starting dynamic subtest: ccs0
[865.162134] Dynamic subtest ccs0: SUCCESS (5.418s)
[865.163313] Subtest Q-smoketest: SUCCESS (37.977s)
[865.479897] [120/131] (175s left) gem_sync (basic-store-each)
[865.567372] Starting subtest: basic-store-each
[868.612158] Subtest basic-store-each: SUCCESS (3.045s)
[868.916913] [121/131] (171s left) gem_pread (uncached)
[868.999304] Subtest uncached: SKIP (0.000s)
[869.069149] [122/131] (171s left) syncobj_timeline (wait-any-snapshot)
[869.152372] Starting subtest: wait-any-snapshot
[869.236026] Subtest wait-any-snapshot: SUCCESS (0.083s)
[869.365173] [123/131] (171s left) gem_userptr_blits (coherency-unsync)
[869.459926] Subtest coherency-unsync: SKIP (0.000s)
[869.694876] [124/131] (171s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[871.712337] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[871.714112] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[871.916925] [125/131] (169s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[873.942290] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[873.943977] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[874.155581] [126/131] (166s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[876.165229] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[876.166961] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[876.357284] [127/131] (164s left) gem_eio (execbuf)
[876.643346] Starting subtest: execbuf
[877.107170] Subtest execbuf: SUCCESS (0.464s)
[879.188391] [128/131] (162s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[881.234255] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[881.235156] Starting dynamic subtest: pipe-A-HDMI-A-3
[881.243797] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[881.256366] Starting dynamic subtest: pipe-B-HDMI-A-3
[881.265117] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[881.276558] Starting dynamic subtest: pipe-C-HDMI-A-3
[881.285338] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[881.297145] Starting dynamic subtest: pipe-D-HDMI-A-3
[881.307029] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[881.309171] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[881.532570] [129/131] (159s left) gem_exec_whisper (basic-fds-priority-all)
[881.621095] Starting subtest: basic-fds-priority-all
[904.407729] Subtest basic-fds-priority-all: SUCCESS (22.783s)
[904.674867] [130/131] (136s left) kms_psr (fbc-pr-no-drrs)
[906.687666] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[906.745685] [131/131] (134s left) api_intel_bb (lot-of-buffers)
[906.821429] Starting subtest: lot-of-buffers
[910.097104] Subtest lot-of-buffers: SUCCESS (3.274s)
[910.372781] Closing watchdogs
results: parsing output: 0/ for test: kms_feature_discovery
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_chamelium_edid
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: fbdev
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_cursor_edge_walk
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: kms_pm_rpm
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_getfb
results: parsing output: 22/ for test: i915_query
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_pipe_stress
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: gem_exec_gttfill
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: i915_hangman
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_force_connector_basic
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_selftest
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_softpin
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_lease
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_atomic_transition
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: gem_mmap_wc
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_plane_lowres
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: prime_self_import
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: i915_pm_rps
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: gem_cs_tlb
results: parsing output: 79/ for test: kms_vblank
results: parsing output: 80/ for test: gem_spin_batch
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_basic
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: gem_ccs
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_atomic_transition
results: parsing output: 93/ for test: gem_mmap_wc
results: parsing output: 94/ for test: gem_partial_pwrite_pread
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: gen7_exec_parse
results: parsing output: 97/ for test: kms_hdr
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: drm_read
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_properties
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: device_reset
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_chamelium_audio
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_color
results: parsing output: 114/ for test: i915_module_load
results: parsing output: 115/ for test: sw_sync
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: gem_ctx_shared
results: parsing output: 119/ for test: gem_sync
results: parsing output: 120/ for test: gem_pread
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: api_intel_bb
Done.