[56.937936] Initializing watchdogs
[56.938011]   /dev/watchdog0
[56.956969] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[56.967855] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[56.971701] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.974170] [001/131] (960s left) kms_lease (empty-lease)
[57.165768] Starting subtest: empty-lease
[57.166618] Starting dynamic subtest: pipe-A-DP-3
[57.168378] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[57.176752] Starting dynamic subtest: pipe-B-DP-3
[57.177547] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[57.184951] Starting dynamic subtest: pipe-C-DP-3
[57.185827] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[57.193293] Starting dynamic subtest: pipe-D-DP-3
[57.194217] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[57.195146] Subtest empty-lease: SUCCESS (0.010s)
[57.318494] [002/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[57.507718] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[57.509434] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[57.659379] [003/131] (959s left) gem_mmap_gtt (basic-small-copy)
[57.727883] Subtest basic-small-copy: SKIP (0.000s)
[57.783927] [004/131] (959s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[57.966718] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[58.096484] [005/131] (959s left) gem_eio (in-flight-internal-1us)
[58.352512] Starting subtest: in-flight-internal-1us
[59.906465] Subtest in-flight-internal-1us: SUCCESS (1.554s)
[60.122500] [006/131] (957s left) gen9_exec_parse (allowed-single)
[60.201848] Subtest allowed-single: SKIP (0.000s)
[60.291804] [007/131] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[60.484433] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[60.486119] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[60.608667] [008/131] (957s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[60.800527] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[60.853270] [009/131] (957s left) perf_pmu (rc6-all-gts)
[60.915461] Starting subtest: rc6-all-gts
[60.917236] Subtest rc6-all-gts: SKIP (0.000s)
[61.041893] [010/131] (956s left) gem_softpin (evict-active)
[61.126271] Starting subtest: evict-active
[61.150375] Subtest evict-active: SUCCESS (0.024s)
[61.325528] [011/131] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[61.515202] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[64.785579] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.268s)
[64.975507] [012/131] (953s left) i915_pm_rpm (gem-idle)
[67.016058] Starting subtest: gem-idle
[72.565599] Subtest gem-idle: SUCCESS (5.552s)
[72.834557] [013/131] (945s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[73.044524] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[73.047165] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[73.137366] [014/131] (945s left) kms_plane_alpha_blend (alpha-opaque-fb)
[73.318591] Starting subtest: alpha-opaque-fb
[73.583303] Starting dynamic subtest: pipe-A-DP-3
[74.096154] Dynamic subtest pipe-A-DP-3: SUCCESS (0.512s)
[74.105106] Starting dynamic subtest: pipe-D-DP-3
[74.673269] Dynamic subtest pipe-D-DP-3: SUCCESS (0.576s)
[74.674162] Subtest alpha-opaque-fb: SUCCESS (1.354s)
[74.936051] [015/131] (943s left) gem_pxp (create-protected-buffer)
[77.537484] Starting subtest: create-protected-buffer
[77.539553] Subtest create-protected-buffer: SKIP (0.000s)
[77.655084] [016/131] (940s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[77.732021] Starting subtest: saturated-hostile-nopreempt
[77.732983] Starting dynamic subtest: rcs0
[77.837481] Dynamic subtest rcs0: SKIP (0.104s)
[77.847972] Starting dynamic subtest: bcs0
[77.854160] Dynamic subtest bcs0: SKIP (0.017s)
[77.863771] Starting dynamic subtest: vcs0
[77.874185] Dynamic subtest vcs0: SKIP (0.020s)
[77.884746] Starting dynamic subtest: vcs1
[77.889146] Dynamic subtest vcs1: SKIP (0.015s)
[77.899763] Starting dynamic subtest: vecs0
[77.905137] Dynamic subtest vecs0: SKIP (0.016s)
[77.915482] Starting dynamic subtest: vecs1
[77.918324] Dynamic subtest vecs1: SKIP (0.013s)
[77.929058] Starting dynamic subtest: ccs0
[77.932380] Dynamic subtest ccs0: SKIP (0.013s)
[77.934205] Subtest saturated-hostile-nopreempt: SKIP (0.198s)
[78.096915] [017/131] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[78.282759] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[78.284376] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[78.434055] [018/131] (940s left) kms_plane_scaling (planes-downscale-factor-0-75)
[78.616767] Starting subtest: planes-downscale-factor-0-75
[78.617548] Starting dynamic subtest: pipe-A
[78.703354] Dynamic subtest pipe-A: SUCCESS (0.086s)
[78.713122] Starting dynamic subtest: pipe-B
[78.902278] Dynamic subtest pipe-B: SUCCESS (0.199s)
[78.919271] Starting dynamic subtest: pipe-C
[79.118194] Dynamic subtest pipe-C: SUCCESS (0.216s)
[79.133146] Starting dynamic subtest: pipe-D
[79.349589] Dynamic subtest pipe-D: SUCCESS (0.231s)
[79.350385] Subtest planes-downscale-factor-0-75: SUCCESS (0.733s)
[79.657933] [019/131] (938s left) kms_draw_crc (draw-method-mmap-gtt)
[79.839995] Starting subtest: draw-method-mmap-gtt
[79.841704] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[80.007421] [020/131] (938s left) kms_content_protection (srm)
[80.263406] Starting subtest: srm
[80.301135] Starting dynamic subtest: pipe-A-DP-3
[201.839874] Dynamic subtest pipe-A-DP-3: FAIL (121.364s)
[201.840849] Subtest srm: FAIL (121.495s)
[202.027213] [021/131] (816s left) i915_query (engine-info-invalid)
[202.096975] Starting subtest: engine-info-invalid
[202.097896] Subtest engine-info-invalid: SUCCESS (0.000s)
[202.269979] [022/131] (816s left) kms_cursor_crc (cursor-random-128x128)
[202.634818] Starting subtest: cursor-random-128x128
[202.639235] Starting dynamic subtest: pipe-A-DP-3
[207.269076] Dynamic subtest pipe-A-DP-3: SUCCESS (4.630s)
[207.315733] Starting dynamic subtest: pipe-D-DP-3
[211.933655] Dynamic subtest pipe-D-DP-3: SUCCESS (4.626s)
[211.934636] Subtest cursor-random-128x128: SUCCESS (9.299s)
[212.367970] [023/131] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[212.552721] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[212.554378] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[212.705058] [024/131] (806s left) gem_eio (context-create)
[213.037461] Starting subtest: context-create
[213.580223] Subtest context-create: SUCCESS (0.543s)
[213.801953] [025/131] (805s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[213.985551] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[218.028778] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.044s)
[218.200626] [026/131] (800s left) i915_drm_fdinfo (virtual-busy)
[218.262173] Starting subtest: virtual-busy
[218.263984] Subtest virtual-busy: SKIP (0.000s)
[218.394114] [027/131] (800s left) syncobj_timeline (wait-for-submit-delayed-submit)
[218.474707] Starting subtest: wait-for-submit-delayed-submit
[218.579350] Subtest wait-for-submit-delayed-submit: SUCCESS (0.105s)
[218.679156] [028/131] (800s left) gem_exec_schedule (smoketest)
[218.906625] Starting subtest: smoketest
[218.908087] Starting dynamic subtest: rcs0
[224.388226] Dynamic subtest rcs0: SUCCESS (5.477s)
[224.398374] Starting dynamic subtest: bcs0
[229.848048] Dynamic subtest bcs0: SUCCESS (5.459s)
[229.857456] Starting dynamic subtest: vcs0
[235.305527] Dynamic subtest vcs0: SUCCESS (5.457s)
[235.315391] Starting dynamic subtest: vcs1
[240.768892] Dynamic subtest vcs1: SUCCESS (5.464s)
[240.778541] Starting dynamic subtest: vecs0
[246.223857] Dynamic subtest vecs0: SUCCESS (5.454s)
[246.233733] Starting dynamic subtest: vecs1
[251.680675] Dynamic subtest vecs1: SUCCESS (5.456s)
[251.692021] Starting dynamic subtest: ccs0
[257.143862] Dynamic subtest ccs0: SUCCESS (5.461s)
[257.145072] Subtest smoketest: SUCCESS (38.229s)
[257.431881] [029/131] (761s left) kms_tiled_display (basic-test-pattern)
[257.690414] Subtest basic-test-pattern: SKIP (0.000s)
[257.751677] [030/131] (761s left) gem_ctx_engines (execute-one)
[257.831427] Starting subtest: execute-one
[261.175488] Subtest execute-one: SUCCESS (3.344s)
[261.421098] [031/131] (757s left) gem_exec_schedule (u-submit-late-slice)
[261.504069] Starting subtest: u-submit-late-slice
[261.504962] Starting dynamic subtest: rcs0
[261.582029] Dynamic subtest rcs0: SUCCESS (0.079s)
[261.591923] Starting dynamic subtest: bcs0
[261.631344] Dynamic subtest bcs0: SUCCESS (0.049s)
[261.641475] Starting dynamic subtest: vcs0
[261.679239] Dynamic subtest vcs0: SUCCESS (0.048s)
[261.689479] Starting dynamic subtest: vcs1
[261.724336] Dynamic subtest vcs1: SUCCESS (0.045s)
[261.734390] Starting dynamic subtest: vecs0
[261.776373] Dynamic subtest vecs0: SUCCESS (0.052s)
[261.786206] Starting dynamic subtest: vecs1
[261.824778] Dynamic subtest vecs1: SUCCESS (0.048s)
[261.834789] Starting dynamic subtest: ccs0
[261.876771] Dynamic subtest ccs0: SUCCESS (0.052s)
[261.877857] Subtest u-submit-late-slice: SUCCESS (0.374s)
[262.335016] [032/131] (757s left) gem_spin_batch (resubmit)
[262.413399] Starting subtest: resubmit
[262.414366] Starting dynamic subtest: rcs0
[262.443187] Dynamic subtest rcs0: SUCCESS (0.030s)
[262.453433] Starting dynamic subtest: bcs0
[262.454387] Dynamic subtest bcs0: SUCCESS (0.002s)
[262.464597] Starting dynamic subtest: vcs0
[262.465813] Dynamic subtest vcs0: SUCCESS (0.003s)
[262.475587] Starting dynamic subtest: vcs1
[262.476805] Dynamic subtest vcs1: SUCCESS (0.004s)
[262.486156] Starting dynamic subtest: vecs0
[262.487263] Dynamic subtest vecs0: SUCCESS (0.002s)
[262.496781] Starting dynamic subtest: vecs1
[262.497957] Dynamic subtest vecs1: SUCCESS (0.002s)
[262.507502] Starting dynamic subtest: ccs0
[262.508764] Dynamic subtest ccs0: SUCCESS (0.002s)
[262.509921] Subtest resubmit: SUCCESS (0.046s)
[262.737404] [033/131] (756s left) gem_mmap_gtt (big-copy)
[262.805143] Subtest big-copy: SKIP (0.000s)
[262.906999] [034/131] (756s left) gem_shrink (reclaim)
[262.982041] Starting subtest: reclaim
[265.225408] Subtest reclaim: SUCCESS (2.243s)
[265.403215] [035/131] (754s left) kms_joiner (basic-big-joiner)
[265.666296] Starting subtest: basic-big-joiner
[265.668026] Subtest basic-big-joiner: SKIP (0.000s)
[265.772051] [036/131] (754s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[265.966320] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[265.968064] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[266.098353] [037/131] (753s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[266.277776] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[266.278622] Starting dynamic subtest: pipe-A-valid-mode
[266.357309] Dynamic subtest pipe-A-valid-mode: SKIP (0.078s)
[266.359034] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.079s)
[266.565566] [038/131] (753s left) core_getversion (basic)
[266.620160] Starting subtest: basic
[266.622430] Subtest basic: SUCCESS (0.000s)
[266.722849] [039/131] (753s left) gem_exec_params (mmapped)
[266.806965] Starting subtest: mmapped
[266.808910] Subtest mmapped: SUCCESS (0.002s)
[266.988418] [040/131] (753s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[267.168542] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[267.169423] Starting dynamic subtest: pipe-A-DP-3
[286.677807] Dynamic subtest pipe-A-DP-3: SUCCESS (4.074s)
[286.697664] Starting dynamic subtest: pipe-B-DP-3
[305.800261] Dynamic subtest pipe-B-DP-3: SUCCESS (3.808s)
[305.844209] Starting dynamic subtest: pipe-C-DP-3
[325.012379] Dynamic subtest pipe-C-DP-3: SUCCESS (3.905s)
[325.032246] Starting dynamic subtest: pipe-D-DP-3
[344.293772] Dynamic subtest pipe-D-DP-3: SUCCESS (3.933s)
[344.294795] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SUCCESS (15.728s)
[344.645991] [041/131] (675s left) gem_workarounds (reset-context)
[344.760962] Starting subtest: reset-context
[344.988735] Subtest reset-context: SUCCESS (0.228s)
[345.129120] [042/131] (675s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[345.204571] Starting subtest: etime-multi-wait-all-for-submit-submitted
[345.315194] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.110s)
[345.409927] [043/131] (674s left) perf_pmu (rc6)
[345.471847] Starting subtest: rc6
[345.472774] Starting dynamic subtest: gt0
[351.830841] Dynamic subtest gt0: SUCCESS (6.357s)
[351.843834] Starting dynamic subtest: runtime-pm-gt0
[359.500198] Dynamic subtest runtime-pm-gt0: SUCCESS (7.667s)
[359.513238] Starting dynamic subtest: runtime-pm-long-gt0
[372.121059] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.619s)
[372.133411] Starting dynamic subtest: other-idle-gt0
[372.135123] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[372.136173] Subtest rc6: SUCCESS (26.650s)
[372.777720] [044/131] (647s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[372.848090] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[372.850305] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[373.010444] [045/131] (647s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[373.200459] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[373.202024] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[373.279291] [046/131] (647s left) gem_reg_read (bad-register)
[373.349669] Starting subtest: bad-register
[373.350715] Subtest bad-register: SUCCESS (0.000s)
[373.439206] [047/131] (647s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[373.624311] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[377.083432] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.460s)
[377.259078] [048/131] (643s left) kms_cursor_crc (cursor-sliding-32x10)
[377.553754] Starting subtest: cursor-sliding-32x10
[377.603574] Subtest cursor-sliding-32x10: SKIP (0.048s)
[377.943158] [049/131] (642s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[378.126430] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[378.127295] Starting dynamic subtest: pipe-A-DP-3
[378.136513] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[378.148907] Starting dynamic subtest: pipe-B-DP-3
[378.158243] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[378.170413] Starting dynamic subtest: pipe-C-DP-3
[378.179504] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[378.191813] Starting dynamic subtest: pipe-D-DP-3
[378.203200] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[378.205212] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s)
[378.497358] [050/131] (642s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[378.569815] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[378.570760] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[378.672408] [051/131] (642s left) gem_exec_params (larger-than-life-batch)
[378.750986] Starting subtest: larger-than-life-batch
[388.684894] Subtest larger-than-life-batch: SUCCESS (9.926s)
[389.125116] [052/131] (631s left) kms_psr (fbc-pr-sprite-render)
[389.354648] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[389.414276] [053/131] (631s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[389.607840] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[390.357078] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.749s)
[390.563125] [054/131] (630s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[390.747115] Starting subtest: basic-modeset-with-all-modifiers-formats
[390.979889] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB8888
[391.299157] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB8888: SUCCESS (0.319s)
[391.317544] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB2101010
[391.332336] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB2101010: SUCCESS (0.033s)
[391.350800] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-XRGB16161616F
[391.365745] Dynamic subtest pipe-A-DP-3-4-rc-ccs-XRGB16161616F: SUCCESS (0.033s)
[391.384569] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[391.548886] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.183s)
[391.562896] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[391.582261] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.033s)
[391.598490] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[391.615756] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.033s)
[391.632006] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[391.649090] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.033s)
[391.665372] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[391.682457] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.033s)
[391.698676] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[391.715770] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.033s)
[391.732044] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[391.749202] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.033s)
[391.763899] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[391.782669] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.033s)
[391.798760] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[391.815801] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.033s)
[391.832056] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[391.999102] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.183s)
[392.012571] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[392.032590] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.033s)
[392.049077] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[392.065991] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.033s)
[392.082485] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[392.099227] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.033s)
[392.115621] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[392.132650] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.033s)
[392.149105] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[392.166081] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.033s)
[392.182581] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[392.199253] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.033s)
[392.215650] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[392.232675] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.033s)
[392.249045] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[392.266010] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.033s)
[392.279436] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[392.433871] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.167s)
[392.447452] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[392.468039] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.034s)
[392.484827] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[392.501530] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.033s)
[392.523606] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[392.534891] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.033s)
[392.556679] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[392.568103] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s)
[392.584702] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[392.601505] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.033s)
[392.616473] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[392.634817] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.033s)
[392.650886] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[392.668194] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.033s)
[392.688707] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[392.701630] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.033s)
[392.992085] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.244s)
[393.276552] [055/131] (627s left) gem_exec_fence (basic-await)
[393.507832] Starting subtest: basic-await
[393.509372] Starting dynamic subtest: rcs0
[393.633633] Dynamic subtest rcs0: SUCCESS (0.125s)
[393.648945] Starting dynamic subtest: bcs0
[393.719485] Dynamic subtest bcs0: SUCCESS (0.085s)
[393.735999] Starting dynamic subtest: vcs0
[393.808010] Dynamic subtest vcs0: SUCCESS (0.088s)
[393.824223] Starting dynamic subtest: vcs1
[393.896692] Dynamic subtest vcs1: SUCCESS (0.088s)
[393.912896] Starting dynamic subtest: vecs0
[393.984315] Dynamic subtest vecs0: SUCCESS (0.087s)
[394.001853] Starting dynamic subtest: vecs1
[394.074667] Dynamic subtest vecs1: SUCCESS (0.089s)
[394.092033] Starting dynamic subtest: ccs0
[394.165494] Dynamic subtest ccs0: SUCCESS (0.090s)
[394.166396] Subtest basic-await: SUCCESS (0.658s)
[394.917435] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[394.919476] [056/131] (626s left) gem_eio (wait-wedge-10ms)
[395.191213] Starting subtest: wait-wedge-10ms
[396.318853] Subtest wait-wedge-10ms: SUCCESS (1.128s)
[396.496476] [057/131] (624s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[396.688946] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[396.690783] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[396.745993] [058/131] (624s left) kms_properties (invalid-properties-legacy)
[396.939260] Starting subtest: invalid-properties-legacy
[397.098579] Subtest invalid-properties-legacy: SUCCESS (0.159s)
[397.180110] [059/131] (624s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[397.369156] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[397.371350] Starting dynamic subtest: pipe-A-valid-mode
[397.461288] Dynamic subtest pipe-A-valid-mode: SKIP (0.089s)
[397.463283] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.091s)
[397.657204] [060/131] (623s left) gen3_render_linear_blits
[397.828049] [061/131] (623s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[398.024428] Starting subtest: plane-all-transition-nonblocking-fencing
[398.026723] Starting dynamic subtest: pipe-A-DP-3
[401.807569] Dynamic subtest pipe-A-DP-3: SUCCESS (3.780s)
[401.945454] Starting dynamic subtest: pipe-B-DP-3
[405.849416] Dynamic subtest pipe-B-DP-3: SUCCESS (3.916s)
[405.939319] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.912s)
[406.131343] [062/131] (615s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[406.326896] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[406.328648] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[406.428563] [063/131] (615s left) kms_scaling_modes (scaling-mode-full-aspect)
[406.618020] Starting subtest: scaling-mode-full-aspect
[406.623134] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[406.684326] [064/131] (614s left) kms_chamelium_color (ctm-red-to-blue)
[406.877060] Subtest ctm-red-to-blue: SKIP (0.000s)
[406.932144] [065/131] (614s left) gem_userptr_blits (relocations)
[407.021601] Starting subtest: relocations
[407.023385] Subtest relocations: SKIP (0.000s)
[407.163497] [066/131] (614s left) gem_ppgtt (shrink-vs-evict-any)
[407.248412] Starting subtest: shrink-vs-evict-any
[413.292879] Subtest shrink-vs-evict-any: SUCCESS (6.043s)
[413.413822] [067/131] (608s left) gem_busy (extended)
[413.656662] Starting subtest: extended
[413.657679] Starting dynamic subtest: rcs0
[413.756405] Dynamic subtest rcs0: SUCCESS (0.098s)
[413.779031] Starting dynamic subtest: bcs0
[413.804132] Dynamic subtest bcs0: SUCCESS (0.045s)
[413.821143] Starting dynamic subtest: vcs0
[413.845092] Dynamic subtest vcs0: SUCCESS (0.040s)
[413.865492] Starting dynamic subtest: vcs1
[413.888217] Dynamic subtest vcs1: SUCCESS (0.042s)
[413.910329] Starting dynamic subtest: vecs0
[413.930192] Dynamic subtest vecs0: SUCCESS (0.041s)
[413.952352] Starting dynamic subtest: vecs1
[413.972063] Dynamic subtest vecs1: SUCCESS (0.041s)
[413.990224] Starting dynamic subtest: ccs0
[414.013222] Dynamic subtest ccs0: SUCCESS (0.040s)
[414.014208] Subtest extended: SUCCESS (0.357s)
[414.270503] [068/131] (607s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[414.464281] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[414.466775] Starting dynamic subtest: pipe-A-DP-3
[414.475362] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[414.488969] Starting dynamic subtest: pipe-B-DP-3
[414.497515] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[414.510803] Starting dynamic subtest: pipe-C-DP-3
[414.519819] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[414.533291] Starting dynamic subtest: pipe-D-DP-3
[414.544170] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[414.546222] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[414.848726] [069/131] (607s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[415.044871] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[415.060505] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.015s)
[415.120479] [070/131] (606s left) gem_exec_reloc (basic-gtt-active)
[415.208037] Subtest basic-gtt-active: SKIP (0.000s)
[415.285800] [071/131] (606s left) gem_exec_params (cliprects_ptr-dirt)
[415.374565] Starting subtest: cliprects_ptr-dirt
[415.375517] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[415.454863] [072/131] (606s left) kms_pm_lpsp (screens-disabled)
[416.654183] Starting subtest: screens-disabled
[416.655930] Subtest screens-disabled: SKIP (0.000s)
[416.722530] [073/131] (605s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[416.919013] Starting subtest: fbcpsr-shrfb-scaledprimary
[416.920755] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[417.007335] [074/131] (605s left) gem_render_copy_redux (flink-interruptible)
[417.089172] Starting subtest: flink-interruptible
[420.175837] Subtest flink-interruptible: SUCCESS (3.086s)
[420.337610] [075/131] (601s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[420.526427] Starting subtest: basic-flip-after-cursor-atomic
[421.546144] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.018s)
[421.773007] [076/131] (600s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[421.974558] Starting subtest: 4-tiled-32bpp-rotate-180
[423.746514] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.771s)
[423.905540] [077/131] (598s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[424.097841] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[424.099596] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[424.177986] [078/131] (598s left) gem_basic (create-close)
[424.262036] Starting subtest: create-close
[424.263833] Subtest create-close: SUCCESS (0.000s)
[424.359333] [079/131] (598s left) gem_exec_params (secure-non-master)
[424.444469] Starting subtest: secure-non-master
[424.446860] Subtest secure-non-master: SKIP (0.000s)
[424.532778] [080/131] (598s left) gem_busy (close-race)
[424.621329] Starting subtest: close-race
[446.589272] Subtest close-race: SUCCESS (21.968s)
[447.091108] [081/131] (575s left) gem_eio (execbuf)
[447.432416] Starting subtest: execbuf
[447.968936] Subtest execbuf: SUCCESS (0.538s)
[448.144277] [082/131] (574s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[448.341532] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[448.343173] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[448.432763] [083/131] (574s left) gem_lmem_evict (dontneed-evict-race)
[451.005205] Starting subtest: dontneed-evict-race
[453.108095] Subtest dontneed-evict-race: SUCCESS (2.103s)
[454.829917] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[454.830856] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[454.833503] [084/131] (567s left) i915_drm_fdinfo (busy-check-all)
[456.269924] Starting subtest: busy-check-all
[456.270854] Starting dynamic subtest: rcs0
[456.307823] Dynamic subtest rcs0: SKIP (0.037s)
[456.320384] Starting dynamic subtest: bcs0
[456.322055] Dynamic subtest bcs0: SKIP (0.000s)
[456.334174] Starting dynamic subtest: vcs0
[456.336404] Dynamic subtest vcs0: SKIP (0.000s)
[456.348233] Starting dynamic subtest: vcs1
[456.350460] Dynamic subtest vcs1: SKIP (0.000s)
[456.362389] Starting dynamic subtest: vecs0
[456.364693] Dynamic subtest vecs0: SKIP (0.000s)
[456.376412] Starting dynamic subtest: vecs1
[456.378806] Dynamic subtest vecs1: SKIP (0.000s)
[456.390565] Starting dynamic subtest: ccs0
[456.393027] Dynamic subtest ccs0: SKIP (0.000s)
[456.395382] Subtest busy-check-all: SKIP (0.046s)
[456.436986] [FACT i915_drm_fdinfo (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[456.439935] [FACT i915_drm_fdinfo (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[456.442892] [085/131] (566s left) perf (gen12-group-exclusive-stream-sample-oa)
[456.794855] Starting subtest: gen12-group-exclusive-stream-sample-oa
[456.816026] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s)
[456.869158] [086/131] (565s left) kms_big_fb (linear-64bpp-rotate-270)
[457.141686] Starting subtest: linear-64bpp-rotate-270
[457.223813] Subtest linear-64bpp-rotate-270: SKIP (0.081s)
[457.380186] [087/131] (565s left) gem_lmem_swapping (verify)
[461.473689] Starting subtest: verify
[461.474596] Starting dynamic subtest: lmem0
[497.847077] Dynamic subtest lmem0: SUCCESS (36.375s)
[497.848072] Subtest verify: SUCCESS (36.376s)
[499.106355] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[499.107602] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[499.109790] [088/131] (523s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[500.652694] Starting subtest: x-tiled-8bpp-rotate-0
[502.241089] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.587s)
[502.421229] [FACT kms_big_fb (x-tiled-8bpp-rotate-0)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[502.423671] [FACT kms_big_fb (x-tiled-8bpp-rotate-0)] new: kernel.kmod_is_loaded.i915: true
[502.426238] [089/131] (520s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[504.461111] Starting subtest: modeset-non-lpsp-stress-no-wait
[507.752169] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (3.292s)
[507.877594] [090/131] (515s left) kms_vblank (ts-continuation-modeset-hang)
[508.069993] Starting subtest: ts-continuation-modeset-hang
[508.070886] Starting dynamic subtest: pipe-A-DP-3
[534.995588] Dynamic subtest pipe-A-DP-3: SUCCESS (26.926s)
[535.011347] Starting dynamic subtest: pipe-D-DP-3
[559.943589] Dynamic subtest pipe-D-DP-3: SUCCESS (24.945s)
[559.944490] Subtest ts-continuation-modeset-hang: SUCCESS (51.877s)
[560.134603] [091/131] (463s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[560.330754] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[560.332467] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[560.413412] [092/131] (462s left) kms_psr (psr2-cursor-mmap-cpu)
[560.603905] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[560.659897] [093/131] (462s left) syncobj_timeline (invalid-transfer-bad-pad)
[560.741124] Starting subtest: invalid-transfer-bad-pad
[560.742067] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[560.811583] [094/131] (462s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[561.019621] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[561.022505] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[561.124997] [095/131] (462s left) perf (oa-formats)
[561.459016] Starting subtest: oa-formats
[561.459893] Starting dynamic subtest: 0-rcs0
[561.483387] Dynamic subtest 0-rcs0: SUCCESS (0.024s)
[561.484231] Subtest oa-formats: SUCCESS (0.025s)
[561.545724] [096/131] (461s left) kms_cursor_legacy (single-move)
[561.735023] Starting subtest: single-move
[561.735895] Starting dynamic subtest: pipe-A
[567.115415] Dynamic subtest pipe-A: SUCCESS (5.379s)
[567.128286] Starting dynamic subtest: pipe-B
[572.495139] Dynamic subtest pipe-B: SUCCESS (5.379s)
[572.507861] Starting dynamic subtest: pipe-C
[577.876098] Dynamic subtest pipe-C: SUCCESS (5.379s)
[577.888529] Starting dynamic subtest: pipe-D
[583.256433] Dynamic subtest pipe-D: SUCCESS (5.378s)
[583.269867] Starting dynamic subtest: all-pipes
[588.637825] Dynamic subtest all-pipes: SUCCESS (5.379s)
[588.638728] Subtest single-move: SUCCESS (26.900s)
[588.699261] [097/131] (434s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[588.778138] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[588.881596] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[588.990101] [098/131] (434s left) kms_psr (psr-sprite-blt)
[589.193434] Subtest psr-sprite-blt: SKIP (0.000s)
[589.247729] [099/131] (434s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[589.444979] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[589.446690] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[589.541026] [100/131] (434s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[589.740550] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[589.742204] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[589.815657] [101/131] (433s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[590.019916] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[590.081160] [102/131] (433s left) prime_vgem (busy)
[590.177014] Starting subtest: busy
[590.178287] Starting dynamic subtest: rcs0
[590.231075] Dynamic subtest rcs0: SUCCESS (0.055s)
[590.245375] Starting dynamic subtest: bcs0
[590.292173] Dynamic subtest bcs0: SUCCESS (0.060s)
[590.312376] Starting dynamic subtest: vcs0
[590.331623] Dynamic subtest vcs0: SUCCESS (0.038s)
[590.351934] Starting dynamic subtest: vcs1
[590.372487] Dynamic subtest vcs1: SUCCESS (0.039s)
[590.392603] Starting dynamic subtest: vecs0
[590.413164] Dynamic subtest vecs0: SUCCESS (0.039s)
[590.433687] Starting dynamic subtest: vecs1
[590.455025] Dynamic subtest vecs1: SUCCESS (0.040s)
[590.475433] Starting dynamic subtest: ccs0
[590.496414] Dynamic subtest ccs0: SUCCESS (0.040s)
[590.497328] Subtest busy: SUCCESS (0.321s)
[590.644327] [103/131] (433s left) api_intel_bb (misplaced-blitter)
[590.722983] Starting subtest: misplaced-blitter
[590.759870] Subtest misplaced-blitter: SUCCESS (0.037s)
[590.870025] [104/131] (433s left) kms_chamelium_hpd (hdmi-hpd-fast)
[591.146782] Subtest hdmi-hpd-fast: SKIP (0.000s)
[591.317547] [105/131] (432s left) sysfs_heartbeat_interval (idempotent)
[591.397022] Starting subtest: idempotent
[591.397966] Starting dynamic subtest: vecs0
[591.400202] Dynamic subtest vecs0: SUCCESS (0.001s)
[591.413438] Starting dynamic subtest: ccs0
[591.414321] Dynamic subtest ccs0: SUCCESS (0.001s)
[591.426924] Starting dynamic subtest: vcs0
[591.428177] Dynamic subtest vcs0: SUCCESS (0.001s)
[591.441007] Starting dynamic subtest: bcs0
[591.442295] Dynamic subtest bcs0: SUCCESS (0.001s)
[591.454515] Starting dynamic subtest: vecs1
[591.455486] Dynamic subtest vecs1: SUCCESS (0.001s)
[591.467751] Starting dynamic subtest: rcs0
[591.469006] Dynamic subtest rcs0: SUCCESS (0.001s)
[591.481253] Starting dynamic subtest: vcs1
[591.482429] Dynamic subtest vcs1: SUCCESS (0.001s)
[591.483601] Subtest idempotent: SUCCESS (0.015s)
[591.530707] [106/131] (432s left) gem_exec_basic (basic)
[591.610572] Starting subtest: basic
[591.611556] Starting dynamic subtest: rcs0-smem
[591.614701] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[591.629808] Starting dynamic subtest: bcs0-smem
[591.630778] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[591.643443] Starting dynamic subtest: vcs0-smem
[591.644307] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[591.656563] Starting dynamic subtest: vcs1-smem
[591.657888] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[591.670320] Starting dynamic subtest: vecs0-smem
[591.671542] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[591.683579] Starting dynamic subtest: vecs1-smem
[591.684880] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[591.697259] Starting dynamic subtest: ccs0-smem
[591.698478] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[591.710751] Starting dynamic subtest: rcs0-lmem0
[591.711989] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[591.724303] Starting dynamic subtest: bcs0-lmem0
[591.725521] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[591.737545] Starting dynamic subtest: vcs0-lmem0
[591.738420] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[591.751179] Starting dynamic subtest: vcs1-lmem0
[591.752135] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[591.765190] Starting dynamic subtest: vecs0-lmem0
[591.766456] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[591.779165] Starting dynamic subtest: vecs1-lmem0
[591.780459] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[591.792695] Starting dynamic subtest: ccs0-lmem0
[591.793793] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[591.794995] Subtest basic: SUCCESS (0.024s)
[591.841426] [107/131] (432s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[592.037056] Starting subtest: 2x-long-cursor-vs-flip-legacy
[592.038794] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[592.106577] [108/131] (432s left) prime_mmap (test_correct)
[592.187433] Starting subtest: test_correct
[592.188287] Starting dynamic subtest: test_correct-smem
[592.235377] Dynamic subtest test_correct-smem: SUCCESS (0.047s)
[592.248208] Starting dynamic subtest: test_correct-lmem0
[592.433059] Dynamic subtest test_correct-lmem0: SUCCESS (0.196s)
[592.434033] Subtest test_correct: SUCCESS (0.246s)
[592.505778] [109/131] (431s left) kms_plane_multiple (2x-tiling-4)
[592.697092] Starting subtest: 2x-tiling-4
[592.698818] Subtest 2x-tiling-4: SKIP (0.000s)
[592.755632] [110/131] (431s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[592.944370] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[592.946708] Starting dynamic subtest: pipe-A-DP-3
[592.950154] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[592.963255] Starting dynamic subtest: pipe-B-DP-3
[592.966811] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[592.979831] Starting dynamic subtest: pipe-C-DP-3
[592.983184] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[592.995692] Starting dynamic subtest: pipe-D-DP-3
[592.999373] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[593.001593] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[593.344225] [111/131] (430s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[593.537442] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[593.539961] Starting dynamic subtest: pipe-A-DP-3
[597.912198] Dynamic subtest pipe-A-DP-3: SUCCESS (4.369s)
[597.929166] Starting dynamic subtest: pipe-B-DP-3
[598.663680] Dynamic subtest pipe-B-DP-3: SUCCESS (0.746s)
[598.705279] Starting dynamic subtest: pipe-C-DP-3
[599.444538] Dynamic subtest pipe-C-DP-3: SUCCESS (0.773s)
[599.488021] Starting dynamic subtest: pipe-D-DP-3
[600.243811] Dynamic subtest pipe-D-DP-3: SUCCESS (0.791s)
[600.245473] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SUCCESS (6.702s)
[600.517514] [112/131] (423s left) kms_big_fb (yf-tiled-addfb)
[600.718639] Starting subtest: yf-tiled-addfb
[600.720719] Subtest yf-tiled-addfb: SKIP (0.000s)
[600.780868] [113/131] (423s left) kms_addfb_basic (too-high)
[600.974571] Starting subtest: too-high
[600.975532] Subtest too-high: SUCCESS (0.001s)
[601.068916] [114/131] (423s left) gem_ctx_persistence (heartbeat-hostile)
[601.157115] Starting subtest: heartbeat-hostile
[601.159256] Subtest heartbeat-hostile: SKIP (0.000s)
[601.230350] [115/131] (423s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[601.314436] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[601.401437] [116/131] (423s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[601.700862] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[601.854362] [117/131] (422s left) gem_softpin (allocator-nopin)
[601.938657] Starting subtest: allocator-nopin
[602.194416] Subtest allocator-nopin: SUCCESS (0.245s)
[602.323075] [118/131] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[602.518908] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[602.520599] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[602.596604] [119/131] (422s left) kms_psr (fbc-psr2-no-drrs)
[602.787942] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[602.845259] [120/131] (422s left) fbdev (eof)
[602.903686] Starting subtest: eof
[602.905060] Subtest eof: SUCCESS (0.000s)
[603.007781] [121/131] (421s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[603.198387] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[603.199234] Starting dynamic subtest: pipe-A
[603.298566] Dynamic subtest pipe-A: SUCCESS (0.099s)
[603.330969] Starting dynamic subtest: pipe-B
[603.530694] Dynamic subtest pipe-B: SUCCESS (0.230s)
[603.551514] Starting dynamic subtest: pipe-C
[603.768029] Dynamic subtest pipe-C: SUCCESS (0.236s)
[603.781793] Starting dynamic subtest: pipe-D
[603.987083] Dynamic subtest pipe-D: SUCCESS (0.218s)
[603.987917] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.789s)
[604.235082] [122/131] (420s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[604.429673] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[604.431337] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[604.527445] [123/131] (420s left) api_intel_allocator (alloc-simple)
[604.603349] Starting subtest: alloc-simple
[604.635706] Subtest alloc-simple: SUCCESS (0.034s)
[604.802236] [124/131] (420s left) kms_psr (fbc-psr-cursor-plane-onoff)
[604.989899] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[605.049454] [125/131] (420s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[605.125811] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[605.210030] [126/131] (420s left) perf_pmu (all-busy-check-all)
[605.281159] Starting subtest: all-busy-check-all
[605.880922] Subtest all-busy-check-all: SUCCESS (0.600s)
[605.995398] [127/131] (419s left) gem_ctx_param (set-priority-not-supported)
[606.074386] Starting subtest: set-priority-not-supported
[606.076126] Subtest set-priority-not-supported: SKIP (0.000s)
[606.135897] [128/131] (419s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[606.327030] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[606.328665] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[606.426777] [129/131] (419s left) kms_flip (plain-flip-ts-check-interruptible)
[606.622127] Starting subtest: plain-flip-ts-check-interruptible
[606.626980] Starting dynamic subtest: A-DP3
[614.748184] Dynamic subtest A-DP3: SUCCESS (8.119s)
[614.769801] Starting dynamic subtest: B-DP3
[622.779316] Dynamic subtest B-DP3: SUCCESS (8.025s)
[622.798266] Starting dynamic subtest: C-DP3
[630.810531] Dynamic subtest C-DP3: SUCCESS (8.028s)
[630.832437] Starting dynamic subtest: D-DP3
[638.837961] Dynamic subtest D-DP3: SUCCESS (8.022s)
[638.840224] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.215s)
[639.141525] [130/131] (386s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[639.220796] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[639.289195] [131/131] (386s left) kms_flip (flip-vs-panning-interruptible)
[639.479344] Starting subtest: flip-vs-panning-interruptible
[639.484206] Starting dynamic subtest: A-DP3
[647.340358] Dynamic subtest A-DP3: SUCCESS (7.853s)
[647.379508] Starting dynamic subtest: B-DP3
[655.116856] Dynamic subtest B-DP3: SUCCESS (7.772s)
[655.159458] Starting dynamic subtest: C-DP3
[662.897842] Dynamic subtest C-DP3: SUCCESS (7.775s)
[662.937173] Starting dynamic subtest: D-DP3
[670.672780] Dynamic subtest D-DP3: SUCCESS (7.769s)
[670.680910] Subtest flip-vs-panning-interruptible: SUCCESS (31.199s)
[670.967716] Closing watchdogs
results: parsing output: 0/ for test: kms_lease
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: gem_eio
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: i915_pm_rpm
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_plane_alpha_blend
results: parsing output: 14/ for test: gem_pxp
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_draw_crc
results: parsing output: 19/ for test: kms_content_protection
results: parsing output: 20/ for test: i915_query
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_tiled_display
results: parsing output: 29/ for test: gem_ctx_engines
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_spin_batch
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: gem_shrink
results: parsing output: 34/ for test: kms_joiner
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: core_getversion
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_workarounds
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_reg_read
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_properties
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: gen3_render_linear_blits
results: parsing output: 60/ for test: kms_atomic_transition
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_scaling_modes
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: gem_ppgtt
results: parsing output: 66/ for test: gem_busy
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_pm_lpsp
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_render_copy_redux
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_basic
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_lmem_evict
results: parsing output: 83/ for test: i915_drm_fdinfo
results: parsing output: 84/ for test: perf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: kms_chamelium_hpd
results: parsing output: 104/ for test: sysfs_heartbeat_interval
results: parsing output: 105/ for test: gem_exec_basic
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: kms_plane_multiple
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_chamelium_hpd
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: fbdev
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: api_intel_allocator
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_pipe_b_c_ivb
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_flip
Done.