[59.893099] Initializing watchdogs
[59.893203]   /dev/watchdog0
[59.910352] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.914762] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.917201] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.920770] [001/132] (960s left) gem_pxp (verify-pxp-stale-ctx-execution)
[60.062771] Starting subtest: verify-pxp-stale-ctx-execution
[61.128901] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[61.295592] [002/132] (959s left) kms_color_pipeline (plane-lut1d-lut1d)
[61.399140] Starting subtest: plane-lut1d-lut1d
[61.424670] Starting dynamic subtest: pipe-A-eDP-1
[62.135856] Dynamic subtest pipe-A-eDP-1: FAIL (0.333s)
[62.793472] Starting dynamic subtest: pipe-B-eDP-1
[63.632731] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[64.235583] Starting dynamic subtest: pipe-C-eDP-1
[65.103307] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[65.575360] Starting dynamic subtest: pipe-D-eDP-1
[66.408729] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[66.411455] Subtest plane-lut1d-lut1d: FAIL (4.682s)
[67.052060] [003/132] (953s left) template (a)
[67.150469] Starting subtest: A
[67.152873] Subtest A: SUCCESS (0.000s)
[67.381440] [004/132] (953s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[67.543219] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[67.545560] Starting dynamic subtest: pipe-A-default-mode
[70.318665] Dynamic subtest pipe-A-default-mode: SUCCESS (2.770s)
[70.321128] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.771s)
[71.170456] [005/132] (949s left) gem_mmap_offset (partial-remap)
[71.238749] Starting subtest: partial-remap
[71.240912] Starting dynamic subtest: smem0
[71.252451] Dynamic subtest smem0: SUCCESS (0.008s)
[71.254444] Subtest partial-remap: SUCCESS (0.009s)
[71.418689] [006/132] (949s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[71.815700] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[72.657171] [007/132] (948s left) kms_frontbuffer_tracking (fbc-tiling-y)
[72.755572] Starting subtest: fbc-tiling-y
[72.759763] Subtest fbc-tiling-y: SKIP (0.000s)
[72.895935] [008/132] (947s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[73.013291] Starting subtest: flip-vs-cursor-varying-size
[81.511041] Subtest flip-vs-cursor-varying-size: SUCCESS (8.491s)
[82.337032] [009/132] (938s left) kms_plane_cursor (primary)
[82.432075] Starting subtest: primary
[82.436451] Starting dynamic subtest: pipe-A-eDP-1-size-64
[84.998586] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.567s)
[85.025125] Starting dynamic subtest: pipe-A-eDP-1-size-128
[87.646109] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.628s)
[87.669703] Starting dynamic subtest: pipe-A-eDP-1-size-256
[90.314642] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.649s)
[90.628587] Starting dynamic subtest: pipe-B-eDP-1-size-64
[93.922081] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.299s)
[93.949332] Starting dynamic subtest: pipe-B-eDP-1-size-128
[96.513829] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[96.534619] Starting dynamic subtest: pipe-B-eDP-1-size-256
[99.069905] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.539s)
[99.390172] Starting dynamic subtest: pipe-C-eDP-1-size-64
[102.282573] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.900s)
[102.306601] Starting dynamic subtest: pipe-C-eDP-1-size-128
[104.438227] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.135s)
[104.462309] Starting dynamic subtest: pipe-C-eDP-1-size-256
[106.772642] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.313s)
[107.089053] Starting dynamic subtest: pipe-D-eDP-1-size-64
[110.020464] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.941s)
[110.049543] Starting dynamic subtest: pipe-D-eDP-1-size-128
[112.232441] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[112.256807] Starting dynamic subtest: pipe-D-eDP-1-size-256
[114.354051] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[114.660900] Subtest primary: SUCCESS (32.221s)
[115.476412] [010/132] (905s left) gem_ctx_persistence (saturated-hostile)
[115.545047] Starting subtest: saturated-hostile
[115.547276] Starting dynamic subtest: rcs0
[116.398435] Dynamic subtest rcs0: SUCCESS (0.856s)
[116.409883] Starting dynamic subtest: bcs0
[117.204749] Dynamic subtest bcs0: SUCCESS (0.804s)
[117.214801] Starting dynamic subtest: vcs0
[118.034778] Dynamic subtest vcs0: SUCCESS (0.828s)
[118.045327] Starting dynamic subtest: vcs1
[118.859829] Dynamic subtest vcs1: SUCCESS (0.823s)
[118.869893] Starting dynamic subtest: vecs0
[119.671722] Dynamic subtest vecs0: SUCCESS (0.809s)
[119.679921] Starting dynamic subtest: ccs0
[120.538127] Dynamic subtest ccs0: SUCCESS (0.865s)
[120.540673] Subtest saturated-hostile: SUCCESS (4.997s)
[120.640830] [011/132] (900s left) gem_ctx_shared (q-out-order)
[120.712013] Starting subtest: Q-out-order
[120.714747] Starting dynamic subtest: rcs0
[120.909974] Dynamic subtest rcs0: SUCCESS (0.197s)
[120.927165] Starting dynamic subtest: vcs0
[121.005301] Dynamic subtest vcs0: SUCCESS (0.095s)
[121.021341] Starting dynamic subtest: vcs1
[121.107998] Dynamic subtest vcs1: SUCCESS (0.102s)
[121.123132] Starting dynamic subtest: vecs0
[121.209704] Dynamic subtest vecs0: SUCCESS (0.101s)
[121.224630] Starting dynamic subtest: ccs0
[121.324857] Dynamic subtest ccs0: SUCCESS (0.114s)
[121.327371] Subtest Q-out-order: SUCCESS (0.613s)
[123.021221] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[123.025433] [012/132] (897s left) gem_exec_params (larger-than-life-batch)
[123.090772] Starting subtest: larger-than-life-batch
[125.339029] Subtest larger-than-life-batch: SUCCESS (2.248s)
[125.984695] [013/132] (895s left) gem_mmap_offset (pf-nonblock)
[126.073256] Starting subtest: pf-nonblock
[126.083804] Subtest pf-nonblock: SUCCESS (0.013s)
[126.264061] [014/132] (894s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[126.381059] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[126.383239] Starting dynamic subtest: pipe-A-eDP-1
[126.392094] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[126.404033] Starting dynamic subtest: pipe-B-eDP-1
[126.412591] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[126.424479] Starting dynamic subtest: pipe-C-eDP-1
[126.433292] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[126.442661] Starting dynamic subtest: pipe-D-eDP-1
[126.450984] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[126.455296] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[128.633051] [015/132] (892s left) vgem_basic (bad-flag)
[128.684671] Starting subtest: bad-flag
[128.686850] Subtest bad-flag: SUCCESS (0.000s)
[128.764750] [016/132] (892s left) vgem_basic (dmabuf-fence-before)
[128.806875] Starting subtest: dmabuf-fence-before
[128.809656] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[128.888083] [017/132] (892s left) gem_eio (wait-1us)
[129.115841] Starting subtest: wait-1us
[129.435139] Subtest wait-1us: SUCCESS (0.320s)
[129.620977] [018/132] (891s left) kms_pm_rpm (pm-caching)
[131.169341] Starting subtest: pm-caching
[131.174550] Subtest pm-caching: SKIP (0.000s)
[131.964991] [019/132] (889s left) gem_exec_balancer (bonded-pair)
[132.031662] Starting subtest: bonded-pair
[132.036277] Subtest bonded-pair: SKIP (0.000s)
[132.349274] [020/132] (888s left) kms_psr (fbc-psr-suspend)
[132.446603] Starting subtest: fbc-psr-suspend
[132.448813] Starting dynamic subtest: eDP-1
[132.452991] Dynamic subtest eDP-1: SKIP (0.000s)
[132.457119] Subtest fbc-psr-suspend: SKIP (0.001s)
[132.540209] [021/132] (888s left) gem_exec_reloc (basic-wc)
[132.616547] Subtest basic-wc: SKIP (0.000s)
[132.701271] [022/132] (888s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[132.799307] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[132.803488] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[132.917519] [023/132] (888s left) i915_drm_fdinfo (memory-info-purgeable)
[132.960666] Starting subtest: memory-info-purgeable
[132.962890] Starting dynamic subtest: smem0
[135.452629] Dynamic subtest smem0: SUCCESS (2.494s)
[135.455259] Subtest memory-info-purgeable: SUCCESS (2.495s)
[135.552972] [024/132] (885s left) kms_hdr (invalid-hdr)
[135.651577] Starting subtest: invalid-hdr
[137.743076] Starting dynamic subtest: pipe-A-eDP-1
[140.699650] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.956s)
[140.701943] Subtest invalid-hdr: SUCCESS (5.050s)
[140.865106] [025/132] (880s left) kms_flip_tiling (flip-change-tiling)
[140.970557] Starting subtest: flip-change-tiling
[140.972811] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[142.236446] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.267s)
[142.247683] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[142.370937] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[142.381065] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[142.515062] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[142.525073] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[142.658869] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[142.672814] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[142.802907] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[142.816670] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[142.947323] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.141s)
[142.958431] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[143.080712] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[143.091916] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[143.191985] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[143.204479] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[143.326544] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.130s)
[143.336059] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[143.470037] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[143.482181] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[143.613402] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[143.625560] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[143.758558] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[143.769161] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[143.892439] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[143.903617] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[144.026525] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.130s)
[144.036361] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[144.136629] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[144.148091] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[144.280921] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[144.292643] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[144.424922] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[144.436293] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[144.569054] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[144.583019] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[144.713746] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[144.725030] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[144.847857] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[144.859762] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[144.991865] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s)
[145.003840] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[145.114636] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[145.126421] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[145.258411] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[145.270602] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[145.402248] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[145.415345] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[145.546665] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[145.557455] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[145.680048] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.131s)
[145.690287] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[145.824285] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[145.836832] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[145.969082] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[145.979993] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[146.091409] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[146.103026] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[146.235985] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[146.247480] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[146.379890] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[146.393551] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[146.524249] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[146.537754] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[146.669639] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[146.679714] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[146.813366] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[146.826540] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[146.958452] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[146.969456] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[147.080218] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[147.131828] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[148.363334] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.237s)
[148.374335] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[148.497835] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[148.508122] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[148.630978] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[148.641831] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[148.774692] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[148.786138] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[148.918718] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[148.929839] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[149.063354] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[149.075039] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[149.208199] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[149.219821] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[149.319357] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[149.331109] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[149.453850] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[149.465024] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[149.597080] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[149.608643] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[149.741024] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[149.752085] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[149.885447] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[149.896462] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[150.030614] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s)
[150.042019] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[150.176030] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[150.187604] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[150.286346] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[150.297945] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[150.430978] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[150.442639] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[150.574239] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[150.585385] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[150.718722] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[150.734613] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[150.863453] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[150.877941] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[151.008312] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.141s)
[151.020105] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[151.152841] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[151.164700] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[151.274580] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[151.284895] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[151.418089] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[151.431376] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[151.562728] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[151.575217] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[151.707166] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[151.720757] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[151.851783] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[151.864571] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[151.995865] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[152.009087] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[152.140844] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[152.156947] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[152.263370] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.119s)
[152.274482] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[152.407655] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[152.419070] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[152.551511] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[152.565470] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[152.696129] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[152.708031] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[152.840562] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[152.851759] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[152.984791] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[152.998183] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[153.129940] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[153.140778] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[153.251901] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[153.304174] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[154.586994] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.289s)
[154.597957] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[154.687417] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[154.698295] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[154.787276] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[154.797696] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[154.898715] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[154.910101] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[155.047931] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.147s)
[155.059057] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[155.220893] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.171s)
[155.234543] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[155.321521] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.097s)
[155.333224] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[155.421603] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[155.432240] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[155.521494] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[155.532891] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[155.632287] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[155.642936] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[155.743089] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[155.753233] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[155.854209] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[155.864459] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[155.954135] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[155.964665] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[156.054713] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[156.065734] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[156.154517] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[156.165990] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[156.265395] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[156.276592] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[156.376095] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[156.388978] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[156.487502] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[156.499565] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[156.599040] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[156.612016] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[156.710432] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.108s)
[156.721503] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[156.809977] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[156.821379] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[156.961579] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.149s)
[156.971884] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[157.070506] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[157.079325] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[157.182135] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[157.191107] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[157.281983] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[157.291357] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[157.381970] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[157.390789] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[157.481728] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[157.491367] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[157.592845] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[157.601820] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[157.704441] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[157.717703] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[157.826849] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.121s)
[157.838576] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[157.937580] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[157.948797] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[158.036963] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s)
[158.048093] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[158.148258] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[158.159118] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[158.259138] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[158.270179] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[158.370963] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[158.382350] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[158.482091] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[158.522285] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[159.715190] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.198s)
[159.725745] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[159.826136] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[159.835139] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[159.937084] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[159.947890] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[160.070611] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.131s)
[160.081649] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[160.192105] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.120s)
[160.204243] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[160.354404] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.160s)
[160.365570] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[160.454994] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[160.465533] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[160.566218] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[160.575809] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[160.665793] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[160.674877] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[160.776696] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[160.786123] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[160.887293] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[160.897796] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[160.998458] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[161.008715] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[161.098732] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[161.109586] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[161.199050] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[161.209915] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[161.299366] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[161.310259] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[161.410313] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[161.421893] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[161.559231] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.147s)
[161.572182] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[161.670397] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[161.681455] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[161.770547] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[161.781784] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[161.871081] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[161.882079] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[161.970684] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[161.981970] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[162.081780] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[162.092492] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[162.192766] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[162.203371] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[162.342441] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.148s)
[162.352996] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[162.453520] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[162.464210] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[162.553309] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[162.563927] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[162.653610] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[162.664994] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[162.764549] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[162.775078] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[162.876376] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[162.887589] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[162.987705] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[162.999344] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[163.098229] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[163.108994] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[163.198489] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s)
[163.209756] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[163.309293] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[163.320218] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[163.420303] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[163.430504] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[163.531807] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[163.542585] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[163.642959] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[163.675563] Subtest flip-change-tiling: SUCCESS (22.707s)
[164.928507] [026/132] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[165.036795] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[172.416377] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.379s)
[172.575610] [027/132] (849s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[172.677364] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[173.468203] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[173.644533] [028/132] (847s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[173.709861] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[173.818570] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[173.920097] [029/132] (847s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[174.485672] Starting subtest: syncobj-backward-timeline-chain-engines
[174.598627] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.112s)
[176.026483] [030/132] (845s left) gem_exec_balancer (sliced)
[176.099356] Starting subtest: sliced
[176.103936] Subtest sliced: SKIP (0.000s)
[176.439116] [031/132] (845s left) perf (oa-exponents)
[176.600349] Starting subtest: oa-exponents
[176.602657] Starting dynamic subtest: 0-rcs0
[178.385821] Dynamic subtest 0-rcs0: SUCCESS (1.785s)
[178.395874] Starting dynamic subtest: 1-vcs0
[180.216377] Dynamic subtest 1-vcs0: SUCCESS (1.830s)
[180.218882] Subtest oa-exponents: SUCCESS (3.616s)
[180.264283] [032/132] (841s left) gem_userptr_blits (stress-mm)
[180.344906] Starting subtest: stress-mm
[185.716402] Subtest stress-mm: SUCCESS (5.369s)
[185.892518] [033/132] (835s left) gem_mmap_gtt (basic-short)
[185.954834] Subtest basic-short: SKIP (0.000s)
[186.025129] [034/132] (835s left) gen7_exec_parse (bitmasks)
[186.089060] Subtest bitmasks: SKIP (0.000s)
[186.177406] [035/132] (835s left) gem_exec_reloc (basic-cpu-wc)
[186.243796] Subtest basic-cpu-wc: SKIP (0.000s)
[186.334388] [036/132] (835s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[186.441370] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[186.445811] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[186.581632] [037/132] (835s left) kms_plane (plane-position-covered)
[186.674118] Starting subtest: plane-position-covered
[187.192027] Starting dynamic subtest: pipe-A-plane-1
[188.524366] Dynamic subtest pipe-A-plane-1: SUCCESS (1.334s)
[188.533830] Starting dynamic subtest: pipe-A-plane-2
[189.835661] Dynamic subtest pipe-A-plane-2: SUCCESS (1.312s)
[189.845782] Starting dynamic subtest: pipe-A-plane-3
[191.084738] Dynamic subtest pipe-A-plane-3: SUCCESS (1.248s)
[191.094242] Starting dynamic subtest: pipe-A-plane-4
[192.387413] Dynamic subtest pipe-A-plane-4: SUCCESS (1.301s)
[192.397990] Starting dynamic subtest: pipe-A-plane-5
[192.412147] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[193.549379] Starting dynamic subtest: pipe-B-plane-1
[194.885964] Dynamic subtest pipe-B-plane-1: SUCCESS (1.341s)
[194.894942] Starting dynamic subtest: pipe-B-plane-2
[196.191762] Dynamic subtest pipe-B-plane-2: SUCCESS (1.305s)
[196.203955] Starting dynamic subtest: pipe-B-plane-3
[197.464693] Dynamic subtest pipe-B-plane-3: SUCCESS (1.272s)
[197.476631] Starting dynamic subtest: pipe-B-plane-4
[198.746352] Dynamic subtest pipe-B-plane-4: SUCCESS (1.280s)
[198.755178] Starting dynamic subtest: pipe-B-plane-5
[198.771940] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[198.774729] Subtest plane-position-covered: SUCCESS (12.098s)
[199.573342] [038/132] (822s left) gem_exec_schedule (noreorder-corked)
[199.743908] Starting subtest: noreorder-corked
[199.746234] Starting dynamic subtest: rcs0
[200.903393] Dynamic subtest rcs0: SUCCESS (1.160s)
[200.914845] Starting dynamic subtest: vcs0
[202.915298] Dynamic subtest vcs0: SUCCESS (2.008s)
[202.929218] Starting dynamic subtest: vcs1
[204.863561] Dynamic subtest vcs1: SUCCESS (1.945s)
[204.877980] Starting dynamic subtest: vecs0
[206.854103] Dynamic subtest vecs0: SUCCESS (1.987s)
[206.873308] Starting dynamic subtest: ccs0
[208.011450] Dynamic subtest ccs0: SUCCESS (1.155s)
[208.014237] Subtest noreorder-corked: SUCCESS (8.269s)
[208.221291] [039/132] (813s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[208.346768] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[209.725795] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.378s)
[210.545038] [040/132] (811s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[210.640983] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[210.643146] Starting dynamic subtest: pipe-A-eDP-1
[210.665224] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.675568] Starting dynamic subtest: pipe-B-eDP-1
[210.697323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.705830] Starting dynamic subtest: pipe-C-eDP-1
[210.726586] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.735655] Starting dynamic subtest: pipe-D-eDP-1
[210.757274] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.761226] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[212.807332] [041/132] (809s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[213.049943] Starting subtest: cursor-rapid-movement-256x256
[213.052439] Starting dynamic subtest: pipe-A-eDP-1
[213.581378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[213.611204] Starting dynamic subtest: pipe-D-eDP-1
[214.801608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.195s)
[214.804313] Subtest cursor-rapid-movement-256x256: SUCCESS (1.750s)
[215.666378] [042/132] (806s left) sw_sync (sync_multi_consumer_producer)
[215.715309] Starting subtest: sync_multi_consumer_producer
[216.030456] Subtest sync_multi_consumer_producer: SUCCESS (0.314s)
[216.124869] [043/132] (806s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[216.224871] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[216.229449] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[216.364284] [044/132] (805s left) gem_lmem_swapping (massive)
[216.414597] Subtest massive: SKIP (0.000s)
[216.460217] [045/132] (805s left) perf_pmu (semaphore-busy)
[216.501529] Starting subtest: semaphore-busy
[216.503330] Starting dynamic subtest: rcs0
[218.164336] Dynamic subtest rcs0: SUCCESS (1.659s)
[218.176566] Starting dynamic subtest: bcs0
[219.796831] Dynamic subtest bcs0: SUCCESS (1.630s)
[219.809620] Starting dynamic subtest: vcs0
[224.401888] Dynamic subtest vcs0: SUCCESS (4.601s)
[224.411476] Starting dynamic subtest: vcs1
[230.417952] Dynamic subtest vcs1: SUCCESS (6.012s)
[230.427761] Starting dynamic subtest: vecs0
[236.433673] Dynamic subtest vecs0: SUCCESS (6.012s)
[236.444688] Starting dynamic subtest: ccs0
[239.509882] Dynamic subtest ccs0: SUCCESS (3.073s)
[239.512323] Subtest semaphore-busy: SUCCESS (23.006s)
[239.648408] [046/132] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[239.760191] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[239.764188] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[239.869334] [047/132] (782s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[239.941571] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[240.010021] [048/132] (782s left) kms_flip (2x-modeset-vs-vblank-race)
[240.106517] Starting subtest: 2x-modeset-vs-vblank-race
[240.117235] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[240.223159] [049/132] (782s left) kms_flip (nonexisting-fb)
[240.316207] Starting subtest: nonexisting-fb
[240.318511] Starting dynamic subtest: A-eDP1
[241.437636] Dynamic subtest A-eDP1: SUCCESS (1.123s)
[241.449140] Starting dynamic subtest: B-eDP1
[242.568297] Dynamic subtest B-eDP1: SUCCESS (1.127s)
[242.579743] Starting dynamic subtest: C-eDP1
[243.702474] Dynamic subtest C-eDP1: SUCCESS (1.131s)
[243.712184] Starting dynamic subtest: D-eDP1
[244.826299] Dynamic subtest D-eDP1: SUCCESS (1.123s)
[244.828505] Subtest nonexisting-fb: SUCCESS (4.516s)
[246.109418] [050/132] (776s left) kms_psr (psr-basic)
[246.213985] Starting subtest: psr-basic
[246.216145] Starting dynamic subtest: eDP-1
[247.866798] Dynamic subtest eDP-1: SUCCESS (1.652s)
[247.869096] Subtest psr-basic: SUCCESS (1.653s)
[248.766700] [051/132] (773s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[248.885045] Starting subtest: cursorB-vs-flipB-atomic
[248.889359] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[249.052320] [052/132] (773s left) kms_cursor_crc (cursor-alpha-transparent)
[249.157780] Starting subtest: cursor-alpha-transparent
[249.160088] Starting dynamic subtest: pipe-A-eDP-1
[249.757682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[249.768853] Starting dynamic subtest: pipe-D-eDP-1
[251.023322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.267s)
[251.025596] Subtest cursor-alpha-transparent: SUCCESS (1.866s)
[251.852175] [053/132] (770s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[251.955086] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[252.087474] [054/132] (770s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[252.160355] Starting subtest: yf-tiled-to-vebox-y-tiled
[252.164466] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[252.362930] [055/132] (770s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[252.466210] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[252.470251] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[252.599055] [056/132] (770s left) kms_addfb_basic (bad-pitch-32)
[252.654329] Starting subtest: bad-pitch-32
[252.656217] Subtest bad-pitch-32: SUCCESS (0.000s)
[252.830389] [057/132] (769s left) kms_flip (flip-vs-rmfb)
[252.926478] Starting subtest: flip-vs-rmfb
[252.928824] Starting dynamic subtest: A-eDP1
[261.621844] Dynamic subtest A-eDP1: SUCCESS (8.695s)
[261.631720] Starting dynamic subtest: B-eDP1
[270.250093] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[270.263503] Starting dynamic subtest: C-eDP1
[278.859339] Dynamic subtest C-eDP1: SUCCESS (8.606s)
[278.869343] Starting dynamic subtest: D-eDP1
[287.489587] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[287.493896] Subtest flip-vs-rmfb: SUCCESS (34.566s)
[288.697487] [058/132] (734s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[288.806870] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[288.809171] Starting dynamic subtest: pipe-A-eDP-1
[288.831255] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[288.841349] Starting dynamic subtest: pipe-B-eDP-1
[288.863294] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[288.873786] Starting dynamic subtest: pipe-C-eDP-1
[288.895060] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[288.903898] Starting dynamic subtest: pipe-D-eDP-1
[288.925321] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[288.929734] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[291.071482] [059/132] (731s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[291.121615] Starting subtest: multi-wait-all-for-submit-signaled
[291.123809] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[291.260220] [060/132] (731s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[291.359147] Starting subtest: primary-4-tiled-reflect-x-0
[298.461719] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.104s)
[299.763806] [061/132] (723s left) gem_close (basic)
[299.843554] Starting subtest: basic
[299.845966] Subtest basic: SUCCESS (0.000s)
[299.989365] [062/132] (723s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[300.117858] Starting subtest: basic-flip-after-cursor-atomic
[301.031387] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.914s)
[301.894873] [063/132] (721s left) syncobj_timeline (multi-wait-for-submit-signaled)
[301.959331] Starting subtest: multi-wait-for-submit-signaled
[301.961578] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[302.132381] [064/132] (720s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[302.243361] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[303.211709] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.967s)
[303.382162] [065/132] (719s left) i915_suspend (basic-s3-without-i915)
[303.423687] Starting subtest: basic-s3-without-i915
[305.411859] Subtest basic-s3-without-i915: SKIP (1.985s)
[307.057326] [066/132] (716s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[307.168981] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[307.171270] Starting dynamic subtest: pipe-A-default-mode
[309.918593] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[309.920503] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.748s)
[310.799490] [067/132] (712s left) i915_pm_rpm (system-suspend)
[313.134367] Starting subtest: system-suspend
[330.611785] Subtest system-suspend: SUCCESS (2.854s)
[331.027072] [068/132] (692s left) kms_vblank (query-forked-hang)
[331.143164] Starting subtest: query-forked-hang
[331.145176] Starting dynamic subtest: pipe-A-eDP-1
[357.389496] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.994s)
[357.403686] Starting dynamic subtest: pipe-D-eDP-1
[372.280892] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.885s)
[372.283326] Subtest query-forked-hang: SUCCESS (40.884s)
[373.150861] [069/132] (650s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[373.278557] Starting subtest: cursor-vs-flip-atomic
[402.508707] Subtest cursor-vs-flip-atomic: SUCCESS (29.222s)
[403.388046] [070/132] (619s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[403.497412] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[403.501761] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[403.627082] [071/132] (619s left) gem_exec_schedule (submit-early-slice)
[403.687063] Starting subtest: submit-early-slice
[403.688933] Starting dynamic subtest: rcs0
[403.733066] Dynamic subtest rcs0: SUCCESS (0.051s)
[403.745236] Starting dynamic subtest: bcs0
[403.771548] Dynamic subtest bcs0: SUCCESS (0.038s)
[403.781646] Starting dynamic subtest: vcs0
[403.813369] Dynamic subtest vcs0: SUCCESS (0.041s)
[403.823568] Starting dynamic subtest: vcs1
[403.852125] Dynamic subtest vcs1: SUCCESS (0.038s)
[403.865109] Starting dynamic subtest: vecs0
[403.887020] Dynamic subtest vecs0: SUCCESS (0.034s)
[403.897568] Starting dynamic subtest: ccs0
[403.921408] Dynamic subtest ccs0: SUCCESS (0.034s)
[403.923746] Subtest submit-early-slice: SUCCESS (0.240s)
[405.624360] [072/132] (617s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[405.745555] Starting subtest: basic-flip-before-cursor-varying-size
[406.690382] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.944s)
[407.525333] [073/132] (615s left) syncobj_timeline (host-signal-ordered)
[407.591244] Starting subtest: host-signal-ordered
[407.593513] Subtest host-signal-ordered: SUCCESS (0.000s)
[407.726144] [074/132] (615s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[407.837843] Starting subtest: x-tiled-64bpp-rotate-0
[409.272158] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.434s)
[409.489080] [075/132] (614s left) gem_userptr_blits (relocations)
[409.553952] Starting subtest: relocations
[409.558231] Subtest relocations: SKIP (0.001s)
[409.695842] [076/132] (613s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[409.797567] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[417.195884] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.399s)
[417.355240] [077/132] (606s left) core_getversion (basic)
[417.397057] Starting subtest: basic
[417.401013] Subtest basic: SUCCESS (0.000s)
[417.485242] [078/132] (606s left) perf (enable-disable)
[417.618529] Starting subtest: enable-disable
[417.620803] Starting dynamic subtest: 0-rcs0
[419.856449] Dynamic subtest 0-rcs0: SUCCESS (2.238s)
[419.867421] Starting dynamic subtest: 1-vcs1
[424.310110] Dynamic subtest 1-vcs1: SUCCESS (4.450s)
[424.312428] Subtest enable-disable: SUCCESS (6.689s)
[424.360562] [079/132] (599s left) gem_softpin (allocator-nopin-reserve)
[424.420347] Starting subtest: allocator-nopin-reserve
[424.538769] Subtest allocator-nopin-reserve: SUCCESS (0.117s)
[424.691192] [080/132] (599s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[424.781597] Starting subtest: basic-max-pipe-crc-check
[424.785907] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[424.829107] [081/132] (598s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[429.815163] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[429.819649] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[430.677863] [082/132] (593s left) api_intel_allocator (two-level-inception-interruptible)
[430.742783] Starting subtest: two-level-inception-interruptible
[436.168407] Subtest two-level-inception-interruptible: SUCCESS (5.427s)
[436.325262] [083/132] (587s left) kms_flip (wf_vblank-ts-check)
[436.433272] Starting subtest: wf_vblank-ts-check
[436.435670] Starting dynamic subtest: A-eDP1
[445.398400] Dynamic subtest A-eDP1: SUCCESS (8.966s)
[445.410156] Starting dynamic subtest: B-eDP1
[454.320109] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[454.332709] Starting dynamic subtest: C-eDP1
[463.248186] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[463.257944] Starting dynamic subtest: D-eDP1
[472.181052] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[472.183623] Subtest wf_vblank-ts-check: SUCCESS (35.751s)
[473.419266] [084/132] (550s left) syncobj_timeline (wait-delayed-signal)
[473.484353] Starting subtest: wait-delayed-signal
[473.587575] Subtest wait-delayed-signal: SUCCESS (0.103s)
[473.686798] [085/132] (550s left) gem_cs_tlb (engines)
[473.747095] Starting subtest: engines
[473.749238] Starting dynamic subtest: rcs0
[475.902660] Dynamic subtest rcs0: SUCCESS (2.153s)
[475.915045] Starting dynamic subtest: bcs0
[478.057795] Dynamic subtest bcs0: SUCCESS (2.152s)
[478.066426] Starting dynamic subtest: vcs0
[480.211246] Dynamic subtest vcs0: SUCCESS (2.152s)
[480.221627] Starting dynamic subtest: vcs1
[482.364681] Dynamic subtest vcs1: SUCCESS (2.152s)
[482.374590] Starting dynamic subtest: vecs0
[484.543740] Dynamic subtest vecs0: SUCCESS (2.151s)
[484.554370] Starting dynamic subtest: ccs0
[486.672722] Dynamic subtest ccs0: SUCCESS (2.153s)
[486.674853] Subtest engines: SUCCESS (12.920s)
[486.835745] [086/132] (537s left) gem_tiled_blits (interruptible)
[486.904374] Subtest interruptible: SKIP (0.000s)
[486.984346] [087/132] (537s left) kms_joiner (basic-big-joiner)
[487.096409] Starting subtest: basic-big-joiner
[487.101076] Subtest basic-big-joiner: SKIP (0.000s)
[487.190983] [088/132] (536s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[487.289468] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[487.291661] Starting dynamic subtest: pipe-A-eDP-1
[487.315509] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[487.325276] Starting dynamic subtest: pipe-B-eDP-1
[487.348077] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[487.356858] Starting dynamic subtest: pipe-C-eDP-1
[487.379665] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[487.388885] Starting dynamic subtest: pipe-D-eDP-1
[487.412971] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[487.417035] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[489.508850] [089/132] (534s left) kms_cursor_crc (cursor-suspend)
[489.642817] Starting subtest: cursor-suspend
[489.644595] Starting dynamic subtest: pipe-A-eDP-1
[522.357522] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.212s)
[522.367826] Starting dynamic subtest: pipe-D-eDP-1
[556.385136] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.754s)
[556.387452] Subtest cursor-suspend: SUCCESS (6.968s)
[557.273201] [090/132] (466s left) gem_tiled_blits (basic)
[557.352811] Subtest basic: SKIP (0.000s)
[557.440326] [091/132] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[557.558829] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[557.563265] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[557.695325] [092/132] (466s left) gem_exec_reloc (basic-cpu-gtt-active)
[557.762494] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[557.840423] [093/132] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[557.939618] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[557.944143] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[558.070295] [094/132] (466s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[558.165141] Starting subtest: fbcpsr-rgb565-draw-blt
[565.295790] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.008s)
[565.454704] [095/132] (458s left) kms_cursor_crc (cursor-offscreen-64x21)
[565.653607] Starting subtest: cursor-offscreen-64x21
[565.704760] Subtest cursor-offscreen-64x21: SKIP (0.046s)
[565.971816] [096/132] (458s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[566.077367] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[566.081574] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[566.199934] [097/132] (458s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[566.312955] Starting subtest: fbc-rgb565-draw-blt
[570.511944] Subtest fbc-rgb565-draw-blt: SUCCESS (4.171s)
[571.721157] [098/132] (452s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[571.828145] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[575.440311] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.602s)
[576.582326] [099/132] (448s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[576.691884] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[576.695918] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[576.799625] [100/132] (447s left) api_intel_bb (full-batch)
[576.866789] Starting subtest: full-batch
[576.872339] Subtest full-batch: SUCCESS (0.005s)
[576.994876] [101/132] (447s left) perf (gen12-unprivileged-single-ctx-counters)
[577.101235] Starting subtest: gen12-unprivileged-single-ctx-counters
[577.103644] Starting dynamic subtest: rcs0
[577.176260] Dynamic subtest rcs0: SUCCESS (0.074s)
[577.178626] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.076s)
[577.227557] [102/132] (447s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[577.367861] Starting subtest: fbc-psr2-cursor-plane-onoff
[577.369750] Starting dynamic subtest: eDP-1
[577.373780] Dynamic subtest eDP-1: SKIP (0.000s)
[577.377809] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[577.467852] [103/132] (447s left) kms_psr (psr2-primary-mmap-cpu)
[577.552874] Starting subtest: psr2-primary-mmap-cpu
[577.554776] Starting dynamic subtest: eDP-1
[579.247872] Dynamic subtest eDP-1: SUCCESS (1.689s)
[579.250206] Subtest psr2-primary-mmap-cpu: SUCCESS (1.690s)
[580.144023] [104/132] (444s left) gem_exec_await (wide-all)
[580.364007] Starting subtest: wide-all
[604.053684] Subtest wide-all: SUCCESS (23.673s)
[604.273917] [105/132] (420s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[604.429500] Starting subtest: fb-8bpc-vs-panel-6bpc
[604.431799] Starting dynamic subtest: pipe-A-eDP-1
[605.829790] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.398s)
[605.831951] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.400s)
[606.714151] [106/132] (418s left) kms_chamelium_frames (dp-crc-single)
[607.113622] Subtest dp-crc-single: SKIP (0.000s)
[607.890925] [107/132] (417s left) gem_exec_whisper (basic-fds-priority-all)
[607.955352] Starting subtest: basic-fds-priority-all
[630.363698] Subtest basic-fds-priority-all: SUCCESS (22.396s)
[630.575678] [108/132] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[630.681941] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[630.686700] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[630.795071] [109/132] (394s left) fbdev (unaligned-read)
[630.840089] Starting subtest: unaligned-read
[630.855204] Subtest unaligned-read: SUCCESS (0.015s)
[630.934587] [110/132] (394s left) gen3_render_tiledy_blits
[631.070242] [111/132] (394s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[631.192916] Starting subtest: cursorA-vs-flipA-toggle
[642.375633] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.178s)
[643.278761] [112/132] (381s left) gem_eio (in-flight-10ms)
[643.514711] Starting subtest: in-flight-10ms
[652.284433] Subtest in-flight-10ms: SUCCESS (8.768s)
[652.476508] [113/132] (372s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[652.579101] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[652.583203] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[652.708871] [114/132] (372s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[654.348556] Starting subtest: modeset-non-lpsp-stress-no-wait
[654.392864] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.045s)
[655.011201] [115/132] (370s left) kms_atomic (plane-immutable-zpos)
[655.101839] Starting subtest: plane-immutable-zpos
[655.104125] Starting dynamic subtest: pipe-A-eDP-1
[655.726170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s)
[655.728121] Subtest plane-immutable-zpos: SUCCESS (0.623s)
[656.543574] [116/132] (368s left) syncobj_timeline (invalid-transfer-non-existent-point)
[656.606089] Starting subtest: invalid-transfer-non-existent-point
[656.608470] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[656.742673] [117/132] (368s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[656.874695] Starting subtest: 4-tiled-64bpp-rotate-0
[658.361616] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.489s)
[658.577761] [118/132] (366s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[658.673304] Starting subtest: plane-downscale-factor-0-75-with-rotation
[658.675529] Starting dynamic subtest: pipe-A
[658.904730] Dynamic subtest pipe-A: SUCCESS (0.233s)
[658.915594] Starting dynamic subtest: pipe-B
[660.212957] Dynamic subtest pipe-B: SUCCESS (1.308s)
[660.223694] Starting dynamic subtest: pipe-C
[661.522066] Dynamic subtest pipe-C: SUCCESS (1.309s)
[661.532954] Starting dynamic subtest: pipe-D
[662.854271] Dynamic subtest pipe-D: SUCCESS (1.332s)
[662.856535] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.185s)
[664.037865] [119/132] (361s left) kms_cdclk (mode-transition-all-outputs)
[664.144612] Starting subtest: mode-transition-all-outputs
[664.432549] Subtest mode-transition-all-outputs: SKIP (0.287s)
[665.268892] [120/132] (360s left) kms_psr (fbc-pr-sprite-plane-move)
[665.365819] Starting subtest: fbc-pr-sprite-plane-move
[665.370069] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[665.465389] [121/132] (360s left) gem_ctx_persistence (engines-mixed-process)
[665.532027] Starting subtest: engines-mixed-process
[665.534390] Starting dynamic subtest: rcs0
[667.210356] Dynamic subtest rcs0: SUCCESS (1.678s)
[667.223427] Starting dynamic subtest: bcs0
[669.192352] Dynamic subtest bcs0: SUCCESS (1.981s)
[669.210586] Starting dynamic subtest: vcs0
[671.183361] Dynamic subtest vcs0: SUCCESS (1.990s)
[671.195619] Starting dynamic subtest: vcs1
[673.169185] Dynamic subtest vcs1: SUCCESS (1.984s)
[673.182331] Starting dynamic subtest: vecs0
[675.221712] Dynamic subtest vecs0: SUCCESS (2.051s)
[675.234924] Starting dynamic subtest: ccs0
[677.204427] Dynamic subtest ccs0: SUCCESS (1.981s)
[677.207138] Subtest engines-mixed-process: SUCCESS (11.676s)
[677.312069] [122/132] (348s left) kms_draw_crc (draw-method-mmap-gtt)
[677.406634] Starting subtest: draw-method-mmap-gtt
[677.411054] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[677.531061] [123/132] (348s left) syncobj_wait (single-wait-all-submitted)
[677.594414] Starting subtest: single-wait-all-submitted
[677.698850] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[677.801004] [124/132] (347s left) gem_lmem_swapping (verify-ccs)
[677.846307] Subtest verify-ccs: SKIP (0.000s)
[677.895338] [125/132] (347s left) i915_pm_freq_api (freq-suspend)
[677.955931] Starting subtest: freq-suspend
[677.958300] Starting dynamic subtest: gt0
[693.905280] Dynamic subtest gt0: SUCCESS (1.244s)
[693.918153] Starting dynamic subtest: gt1
[709.865286] Dynamic subtest gt1: SUCCESS (1.195s)
[709.867605] Subtest freq-suspend: SUCCESS (2.441s)
[709.974855] [126/132] (315s left) gem_eio (wait-immediate)
[710.203387] Starting subtest: wait-immediate
[710.568001] Subtest wait-immediate: SUCCESS (0.358s)
[710.751555] [127/132] (315s left) gem_vm_create (invalid-create)
[710.821083] Starting subtest: invalid-create
[710.823368] Subtest invalid-create: SUCCESS (0.001s)
[710.953493] [128/132] (314s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[716.119363] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[716.124048] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.004s)
[716.987032] [129/132] (308s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[717.084205] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[717.086534] Starting dynamic subtest: pipe-A
[717.104433] Dynamic subtest pipe-A: SKIP (0.017s)
[717.116565] Starting dynamic subtest: pipe-B
[717.137316] Dynamic subtest pipe-B: SKIP (0.030s)
[717.148713] Starting dynamic subtest: pipe-C
[717.169118] Dynamic subtest pipe-C: SKIP (0.030s)
[717.179728] Starting dynamic subtest: pipe-D
[717.197608] Dynamic subtest pipe-D: SKIP (0.030s)
[717.201439] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.110s)
[717.333410] [130/132] (308s left) kms_vblank (wait-forked-busy)
[717.435314] Starting subtest: wait-forked-busy
[717.437689] Starting dynamic subtest: pipe-A-eDP-1
[719.342522] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[719.359048] Starting dynamic subtest: pipe-D-eDP-1
[721.889460] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.519s)
[721.891912] Subtest wait-forked-busy: SUCCESS (4.405s)
[722.725564] [131/132] (303s left) prime_vgem (sync)
[722.820548] Starting subtest: sync
[722.822958] Starting dynamic subtest: rcs0
[722.891929] Dynamic subtest rcs0: SUCCESS (0.071s)
[722.902188] Starting dynamic subtest: bcs0
[722.961124] Dynamic subtest bcs0: SUCCESS (0.068s)
[722.971743] Starting dynamic subtest: vcs0
[723.010149] Dynamic subtest vcs0: SUCCESS (0.048s)
[723.020609] Starting dynamic subtest: vcs1
[723.055213] Dynamic subtest vcs1: SUCCESS (0.044s)
[723.065838] Starting dynamic subtest: vecs0
[723.101969] Dynamic subtest vecs0: SUCCESS (0.045s)
[723.112788] Starting dynamic subtest: ccs0
[723.146913] Dynamic subtest ccs0: SUCCESS (0.044s)
[723.149255] Subtest sync: SUCCESS (0.325s)
[723.315402] [132/132] (302s left) kms_getfb (getfb-repeated-different-handles)
[723.408103] Starting subtest: getfb-repeated-different-handles
[723.409974] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[723.543879] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: kms_color_pipeline
results: parsing output: 2/ for test: template
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_plane_cursor
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_mmap_offset
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: vgem_basic
results: parsing output: 16/ for test: gem_eio
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_hdr
results: parsing output: 24/ for test: kms_flip_tiling
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: gen7_exec_parse
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: sw_sync
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_pipe_b_c_ivb
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_rotation_crc
results: parsing output: 60/ for test: gem_close
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: i915_suspend
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: core_getversion
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_multipipe_modeset
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_cs_tlb
results: parsing output: 85/ for test: gem_tiled_blits
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: gem_tiled_blits
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_await
results: parsing output: 104/ for test: kms_dither
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: fbdev
results: parsing output: 109/ for test: gen3_render_tiledy_blits
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_cdclk
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: i915_pm_freq_api
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: gem_vm_create
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: prime_vgem
results: parsing output: 131/ for test: kms_getfb
Done.