[108.849216] Initializing watchdogs
[108.849299]   /dev/watchdog0
[108.879849] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[108.894806] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[108.899778] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[108.903134] [001/156] (960s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[108.955111] Starting subtest: multi-wait-all-for-submit-available-submitted
[108.956032] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[109.086839] [002/156] (960s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[110.629601] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[110.759309] [003/156] (958s left) kms_color_pipeline (plane-ctm3x4)
[112.246883] Starting subtest: plane-ctm3x4
[112.451153] Starting dynamic subtest: pipe-A-plane-0
[112.684882] Dynamic subtest pipe-A-plane-0: SUCCESS (0.233s)
[112.719694] Starting dynamic subtest: pipe-A-plane-1
[112.884921] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[112.905131] Starting dynamic subtest: pipe-A-plane-2
[113.051600] Dynamic subtest pipe-A-plane-2: SUCCESS (0.165s)
[113.370160] Starting dynamic subtest: pipe-B-plane-0
[113.532329] Dynamic subtest pipe-B-plane-0: SUCCESS (0.183s)
[113.556407] Starting dynamic subtest: pipe-B-plane-1
[113.699587] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[113.735853] Starting dynamic subtest: pipe-B-plane-2
[113.880402] Dynamic subtest pipe-B-plane-2: SUCCESS (0.181s)
[114.166867] Starting dynamic subtest: pipe-C-plane-0
[114.322533] Dynamic subtest pipe-C-plane-0: SUCCESS (0.183s)
[114.359342] Starting dynamic subtest: pipe-C-plane-1
[114.520369] Dynamic subtest pipe-C-plane-1: SUCCESS (0.197s)
[114.529112] Starting dynamic subtest: pipe-C-plane-2
[114.687128] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[114.994300] Starting dynamic subtest: pipe-D-plane-0
[115.157089] Dynamic subtest pipe-D-plane-0: SUCCESS (0.183s)
[115.182974] Starting dynamic subtest: pipe-D-plane-1
[115.356997] Dynamic subtest pipe-D-plane-1: SUCCESS (0.199s)
[115.385985] Starting dynamic subtest: pipe-D-plane-2
[115.557047] Dynamic subtest pipe-D-plane-2: SUCCESS (0.199s)
[115.610835] Subtest plane-ctm3x4: SUCCESS (3.364s)
[115.837316] [004/156] (953s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[117.325735] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[117.326661] Starting dynamic subtest: pipe-A-HDMI-A-3
[117.335891] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[117.344543] Starting dynamic subtest: pipe-B-HDMI-A-3
[117.353115] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[117.361494] Starting dynamic subtest: pipe-C-HDMI-A-3
[117.370656] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[117.379008] Starting dynamic subtest: pipe-D-HDMI-A-3
[117.388095] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[117.389903] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[117.591510] [005/156] (952s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[119.078901] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[119.079822] Starting dynamic subtest: pipe-A-valid-mode
[121.617096] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.536s)
[121.617908] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (2.538s)
[121.820388] [006/156] (947s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[123.315051] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[123.317159] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[123.532567] [007/156] (946s left) perf_pmu (frequency)
[123.587261] Starting subtest: frequency
[123.590609] Starting dynamic subtest: gt0
[125.753455] Dynamic subtest gt0: SUCCESS (2.160s)
[125.763208] Starting dynamic subtest: idle-gt0
[126.263710] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[126.265976] Subtest frequency: SUCCESS (2.674s)
[126.432573] [008/156] (943s left) gem_create (create-ext-placement-all)
[126.595060] Starting subtest: create-ext-placement-all
[126.596115] Subtest create-ext-placement-all: SUCCESS (0.000s)
[126.715980] [009/156] (943s left) gem_exec_balancer (invalid-bonds)
[126.771471] Starting subtest: invalid-bonds
[126.773308] Subtest invalid-bonds: SKIP (0.000s)
[127.197465] [010/156] (942s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[127.243213] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[127.244119] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[127.364287] [011/156] (942s left) kms_async_flips (alternate-sync-async-flip-atomic)
[128.850985] Starting subtest: alternate-sync-async-flip-atomic
[129.062920] Starting dynamic subtest: pipe-A-HDMI-A-3
[131.384191] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.317s)
[131.585166] Starting dynamic subtest: pipe-B-HDMI-A-3
[133.645938] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.065s)
[133.859734] Starting dynamic subtest: pipe-C-HDMI-A-3
[135.931589] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.076s)
[136.103181] Starting dynamic subtest: pipe-D-HDMI-A-3
[138.169970] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.071s)
[138.172382] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.316s)
[138.561505] [012/156] (931s left) gem_exec_nop (basic-sequential)
[138.620172] Starting subtest: basic-sequential
[142.364571] Subtest basic-sequential: SUCCESS (3.743s)
[142.656603] [013/156] (927s left) kms_big_fb (linear-16bpp-rotate-270)
[144.167313] Starting subtest: linear-16bpp-rotate-270
[144.271918] Subtest linear-16bpp-rotate-270: SKIP (0.104s)
[144.445433] [014/156] (925s left) gen9_exec_parse (batch-zero-length)
[144.497124] Subtest batch-zero-length: SKIP (0.000s)
[144.577837] [015/156] (925s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[146.083999] Starting subtest: yf-tiled-16bpp-rotate-90
[146.085973] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[146.283988] [016/156] (924s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[147.771825] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[147.772721] Starting dynamic subtest: pipe-A-HDMI-A-3
[147.780900] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[147.790590] Starting dynamic subtest: pipe-B-HDMI-A-3
[147.798626] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[147.808249] Starting dynamic subtest: pipe-C-HDMI-A-3
[147.816506] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[147.826056] Starting dynamic subtest: pipe-D-HDMI-A-3
[147.834830] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[147.836547] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[148.045345] [017/156] (922s left) kms_fbcon_fbt (fbc)
[148.095225] Starting subtest: fbc
[151.546175] Subtest fbc: SUCCESS (3.447s)
[151.637554] [018/156] (919s left) kms_feature_discovery (psr1)
[153.127246] Starting subtest: psr1
[153.129102] Subtest psr1: SKIP (0.000s)
[153.259859] [019/156] (917s left) gem_exec_schedule (u-semaphore-codependency)
[153.334233] Starting subtest: u-semaphore-codependency
[153.365639] Subtest u-semaphore-codependency: SUCCESS (0.031s)
[153.771235] [020/156] (917s left) kms_psr (psr2-basic)
[155.258248] Subtest psr2-basic: SKIP (0.000s)
[155.329634] [021/156] (915s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[156.867347] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[156.994159] [022/156] (913s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[158.489091] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[158.491267] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[158.664680] [023/156] (912s left) kms_plane_alpha_blend (constant-alpha-max)
[160.153663] Starting subtest: constant-alpha-max
[160.424152] Starting dynamic subtest: pipe-A-HDMI-A-3
[161.324098] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.899s)
[161.334148] Starting dynamic subtest: pipe-D-HDMI-A-3
[162.206495] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.881s)
[162.207306] Subtest constant-alpha-max: SUCCESS (2.053s)
[162.404565] [024/156] (908s left) kms_getfb (getfb-handle-not-fb)
[163.893039] Starting subtest: getfb-handle-not-fb
[163.893960] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[164.064598] [025/156] (907s left) perf (enable-disable)
[164.191280] Starting subtest: enable-disable
[164.192226] Starting dynamic subtest: 0-rcs0
[166.483433] Dynamic subtest 0-rcs0: SUCCESS (2.290s)
[166.484360] Subtest enable-disable: SUCCESS (2.290s)
[166.552946] [026/156] (904s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[166.605434] Starting subtest: yf-tiled-to-vebox-yf-tiled
[166.606289] Starting dynamic subtest: smem
[166.691562] Dynamic subtest smem: SUCCESS (0.086s)
[166.701704] Starting dynamic subtest: lmem0
[167.447997] Dynamic subtest lmem0: SUCCESS (0.753s)
[167.448962] Subtest yf-tiled-to-vebox-yf-tiled: SUCCESS (0.840s)
[167.708177] [027/156] (903s left) kms_dp_linktrain_fallback (dsc-fallback)
[169.195273] Starting subtest: dsc-fallback
[169.198509] Subtest dsc-fallback: SKIP (0.000s)
[169.322455] [028/156] (902s left) syncobj_wait (multi-wait-all-submitted)
[169.384598] Starting subtest: multi-wait-all-submitted
[169.494637] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[169.649402] [029/156] (901s left) gem_ctx_param (invalid-set-ringsize)
[169.693557] Starting subtest: invalid-set-ringsize
[169.694459] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[169.810455] [030/156] (901s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[171.300814] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[171.364113] [031/156] (900s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[172.857950] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[172.859952] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[173.045315] [032/156] (898s left) gem_exec_schedule (preempt-contexts)
[173.108970] Starting subtest: preempt-contexts
[173.109996] Starting dynamic subtest: rcs0
[173.197132] Dynamic subtest rcs0: SUCCESS (0.088s)
[173.207387] Starting dynamic subtest: bcs0
[173.265284] Dynamic subtest bcs0: SUCCESS (0.068s)
[173.276370] Starting dynamic subtest: vcs0
[173.335478] Dynamic subtest vcs0: SUCCESS (0.070s)
[173.345753] Starting dynamic subtest: vcs1
[173.405499] Dynamic subtest vcs1: SUCCESS (0.070s)
[173.415489] Starting dynamic subtest: vecs0
[173.476773] Dynamic subtest vecs0: SUCCESS (0.071s)
[173.477597] Subtest preempt-contexts: SUCCESS (0.368s)
[173.934691] [033/156] (897s left) gem_ppgtt (shrink-vs-evict-any)
[173.985434] Starting subtest: shrink-vs-evict-any
[181.850697] Subtest shrink-vs-evict-any: SUCCESS (7.862s)
[181.948295] [034/156] (889s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[183.440044] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[183.442089] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[183.632533] [035/156] (888s left) kms_hdmi_inject (inject-4k)
[183.715205] Starting subtest: inject-4k
[183.903932] Subtest inject-4k: SUCCESS (0.189s)
[184.828481] [036/156] (887s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[186.332590] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[186.335038] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[186.507824] [037/156] (885s left) gem_exec_flush (basic-uc-pro-default)
[186.560298] Subtest basic-uc-pro-default: SKIP (0.000s)
[186.650204] [038/156] (885s left) gem_exec_schedule (smoketest-all)
[186.711838] Starting subtest: smoketest-all
[219.019269] Subtest smoketest-all: SUCCESS (32.298s)
[219.552453] [039/156] (852s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[221.044902] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[221.046890] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[221.228383] [040/156] (851s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[222.723167] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[222.725131] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[222.863128] [041/156] (849s left) kms_frontbuffer_tracking (psr-slowdraw)
[224.361471] Starting subtest: psr-slowdraw
[224.363188] Subtest psr-slowdraw: SKIP (0.000s)
[224.557478] [042/156] (848s left) kms_pm_rpm (cursor-dpms)
[228.002748] Starting subtest: cursor-dpms
[228.004946] Subtest cursor-dpms: SKIP (0.000s)
[228.994859] [043/156] (843s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[230.507468] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite
[230.509281] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[230.686356] [044/156] (842s left) gem_softpin (allocator-fork)
[230.739589] Starting subtest: allocator-fork
[233.065786] Subtest allocator-fork: SUCCESS (2.323s)
[233.218412] [045/156] (839s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[234.705076] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[234.706018] Starting dynamic subtest: pipe-A-valid-mode
[235.514063] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.808s)
[235.514973] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.809s)
[235.726862] [046/156] (837s left) kms_flip (2x-flip-vs-modeset)
[237.216784] Starting subtest: 2x-flip-vs-modeset
[237.236715] Subtest 2x-flip-vs-modeset: SKIP (0.019s)
[237.362373] [047/156] (835s left) syncobj_basic (create-signaled)
[237.413539] Starting subtest: create-signaled
[237.414335] Subtest create-signaled: SUCCESS (0.000s)
[237.518260] [048/156] (835s left) gem_ctx_shared (create-shared-gtt)
[237.575422] Starting subtest: create-shared-gtt
[239.728909] Subtest create-shared-gtt: SUCCESS (2.150s)
[240.520109] [049/156] (832s left) syncobj_wait (wait-any-complex)
[240.565410] Starting subtest: wait-any-complex
[240.627990] Subtest wait-any-complex: SUCCESS (0.062s)
[240.771390] [050/156] (832s left) kms_prime (d3hot)
[242.274924] Subtest D3hot: SKIP (0.000s)
[242.544645] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[242.550586] [051/156] (830s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[242.598109] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[242.599137] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[242.703661] [052/156] (830s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[244.210048] Starting subtest: yf-tiled-addfb-size-offset-overflow
[244.211862] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[244.417526] [053/156] (829s left) syncobj_timeline (wait-for-submit-delayed-submit)
[244.463937] Starting subtest: wait-for-submit-delayed-submit
[244.569383] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[244.789418] [054/156] (829s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[246.276684] Starting subtest: plane-scaler-unity-scaling-with-rotation
[246.277628] Starting dynamic subtest: pipe-A
[246.649896] Dynamic subtest pipe-A: SKIP (0.370s)
[246.660268] Starting dynamic subtest: pipe-B
[247.068428] Dynamic subtest pipe-B: SKIP (0.418s)
[247.078812] Starting dynamic subtest: pipe-C
[247.491409] Dynamic subtest pipe-C: SKIP (0.422s)
[247.502048] Starting dynamic subtest: pipe-D
[247.915150] Dynamic subtest pipe-D: SKIP (0.422s)
[247.917055] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (1.637s)
[248.115208] [055/156] (825s left) gem_basic (multigpu-create-close)
[248.167282] Starting subtest: multigpu-create-close
[248.169158] Subtest multigpu-create-close: SKIP (0.000s)
[248.278576] [056/156] (825s left) kms_flip (plain-flip-fb-recreate)
[249.768247] Starting subtest: plain-flip-fb-recreate
[249.774527] Starting dynamic subtest: A-HDMI-A3
[257.825379] Dynamic subtest A-HDMI-A3: SUCCESS (8.049s)
[257.854129] Starting dynamic subtest: B-HDMI-A3
[265.855427] Dynamic subtest B-HDMI-A3: SUCCESS (8.022s)
[265.892872] Starting dynamic subtest: C-HDMI-A3
[273.849544] Dynamic subtest C-HDMI-A3: SUCCESS (7.985s)
[273.897466] Starting dynamic subtest: D-HDMI-A3
[281.860351] Dynamic subtest D-HDMI-A3: SUCCESS (8.002s)
[281.870130] Subtest plain-flip-fb-recreate: SUCCESS (32.101s)
[282.169791] [057/156] (791s left) gem_create (create-invalid-size)
[282.232344] Starting subtest: create-invalid-size
[282.233276] Subtest create-invalid-size: SUCCESS (0.000s)
[282.522179] [058/156] (791s left) kms_plane_multiple (tiling-4)
[284.010283] Starting subtest: tiling-4
[284.011993] Subtest tiling-4: SKIP (0.000s)
[284.125753] [059/156] (790s left) gem_exec_reloc (basic-cpu-read-noreloc)
[284.187240] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[284.275951] [060/156] (790s left) i915_hangman (gt-engine-hang)
[284.336684] Starting subtest: gt-engine-hang
[284.337547] Starting dynamic subtest: rcs0
[285.042434] Dynamic subtest rcs0: SUCCESS (0.705s)
[285.055092] Starting dynamic subtest: bcs0
[285.703311] Dynamic subtest bcs0: SUCCESS (0.660s)
[285.716383] Starting dynamic subtest: vcs0
[286.374413] Dynamic subtest vcs0: SUCCESS (0.670s)
[286.389500] Starting dynamic subtest: vcs1
[287.050374] Dynamic subtest vcs1: SUCCESS (0.674s)
[287.064012] Starting dynamic subtest: vecs0
[287.727333] Dynamic subtest vecs0: SUCCESS (0.676s)
[287.728283] Subtest gt-engine-hang: SUCCESS (3.391s)
[287.885958] [061/156] (786s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[287.933406] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[287.934305] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[288.049173] [062/156] (786s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[289.556133] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[289.557948] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[289.757045] [063/156] (784s left) api_intel_bb (render-ccs)
[289.804426] Starting subtest: render-ccs
[289.902395] Subtest render-ccs: SUCCESS (0.099s)
[290.042927] [064/156] (784s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite)
[291.537143] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite
[291.539121] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[291.766559] [065/156] (783s left) i915_drm_fdinfo (busy-idle-check-all)
[291.816738] Starting subtest: busy-idle-check-all
[291.817665] Starting dynamic subtest: rcs0
[291.839051] Dynamic subtest rcs0: SKIP (0.020s)
[291.849996] Starting dynamic subtest: bcs0
[291.852232] Dynamic subtest bcs0: SKIP (0.000s)
[291.862600] Starting dynamic subtest: vcs0
[291.864669] Dynamic subtest vcs0: SKIP (0.000s)
[291.875218] Starting dynamic subtest: vcs1
[291.877648] Dynamic subtest vcs1: SKIP (0.000s)
[291.888234] Starting dynamic subtest: vecs0
[291.890652] Dynamic subtest vecs0: SKIP (0.000s)
[291.893045] Subtest busy-idle-check-all: SKIP (0.030s)
[291.989732] [066/156] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[293.520802] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[293.522539] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[293.688919] [067/156] (781s left) gem_exec_capture (capture-recoverable)
[293.745420] Starting subtest: capture-recoverable
[293.749896] Subtest capture-recoverable: SUCCESS (0.005s)
[293.939264] [068/156] (781s left) core_sysfs (read-all-entries)
[293.986537] Starting subtest: read-all-entries
[293.992219] Subtest read-all-entries: SUCCESS (0.007s)
[294.097809] [069/156] (781s left) syncobj_wait (invalid-reset-one-illegal-handle)
[294.144999] Starting subtest: invalid-reset-one-illegal-handle
[294.145982] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[294.273688] [070/156] (781s left) kms_psr (fbc-psr-cursor-render)
[295.760608] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[295.843763] [071/156] (779s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[297.339219] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[297.341277] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[297.512253] [072/156] (777s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[299.008167] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[299.010043] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[299.215137] [073/156] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[300.725417] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[300.727114] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[300.926922] [074/156] (774s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[302.421988] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[302.423968] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[302.637674] [075/156] (773s left) kms_plane (planar-pixel-format-settings)
[304.142496] Starting subtest: planar-pixel-format-settings
[304.236256] Subtest planar-pixel-format-settings: SUCCESS (0.094s)
[304.418262] [076/156] (771s left) gem_exec_whisper (basic-contexts-priority-all)
[304.478259] Starting subtest: basic-contexts-priority-all
[318.155562] Subtest basic-contexts-priority-all: SUCCESS (13.673s)
[318.458165] [077/156] (757s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[319.952746] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[319.954421] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[320.156712] [078/156] (756s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc)
[321.650762] Starting subtest: hdr-rgb101010-draw-mmap-wc
[321.652484] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[321.858908] [079/156] (754s left) kms_vblank (ts-continuation-modeset-rpm)
[323.347518] Starting subtest: ts-continuation-modeset-rpm
[323.348563] Starting dynamic subtest: pipe-A-HDMI-A-3
[325.817151] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.467s)
[325.831575] Starting dynamic subtest: pipe-D-HDMI-A-3
[327.807622] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.987s)
[327.808525] Subtest ts-continuation-modeset-rpm: SUCCESS (4.462s)
[328.015010] [080/156] (748s left) gem_userptr_blits (userfault)
[328.069819] Starting subtest: userfault
[328.074116] Subtest userfault: SUCCESS (0.006s)
[328.281479] [081/156] (748s left) kms_lease (lease-invalid-plane)
[329.769307] Starting subtest: lease-invalid-plane
[329.770171] Starting dynamic subtest: pipe-A-HDMI-A-3
[329.770993] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.000s)
[329.783873] Starting dynamic subtest: pipe-B-HDMI-A-3
[329.785057] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.000s)
[329.795968] Starting dynamic subtest: pipe-C-HDMI-A-3
[329.797180] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.000s)
[329.808192] Starting dynamic subtest: pipe-D-HDMI-A-3
[329.809279] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.000s)
[329.810294] Subtest lease-invalid-plane: SUCCESS (0.009s)
[329.904238] [082/156] (746s left) gem_lmem_swapping (smem-oom)
[334.195827] Starting subtest: smem-oom
[334.196822] Starting dynamic subtest: lmem0
[369.536423] Dynamic subtest lmem0: SUCCESS (35.336s)
[369.537741] Subtest smem-oom: SUCCESS (35.339s)
[370.624032] [FACT gem_lmem_swapping (smem-oom)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[370.627532] [FACT gem_lmem_swapping (smem-oom)] deleted: kernel.kmod_is_loaded.i915: true
[370.631442] [083/156] (706s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[375.518937] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[375.521047] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[375.736359] [FACT kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[375.739608] [FACT kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)] new: kernel.kmod_is_loaded.i915: true
[375.746335] [084/156] (701s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[377.241229] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[377.242747] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[377.393065] [085/156] (699s left) kms_cursor_crc (cursor-tearing-position-change)
[380.016746] Starting subtest: cursor-tearing-position-change
[380.019219] Starting dynamic subtest: pipe-A-HDMI-A-3
[380.531226] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.512s)
[380.545621] Starting dynamic subtest: pipe-D-HDMI-A-3
[380.885511] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.351s)
[380.886443] Subtest cursor-tearing-position-change: SUCCESS (0.868s)
[381.569861] [086/156] (695s left) gem_exec_parallel (userptr)
[381.636614] Starting subtest: userptr
[381.637568] Starting dynamic subtest: rcs0
[383.600457] Dynamic subtest rcs0: SUCCESS (1.965s)
[383.617789] Starting dynamic subtest: bcs0
[385.133928] Dynamic subtest bcs0: SUCCESS (1.532s)
[385.148437] Starting dynamic subtest: vcs0
[386.667097] Dynamic subtest vcs0: SUCCESS (1.532s)
[386.685462] Starting dynamic subtest: vcs1
[388.223089] Dynamic subtest vcs1: SUCCESS (1.554s)
[388.241101] Starting dynamic subtest: vecs0
[389.777016] Dynamic subtest vecs0: SUCCESS (1.552s)
[389.777897] Subtest userptr: SUCCESS (8.143s)
[390.121570] [087/156] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[391.617177] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[391.619040] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[391.824416] [088/156] (685s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[393.322807] Starting subtest: psr-2p-primscrn-cur-indfb-move
[393.324571] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[393.512978] [089/156] (683s left) kms_cursor_crc (cursor-onscreen-512x512)
[395.272882] Starting subtest: cursor-onscreen-512x512
[395.275011] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[395.531157] [090/156] (681s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[397.026945] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[397.028753] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[397.213697] [091/156] (680s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[398.711446] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[398.713433] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[398.887586] [092/156] (678s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[400.381796] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[400.470085] [093/156] (677s left) i915_pm_rpm (system-suspend-devices)
[403.992126] Starting subtest: system-suspend-devices
[412.184546] Subtest system-suspend-devices: SUCCESS (8.199s)
[419.246948] [094/156] (664s left) kms_flip (bo-too-big-interruptible)
[420.742598] Starting subtest: bo-too-big-interruptible
[420.749999] Starting dynamic subtest: A-HDMI-A3
[420.979364] Dynamic subtest A-HDMI-A3: SUCCESS (0.229s)
[420.999889] Starting dynamic subtest: B-HDMI-A3
[421.129346] Dynamic subtest B-HDMI-A3: SUCCESS (0.148s)
[421.145599] Starting dynamic subtest: C-HDMI-A3
[421.274606] Dynamic subtest C-HDMI-A3: SUCCESS (0.143s)
[421.291050] Starting dynamic subtest: D-HDMI-A3
[421.419356] Dynamic subtest D-HDMI-A3: SUCCESS (0.143s)
[421.421929] Subtest bo-too-big-interruptible: SUCCESS (0.679s)
[421.669325] [095/156] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[423.175102] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[423.176872] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[423.364326] [096/156] (660s left) perf (polling-parameterized)
[423.527699] Starting subtest: polling-parameterized
[443.579366] Subtest polling-parameterized: SUCCESS (20.048s)
[443.660265] [097/156] (640s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[445.169253] Starting subtest: 4-tiled-64bpp-rotate-270
[445.171357] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[445.365465] [098/156] (638s left) kms_properties (crtc-properties-atomic)
[446.854700] Starting subtest: crtc-properties-atomic
[446.855714] Starting dynamic subtest: pipe-A-HDMI-A-3
[447.226348] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.369s)
[447.256974] Starting dynamic subtest: pipe-B-HDMI-A-3
[447.535673] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.304s)
[447.550501] Starting dynamic subtest: pipe-C-HDMI-A-3
[447.835399] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.297s)
[447.850840] Starting dynamic subtest: pipe-D-HDMI-A-3
[448.133540] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.296s)
[448.134592] Subtest crtc-properties-atomic: SUCCESS (1.279s)
[448.354465] [099/156] (636s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[449.846430] Starting subtest: cursorA-vs-flipA-toggle
[460.760768] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.915s)
[460.965471] [100/156] (623s left) i915_query (engine-info)
[461.016709] Starting subtest: engine-info
[461.021670] Subtest engine-info: SUCCESS (0.005s)
[461.141322] [101/156] (623s left) gem_exec_whisper (basic-sync)
[461.201843] Starting subtest: basic-sync
[464.635055] Subtest basic-sync: SUCCESS (3.432s)
[464.857564] [102/156] (619s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[466.428432] Starting subtest: cursor-rapid-movement-32x32
[466.477877] Subtest cursor-rapid-movement-32x32: SKIP (0.046s)
[466.874818] [103/156] (617s left) gem_eio (create-ext)
[467.085441] Starting subtest: create-ext
[467.403563] Subtest create-ext: SUCCESS (0.318s)
[469.004366] [104/156] (615s left) kms_invalid_mode (bad-vtotal)
[470.495981] Starting subtest: bad-vtotal
[470.501625] Starting dynamic subtest: pipe-A-HDMI-A-3
[470.539131] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.042s)
[470.556416] Starting dynamic subtest: pipe-B-HDMI-A-3
[470.557543] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[470.573455] Starting dynamic subtest: pipe-C-HDMI-A-3
[470.574328] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[470.591159] Starting dynamic subtest: pipe-D-HDMI-A-3
[470.592042] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[470.592927] Subtest bad-vtotal: SUCCESS (0.054s)
[470.747026] [105/156] (614s left) gem_render_copy (yf-tiled-ccs-to-linear)
[470.804525] Starting subtest: yf-tiled-ccs-to-linear
[470.805446] Starting dynamic subtest: smem
[470.891144] Dynamic subtest smem: SUCCESS (0.087s)
[470.908385] Starting dynamic subtest: lmem0
[471.201151] Dynamic subtest lmem0: SUCCESS (0.305s)
[471.202093] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.395s)
[471.460868] [106/156] (613s left) gem_mmap_gtt (isolation)
[471.508162] Subtest isolation: SKIP (0.000s)
[471.596660] [107/156] (613s left) gem_softpin (evict-active-interruptible)
[471.651848] Starting subtest: evict-active-interruptible
[471.664776] Subtest evict-active-interruptible: SUCCESS (0.013s)
[471.870472] [108/156] (613s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[473.358578] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[473.359570] Starting dynamic subtest: pipe-A-valid-mode
[474.658379] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.298s)
[474.659283] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.300s)
[474.873495] [109/156] (610s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[476.377927] Starting subtest: extended-modeset-hang-oldfb-with-reset
[476.380371] Starting dynamic subtest: pipe-A
[487.169293] Dynamic subtest pipe-A: SUCCESS (10.788s)
[487.189106] Starting dynamic subtest: pipe-D
[497.883596] Dynamic subtest pipe-D: SUCCESS (10.708s)
[497.884585] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.506s)
[498.112225] [110/156] (587s left) api_intel_allocator (fork-simple-once)
[498.160572] Starting subtest: fork-simple-once
[498.190984] Subtest fork-simple-once: SUCCESS (0.031s)
[498.392174] [111/156] (587s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[499.887226] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[499.889169] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[500.058516] [112/156] (585s left) kms_psr (psr2-primary-mmap-gtt)
[501.550145] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[501.628134] [113/156] (584s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[503.124443] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[503.126089] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[503.309289] [114/156] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[504.803895] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[504.805647] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[504.979392] [115/156] (580s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[505.028407] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[505.133893] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[505.322637] [116/156] (580s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[505.371837] Starting subtest: framebuffer-vs-set-tiling
[505.373593] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[506.998802] [117/156] (579s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[508.489382] Starting subtest: 2x-long-flip-vs-cursor-atomic
[508.491946] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[508.648130] [118/156] (577s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[510.144933] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[510.146845] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[510.339250] [119/156] (576s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[510.387527] Starting subtest: single-wait-all-for-submit-unsubmitted
[510.493164] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[510.664401] [120/156] (575s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[512.156353] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[512.248922] [121/156] (574s left) kms_content_protection (lic-type-0-hdcp14)
[513.795932] Starting subtest: lic-type-0-hdcp14
[513.800341] Subtest lic-type-0-hdcp14: SKIP (0.002s)
[514.006814] [122/156] (572s left) gem_partial_pwrite_pread (writes-after-reads-display)
[514.059249] Subtest writes-after-reads-display: SKIP (0.000s)
[514.162422] [123/156] (572s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[515.657291] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[515.659249] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[515.862544] [124/156] (570s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[517.371988] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[517.373880] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[517.533646] [125/156] (569s left) kms_getfb (getfb2-handle-zero)
[519.037678] Starting subtest: getfb2-handle-zero
[519.038626] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[519.194727] [126/156] (567s left) kms_chamelium_audio (hdmi-audio-edid)
[520.737320] Subtest hdmi-audio-edid: SKIP (0.000s)
[520.874902] [127/156] (566s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt)
[522.369140] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt
[522.371060] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[522.564158] [128/156] (564s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[524.059596] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[524.061607] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[524.245583] [129/156] (563s left) prime_busy (hang-wait)
[524.297872] Starting subtest: hang-wait
[524.300372] Starting dynamic subtest: rcs0
[550.457610] Dynamic subtest rcs0: SUCCESS (26.157s)
[550.473733] Starting dynamic subtest: bcs0
[557.602048] Dynamic subtest bcs0: SUCCESS (7.144s)
[557.619540] Starting dynamic subtest: vcs0
[564.579762] Dynamic subtest vcs0: SUCCESS (6.976s)
[564.597441] Starting dynamic subtest: vcs1
[571.557526] Dynamic subtest vcs1: SUCCESS (6.975s)
[571.573529] Starting dynamic subtest: vecs0
[578.530947] Dynamic subtest vecs0: SUCCESS (6.973s)
[578.533486] Subtest hang-wait: SUCCESS (54.234s)
[578.752809] [130/156] (508s left) gem_userptr_blits (dmabuf-sync)
[578.814864] Starting subtest: dmabuf-sync
[578.818802] Subtest dmabuf-sync: SKIP (0.003s)
[579.012795] [131/156] (508s left) kms_selftest (drm_format_helper)
[579.060466] Starting subtest: drm_format_helper
[579.113567] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[579.193127] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.080s)
[579.238528] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[579.270755] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.074s)
[579.292542] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[579.353775] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.079s)
[579.402032] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[579.427596] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.068s)
[579.446265] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[579.533086] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.098s)
[579.578318] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[579.604762] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.067s)
[579.622147] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[579.677575] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.072s)
[579.713545] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[579.747644] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.069s)
[579.796598] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[579.824551] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.073s)
[579.843610] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[579.915461] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.087s)
[579.966913] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[579.990851] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.069s)
[580.009999] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[580.060236] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.067s)
[580.108445] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[580.133766] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.069s)
[580.153188] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[580.207221] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.071s)
[580.238067] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[580.280652] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.072s)
[580.325112] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[580.357481] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.075s)
[580.378963] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[580.450677] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.089s)
[580.452278] Subtest drm_format_helper: SUCCESS (1.390s)
[580.727273] [132/156] (506s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[582.216444] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[582.217406] Starting dynamic subtest: pipe-A
[582.321565] Dynamic subtest pipe-A: SUCCESS (0.105s)
[582.343463] Starting dynamic subtest: pipe-B
[582.479885] Dynamic subtest pipe-B: SUCCESS (0.157s)
[582.497525] Starting dynamic subtest: pipe-C
[582.636422] Dynamic subtest pipe-C: SUCCESS (0.155s)
[582.654546] Starting dynamic subtest: pipe-D
[582.794233] Dynamic subtest pipe-D: SUCCESS (0.157s)
[582.795180] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.580s)
[583.015691] [133/156] (504s left) syncobj_wait (single-wait-for-submit-signaled)
[583.064249] Starting subtest: single-wait-for-submit-signaled
[583.065200] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[583.224367] [134/156] (504s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[584.720100] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[584.722099] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[584.917950] [135/156] (503s left) gem_flink_basic (basic)
[584.969540] Starting subtest: basic
[584.970503] Subtest basic: SUCCESS (0.000s)
[585.138533] [136/156] (502s left) gem_workarounds (reset-context)
[585.211990] Starting subtest: reset-context
[585.346109] Subtest reset-context: SUCCESS (0.133s)
[585.522972] [137/156] (502s left) kms_flip (plain-flip-interruptible)
[587.021159] Starting subtest: plain-flip-interruptible
[587.028721] Starting dynamic subtest: A-HDMI-A3
[587.760443] Dynamic subtest A-HDMI-A3: SUCCESS (0.733s)
[587.780948] Starting dynamic subtest: B-HDMI-A3
[588.440350] Dynamic subtest B-HDMI-A3: SUCCESS (0.676s)
[588.489504] Starting dynamic subtest: C-HDMI-A3
[589.151669] Dynamic subtest C-HDMI-A3: SUCCESS (0.701s)
[589.172033] Starting dynamic subtest: D-HDMI-A3
[589.845112] Dynamic subtest D-HDMI-A3: SUCCESS (0.688s)
[589.855334] Subtest plain-flip-interruptible: SUCCESS (2.835s)
[590.126476] [138/156] (498s left) sysfs_heartbeat_interval (nopreempt)
[590.180477] Starting subtest: nopreempt
[590.183191] Starting dynamic subtest: vecs0
[594.135260] Dynamic subtest vecs0: SUCCESS (3.953s)
[594.153277] Starting dynamic subtest: vcs0
[598.060441] Dynamic subtest vcs0: SUCCESS (3.923s)
[598.077832] Starting dynamic subtest: bcs0
[601.969093] Dynamic subtest bcs0: SUCCESS (3.907s)
[601.987104] Starting dynamic subtest: rcs0
[605.994348] Dynamic subtest rcs0: SUCCESS (4.023s)
[606.012800] Starting dynamic subtest: vcs1
[609.917459] Dynamic subtest vcs1: SUCCESS (3.922s)
[609.918373] Subtest nopreempt: SUCCESS (19.738s)
[610.090067] [139/156] (478s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[611.581474] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[611.582485] Starting dynamic subtest: pipe-A-HDMI-A-3
[611.591909] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[611.608619] Starting dynamic subtest: pipe-B-HDMI-A-3
[611.617982] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[611.634197] Starting dynamic subtest: pipe-C-HDMI-A-3
[611.643896] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[611.659810] Starting dynamic subtest: pipe-D-HDMI-A-3
[611.670081] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[611.672415] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.014s)
[611.871009] [140/156] (476s left) perf_pmu (busy-accuracy-2)
[611.922802] Starting subtest: busy-accuracy-2
[611.923817] Starting dynamic subtest: rcs0
[614.979500] Dynamic subtest rcs0: SUCCESS (3.055s)
[614.995889] Starting dynamic subtest: bcs0
[618.038279] Dynamic subtest bcs0: SUCCESS (3.057s)
[618.055163] Starting dynamic subtest: vcs0
[621.093450] Dynamic subtest vcs0: SUCCESS (3.054s)
[621.109825] Starting dynamic subtest: vcs1
[624.149364] Dynamic subtest vcs1: SUCCESS (3.054s)
[624.166952] Starting dynamic subtest: vecs0
[627.207378] Dynamic subtest vecs0: SUCCESS (3.056s)
[627.208284] Subtest busy-accuracy-2: SUCCESS (15.285s)
[627.376245] [141/156] (461s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[628.866449] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[628.867443] Starting dynamic subtest: pipe-A-HDMI-A-3
[628.877044] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[628.893625] Starting dynamic subtest: pipe-B-HDMI-A-3
[628.902857] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[628.918842] Starting dynamic subtest: pipe-C-HDMI-A-3
[628.928404] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[628.944541] Starting dynamic subtest: pipe-D-HDMI-A-3
[628.955627] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[628.957921] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[629.146995] [142/156] (459s left) kms_psr (fbc-pr-sprite-plane-move)
[630.635361] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[630.723510] [143/156] (457s left) gem_close (many-handles-one-vma)
[630.776413] Starting subtest: many-handles-one-vma
[630.814866] Subtest many-handles-one-vma: SUCCESS (0.038s)
[631.042258] [144/156] (457s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[632.536418] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[632.538214] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[632.749574] [145/156] (456s left) syncobj_wait (multi-wait-signaled)
[632.797661] Starting subtest: multi-wait-signaled
[632.798594] Subtest multi-wait-signaled: SUCCESS (0.000s)
[633.008850] [146/156] (456s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-render)
[634.503856] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-render
[634.505796] Subtest hdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[634.697546] [147/156] (454s left) i915_query (query-topology-kernel-writes)
[634.744668] Starting subtest: query-topology-kernel-writes
[634.745553] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[634.884009] [148/156] (454s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[636.380523] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[636.385548] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[636.560513] [149/156] (452s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[638.086299] Starting subtest: y-tiled-16bpp-rotate-90
[639.876580] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.787s)
[640.067929] [150/156] (449s left) gem_render_copy (y-tiled)
[640.122493] Starting subtest: y-tiled
[640.123491] Starting dynamic subtest: smem
[640.215507] Dynamic subtest smem: SUCCESS (0.092s)
[640.233534] Starting dynamic subtest: lmem0
[640.977825] Dynamic subtest lmem0: SUCCESS (0.757s)
[640.979188] Subtest y-tiled: SUCCESS (0.853s)
[641.247878] [151/156] (448s left) kms_atomic_transition (modeset-transition-nonblocking)
[642.738369] Starting subtest: modeset-transition-nonblocking
[642.739256] Starting dynamic subtest: 1x-outputs
[644.903037] Dynamic subtest 1x-outputs: SUCCESS (2.160s)
[644.903981] Subtest modeset-transition-nonblocking: SUCCESS (2.165s)
[645.114075] [152/156] (444s left) kms_psr (psr-sprite-plane-onoff)
[646.602521] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[646.697887] [153/156] (442s left) gem_ppgtt (blt-vs-render-ctx0)
[646.752846] Starting subtest: blt-vs-render-ctx0
[679.387737] Subtest blt-vs-render-ctx0: SUCCESS (32.631s)
[679.629013] [154/156] (410s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[681.195949] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[681.197865] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[681.388883] [155/156] (408s left) gem_exec_fence (submit)
[681.612119] Starting subtest: submit
[681.614523] Subtest submit: SKIP (0.000s)
[682.294349] [156/156] (407s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[683.788872] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[683.791304] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[683.969660] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_chamelium_frames
results: parsing output: 2/ for test: kms_color_pipeline
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: gem_exec_nop
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_fbcon_fbt
results: parsing output: 17/ for test: kms_feature_discovery
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_alpha_blend
results: parsing output: 23/ for test: kms_getfb
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_dp_linktrain_fallback
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gem_ppgtt
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_hdmi_inject
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_flush
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: syncobj_basic
results: parsing output: 47/ for test: gem_ctx_shared
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_prime
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: gem_basic
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_create
results: parsing output: 57/ for test: kms_plane_multiple
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: i915_hangman
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_capture
results: parsing output: 67/ for test: core_sysfs
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: gem_lmem_swapping
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_exec_parallel
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: i915_pm_rpm
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_properties
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: i915_query
results: parsing output: 100/ for test: gem_exec_whisper
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: kms_invalid_mode
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: gem_softpin
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_busy
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: gem_partial_pwrite_pread
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_getfb
results: parsing output: 125/ for test: kms_chamelium_audio
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: prime_busy
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_selftest
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: syncobj_wait
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_flink_basic
results: parsing output: 135/ for test: gem_workarounds
results: parsing output: 136/ for test: kms_flip
results: parsing output: 137/ for test: sysfs_heartbeat_interval
results: parsing output: 138/ for test: kms_ccs
results: parsing output: 139/ for test: perf_pmu
results: parsing output: 140/ for test: kms_ccs
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: gem_close
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: syncobj_wait
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: i915_query
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_big_fb
results: parsing output: 149/ for test: gem_render_copy
results: parsing output: 150/ for test: kms_atomic_transition
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: gem_ppgtt
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_exec_fence
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.