[67.320695] Initializing watchdogs
[67.320777]   /dev/watchdog0
[67.351341] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.366796] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.371709] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.375403] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[68.886825] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[68.890326] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[69.060466] [002/133] (958s left) gem_flink_basic (bad-open)
[69.107516] Starting subtest: bad-open
[69.108813] Subtest bad-open: SUCCESS (0.000s)
[69.243190] [003/133] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[70.741592] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[70.744834] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[70.924669] [004/133] (957s left) gem_ppgtt (shrink-vs-evict-pinned)
[70.984377] Starting subtest: shrink-vs-evict-pinned
[76.901113] Subtest shrink-vs-evict-pinned: SUCCESS (5.901s)
[76.982020] [005/133] (951s left) gem_exec_schedule (implicit-boths)
[77.040359] Starting subtest: implicit-boths
[77.041679] Starting dynamic subtest: rcs0
[77.242719] Dynamic subtest rcs0: SUCCESS (0.199s)
[77.251377] Starting dynamic subtest: bcs0
[77.379045] Dynamic subtest bcs0: SUCCESS (0.139s)
[77.387485] Starting dynamic subtest: vcs0
[77.518581] Dynamic subtest vcs0: SUCCESS (0.139s)
[77.527328] Starting dynamic subtest: vcs1
[77.669373] Dynamic subtest vcs1: SUCCESS (0.150s)
[77.678207] Starting dynamic subtest: vecs0
[77.819819] Dynamic subtest vecs0: SUCCESS (0.150s)
[77.821627] Subtest implicit-boths: SUCCESS (0.778s)
[78.263197] [006/133] (950s left) vgem_slow (nohang)
[78.361989] Starting subtest: nohang
[88.649473] Subtest nohang: SUCCESS (10.280s)
[88.753201] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[88.755711] [007/133] (939s left) gem_exec_schedule (u-submit-late-slice)
[88.817000] Starting subtest: u-submit-late-slice
[88.818498] Starting dynamic subtest: rcs0
[88.877925] Dynamic subtest rcs0: SUCCESS (0.061s)
[88.886959] Starting dynamic subtest: bcs0
[88.920465] Dynamic subtest bcs0: SUCCESS (0.042s)
[88.929700] Starting dynamic subtest: vcs0
[88.963559] Dynamic subtest vcs0: SUCCESS (0.043s)
[88.972792] Starting dynamic subtest: vcs1
[89.006440] Dynamic subtest vcs1: SUCCESS (0.042s)
[89.015447] Starting dynamic subtest: vecs0
[89.048168] Dynamic subtest vecs0: SUCCESS (0.041s)
[89.049881] Subtest u-submit-late-slice: SUCCESS (0.231s)
[89.493778] [008/133] (938s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[90.979149] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[90.980807] Starting dynamic subtest: pipe-A-HDMI-A-1
[90.995311] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[91.004514] Starting dynamic subtest: pipe-B-HDMI-A-1
[91.019358] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[91.028722] Starting dynamic subtest: pipe-C-HDMI-A-1
[91.043834] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[91.052911] Starting dynamic subtest: pipe-D-HDMI-A-1
[91.068642] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[91.070362] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SUCCESS (0.008s)
[91.215511] [009/133] (937s left) kms_cursor_legacy (torture-move)
[92.700571] Starting subtest: torture-move
[92.702160] Starting dynamic subtest: pipe-A
[98.243507] Dynamic subtest pipe-A: SUCCESS (5.536s)
[98.253210] Starting dynamic subtest: pipe-B
[103.730663] Dynamic subtest pipe-B: SUCCESS (5.488s)
[103.739826] Starting dynamic subtest: pipe-C
[109.194312] Dynamic subtest pipe-C: SUCCESS (5.462s)
[109.203553] Starting dynamic subtest: pipe-D
[114.677935] Dynamic subtest pipe-D: SUCCESS (5.472s)
[114.687248] Starting dynamic subtest: all-pipes
[120.144916] Dynamic subtest all-pipes: SUCCESS (5.476s)
[120.146425] Subtest torture-move: SUCCESS (27.436s)
[120.295083] [010/133] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[121.801953] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[121.805156] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[122.061767] [011/133] (906s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[123.565234] Starting subtest: psr-rgb101010-draw-mmap-wc
[123.568274] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[123.766649] [012/133] (905s left) i915_drm_fdinfo (virtual-busy-idle)
[123.816375] Starting subtest: virtual-busy-idle
[123.819232] Subtest virtual-busy-idle: SKIP (0.000s)
[123.931431] [013/133] (905s left) kms_vblank (ts-continuation-modeset)
[125.416111] Starting subtest: ts-continuation-modeset
[125.419236] Starting dynamic subtest: pipe-A-HDMI-A-1
[125.860167] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.442s)
[125.872442] Starting dynamic subtest: pipe-D-HDMI-A-1
[126.129188] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.265s)
[126.130699] Subtest ts-continuation-modeset: SUCCESS (0.713s)
[126.288450] [014/133] (902s left) i915_pm_rps (thresholds-idle)
[126.345146] Starting subtest: thresholds-idle
[126.348393] Subtest thresholds-idle: SKIP (0.000s)
[126.452840] [015/133] (902s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[127.939403] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[127.940949] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.954799] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[127.964192] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.978505] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[127.987454] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.001873] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[128.011118] Starting dynamic subtest: pipe-D-HDMI-A-1
[128.026472] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[128.028366] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.008s)
[128.182350] [016/133] (900s left) gem_ctx_bad_destroy (invalid-default-ctx)
[128.228627] Starting subtest: invalid-default-ctx
[128.230203] Subtest invalid-default-ctx: SUCCESS (0.000s)
[128.350354] [017/133] (900s left) gem_fence_thrash (bo-write-verify-threaded-y)
[128.393917] Starting subtest: bo-write-verify-threaded-y
[128.399200] Subtest bo-write-verify-threaded-y: SKIP (0.002s)
[128.481302] [018/133] (900s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[129.992777] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[129.996180] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[130.164353] [019/133] (899s left) kms_color_pipeline (plane-lut1d-lut1d)
[131.652157] Starting subtest: plane-lut1d-lut1d
[131.852506] Starting dynamic subtest: pipe-A-plane-0
[132.102974] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s)
[132.139239] Starting dynamic subtest: pipe-A-plane-1
[132.303198] Dynamic subtest pipe-A-plane-1: SUCCESS (0.198s)
[132.335886] Starting dynamic subtest: pipe-A-plane-2
[132.503054] Dynamic subtest pipe-A-plane-2: SUCCESS (0.198s)
[132.788929] Starting dynamic subtest: pipe-B-plane-0
[132.953419] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s)
[132.962945] Starting dynamic subtest: pipe-B-plane-1
[133.122228] Dynamic subtest pipe-B-plane-1: SUCCESS (0.167s)
[133.152832] Starting dynamic subtest: pipe-B-plane-2
[133.322217] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s)
[133.614942] Starting dynamic subtest: pipe-C-plane-0
[133.771506] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[133.799871] Starting dynamic subtest: pipe-C-plane-1
[133.987983] Dynamic subtest pipe-C-plane-1: SUCCESS (0.215s)
[134.015233] Starting dynamic subtest: pipe-C-plane-2
[134.204660] Dynamic subtest pipe-C-plane-2: SUCCESS (0.215s)
[134.504390] Starting dynamic subtest: pipe-D-plane-0
[134.678411] Dynamic subtest pipe-D-plane-0: SUCCESS (0.200s)
[134.691847] Starting dynamic subtest: pipe-D-plane-1
[134.861929] Dynamic subtest pipe-D-plane-1: SUCCESS (0.182s)
[134.875768] Starting dynamic subtest: pipe-D-plane-2
[135.062035] Dynamic subtest pipe-D-plane-2: SUCCESS (0.199s)
[135.114976] Subtest plane-lut1d-lut1d: SUCCESS (3.462s)
[135.285549] [020/133] (894s left) gem_ctx_shared (create-shared-gtt)
[135.346033] Starting subtest: create-shared-gtt
[137.499657] Subtest create-shared-gtt: SUCCESS (2.150s)
[138.339786] [021/133] (891s left) gem_exec_create (basic)
[138.397188] Starting subtest: basic
[138.398780] Starting dynamic subtest: smem
[140.497746] Dynamic subtest smem: SUCCESS (2.102s)
[140.507496] Starting dynamic subtest: lmem0
[142.592687] Dynamic subtest lmem0: SUCCESS (2.094s)
[142.594215] Subtest basic: SUCCESS (4.197s)
[142.880141] [022/133] (886s left) syncobj_timeline (single-wait-signaled)
[142.927632] Starting subtest: single-wait-signaled
[142.929194] Subtest single-wait-signaled: SUCCESS (0.001s)
[143.040940] [023/133] (886s left) kms_chamelium_audio (dp-audio)
[144.563237] Subtest dp-audio: SKIP (0.000s)
[144.677710] [024/133] (885s left) gem_pwrite_snooped
[144.855885] [025/133] (885s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[146.348713] Starting subtest: fbc-rgb101010-draw-render
[149.314895] Subtest fbc-rgb101010-draw-render: SUCCESS (2.968s)
[149.525921] [026/133] (880s left) perf (gen12-invalid-class-instance)
[149.644502] Starting subtest: gen12-invalid-class-instance
[149.665450] Subtest gen12-invalid-class-instance: SUCCESS (0.022s)
[149.743251] [027/133] (880s left) kms_psr (fbc-psr-primary-page-flip)
[151.237703] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[151.306633] [028/133] (878s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[152.816477] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[153.947626] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.131s)
[154.187297] [029/133] (876s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[155.689231] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[155.692521] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[155.862642] [030/133] (874s left) gem_exec_params (sol-reset-invalid)
[155.914079] Starting subtest: sol-reset-invalid
[155.918478] Subtest sol-reset-invalid: SUCCESS (0.002s)
[156.118698] [031/133] (874s left) gem_mmap_gtt (zero-extend)
[156.165994] Subtest zero-extend: SKIP (0.000s)
[156.239813] [032/133] (874s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[157.746108] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[158.846901] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.101s)
[159.046319] [033/133] (871s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[160.531412] Starting subtest: primary-x-tiled-reflect-x-0
[171.291749] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.760s)
[171.506278] [034/133] (859s left) kms_big_fb (linear-32bpp-rotate-0)
[173.012838] Starting subtest: linear-32bpp-rotate-0
[175.224435] Subtest linear-32bpp-rotate-0: SUCCESS (2.211s)
[175.476754] [035/133] (855s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[176.961923] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[176.964905] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[177.095509] [036/133] (853s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[178.587851] Starting subtest: crc-primary-basic-yf-tiled-ccs
[178.589316] Starting dynamic subtest: pipe-A-HDMI-A-1
[178.603450] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[178.613026] Starting dynamic subtest: pipe-B-HDMI-A-1
[178.628024] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[178.637158] Starting dynamic subtest: pipe-C-HDMI-A-1
[178.652103] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[178.661559] Starting dynamic subtest: pipe-D-HDMI-A-1
[178.677920] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[178.681170] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.009s)
[178.836195] [037/133] (852s left) kms_plane (pixel-format-x-tiled-modifier)
[180.321619] Starting subtest: pixel-format-x-tiled-modifier
[180.354111] Starting dynamic subtest: pipe-A-plane-0
[181.470799] Dynamic subtest pipe-A-plane-0: SUCCESS (1.117s)
[181.483796] Starting dynamic subtest: pipe-A-plane-3
[182.304322] Dynamic subtest pipe-A-plane-3: SUCCESS (0.832s)
[182.341178] Starting dynamic subtest: pipe-A-plane-5
[183.021995] Dynamic subtest pipe-A-plane-5: SUCCESS (0.716s)
[183.060924] Starting dynamic subtest: pipe-A-plane-7
[183.065152] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[183.196214] Starting dynamic subtest: pipe-B-plane-0
[184.188746] Dynamic subtest pipe-B-plane-0: SUCCESS (1.000s)
[184.216518] Starting dynamic subtest: pipe-B-plane-3
[185.054969] Dynamic subtest pipe-B-plane-3: SUCCESS (0.865s)
[185.088089] Starting dynamic subtest: pipe-B-plane-5
[185.705585] Dynamic subtest pipe-B-plane-5: SUCCESS (0.649s)
[185.719248] Starting dynamic subtest: pipe-B-plane-7
[185.722524] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[185.759866] Subtest pixel-format-x-tiled-modifier: SUCCESS (5.437s)
[186.000517] [038/133] (845s left) kms_psr (psr2-primary-render)
[187.486472] Subtest psr2-primary-render: SKIP (0.000s)
[187.565659] [039/133] (843s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[189.055543] Starting subtest: cursor-vs-flip-atomic
[220.841204] Subtest cursor-vs-flip-atomic: SUCCESS (31.786s)
[221.013893] [040/133] (810s left) gem_ctx_freq (sysfs)
[221.069890] Starting subtest: sysfs
[221.071456] Starting dynamic subtest: gt0
[226.730422] Dynamic subtest gt0: SUCCESS (5.659s)
[226.733296] Subtest sysfs: SUCCESS (5.661s)
[226.921594] [041/133] (804s left) gem_lmem_swapping (heavy-verify-multi)
[231.099388] Starting subtest: heavy-verify-multi
[231.100783] Starting dynamic subtest: lmem0
[246.222157] Dynamic subtest lmem0: SUCCESS (15.120s)
[246.223664] Subtest heavy-verify-multi: SUCCESS (15.121s)
[247.635013] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[247.636414] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true
[247.639111] [042/133] (783s left) kms_plane_multiple (tiling-none)
[252.326513] Starting subtest: tiling-none
[252.328061] Starting dynamic subtest: pipe-A-HDMI-A-1
[253.165818] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.837s)
[253.176515] Starting dynamic subtest: pipe-B-HDMI-A-1
[253.876308] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.703s)
[253.888927] Starting dynamic subtest: pipe-C-HDMI-A-1
[254.618497] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.724s)
[254.654935] Starting dynamic subtest: pipe-D-HDMI-A-1
[255.327191] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.727s)
[255.328791] Subtest tiling-none: SUCCESS (2.999s)
[255.575365] [FACT kms_plane_multiple (tiling-none)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[255.578758] [FACT kms_plane_multiple (tiling-none)] new: kernel.kmod_is_loaded.i915: true
[255.585109] [043/133] (775s left) gem_partial_pwrite_pread (reads)
[255.663503] Subtest reads: SKIP (0.000s)
[255.775960] [044/133] (775s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[257.262998] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[257.266553] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[257.466793] [045/133] (774s left) core_getclient (basic)
[257.514960] Starting subtest: basic
[257.516720] Subtest basic: SUCCESS (0.000s)
[257.649976] [046/133] (774s left) gem_eio (create)
[257.815665] Starting subtest: create
[258.044949] Subtest create: SUCCESS (0.230s)
[259.624589] [047/133] (772s left) gem_exec_schedule (smoketest)
[259.846923] Starting subtest: smoketest
[259.848948] Starting dynamic subtest: rcs0
[265.308661] Dynamic subtest rcs0: SUCCESS (5.445s)
[265.324023] Starting dynamic subtest: bcs0
[270.761836] Dynamic subtest bcs0: SUCCESS (5.455s)
[270.774104] Starting dynamic subtest: vcs0
[276.208197] Dynamic subtest vcs0: SUCCESS (5.444s)
[276.219712] Starting dynamic subtest: vcs1
[281.648138] Dynamic subtest vcs1: SUCCESS (5.438s)
[281.660523] Starting dynamic subtest: vecs0
[287.113763] Dynamic subtest vecs0: SUCCESS (5.455s)
[287.115245] Subtest smoketest: SUCCESS (27.243s)
[287.400982] [048/133] (744s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[288.888135] Starting subtest: basic-flip-after-cursor-legacy
[289.899918] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.009s)
[290.076681] [049/133] (741s left) kms_cursor_edge_walk (64x64-top-edge)
[291.565529] Starting subtest: 64x64-top-edge
[291.567045] Starting dynamic subtest: pipe-A-HDMI-A-1
[294.884091] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.316s)
[294.895656] Starting dynamic subtest: pipe-D-HDMI-A-1
[298.097902] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.213s)
[298.099381] Subtest 64x64-top-edge: SUCCESS (6.534s)
[298.279876] [050/133] (733s left) syncobj_eventfd (binary-wait-before-signal)
[298.339327] Starting subtest: binary-wait-before-signal
[298.370803] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[298.541168] [051/133] (733s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[298.589170] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[298.590792] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[298.732136] [052/133] (733s left) core_auth (basic-auth)
[298.779359] Starting subtest: basic-auth
[298.780990] Subtest basic-auth: SUCCESS (0.001s)
[298.896880] [053/133] (733s left) kms_flip (flip-vs-panning)
[300.384480] Starting subtest: flip-vs-panning
[300.388832] Starting dynamic subtest: A-HDMI-A1
[308.138712] Dynamic subtest A-HDMI-A1: SUCCESS (7.749s)
[308.178537] Starting dynamic subtest: B-HDMI-A1
[315.864690] Dynamic subtest B-HDMI-A1: SUCCESS (7.718s)
[315.904767] Starting dynamic subtest: C-HDMI-A1
[323.591918] Dynamic subtest C-HDMI-A1: SUCCESS (7.719s)
[323.607965] Starting dynamic subtest: D-HDMI-A1
[331.285530] Dynamic subtest D-HDMI-A1: SUCCESS (7.687s)
[331.304351] Subtest flip-vs-panning: SUCCESS (30.920s)
[331.573983] [054/133] (700s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[333.061869] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[333.065395] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[333.275134] [055/133] (699s left) gem_cs_tlb (engines)
[333.327247] Starting subtest: engines
[333.328675] Starting dynamic subtest: rcs0
[335.487348] Dynamic subtest rcs0: SUCCESS (2.156s)
[335.498834] Starting dynamic subtest: bcs0
[337.641937] Dynamic subtest bcs0: SUCCESS (2.153s)
[337.653082] Starting dynamic subtest: vcs0
[339.797136] Dynamic subtest vcs0: SUCCESS (2.154s)
[339.808183] Starting dynamic subtest: vcs1
[341.951924] Dynamic subtest vcs1: SUCCESS (2.153s)
[341.962857] Starting dynamic subtest: vecs0
[344.107179] Dynamic subtest vecs0: SUCCESS (2.153s)
[344.108806] Subtest engines: SUCCESS (10.776s)
[344.268832] [056/133] (688s left) gem_vm_create (isolation)
[344.320135] Starting subtest: isolation
[344.332226] Subtest isolation: SUCCESS (0.012s)
[344.515682] [057/133] (688s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[346.009991] Starting subtest: psr-1p-pri-indfb-multidraw
[346.015228] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[346.237608] [058/133] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[347.730274] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[347.733195] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[347.861847] [059/133] (684s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[349.404720] Starting subtest: dp-mst-type-0-suspend-resume
[349.408069] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[349.600901] [060/133] (683s left) gen9_exec_parse (bb-start-param)
[349.653293] Subtest bb-start-param: SKIP (0.000s)
[349.737495] [061/133] (683s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[351.224116] Starting subtest: flip-vs-dpms-off-vs-modeset
[351.229282] Starting dynamic subtest: A-HDMI-A1
[352.072402] Dynamic subtest A-HDMI-A1: SUCCESS (0.842s)
[352.083930] Starting dynamic subtest: B-HDMI-A1
[352.774242] Dynamic subtest B-HDMI-A1: SUCCESS (0.700s)
[352.785608] Starting dynamic subtest: C-HDMI-A1
[353.486890] Dynamic subtest C-HDMI-A1: SUCCESS (0.710s)
[353.498429] Starting dynamic subtest: D-HDMI-A1
[354.189848] Dynamic subtest D-HDMI-A1: SUCCESS (0.701s)
[354.193895] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.968s)
[354.383551] [062/133] (678s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[355.876543] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[355.974369] [063/133] (677s left) core_getversion (all-cards)
[356.030368] Starting subtest: all-cards
[356.053797] Subtest all-cards: SUCCESS (0.026s)
[356.131663] [064/133] (677s left) gem_ringfill (legacy-basic)
[356.577057] Starting subtest: legacy-basic
[356.579919] Starting dynamic subtest: default
[356.661730] Dynamic subtest default: SUCCESS (0.087s)
[356.673971] Starting dynamic subtest: render
[356.703717] Dynamic subtest render: SUCCESS (0.040s)
[356.723106] Starting dynamic subtest: bsd
[356.746825] Dynamic subtest bsd: SUCCESS (0.041s)
[356.770731] Starting dynamic subtest: bsd1
[356.792897] Dynamic subtest bsd1: SUCCESS (0.043s)
[356.816781] Starting dynamic subtest: bsd2
[356.837947] Dynamic subtest bsd2: SUCCESS (0.042s)
[356.861869] Starting dynamic subtest: blt
[356.883953] Dynamic subtest blt: SUCCESS (0.043s)
[356.907863] Starting dynamic subtest: vebox
[356.929848] Dynamic subtest vebox: SUCCESS (0.043s)
[356.931822] Subtest legacy-basic: SUCCESS (0.361s)
[357.112807] [065/133] (676s left) gem_media_fill (media-fill)
[357.168661] Starting subtest: media-fill
[357.170283] Starting dynamic subtest: smem
[357.189343] Dynamic subtest smem: SUCCESS (0.020s)
[357.202654] Starting dynamic subtest: lmem0
[357.204281] Dynamic subtest lmem0: SUCCESS (0.010s)
[357.206110] Subtest media-fill: SUCCESS (0.033s)
[357.497207] [066/133] (675s left) perf_pmu (render-node-busy)
[357.557572] Starting subtest: render-node-busy
[357.558830] Starting dynamic subtest: rcs0
[358.157967] Dynamic subtest rcs0: SUCCESS (0.599s)
[358.173933] Starting dynamic subtest: bcs0
[358.720914] Dynamic subtest bcs0: SUCCESS (0.557s)
[358.736721] Starting dynamic subtest: vcs0
[359.278950] Dynamic subtest vcs0: SUCCESS (0.552s)
[359.294700] Starting dynamic subtest: vcs1
[359.836988] Dynamic subtest vcs1: SUCCESS (0.552s)
[359.852920] Starting dynamic subtest: vecs0
[360.395042] Dynamic subtest vecs0: SUCCESS (0.552s)
[360.400958] Subtest render-node-busy: SUCCESS (2.841s)
[360.552613] [067/133] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[362.045974] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[362.048909] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[362.239506] [068/133] (671s left) gem_partial_pwrite_pread (write-display)
[362.290361] Subtest write-display: SKIP (0.000s)
[362.395993] [069/133] (671s left) gem_userptr_blits (dmabuf-sync)
[362.456155] Starting subtest: dmabuf-sync
[362.461088] Subtest dmabuf-sync: SKIP (0.003s)
[362.690879] [070/133] (671s left) i915_pm_rps (basic-api)
[362.754953] Starting subtest: basic-api
[362.757990] Subtest basic-api: SKIP (0.000s)
[362.867813] [071/133] (671s left) syncobj_basic (bad-handle-to-fd)
[362.916560] Starting subtest: bad-handle-to-fd
[362.918106] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[363.040920] [072/133] (670s left) sysfs_preempt_timeout (idempotent)
[363.092778] Starting subtest: idempotent
[363.094406] Starting dynamic subtest: vecs0
[363.095973] Dynamic subtest vecs0: SUCCESS (0.001s)
[363.107780] Starting dynamic subtest: vcs0
[363.109371] Dynamic subtest vcs0: SUCCESS (0.001s)
[363.121235] Starting dynamic subtest: bcs0
[363.122941] Dynamic subtest bcs0: SUCCESS (0.001s)
[363.134520] Starting dynamic subtest: rcs0
[363.136213] Dynamic subtest rcs0: SUCCESS (0.001s)
[363.148135] Starting dynamic subtest: vcs1
[363.149952] Dynamic subtest vcs1: SUCCESS (0.001s)
[363.151619] Subtest idempotent: SUCCESS (0.013s)
[363.217341] [073/133] (670s left) gem_pxp (reject-modify-context-protection-off-2)
[365.792753] Starting subtest: reject-modify-context-protection-off-2
[365.796297] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[365.910808] [074/133] (668s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[365.989198] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[366.082548] [075/133] (668s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[366.130393] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[366.242073] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[366.405418] [076/133] (667s left) syncobj_basic (bad-flags-handle-to-fd)
[366.452988] Starting subtest: bad-flags-handle-to-fd
[366.454563] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[366.569951] [077/133] (667s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[368.061641] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[368.064803] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[368.263672] [078/133] (666s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[369.776594] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[371.082633] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.305s)
[371.320946] [079/133] (663s left) gem_exec_balancer (sliced)
[371.381463] Starting subtest: sliced
[371.384945] Subtest sliced: SKIP (0.000s)
[371.820808] [080/133] (662s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[373.318514] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[373.394635] [081/133] (661s left) syncobj_timeline (multi-wait-for-submit-signaled)
[373.442052] Starting subtest: multi-wait-for-submit-signaled
[373.443618] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[373.553269] [082/133] (661s left) syncobj_wait (multi-wait-signaled)
[373.611838] Starting subtest: multi-wait-signaled
[373.613797] Subtest multi-wait-signaled: SUCCESS (0.001s)
[373.743748] [083/133] (661s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[375.238985] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[375.242824] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[375.413157] [084/133] (659s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[376.917537] Starting subtest: yf-tiled-32bpp-rotate-90
[376.920586] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[377.087709] [085/133] (658s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[378.592556] Starting subtest: y-tiled-8bpp-rotate-270
[378.707192] Subtest y-tiled-8bpp-rotate-270: SKIP (0.111s)
[378.853756] [086/133] (656s left) gem_exec_reloc (basic-write-read-noreloc)
[378.927232] Subtest basic-write-read-noreloc: SKIP (0.000s)
[379.032655] [087/133] (656s left) kms_dsc (dsc-with-output-formats)
[380.519811] Starting subtest: dsc-with-output-formats
[380.536658] Subtest dsc-with-output-formats: SKIP (0.001s)
[380.650375] [088/133] (654s left) kms_chamelium_color (gamma)
[382.139864] Subtest gamma: SKIP (0.000s)
[382.234934] [089/133] (653s left) kms_psr (psr-suspend)
[383.726562] Subtest psr-suspend: SKIP (0.000s)
[383.896687] [090/133] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[385.396382] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[385.399535] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[385.553684] [091/133] (650s left) kms_vblank (accuracy-idle)
[387.040969] Starting subtest: accuracy-idle
[387.042826] Starting dynamic subtest: pipe-A-HDMI-A-1
[389.369635] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.329s)
[389.385884] Starting dynamic subtest: pipe-D-HDMI-A-1
[391.546190] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.171s)
[391.547656] Subtest accuracy-idle: SUCCESS (4.508s)
[391.714583] [092/133] (644s left) kms_async_flips (async-flip-suspend-resume)
[393.202696] Starting subtest: async-flip-suspend-resume
[393.473632] Starting dynamic subtest: pipe-A-HDMI-A-1
[415.431281] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (11.508s)
[415.611005] Starting dynamic subtest: pipe-B-HDMI-A-1
[438.419996] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (10.946s)
[438.577811] Starting dynamic subtest: pipe-C-HDMI-A-1
[461.410297] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (10.933s)
[461.574383] Starting dynamic subtest: pipe-D-HDMI-A-1
[484.407417] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (10.932s)
[484.408935] Subtest async-flip-suspend-resume: SUCCESS (45.063s)
[490.765421] [093/133] (551s left) kms_psr (psr2-cursor-blt)
[492.255743] Subtest psr2-cursor-blt: SKIP (0.000s)
[492.350073] [094/133] (549s left) kms_plane (plane-position-covered)
[493.841632] Starting subtest: plane-position-covered
[494.267538] Starting dynamic subtest: pipe-A-plane-1
[494.641837] Dynamic subtest pipe-A-plane-1: SUCCESS (0.373s)
[494.656104] Starting dynamic subtest: pipe-A-plane-2
[495.015542] Dynamic subtest pipe-A-plane-2: SUCCESS (0.373s)
[495.029008] Starting dynamic subtest: pipe-A-plane-3
[495.391151] Dynamic subtest pipe-A-plane-3: SUCCESS (0.374s)
[495.404895] Starting dynamic subtest: pipe-A-plane-4
[495.766650] Dynamic subtest pipe-A-plane-4: SUCCESS (0.374s)
[495.780405] Starting dynamic subtest: pipe-A-plane-5
[496.140974] Dynamic subtest pipe-A-plane-5: SUCCESS (0.374s)
[496.154652] Starting dynamic subtest: pipe-A-plane-6
[496.517398] Dynamic subtest pipe-A-plane-6: SUCCESS (0.374s)
[496.531401] Starting dynamic subtest: pipe-A-plane-7
[496.539341] Dynamic subtest pipe-A-plane-7: SUCCESS (0.020s)
[496.831738] Starting dynamic subtest: pipe-B-plane-1
[497.192286] Dynamic subtest pipe-B-plane-1: SUCCESS (0.374s)
[497.205946] Starting dynamic subtest: pipe-B-plane-2
[497.571745] Dynamic subtest pipe-B-plane-2: SUCCESS (0.379s)
[497.585914] Starting dynamic subtest: pipe-B-plane-3
[497.949001] Dynamic subtest pipe-B-plane-3: SUCCESS (0.375s)
[497.963092] Starting dynamic subtest: pipe-B-plane-4
[498.326433] Dynamic subtest pipe-B-plane-4: SUCCESS (0.375s)
[498.340425] Starting dynamic subtest: pipe-B-plane-5
[498.700882] Dynamic subtest pipe-B-plane-5: SUCCESS (0.373s)
[498.715019] Starting dynamic subtest: pipe-B-plane-6
[499.061684] Dynamic subtest pipe-B-plane-6: SUCCESS (0.359s)
[499.076777] Starting dynamic subtest: pipe-B-plane-7
[499.090834] Dynamic subtest pipe-B-plane-7: SUCCESS (0.027s)
[499.092639] Subtest plane-position-covered: SUCCESS (5.250s)
[499.276119] [095/133] (542s left) kms_joiner (basic-force-big-joiner)
[500.770141] Starting subtest: basic-force-big-joiner
[500.773805] Subtest basic-force-big-joiner: SKIP (0.000s)
[500.933948] [096/133] (541s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[502.423021] Starting subtest: 2x-cursor-vs-flip-atomic
[502.426268] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.003s)
[502.582620] [097/133] (539s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[504.110906] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[504.230177] [098/133] (538s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[505.727128] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[505.730611] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[505.915523] [099/133] (536s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[507.408063] Starting subtest: stress-xrgb8888-4tiled
[507.411314] Subtest stress-xrgb8888-4tiled: SKIP (0.000s)
[507.491060] [100/133] (535s left) kms_pm_dc (dc6-psr)
[509.986596] Starting subtest: dc6-psr
[509.989298] Subtest dc6-psr: SKIP (0.000s)
[510.115950] [101/133] (532s left) kms_cursor_crc (cursor-alpha-transparent)
[511.604149] Starting subtest: cursor-alpha-transparent
[511.605984] Starting dynamic subtest: pipe-A-HDMI-A-1
[512.231985] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.626s)
[512.245711] Starting dynamic subtest: pipe-D-HDMI-A-1
[512.688604] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.455s)
[512.690286] Subtest cursor-alpha-transparent: SUCCESS (1.087s)
[513.372153] [102/133] (529s left) i915_drm_fdinfo (virtual-busy-hang)
[513.422743] Starting subtest: virtual-busy-hang
[513.425639] Subtest virtual-busy-hang: SKIP (0.000s)
[513.536316] [103/133] (529s left) kms_psr2_su (page_flip-xrgb8888)
[513.585767] Subtest page_flip-XRGB8888: SKIP (0.000s)
[513.665507] [104/133] (529s left) kms_force_connector_basic (force-connector-state)
[513.821296] Starting subtest: force-connector-state
[515.651097] Subtest force-connector-state: SUCCESS (1.829s)
[517.412585] [105/133] (525s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[518.902964] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[518.906185] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[519.055919] [106/133] (524s left) gem_tiled_blits (basic)
[519.111305] Subtest basic: SKIP (0.000s)
[519.199165] [107/133] (523s left) gem_userptr_blits (access-control)
[519.274407] Starting subtest: access-control
[519.278133] Subtest access-control: SKIP (0.000s)
[519.508261] [108/133] (523s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[521.004099] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[521.008156] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[521.195538] [109/133] (522s left) gem_exec_fence (syncobj-timeline-chain-engines)
[521.764818] Starting subtest: syncobj-timeline-chain-engines
[521.909247] Subtest syncobj-timeline-chain-engines: SUCCESS (0.148s)
[522.211143] [110/133] (521s left) gem_ccs (block-copy-uncompressed)
[522.261894] Starting subtest: block-copy-uncompressed
[522.265175] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[522.298068] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.035s)
[522.313650] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[522.315214] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.016s)
[522.330806] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[522.377527] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.061s)
[522.393118] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[522.438590] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.059s)
[522.454343] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[522.456037] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[522.471920] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-lmem0
[522.473298] Dynamic subtest ymajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[522.486938] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-smem
[522.534035] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.060s)
[522.547556] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-lmem0
[522.594667] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.059s)
[522.596037] Subtest block-copy-uncompressed: SUCCESS (0.334s)
[522.792805] [111/133] (520s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[524.308657] Starting subtest: 4-tiled-64bpp-rotate-270
[524.311838] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[524.492019] [112/133] (519s left) gem_exec_schedule (preemptive-hang)
[524.666902] Starting subtest: preemptive-hang
[524.668376] Starting dynamic subtest: rcs0
[534.197501] Dynamic subtest rcs0: SUCCESS (9.532s)
[534.211760] Starting dynamic subtest: bcs0
[543.218219] Dynamic subtest bcs0: SUCCESS (9.018s)
[543.232847] Starting dynamic subtest: vcs0
[552.250002] Dynamic subtest vcs0: SUCCESS (9.030s)
[552.264096] Starting dynamic subtest: vcs1
[561.208820] Dynamic subtest vcs1: SUCCESS (8.958s)
[561.222691] Starting dynamic subtest: vecs0
[570.226627] Dynamic subtest vecs0: SUCCESS (9.016s)
[570.227960] Subtest preemptive-hang: SUCCESS (45.561s)
[570.524791] [113/133] (473s left) kms_pm_rpm (universal-planes)
[574.151733] Starting subtest: universal-planes
[574.160707] Starting dynamic subtest: plane-34
[580.948418] Dynamic subtest plane-34: SUCCESS (6.792s)
[581.024466] Starting dynamic subtest: plane-64
[587.875434] Dynamic subtest plane-64: SUCCESS (6.916s)
[587.951122] Starting dynamic subtest: plane-94
[594.691941] Dynamic subtest plane-94: SUCCESS (6.812s)
[594.769060] Starting dynamic subtest: plane-124
[602.404732] Dynamic subtest plane-124: SUCCESS (7.705s)
[602.480272] Starting dynamic subtest: plane-134
[609.325400] Dynamic subtest plane-134: SUCCESS (6.913s)
[609.400183] Starting dynamic subtest: plane-144
[616.141801] Dynamic subtest plane-144: SUCCESS (6.807s)
[616.218252] Starting dynamic subtest: plane-154
[623.762660] Dynamic subtest plane-154: SUCCESS (7.612s)
[623.838481] Starting dynamic subtest: plane-164
[630.489430] Dynamic subtest plane-164: SUCCESS (6.719s)
[630.492172] Subtest universal-planes: SUCCESS (56.340s)
[631.453149] [114/133] (412s left) gem_spin_batch (spin-all-new)
[631.513651] Starting subtest: spin-all-new
[631.550132] Subtest spin-all-new: SUCCESS (0.036s)
[631.895890] [115/133] (412s left) gem_exec_reloc (basic-gtt-read-active)
[631.948058] Subtest basic-gtt-read-active: SKIP (0.000s)
[632.053405] [116/133] (412s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[632.101980] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[632.103536] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[632.233430] [117/133] (411s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[633.720884] Starting subtest: 2x-long-flip-vs-cursor-atomic
[633.726225] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.003s)
[633.871717] [118/133] (410s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[635.367123] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[635.370361] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[635.573508] [119/133] (408s left) perf_pmu (semaphore-busy)
[635.626593] Starting subtest: semaphore-busy
[635.628098] Starting dynamic subtest: rcs0
[637.275550] Dynamic subtest rcs0: SUCCESS (1.643s)
[637.290080] Starting dynamic subtest: bcs0
[638.906278] Dynamic subtest bcs0: SUCCESS (1.625s)
[638.920540] Starting dynamic subtest: vcs0
[640.546627] Dynamic subtest vcs0: SUCCESS (1.636s)
[640.566453] Starting dynamic subtest: vcs1
[642.203920] Dynamic subtest vcs1: SUCCESS (1.648s)
[642.218317] Starting dynamic subtest: vecs0
[643.834684] Dynamic subtest vecs0: SUCCESS (1.626s)
[643.836730] Subtest semaphore-busy: SUCCESS (8.207s)
[643.997809] [120/133] (400s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[645.491312] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[645.570117] [121/133] (398s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[647.063442] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[647.066813] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[647.269130] [122/133] (397s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[648.763423] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[648.766818] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[648.985531] [123/133] (395s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[649.033932] Starting subtest: multi-wait-all-for-submit-available-submitted
[649.035547] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[649.165204] [124/133] (395s left) api_intel_allocator (two-level-inception)
[649.215088] Starting subtest: two-level-inception
[654.656342] Subtest two-level-inception: SUCCESS (5.440s)
[654.827094] [125/133] (390s left) kms_async_flips (test-time-stamp)
[656.315111] Starting subtest: test-time-stamp
[656.586930] Starting dynamic subtest: pipe-A-HDMI-A-1
[656.951277] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.363s)
[657.165649] Starting dynamic subtest: pipe-B-HDMI-A-1
[657.250593] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.096s)
[657.444923] Starting dynamic subtest: pipe-C-HDMI-A-1
[657.533877] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.100s)
[657.737349] Starting dynamic subtest: pipe-D-HDMI-A-1
[657.826431] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.100s)
[657.828076] Subtest test-time-stamp: SUCCESS (1.513s)
[658.152229] [126/133] (386s left) drm_read (empty-nonblock)
[659.699728] Starting subtest: empty-nonblock
[659.701471] Subtest empty-nonblock: SUCCESS (0.000s)
[659.946208] [127/133] (385s left) kms_lease (lease-again)
[661.439711] Starting subtest: lease-again
[661.443708] Starting dynamic subtest: pipe-A-HDMI-A-1
[661.445385] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.003s)
[661.460527] Starting dynamic subtest: pipe-B-HDMI-A-1
[661.462445] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[661.476935] Starting dynamic subtest: pipe-C-HDMI-A-1
[661.478553] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.003s)
[661.492967] Starting dynamic subtest: pipe-D-HDMI-A-1
[661.494644] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.002s)
[661.496403] Subtest lease-again: SUCCESS (0.021s)
[661.626920] [128/133] (383s left) gem_exec_balancer (indices)
[661.686554] Starting subtest: indices
[663.777991] Subtest indices: SUCCESS (2.091s)
[664.200776] [129/133] (381s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[665.927921] Starting subtest: cursor-rapid-movement-256x85
[665.935200] Starting dynamic subtest: pipe-A-HDMI-A-1
[666.369994] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.435s)
[666.406930] Starting dynamic subtest: pipe-D-HDMI-A-1
[666.714631] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.321s)
[666.716220] Subtest cursor-rapid-movement-256x85: SUCCESS (0.786s)
[667.036128] [130/133] (378s left) gem_basic (create-fd-close)
[667.084351] Starting subtest: create-fd-close
[667.088075] Subtest create-fd-close: SUCCESS (0.000s)
[667.260128] [131/133] (378s left) core_auth (many-magics)
[667.304923] Starting subtest: many-magics
[668.296288] Subtest many-magics: SUCCESS (0.991s)
[668.663338] [132/133] (376s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[670.236346] Starting subtest: 2x-absolute-wf_vblank-interruptible
[670.259629] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.022s)
[670.419572] [133/133] (375s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[671.908888] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[671.910398] Starting dynamic subtest: pipe-A
[672.629162] Dynamic subtest pipe-A: SUCCESS (0.722s)
[672.650284] Starting dynamic subtest: pipe-B
[673.386177] Dynamic subtest pipe-B: SUCCESS (0.755s)
[673.407958] Starting dynamic subtest: pipe-C
[674.142978] Dynamic subtest pipe-C: SUCCESS (0.755s)
[674.163834] Starting dynamic subtest: pipe-D
[674.899477] Dynamic subtest pipe-D: SUCCESS (0.754s)
[674.901390] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.993s)
[675.124019] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_flink_basic
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ppgtt
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: vgem_slow
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: i915_pm_rps
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_ctx_bad_destroy
results: parsing output: 16/ for test: gem_fence_thrash
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_color_pipeline
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: gem_exec_create
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_chamelium_audio
results: parsing output: 23/ for test: gem_pwrite_snooped
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: gem_ctx_freq
results: parsing output: 40/ for test: gem_lmem_swapping
results: parsing output: 41/ for test: kms_plane_multiple
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: core_getclient
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_cursor_edge_walk
results: parsing output: 49/ for test: syncobj_eventfd
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: core_auth
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: gem_cs_tlb
results: parsing output: 55/ for test: gem_vm_create
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: core_getversion
results: parsing output: 63/ for test: gem_ringfill
results: parsing output: 64/ for test: gem_media_fill
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_partial_pwrite_pread
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: i915_pm_rps
results: parsing output: 70/ for test: syncobj_basic
results: parsing output: 71/ for test: sysfs_preempt_timeout
results: parsing output: 72/ for test: gem_pxp
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_basic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_dsc
results: parsing output: 87/ for test: kms_chamelium_color
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_vblank
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_joiner
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_pipe_stress
results: parsing output: 99/ for test: kms_pm_dc
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: kms_psr2_su
results: parsing output: 103/ for test: kms_force_connector_basic
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: gem_tiled_blits
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_ccs
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: gem_spin_batch
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: drm_read
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_basic
results: parsing output: 130/ for test: core_auth
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_plane_scaling
Done.