[56.556971] Initializing watchdogs
[56.557019]   /dev/watchdog0
[56.570669] [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]
[56.574396] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.576576] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.579421] [001/130] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[56.755199] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[59.513706] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.716s)
[59.632937] [002/130] (957s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[59.752424] Starting subtest: flip-vs-cursor-busy-crc-legacy
[60.538570] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.773s)
[61.350423] [003/130] (955s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[61.450088] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[61.452584] Starting dynamic subtest: pipe-A
[63.045220] Dynamic subtest pipe-A: SUCCESS (1.582s)
[63.052710] Starting dynamic subtest: pipe-B
[65.640985] Dynamic subtest pipe-B: SUCCESS (2.576s)
[65.649156] Starting dynamic subtest: pipe-C
[66.811524] Dynamic subtest pipe-C: SUCCESS (1.163s)
[66.818460] Starting dynamic subtest: pipe-D
[68.030591] Dynamic subtest pipe-D: SUCCESS (1.212s)
[68.032923] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.534s)
[69.209984] [004/130] (948s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[69.318261] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[69.322216] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[69.403051] [005/130] (947s left) gem_exec_schedule (lateslice)
[69.483480] Starting subtest: lateslice
[69.485459] Starting dynamic subtest: rcs0
[69.494761] Dynamic subtest rcs0: SUCCESS (0.020s)
[69.501469] Starting dynamic subtest: bcs0
[69.511365] Dynamic subtest bcs0: SUCCESS (0.017s)
[69.518149] Starting dynamic subtest: vcs0
[69.528316] Dynamic subtest vcs0: SUCCESS (0.017s)
[69.534626] Starting dynamic subtest: vcs1
[69.545316] Dynamic subtest vcs1: SUCCESS (0.016s)
[69.551699] Starting dynamic subtest: vecs0
[69.560887] Dynamic subtest vecs0: SUCCESS (0.016s)
[69.567599] Starting dynamic subtest: ccs0
[69.577734] Dynamic subtest ccs0: SUCCESS (0.016s)
[69.580077] Subtest lateslice: SUCCESS (0.103s)
[71.240579] [006/130] (946s left) intel_hwmon (hwmon-write)
[71.330186] Subtest hwmon-write: SKIP (0.000s)
[71.464858] [007/130] (945s left) gem_exec_schedule (preempt)
[71.581114] Starting subtest: preempt
[71.583813] Starting dynamic subtest: rcs0
[71.615189] Dynamic subtest rcs0: SUCCESS (0.034s)
[71.625782] Starting dynamic subtest: bcs0
[71.639685] Dynamic subtest bcs0: SUCCESS (0.024s)
[71.646703] Starting dynamic subtest: vcs0
[71.669194] Dynamic subtest vcs0: SUCCESS (0.029s)
[71.677248] Starting dynamic subtest: vcs1
[71.690496] Dynamic subtest vcs1: SUCCESS (0.021s)
[71.697492] Starting dynamic subtest: vecs0
[71.713321] Dynamic subtest vecs0: SUCCESS (0.023s)
[71.720092] Starting dynamic subtest: ccs0
[71.739672] Dynamic subtest ccs0: SUCCESS (0.026s)
[71.742079] Subtest preempt: SUCCESS (0.158s)
[73.006366] [008/130] (944s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[73.115605] Starting subtest: yf-tiled-8bpp-rotate-90
[73.120095] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[73.221501] [009/130] (944s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[73.266704] Starting subtest: single-wait-for-submit-available-submitted
[73.268989] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[73.368642] [010/130] (944s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[78.891165] Starting subtest: psr2-cursor-plane-update-sf
[78.893627] Starting dynamic subtest: pipe-B-eDP-1
[80.185361] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.291s)
[80.187693] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.293s)
[81.049673] [011/130] (936s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[81.152690] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[81.155144] Starting dynamic subtest: pipe-A
[81.709080] Dynamic subtest pipe-A: SUCCESS (0.555s)
[81.721048] Starting dynamic subtest: pipe-B
[83.303327] Dynamic subtest pipe-B: SUCCESS (1.593s)
[83.311823] Starting dynamic subtest: pipe-C
[84.833764] Dynamic subtest pipe-C: SUCCESS (1.529s)
[84.841910] Starting dynamic subtest: pipe-D
[86.391392] Dynamic subtest pipe-D: SUCCESS (1.556s)
[86.393804] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (5.234s)
[87.564840] [012/130] (930s left) gem_gpgpu_fill (offset-16x16)
[87.623904] Starting subtest: offset-16x16
[87.631016] Subtest offset-16x16: SUCCESS (0.007s)
[87.769655] [013/130] (929s left) kms_chamelium_hpd (dp-hpd-fast)
[88.154840] Subtest dp-hpd-fast: SKIP (0.000s)
[88.961280] [014/130] (928s left) kms_pm_dc (dc6-psr)
[90.068098] Starting subtest: dc6-psr
[97.281820] Subtest dc6-psr: FAIL (6.615s)
[97.311283] [015/130] (920s left) kms_psr (psr-sprite-blt)
[97.399060] Starting subtest: psr-sprite-blt
[97.401304] Starting dynamic subtest: eDP-1
[99.107119] Dynamic subtest eDP-1: SUCCESS (1.704s)
[99.109336] Subtest psr-sprite-blt: SUCCESS (1.705s)
[99.932069] [016/130] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[100.039660] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[100.044328] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[100.158307] [017/130] (917s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[100.220705] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[100.273330] [018/130] (917s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[100.371938] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[100.374336] Starting dynamic subtest: pipe-A-eDP-1
[100.509281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[100.517821] Starting dynamic subtest: pipe-B-eDP-1
[100.648448] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.138s)
[100.655297] Starting dynamic subtest: pipe-C-eDP-1
[100.786580] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.137s)
[100.793997] Starting dynamic subtest: pipe-D-eDP-1
[100.923462] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.136s)
[100.925599] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.552s)
[103.078299] [019/130] (914s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[103.174512] Starting subtest: psr-rgb565-draw-mmap-wc
[107.747476] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (4.574s)
[107.874812] [020/130] (910s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[107.977117] Starting subtest: fbc-pr-sprite-mmap-cpu
[107.981631] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[108.042791] [021/130] (909s left) gem_exec_flush (basic-wb-set-default)
[108.101280] Starting subtest: basic-wb-set-default
[113.569608] Subtest basic-wb-set-default: SUCCESS (5.467s)
[113.749223] [022/130] (904s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[113.857991] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[113.860456] Starting dynamic subtest: pipe-A-eDP-1
[113.883627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[113.891336] Starting dynamic subtest: pipe-B-eDP-1
[113.912336] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[113.919183] Starting dynamic subtest: pipe-C-eDP-1
[113.941280] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[113.947606] Starting dynamic subtest: pipe-D-eDP-1
[113.969189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[113.973556] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[115.997356] [023/130] (901s left) gem_watchdog (default-physical)
[116.075338] Starting subtest: default-physical
[117.830415] Subtest default-physical: SUCCESS (1.767s)
[117.938059] [024/130] (900s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[118.042096] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[118.047044] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[119.120133] [025/130] (898s left) kms_psr (fbc-psr2-primary-page-flip)
[119.229486] Starting subtest: fbc-psr2-primary-page-flip
[119.231462] Starting dynamic subtest: eDP-1
[119.235592] Dynamic subtest eDP-1: SKIP (0.000s)
[119.239732] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[119.293607] [026/130] (898s left) sysfs_timeslice_duration (timeout)
[119.359885] Starting subtest: timeout
[119.362239] Starting dynamic subtest: vecs0
[128.959319] Dynamic subtest vecs0: SUCCESS (9.594s)
[128.968803] Starting dynamic subtest: ccs0
[130.232549] Dynamic subtest ccs0: SUCCESS (1.274s)
[130.239939] Starting dynamic subtest: vcs0
[139.973088] Dynamic subtest vcs0: SUCCESS (9.735s)
[139.982188] Starting dynamic subtest: bcs0
[140.501621] Dynamic subtest bcs0: SUCCESS (0.531s)
[140.511225] Starting dynamic subtest: rcs0
[141.771864] Dynamic subtest rcs0: SUCCESS (1.269s)
[141.783214] Starting dynamic subtest: vcs1
[150.980968] Dynamic subtest vcs1: SUCCESS (9.204s)
[150.983410] Subtest timeout: SUCCESS (31.614s)
[151.046473] [027/130] (867s left) kms_fence_pin_leak
[151.220120] [028/130] (866s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[151.322210] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[151.326229] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[151.421119] [029/130] (866s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[151.476113] Starting subtest: single-wait-for-submit-unsubmitted
[151.582951] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[151.648502] [030/130] (866s left) kms_frontbuffer_tracking (fbc-1p-rte)
[151.752045] Starting subtest: fbc-1p-rte
[156.171369] Subtest fbc-1p-rte: SUCCESS (4.424s)
[156.332349] [031/130] (861s left) kms_force_connector_basic (force-load-detect)
[156.412495] Starting subtest: force-load-detect
[156.417254] Subtest force-load-detect: SKIP (0.000s)
[156.531736] [032/130] (861s left) gem_exec_reloc (basic-gtt)
[156.597558] Subtest basic-gtt: SKIP (0.000s)
[156.656852] [033/130] (861s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[156.765270] Starting subtest: x-tiled-64bpp-rotate-90
[156.785050] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[156.912744] [034/130] (861s left) kms_vblank (ts-continuation-modeset)
[157.016519] Starting subtest: ts-continuation-modeset
[157.018613] Starting dynamic subtest: pipe-A-eDP-1
[158.499549] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.480s)
[158.512074] Starting dynamic subtest: pipe-D-eDP-1
[160.648789] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.147s)
[160.651270] Subtest ts-continuation-modeset: SUCCESS (3.630s)
[161.440384] [035/130] (856s left) syncobj_wait (single-wait-for-submit-submitted)
[161.492338] Starting subtest: single-wait-for-submit-submitted
[161.599332] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[161.666340] [036/130] (856s left) gem_exec_fence (syncobj-repeat)
[162.095902] Starting subtest: syncobj-repeat
[162.262046] Subtest syncobj-repeat: SUCCESS (0.165s)
[164.038384] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[164.041429] [037/130] (854s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[164.107891] Starting subtest: yf-tiled-to-vebox-x-tiled
[164.112374] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[164.285037] [038/130] (854s left) dumb_buffer (map-uaf)
[164.351550] Starting subtest: map-uaf
[164.364037] Subtest map-uaf: SUCCESS (0.015s)
[164.468539] [039/130] (854s left) kms_cursor_edge_walk (64x64-top-bottom)
[164.582023] Starting subtest: 64x64-top-bottom
[164.584318] Starting dynamic subtest: pipe-A-eDP-1
[167.998932] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s)
[168.007125] Starting dynamic subtest: pipe-D-eDP-1
[171.105735] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.106s)
[171.107996] Subtest 64x64-top-bottom: SUCCESS (6.521s)
[171.927697] [040/130] (846s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[172.038592] Starting subtest: x-tiled-16bpp-rotate-270
[172.057673] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[172.185190] [041/130] (846s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[172.286259] Starting subtest: fbc-psr-sprite-mmap-gtt
[172.288455] Starting dynamic subtest: eDP-1
[172.292372] Dynamic subtest eDP-1: SKIP (0.000s)
[172.296298] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[172.352517] [042/130] (846s left) i915_query (query-topology-known-pci-ids)
[172.412490] Starting subtest: query-topology-known-pci-ids
[172.417090] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[172.522238] [043/130] (846s left) kms_joiner (basic-ultra-joiner)
[172.624619] Starting subtest: basic-ultra-joiner
[172.628775] Subtest basic-ultra-joiner: SKIP (0.000s)
[172.684839] [044/130] (845s left) syncobj_timeline (reset-unsignaled)
[172.743704] Starting subtest: reset-unsignaled
[172.746039] Subtest reset-unsignaled: SUCCESS (0.000s)
[172.843107] [045/130] (845s left) gem_exec_reloc (basic-write-read-active)
[172.906189] Subtest basic-write-read-active: SKIP (0.000s)
[172.986265] [046/130] (845s left) kms_chamelium_edid (hdmi-mode-timings)
[173.376059] Subtest hdmi-mode-timings: SKIP (0.000s)
[174.133957] [047/130] (844s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[174.232062] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[174.234406] Starting dynamic subtest: pipe-A-eDP-1
[174.282903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.050s)
[174.290702] Starting dynamic subtest: pipe-B-eDP-1
[174.330269] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.047s)
[174.337695] Starting dynamic subtest: pipe-C-eDP-1
[174.377327] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.046s)
[174.385205] Starting dynamic subtest: pipe-D-eDP-1
[174.422434] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.044s)
[174.424683] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.191s)
[176.589143] [048/130] (842s left) gem_exec_schedule (wide)
[176.766582] Starting subtest: wide
[176.768981] Starting dynamic subtest: rcs0
[185.008684] Dynamic subtest rcs0: SUCCESS (8.239s)
[185.018384] Starting dynamic subtest: vcs0
[195.221943] Dynamic subtest vcs0: SUCCESS (10.212s)
[195.231571] Starting dynamic subtest: vcs1
[203.863416] Dynamic subtest vcs1: SUCCESS (8.641s)
[203.871014] Starting dynamic subtest: vecs0
[214.071713] Dynamic subtest vecs0: SUCCESS (10.206s)
[214.078549] Starting dynamic subtest: ccs0
[225.590606] Dynamic subtest ccs0: SUCCESS (11.518s)
[225.593311] Subtest wide: SUCCESS (48.820s)
[226.853888] [049/130] (791s left) kms_psr (pr-primary-render)
[226.944129] Starting subtest: pr-primary-render
[226.948579] Subtest pr-primary-render: SKIP (0.000s)
[227.007824] [050/130] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[227.107414] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[231.649490] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.549s)
[231.779085] [051/130] (787s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[231.885117] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[231.887514] Starting dynamic subtest: pipe-A-eDP-1
[231.896854] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.905117] Starting dynamic subtest: pipe-B-eDP-1
[231.914217] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.921457] Starting dynamic subtest: pipe-C-eDP-1
[231.930532] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.937102] Starting dynamic subtest: pipe-D-eDP-1
[231.945622] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.949712] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[233.999722] [052/130] (784s left) kms_vblank (wait-forked-hang)
[234.101080] Starting subtest: wait-forked-hang
[234.103324] Starting dynamic subtest: pipe-A-eDP-1
[260.713155] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.607s)
[260.726921] Starting dynamic subtest: pipe-D-eDP-1
[285.661263] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.946s)
[285.663789] Subtest wait-forked-hang: SUCCESS (51.557s)
[286.454412] [053/130] (732s left) kms_flip_tiling (flip-change-tiling)
[286.548092] Starting subtest: flip-change-tiling
[286.550413] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[286.741417] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.192s)
[286.752737] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[286.914828] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.170s)
[286.925046] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[287.086783] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.171s)
[287.097490] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[287.285533] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.197s)
[287.295365] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[287.456194] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.170s)
[287.464082] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[287.627876] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.171s)
[287.636666] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[287.800241] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.171s)
[287.810026] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[287.964084] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.161s)
[287.973062] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[288.148745] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.182s)
[288.159643] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[288.348815] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.198s)
[288.362818] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[288.519139] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.171s)
[288.528720] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[288.691299] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.171s)
[288.701643] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[288.846949] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.154s)
[288.857114] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[289.003696] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.155s)
[289.017596] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[289.153548] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.149s)
[289.163324] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[289.323942] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.171s)
[289.334544] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[289.499291] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.174s)
[289.508802] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[289.670777] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.170s)
[289.680862] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[289.843594] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.171s)
[289.853947] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[290.015651] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.170s)
[290.026334] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[290.187174] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.170s)
[290.197205] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[290.348051] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.159s)
[290.357770] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[290.531503] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.182s)
[290.541166] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[290.708386] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.175s)
[290.718733] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[290.885286] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.175s)
[290.895249] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[291.057638] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.170s)
[291.067508] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[291.229164] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.171s)
[291.238708] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[291.401233] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.170s)
[291.411463] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[291.563653] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.161s)
[291.572927] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[291.738593] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.173s)
[291.749147] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[291.921419] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.182s)
[291.931798] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[292.093312] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.170s)
[292.103036] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[292.265868] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.170s)
[292.275667] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[292.439221] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.171s)
[292.448416] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[292.616253] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.176s)
[292.626529] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[292.767930] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.151s)
[292.820871] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[294.028458] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.215s)
[294.039767] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[294.201355] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.170s)
[294.212443] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[294.373382] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s)
[294.382990] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[294.544306] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.170s)
[294.554333] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[294.715675] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.170s)
[294.726718] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[294.887897] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.170s)
[294.898034] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[295.060097] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.170s)
[295.071273] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[295.210716] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[295.219985] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[295.382735] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s)
[295.392507] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[295.553387] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.171s)
[295.564080] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[295.752726] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.198s)
[295.765831] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[295.941054] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.187s)
[295.953723] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[296.112874] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.170s)
[296.121839] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[296.269958] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.155s)
[296.280096] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[296.402393] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.132s)
[296.412685] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[296.575384] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s)
[296.585976] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[296.745756] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.170s)
[296.755803] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[296.929655] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.181s)
[296.939650] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[297.102096] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.170s)
[297.111954] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[297.273981] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.170s)
[297.282692] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[297.457566] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.182s)
[297.465923] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[297.606825] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.148s)
[297.616196] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[297.778038] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.170s)
[297.786144] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[297.957098] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.177s)
[297.966164] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[298.141232] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.182s)
[298.150815] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[298.313452] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.170s)
[298.322623] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[298.485079] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.169s)
[298.494577] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[298.658522] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.170s)
[298.669552] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[298.813964] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.155s)
[298.827075] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[298.991263] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.176s)
[299.001056] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[299.162344] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.170s)
[299.172131] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[299.334722] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.170s)
[299.345448] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[299.507031] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.170s)
[299.519716] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[299.691194] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.183s)
[299.700519] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[299.871096] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.178s)
[299.881102] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[300.023439] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.151s)
[300.074220] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[301.353300] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.284s)
[301.363226] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[301.503799] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[301.513732] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[301.653399] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s)
[301.663192] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[301.801971] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.149s)
[301.811845] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[301.951332] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.148s)
[301.960993] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[302.102395] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.148s)
[302.112043] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[302.251392] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.149s)
[302.261341] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[302.402044] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[302.412126] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[302.551424] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.147s)
[302.561068] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[302.700101] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.148s)
[302.711728] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[302.874385] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.173s)
[302.884182] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[303.024211] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.148s)
[303.033825] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[303.174633] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.148s)
[303.185048] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[303.325080] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.148s)
[303.335717] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[303.474878] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[303.485195] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[303.623063] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s)
[303.632651] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[303.772621] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.148s)
[303.784777] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[303.922569] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.149s)
[303.933091] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[304.072793] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.148s)
[304.083455] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[304.223286] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.148s)
[304.233438] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[304.372968] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.148s)
[304.383759] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[304.521939] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.148s)
[304.532050] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[304.670909] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.148s)
[304.680734] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[304.820594] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.149s)
[304.830230] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[304.970137] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.148s)
[304.979568] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[305.119852] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.148s)
[305.129530] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[305.269527] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.148s)
[305.277942] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[305.419099] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.148s)
[305.428665] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[305.569735] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.149s)
[305.579423] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[305.719059] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.148s)
[305.728854] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[305.868604] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.148s)
[305.878699] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[306.018291] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.148s)
[306.027890] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[306.168412] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.149s)
[306.177871] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[306.318463] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.148s)
[306.327816] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[306.487790] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.167s)
[306.497506] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[306.642924] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.152s)
[306.669739] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[307.879356] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.214s)
[307.889583] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[308.030351] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[308.038260] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[308.180027] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s)
[308.188643] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[308.328964] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.148s)
[308.338495] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[308.478044] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.148s)
[308.486558] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[308.627734] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.148s)
[308.638749] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[308.778562] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.148s)
[308.788651] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[308.928910] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.147s)
[308.942647] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[309.078376] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s)
[309.090945] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[309.227450] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.149s)
[309.237695] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[309.376370] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.148s)
[309.386216] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[309.525982] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.148s)
[309.535104] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[309.675823] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.148s)
[309.684059] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[309.827093] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.148s)
[309.837396] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[309.976768] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[309.986471] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[310.125139] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s)
[310.135133] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[310.274649] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.148s)
[310.284498] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[310.423973] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.148s)
[310.433743] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[310.574243] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.148s)
[310.581982] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[310.724277] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.148s)
[310.734569] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[310.874808] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.147s)
[310.882858] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[311.025809] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.150s)
[311.036065] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[311.175349] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.148s)
[311.185584] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[311.324958] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.148s)
[311.334664] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[311.474582] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.148s)
[311.483263] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[311.624106] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.148s)
[311.632221] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[311.774145] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.148s)
[311.784864] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[311.923412] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.148s)
[311.933123] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[312.073475] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.148s)
[312.083441] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[312.255308] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.180s)
[312.268503] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[312.404431] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.148s)
[312.418043] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[312.554751] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.147s)
[312.564072] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[312.704130] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.149s)
[312.713755] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[312.855020] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.149s)
[312.867151] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[313.011449] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.154s)
[313.021018] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[313.172996] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.160s)
[313.194527] Subtest flip-change-tiling: SUCCESS (26.647s)
[314.360496] [054/130] (704s left) gem_exec_params (batch-first)
[314.419258] Starting subtest: batch-first
[314.424948] Subtest batch-first: SUCCESS (0.006s)
[314.530531] [055/130] (704s left) gem_mmap_wc (pf-nonblock)
[314.576172] Subtest pf-nonblock: SKIP (0.000s)
[314.621587] [056/130] (704s left) perf_pmu (busy-idle)
[314.660893] Starting subtest: busy-idle
[314.663741] Starting dynamic subtest: rcs0
[315.371716] Dynamic subtest rcs0: SUCCESS (0.712s)
[315.381807] Starting dynamic subtest: bcs0
[316.032454] Dynamic subtest bcs0: SUCCESS (0.659s)
[316.042572] Starting dynamic subtest: vcs0
[317.930505] Dynamic subtest vcs0: SUCCESS (1.895s)
[317.941928] Starting dynamic subtest: vcs1
[319.912882] Dynamic subtest vcs1: SUCCESS (1.982s)
[319.924196] Starting dynamic subtest: vecs0
[321.900240] Dynamic subtest vecs0: SUCCESS (1.984s)
[321.911571] Starting dynamic subtest: ccs0
[322.568588] Dynamic subtest ccs0: SUCCESS (0.668s)
[322.571345] Subtest busy-idle: SUCCESS (7.909s)
[322.661095] [057/130] (696s left) prime_busy (hang)
[322.720512] Starting subtest: hang
[322.722947] Starting dynamic subtest: rcs0
[348.414872] Dynamic subtest rcs0: SUCCESS (25.689s)
[348.422550] Starting dynamic subtest: bcs0
[355.577615] Dynamic subtest bcs0: SUCCESS (7.160s)
[355.585079] Starting dynamic subtest: vcs0
[362.612683] Dynamic subtest vcs0: SUCCESS (7.035s)
[362.620068] Starting dynamic subtest: vcs1
[369.589787] Dynamic subtest vcs1: SUCCESS (6.979s)
[369.597621] Starting dynamic subtest: vecs0
[376.565546] Dynamic subtest vecs0: SUCCESS (6.971s)
[376.574893] Starting dynamic subtest: ccs0
[390.462633] Dynamic subtest ccs0: SUCCESS (13.897s)
[390.464997] Subtest hang: SUCCESS (67.738s)
[390.593016] [058/130] (628s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[395.598839] Starting subtest: fbc-pr-cursor-plane-update-sf
[395.603581] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[396.449687] [059/130] (622s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[396.557462] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[396.561814] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[396.645464] [060/130] (622s left) gem_exec_fence (invalid-fence-array)
[397.101943] Starting subtest: invalid-fence-array
[397.104426] Subtest invalid-fence-array: SUCCESS (0.002s)
[398.981096] [061/130] (620s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[399.046030] Starting subtest: invalid-bsd1-flag-on-blt
[399.048451] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[399.135429] [062/130] (620s left) gem_partial_pwrite_pread (write)
[399.188572] Subtest write: SKIP (0.000s)
[399.267559] [063/130] (620s left) kms_flip (modeset-vs-vblank-race-interruptible)
[399.370646] Starting subtest: modeset-vs-vblank-race-interruptible
[399.372778] Starting dynamic subtest: A-eDP1
[404.053724] Dynamic subtest A-eDP1: SUCCESS (4.681s)
[404.062541] Starting dynamic subtest: B-eDP1
[408.753233] Dynamic subtest B-eDP1: SUCCESS (4.697s)
[408.763564] Starting dynamic subtest: C-eDP1
[413.337536] Dynamic subtest C-eDP1: SUCCESS (4.582s)
[413.346336] Starting dynamic subtest: D-eDP1
[417.763234] Dynamic subtest D-eDP1: SUCCESS (4.425s)
[417.765605] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.394s)
[418.910255] [064/130] (600s left) prime_vgem (basic-read)
[418.983549] Starting subtest: basic-read
[418.995483] Subtest basic-read: SKIP (0.010s)
[419.107771] [065/130] (600s left) drm_fdinfo (busy)
[419.144514] Starting subtest: busy
[419.146824] Starting dynamic subtest: rcs0
[419.166397] Dynamic subtest rcs0: SKIP (0.020s)
[419.176221] Starting dynamic subtest: bcs0
[419.190844] Dynamic subtest bcs0: SKIP (0.024s)
[419.198502] Starting dynamic subtest: vcs0
[419.202941] Dynamic subtest vcs0: SKIP (0.000s)
[419.210925] Starting dynamic subtest: vcs1
[419.215076] Dynamic subtest vcs1: SKIP (0.000s)
[419.222460] Starting dynamic subtest: vecs0
[419.226879] Dynamic subtest vecs0: SKIP (0.000s)
[419.234592] Starting dynamic subtest: ccs0
[419.239248] Dynamic subtest ccs0: SKIP (0.000s)
[419.243803] Subtest busy: SKIP (0.049s)
[419.274685] [066/130] (600s left) gem_render_copy (linear)
[419.329802] Starting subtest: linear
[419.332182] Starting dynamic subtest: smem
[419.371053] Dynamic subtest smem: SUCCESS (0.041s)
[419.373403] Subtest linear: SUCCESS (0.042s)
[419.599037] [067/130] (599s left) gem_workarounds (basic-read-context)
[419.653583] Starting subtest: basic-read-context
[419.663080] Subtest basic-read-context: SUCCESS (0.009s)
[419.797408] [068/130] (599s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[419.897374] Starting subtest: 4-tiled-64bpp-rotate-0
[422.047213] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (2.150s)
[422.276114] [069/130] (597s left) gem_mmap_gtt (medium-copy-xy)
[422.394221] Subtest medium-copy-XY: SKIP (0.000s)
[422.448034] [070/130] (597s left) kms_atomic_interruptible (legacy-setmode)
[422.551076] Starting subtest: legacy-setmode
[422.553416] Starting dynamic subtest: pipe-A-eDP-1
[429.416640] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.864s)
[429.418638] Subtest legacy-setmode: SUCCESS (6.865s)
[430.276913] [071/130] (589s left) syncobj_eventfd (timeline-wait-signaled)
[430.332083] Starting subtest: timeline-wait-signaled
[430.334366] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[430.415283] [072/130] (589s left) kms_cursor_crc (cursor-offscreen-256x85)
[430.631377] Starting subtest: cursor-offscreen-256x85
[430.669572] Subtest cursor-offscreen-256x85: SKIP (0.033s)
[430.866505] [073/130] (588s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[430.965278] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[430.967550] Starting dynamic subtest: pipe-A-default-mode
[432.135849] Dynamic subtest pipe-A-default-mode: SKIP (1.166s)
[432.140992] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.168s)
[432.286712] [074/130] (587s left) kms_cursor_crc (cursor-random-128x42)
[432.484886] Starting subtest: cursor-random-128x42
[432.526939] Subtest cursor-random-128x42: SKIP (0.038s)
[432.722930] [075/130] (586s left) gem_set_tiling_vs_gtt
[432.832360] [076/130] (586s left) drm_read (short-buffer-nonblock)
[432.990075] Starting subtest: short-buffer-nonblock
[432.992348] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[433.141921] [077/130] (586s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[433.234524] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[433.237958] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[433.320856] [078/130] (586s left) kms_atomic_transition (plane-all-transition-fencing)
[433.415101] Starting subtest: plane-all-transition-fencing
[433.417234] Starting dynamic subtest: pipe-A-eDP-1
[435.920834] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s)
[436.219088] Starting dynamic subtest: pipe-B-eDP-1
[439.445385] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.235s)
[439.720843] Subtest plane-all-transition-fencing: SUCCESS (6.304s)
[440.552411] [079/130] (579s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[445.609574] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[445.611890] Starting dynamic subtest: pipe-A-eDP-1
[446.412835] Dynamic subtest pipe-A-eDP-1: SKIP (0.800s)
[446.421361] Starting dynamic subtest: pipe-B-eDP-1
[447.539770] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[447.544277] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.928s)
[448.711444] [080/130] (571s left) kms_sequence (get-forked)
[448.805362] Starting subtest: get-forked
[448.807780] Starting dynamic subtest: pipe-A-eDP-1
[450.721265] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.913s)
[450.729465] Starting dynamic subtest: pipe-B-eDP-1
[453.293711] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.571s)
[453.302666] Starting dynamic subtest: pipe-C-eDP-1
[455.789624] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.495s)
[455.798426] Starting dynamic subtest: pipe-D-eDP-1
[458.315819] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.526s)
[458.318217] Subtest get-forked: SUCCESS (9.510s)
[459.128100] [081/130] (560s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[459.202616] Starting subtest: stress-mm-invalidate-close-overlap
[461.352557] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[461.482243] [082/130] (558s left) gem_exec_whisper (basic-contexts-forked)
[461.543188] Starting subtest: basic-contexts-forked
[486.183992] Subtest basic-contexts-forked: SUCCESS (24.634s)
[486.364529] [083/130] (533s left) gem_ctx_persistence (engines-hostile-preempt)
[486.440635] Starting subtest: engines-hostile-preempt
[486.443067] Starting dynamic subtest: rcs0
[486.572232] Dynamic subtest rcs0: SUCCESS (0.130s)
[486.582788] Starting dynamic subtest: bcs0
[486.631924] Dynamic subtest bcs0: SUCCESS (0.058s)
[486.642066] Starting dynamic subtest: vcs0
[487.899482] Dynamic subtest vcs0: SUCCESS (1.264s)
[487.908965] Starting dynamic subtest: vcs1
[489.896467] Dynamic subtest vcs1: SUCCESS (1.995s)
[489.907785] Starting dynamic subtest: vecs0
[491.864504] Dynamic subtest vecs0: SUCCESS (1.966s)
[491.873436] Starting dynamic subtest: ccs0
[491.963876] Dynamic subtest ccs0: SUCCESS (0.099s)
[491.966573] Subtest engines-hostile-preempt: SUCCESS (5.524s)
[492.039223] [084/130] (527s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[492.099078] Starting subtest: multi-wait-available-unsubmitted-submitted
[492.101244] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[492.219018] [085/130] (527s left) kms_color (invalid-degamma-lut-sizes)
[492.316850] Starting subtest: invalid-degamma-lut-sizes
[492.319367] Starting dynamic subtest: pipe-A
[492.602237] Dynamic subtest pipe-A: SUCCESS (0.282s)
[492.611229] Starting dynamic subtest: pipe-B
[492.613552] Dynamic subtest pipe-B: SUCCESS (0.002s)
[492.621405] Starting dynamic subtest: pipe-C
[492.623842] Dynamic subtest pipe-C: SUCCESS (0.001s)
[492.633621] Starting dynamic subtest: pipe-D
[492.635881] Dynamic subtest pipe-D: SUCCESS (0.001s)
[492.638137] Subtest invalid-degamma-lut-sizes: SUCCESS (0.289s)
[493.449403] [086/130] (526s left) kms_plane_cursor (overlay)
[493.564047] Starting subtest: overlay
[493.568640] Starting dynamic subtest: pipe-A-eDP-1-size-64
[496.483902] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.919s)
[496.545193] Starting dynamic subtest: pipe-A-eDP-1-size-128
[499.442083] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.904s)
[499.502678] Starting dynamic subtest: pipe-A-eDP-1-size-256
[502.286154] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.793s)
[502.633535] Starting dynamic subtest: pipe-B-eDP-1-size-64
[506.252742] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.629s)
[506.316473] Starting dynamic subtest: pipe-B-eDP-1-size-128
[509.167301] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.859s)
[509.224060] Starting dynamic subtest: pipe-B-eDP-1-size-256
[512.068375] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.850s)
[512.416098] Starting dynamic subtest: pipe-C-eDP-1-size-64
[515.488514] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.080s)
[515.525269] Starting dynamic subtest: pipe-C-eDP-1-size-128
[517.955336] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.435s)
[517.993899] Starting dynamic subtest: pipe-C-eDP-1-size-256
[520.411271] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.424s)
[520.739653] Starting dynamic subtest: pipe-D-eDP-1-size-64
[523.809354] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.080s)
[523.847222] Starting dynamic subtest: pipe-D-eDP-1-size-128
[526.254198] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.412s)
[526.291342] Starting dynamic subtest: pipe-D-eDP-1-size-256
[528.699056] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.413s)
[529.020456] Subtest overlay: SUCCESS (35.451s)
[529.835152] [087/130] (490s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[529.936954] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[529.939303] Starting dynamic subtest: A-eDP1
[533.430180] Dynamic subtest A-eDP1: SUCCESS (3.491s)
[533.438938] Starting dynamic subtest: B-eDP1
[536.519080] Dynamic subtest B-eDP1: SUCCESS (3.089s)
[536.528066] Starting dynamic subtest: C-eDP1
[539.584458] Dynamic subtest C-eDP1: SUCCESS (3.062s)
[539.593437] Starting dynamic subtest: D-eDP1
[542.657020] Dynamic subtest D-eDP1: SUCCESS (3.073s)
[542.659877] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.722s)
[543.445143] [088/130] (476s left) gem_create (create-ext-cpu-access-big)
[543.617089] Starting subtest: create-ext-cpu-access-big
[543.622186] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[543.685464] [089/130] (476s left) gem_mmap_gtt (basic-read-write)
[543.740751] Subtest basic-read-write: SKIP (0.000s)
[543.795636] [090/130] (476s left) gem_exec_reloc (basic-gtt-wc-active)
[543.857024] Subtest basic-gtt-wc-active: SKIP (0.000s)
[543.935687] [091/130] (476s left) gem_spin_batch (spin-each)
[544.005290] Starting subtest: spin-each
[547.282715] Subtest spin-each: SUCCESS (3.270s)
[548.040843] [092/130] (472s left) gem_exec_balancer (parallel)
[548.292224] Starting subtest: parallel
[549.056577] Subtest parallel: SUCCESS (0.764s)
[549.964970] [093/130] (470s left) kms_pm_backlight (fade)
[550.066874] Starting subtest: fade
[550.128204] Starting dynamic subtest: eDP-1
[552.794761] Dynamic subtest eDP-1: SUCCESS (2.664s)
[552.797158] Subtest fade: SUCCESS (2.729s)
[553.576142] [094/130] (466s left) kms_dsc (dsc-with-bpc-formats)
[553.679089] Starting subtest: dsc-with-bpc-formats
[553.790226] Subtest dsc-with-bpc-formats: SKIP (0.002s)
[553.822348] [095/130] (466s left) kms_atomic (atomic-plane-damage)
[553.918311] Starting subtest: atomic-plane-damage
[553.973070] Starting dynamic subtest: pipe-A-eDP-1
[554.602270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[554.604594] Subtest atomic-plane-damage: SUCCESS (0.684s)
[555.409257] [096/130] (465s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[555.614855] Starting subtest: cursor-rapid-movement-256x256
[555.620189] Starting dynamic subtest: pipe-A-eDP-1
[556.182288] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[556.207908] Starting dynamic subtest: pipe-D-eDP-1
[557.421461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[557.423807] Subtest cursor-rapid-movement-256x256: SUCCESS (1.805s)
[558.255282] [097/130] (462s left) kms_frontbuffer_tracking (fbc-tiling-4)
[558.369297] Starting subtest: fbc-tiling-4
[561.586337] Subtest fbc-tiling-4: SUCCESS (3.221s)
[561.717432] [098/130] (458s left) kms_fb_coherency (memset-crc)
[561.817402] Starting subtest: memset-crc
[561.819052] Starting dynamic subtest: mmap-offset-wc
[562.202501] Dynamic subtest mmap-offset-wc: SUCCESS (0.386s)
[562.497881] Starting dynamic subtest: mmap-offset-uc
[568.572452] Dynamic subtest mmap-offset-uc: SUCCESS (6.082s)
[568.867516] Subtest memset-crc: SUCCESS (7.049s)
[569.732672] [099/130] (450s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[569.846438] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[569.850406] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[569.937584] [100/130] (450s left) kms_rotation_crc (bad-tiling)
[570.037134] Starting subtest: bad-tiling
[570.041697] Subtest bad-tiling: SKIP (0.001s)
[570.103830] [101/130] (450s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[570.202420] Starting subtest: y-tiled-16bpp-rotate-180
[570.206883] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[570.277956] [102/130] (450s left) gem_ctx_shared (q-independent)
[570.334163] Starting subtest: Q-independent
[570.336404] Starting dynamic subtest: rcs0
[570.392665] Dynamic subtest rcs0: SUCCESS (0.058s)
[570.402896] Starting dynamic subtest: vcs0
[570.434064] Dynamic subtest vcs0: SUCCESS (0.040s)
[570.443456] Starting dynamic subtest: vcs1
[570.469101] Dynamic subtest vcs1: SUCCESS (0.035s)
[570.477208] Starting dynamic subtest: vecs0
[570.501737] Dynamic subtest vecs0: SUCCESS (0.032s)
[570.516698] Starting dynamic subtest: ccs0
[570.544621] Dynamic subtest ccs0: SUCCESS (0.042s)
[570.547063] Subtest Q-independent: SUCCESS (0.210s)
[572.052623] [103/130] (448s left) i915_query (query-topology-kernel-writes)
[572.105033] Starting subtest: query-topology-kernel-writes
[572.107248] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[572.207579] [104/130] (448s left) gem_mmap_gtt (big-copy)
[572.265971] Subtest big-copy: SKIP (0.000s)
[572.322895] [105/130] (448s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[572.376740] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[572.479058] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[572.548463] [106/130] (448s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[572.659425] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[577.188632] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (4.532s)
[577.311263] [107/130] (443s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[577.416692] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[577.420633] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[577.517274] [108/130] (443s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[577.622679] Starting subtest: psr-1p-primscrn-cur-indfb-move
[582.678590] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.060s)
[582.807487] [109/130] (438s left) kms_flip (blocking-wf_vblank)
[582.919121] Starting subtest: blocking-wf_vblank
[582.921437] Starting dynamic subtest: A-eDP1
[591.887991] Dynamic subtest A-eDP1: SUCCESS (8.968s)
[591.897478] Starting dynamic subtest: B-eDP1
[600.810666] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[600.819696] Starting dynamic subtest: C-eDP1
[609.721761] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[609.730299] Starting dynamic subtest: D-eDP1
[618.646259] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[618.648725] Subtest blocking-wf_vblank: SUCCESS (35.730s)
[619.866103] [110/130] (401s left) gem_create (create-ext-placement-sanity-check)
[620.043104] Starting subtest: create-ext-placement-sanity-check
[620.045465] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[620.151587] [111/130] (400s left) kms_lease (lease-unleased-connector)
[620.256843] Starting subtest: lease-unleased-connector
[620.259311] Starting dynamic subtest: pipe-A-eDP-1
[620.269502] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.010s)
[620.279091] Starting dynamic subtest: pipe-B-eDP-1
[620.281312] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[620.291166] Starting dynamic subtest: pipe-C-eDP-1
[620.293457] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[620.302912] Starting dynamic subtest: pipe-D-eDP-1
[620.305197] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[620.307588] Subtest lease-unleased-connector: SUCCESS (0.046s)
[620.409068] [112/130] (400s left) api_intel_bb (simple-bb)
[620.472404] Starting subtest: simple-bb
[620.475072] Subtest simple-bb: SUCCESS (0.005s)
[620.575179] [113/130] (400s left) kms_addfb_basic (bad-pitch-63)
[620.635252] Starting subtest: bad-pitch-63
[620.637262] Subtest bad-pitch-63: SUCCESS (0.000s)
[620.772800] [114/130] (400s left) gem_pxp (create-regular-context-1)
[620.900257] Starting subtest: create-regular-context-1
[620.902754] Subtest create-regular-context-1: SUCCESS (0.002s)
[620.998819] [115/130] (400s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[621.092509] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[621.095956] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[621.182896] [116/130] (399s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[621.292674] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[622.425884] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.134s)
[622.556660] [117/130] (398s left) gen9_exec_parse (allowed-single)
[622.618780] Subtest allowed-single: SKIP (0.000s)
[622.685092] [118/130] (398s left) i915_pm_rps (basic-api)
[622.739103] Starting subtest: basic-api
[622.742650] Subtest basic-api: SKIP (0.001s)
[622.802990] [119/130] (398s left) api_intel_allocator (execbuf-with-allocator)
[622.858038] Starting subtest: execbuf-with-allocator
[622.860322] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[622.982923] [120/130] (398s left) kms_rotation_crc (primary-rotation-180)
[623.075654] Starting subtest: primary-rotation-180
[630.004078] Subtest primary-rotation-180: SUCCESS (6.926s)
[631.211290] [121/130] (390s left) perf_pmu (multi-client)
[631.249895] Starting subtest: multi-client
[631.252236] Starting dynamic subtest: rcs0
[632.317431] Dynamic subtest rcs0: SUCCESS (1.066s)
[632.328631] Starting dynamic subtest: bcs0
[633.366137] Dynamic subtest bcs0: SUCCESS (1.047s)
[633.375737] Starting dynamic subtest: vcs0
[634.415499] Dynamic subtest vcs0: SUCCESS (1.047s)
[634.426628] Starting dynamic subtest: vcs1
[635.940536] Dynamic subtest vcs1: SUCCESS (1.522s)
[635.949778] Starting dynamic subtest: vecs0
[637.924037] Dynamic subtest vecs0: SUCCESS (1.982s)
[637.935282] Starting dynamic subtest: ccs0
[639.968647] Dynamic subtest ccs0: SUCCESS (2.042s)
[639.971830] Subtest multi-client: SUCCESS (8.718s)
[640.082281] [122/130] (381s left) api_intel_allocator (two-level-inception-interruptible)
[640.134165] Starting subtest: two-level-inception-interruptible
[645.550407] Subtest two-level-inception-interruptible: SUCCESS (5.415s)
[645.672175] [123/130] (375s left) i915_pm_freq_api (freq-suspend)
[645.738162] Starting subtest: freq-suspend
[645.740637] Starting dynamic subtest: gt0
[661.609885] Dynamic subtest gt0: SUCCESS (4.617s)
[661.622386] Starting dynamic subtest: gt1
[677.540061] Dynamic subtest gt1: SUCCESS (1.159s)
[677.544796] Subtest freq-suspend: SUCCESS (5.779s)
[678.623841] [124/130] (369s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[678.682587] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[678.687420] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[678.868521] [125/130] (369s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[678.970839] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[678.975165] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[679.072653] [126/130] (369s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[679.176817] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[684.335200] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (5.020s)
[684.488717] [127/130] (364s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[684.597502] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[689.524035] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.860s)
[689.630777] [128/130] (359s left) kms_flip (2x-plain-flip-fb-recreate)
[689.735750] Starting subtest: 2x-plain-flip-fb-recreate
[689.746355] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[689.820483] [129/130] (358s left) gem_mmap_gtt (basic)
[689.885772] Subtest basic: SKIP (0.000s)
[689.948309] [130/130] (358s left) gem_gtt_cpu_tlb
[690.077171] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: intel_hwmon
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: gem_gpgpu_fill
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_pm_dc
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_flush
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_watchdog
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: sysfs_timeslice_duration
results: parsing output: 26/ for test: kms_fence_pin_leak
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_force_connector_basic
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: dumb_buffer
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: i915_query
results: parsing output: 42/ for test: kms_joiner
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_exec_reloc
results: parsing output: 45/ for test: kms_chamelium_edid
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_flip_tiling
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: prime_busy
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: gem_partial_pwrite_pread
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: prime_vgem
results: parsing output: 64/ for test: drm_fdinfo
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: gem_workarounds
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_atomic_interruptible
results: parsing output: 70/ for test: syncobj_eventfd
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_set_tiling_vs_gtt
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_atomic_transition
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_sequence
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: gem_exec_whisper
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_color
results: parsing output: 85/ for test: kms_plane_cursor
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: gem_create
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: kms_pm_backlight
results: parsing output: 93/ for test: kms_dsc
results: parsing output: 94/ for test: kms_atomic
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_fb_coherency
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_ctx_shared
results: parsing output: 102/ for test: i915_query
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: gem_create
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: gem_pxp
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gen9_exec_parse
results: parsing output: 117/ for test: i915_pm_rps
results: parsing output: 118/ for test: api_intel_allocator
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: api_intel_allocator
results: parsing output: 122/ for test: i915_pm_freq_api
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: gem_gtt_cpu_tlb
Done.