[66.950690] Initializing watchdogs
[66.950773]   /dev/watchdog0
[66.981873] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[66.996940] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.002150] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.005615] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[68.770937] Starting subtest: cursor-offscreen-256x85
[68.787607] Starting dynamic subtest: pipe-A-HDMI-A-4
[71.376533] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.579s)
[71.410195] Starting dynamic subtest: pipe-D-HDMI-A-4
[73.864404] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.456s)
[73.865887] Subtest cursor-offscreen-256x85: SUCCESS (5.076s)
[74.173550] [002/133] (953s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[75.663459] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[75.665173] Starting dynamic subtest: pipe-A-HDMI-A-4
[75.711155] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[75.719792] Starting dynamic subtest: pipe-B-HDMI-A-4
[75.763238] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[75.771482] Starting dynamic subtest: pipe-C-HDMI-A-4
[75.809759] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[75.817971] Starting dynamic subtest: pipe-D-HDMI-A-4
[75.864437] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[75.868193] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.016s)
[75.936306] [003/133] (951s left) sysfs_timeslice_duration (duration)
[75.993310] Starting subtest: duration
[75.995089] Starting dynamic subtest: vecs0
[89.137108] Dynamic subtest vecs0: SUCCESS (13.132s)
[89.147905] Starting dynamic subtest: vcs0
[102.287521] Dynamic subtest vcs0: SUCCESS (13.143s)
[102.297134] Starting dynamic subtest: bcs0
[115.427417] Dynamic subtest bcs0: SUCCESS (13.136s)
[115.437254] Starting dynamic subtest: rcs0
[128.571830] Dynamic subtest rcs0: SUCCESS (13.142s)
[128.581386] Starting dynamic subtest: vcs1
[141.703866] Dynamic subtest vcs1: SUCCESS (13.130s)
[141.705332] Subtest duration: SUCCESS (65.687s)
[141.817983] [004/133] (885s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[143.305501] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[143.307146] Starting dynamic subtest: pipe-A-HDMI-A-4
[143.313597] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[143.322433] Starting dynamic subtest: pipe-B-HDMI-A-4
[143.328951] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[143.337395] Starting dynamic subtest: pipe-C-HDMI-A-4
[143.343647] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[143.351579] Starting dynamic subtest: pipe-D-HDMI-A-4
[143.356580] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[143.359103] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[143.543293] [005/133] (884s left) drm_buddy (drm_buddy)
[143.627932] Starting subtest: drm_buddy
[143.631215] Subtest drm_buddy: SKIP (0.001s)
[143.712184] [006/133] (884s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[145.221933] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[145.817928] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.596s)
[146.054793] [007/133] (881s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[147.542507] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[147.544094] Starting dynamic subtest: pipe-A-HDMI-A-4
[147.561557] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[147.570301] Starting dynamic subtest: pipe-B-HDMI-A-4
[147.590275] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[147.598990] Starting dynamic subtest: pipe-C-HDMI-A-4
[147.617313] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[147.626170] Starting dynamic subtest: pipe-D-HDMI-A-4
[147.648229] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[147.651785] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[147.789670] [008/133] (880s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[149.278418] Starting subtest: bad-pixel-format-yf-tiled-ccs
[149.280023] Starting dynamic subtest: pipe-A-HDMI-A-4
[149.295816] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[149.304845] Starting dynamic subtest: pipe-B-HDMI-A-4
[149.321199] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[149.329739] Starting dynamic subtest: pipe-C-HDMI-A-4
[149.346120] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[149.354741] Starting dynamic subtest: pipe-D-HDMI-A-4
[149.371604] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[149.376667] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.006s)
[149.525866] [009/133] (878s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[149.576884] Starting subtest: multi-wait-available-unsubmitted-submitted
[149.578512] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[149.709704] [010/133] (878s left) perf_pmu (event-wait)
[149.759715] Starting subtest: event-wait
[149.761157] Starting dynamic subtest: rcs0
[149.764054] Dynamic subtest rcs0: SKIP (0.000s)
[149.767245] Subtest event-wait: SKIP (0.000s)
[149.883772] [011/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[151.378583] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[151.381524] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[151.495329] [012/133] (876s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[153.000813] Starting subtest: psr-rgb565-draw-mmap-gtt
[153.003561] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[153.169095] [013/133] (875s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[154.667780] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[154.745419] [014/133] (873s left) kms_psr (fbc-psr2-dpms)
[156.233423] Subtest fbc-psr2-dpms: SKIP (0.000s)
[156.310971] [015/133] (872s left) gem_exec_balancer (parallel-ordering)
[156.729112] Starting subtest: parallel-ordering
[158.884636] Subtest parallel-ordering: SUCCESS (2.156s)
[159.017398] [016/133] (869s left) kms_joiner (basic-big-joiner)
[160.507833] Starting subtest: basic-big-joiner
[160.511194] Subtest basic-big-joiner: SKIP (0.000s)
[160.616632] [017/133] (868s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[162.110657] Starting subtest: flip-vs-cursor-crc-atomic
[162.660977] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.551s)
[162.835530] [018/133] (865s left) gem_wait (wait)
[162.898181] Starting subtest: wait
[162.899725] Starting dynamic subtest: all-engines
[163.977715] Dynamic subtest all-engines: SUCCESS (1.079s)
[163.989216] Starting dynamic subtest: rcs0
[165.033561] Dynamic subtest rcs0: SUCCESS (1.055s)
[165.044663] Starting dynamic subtest: bcs0
[166.088566] Dynamic subtest bcs0: SUCCESS (1.055s)
[166.102609] Starting dynamic subtest: vcs0
[167.143551] Dynamic subtest vcs0: SUCCESS (1.055s)
[167.157584] Starting dynamic subtest: vcs1
[168.198580] Dynamic subtest vcs1: SUCCESS (1.055s)
[168.212807] Starting dynamic subtest: vecs0
[169.253622] Dynamic subtest vecs0: SUCCESS (1.055s)
[169.255344] Subtest wait: SUCCESS (6.356s)
[169.536436] [019/133] (859s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[171.030588] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[171.033723] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[171.230944] [020/133] (857s left) kms_flip (2x-flip-vs-expired-vblank)
[172.719911] Starting subtest: 2x-flip-vs-expired-vblank
[172.736044] Subtest 2x-flip-vs-expired-vblank: SKIP (0.017s)
[172.868809] [021/133] (856s left) kms_lease (page-flip-implicit-plane)
[174.366446] Starting subtest: page-flip-implicit-plane
[174.367975] Starting dynamic subtest: pipe-A-HDMI-A-4
[174.795040] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.427s)
[174.804471] Starting dynamic subtest: pipe-B-HDMI-A-4
[175.040402] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.245s)
[175.049987] Starting dynamic subtest: pipe-C-HDMI-A-4
[175.325667] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.283s)
[175.334677] Starting dynamic subtest: pipe-D-HDMI-A-4
[175.581736] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.255s)
[175.583360] Subtest page-flip-implicit-plane: SUCCESS (1.216s)
[175.774436] [022/133] (853s left) gem_exec_params (rsvd2-dirt)
[175.826999] Starting subtest: rsvd2-dirt
[175.832923] Subtest rsvd2-dirt: SKIP (0.000s)
[175.975062] [023/133] (853s left) api_intel_bb (blit-reloc-purge-cache)
[176.022729] Starting subtest: blit-reloc-purge-cache
[176.026220] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[176.172594] [024/133] (853s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[177.664820] Starting subtest: fbc-shrfb-scaledprimary
[181.299246] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.635s)
[181.484441] [025/133] (847s left) i915_pm_rpm (gem-idle)
[184.995368] Starting subtest: gem-idle
[191.075813] Subtest gem-idle: SUCCESS (6.080s)
[191.931666] [026/133] (837s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[193.444816] Starting subtest: x-tiled-8bpp-rotate-0
[195.126442] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.679s)
[195.308229] [027/133] (834s left) gem_exec_schedule (preempt-contexts)
[195.391966] Starting subtest: preempt-contexts
[195.393454] Starting dynamic subtest: rcs0
[195.483724] Dynamic subtest rcs0: SUCCESS (0.092s)
[195.492703] Starting dynamic subtest: bcs0
[195.554725] Dynamic subtest bcs0: SUCCESS (0.071s)
[195.564073] Starting dynamic subtest: vcs0
[195.625453] Dynamic subtest vcs0: SUCCESS (0.070s)
[195.634757] Starting dynamic subtest: vcs1
[195.696913] Dynamic subtest vcs1: SUCCESS (0.071s)
[195.706444] Starting dynamic subtest: vecs0
[195.767794] Dynamic subtest vecs0: SUCCESS (0.070s)
[195.769672] Subtest preempt-contexts: SUCCESS (0.376s)
[196.215843] [028/133] (833s left) gem_exec_flush (basic-uc-rw-default)
[196.268973] Subtest basic-uc-rw-default: SKIP (0.000s)
[196.366754] [029/133] (833s left) kms_color_pipeline (plane-lut1d)
[197.857750] Starting subtest: plane-lut1d
[198.057037] Starting dynamic subtest: pipe-A-plane-0
[198.306977] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s)
[198.343075] Starting dynamic subtest: pipe-A-plane-1
[198.523699] Dynamic subtest pipe-A-plane-1: SUCCESS (0.215s)
[198.546022] Starting dynamic subtest: pipe-A-plane-2
[198.707182] Dynamic subtest pipe-A-plane-2: SUCCESS (0.182s)
[198.998183] Starting dynamic subtest: pipe-B-plane-0
[199.170453] Dynamic subtest pipe-B-plane-0: SUCCESS (0.183s)
[199.194831] Starting dynamic subtest: pipe-B-plane-1
[199.353709] Dynamic subtest pipe-B-plane-1: SUCCESS (0.181s)
[199.382387] Starting dynamic subtest: pipe-B-plane-2
[199.570540] Dynamic subtest pipe-B-plane-2: SUCCESS (0.215s)
[199.836898] Starting dynamic subtest: pipe-C-plane-0
[200.013697] Dynamic subtest pipe-C-plane-0: SUCCESS (0.184s)
[200.045501] Starting dynamic subtest: pipe-C-plane-1
[200.230482] Dynamic subtest pipe-C-plane-1: SUCCESS (0.215s)
[200.254873] Starting dynamic subtest: pipe-C-plane-2
[200.430610] Dynamic subtest pipe-C-plane-2: SUCCESS (0.198s)
[200.754198] Starting dynamic subtest: pipe-D-plane-0
[200.931259] Dynamic subtest pipe-D-plane-0: SUCCESS (0.199s)
[200.958311] Starting dynamic subtest: pipe-D-plane-1
[201.147957] Dynamic subtest pipe-D-plane-1: SUCCESS (0.214s)
[201.177178] Starting dynamic subtest: pipe-D-plane-2
[201.364642] Dynamic subtest pipe-D-plane-2: SUCCESS (0.214s)
[201.420475] Subtest plane-lut1d: SUCCESS (3.563s)
[201.592698] [030/133] (828s left) gem_exec_schedule (deep)
[201.785306] Starting subtest: deep
[201.786781] Starting dynamic subtest: rcs0
[217.761161] Dynamic subtest rcs0: SUCCESS (15.971s)
[217.772636] Starting dynamic subtest: bcs0
[233.845193] Dynamic subtest bcs0: SUCCESS (16.080s)
[233.854907] Starting dynamic subtest: vcs0
[250.103521] Dynamic subtest vcs0: SUCCESS (16.257s)
[250.113326] Starting dynamic subtest: vcs1
[266.580108] Dynamic subtest vcs1: SUCCESS (16.475s)
[266.589690] Starting dynamic subtest: vecs0
[282.698176] Dynamic subtest vecs0: SUCCESS (16.118s)
[282.699648] Subtest deep: SUCCESS (80.907s)
[283.547672] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[283.550302] [031/133] (746s left) kms_cursor_crc (cursor-suspend)
[285.099128] Starting subtest: cursor-suspend
[285.100778] Starting dynamic subtest: pipe-A-HDMI-A-4
[328.595183] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (20.686s)
[328.606460] Starting dynamic subtest: pipe-D-HDMI-A-4
[371.574717] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (20.183s)
[371.576280] Subtest cursor-suspend: SUCCESS (40.872s)
[376.185955] [032/133] (657s left) perf (gen8-unprivileged-single-ctx-counters)
[376.314685] Starting subtest: gen8-unprivileged-single-ctx-counters
[376.317901] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[376.393472] [033/133] (657s left) api_intel_bb (intel-bb-blit-y)
[376.441940] Starting subtest: intel-bb-blit-y
[378.005878] Subtest intel-bb-blit-y: SUCCESS (1.564s)
[378.182876] [034/133] (655s left) prime_mmap (test_refcounting)
[378.230819] Starting subtest: test_refcounting
[378.232082] Starting dynamic subtest: test_refcounting-smem
[378.293437] Dynamic subtest test_refcounting-smem: SUCCESS (0.063s)
[378.304506] Starting dynamic subtest: test_refcounting-lmem0
[378.357813] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.064s)
[378.359097] Subtest test_refcounting: SUCCESS (0.128s)
[378.511788] [035/133] (655s left) kms_atomic_transition (modeset-transition)
[379.998388] Starting subtest: modeset-transition
[380.000054] Starting dynamic subtest: 1x-outputs
[381.983967] Dynamic subtest 1x-outputs: SUCCESS (1.986s)
[381.985797] Subtest modeset-transition: SUCCESS (1.986s)
[382.162314] [036/133] (651s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[383.649940] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[383.651223] Starting dynamic subtest: pipe-A
[384.478850] Dynamic subtest pipe-A: SUCCESS (0.820s)
[384.492257] Starting dynamic subtest: pipe-B
[385.225661] Dynamic subtest pipe-B: SUCCESS (0.756s)
[385.238960] Starting dynamic subtest: pipe-C
[385.983886] Dynamic subtest pipe-C: SUCCESS (0.757s)
[385.997380] Starting dynamic subtest: pipe-D
[386.740534] Dynamic subtest pipe-D: SUCCESS (0.756s)
[386.742228] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.092s)
[386.914555] [037/133] (647s left) kms_frontbuffer_tracking (fbc-suspend)
[388.411004] Starting subtest: fbc-suspend
[433.764371] Subtest fbc-suspend: SUCCESS (23.394s)
[437.003190] [038/133] (600s left) gem_pxp (display-protected-crc)
[439.574663] Starting subtest: display-protected-crc
[439.577420] Subtest display-protected-crc: SKIP (0.000s)
[439.689315] [039/133] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[441.183580] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[441.187216] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[441.349451] [040/133] (596s left) gem_userptr_blits (dmabuf-unsync)
[441.410711] Subtest dmabuf-unsync: SKIP (0.000s)
[441.613950] [041/133] (595s left) gem_eio (context-create)
[441.802809] Starting subtest: context-create
[442.087151] Subtest context-create: SUCCESS (0.284s)
[443.670714] [042/133] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[445.171790] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[445.175322] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[445.329178] [043/133] (592s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[446.828096] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[446.831441] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[447.018471] [044/133] (590s left) kms_selftest (drm_dp_mst_helper)
[447.068660] Starting subtest: drm_dp_mst_helper
[447.141936] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[447.191115] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.072s)
[447.212962] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[447.309267] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.118s)
[447.341774] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[447.401501] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.087s)
[447.403340] Subtest drm_dp_mst_helper: SUCCESS (0.332s)
[447.657837] [045/133] (590s left) gem_spin_batch (resubmit-new)
[447.716997] Starting subtest: resubmit-new
[447.718454] Starting dynamic subtest: rcs0
[447.737057] Dynamic subtest rcs0: SUCCESS (0.021s)
[447.749529] Starting dynamic subtest: bcs0
[447.750991] Dynamic subtest bcs0: SUCCESS (0.005s)
[447.763358] Starting dynamic subtest: vcs0
[447.764894] Dynamic subtest vcs0: SUCCESS (0.005s)
[447.776905] Starting dynamic subtest: vcs1
[447.778544] Dynamic subtest vcs1: SUCCESS (0.006s)
[447.790298] Starting dynamic subtest: vecs0
[447.791866] Dynamic subtest vecs0: SUCCESS (0.005s)
[447.793486] Subtest resubmit-new: SUCCESS (0.047s)
[448.070052] [046/133] (590s left) testdisplay
[454.400325] [047/133] (583s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[455.906506] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[455.979273] [048/133] (582s left) i915_selftest (live)
[456.929021] Starting subtest: live
[456.930742] Starting dynamic subtest: sanitycheck
[458.319183] Dynamic subtest sanitycheck: SUCCESS (1.390s)
[458.329019] Starting dynamic subtest: uncore
[459.690731] Dynamic subtest uncore: SUCCESS (1.370s)
[459.700676] Starting dynamic subtest: workarounds
[463.038378] Dynamic subtest workarounds: SUCCESS (3.340s)
[463.060188] Starting dynamic subtest: gt_engines
[464.993461] Dynamic subtest gt_engines: SUCCESS (1.960s)
[465.003282] Starting dynamic subtest: gt_timelines
[531.557388] Dynamic subtest gt_timelines: SUCCESS (66.563s)
[531.567475] Starting dynamic subtest: gt_contexts
[532.982654] Dynamic subtest gt_contexts: SUCCESS (1.424s)
[532.992723] Starting dynamic subtest: gt_lrc
[539.249446] Dynamic subtest gt_lrc: SUCCESS (6.263s)
[539.259987] Starting dynamic subtest: gt_mocs
[541.526461] Dynamic subtest gt_mocs: SUCCESS (2.276s)
[541.536733] Starting dynamic subtest: gt_pm
[545.503262] Dynamic subtest gt_pm: SUCCESS (3.976s)
[545.513785] Starting dynamic subtest: gt_heartbeat
[546.919074] Dynamic subtest gt_heartbeat: SUCCESS (1.415s)
[546.928940] Starting dynamic subtest: gt_tlb
[560.694614] Dynamic subtest gt_tlb: SUCCESS (13.775s)
[560.704995] Starting dynamic subtest: requests
[571.602739] Dynamic subtest requests: SUCCESS (10.906s)
[571.613339] Starting dynamic subtest: migrate
[576.198249] Dynamic subtest migrate: SUCCESS (4.594s)
[576.208554] Starting dynamic subtest: active
[577.586076] Dynamic subtest active: SUCCESS (1.387s)
[577.596287] Starting dynamic subtest: objects
[579.905315] Dynamic subtest objects: SUCCESS (2.317s)
[579.915102] Starting dynamic subtest: mman
[583.423396] Dynamic subtest mman: SUCCESS (3.516s)
[583.434078] Starting dynamic subtest: dmabuf
[584.929378] Dynamic subtest dmabuf: SUCCESS (1.505s)
[584.939370] Starting dynamic subtest: vma
[586.339363] Dynamic subtest vma: SUCCESS (1.408s)
[586.350624] Starting dynamic subtest: coherency
[596.404351] Dynamic subtest coherency: SUCCESS (10.063s)
[596.414837] Starting dynamic subtest: gtt
[605.387802] Dynamic subtest gtt: SUCCESS (8.982s)
[605.399080] Starting dynamic subtest: gem
[606.955076] Dynamic subtest gem: SUCCESS (1.566s)
[606.964911] Starting dynamic subtest: evict
[618.486983] Dynamic subtest evict: SUCCESS (11.530s)
[618.497195] Starting dynamic subtest: hugepages
[635.630206] Dynamic subtest hugepages: SUCCESS (17.142s)
[635.640406] Starting dynamic subtest: gem_contexts
[663.165105] Dynamic subtest gem_contexts: SUCCESS (27.533s)
[663.174722] Starting dynamic subtest: client
[664.627439] Dynamic subtest client: SUCCESS (1.461s)
[664.637352] Starting dynamic subtest: gem_migrate
[667.190309] Dynamic subtest gem_migrate: SUCCESS (2.561s)
[667.200815] Starting dynamic subtest: reset
[668.625385] Dynamic subtest reset: SUCCESS (1.434s)
[668.635777] Starting dynamic subtest: memory_region
[671.666127] Dynamic subtest memory_region: SUCCESS (3.039s)
[671.675847] Starting dynamic subtest: hangcheck
[700.844491] Dynamic subtest hangcheck: SUCCESS (29.178s)
[700.854789] Starting dynamic subtest: execlists
[702.264357] Dynamic subtest execlists: SUCCESS (1.418s)
[702.274889] Starting dynamic subtest: ring_submission
[703.654394] Dynamic subtest ring_submission: SUCCESS (1.388s)
[703.665444] Starting dynamic subtest: perf
[705.139114] Dynamic subtest perf: SUCCESS (1.484s)
[705.149784] Starting dynamic subtest: slpc
[711.059210] Dynamic subtest slpc: SUCCESS (5.919s)
[711.069802] Starting dynamic subtest: guc
[714.521477] Dynamic subtest guc: SUCCESS (3.461s)
[714.531729] Starting dynamic subtest: guc_multi_lrc
[715.950256] Dynamic subtest guc_multi_lrc: SUCCESS (1.427s)
[715.960527] Starting dynamic subtest: guc_hang
[718.126263] Dynamic subtest guc_hang: SUCCESS (2.174s)
[718.136357] Starting dynamic subtest: late_gt_pm
[719.539973] Dynamic subtest late_gt_pm: SUCCESS (1.416s)
[719.541408] Subtest live: SUCCESS (262.613s)
[719.585609] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[719.587004] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[719.589865] [049/133] (318s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[722.929170] Subtest writes-after-reads-uncached: SKIP (0.000s)
[723.019725] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[723.023208] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[723.036789] [050/133] (315s left) kms_getfb (getfb-handle-not-fb)
[724.529526] Starting subtest: getfb-handle-not-fb
[724.530901] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[724.704807] [051/133] (313s left) kms_psr (fbc-psr-sprite-plane-onoff)
[726.194365] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[726.282418] [052/133] (312s left) i915_hangman (gt-error-state-capture)
[726.407469] Starting subtest: gt-error-state-capture
[726.409113] Starting dynamic subtest: rcs0
[736.583597] Dynamic subtest rcs0: SUCCESS (10.176s)
[736.599262] Starting dynamic subtest: bcs0
[746.592660] Dynamic subtest bcs0: SUCCESS (10.007s)
[746.609553] Starting dynamic subtest: vcs0
[756.578668] Dynamic subtest vcs0: SUCCESS (9.984s)
[756.591935] Starting dynamic subtest: vcs1
[766.562001] Dynamic subtest vcs1: SUCCESS (9.981s)
[766.577074] Starting dynamic subtest: vecs0
[776.541696] Dynamic subtest vecs0: SUCCESS (9.978s)
[776.543470] Subtest gt-error-state-capture: SUCCESS (50.135s)
[776.745865] [053/133] (261s left) perf (invalid-open-flags)
[776.879854] Starting subtest: invalid-open-flags
[776.881175] Subtest invalid-open-flags: SUCCESS (0.000s)
[776.963698] [054/133] (261s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[778.463115] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[778.466882] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[778.639800] [055/133] (260s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[780.132499] Starting subtest: async-flip-with-page-flip-events-linear
[780.384825] Starting dynamic subtest: pipe-A-HDMI-A-4
[782.696823] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.308s)
[782.908831] Starting dynamic subtest: pipe-B-HDMI-A-4
[784.950832] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.052s)
[785.135825] Starting dynamic subtest: pipe-C-HDMI-A-4
[787.187190] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.059s)
[787.363796] Starting dynamic subtest: pipe-D-HDMI-A-4
[789.413675] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.057s)
[789.415489] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.281s)
[789.755613] [056/133] (249s left) sw_sync (alloc_fence)
[789.800663] Starting subtest: alloc_fence
[789.802236] Subtest alloc_fence: SUCCESS (0.000s)
[789.944422] [057/133] (249s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[791.432026] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[791.433547] Starting dynamic subtest: pipe-A-valid-mode
[792.660814] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.229s)
[792.662283] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.232s)
[792.846356] [058/133] (246s left) gem_ctx_persistence (heartbeat-close)
[792.899405] Starting subtest: heartbeat-close
[792.902550] Subtest heartbeat-close: SKIP (0.000s)
[793.030372] [059/133] (246s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[794.536943] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[794.539967] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[794.687511] [060/133] (244s left) kms_flip (2x-flip-vs-modeset)
[796.179788] Starting subtest: 2x-flip-vs-modeset
[796.198064] Subtest 2x-flip-vs-modeset: SKIP (0.017s)
[796.353029] [061/133] (243s left) sw_sync (alloc_timeline)
[796.400206] Starting subtest: alloc_timeline
[796.401730] Subtest alloc_timeline: SUCCESS (0.000s)
[796.502221] [062/133] (242s left) gem_exec_fence (syncobj-timeline-chain-engines)
[797.039024] Starting subtest: syncobj-timeline-chain-engines
[797.175604] Subtest syncobj-timeline-chain-engines: SUCCESS (0.137s)
[797.506350] [063/133] (242s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[798.994424] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[799.026926] Starting dynamic subtest: pipe-A-plane-0
[799.544612] Dynamic subtest pipe-A-plane-0: SUCCESS (0.516s)
[799.594213] Starting dynamic subtest: pipe-A-plane-3
[799.860116] Dynamic subtest pipe-A-plane-3: SUCCESS (0.309s)
[799.904269] Starting dynamic subtest: pipe-A-plane-5
[800.193547] Dynamic subtest pipe-A-plane-5: SUCCESS (0.328s)
[800.341603] Starting dynamic subtest: pipe-B-plane-0
[800.730094] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[800.781131] Starting dynamic subtest: pipe-B-plane-3
[801.063463] Dynamic subtest pipe-B-plane-3: SUCCESS (0.328s)
[801.080338] Starting dynamic subtest: pipe-B-plane-5
[801.413557] Dynamic subtest pipe-B-plane-5: SUCCESS (0.346s)
[801.487674] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.495s)
[801.671198] [064/133] (237s left) perf_pmu (all-busy-check-all)
[801.744934] Starting subtest: all-busy-check-all
[802.316006] Subtest all-busy-check-all: SUCCESS (0.574s)
[802.460719] [065/133] (237s left) kms_chamelium_frames (hdmi-crc-single)
[803.993895] Subtest hdmi-crc-single: SKIP (0.000s)
[804.111871] [066/133] (235s left) kms_draw_crc (draw-method-mmap-wc)
[805.602146] Starting subtest: draw-method-mmap-wc
[805.605260] Subtest draw-method-mmap-wc: SKIP (0.000s)
[805.794502] [067/133] (234s left) kms_content_protection (atomic)
[807.340789] Starting subtest: atomic
[807.352955] Subtest atomic: SKIP (0.006s)
[807.535103] [068/133] (232s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[809.026027] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[809.027509] Starting dynamic subtest: pipe-A-HDMI-A-4
[809.042246] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[809.055939] Starting dynamic subtest: pipe-B-HDMI-A-4
[809.070733] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[809.084003] Starting dynamic subtest: pipe-C-HDMI-A-4
[809.099088] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[809.112368] Starting dynamic subtest: pipe-D-HDMI-A-4
[809.128482] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[809.131592] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.011s)
[809.292541] [069/133] (230s left) kms_psr (pr-primary-render)
[810.784915] Subtest pr-primary-render: SKIP (0.000s)
[810.871508] [070/133] (229s left) gem_exec_flush (basic-uc-ro-default)
[810.925931] Subtest basic-uc-ro-default: SKIP (0.000s)
[811.021210] [071/133] (229s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[812.506621] Starting subtest: fb-8bpc-vs-panel-8bpc
[812.511346] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.001s)
[812.639331] [072/133] (227s left) gem_madvise (dontneed-after-mmap)
[812.696061] Starting subtest: dontneed-after-mmap
[812.699497] Subtest dontneed-after-mmap: SUCCESS (0.004s)
[812.880227] [073/133] (227s left) kms_plane_alpha_blend (constant-alpha-mid)
[814.364728] Starting subtest: constant-alpha-mid
[814.632774] Starting dynamic subtest: pipe-A-HDMI-A-4
[815.328427] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.696s)
[815.343835] Starting dynamic subtest: pipe-D-HDMI-A-4
[816.032926] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.702s)
[816.034513] Subtest constant-alpha-mid: SUCCESS (1.669s)
[816.231677] [074/133] (224s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[816.283129] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[816.358304] [075/133] (224s left) kms_flip (2x-flip-vs-wf_vblank)
[817.846213] Starting subtest: 2x-flip-vs-wf_vblank
[817.863710] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s)
[817.989424] [076/133] (222s left) kms_cursor_crc (cursor-sliding-128x42)
[819.680114] Starting subtest: cursor-sliding-128x42
[819.687544] Starting dynamic subtest: pipe-A-HDMI-A-4
[824.115835] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.429s)
[824.154155] Starting dynamic subtest: pipe-D-HDMI-A-4
[828.466174] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.323s)
[828.467986] Subtest cursor-sliding-128x42: SUCCESS (8.785s)
[828.839338] [077/133] (211s left) kms_psr (psr2-suspend)
[830.327773] Subtest psr2-suspend: SKIP (0.000s)
[830.417663] [078/133] (210s left) gem_mmap_offset (open-flood)
[830.464540] Starting subtest: open-flood
[851.951310] Subtest open-flood: SUCCESS (21.486s)
[852.113405] [079/133] (188s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[853.609322] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[853.612431] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[853.774657] [080/133] (187s left) gem_exec_nop (basic-sequential)
[853.840353] Starting subtest: basic-sequential
[857.574756] Subtest basic-sequential: SUCCESS (3.737s)
[857.862859] [081/133] (183s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[859.349898] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[859.353023] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[859.458619] [082/133] (181s left) gem_mmap_gtt (basic-small-bo-tiledy)
[859.510665] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[859.585196] [083/133] (181s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[861.092772] Starting subtest: y-tiled-64bpp-rotate-90
[861.162394] Subtest y-tiled-64bpp-rotate-90: SKIP (0.068s)
[861.359178] [084/133] (179s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[862.852522] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[862.855678] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[863.033979] [085/133] (178s left) gem_exec_alignment (single)
[863.089804] Starting subtest: single
[863.097114] Subtest single: SUCCESS (0.007s)
[863.267361] [086/133] (178s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[864.763156] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[864.766728] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[864.923282] [087/133] (176s left) syncobj_timeline (etime-single-wait-submitted)
[864.974179] Starting subtest: etime-single-wait-submitted
[865.085674] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[865.247996] [088/133] (176s left) i915_drm_fdinfo (virtual-busy-all)
[865.299094] Starting subtest: virtual-busy-all
[865.301726] Subtest virtual-busy-all: SKIP (0.000s)
[865.407446] [089/133] (176s left) gem_ctx_exec (basic)
[865.455671] Starting subtest: basic
[865.461326] Subtest basic: SUCCESS (0.006s)
[865.667590] [090/133] (176s left) gem_busy (parallel)
[865.861484] Starting subtest: parallel
[865.862988] Starting dynamic subtest: rcs0
[865.966845] Dynamic subtest rcs0: SUCCESS (0.105s)
[865.990669] Starting dynamic subtest: bcs0
[866.034119] Dynamic subtest bcs0: SUCCESS (0.065s)
[866.065819] Starting dynamic subtest: vcs0
[866.103845] Dynamic subtest vcs0: SUCCESS (0.068s)
[866.126844] Starting dynamic subtest: vcs1
[866.168057] Dynamic subtest vcs1: SUCCESS (0.062s)
[866.204603] Starting dynamic subtest: vecs0
[866.245677] Dynamic subtest vecs0: SUCCESS (0.075s)
[866.247465] Subtest parallel: SUCCESS (0.385s)
[866.592392] [091/133] (175s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[866.638987] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[866.640571] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[866.777942] [092/133] (175s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[868.278537] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[868.280095] Starting dynamic subtest: pipe-A-valid-mode
[869.502485] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.220s)
[869.504061] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.222s)
[869.683034] [093/133] (172s left) kms_vblank (ts-continuation-dpms-rpm)
[871.173864] Starting subtest: ts-continuation-dpms-rpm
[871.175458] Starting dynamic subtest: pipe-A-HDMI-A-4
[873.571216] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.397s)
[873.589511] Starting dynamic subtest: pipe-D-HDMI-A-4
[875.603434] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.026s)
[875.605083] Subtest ts-continuation-dpms-rpm: SUCCESS (4.431s)
[875.784544] [094/133] (166s left) sw_sync (timeline_closed_signaled)
[875.829861] Starting subtest: timeline_closed_signaled
[875.831178] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[875.923467] [095/133] (166s left) gem_lmem_swapping (verify)
[880.151969] Starting subtest: verify
[880.153504] Starting dynamic subtest: lmem0
[920.897824] Dynamic subtest lmem0: SUCCESS (40.741s)
[920.899351] Subtest verify: SUCCESS (40.743s)
[922.261437] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[922.262575] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[922.265677] [096/133] (120s left) syncobj_wait (invalid-signal-zero-handles)
[925.590277] Starting subtest: invalid-signal-zero-handles
[925.594442] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[925.686490] [FACT syncobj_wait (invalid-signal-zero-handles)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[925.689956] [FACT syncobj_wait (invalid-signal-zero-handles)] new: kernel.kmod_is_loaded.i915: true
[925.693942] [097/133] (116s left) kms_pm_rpm (i2c)
[929.629650] Starting subtest: i2c
[933.315557] Subtest i2c: SUCCESS (3.691s)
[934.226904] [098/133] (108s left) vgem_basic (setversion)
[934.298355] Starting subtest: setversion
[934.302126] Subtest setversion: SUCCESS (0.000s)
[934.426609] [099/133] (108s left) gem_exec_reloc (basic-write-gtt)
[934.485306] Subtest basic-write-gtt: SKIP (0.000s)
[934.609294] [100/133] (108s left) kms_scaling_modes (scaling-mode-center)
[936.105858] Starting subtest: scaling-mode-center
[936.114998] Subtest scaling-mode-center: SKIP (0.002s)
[936.250481] [101/133] (106s left) perf_pmu (frequency)
[936.307906] Starting subtest: frequency
[936.312006] Starting dynamic subtest: gt0
[938.655932] Dynamic subtest gt0: FAIL (2.201s)
[938.698123] Starting dynamic subtest: idle-gt0
[939.027300] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[939.028907] Subtest frequency: FAIL (2.720s)
[939.186882] [102/133] (103s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[940.695060] Starting subtest: 4-tiled-32bpp-rotate-180
[940.698638] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[940.871235] [103/133] (102s left) kms_hdr (bpc-switch-dpms)
[942.365056] Starting subtest: bpc-switch-dpms
[942.369548] Subtest bpc-switch-dpms: SKIP (0.001s)
[942.497318] [104/133] (100s left) syncobj_timeline (wait-any-interrupted)
[942.558431] Starting subtest: wait-any-interrupted
[942.662957] Subtest wait-any-interrupted: SUCCESS (0.103s)
[942.809462] [105/133] (100s left) gem_exec_parallel (contexts)
[942.867667] Starting subtest: contexts
[942.869383] Starting dynamic subtest: rcs0
[947.175191] Dynamic subtest rcs0: SUCCESS (4.304s)
[947.188003] Starting dynamic subtest: bcs0
[951.414988] Dynamic subtest bcs0: SUCCESS (4.239s)
[951.427712] Starting dynamic subtest: vcs0
[956.305673] Dynamic subtest vcs0: SUCCESS (4.889s)
[956.321200] Starting dynamic subtest: vcs1
[961.272893] Dynamic subtest vcs1: SUCCESS (4.966s)
[961.285849] Starting dynamic subtest: vecs0
[965.191899] Dynamic subtest vecs0: SUCCESS (3.918s)
[965.193414] Subtest contexts: SUCCESS (22.323s)
[965.480342] [106/133] ( 77s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[968.053490] Starting subtest: verify-pxp-key-change-after-suspend-resume
[968.056567] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[968.191301] [107/133] ( 75s left) gem_create (create-ext-placement-each)
[968.375633] Starting subtest: create-ext-placement-each
[968.377312] Subtest create-ext-placement-each: SUCCESS (0.001s)
[968.539821] [108/133] ( 74s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[970.027725] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[970.029460] Starting dynamic subtest: pipe-A-HDMI-A-4
[970.042392] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[970.055281] Starting dynamic subtest: pipe-B-HDMI-A-4
[970.068373] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[970.080560] Starting dynamic subtest: pipe-C-HDMI-A-4
[970.093808] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[970.106262] Starting dynamic subtest: pipe-D-HDMI-A-4
[970.120323] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[970.123169] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.011s)
[970.291339] [109/133] ( 73s left) gem_close_race (basic-process)
[970.366243] Starting subtest: basic-process
[970.414737] Subtest basic-process: SUCCESS (0.048s)
[970.664410] [110/133] ( 72s left) gem_exec_schedule (u-independent)
[970.726519] Starting subtest: u-independent
[970.728158] Starting dynamic subtest: rcs0
[970.975855] Dynamic subtest rcs0: SUCCESS (0.250s)
[970.999417] Starting dynamic subtest: bcs0
[971.192640] Dynamic subtest bcs0: SUCCESS (0.215s)
[971.221519] Starting dynamic subtest: vcs0
[971.406838] Dynamic subtest vcs0: SUCCESS (0.212s)
[971.429996] Starting dynamic subtest: vcs1
[971.620641] Dynamic subtest vcs1: SUCCESS (0.212s)
[971.640010] Starting dynamic subtest: vecs0
[971.832708] Dynamic subtest vecs0: SUCCESS (0.210s)
[971.834509] Subtest u-independent: SUCCESS (1.109s)
[972.214329] [111/133] ( 71s left) gen9_exec_parse (batch-without-end)
[972.269303] Subtest batch-without-end: SKIP (0.000s)
[972.358073] [112/133] ( 71s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[976.609324] Starting subtest: dpms-mode-unset-lpsp
[977.588136] Subtest dpms-mode-unset-lpsp: SKIP (0.976s)
[978.643675] [113/133] ( 65s left) kms_chamelium_hpd (vga-hpd)
[980.177749] Subtest vga-hpd: SKIP (0.000s)
[980.296217] [114/133] ( 63s left) gem_lmem_swapping (heavy-multi)
[984.510737] Starting subtest: heavy-multi
[984.512255] Starting dynamic subtest: lmem0
[989.912883] Dynamic subtest lmem0: SUCCESS (5.398s)
[989.914493] Subtest heavy-multi: SUCCESS (5.400s)
[991.311600] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[991.312732] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[991.315904] [115/133] ( 52s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[996.104820] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[996.212977] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[996.216929] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)] new: kernel.kmod_is_loaded.i915: true
[996.221291] [116/133] ( 47s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[997.725842] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[997.729302] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[997.891608] [117/133] ( 46s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[999.389623] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1002.368093] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.981s)
[1002.595455] [118/133] ( 41s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1004.089300] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1004.091938] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[1004.247099] [119/133] ( 40s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[1005.743458] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[1005.746990] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[1005.941494] [120/133] ( 38s left) gem_exec_balancer (noheartbeat)
[1006.372853] Starting subtest: noheartbeat
[1006.376613] Subtest noheartbeat: SKIP (0.000s)
[1006.484298] [121/133] ( 38s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[1006.532710] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[1006.638858] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[1006.803075] [122/133] ( 37s left) kms_big_fb (linear-addfb)
[1008.310405] Starting subtest: linear-addfb
[1008.311987] Subtest linear-addfb: SUCCESS (0.000s)
[1008.501431] [123/133] ( 36s left) perf_pmu (busy)
[1008.556916] Starting subtest: busy
[1008.558637] Starting dynamic subtest: rcs0
[1009.136995] Dynamic subtest rcs0: SUCCESS (0.582s)
[1009.154019] Starting dynamic subtest: bcs0
[1009.697053] Dynamic subtest bcs0: SUCCESS (0.558s)
[1009.714081] Starting dynamic subtest: vcs0
[1010.258053] Dynamic subtest vcs0: SUCCESS (0.559s)
[1010.275179] Starting dynamic subtest: vcs1
[1010.819024] Dynamic subtest vcs1: SUCCESS (0.559s)
[1010.836342] Starting dynamic subtest: vecs0
[1011.379135] Dynamic subtest vecs0: SUCCESS (0.558s)
[1011.380696] Subtest busy: SUCCESS (2.826s)
[1011.512622] [124/133] ( 33s left) kms_force_connector_basic (force-load-detect)
[1011.644012] Starting subtest: force-load-detect
[1011.646879] Subtest force-load-detect: SKIP (0.000s)
[1012.581848] [125/133] ( 32s left) gem_ctx_param (invalid-get-ringsize)
[1012.629902] Starting subtest: invalid-get-ringsize
[1012.631564] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[1012.770063] [126/133] ( 32s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[1014.283851] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[1014.287147] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[1014.457992] [127/133] ( 30s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[1015.948271] Starting subtest: cursorB-vs-flipA-varying-size
[1015.953854] Subtest cursorB-vs-flipA-varying-size: SKIP (0.003s)
[1016.087645] [128/133] ( 29s left) kms_flip (2x-blocking-wf_vblank)
[1017.583236] Starting subtest: 2x-blocking-wf_vblank
[1017.600520] Subtest 2x-blocking-wf_vblank: SKIP (0.017s)
[1017.731441] [129/133] ( 27s left) kms_plane_scaling (planes-downscale-factor-0-75)
[1019.225411] Starting subtest: planes-downscale-factor-0-75
[1019.226858] Starting dynamic subtest: pipe-A
[1019.332620] Dynamic subtest pipe-A: SUCCESS (0.107s)
[1019.345301] Starting dynamic subtest: pipe-B
[1019.474874] Dynamic subtest pipe-B: SUCCESS (0.141s)
[1019.487552] Starting dynamic subtest: pipe-C
[1019.616328] Dynamic subtest pipe-C: SUCCESS (0.140s)
[1019.628854] Starting dynamic subtest: pipe-D
[1019.757380] Dynamic subtest pipe-D: SUCCESS (0.140s)
[1019.758883] Subtest planes-downscale-factor-0-75: SUCCESS (0.533s)
[1019.956526] [130/133] ( 25s left) gem_exec_whisper (basic-fds-forked-all)
[1020.017614] Starting subtest: basic-fds-forked-all
[1031.915239] Subtest basic-fds-forked-all: SUCCESS (11.892s)
[1032.220537] [131/133] ( 13s left) kms_plane_lowres (tiling-none)
[1033.707598] Starting subtest: tiling-none
[1033.709146] Starting dynamic subtest: pipe-A-HDMI-A-4
[1043.055890] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.346s)
[1043.159151] Starting dynamic subtest: pipe-B-HDMI-A-4
[1052.337205] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (9.192s)
[1052.391924] Starting dynamic subtest: pipe-C-HDMI-A-4
[1061.615471] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (9.236s)
[1061.717661] Starting dynamic subtest: pipe-D-HDMI-A-4
[1070.875852] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.171s)
[1070.917969] Subtest tiling-none: SUCCESS (37.210s)
[1071.119702] Overall timeout time exceeded, stopping.
[1071.175839] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: drm_buddy
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_color_pipeline
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_selftest
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: testdisplay
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: i915_selftest
results: parsing output: 48/ for test: gem_partial_pwrite_pread
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: sw_sync
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: kms_dither
results: parsing output: 71/ for test: gem_madvise
results: parsing output: 72/ for test: kms_plane_alpha_blend
results: parsing output: 73/ for test: kms_pipe_b_c_ivb
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_nop
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_alignment
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: gem_ctx_exec
results: parsing output: 89/ for test: gem_busy
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_scaling_modes
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_exec_parallel
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_close_race
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_force_connector_basic
results: parsing output: 124/ for test: gem_ctx_param
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: kms_plane_lowres
results: parsing output: 131/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 132/ for test: prime_vgem
results: no output, setting notrun
Done.