[65.603564] Initializing watchdogs
[65.603628]   /dev/watchdog0
[65.623848] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.635241] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.639108] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.641572] [001/132] (960s left) gem_media_vme
[65.774652] [002/132] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[65.960631] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[66.009384] [003/132] (960s left) kms_psr (fbc-psr-sprite-blt)
[66.188350] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[66.243712] [004/132] (960s left) kms_fb_coherency (memset-crc)
[66.420988] Starting subtest: memset-crc
[66.421896] Starting dynamic subtest: mmap-offset-fixed
[66.901424] Dynamic subtest mmap-offset-fixed: CRASH (0.293s)
[67.161038] Subtest memset-crc: CRASH (0.475s)
[67.578113] [005/132] (958s left) perf_pmu (interrupts)
[67.683159] Starting subtest: interrupts
[68.961231] Subtest interrupts: SUCCESS (1.279s)
[69.130091] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[69.132689] [006/132] (957s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[69.321424] Starting subtest: crc-primary-suspend-y-tiled-ccs
[69.322320] Starting dynamic subtest: pipe-A-DP-3
[69.325824] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[69.334502] Starting dynamic subtest: pipe-B-DP-3
[69.338057] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[69.346487] Starting dynamic subtest: pipe-C-DP-3
[69.350037] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[69.359236] Starting dynamic subtest: pipe-D-DP-3
[69.362688] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[69.364378] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[69.830813] [007/132] (956s left) gem_exec_params (invalid-bsd-ring)
[69.917806] Starting subtest: invalid-bsd-ring
[69.918724] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[70.079589] [008/132] (956s left) gem_exec_whisper (basic-sync)
[70.172203] Starting subtest: basic-sync
[76.392602] Subtest basic-sync: SUCCESS (6.219s)
[76.637955] [009/132] (949s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[76.826737] Starting subtest: async-flip-with-page-flip-events-tiled
[77.056740] Starting dynamic subtest: pipe-A-DP-3-4
[79.326347] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.269s)
[79.343573] Starting dynamic subtest: pipe-A-DP-3-x
[81.523811] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.197s)
[81.771012] Starting dynamic subtest: pipe-B-DP-3-4
[84.000146] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.240s)
[84.009612] Starting dynamic subtest: pipe-B-DP-3-x
[86.164342] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.164s)
[86.353176] Starting dynamic subtest: pipe-C-DP-3-4
[88.585043] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.242s)
[88.594839] Starting dynamic subtest: pipe-C-DP-3-x
[90.749611] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.165s)
[90.933924] Starting dynamic subtest: pipe-D-DP-3-4
[93.162864] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.240s)
[93.172538] Starting dynamic subtest: pipe-D-DP-3-x
[95.327824] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.165s)
[95.328741] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (18.503s)
[95.856012] [010/132] (930s left) gem_madvise (dontneed-before-pwrite)
[95.904465] Starting subtest: dontneed-before-pwrite
[95.935910] Subtest dontneed-before-pwrite: SKIP (0.030s)
[96.015218] [011/132] (930s left) kms_color (ctm-0-50)
[96.199732] Starting subtest: ctm-0-50
[96.200604] Starting dynamic subtest: pipe-A-DP-3
[97.987624] Dynamic subtest pipe-A-DP-3: SUCCESS (1.788s)
[98.002765] Starting dynamic subtest: pipe-B-DP-3
[99.657476] Dynamic subtest pipe-B-DP-3: SUCCESS (1.670s)
[99.667999] Starting dynamic subtest: pipe-C-DP-3
[101.291281] Dynamic subtest pipe-C-DP-3: SUCCESS (1.633s)
[101.302368] Starting dynamic subtest: pipe-D-DP-3
[102.940335] Dynamic subtest pipe-D-DP-3: SUCCESS (1.649s)
[102.941219] Subtest ctm-0-50: SUCCESS (6.741s)
[103.278291] [012/132] (923s left) kms_vblank (query-busy)
[103.465893] Starting subtest: query-busy
[103.466829] Starting dynamic subtest: pipe-A-DP-3
[105.996161] Dynamic subtest pipe-A-DP-3: SUCCESS (2.528s)
[106.022965] Starting dynamic subtest: pipe-D-DP-3
[108.461379] Dynamic subtest pipe-D-DP-3: SUCCESS (2.457s)
[108.462395] Subtest query-busy: SUCCESS (4.995s)
[108.722014] [013/132] (918s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[108.913660] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[108.915285] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[109.097537] [014/132] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[109.289897] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[109.291538] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[109.497064] [015/132] (917s left) gem_exec_fence (submit3)
[109.712510] Starting subtest: submit3
[109.714637] Subtest submit3: SKIP (0.000s)
[110.481197] [016/132] (916s left) gem_ccs (block-copy-compressed)
[110.576999] Starting subtest: block-copy-compressed
[110.577952] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[110.623980] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.046s)
[110.633093] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[110.716180] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.092s)
[110.725038] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[110.734749] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[110.743813] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[110.836137] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.101s)
[110.845219] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[110.853296] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[110.862324] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[110.950837] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.097s)
[110.960130] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[110.968258] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[110.977480] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[111.068865] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.100s)
[111.069795] Subtest block-copy-compressed: SUCCESS (0.492s)
[111.293439] [017/132] (915s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[111.378578] Starting subtest: y-tiled-ccs-to-y-tiled
[111.380622] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[111.663353] [018/132] (915s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[111.868693] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[112.616373] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.748s)
[112.847778] [019/132] (914s left) gem_ctx_engines (execute-oneforall)
[112.941774] Starting subtest: execute-oneforall
[113.697865] Subtest execute-oneforall: SUCCESS (0.755s)
[114.382839] [020/132] (912s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[114.569136] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[114.570065] Starting dynamic subtest: pipe-A-valid-mode
[114.669438] Dynamic subtest pipe-A-valid-mode: SKIP (0.098s)
[114.671631] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.100s)
[114.931430] [021/132] (912s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[115.131626] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[116.248196] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.116s)
[116.516695] [022/132] (911s left) kms_vrr (flip-suspend)
[116.710037] Starting subtest: flip-suspend
[116.712716] Subtest flip-suspend: SKIP (0.000s)
[116.870380] [023/132] (910s left) perf_pmu (pmu-read)
[116.940543] Starting subtest: pmu-read
[116.944947] Subtest pmu-read: SUCCESS (0.004s)
[117.127475] [024/132] (910s left) kms_prop_blob (blob-prop-validate)
[117.211171] Starting subtest: blob-prop-validate
[117.212228] Subtest blob-prop-validate: SUCCESS (0.000s)
[117.376153] [025/132] (910s left) kms_pm_rpm (fences-dpms)
[119.081006] Starting subtest: fences-dpms
[119.083234] Subtest fences-dpms: SKIP (0.000s)
[119.525095] [026/132] (908s left) kms_psr (fbc-pr-sprite-plane-onoff)
[119.718990] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[119.774091] [027/132] (908s left) sysfs_preempt_timeout (timeout)
[119.866552] Starting subtest: timeout
[119.867574] Starting dynamic subtest: vecs0
[121.788149] Dynamic subtest vecs0: SUCCESS (1.920s)
[121.797925] Starting dynamic subtest: ccs0
[123.627180] Dynamic subtest ccs0: SUCCESS (1.838s)
[123.636532] Starting dynamic subtest: vcs0
[125.348362] Dynamic subtest vcs0: SUCCESS (1.721s)
[125.359133] Starting dynamic subtest: bcs0
[127.051229] Dynamic subtest bcs0: SUCCESS (1.702s)
[127.062381] Starting dynamic subtest: vecs1
[128.759247] Dynamic subtest vecs1: SUCCESS (1.708s)
[128.769485] Starting dynamic subtest: rcs0
[130.429975] Dynamic subtest rcs0: SUCCESS (1.670s)
[130.439654] Starting dynamic subtest: vcs1
[132.124174] Dynamic subtest vcs1: SUCCESS (1.694s)
[132.125209] Subtest timeout: SUCCESS (12.258s)
[132.297687] [028/132] (895s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[132.485197] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[133.572570] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.087s)
[133.888786] [029/132] (894s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[134.077366] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[134.078279] Starting dynamic subtest: pipe-A-DP-3
[134.094120] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[134.103518] Starting dynamic subtest: pipe-B-DP-3
[134.112054] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[134.121268] Starting dynamic subtest: pipe-C-DP-3
[134.129469] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[134.138618] Starting dynamic subtest: pipe-D-DP-3
[134.149036] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[134.151163] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[134.567630] [030/132] (893s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[137.175229] Starting subtest: verify-pxp-key-change-after-suspend-resume
[137.177621] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[137.313739] [031/132] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[137.504602] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[137.506288] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[137.700519] [032/132] (890s left) perf_pmu (busy)
[137.770479] Starting subtest: busy
[137.771420] Starting dynamic subtest: rcs0
[138.418037] Dynamic subtest rcs0: SUCCESS (0.646s)
[138.432033] Starting dynamic subtest: bcs0
[138.979523] Dynamic subtest bcs0: SUCCESS (0.560s)
[138.993771] Starting dynamic subtest: vcs0
[139.541525] Dynamic subtest vcs0: SUCCESS (0.560s)
[139.553705] Starting dynamic subtest: vcs1
[140.104538] Dynamic subtest vcs1: SUCCESS (0.561s)
[140.116769] Starting dynamic subtest: vecs0
[140.666679] Dynamic subtest vecs0: SUCCESS (0.560s)
[140.680993] Starting dynamic subtest: vecs1
[141.235677] Dynamic subtest vecs1: SUCCESS (0.567s)
[141.249976] Starting dynamic subtest: ccs0
[141.799599] Dynamic subtest ccs0: SUCCESS (0.562s)
[141.801448] Subtest busy: SUCCESS (4.030s)
[141.982309] [033/132] (886s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[142.293974] Starting subtest: cursor-rapid-movement-32x10
[142.344486] Subtest cursor-rapid-movement-32x10: SKIP (0.050s)
[142.802036] [034/132] (885s left) kms_flip (2x-flip-vs-rmfb)
[142.992081] Starting subtest: 2x-flip-vs-rmfb
[143.007169] Subtest 2x-flip-vs-rmfb: SKIP (0.015s)
[143.173051] [035/132] (885s left) kms_frontbuffer_tracking (fbc-tiling-4)
[143.369672] Starting subtest: fbc-tiling-4
[146.069600] Subtest fbc-tiling-4: SUCCESS (2.700s)
[146.284787] [036/132] (882s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[146.476112] Starting subtest: extended-pageflip-modeset-hang-oldfb
[146.477052] Starting dynamic subtest: pipe-A
[154.296847] Dynamic subtest pipe-A: SUCCESS (7.818s)
[154.308190] Starting dynamic subtest: pipe-D
[162.123287] Dynamic subtest pipe-D: SUCCESS (7.823s)
[162.124178] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.647s)
[162.437716] [037/132] (866s left) gem_linear_blits (basic)
[162.842423] Starting subtest: basic
[162.881160] Subtest basic: SUCCESS (0.039s)
[163.116296] [038/132] (865s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[163.355036] Starting subtest: 2x-long-cursor-vs-flip-legacy
[163.356943] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[163.526754] [039/132] (865s left) kms_addfb_basic (no-handle)
[163.605185] Starting subtest: no-handle
[163.606132] Subtest no-handle: SUCCESS (0.000s)
[163.908050] [040/132] (864s left) gem_exec_schedule (preempt-queue-contexts-chain)
[164.012487] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[164.424673] [041/132] (864s left) gem_wait (write-wait)
[164.519398] Starting subtest: write-wait
[164.520195] Starting dynamic subtest: all-engines
[165.644615] Dynamic subtest all-engines: SUCCESS (1.125s)
[165.657666] Starting dynamic subtest: rcs0
[166.705588] Dynamic subtest rcs0: SUCCESS (1.060s)
[166.719341] Starting dynamic subtest: bcs0
[167.764191] Dynamic subtest bcs0: SUCCESS (1.058s)
[167.783944] Starting dynamic subtest: vcs0
[168.825551] Dynamic subtest vcs0: SUCCESS (1.060s)
[168.839802] Starting dynamic subtest: vcs1
[169.885432] Dynamic subtest vcs1: SUCCESS (1.057s)
[169.900007] Starting dynamic subtest: vecs0
[170.942541] Dynamic subtest vecs0: SUCCESS (1.055s)
[170.957206] Starting dynamic subtest: vecs1
[172.002447] Dynamic subtest vecs1: SUCCESS (1.057s)
[172.016465] Starting dynamic subtest: ccs0
[173.060467] Dynamic subtest ccs0: SUCCESS (1.056s)
[173.061977] Subtest write-wait: SUCCESS (8.541s)
[173.402475] [042/132] (855s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[173.593028] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[173.593924] Starting dynamic subtest: pipe-A-DP-3
[173.602274] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[173.612319] Starting dynamic subtest: pipe-B-DP-3
[173.620843] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[173.630567] Starting dynamic subtest: pipe-C-DP-3
[173.646219] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[173.656024] Starting dynamic subtest: pipe-D-DP-3
[173.665933] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[173.667977] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[174.121765] [043/132] (854s left) kms_addfb_basic (size-max)
[174.311097] Starting subtest: size-max
[174.312008] Subtest size-max: SUCCESS (0.000s)
[174.523317] [044/132] (854s left) gem_workarounds (reset)
[174.622131] Starting subtest: reset
[174.834167] Subtest reset: SUCCESS (0.212s)
[175.053829] [045/132] (854s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[175.134250] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[175.239238] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[175.387554] [046/132] (853s left) kms_rotation_crc (bad-pixel-format)
[175.577296] Starting subtest: bad-pixel-format
[175.579150] Subtest bad-pixel-format: SKIP (0.001s)
[175.736778] [047/132] (853s left) gem_exec_reloc (basic-active)
[175.829565] Subtest basic-active: SKIP (0.000s)
[175.916836] [048/132] (853s left) gem_tiled_blits (basic)
[176.002447] Subtest basic: SKIP (0.000s)
[176.085154] [049/132] (853s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[176.278152] Starting subtest: cursorA-vs-flipA-atomic
[187.246103] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.968s)
[187.533667] [050/132] (842s left) gem_ctx_persistence (engines-queued)
[187.621399] Starting subtest: engines-queued
[187.622332] Starting dynamic subtest: rcs0
[187.732530] Dynamic subtest rcs0: SUCCESS (0.111s)
[187.747493] Starting dynamic subtest: bcs0
[187.773373] Dynamic subtest bcs0: SUCCESS (0.040s)
[187.790187] Starting dynamic subtest: vcs0
[187.853608] Dynamic subtest vcs0: SUCCESS (0.079s)
[187.867169] Starting dynamic subtest: vcs1
[187.921555] Dynamic subtest vcs1: SUCCESS (0.067s)
[187.942924] Starting dynamic subtest: vecs0
[187.957804] Dynamic subtest vecs0: SUCCESS (0.035s)
[187.971646] Starting dynamic subtest: vecs1
[188.023230] Dynamic subtest vecs1: SUCCESS (0.064s)
[188.037347] Starting dynamic subtest: ccs0
[188.198769] Dynamic subtest ccs0: SUCCESS (0.175s)
[188.199585] Subtest engines-queued: SUCCESS (0.578s)
[188.398736] [051/132] (841s left) gem_exec_schedule (noreorder-priority)
[188.606335] Starting subtest: noreorder-priority
[188.607262] Starting dynamic subtest: rcs0
[189.784507] Dynamic subtest rcs0: SUCCESS (1.178s)
[189.796970] Starting dynamic subtest: bcs0
[190.928388] Dynamic subtest bcs0: SUCCESS (1.143s)
[190.940300] Starting dynamic subtest: vcs0
[192.086538] Dynamic subtest vcs0: SUCCESS (1.157s)
[192.099349] Starting dynamic subtest: vcs1
[193.215229] Dynamic subtest vcs1: SUCCESS (1.128s)
[193.226136] Starting dynamic subtest: vecs0
[194.357535] Dynamic subtest vecs0: SUCCESS (1.142s)
[194.369500] Starting dynamic subtest: vecs1
[195.492369] Dynamic subtest vecs1: SUCCESS (1.134s)
[195.503421] Starting dynamic subtest: ccs0
[196.641400] Dynamic subtest ccs0: SUCCESS (1.148s)
[196.642484] Subtest noreorder-priority: SUCCESS (8.035s)
[196.910917] [052/132] (832s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[197.101581] Starting subtest: primary-yf-tiled-reflect-x-0
[197.193702] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.091s)
[197.394320] [053/132] (832s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[197.589815] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[200.343644] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.755s)
[200.559743] [054/132] (829s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[200.752944] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[200.754637] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[200.957786] [055/132] (828s left) gem_exec_nop (basic-parallel)
[201.048533] Starting subtest: basic-parallel
[205.453381] Subtest basic-parallel: SUCCESS (4.405s)
[205.789300] [056/132] (824s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[205.978515] Starting subtest: stress-xrgb8888-ytiled
[205.980264] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[206.055213] [057/132] (824s left) gen7_exec_parse (oacontrol-tracking)
[206.146372] Subtest oacontrol-tracking: SKIP (0.000s)
[206.220361] [058/132] (823s left) kms_joiner (invalid-modeset-ultra-joiner)
[206.412983] Starting subtest: invalid-modeset-ultra-joiner
[206.414678] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[206.581163] [059/132] (823s left) gem_exec_schedule (smoketest-all)
[206.675395] Starting subtest: smoketest-all
[238.987995] Subtest smoketest-all: SUCCESS (32.303s)
[239.451946] [060/132] (790s left) api_intel_allocator (two-level-inception)
[239.531185] Starting subtest: two-level-inception
[244.951939] Subtest two-level-inception: SUCCESS (5.421s)
[245.166330] [061/132] (785s left) kms_flip (dpms-vs-vblank-race-interruptible)
[245.358736] Starting subtest: dpms-vs-vblank-race-interruptible
[245.363237] Starting dynamic subtest: A-DP3
[248.556169] Dynamic subtest A-DP3: SUCCESS (3.193s)
[248.577409] Starting dynamic subtest: B-DP3
[251.663028] Dynamic subtest B-DP3: SUCCESS (3.105s)
[251.675752] Starting dynamic subtest: C-DP3
[254.680529] Dynamic subtest C-DP3: SUCCESS (3.016s)
[254.691326] Starting dynamic subtest: D-DP3
[257.757908] Dynamic subtest D-DP3: SUCCESS (3.077s)
[257.760314] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.400s)
[258.071016] [062/132] (772s left) perf (polling)
[258.521890] Starting subtest: polling
[258.522767] Starting dynamic subtest: 0-rcs0
[268.546101] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[268.547104] Subtest polling: SUCCESS (10.026s)
[268.599567] [063/132] (761s left) gem_exec_reloc (basic-cpu-active)
[268.688242] Subtest basic-cpu-active: SKIP (0.000s)
[268.797435] [064/132] (761s left) syncobj_timeline (signal)
[268.887411] Starting subtest: signal
[268.888326] Subtest signal: SUCCESS (0.000s)
[269.094206] [065/132] (761s left) gem_userptr_blits (usage-restrictions)
[269.188137] Starting subtest: usage-restrictions
[269.189012] Subtest usage-restrictions: SUCCESS (0.000s)
[269.365629] [066/132] (761s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[269.555286] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[272.339528] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (2.785s)
[272.598179] [067/132] (758s left) kms_chamelium_color (ctm-limited-range)
[272.786176] Subtest ctm-limited-range: SKIP (0.000s)
[272.871450] [068/132] (758s left) kms_cursor_crc (cursor-offscreen-512x170)
[273.355161] Starting subtest: cursor-offscreen-512x170
[273.358274] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[273.637427] [069/132] (757s left) i915_drm_fdinfo (most-busy-check-all)
[273.710183] Starting subtest: most-busy-check-all
[273.711138] Starting dynamic subtest: rcs0
[273.737722] Dynamic subtest rcs0: SKIP (0.026s)
[273.749064] Starting dynamic subtest: bcs0
[273.751178] Dynamic subtest bcs0: SKIP (0.000s)
[273.762163] Starting dynamic subtest: vcs0
[273.764027] Dynamic subtest vcs0: SKIP (0.000s)
[273.774969] Starting dynamic subtest: vcs1
[273.777420] Dynamic subtest vcs1: SKIP (0.000s)
[273.788197] Starting dynamic subtest: vecs0
[273.790651] Dynamic subtest vecs0: SKIP (0.000s)
[273.801378] Starting dynamic subtest: vecs1
[273.803779] Dynamic subtest vecs1: SKIP (0.000s)
[273.814367] Starting dynamic subtest: ccs0
[273.816490] Dynamic subtest ccs0: SKIP (0.001s)
[273.818559] Subtest most-busy-check-all: SKIP (0.037s)
[273.883051] [070/132] (757s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[274.123386] Starting subtest: x-tiled-16bpp-rotate-90
[274.185389] Subtest x-tiled-16bpp-rotate-90: SKIP (0.061s)
[274.402638] [071/132] (756s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[274.593257] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[274.594992] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[274.786613] [072/132] (756s left) kms_hdr (bpc-switch-suspend)
[274.973421] Starting subtest: bpc-switch-suspend
[278.285037] Starting dynamic subtest: pipe-A-DP-3
[298.310252] Dynamic subtest pipe-A-DP-3: SUCCESS (5.162s)
[298.311201] Subtest bpc-switch-suspend: SUCCESS (8.475s)
[298.688405] [073/132] (732s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[298.903628] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[298.905250] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[299.127339] [074/132] (732s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[299.318037] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[299.318946] Starting dynamic subtest: pipe-A-valid-mode
[299.398173] Dynamic subtest pipe-A-valid-mode: SKIP (0.079s)
[299.399977] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.080s)
[299.655688] [075/132] (731s left) gem_exec_reloc (basic-write-gtt)
[299.749600] Subtest basic-write-gtt: SKIP (0.000s)
[299.838899] [076/132] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[300.034980] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[300.036668] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[300.244488] [077/132] (731s left) gem_exec_balancer (invalid-balancer)
[300.333904] Starting subtest: invalid-balancer
[301.927371] Subtest invalid-balancer: SUCCESS (1.593s)
[302.383242] [078/132] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[302.575566] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[302.577181] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[302.822819] [079/132] (729s left) api_intel_bb (full-batch)
[302.903379] Starting subtest: full-batch
[302.931294] Subtest full-batch: SUCCESS (0.029s)
[303.172663] [080/132] (728s left) gem_ctx_param (invalid-size-set)
[303.249525] Starting subtest: invalid-size-set
[303.251838] Subtest invalid-size-set: SUCCESS (0.001s)
[303.423404] [081/132] (728s left) syncobj_timeline (wait-all-complex)
[303.503159] Starting subtest: wait-all-complex
[303.720654] Subtest wait-all-complex: SUCCESS (0.216s)
[303.863277] [082/132] (728s left) i915_power (sanity)
[303.938476] Starting subtest: sanity
[307.998085] Subtest sanity: SUCCESS (4.059s)
[308.192120] [083/132] (723s left) syncobj_timeline (invalid-query-illegal-handle)
[308.271531] Starting subtest: invalid-query-illegal-handle
[308.272475] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[308.429547] [084/132] (723s left) i915_pm_freq_mult (media-freq)
[308.508433] Starting subtest: media-freq
[308.509292] Starting dynamic subtest: gt0
[309.022649] Dynamic subtest gt0: SUCCESS (0.514s)
[309.027413] Subtest media-freq: SUCCESS (0.517s)
[309.197114] [085/132] (723s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[309.278171] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[309.279068] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[309.473073] [086/132] (722s left) kms_chamelium_frames (dp-crc-single)
[309.753100] Subtest dp-crc-single: SKIP (0.000s)
[309.912031] [087/132] (722s left) kms_psr (fbc-psr-cursor-render)
[310.097974] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[310.165268] [088/132] (722s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[310.249680] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[310.251910] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[310.554668] [089/132] (721s left) kms_content_protection (atomic)
[310.804034] Starting subtest: atomic
[310.834623] Starting dynamic subtest: pipe-A-DP-3
[431.859671] Dynamic subtest pipe-A-DP-3: FAIL (120.857s)
[431.861188] Subtest atomic: FAIL (120.991s)
[432.135282] [090/132] (600s left) core_setmaster (master-drop-set-shared-fd)
[432.314515] Starting subtest: master-drop-set-shared-fd
[432.347140] Subtest master-drop-set-shared-fd: SUCCESS (0.033s)
[432.398919] [091/132] (600s left) gem_exec_flush (basic-wb-rw-before-default)
[432.489160] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[432.563605] [092/132] (600s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[432.763069] Starting subtest: yf-tiled-8bpp-rotate-90
[432.764802] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[432.957714] [093/132] (599s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[433.146106] Starting subtest: basic-flip-before-cursor-legacy
[434.173949] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.028s)
[434.517639] [094/132] (598s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[434.724989] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[434.726637] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[434.933294] [095/132] (598s left) gem_softpin (invalid)
[435.020077] Starting subtest: invalid
[435.033660] Subtest invalid: SUCCESS (0.014s)
[435.221165] [096/132] (597s left) kms_cursor_crc (cursor-suspend)
[435.479871] Starting subtest: cursor-suspend
[435.482222] Starting dynamic subtest: pipe-A-DP-3
[475.620829] Dynamic subtest pipe-A-DP-3: SUCCESS (8.134s)
[475.646175] Starting dynamic subtest: pipe-D-DP-3
[515.788157] Dynamic subtest pipe-D-DP-3: SUCCESS (7.731s)
[515.789597] Subtest cursor-suspend: SUCCESS (15.876s)
[516.555241] [097/132] (516s left) kms_lease (lease-get)
[516.788284] Starting subtest: lease-get
[516.789160] Starting dynamic subtest: pipe-A-DP-3
[516.791571] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[516.806096] Starting dynamic subtest: pipe-B-DP-3
[516.807015] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[516.820173] Starting dynamic subtest: pipe-C-DP-3
[516.821288] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[516.834062] Starting dynamic subtest: pipe-D-DP-3
[516.835063] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[516.836330] Subtest lease-get: SUCCESS (0.016s)
[517.015101] [098/132] (516s left) gem_mmap_wc (bad-size)
[517.093962] Subtest bad-size: SKIP (0.000s)
[517.167057] [099/132] (516s left) gem_exec_capture (capture-recoverable)
[517.256086] Starting subtest: capture-recoverable
[517.259929] Subtest capture-recoverable: SUCCESS (0.004s)
[517.440959] [100/132] (515s left) gem_ctx_shared (exec-shared-gtt)
[517.535454] Starting subtest: exec-shared-gtt
[517.536333] Starting dynamic subtest: rcs0
[517.544643] Dynamic subtest rcs0: SUCCESS (0.009s)
[517.559421] Starting dynamic subtest: bcs0
[517.560249] Dynamic subtest bcs0: SUCCESS (0.006s)
[517.574070] Starting dynamic subtest: vcs0
[517.574964] Dynamic subtest vcs0: SUCCESS (0.008s)
[517.588283] Starting dynamic subtest: vcs1
[517.589160] Dynamic subtest vcs1: SUCCESS (0.006s)
[517.602840] Starting dynamic subtest: vecs0
[517.603811] Dynamic subtest vecs0: SUCCESS (0.006s)
[517.616832] Starting dynamic subtest: vecs1
[517.617877] Dynamic subtest vecs1: SUCCESS (0.008s)
[517.630647] Starting dynamic subtest: ccs0
[517.631901] Dynamic subtest ccs0: SUCCESS (0.006s)
[517.633038] Subtest exec-shared-gtt: SUCCESS (0.058s)
[517.886775] [101/132] (515s left) gem_spin_batch (engines)
[517.978069] Starting subtest: engines
[517.979021] Starting dynamic subtest: rcs0
[521.243483] Dynamic subtest rcs0: SUCCESS (3.263s)
[521.261851] Starting dynamic subtest: bcs0
[524.481196] Dynamic subtest bcs0: SUCCESS (3.233s)
[524.499859] Starting dynamic subtest: vcs0
[527.719165] Dynamic subtest vcs0: SUCCESS (3.234s)
[527.738066] Starting dynamic subtest: vcs1
[530.958295] Dynamic subtest vcs1: SUCCESS (3.235s)
[530.976916] Starting dynamic subtest: vecs0
[534.196572] Dynamic subtest vecs0: SUCCESS (3.233s)
[534.212694] Starting dynamic subtest: vecs1
[537.432325] Dynamic subtest vecs1: SUCCESS (3.231s)
[537.450292] Starting dynamic subtest: ccs0
[540.669802] Dynamic subtest ccs0: SUCCESS (3.233s)
[540.671591] Subtest engines: SUCCESS (22.696s)
[541.018180] [102/132] (492s left) kms_sequence (get-forked-busy)
[541.210386] Starting subtest: get-forked-busy
[541.212835] Starting dynamic subtest: pipe-A-DP-3
[543.873091] Dynamic subtest pipe-A-DP-3: SUCCESS (2.661s)
[543.891963] Starting dynamic subtest: pipe-B-DP-3
[546.415844] Dynamic subtest pipe-B-DP-3: SUCCESS (2.540s)
[546.448870] Starting dynamic subtest: pipe-C-DP-3
[548.988757] Dynamic subtest pipe-C-DP-3: SUCCESS (2.569s)
[549.016248] Starting dynamic subtest: pipe-D-DP-3
[551.596680] Dynamic subtest pipe-D-DP-3: SUCCESS (2.605s)
[551.597652] Subtest get-forked-busy: SUCCESS (10.387s)
[551.907236] [103/132] (481s left) kms_pm_backlight (bad-brightness)
[552.094834] Subtest bad-brightness: SKIP (0.000s)
[552.155151] [104/132] (481s left) gem_mmap_gtt (isolation)
[552.236767] Subtest isolation: SKIP (0.000s)
[552.303482] [105/132] (481s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[552.493866] Starting subtest: fbc-rgb101010-draw-render
[555.374365] Subtest fbc-rgb101010-draw-render: SUCCESS (2.881s)
[555.610311] [106/132] (478s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[555.805077] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[555.872127] [107/132] (477s left) gem_exec_reloc (basic-write-read)
[555.961228] Subtest basic-write-read: SKIP (0.000s)
[556.060987] [108/132] (477s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[556.143047] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[556.144096] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[556.345048] [109/132] (477s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[556.537926] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[556.539660] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[556.745093] [110/132] (477s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[556.937837] Starting subtest: fbcpsr-shrfb-scaledprimary
[556.939551] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[557.145106] [111/132] (477s left) kms_plane_multiple (2x-tiling-y)
[557.331130] Starting subtest: 2x-tiling-y
[557.332912] Subtest 2x-tiling-y: SKIP (0.000s)
[557.503516] [112/132] (476s left) kms_big_fb (linear-64bpp-rotate-90)
[557.705122] Starting subtest: linear-64bpp-rotate-90
[557.757889] Subtest linear-64bpp-rotate-90: SKIP (0.052s)
[557.993091] [113/132] (476s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[558.180812] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[558.182582] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[558.378087] [114/132] (476s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[558.565111] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[558.565964] Starting dynamic subtest: pipe-A-DP-3
[558.574250] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[558.587452] Starting dynamic subtest: pipe-B-DP-3
[558.595809] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[558.608676] Starting dynamic subtest: pipe-C-DP-3
[558.617601] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[558.630619] Starting dynamic subtest: pipe-D-DP-3
[558.639829] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[558.641820] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[559.057340] [115/132] (475s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[559.248515] Starting subtest: plane-downscale-factor-0-75-with-rotation
[559.249963] Starting dynamic subtest: pipe-A
[559.618045] Dynamic subtest pipe-A: SUCCESS (0.369s)
[559.639191] Starting dynamic subtest: pipe-B
[560.082539] Dynamic subtest pipe-B: SUCCESS (0.462s)
[560.127981] Starting dynamic subtest: pipe-C
[560.600981] Dynamic subtest pipe-C: SUCCESS (0.514s)
[560.631877] Starting dynamic subtest: pipe-D
[561.080243] Dynamic subtest pipe-D: SUCCESS (0.477s)
[561.081123] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.833s)
[561.431824] [116/132] (473s left) i915_module_load (resize-bar)
[561.481109] Starting subtest: resize-bar
[617.972754] Subtest resize-bar: SUCCESS (56.493s)
[618.004034] [FACT i915_module_load (resize-bar)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[618.005021] [FACT i915_module_load (resize-bar)] deleted: kernel.kmod_is_loaded.i915: true
[618.007124] [117/132] (416s left) gem_mmap_gtt (basic-small-copy)
[619.658655] Subtest basic-small-copy: SKIP (0.000s)
[619.724545] [FACT gem_mmap_gtt (basic-small-copy)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[619.727419] [FACT gem_mmap_gtt (basic-small-copy)] new: kernel.kmod_is_loaded.i915: true
[619.730607] [118/132] (415s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[619.922105] Starting subtest: short-busy-flip-before-cursor-toggle
[619.923854] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[620.088651] [119/132] (414s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[620.169229] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[620.170143] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[620.387013] [120/132] (414s left) kms_psr (psr-cursor-plane-move)
[620.576989] Subtest psr-cursor-plane-move: SKIP (0.000s)
[620.647409] [121/132] (414s left) syncobj_timeline (device-submit-unordered)
[620.728145] Starting subtest: device-submit-unordered
[620.729077] Subtest device-submit-unordered: SUCCESS (0.000s)
[620.919261] [122/132] (414s left) gem_madvise (dontneed-before-mmap)
[620.967442] Starting subtest: dontneed-before-mmap
[621.021086] Subtest dontneed-before-mmap: SUCCESS (0.054s)
[621.202649] [123/132] (413s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[621.414453] Starting subtest: 4-tiled-16bpp-rotate-0
[623.183732] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.769s)
[623.420179] [124/132] (411s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[623.622060] Starting subtest: y-tiled-8bpp-rotate-270
[623.623809] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[623.834629] [125/132] (411s left) gem_mmap_gtt (medium-copy)
[623.913917] Subtest medium-copy: SKIP (0.000s)
[624.000160] [126/132] (411s left) gem_ctx_persistence (engines-hostile)
[624.094195] Starting subtest: engines-hostile
[624.095263] Starting dynamic subtest: rcs0
[624.261099] Dynamic subtest rcs0: SUCCESS (0.167s)
[624.281840] Starting dynamic subtest: bcs0
[624.312865] Dynamic subtest bcs0: SUCCESS (0.048s)
[624.327982] Starting dynamic subtest: vcs0
[624.411896] Dynamic subtest vcs0: SUCCESS (0.097s)
[624.457870] Starting dynamic subtest: vcs1
[624.485930] Dynamic subtest vcs1: SUCCESS (0.070s)
[624.505083] Starting dynamic subtest: vecs0
[624.588098] Dynamic subtest vecs0: SUCCESS (0.100s)
[624.636413] Starting dynamic subtest: vecs1
[624.637716] Dynamic subtest vecs1: SUCCESS (0.034s)
[624.654674] Starting dynamic subtest: ccs0
[624.740257] Dynamic subtest ccs0: SUCCESS (0.111s)
[624.744121] Subtest engines-hostile: SUCCESS (0.649s)
[624.969818] [127/132] (410s left) kms_psr (psr2-primary-mmap-gtt)
[625.158971] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[625.230745] [128/132] (410s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[625.422142] Starting subtest: blocking-absolute-wf_vblank-interruptible
[625.426957] Starting dynamic subtest: A-DP3
[633.240438] Dynamic subtest A-DP3: SUCCESS (7.813s)
[633.256729] Starting dynamic subtest: B-DP3
[640.990349] Dynamic subtest B-DP3: SUCCESS (7.748s)
[641.004502] Starting dynamic subtest: C-DP3
[648.741201] Dynamic subtest C-DP3: SUCCESS (7.749s)
[648.755200] Starting dynamic subtest: D-DP3
[656.495376] Dynamic subtest D-DP3: SUCCESS (7.753s)
[656.497759] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.074s)
[656.864685] [129/132] (378s left) gem_exec_whisper (basic-forked-all)
[656.953731] Starting subtest: basic-forked-all
[659.796909] Subtest basic-forked-all: SUCCESS (2.842s)
[660.087104] [130/132] (375s left) gem_ppgtt (blt-vs-render-ctx0)
[660.176102] Starting subtest: blt-vs-render-ctx0
[693.009243] Subtest blt-vs-render-ctx0: SUCCESS (32.831s)
[693.231578] [131/132] (342s left) kms_content_protection (content-type-change)
[693.547091] Starting subtest: content-type-change
[693.553571] Subtest content-type-change: SKIP (0.003s)
[693.780386] [132/132] (342s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[693.975726] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[693.977526] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[694.172413] Closing watchdogs
results: parsing output: 0/ for test: gem_media_vme
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_fb_coherency
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: gem_exec_whisper
results: parsing output: 8/ for test: kms_async_flips
results: parsing output: 9/ for test: gem_madvise
results: parsing output: 10/ for test: kms_color
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_ctx_engines
results: parsing output: 19/ for test: kms_flip_scaled_crc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_vrr
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_prop_blob
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: sysfs_preempt_timeout
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_pxp
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_busy
results: parsing output: 36/ for test: gem_linear_blits
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_wait
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: gem_workarounds
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gem_tiled_blits
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_nop
results: parsing output: 55/ for test: kms_pipe_stress
results: parsing output: 56/ for test: gen7_exec_parse
results: parsing output: 57/ for test: kms_joiner
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_chamelium_color
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_hdr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: i915_power
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: i915_pm_freq_mult
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_chamelium_frames
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_content_protection
results: parsing output: 89/ for test: core_setmaster
results: parsing output: 90/ for test: gem_exec_flush
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: gem_mmap_wc
results: parsing output: 98/ for test: gem_exec_capture
results: parsing output: 99/ for test: gem_ctx_shared
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_sequence
results: parsing output: 102/ for test: kms_pm_backlight
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_plane_multiple
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: i915_module_load
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_madvise
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: gem_ppgtt
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.