[87.247591] Initializing watchdogs
[87.247750]   /dev/watchdog0
[87.288437] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.303199] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.309524] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.317642] [001/133] (960s left) kms_psr (fbc-psr-primary-page-flip)
[87.529099] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[87.634634] [002/133] (960s left) drm_buddy (drm_buddy)
[87.746322] Starting subtest: drm_buddy
[87.754225] Subtest drm_buddy: SKIP (0.003s)
[87.886216] [003/133] (960s left) gem_ppgtt (shrink-vs-evict-pinned)
[88.009666] Starting subtest: shrink-vs-evict-pinned
[93.081829] Subtest shrink-vs-evict-pinned: SUCCESS (5.066s)
[93.200685] [004/133] (954s left) kms_color_pipeline (plane-ctm3x4)
[93.392424] Starting subtest: plane-ctm3x4
[95.015485] Subtest plane-ctm3x4: SKIP (1.621s)
[95.334864] [005/133] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[95.559156] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[97.976898] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.420s)
[98.180333] [006/133] (950s left) kms_properties (colorop-properties-legacy)
[98.369116] Starting subtest: colorop-properties-legacy
[98.373267] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.904153] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.529s)
[98.926665] Starting dynamic subtest: pipe-A-HDMI-A-2
[99.231354] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.326s)
[99.260745] Starting dynamic subtest: pipe-B-HDMI-A-1
[99.591172] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.352s)
[99.620344] Starting dynamic subtest: pipe-B-HDMI-A-2
[99.942049] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.350s)
[99.962405] Starting dynamic subtest: pipe-C-HDMI-A-1
[100.253108] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.309s)
[100.285416] Starting dynamic subtest: pipe-C-HDMI-A-2
[100.706956] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.334s)
[100.775262] Subtest colorop-properties-legacy: SUCCESS (2.222s)
[101.357588] [007/133] (947s left) kms_psr (psr-sprite-mmap-cpu)
[101.918220] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[102.184171] [008/133] (946s left) kms_psr (fbc-psr2-no-drrs)
[102.366078] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[102.469099] [009/133] (946s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[102.649200] Starting subtest: async-flip-with-page-flip-events-linear
[103.248278] Subtest async-flip-with-page-flip-events-linear: SKIP (0.596s)
[103.572051] [010/133] (945s left) kms_joiner (basic-big-joiner)
[103.773123] Starting subtest: basic-big-joiner
[103.783064] Subtest basic-big-joiner: SKIP (0.000s)
[103.905631] [011/133] (945s left) sw_sync (sync_random_merge)
[104.018266] Starting subtest: sync_random_merge
[104.224058] Subtest sync_random_merge: SUCCESS (0.208s)
[104.335974] [012/133] (945s left) gen9_exec_parse (valid-registers)
[104.472412] Starting subtest: valid-registers
[104.643248] Subtest valid-registers: SUCCESS (0.177s)
[104.903949] [013/133] (944s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[105.010156] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[105.117143] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[105.286780] [014/133] (944s left) i915_hangman (gt-engine-error)
[105.422192] Starting subtest: gt-engine-error
[105.426544] Starting dynamic subtest: rcs0
[105.504162] Dynamic subtest rcs0: SUCCESS (0.083s)
[105.527881] Starting dynamic subtest: bcs0
[105.536913] Dynamic subtest bcs0: SKIP (0.003s)
[105.567234] Starting dynamic subtest: vcs0
[105.577643] Dynamic subtest vcs0: SUCCESS (0.066s)
[105.599304] Starting dynamic subtest: vecs0
[105.647077] Dynamic subtest vecs0: SUCCESS (0.071s)
[105.650510] Subtest gt-engine-error: SUCCESS (0.229s)
[105.817795] [015/133] (943s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[106.000182] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[106.003443] Starting dynamic subtest: pipe-A-HDMI-A-1
[106.054585] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[106.096580] Starting dynamic subtest: pipe-A-HDMI-A-2
[106.144736] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[106.164436] Starting dynamic subtest: pipe-B-HDMI-A-1
[106.197032] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[106.216504] Starting dynamic subtest: pipe-B-HDMI-A-2
[106.248514] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[106.267817] Starting dynamic subtest: pipe-C-HDMI-A-1
[106.298879] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[106.321750] Starting dynamic subtest: pipe-C-HDMI-A-2
[106.353948] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[106.360409] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.029s)
[106.929907] [016/133] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[107.157518] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[109.657022] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.501s)
[109.865360] [017/133] (940s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[110.083085] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[110.092169] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[110.230627] [018/133] (939s left) kms_plane (pixel-format-y-tiled-modifier)
[110.425503] Starting subtest: pixel-format-y-tiled-modifier
[110.656226] Starting dynamic subtest: pipe-A-plane-0
[111.489955] Dynamic subtest pipe-A-plane-0: SUCCESS (0.833s)
[111.510640] Starting dynamic subtest: pipe-A-plane-1
[112.290640] Dynamic subtest pipe-A-plane-1: SUCCESS (0.799s)
[112.311799] Starting dynamic subtest: pipe-A-plane-2
[112.858117] Dynamic subtest pipe-A-plane-2: SUCCESS (0.565s)
[112.878822] Starting dynamic subtest: pipe-A-plane-3
[113.439553] Dynamic subtest pipe-A-plane-3: SUCCESS (0.581s)
[113.464080] Starting dynamic subtest: pipe-A-plane-4
[113.478181] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[113.812250] Starting dynamic subtest: pipe-B-plane-0
[114.580242] Dynamic subtest pipe-B-plane-0: SUCCESS (0.783s)
[114.600570] Starting dynamic subtest: pipe-B-plane-1
[115.362443] Dynamic subtest pipe-B-plane-1: SUCCESS (0.783s)
[115.383217] Starting dynamic subtest: pipe-B-plane-2
[115.930549] Dynamic subtest pipe-B-plane-2: SUCCESS (0.565s)
[115.951414] Starting dynamic subtest: pipe-B-plane-3
[116.480156] Dynamic subtest pipe-B-plane-3: SUCCESS (0.549s)
[116.509328] Starting dynamic subtest: pipe-B-plane-4
[116.521506] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[116.695959] Subtest pixel-format-y-tiled-modifier: SUCCESS (6.273s)
[117.058336] [019/133] (933s left) gem_exec_balancer (bonded-sync)
[117.196785] Starting subtest: bonded-sync
[121.538427] Subtest bonded-sync: SUCCESS (4.334s)
[121.798163] [020/133] (928s left) gem_close_race (multigpu-basic-threads)
[121.927837] Starting subtest: multigpu-basic-threads
[121.935979] Subtest multigpu-basic-threads: SKIP (0.000s)
[122.179976] [021/133] (928s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[122.363341] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[122.367227] Starting dynamic subtest: pipe-A
[123.391415] Dynamic subtest pipe-A: SUCCESS (1.033s)
[123.420066] Starting dynamic subtest: pipe-B
[124.483428] Dynamic subtest pipe-B: SUCCESS (1.090s)
[124.525181] Starting dynamic subtest: pipe-C
[124.946915] Dynamic subtest pipe-C: SUCCESS (0.459s)
[124.951346] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.588s)
[125.449733] [022/133] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[125.668681] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[125.676302] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[125.816674] [023/133] (924s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[125.996334] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[127.334073] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.334s)
[127.622798] [024/133] (922s left) kms_lease (setcrtc-implicit-plane)
[127.817766] Starting subtest: setcrtc-implicit-plane
[127.822646] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.577727] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.753s)
[128.606320] Starting dynamic subtest: pipe-A-HDMI-A-2
[129.047108] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.465s)
[129.081374] Starting dynamic subtest: pipe-B-HDMI-A-1
[129.468740] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.415s)
[129.501377] Starting dynamic subtest: pipe-B-HDMI-A-2
[129.927082] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.448s)
[129.954736] Starting dynamic subtest: pipe-C-HDMI-A-1
[130.359716] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.432s)
[130.393260] Starting dynamic subtest: pipe-C-HDMI-A-2
[130.805629] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.440s)
[130.809174] Subtest setcrtc-implicit-plane: SUCCESS (2.987s)
[131.155575] [025/133] (919s left) gem_tiled_fence_blits (normal)
[131.865182] Starting subtest: normal
[134.195095] Subtest normal: SUCCESS (2.334s)
[134.348375] [026/133] (916s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[134.725138] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[134.731465] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[134.870266] [027/133] (916s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[135.088316] Starting subtest: x-tiled-addfb-size-offset-overflow
[135.092076] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[135.222970] [028/133] (915s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[135.427807] Starting subtest: x-tiled-32bpp-rotate-270
[135.747416] Subtest x-tiled-32bpp-rotate-270: SKIP (0.318s)
[135.988318] [029/133] (915s left) gem_userptr_blits (userfault)
[136.126279] Starting subtest: userfault
[136.131071] Subtest userfault: SUCCESS (0.010s)
[136.317840] [030/133] (914s left) gem_userptr_blits (sync-overlap)
[136.454270] Starting subtest: sync-overlap
[136.459225] Subtest sync-overlap: SUCCESS (0.000s)
[136.619681] [031/133] (914s left) kms_chamelium_color (ctm-negative)
[136.806158] Subtest ctm-negative: SKIP (0.000s)
[136.916884] [032/133] (914s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[137.111379] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[137.118811] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[137.254246] [033/133] (914s left) sysfs_timeslice_duration (timeout)
[137.377043] Starting subtest: timeout
[137.382243] Starting dynamic subtest: vecs0
[138.228147] Dynamic subtest vecs0: SUCCESS (0.845s)
[138.257379] Starting dynamic subtest: vcs0
[139.063637] Dynamic subtest vcs0: SUCCESS (0.836s)
[139.086695] Starting dynamic subtest: bcs0
[139.898229] Dynamic subtest bcs0: SUCCESS (0.833s)
[139.924656] Starting dynamic subtest: rcs0
[140.750857] Dynamic subtest rcs0: SUCCESS (0.851s)
[140.754837] Subtest timeout: SUCCESS (3.373s)
[140.889329] [034/133] (910s left) kms_frontbuffer_tracking (psr-suspend)
[141.090392] Starting subtest: psr-suspend
[141.097757] Subtest psr-suspend: SKIP (0.000s)
[141.242143] [035/133] (910s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[141.438977] Starting subtest: cursorA-vs-flipA-varying-size
[152.810996] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.375s)
[153.139840] [036/133] (898s left) gem_mmap_gtt (flink-race)
[153.265242] Starting subtest: flink-race
[173.324427] Subtest flink-race: SUCCESS (20.066s)
[173.468976] [037/133] (878s left) gem_mmap_gtt (bad-object)
[173.577805] Starting subtest: bad-object
[173.581232] Subtest bad-object: SUCCESS (0.000s)
[173.718530] [038/133] (878s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[173.839159] Starting subtest: writes-after-reads-uncached
[194.775525] Subtest writes-after-reads-uncached: SUCCESS (20.940s)
[194.936126] [039/133] (857s left) gem_busy (busy)
[195.074108] Starting subtest: busy
[195.077999] Starting dynamic subtest: all-engines
[195.159131] Dynamic subtest all-engines: SUCCESS (0.082s)
[195.183643] Starting dynamic subtest: rcs0
[195.187230] Dynamic subtest rcs0: SUCCESS (0.012s)
[195.210566] Starting dynamic subtest: bcs0
[195.214236] Dynamic subtest bcs0: SUCCESS (0.009s)
[195.236131] Starting dynamic subtest: vcs0
[195.240473] Dynamic subtest vcs0: SUCCESS (0.014s)
[195.262382] Starting dynamic subtest: vecs0
[195.266483] Dynamic subtest vecs0: SUCCESS (0.008s)
[195.270682] Subtest busy: SUCCESS (0.143s)
[195.945212] [040/133] (856s left) prime_mmap_coherency (write)
[196.503273] Starting subtest: write
[201.651659] Subtest write: SUCCESS (5.401s)
[201.824805] [041/133] (850s left) gem_reg_read (timestamp-monotonic)
[201.936411] Starting subtest: timestamp-monotonic
[206.137079] Subtest timestamp-monotonic: SUCCESS (4.203s)
[206.284891] [042/133] (846s left) kms_plane_alpha_blend (alpha-7efc)
[206.475268] Starting subtest: alpha-7efc
[206.662408] Starting dynamic subtest: pipe-A-HDMI-A-1
[207.669730] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.006s)
[207.806402] Starting dynamic subtest: pipe-C-HDMI-A-1
[208.900111] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.138s)
[208.909443] Subtest alpha-7efc: SUCCESS (2.431s)
[209.251854] [043/133] (843s left) syncobj_wait (multi-wait-submitted)
[209.381165] Starting subtest: multi-wait-submitted
[209.485825] Subtest multi-wait-submitted: SUCCESS (0.102s)
[209.633750] [044/133] (843s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[209.853783] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[209.861335] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[210.001741] [045/133] (842s left) i915_selftest (live)
[211.621410] Starting subtest: live
[211.625043] Starting dynamic subtest: sanitycheck
[214.126800] Dynamic subtest sanitycheck: SUCCESS (2.502s)
[214.149494] Starting dynamic subtest: uncore
[216.562775] Dynamic subtest uncore: SUCCESS (2.431s)
[216.586041] Starting dynamic subtest: workarounds
[219.185506] Dynamic subtest workarounds: SUCCESS (2.612s)
[219.209320] Starting dynamic subtest: gt_engines
[222.058785] Dynamic subtest gt_engines: SUCCESS (2.874s)
[222.133095] Starting dynamic subtest: gt_timelines
[237.936574] Dynamic subtest gt_timelines: SUCCESS (15.875s)
[237.960225] Starting dynamic subtest: gt_contexts
[240.484781] Dynamic subtest gt_contexts: SUCCESS (2.544s)
[240.508421] Starting dynamic subtest: gt_lrc
[245.633850] Dynamic subtest gt_lrc: SUCCESS (5.144s)
[245.657392] Starting dynamic subtest: gt_mocs
[248.413257] Dynamic subtest gt_mocs: SUCCESS (2.775s)
[248.437438] Starting dynamic subtest: gt_pm
[259.265321] Dynamic subtest gt_pm: SUCCESS (10.848s)
[259.290347] Starting dynamic subtest: gt_heartbeat
[261.781383] Dynamic subtest gt_heartbeat: SUCCESS (2.512s)
[261.806374] Starting dynamic subtest: gt_tlb
[265.786544] Dynamic subtest gt_tlb: SUCCESS (4.000s)
[265.810787] Starting dynamic subtest: requests
[274.804599] Dynamic subtest requests: SUCCESS (9.013s)
[274.828715] Starting dynamic subtest: migrate
[280.369883] Dynamic subtest migrate: SUCCESS (5.559s)
[280.394342] Starting dynamic subtest: active
[282.890815] Dynamic subtest active: SUCCESS (2.517s)
[282.914276] Starting dynamic subtest: objects
[287.328935] Dynamic subtest objects: SUCCESS (4.435s)
[287.359413] Starting dynamic subtest: mman
[295.001462] Dynamic subtest mman: SUCCESS (7.668s)
[295.032245] Starting dynamic subtest: dmabuf
[297.606340] Dynamic subtest dmabuf: SUCCESS (2.591s)
[297.630309] Starting dynamic subtest: vma
[300.308243] Dynamic subtest vma: SUCCESS (2.708s)
[300.336218] Starting dynamic subtest: coherency
[309.344122] Dynamic subtest coherency: SUCCESS (9.028s)
[309.369372] Starting dynamic subtest: gtt
[319.653962] Dynamic subtest gtt: SUCCESS (10.309s)
[319.678223] Starting dynamic subtest: gem
[322.523623] Dynamic subtest gem: SUCCESS (2.865s)
[322.548383] Starting dynamic subtest: evict
[328.088798] Dynamic subtest evict: SUCCESS (5.561s)
[328.119370] Starting dynamic subtest: hugepages
[336.994095] Dynamic subtest hugepages: SUCCESS (8.900s)
[337.018227] Starting dynamic subtest: gem_contexts
[357.531443] Dynamic subtest gem_contexts: SUCCESS (20.534s)
[357.560264] Starting dynamic subtest: client
[360.056308] Dynamic subtest client: SUCCESS (2.520s)
[360.080582] Starting dynamic subtest: gem_migrate
[362.495772] Dynamic subtest gem_migrate: SUCCESS (2.436s)
[362.533147] Starting dynamic subtest: reset
[368.830594] Dynamic subtest reset: SUCCESS (6.325s)
[368.862165] Starting dynamic subtest: memory_region
[371.221868] Dynamic subtest memory_region: SUCCESS (2.385s)
[371.246448] Starting dynamic subtest: hangcheck
[396.777304] Dynamic subtest hangcheck: SUCCESS (25.552s)
[396.806422] Starting dynamic subtest: execlists
[408.481173] Dynamic subtest execlists: SUCCESS (11.698s)
[408.506534] Starting dynamic subtest: ring_submission
[410.995639] Dynamic subtest ring_submission: SUCCESS (2.510s)
[411.019784] Starting dynamic subtest: perf
[413.479446] Dynamic subtest perf: SUCCESS (2.480s)
[413.503935] Starting dynamic subtest: slpc
[415.903356] Dynamic subtest slpc: SUCCESS (2.419s)
[415.927412] Starting dynamic subtest: guc
[418.384813] Dynamic subtest guc: SUCCESS (2.477s)
[418.408668] Starting dynamic subtest: guc_multi_lrc
[421.094705] Dynamic subtest guc_multi_lrc: SUCCESS (2.707s)
[421.123424] Starting dynamic subtest: guc_hang
[423.664890] Dynamic subtest guc_hang: SUCCESS (2.566s)
[423.689318] Starting dynamic subtest: late_gt_pm
[426.167037] Dynamic subtest late_gt_pm: SUCCESS (2.498s)
[426.170776] Subtest live: SUCCESS (214.545s)
[426.239607] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[426.246450] [046/133] (626s left) gem_exec_schedule (wide)
[429.610097] Starting subtest: wide
[429.615104] Starting dynamic subtest: rcs0
[449.237697] Dynamic subtest rcs0: SUCCESS (19.619s)
[449.377145] Starting dynamic subtest: bcs0
[469.968197] Dynamic subtest bcs0: SUCCESS (20.727s)
[470.079034] Starting dynamic subtest: vcs0
[490.285736] Dynamic subtest vcs0: SUCCESS (20.305s)
[490.414802] Starting dynamic subtest: vecs0
[510.159534] Dynamic subtest vecs0: SUCCESS (19.868s)
[510.165113] Subtest wide: SUCCESS (80.547s)
[511.192216] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.i915: true
[511.194048] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[511.201415] [047/133] (541s left) kms_cursor_edge_walk (128x128-top-bottom)
[511.395043] Starting subtest: 128x128-top-bottom
[511.400399] Starting dynamic subtest: pipe-A-HDMI-A-1
[515.329447] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.938s)
[515.364407] Starting dynamic subtest: pipe-C-HDMI-A-1
[518.864953] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.526s)
[518.870382] Subtest 128x128-top-bottom: SUCCESS (7.479s)
[519.213584] [048/133] (533s left) syncobj_timeline (invalid-query-bad-pad)
[519.333366] Starting subtest: invalid-query-bad-pad
[519.336628] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[519.481079] [049/133] (533s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[519.591122] Starting subtest: single-wait-all-for-submit-signaled
[519.594451] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[519.773634] [050/133] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[519.978079] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[519.986118] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[520.161748] [051/133] (533s left) gem_exec_async (concurrent-writes)
[520.293747] Starting subtest: concurrent-writes
[520.298977] Starting dynamic subtest: rcs0
[520.341838] Dynamic subtest rcs0: SUCCESS (0.019s)
[520.370772] Starting dynamic subtest: bcs0
[520.374780] Dynamic subtest bcs0: SUCCESS (0.012s)
[520.400481] Starting dynamic subtest: vcs0
[520.404533] Dynamic subtest vcs0: SUCCESS (0.013s)
[520.429353] Starting dynamic subtest: vecs0
[520.433596] Dynamic subtest vecs0: SUCCESS (0.013s)
[520.438305] Subtest concurrent-writes: SUCCESS (0.072s)
[520.648233] [052/133] (532s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[521.230747] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[521.583202] [053/133] (532s left) gem_ctx_persistence (engines-hang)
[521.712150] Starting subtest: engines-hang
[521.715857] Starting dynamic subtest: rcs0
[521.748247] Dynamic subtest rcs0: SUCCESS (0.035s)
[521.785986] Starting dynamic subtest: bcs0
[521.797888] Dynamic subtest bcs0: SKIP (0.006s)
[521.829059] Starting dynamic subtest: vcs0
[521.832797] Dynamic subtest vcs0: SUCCESS (0.023s)
[521.856665] Starting dynamic subtest: vecs0
[521.860624] Dynamic subtest vecs0: SUCCESS (0.033s)
[521.864678] Subtest engines-hang: SUCCESS (0.112s)
[522.020339] [054/133] (531s left) gem_exec_schedule (implicit-write-read)
[522.157792] Starting subtest: implicit-write-read
[522.161334] Starting dynamic subtest: rcs0
[522.277601] Dynamic subtest rcs0: SUCCESS (0.119s)
[522.311348] Starting dynamic subtest: bcs0
[522.416229] Dynamic subtest bcs0: SUCCESS (0.127s)
[522.444858] Starting dynamic subtest: vcs0
[522.538739] Dynamic subtest vcs0: SUCCESS (0.116s)
[522.564049] Starting dynamic subtest: vecs0
[522.653926] Dynamic subtest vecs0: SUCCESS (0.117s)
[522.659203] Subtest implicit-write-read: SUCCESS (0.498s)
[523.063207] [055/133] (530s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[523.184199] Starting subtest: untiled-to-tiled
[523.317450] Subtest untiled-to-tiled: SUCCESS (0.129s)
[523.493375] [056/133] (530s left) kms_chamelium_edid (dp-mode-timings)
[524.105963] Subtest dp-mode-timings: SKIP (0.000s)
[524.412781] [057/133] (529s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[524.536142] Starting subtest: multi-wait-for-submit-available-submitted
[524.541367] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[524.694288] [058/133] (529s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[524.905980] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[527.791498] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.889s)
[528.008135] [059/133] (526s left) api_intel_allocator (two-level-inception-interruptible)
[528.126225] Starting subtest: two-level-inception-interruptible
[533.681322] Subtest two-level-inception-interruptible: SUCCESS (5.560s)
[533.843384] [060/133] (520s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[534.029256] Starting subtest: plane-all-transition-nonblocking-fencing
[534.044530] Starting dynamic subtest: pipe-A-HDMI-A-1
[539.307573] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.272s)
[539.726454] Starting dynamic subtest: pipe-A-HDMI-A-2
[544.415443] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.834s)
[544.716499] Starting dynamic subtest: pipe-B-HDMI-A-1
[549.876169] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.202s)
[550.150447] Starting dynamic subtest: pipe-B-HDMI-A-2
[555.141188] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (5.038s)
[555.358051] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (21.328s)
[555.721647] [061/133] (498s left) gem_ctx_persistence (legacy-engines-cleanup)
[555.875745] Starting subtest: legacy-engines-cleanup
[555.880381] Starting dynamic subtest: render
[555.908443] Dynamic subtest render: SUCCESS (0.027s)
[555.935140] Starting dynamic subtest: bsd
[555.946050] Dynamic subtest bsd: SUCCESS (0.034s)
[555.976053] Starting dynamic subtest: blt
[555.980551] Dynamic subtest blt: SUCCESS (0.024s)
[556.006664] Starting dynamic subtest: vebox
[556.011088] Dynamic subtest vebox: SUCCESS (0.022s)
[556.016059] Subtest legacy-engines-cleanup: SUCCESS (0.129s)
[556.167365] [062/133] (498s left) syncobj_timeline (host-signal-points)
[556.283104] Starting subtest: host-signal-points
[556.304767] Subtest host-signal-points: SUCCESS (0.025s)
[556.466251] [063/133] (498s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[556.673347] Starting subtest: cursorA-vs-flipA-atomic-transitions
[568.115267] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.325s)
[568.895924] [064/133] (486s left) kms_dp_link_training (non-uhbr-mst)
[569.590838] Starting subtest: non-uhbr-mst
[569.614799] Subtest non-uhbr-mst: SKIP (0.000s)
[569.719032] [065/133] (485s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[569.945045] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[572.425509] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.486s)
[572.764974] [066/133] (482s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[572.982490] Starting subtest: cursor-rapid-movement-32x32
[573.133116] Subtest cursor-rapid-movement-32x32: SKIP (0.150s)
[573.298737] [067/133] (482s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[573.506964] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[573.513909] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[573.665044] [068/133] (482s left) kms_atomic_interruptible (universal-setplane-cursor)
[573.875053] Starting subtest: universal-setplane-cursor
[573.880355] Starting dynamic subtest: pipe-A-HDMI-A-1
[580.756925] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.871s)
[580.763460] Subtest universal-setplane-cursor: SUCCESS (6.879s)
[581.105942] [069/133] (474s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[581.308612] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[581.315196] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[581.459175] [070/133] (474s left) kms_prime (basic-crc-hybrid)
[581.678180] Subtest basic-crc-hybrid: SKIP (0.000s)
[581.866300] [071/133] (474s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[582.088753] Starting subtest: crc-primary-suspend-y-tiled-ccs
[582.093678] Starting dynamic subtest: pipe-A-HDMI-A-1
[598.831140] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.628s)
[598.883401] Starting dynamic subtest: pipe-A-HDMI-A-2