[61.146886] Initializing watchdogs
[61.146948]   /dev/watchdog0
[61.164836] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.174860] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.178300] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.180492] [001/131] (960s left) kms_concurrent (multi-plane-atomic-lowres)
[61.475193] Starting subtest: multi-plane-atomic-lowres
[61.476065] Starting dynamic subtest: pipe-A-DP-4
[62.001048] Dynamic subtest pipe-A-DP-4: SUCCESS (0.526s)
[62.002109] Subtest multi-plane-atomic-lowres: SUCCESS (0.527s)
[62.284715] [002/131] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[62.487397] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[62.489140] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[62.585166] [003/131] (959s left) kms_flip (plain-flip-interruptible)
[62.794284] Starting subtest: plain-flip-interruptible
[62.799447] Starting dynamic subtest: A-DP4
[63.646125] Dynamic subtest A-DP4: SUCCESS (0.848s)
[63.677401] Starting dynamic subtest: B-DP4
[64.423239] Dynamic subtest B-DP4: SUCCESS (0.778s)
[64.432209] Starting dynamic subtest: C-DP4
[65.170275] Dynamic subtest C-DP4: SUCCESS (0.748s)
[65.178454] Starting dynamic subtest: D-DP4
[65.917377] Dynamic subtest D-DP4: SUCCESS (0.748s)
[65.918350] Subtest plain-flip-interruptible: SUCCESS (3.130s)
[66.245984] [004/131] (955s left) gem_exec_params (readonly)
[66.325757] Starting subtest: readonly
[66.327731] Subtest readonly: SUCCESS (0.001s)
[66.447916] [005/131] (955s left) api_intel_allocator (open-vm)
[66.519075] Starting subtest: open-vm
[66.542922] Subtest open-vm: SUCCESS (0.024s)
[66.712688] [006/131] (955s left) kms_psr (fbc-psr2-sprite-blt)
[67.016803] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[67.104353] [007/131] (954s left) kms_pm_backlight (bad-brightness)
[67.562462] Subtest bad-brightness: SKIP (0.000s)
[67.627812] [008/131] (954s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[68.205486] Starting subtest: cursor-rapid-movement-256x256
[68.210223] Starting dynamic subtest: pipe-A-DP-4
[68.646977] Dynamic subtest pipe-A-DP-4: SUCCESS (0.437s)
[68.690956] Starting dynamic subtest: pipe-D-DP-4
[69.093094] Dynamic subtest pipe-D-DP-4: SUCCESS (0.409s)
[69.094056] Subtest cursor-rapid-movement-256x256: SUCCESS (0.888s)
[69.450942] [009/131] (952s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[69.654445] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[69.656236] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[69.945988] [010/131] (952s left) syncobj_timeline (host-signal-points)
[70.019538] Starting subtest: host-signal-points
[70.025902] Subtest host-signal-points: SUCCESS (0.006s)
[70.151682] [011/131] (952s left) syncobj_wait (invalid-reset-bad-pad)
[70.220782] Starting subtest: invalid-reset-bad-pad
[70.221714] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[70.324464] [012/131] (951s left) gem_exec_schedule (pi-shared-iova)
[70.553181] Starting subtest: pi-shared-iova
[70.554686] Starting dynamic subtest: rcs0
[70.809247] Dynamic subtest rcs0: SUCCESS (0.257s)
[70.817069] Starting dynamic subtest: bcs0
[70.973115] Dynamic subtest bcs0: SUCCESS (0.164s)
[70.980794] Starting dynamic subtest: vcs0
[71.151381] Dynamic subtest vcs0: SUCCESS (0.178s)
[71.159173] Starting dynamic subtest: vcs1
[71.327180] Dynamic subtest vcs1: SUCCESS (0.176s)
[71.334926] Starting dynamic subtest: vecs0
[71.502991] Dynamic subtest vecs0: SUCCESS (0.176s)
[71.510711] Starting dynamic subtest: vecs1
[71.681685] Dynamic subtest vecs1: SUCCESS (0.179s)
[71.689482] Starting dynamic subtest: ccs0
[71.855702] Dynamic subtest ccs0: SUCCESS (0.174s)
[71.856789] Subtest pi-shared-iova: SUCCESS (1.305s)
[72.112931] [013/131] (950s left) perf (oa-exponents)
[72.444900] Starting subtest: oa-exponents
[72.445800] Starting dynamic subtest: 0-rcs0
[74.686314] Dynamic subtest 0-rcs0: SUCCESS (2.242s)
[74.687238] Subtest oa-exponents: SUCCESS (2.243s)
[74.745158] [014/131] (947s left) gem_close (basic)
[74.833480] Starting subtest: basic
[74.834490] Subtest basic: SUCCESS (0.000s)
[74.952216] [015/131] (947s left) kms_flip (plain-flip-ts-check)
[75.154986] Starting subtest: plain-flip-ts-check
[75.158581] Starting dynamic subtest: A-DP4
[83.280794] Dynamic subtest A-DP4: SUCCESS (8.124s)
[83.294076] Starting dynamic subtest: B-DP4
[91.351677] Dynamic subtest B-DP4: SUCCESS (8.072s)
[91.360245] Starting dynamic subtest: C-DP4
[99.411737] Dynamic subtest C-DP4: SUCCESS (8.059s)
[99.421630] Starting dynamic subtest: D-DP4
[107.457293] Dynamic subtest D-DP4: SUCCESS (8.045s)
[107.458246] Subtest plain-flip-ts-check: SUCCESS (32.309s)
[107.791823] [016/131] (914s left) gem_exec_whisper (basic-fds-all)
[107.874422] Starting subtest: basic-fds-all
[129.933450] Subtest basic-fds-all: SUCCESS (22.059s)
[130.169033] [017/131] (892s left) gem_exec_fence (syncobj-unused-fence)
[130.689790] Starting subtest: syncobj-unused-fence
[130.715060] Subtest syncobj-unused-fence: SUCCESS (0.025s)
[131.123047] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[131.124988] [018/131] (891s left) kms_vblank (ts-continuation-dpms-rpm)
[131.331577] Starting subtest: ts-continuation-dpms-rpm
[131.333467] Starting dynamic subtest: pipe-A-DP-4
[133.172863] Dynamic subtest pipe-A-DP-4: SUCCESS (1.840s)
[133.194226] Starting dynamic subtest: pipe-D-DP-4
[134.192430] Dynamic subtest pipe-D-DP-4: SUCCESS (1.013s)
[134.193328] Subtest ts-continuation-dpms-rpm: SUCCESS (2.860s)
[134.422645] [019/131] (888s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[134.635502] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[134.637255] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[134.759644] [020/131] (888s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[134.969977] Starting subtest: basic-busy-flip-before-cursor-varying-size
[134.971810] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[135.058257] [021/131] (887s left) gem_workarounds (suspend-resume-context)
[135.156978] Starting subtest: suspend-resume-context
[154.415721] Subtest suspend-resume-context: SUCCESS (3.789s)
[158.579294] [022/131] (883s left) kms_prime (d3hot)
[161.510487] Subtest D3hot: SKIP (0.000s)
[161.616703] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.amdgpu: true
[161.617671] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.xe: true
[161.619423] [023/131] (880s left) fbdev (read)
[161.686793] Starting subtest: read
[164.715302] Subtest read: SUCCESS (3.028s)
[164.796196] [024/131] (877s left) kms_psr (psr-basic)
[165.007339] Subtest psr-basic: SKIP (0.000s)
[165.059210] [025/131] (877s left) kms_big_fb (linear-addfb)
[165.280253] Starting subtest: linear-addfb
[165.281204] Subtest linear-addfb: SUCCESS (0.000s)
[165.390439] [026/131] (877s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[165.608254] Starting subtest: flip-vs-dpms-off-vs-modeset
[165.616021] Starting dynamic subtest: A-DP4
[166.637009] Dynamic subtest A-DP4: SUCCESS (1.019s)
[166.657913] Starting dynamic subtest: B-DP4
[167.463936] Dynamic subtest B-DP4: SUCCESS (0.825s)
[167.486088] Starting dynamic subtest: C-DP4
[168.283647] Dynamic subtest C-DP4: SUCCESS (0.820s)
[168.305606] Starting dynamic subtest: D-DP4
[169.108531] Dynamic subtest D-DP4: SUCCESS (0.822s)
[169.109887] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.500s)
[169.432252] [027/131] (873s left) gem_softpin (allocator-nopin-reserve)
[169.520609] Starting subtest: allocator-nopin-reserve
[169.723009] Subtest allocator-nopin-reserve: SUCCESS (0.194s)
[169.915551] [028/131] (872s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[170.129850] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[170.131551] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[170.264191] [029/131] (872s left) gem_basic (create-close)
[170.344309] Starting subtest: create-close
[170.346271] Subtest create-close: SUCCESS (0.000s)
[170.510505] [030/131] (872s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[170.729916] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[170.731735] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[170.870033] [031/131] (872s left) gem_gpgpu_fill (basic)
[170.952484] Starting subtest: basic
[170.953404] Starting dynamic subtest: smem
[170.978319] Dynamic subtest smem: SUCCESS (0.025s)
[170.991352] Starting dynamic subtest: lmem0
[170.993519] Dynamic subtest lmem0: SUCCESS (0.014s)
[170.994479] Subtest basic: SUCCESS (0.041s)
[171.139175] [032/131] (871s left) gem_exec_balancer (hog)
[171.227911] Starting subtest: hog
[171.229954] Subtest hog: SKIP (0.000s)
[171.620242] [033/131] (871s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[171.835548] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[171.837321] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[171.991563] [034/131] (871s left) dmabuf_sync_file (export-wait-after-attach)
[172.049460] Starting subtest: export-wait-after-attach
[172.050398] Subtest export-wait-after-attach: SUCCESS (0.001s)
[172.141822] [035/131] (871s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[172.360005] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[172.361837] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[172.477493] [036/131] (870s left) syncobj_basic (bad-fd-to-handle)
[172.564243] Starting subtest: bad-fd-to-handle
[172.565207] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[172.762085] [037/131] (870s left) gem_close_race (multigpu-basic-process)
[172.876558] Starting subtest: multigpu-basic-process
[172.878625] Subtest multigpu-basic-process: SKIP (0.000s)
[173.198338] [038/131] (870s left) gem_userptr_blits (userfault)
[173.287137] Starting subtest: userfault
[173.289278] Subtest userfault: SUCCESS (0.003s)
[173.459721] [039/131] (870s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[173.537803] Starting subtest: multi-wait-all-for-submit-unsubmitted
[173.643388] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[173.780684] [040/131] (869s left) gem_mmap_wc (write-wc-read-gtt)
[173.862490] Subtest write-wc-read-gtt: SKIP (0.000s)
[173.939693] [041/131] (869s left) i915_hangman (gt-error-state-capture)
[174.033806] Starting subtest: gt-error-state-capture
[174.035048] Starting dynamic subtest: rcs0
[183.630840] Dynamic subtest rcs0: SUCCESS (9.561s)
[183.644298] Starting dynamic subtest: bcs0
[193.600376] Dynamic subtest bcs0: SUCCESS (9.955s)
[193.611021] Starting dynamic subtest: vcs0
[203.613678] Dynamic subtest vcs0: SUCCESS (10.007s)
[203.625780] Starting dynamic subtest: vcs1
[213.608883] Dynamic subtest vcs1: SUCCESS (9.994s)
[213.639575] Starting dynamic subtest: vecs0
[223.552351] Dynamic subtest vecs0: SUCCESS (9.941s)
[223.563163] Starting dynamic subtest: vecs1
[233.593559] Dynamic subtest vecs1: SUCCESS (10.038s)
[233.604397] Starting dynamic subtest: ccs0
[243.588349] Dynamic subtest ccs0: SUCCESS (9.991s)
[243.589265] Subtest gt-error-state-capture: SUCCESS (69.491s)
[243.786876] [042/131] (800s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[244.000745] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[244.002426] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[244.129389] [043/131] (799s left) i915_pm_rpm (gem-idle)
[246.577567] Starting subtest: gem-idle
[251.939678] Subtest gem-idle: SUCCESS (5.361s)
[252.180246] [044/131] (791s left) kms_flip (busy-flip)
[252.435207] Starting subtest: busy-flip
[252.443020] Starting dynamic subtest: A-DP4
[253.290139] Dynamic subtest A-DP4: SUCCESS (0.846s)
[253.304769] Starting dynamic subtest: B-DP4
[254.075520] Dynamic subtest B-DP4: SUCCESS (0.783s)
[254.087423] Starting dynamic subtest: C-DP4
[254.835273] Dynamic subtest C-DP4: SUCCESS (0.758s)
[254.853599] Starting dynamic subtest: D-DP4
[255.612449] Dynamic subtest D-DP4: SUCCESS (0.773s)
[255.618035] Subtest busy-flip: SUCCESS (3.179s)
[255.972748] [045/131] (788s left) syncobj_wait (invalid-reset-illegal-handle)
[256.053831] Starting subtest: invalid-reset-illegal-handle
[256.054698] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[256.222002] [046/131] (787s left) core_auth (many-magics)
[256.297190] Starting subtest: many-magics
[257.673812] Subtest many-magics: SUCCESS (1.372s)
[257.883926] [047/131] (786s left) gem_mmap_offset (close-race)
[257.972250] Starting subtest: close-race
[278.040126] Subtest close-race: SUCCESS (20.069s)
[278.226886] [048/131] (766s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[278.309301] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[278.375346] [049/131] (765s left) prime_mmap (test_forked_cpu_write)
[278.455332] Starting subtest: test_forked_cpu_write
[278.456225] Starting dynamic subtest: test_forked_cpu_write-smem
[278.465331] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[278.476886] Starting dynamic subtest: test_forked_cpu_write-lmem0
[278.477850] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.011s)
[278.478776] Subtest test_forked_cpu_write: SUCCESS (0.023s)
[278.601667] [050/131] (765s left) kms_vrr (flip-basic)
[278.809220] Starting subtest: flip-basic
[278.811943] Subtest flip-basic: SKIP (0.000s)
[278.895304] [051/131] (765s left) kms_atomic (plane-overlay-legacy)
[279.102843] Starting subtest: plane-overlay-legacy
[279.105002] Starting dynamic subtest: pipe-A-DP-4
[279.873480] Dynamic subtest pipe-A-DP-4: SUCCESS (0.768s)
[279.874443] Subtest plane-overlay-legacy: SUCCESS (0.770s)
[280.169934] [052/131] (764s left) kms_hdr (static-toggle-suspend)
[280.386059] Starting subtest: static-toggle-suspend
[283.810455] Starting dynamic subtest: pipe-A-DP-4
[303.619799] Dynamic subtest pipe-A-DP-4: SUCCESS (4.956s)
[303.620821] Subtest static-toggle-suspend: SUCCESS (8.381s)
[307.958909] [053/131] (755s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[308.174947] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[308.176659] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[308.313618] [054/131] (755s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[308.525524] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[308.526479] Starting dynamic subtest: pipe-A-DP-4
[308.548849] Dynamic subtest pipe-A-DP-4: SKIP (0.002s)
[308.559993] Starting dynamic subtest: pipe-B-DP-4
[308.582230] Dynamic subtest pipe-B-DP-4: SKIP (0.002s)
[308.593063] Starting dynamic subtest: pipe-C-DP-4
[308.620174] Dynamic subtest pipe-C-DP-4: SKIP (0.002s)
[308.631773] Starting dynamic subtest: pipe-D-DP-4
[308.652184] Dynamic subtest pipe-D-DP-4: SKIP (0.002s)
[308.653686] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.013s)
[308.999148] [055/131] (754s left) gem_ctx_shared (q-smoketest-all)
[309.096579] Starting subtest: Q-smoketest-all
[341.481980] Subtest Q-smoketest-all: SUCCESS (32.293s)
[341.736258] [056/131] (722s left) kms_plane_alpha_blend (alpha-opaque-fb)
[341.944994] Starting subtest: alpha-opaque-fb
[342.162211] Starting dynamic subtest: pipe-A-DP-4
[342.644128] Dynamic subtest pipe-A-DP-4: SUCCESS (0.481s)
[342.656485] Starting dynamic subtest: pipe-D-DP-4
[343.215868] Dynamic subtest pipe-D-DP-4: SUCCESS (0.568s)
[343.216795] Subtest alpha-opaque-fb: SUCCESS (1.270s)
[343.491804] [057/131] (720s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[343.705516] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[343.707328] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[343.846759] [058/131] (720s left) gem_exec_params (no-blt)
[343.923858] Starting subtest: no-blt
[343.925932] Subtest no-blt: SUCCESS (0.001s)
[344.094340] [059/131] (719s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[344.309853] Starting subtest: bad-rotation-90-y-tiled-ccs
[344.310859] Starting dynamic subtest: pipe-A-DP-4
[344.319812] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[344.330998] Starting dynamic subtest: pipe-B-DP-4
[344.339598] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[344.350622] Starting dynamic subtest: pipe-C-DP-4
[344.359055] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[344.369915] Starting dynamic subtest: pipe-D-DP-4
[344.379698] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[344.381699] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.007s)
[344.790824] [060/131] (719s left) gen9_exec_parse (bb-secure)
[344.882324] Subtest bb-secure: SKIP (0.000s)
[344.961662] [061/131] (719s left) gem_fenced_exec_thrash (too-many-fences)
[345.041398] Subtest too-many-fences: SKIP (0.000s)
[345.144731] [062/131] (719s left) kms_lease (lease-unleased-connector)
[345.356551] Starting subtest: lease-unleased-connector
[345.359016] Starting dynamic subtest: pipe-A-DP-4
[345.511523] Dynamic subtest pipe-A-DP-4: SUCCESS (0.150s)
[345.539848] Starting dynamic subtest: pipe-B-DP-4
[345.656065] Dynamic subtest pipe-B-DP-4: SUCCESS (0.140s)
[345.666820] Starting dynamic subtest: pipe-C-DP-4
[345.788966] Dynamic subtest pipe-C-DP-4: SUCCESS (0.133s)
[345.801771] Starting dynamic subtest: pipe-D-DP-4
[345.939132] Dynamic subtest pipe-D-DP-4: SUCCESS (0.144s)
[345.941100] Subtest lease-unleased-connector: SUCCESS (0.580s)
[346.055944] [063/131] (718s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[346.275479] Starting subtest: y-tiled-addfb-size-offset-overflow
[346.277322] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[346.409156] [064/131] (717s left) perf (short-reads)
[346.605713] Starting subtest: short-reads
[346.626886] Subtest short-reads: SUCCESS (0.021s)
[346.682768] [065/131] (717s left) gem_partial_pwrite_pread (reads-snoop)
[346.772763] Subtest reads-snoop: SKIP (0.000s)
[346.855262] [066/131] (717s left) gem_softpin (evict-active-interruptible)
[346.943840] Starting subtest: evict-active-interruptible
[346.963738] Subtest evict-active-interruptible: SUCCESS (0.020s)
[347.156915] [067/131] (717s left) perf_pmu (event-wait)
[347.228889] Starting subtest: event-wait
[347.229812] Starting dynamic subtest: rcs0
[347.231631] Dynamic subtest rcs0: SKIP (0.000s)
[347.233330] Subtest event-wait: SKIP (0.001s)
[347.374372] [068/131] (717s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[347.584050] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[347.647651] [069/131] (717s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[347.869905] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[347.871765] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[348.004672] [070/131] (716s left) vgem_basic (setversion)
[348.073365] Starting subtest: setversion
[348.075357] Subtest setversion: SUCCESS (0.000s)
[348.178401] [071/131] (716s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[348.257721] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[348.363190] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[348.457366] [072/131] (716s left) gem_exec_flush (basic-wb-rw-before-default)
[348.543523] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[348.619825] [073/131] (716s left) gem_mmap_gtt (cpuset-big-copy)
[348.699754] Subtest cpuset-big-copy: SKIP (0.000s)
[348.766335] [074/131] (716s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[348.849237] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[348.850249] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[349.020093] [075/131] (716s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[349.238803] Starting subtest: yf-tiled-16bpp-rotate-270
[349.240538] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[349.379171] [076/131] (715s left) gem_eio (in-flight-10ms)
[349.670611] Starting subtest: in-flight-10ms
[354.862575] Subtest in-flight-10ms: SUCCESS (5.193s)
[355.088223] [077/131] (710s left) gem_render_copy (linear)
[355.175854] Starting subtest: linear
[355.176808] Starting dynamic subtest: smem
[355.274800] Dynamic subtest smem: SUCCESS (0.098s)
[355.285962] Starting dynamic subtest: lmem0
[355.561227] Dynamic subtest lmem0: SUCCESS (0.285s)
[355.562175] Subtest linear: SUCCESS (0.386s)
[355.875708] [078/131] (709s left) gem_exec_capture (capture)
[355.962961] Starting subtest: capture
[355.963910] Starting dynamic subtest: rcs0-smem
[356.940792] Dynamic subtest rcs0-smem: SUCCESS (0.977s)
[356.952503] Starting dynamic subtest: rcs0-lmem0
[358.379707] Dynamic subtest rcs0-lmem0: SUCCESS (1.439s)
[358.391180] Starting dynamic subtest: bcs0-smem
[359.307763] Dynamic subtest bcs0-smem: SUCCESS (0.927s)
[359.318980] Starting dynamic subtest: bcs0-lmem0
[360.232676] Dynamic subtest bcs0-lmem0: SUCCESS (0.925s)
[360.243894] Starting dynamic subtest: vcs0-smem
[361.146255] Dynamic subtest vcs0-smem: SUCCESS (0.913s)
[361.157661] Starting dynamic subtest: vcs0-lmem0
[362.563698] Dynamic subtest vcs0-lmem0: SUCCESS (1.416s)
[362.574903] Starting dynamic subtest: vcs1-smem
[363.584767] Dynamic subtest vcs1-smem: SUCCESS (1.020s)
[363.596150] Starting dynamic subtest: vcs1-lmem0
[364.500003] Dynamic subtest vcs1-lmem0: SUCCESS (0.914s)
[364.511181] Starting dynamic subtest: vecs0-smem
[365.658839] Dynamic subtest vecs0-smem: FAIL (1.139s)
[365.669598] Starting dynamic subtest: vecs0-lmem0
[366.958265] Dynamic subtest vecs0-lmem0: FAIL (1.294s)
[366.969106] Starting dynamic subtest: vecs1-smem
[368.379067] Dynamic subtest vecs1-smem: FAIL (1.421s)
[368.389882] Starting dynamic subtest: vecs1-lmem0
[369.393344] Dynamic subtest vecs1-lmem0: FAIL (1.013s)
[369.404335] Starting dynamic subtest: ccs0-smem
[370.809071] Dynamic subtest ccs0-smem: SUCCESS (1.431s)
[370.819972] Starting dynamic subtest: ccs0-lmem0
[372.239799] Dynamic subtest ccs0-lmem0: SUCCESS (1.435s)
[372.240714] Subtest capture: FAIL (16.277s)
[372.382433] [079/131] (692s left) kms_psr (fbc-psr-sprite-blt)
[372.597350] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[372.648234] [080/131] (692s left) kms_addfb_basic (clobberred-modifier)
[372.725766] Starting subtest: clobberred-modifier
[372.727573] Subtest clobberred-modifier: SKIP (0.000s)
[372.980087] [081/131] (692s left) gem_create (hog-create)
[373.065959] Starting subtest: hog-create
[373.066890] Starting dynamic subtest: lmem0
[405.349567] Dynamic subtest lmem0: SUCCESS (32.273s)
[405.361105] Starting dynamic subtest: smem0
[437.634749] Dynamic subtest smem0: SUCCESS (32.286s)
[437.635881] Subtest hog-create: SUCCESS (64.561s)
[437.930386] [082/131] (627s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[438.144631] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[438.146407] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[438.330925] [083/131] (627s left) perf_pmu (init-wait)
[438.401969] Starting subtest: init-wait
[438.402872] Starting dynamic subtest: rcs0
[438.405189] Dynamic subtest rcs0: SUCCESS (0.002s)
[438.416634] Starting dynamic subtest: bcs0
[438.417544] Dynamic subtest bcs0: SUCCESS (0.000s)
[438.428743] Starting dynamic subtest: vcs0
[438.429618] Dynamic subtest vcs0: SUCCESS (0.000s)
[438.440970] Starting dynamic subtest: vcs1
[438.442126] Dynamic subtest vcs1: SUCCESS (0.000s)
[438.453130] Starting dynamic subtest: vecs0
[438.454257] Dynamic subtest vecs0: SUCCESS (0.001s)
[438.465053] Starting dynamic subtest: vecs1
[438.465959] Dynamic subtest vecs1: SUCCESS (0.000s)
[438.477250] Starting dynamic subtest: ccs0
[438.478412] Dynamic subtest ccs0: SUCCESS (0.000s)
[438.479504] Subtest init-wait: SUCCESS (0.011s)
[438.546117] [084/131] (627s left) gem_eio (in-flight-1us)
[438.846775] Starting subtest: in-flight-1us
[443.928925] Subtest in-flight-1us: SUCCESS (5.083s)
[444.147160] [085/131] (621s left) gem_exec_schedule (submit-early-slice)
[444.245878] Starting subtest: submit-early-slice
[444.246857] Starting dynamic subtest: rcs0
[444.348370] Dynamic subtest rcs0: SUCCESS (0.102s)
[444.359764] Starting dynamic subtest: bcs0
[444.399778] Dynamic subtest bcs0: SUCCESS (0.050s)
[444.411037] Starting dynamic subtest: vcs0
[444.454401] Dynamic subtest vcs0: SUCCESS (0.054s)
[444.465838] Starting dynamic subtest: vcs1
[444.504042] Dynamic subtest vcs1: SUCCESS (0.049s)
[444.515424] Starting dynamic subtest: vecs0
[444.560123] Dynamic subtest vecs0: SUCCESS (0.055s)
[444.571864] Starting dynamic subtest: vecs1
[444.610064] Dynamic subtest vecs1: SUCCESS (0.049s)
[444.621525] Starting dynamic subtest: ccs0
[444.658078] Dynamic subtest ccs0: SUCCESS (0.047s)
[444.659105] Subtest submit-early-slice: SUCCESS (0.413s)
[445.190604] [086/131] (620s left) kms_invalid_mode (zero-hdisplay)
[445.403228] Starting subtest: zero-hdisplay
[445.404260] Starting dynamic subtest: pipe-A-DP-4
[445.474494] Dynamic subtest pipe-A-DP-4: SUCCESS (0.070s)
[445.485858] Starting dynamic subtest: pipe-B-DP-4
[445.486941] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[445.497948] Starting dynamic subtest: pipe-C-DP-4
[445.499096] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[445.510193] Starting dynamic subtest: pipe-D-DP-4
[445.511093] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[445.511975] Subtest zero-hdisplay: SUCCESS (0.079s)
[445.730721] [087/131] (620s left) api_intel_bb (render-ccs)
[445.805694] Starting subtest: render-ccs
[445.889954] Subtest render-ccs: SUCCESS (0.084s)
[446.087034] [088/131] (619s left) gem_tiled_pread_pwrite
[446.243944] [089/131] (619s left) syncobj_eventfd (invalid-bad-pad)
[446.321315] Starting subtest: invalid-bad-pad
[446.322314] Subtest invalid-bad-pad: SUCCESS (0.000s)
[446.469316] [090/131] (619s left) gem_ctx_shared (detached-shared-gtt)
[446.558754] Starting subtest: detached-shared-gtt
[448.708882] Subtest detached-shared-gtt: SUCCESS (2.150s)
[451.440999] [091/131] (614s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[451.658526] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[451.705948] [092/131] (614s left) perf (invalid-open-flags)
[451.893952] Starting subtest: invalid-open-flags
[451.894849] Subtest invalid-open-flags: SUCCESS (0.000s)
[451.943664] [093/131] (614s left) gem_spin_batch (legacy)
[452.032850] Starting subtest: legacy
[452.033793] Starting dynamic subtest: default
[455.288626] Dynamic subtest default: SUCCESS (3.252s)
[455.302462] Starting dynamic subtest: render
[458.530563] Dynamic subtest render: SUCCESS (3.237s)
[458.546323] Starting dynamic subtest: bsd
[461.774592] Dynamic subtest bsd: SUCCESS (3.238s)
[461.788236] Starting dynamic subtest: bsd1
[465.015681] Dynamic subtest bsd1: SUCCESS (3.236s)
[465.029622] Starting dynamic subtest: bsd2
[468.253768] Dynamic subtest bsd2: SUCCESS (3.233s)
[468.269833] Starting dynamic subtest: blt
[471.495097] Dynamic subtest blt: SUCCESS (3.236s)
[471.508409] Starting dynamic subtest: vebox
[474.731351] Dynamic subtest vebox: SUCCESS (3.231s)
[474.733513] Subtest legacy: SUCCESS (22.695s)
[474.989829] [094/131] (591s left) gem_pxp (reject-modify-context-protection-on)
[477.596614] Starting subtest: reject-modify-context-protection-on
[477.598654] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[477.689916] [095/131] (588s left) kms_flip_tiling (flip-change-tiling)
[477.896765] Starting subtest: flip-change-tiling
[477.897759] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-4-mc-ccs
[478.136093] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.238s)
[478.180078] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-4-rc-ccs-cc
[478.353031] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.212s)
[478.398932] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-4-rc-ccs
[478.569731] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.212s)
[478.615224] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-4
[478.786549] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-4: SUCCESS (0.212s)
[478.832721] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-x
[479.003052] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-x: SUCCESS (0.212s)
[479.049759] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs-to-linear
[479.219875] Dynamic subtest pipe-A-DP-4-4-mc-ccs-to-linear: SUCCESS (0.212s)
[479.266082] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-4-mc-ccs
[479.436609] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.212s)
[479.482556] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc
[479.620020] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.179s)
[479.667755] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-4-rc-ccs
[479.836677] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.212s)
[479.883414] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-4
[480.053494] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-4: SUCCESS (0.212s)
[480.100377] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-x
[480.269871] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-x: SUCCESS (0.212s)
[480.316760] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc-to-linear
[480.486664] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc-to-linear: SUCCESS (0.212s)
[480.507130] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-4-mc-ccs
[480.686877] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.195s)
[480.732504] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-4-rc-ccs-cc
[480.903629] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.212s)
[480.948762] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-4-rc-ccs
[481.086665] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.179s)
[481.129916] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-4
[481.303654] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-4: SUCCESS (0.212s)
[481.348824] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-x
[481.520155] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-x: SUCCESS (0.212s)
[481.564978] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-to-linear
[481.736807] Dynamic subtest pipe-A-DP-4-4-rc-ccs-to-linear: SUCCESS (0.212s)
[481.781904] Starting dynamic subtest: pipe-A-DP-4-4-to-4-mc-ccs
[481.953907] Dynamic subtest pipe-A-DP-4-4-to-4-mc-ccs: SUCCESS (0.212s)
[481.999622] Starting dynamic subtest: pipe-A-DP-4-4-to-4-rc-ccs-cc
[482.170654] Dynamic subtest pipe-A-DP-4-4-to-4-rc-ccs-cc: SUCCESS (0.212s)
[482.216567] Starting dynamic subtest: pipe-A-DP-4-4-to-4-rc-ccs
[482.387513] Dynamic subtest pipe-A-DP-4-4-to-4-rc-ccs: SUCCESS (0.212s)
[482.434855] Starting dynamic subtest: pipe-A-DP-4-4-to-4
[482.570341] Dynamic subtest pipe-A-DP-4-4-to-4: SUCCESS (0.179s)
[482.615411] Starting dynamic subtest: pipe-A-DP-4-4-to-x
[482.787068] Dynamic subtest pipe-A-DP-4-4-to-x: SUCCESS (0.212s)
[482.832272] Starting dynamic subtest: pipe-A-DP-4-4-to-linear
[483.003768] Dynamic subtest pipe-A-DP-4-4-to-linear: SUCCESS (0.212s)
[483.050994] Starting dynamic subtest: pipe-A-DP-4-x-to-4-mc-ccs
[483.220486] Dynamic subtest pipe-A-DP-4-x-to-4-mc-ccs: SUCCESS (0.212s)
[483.267335] Starting dynamic subtest: pipe-A-DP-4-x-to-4-rc-ccs-cc
[483.437303] Dynamic subtest pipe-A-DP-4-x-to-4-rc-ccs-cc: SUCCESS (0.212s)
[483.452293] Starting dynamic subtest: pipe-A-DP-4-x-to-4-rc-ccs
[483.620717] Dynamic subtest pipe-A-DP-4-x-to-4-rc-ccs: SUCCESS (0.179s)
[483.667509] Starting dynamic subtest: pipe-A-DP-4-x-to-4
[483.837414] Dynamic subtest pipe-A-DP-4-x-to-4: SUCCESS (0.212s)
[483.857595] Starting dynamic subtest: pipe-A-DP-4-x-to-x
[483.986989] Dynamic subtest pipe-A-DP-4-x-to-x: SUCCESS (0.145s)
[484.033105] Starting dynamic subtest: pipe-A-DP-4-x-to-linear
[484.204423] Dynamic subtest pipe-A-DP-4-x-to-linear: SUCCESS (0.213s)
[484.250370] Starting dynamic subtest: pipe-A-DP-4-linear-to-4-mc-ccs
[484.420788] Dynamic subtest pipe-A-DP-4-linear-to-4-mc-ccs: SUCCESS (0.212s)
[484.465221] Starting dynamic subtest: pipe-A-DP-4-linear-to-4-rc-ccs-cc
[484.637474] Dynamic subtest pipe-A-DP-4-linear-to-4-rc-ccs-cc: SUCCESS (0.212s)
[484.683921] Starting dynamic subtest: pipe-A-DP-4-linear-to-4-rc-ccs
[484.855083] Dynamic subtest pipe-A-DP-4-linear-to-4-rc-ccs: SUCCESS (0.212s)
[484.900566] Starting dynamic subtest: pipe-A-DP-4-linear-to-4
[485.070872] Dynamic subtest pipe-A-DP-4-linear-to-4: SUCCESS (0.212s)
[485.116599] Starting dynamic subtest: pipe-A-DP-4-linear-to-x
[485.288053] Dynamic subtest pipe-A-DP-4-linear-to-x: SUCCESS (0.212s)
[485.336415] Starting dynamic subtest: pipe-A-DP-4-linear-to-linear
[485.470886] Dynamic subtest pipe-A-DP-4-linear-to-linear: SUCCESS (0.179s)
[485.537288] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-4-mc-ccs
[485.867832] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.339s)
[485.908720] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-4-rc-ccs-cc
[486.039217] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.162s)
[486.072269] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-4-rc-ccs
[486.177142] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.147s)
[486.193993] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-4
[486.310913] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-4: SUCCESS (0.132s)
[486.351773] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-x
[486.477553] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-x: SUCCESS (0.164s)
[486.512480] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs-to-linear
[486.627431] Dynamic subtest pipe-B-DP-4-4-mc-ccs-to-linear: SUCCESS (0.148s)
[486.653442] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-4-mc-ccs
[486.777790] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.148s)
[486.818494] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc
[486.927433] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.147s)
[486.957943] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-4-rc-ccs
[487.077674] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.148s)
[487.119002] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-4
[487.227482] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-4: SUCCESS (0.148s)
[487.243944] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-x
[487.361157] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-x: SUCCESS (0.132s)
[487.397190] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc-to-linear
[487.510960] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc-to-linear: SUCCESS (0.148s)
[487.536715] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-4-mc-ccs
[487.661291] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.148s)
[487.696481] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-4-rc-ccs-cc
[487.811068] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s)
[487.841277] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-4-rc-ccs
[487.960948] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[487.990983] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-4
[488.112239] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-4: SUCCESS (0.150s)
[488.125861] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-x
[488.244731] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-x: SUCCESS (0.130s)
[488.262730] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-to-linear
[488.377892] Dynamic subtest pipe-B-DP-4-4-rc-ccs-to-linear: SUCCESS (0.131s)
[488.412736] Starting dynamic subtest: pipe-B-DP-4-4-to-4-mc-ccs
[488.527763] Dynamic subtest pipe-B-DP-4-4-to-4-mc-ccs: SUCCESS (0.148s)
[488.545641] Starting dynamic subtest: pipe-B-DP-4-4-to-4-rc-ccs-cc
[488.661301] Dynamic subtest pipe-B-DP-4-4-to-4-rc-ccs-cc: SUCCESS (0.131s)
[488.701895] Starting dynamic subtest: pipe-B-DP-4-4-to-4-rc-ccs
[488.829016] Dynamic subtest pipe-B-DP-4-4-to-4-rc-ccs: SUCCESS (0.165s)
[488.874594] Starting dynamic subtest: pipe-B-DP-4-4-to-4
[488.994840] Dynamic subtest pipe-B-DP-4-4-to-4: SUCCESS (0.162s)
[489.012862] Starting dynamic subtest: pipe-B-DP-4-4-to-x
[489.127533] Dynamic subtest pipe-B-DP-4-4-to-x: SUCCESS (0.131s)
[489.139818] Starting dynamic subtest: pipe-B-DP-4-4-to-linear
[489.261558] Dynamic subtest pipe-B-DP-4-4-to-linear: SUCCESS (0.133s)
[489.302261] Starting dynamic subtest: pipe-B-DP-4-x-to-4-mc-ccs
[489.411392] Dynamic subtest pipe-B-DP-4-x-to-4-mc-ccs: SUCCESS (0.148s)
[489.434586] Starting dynamic subtest: pipe-B-DP-4-x-to-4-rc-ccs-cc
[489.544725] Dynamic subtest pipe-B-DP-4-x-to-4-rc-ccs-cc: SUCCESS (0.132s)
[489.570120] Starting dynamic subtest: pipe-B-DP-4-x-to-4-rc-ccs
[489.694929] Dynamic subtest pipe-B-DP-4-x-to-4-rc-ccs: SUCCESS (0.148s)
[489.729541] Starting dynamic subtest: pipe-B-DP-4-x-to-4
[489.844698] Dynamic subtest pipe-B-DP-4-x-to-4: SUCCESS (0.148s)
[489.870251] Starting dynamic subtest: pipe-B-DP-4-x-to-x
[489.996036] Dynamic subtest pipe-B-DP-4-x-to-x: SUCCESS (0.149s)
[490.039282] Starting dynamic subtest: pipe-B-DP-4-x-to-linear
[490.161795] Dynamic subtest pipe-B-DP-4-x-to-linear: SUCCESS (0.162s)
[490.179858] Starting dynamic subtest: pipe-B-DP-4-linear-to-4-mc-ccs
[490.295179] Dynamic subtest pipe-B-DP-4-linear-to-4-mc-ccs: SUCCESS (0.131s)
[490.312973] Starting dynamic subtest: pipe-B-DP-4-linear-to-4-rc-ccs-cc
[490.428461] Dynamic subtest pipe-B-DP-4-linear-to-4-rc-ccs-cc: SUCCESS (0.131s)
[490.465942] Starting dynamic subtest: pipe-B-DP-4-linear-to-4-rc-ccs
[490.578296] Dynamic subtest pipe-B-DP-4-linear-to-4-rc-ccs: SUCCESS (0.148s)
[490.607170] Starting dynamic subtest: pipe-B-DP-4-linear-to-4
[490.728797] Dynamic subtest pipe-B-DP-4-linear-to-4: SUCCESS (0.148s)
[490.764050] Starting dynamic subtest: pipe-B-DP-4-linear-to-x
[490.878582] Dynamic subtest pipe-B-DP-4-linear-to-x: SUCCESS (0.148s)
[490.895496] Starting dynamic subtest: pipe-B-DP-4-linear-to-linear
[491.011918] Dynamic subtest pipe-B-DP-4-linear-to-linear: SUCCESS (0.132s)
[491.058647] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-4-mc-ccs
[491.374505] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.318s)
[491.412760] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-4-rc-ccs-cc
[491.549350] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.162s)
[491.578051] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-4-rc-ccs
[491.681554] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.147s)
[491.711663] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-4
[491.831829] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-4: SUCCESS (0.148s)
[491.850133] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-x
[491.964734] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-x: SUCCESS (0.131s)
[492.000228] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs-to-linear
[492.114779] Dynamic subtest pipe-C-DP-4-4-mc-ccs-to-linear: SUCCESS (0.148s)
[492.145279] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-4-mc-ccs
[492.264964] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.148s)
[492.300419] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc
[492.415402] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[492.429640] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-4-rc-ccs
[492.548620] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[492.594305] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-4
[492.715232] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-4: SUCCESS (0.164s)
[492.755218] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-x
[492.864885] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-x: SUCCESS (0.147s)
[492.890269] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc-to-linear
[493.015255] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc-to-linear: SUCCESS (0.148s)
[493.055742] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-4-mc-ccs
[493.182130] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.164s)
[493.221839] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-4-rc-ccs-cc
[493.331905] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.147s)
[493.349800] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-4-rc-ccs
[493.465071] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[493.500098] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-4
[493.615020] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-4: SUCCESS (0.148s)
[493.631866] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-x
[493.748642] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-x: SUCCESS (0.132s)
[493.784136] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-to-linear
[493.898518] Dynamic subtest pipe-C-DP-4-4-rc-ccs-to-linear: SUCCESS (0.148s)
[493.914555] Starting dynamic subtest: pipe-C-DP-4-4-to-4-mc-ccs
[494.032627] Dynamic subtest pipe-C-DP-4-4-to-4-mc-ccs: SUCCESS (0.132s)
[494.076878] Starting dynamic subtest: pipe-C-DP-4-4-to-4-rc-ccs-cc
[494.219143] Dynamic subtest pipe-C-DP-4-4-to-4-rc-ccs-cc: SUCCESS (0.163s)
[494.234309] Starting dynamic subtest: pipe-C-DP-4-4-to-4-rc-ccs
[494.348790] Dynamic subtest pipe-C-DP-4-4-to-4-rc-ccs: SUCCESS (0.148s)
[494.389790] Starting dynamic subtest: pipe-C-DP-4-4-to-4
[494.498748] Dynamic subtest pipe-C-DP-4-4-to-4: SUCCESS (0.148s)
[494.524291] Starting dynamic subtest: pipe-C-DP-4-4-to-x
[494.648824] Dynamic subtest pipe-C-DP-4-4-to-x: SUCCESS (0.148s)
[494.687024] Starting dynamic subtest: pipe-C-DP-4-4-to-linear
[494.798763] Dynamic subtest pipe-C-DP-4-4-to-linear: SUCCESS (0.148s)
[494.821114] Starting dynamic subtest: pipe-C-DP-4-x-to-4-mc-ccs
[494.932135] Dynamic subtest pipe-C-DP-4-x-to-4-mc-ccs: SUCCESS (0.132s)
[494.948877] Starting dynamic subtest: pipe-C-DP-4-x-to-4-rc-ccs-cc
[495.065847] Dynamic subtest pipe-C-DP-4-x-to-4-rc-ccs-cc: SUCCESS (0.132s)
[495.107975] Starting dynamic subtest: pipe-C-DP-4-x-to-4-rc-ccs
[495.232459] Dynamic subtest pipe-C-DP-4-x-to-4-rc-ccs: SUCCESS (0.164s)
[495.250147] Starting dynamic subtest: pipe-C-DP-4-x-to-4
[495.365661] Dynamic subtest pipe-C-DP-4-x-to-4: SUCCESS (0.131s)
[495.380577] Starting dynamic subtest: pipe-C-DP-4-x-to-x
[495.499382] Dynamic subtest pipe-C-DP-4-x-to-x: SUCCESS (0.131s)
[495.545748] Starting dynamic subtest: pipe-C-DP-4-x-to-linear
[495.665710] Dynamic subtest pipe-C-DP-4-x-to-linear: SUCCESS (0.164s)
[495.700343] Starting dynamic subtest: pipe-C-DP-4-linear-to-4-mc-ccs
[495.815765] Dynamic subtest pipe-C-DP-4-linear-to-4-mc-ccs: SUCCESS (0.148s)
[495.845407] Starting dynamic subtest: pipe-C-DP-4-linear-to-4-rc-ccs-cc
[495.965812] Dynamic subtest pipe-C-DP-4-linear-to-4-rc-ccs-cc: SUCCESS (0.148s)
[496.000560] Starting dynamic subtest: pipe-C-DP-4-linear-to-4-rc-ccs
[496.115774] Dynamic subtest pipe-C-DP-4-linear-to-4-rc-ccs: SUCCESS (0.148s)
[496.131941] Starting dynamic subtest: pipe-C-DP-4-linear-to-4
[496.249826] Dynamic subtest pipe-C-DP-4-linear-to-4: SUCCESS (0.132s)
[496.284098] Starting dynamic subtest: pipe-C-DP-4-linear-to-x
[496.399328] Dynamic subtest pipe-C-DP-4-linear-to-x: SUCCESS (0.148s)
[496.429015] Starting dynamic subtest: pipe-C-DP-4-linear-to-linear
[496.549326] Dynamic subtest pipe-C-DP-4-linear-to-linear: SUCCESS (0.148s)
[496.594638] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-4-mc-ccs
[496.913488] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.319s)
[496.952266] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-4-rc-ccs-cc
[497.094552] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.162s)
[497.117891] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-4-rc-ccs
[497.219433] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[497.237387] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-4
[497.352828] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-4: SUCCESS (0.131s)
[497.387391] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-x
[497.502824] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-x: SUCCESS (0.148s)
[497.532542] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs-to-linear
[497.653011] Dynamic subtest pipe-D-DP-4-4-mc-ccs-to-linear: SUCCESS (0.148s)
[497.671799] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-4-mc-ccs
[497.787160] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[497.833367] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc
[497.961302] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.162s)
[497.996099] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-4-rc-ccs
[498.102915] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.147s)
[498.119347] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-4
[498.237175] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-4: SUCCESS (0.132s)
[498.282956] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-x
[498.402959] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-x: SUCCESS (0.162s)
[498.433092] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc-to-linear
[498.553151] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc-to-linear: SUCCESS (0.148s)
[498.587778] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-4-mc-ccs
[498.703071] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.148s)
[498.733046] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-4-rc-ccs-cc
[498.854023] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s)
[498.898945] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-4-rc-ccs
[499.019786] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.162s)
[499.054917] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-4
[499.169900] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-4: SUCCESS (0.148s)
[499.196994] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-x
[499.319972] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-x: SUCCESS (0.148s)
[499.337190] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-to-linear
[499.453408] Dynamic subtest pipe-D-DP-4-4-rc-ccs-to-linear: SUCCESS (0.131s)
[499.470336] Starting dynamic subtest: pipe-D-DP-4-4-to-4-mc-ccs
[499.586675] Dynamic subtest pipe-D-DP-4-4-to-4-mc-ccs: SUCCESS (0.131s)
[499.624109] Starting dynamic subtest: pipe-D-DP-4-4-to-4-rc-ccs-cc
[499.736751] Dynamic subtest pipe-D-DP-4-4-to-4-rc-ccs-cc: SUCCESS (0.148s)
[499.766996] Starting dynamic subtest: pipe-D-DP-4-4-to-4-rc-ccs
[499.886754] Dynamic subtest pipe-D-DP-4-4-to-4-rc-ccs: SUCCESS (0.148s)
[499.920279] Starting dynamic subtest: pipe-D-DP-4-4-to-4
[500.036752] Dynamic subtest pipe-D-DP-4-4-to-4: SUCCESS (0.148s)
[500.066958] Starting dynamic subtest: pipe-D-DP-4-4-to-x
[500.186801] Dynamic subtest pipe-D-DP-4-4-to-x: SUCCESS (0.148s)
[500.216980] Starting dynamic subtest: pipe-D-DP-4-4-to-linear
[500.336881] Dynamic subtest pipe-D-DP-4-4-to-linear: SUCCESS (0.148s)
[500.366976] Starting dynamic subtest: pipe-D-DP-4-x-to-4-mc-ccs
[500.486969] Dynamic subtest pipe-D-DP-4-x-to-4-mc-ccs: SUCCESS (0.148s)
[500.521746] Starting dynamic subtest: pipe-D-DP-4-x-to-4-rc-ccs-cc
[500.637021] Dynamic subtest pipe-D-DP-4-x-to-4-rc-ccs-cc: SUCCESS (0.148s)
[500.667333] Starting dynamic subtest: pipe-D-DP-4-x-to-4-rc-ccs
[500.786931] Dynamic subtest pipe-D-DP-4-x-to-4-rc-ccs: SUCCESS (0.148s)
[500.817572] Starting dynamic subtest: pipe-D-DP-4-x-to-4
[500.937204] Dynamic subtest pipe-D-DP-4-x-to-4: SUCCESS (0.148s)
[500.972099] Starting dynamic subtest: pipe-D-DP-4-x-to-x
[501.087006] Dynamic subtest pipe-D-DP-4-x-to-x: SUCCESS (0.148s)
[501.117737] Starting dynamic subtest: pipe-D-DP-4-x-to-linear
[501.237136] Dynamic subtest pipe-D-DP-4-x-to-linear: SUCCESS (0.148s)
[501.272945] Starting dynamic subtest: pipe-D-DP-4-linear-to-4-mc-ccs
[501.387121] Dynamic subtest pipe-D-DP-4-linear-to-4-mc-ccs: SUCCESS (0.148s)
[501.404796] Starting dynamic subtest: pipe-D-DP-4-linear-to-4-rc-ccs-cc
[501.520715] Dynamic subtest pipe-D-DP-4-linear-to-4-rc-ccs-cc: SUCCESS (0.131s)
[501.562178] Starting dynamic subtest: pipe-D-DP-4-linear-to-4-rc-ccs
[501.670406] Dynamic subtest pipe-D-DP-4-linear-to-4-rc-ccs: SUCCESS (0.147s)
[501.692957] Starting dynamic subtest: pipe-D-DP-4-linear-to-4
[501.803996] Dynamic subtest pipe-D-DP-4-linear-to-4: SUCCESS (0.132s)
[501.833943] Starting dynamic subtest: pipe-D-DP-4-linear-to-x
[501.954848] Dynamic subtest pipe-D-DP-4-linear-to-x: SUCCESS (0.148s)
[501.987579] Starting dynamic subtest: pipe-D-DP-4-linear-to-linear
[502.104101] Dynamic subtest pipe-D-DP-4-linear-to-linear: SUCCESS (0.148s)
[502.136937] Subtest flip-change-tiling: SUCCESS (24.236s)
[502.448432] [096/131] (564s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[502.659807] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[502.660791] Starting dynamic subtest: pipe-A-valid-mode
[502.730768] Dynamic subtest pipe-A-valid-mode: SKIP (0.070s)
[502.732541] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.071s)
[502.933799] [097/131] (563s left) kms_sequence (get-busy)
[503.156823] Starting subtest: get-busy
[503.157754] Starting dynamic subtest: pipe-A-DP-4
[505.730495] Dynamic subtest pipe-A-DP-4: SUCCESS (2.575s)
[505.745908] Starting dynamic subtest: pipe-B-DP-4
[508.239852] Dynamic subtest pipe-B-DP-4: SUCCESS (2.508s)
[508.252952] Starting dynamic subtest: pipe-C-DP-4
[510.713907] Dynamic subtest pipe-C-DP-4: SUCCESS (2.472s)
[510.726912] Starting dynamic subtest: pipe-D-DP-4
[513.193773] Dynamic subtest pipe-D-DP-4: SUCCESS (2.477s)
[513.194788] Subtest get-busy: SUCCESS (10.039s)
[513.475054] [098/131] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[513.687277] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[516.013682] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.326s)
[516.179451] [099/131] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[516.397276] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[516.398995] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[516.526273] [100/131] (550s left) kms_chamelium_frames (hdmi-aspect-ratio)
[516.846730] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[517.009040] [101/131] (549s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[517.227181] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[517.279999] [102/131] (549s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[517.499384] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[518.555834] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.056s)
[518.782027] [103/131] (548s left) kms_draw_crc (draw-method-render)
[518.991294] Starting subtest: draw-method-render
[518.992292] Starting dynamic subtest: xrgb8888-untiled
[519.340660] Dynamic subtest xrgb8888-untiled: SUCCESS (0.348s)
[519.385627] Starting dynamic subtest: rgb565-untiled
[519.690847] Dynamic subtest rgb565-untiled: SUCCESS (0.345s)
[519.735729] Starting dynamic subtest: xrgb2101010-untiled
[520.022548] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.328s)
[520.036544] Starting dynamic subtest: xbgr16161616f-untiled
[520.340643] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.316s)
[520.380826] Starting dynamic subtest: xrgb8888-xtiled
[520.524480] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.179s)
[520.568946] Starting dynamic subtest: rgb565-xtiled
[520.707890] Dynamic subtest rgb565-xtiled: SUCCESS (0.179s)
[520.723525] Starting dynamic subtest: xrgb2101010-xtiled
[520.840962] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.128s)
[520.886149] Starting dynamic subtest: xbgr16161616f-xtiled
[521.022734] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.178s)
[521.036477] Starting dynamic subtest: xrgb8888-4tiled
[521.174289] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.150s)
[521.219078] Starting dynamic subtest: rgb565-4tiled
[521.357726] Dynamic subtest rgb565-4tiled: SUCCESS (0.179s)
[521.400662] Starting dynamic subtest: xrgb2101010-4tiled
[521.524458] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.162s)
[521.569423] Starting dynamic subtest: xbgr16161616f-4tiled
[521.707849] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.179s)
[521.714324] Subtest draw-method-render: SUCCESS (2.717s)
[521.886562] [104/131] (545s left) gem_ctx_bad_destroy (invalid-pad)
[521.966049] Starting subtest: invalid-pad
[521.967077] Subtest invalid-pad: SUCCESS (0.000s)
[522.078830] [105/131] (544s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[522.296450] Starting subtest: fbc-rgb565-draw-mmap-gtt
[522.298282] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[522.453285] [106/131] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[522.666534] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[522.668348] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[522.815765] [107/131] (544s left) kms_big_fb (x-tiled-addfb)
[523.034478] Starting subtest: x-tiled-addfb
[523.035454] Subtest x-tiled-addfb: SUCCESS (0.000s)
[523.181572] [108/131] (544s left) gem_ctx_persistence (engines-queued)
[523.266232] Starting subtest: engines-queued
[523.267199] Starting dynamic subtest: rcs0
[523.364759] Dynamic subtest rcs0: SUCCESS (0.098s)
[523.386576] Starting dynamic subtest: bcs0
[523.388866] Dynamic subtest bcs0: SUCCESS (0.022s)
[523.400552] Starting dynamic subtest: vcs0
[523.456566] Dynamic subtest vcs0: SUCCESS (0.068s)
[523.473309] Starting dynamic subtest: vcs1
[523.517629] Dynamic subtest vcs1: SUCCESS (0.059s)
[523.557865] Starting dynamic subtest: vecs0
[523.564732] Dynamic subtest vecs0: SUCCESS (0.045s)
[523.579941] Starting dynamic subtest: vecs1
[523.619629] Dynamic subtest vecs1: SUCCESS (0.054s)
[523.632965] Starting dynamic subtest: ccs0
[523.791550] Dynamic subtest ccs0: SUCCESS (0.171s)
[523.792571] Subtest engines-queued: SUCCESS (0.526s)
[523.980206] [109/131] (543s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[524.190442] Starting subtest: sprite-rotation-90-pos-100-0
[524.192540] Subtest sprite-rotation-90-pos-100-0: SKIP (0.002s)
[524.286682] [110/131] (543s left) sysfs_heartbeat_interval (invalid)
[524.371784] Starting subtest: invalid
[524.374086] Starting dynamic subtest: vecs0
[524.375009] Dynamic subtest vecs0: SUCCESS (0.000s)
[524.386866] Starting dynamic subtest: ccs0
[524.387970] Dynamic subtest ccs0: SUCCESS (0.000s)
[524.399371] Starting dynamic subtest: vcs0
[524.400370] Dynamic subtest vcs0: SUCCESS (0.000s)
[524.411531] Starting dynamic subtest: bcs0
[524.412730] Dynamic subtest bcs0: SUCCESS (0.000s)
[524.423787] Starting dynamic subtest: vecs1
[524.424877] Dynamic subtest vecs1: SUCCESS (0.000s)
[524.436199] Starting dynamic subtest: rcs0
[524.437370] Dynamic subtest rcs0: SUCCESS (0.000s)
[524.449245] Starting dynamic subtest: vcs1
[524.450381] Dynamic subtest vcs1: SUCCESS (0.000s)
[524.451374] Subtest invalid: SUCCESS (0.009s)
[524.494062] [111/131] (542s left) debugfs_test (read_all_entries)
[524.579839] Starting subtest: read_all_entries
[525.228159] Subtest read_all_entries: SUCCESS (0.648s)
[525.456159] [112/131] (542s left) kms_busy (extended-pageflip-hang-newfb)
[525.674753] Starting subtest: extended-pageflip-hang-newfb
[525.675706] Starting dynamic subtest: pipe-A
[533.538928] Dynamic subtest pipe-A: SUCCESS (7.860s)
[533.556596] Starting dynamic subtest: pipe-D
[541.437647] Dynamic subtest pipe-D: SUCCESS (7.892s)
[541.438562] Subtest extended-pageflip-hang-newfb: SUCCESS (15.760s)
[541.714848] [113/131] (525s left) vgem_basic (second-client)
[541.776728] Starting subtest: second-client
[541.808744] Subtest second-client: SUCCESS (0.033s)
[541.936801] [114/131] (525s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[542.148796] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[542.149832] Starting dynamic subtest: pipe-A-valid-mode
[546.425982] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.273s)
[546.427790] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (4.277s)
[546.722841] [115/131] (521s left) syncobj_timeline (wait-delayed-signal)
[546.804394] Starting subtest: wait-delayed-signal
[546.907560] Subtest wait-delayed-signal: SUCCESS (0.103s)
[547.016312] [116/131] (520s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[547.227069] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[547.227855] Starting dynamic subtest: pipe-A
[547.323736] Dynamic subtest pipe-A: SUCCESS (0.097s)
[547.339225] Starting dynamic subtest: pipe-B
[547.542755] Dynamic subtest pipe-B: SUCCESS (0.218s)
[547.555981] Starting dynamic subtest: pipe-C
[547.745033] Dynamic subtest pipe-C: SUCCESS (0.201s)
[547.768418] Starting dynamic subtest: pipe-D
[547.965174] Dynamic subtest pipe-D: SUCCESS (0.219s)
[547.966227] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.740s)
[548.291534] [117/131] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[548.503490] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[548.505230] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[548.646922] [118/131] (519s left) kms_panel_fitting (legacy)
[548.858026] Starting subtest: legacy
[548.859746] Subtest legacy: SKIP (0.000s)
[548.949133] [119/131] (519s left) kms_pm_rpm (modeset-lpsp)
[551.396337] Starting subtest: modeset-lpsp
[551.773164] Subtest modeset-lpsp: SKIP (0.375s)
[552.121104] [120/131] (515s left) kms_cursor_crc (cursor-offscreen-64x21)
[552.448533] Starting subtest: cursor-offscreen-64x21
[552.453708] Starting dynamic subtest: pipe-A-DP-4
[554.964238] Dynamic subtest pipe-A-DP-4: SUCCESS (2.511s)
[555.016934] Starting dynamic subtest: pipe-D-DP-4
[557.465863] Dynamic subtest pipe-D-DP-4: SUCCESS (2.460s)
[557.466812] Subtest cursor-offscreen-64x21: SUCCESS (5.018s)
[557.889676] [121/131] (510s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[558.104397] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[558.106170] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[558.241242] [122/131] (510s left) kms_psr (psr2-cursor-render)
[558.454266] Subtest psr2-cursor-render: SKIP (0.000s)
[558.513416] [123/131] (509s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[558.727312] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[558.845093] [124/131] (509s left) kms_chamelium_frames (dp-crc-fast)
[559.149195] Subtest dp-crc-fast: SKIP (0.000s)
[559.337744] [125/131] (509s left) kms_setmode (invalid-clone-single-crtc-stealing)
[559.417682] Starting subtest: invalid-clone-single-crtc-stealing
[559.420393] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[559.596419] [126/131] (508s left) kms_async_flips (alternate-sync-async-flip)
[559.811530] Starting subtest: alternate-sync-async-flip
[560.023158] Starting dynamic subtest: pipe-A-DP-4
[562.310154] Dynamic subtest pipe-A-DP-4: SUCCESS (2.287s)
[562.552066] Starting dynamic subtest: pipe-B-DP-4
[564.656364] Dynamic subtest pipe-B-DP-4: SUCCESS (2.116s)
[564.869085] Starting dynamic subtest: pipe-C-DP-4
[566.981863] Dynamic subtest pipe-C-DP-4: SUCCESS (2.124s)
[567.206941] Starting dynamic subtest: pipe-D-DP-4
[569.331124] Dynamic subtest pipe-D-DP-4: SUCCESS (2.135s)
[569.337285] Subtest alternate-sync-async-flip: SUCCESS (9.524s)
[569.847519] [127/131] (498s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[570.053941] Starting subtest: random-ccs-data-y-tiled-ccs
[570.054853] Starting dynamic subtest: pipe-A-DP-4
[570.064280] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[570.075883] Starting dynamic subtest: pipe-B-DP-4
[570.085382] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[570.096727] Starting dynamic subtest: pipe-C-DP-4
[570.106038] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[570.117349] Starting dynamic subtest: pipe-D-DP-4
[570.128322] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[570.130402] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.007s)
[570.517004] [128/131] (498s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[570.734712] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[570.736512] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[570.881146] [129/131] (497s left) kms_content_protection (srm)
[571.141977] Starting subtest: srm
[571.175713] Starting dynamic subtest: pipe-A-DP-4
[695.692296] Dynamic subtest pipe-A-DP-4: FAIL (124.344s)
[695.693087] Subtest srm: FAIL (124.475s)
[695.879707] [130/131] (372s left) kms_plane_multiple (tiling-y)
[696.090654] Starting subtest: tiling-y
[696.092479] Subtest tiling-y: SKIP (0.000s)
[696.185695] [131/131] (372s left) syncobj_timeline (reset-signaled)
[696.280697] Starting subtest: reset-signaled
[696.281713] Subtest reset-signaled: SUCCESS (0.000s)
[696.464742] Closing watchdogs
results: parsing output: 0/ for test: kms_concurrent
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: api_intel_allocator
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_pm_backlight
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: gem_close
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: gem_exec_whisper
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: kms_vblank
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gem_workarounds
results: parsing output: 21/ for test: kms_prime
results: parsing output: 22/ for test: fbdev
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_basic
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_gpgpu_fill
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: dmabuf_sync_file
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_basic
results: parsing output: 36/ for test: gem_close_race
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: i915_pm_rpm
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: core_auth
results: parsing output: 46/ for test: gem_mmap_offset
results: parsing output: 47/ for test: kms_pipe_b_c_ivb
results: parsing output: 48/ for test: prime_mmap
results: parsing output: 49/ for test: kms_vrr
results: parsing output: 50/ for test: kms_atomic
results: parsing output: 51/ for test: kms_hdr
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_ctx_shared
results: parsing output: 55/ for test: kms_plane_alpha_blend
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: gem_fenced_exec_thrash
results: parsing output: 61/ for test: kms_lease
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: gem_partial_pwrite_pread
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: vgem_basic
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: gem_exec_capture
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: gem_create
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_invalid_mode
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: gem_tiled_pread_pwrite
results: parsing output: 88/ for test: syncobj_eventfd
results: parsing output: 89/ for test: gem_ctx_shared
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: gem_pxp
results: parsing output: 94/ for test: kms_flip_tiling
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: kms_sequence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_chamelium_frames
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_draw_crc
results: parsing output: 103/ for test: gem_ctx_bad_destroy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: sysfs_heartbeat_interval
results: parsing output: 110/ for test: debugfs_test
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: vgem_basic
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_panel_fitting
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_chamelium_frames
results: parsing output: 124/ for test: kms_setmode
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: kms_plane_multiple
results: parsing output: 130/ for test: syncobj_timeline
Done.