[68.869304] Initializing watchdogs
[68.869374]   /dev/watchdog0
[68.888827] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[68.899422] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.903979] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.906378] [001/134] (960s left) gem_userptr_blits (readonly-pwrite-unsync)
[68.988715] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[69.202976] [002/134] (960s left) kms_properties (invalid-properties-atomic)
[69.383222] Starting subtest: invalid-properties-atomic
[69.851817] Subtest invalid-properties-atomic: SUCCESS (0.469s)
[69.963452] [003/134] (959s left) kms_frontbuffer_tracking (basic)
[70.144561] Starting subtest: basic
[72.928740] Subtest basic: SUCCESS (2.787s)
[73.111668] [004/134] (956s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[73.305930] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[74.610982] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.305s)
[74.852020] [005/134] (954s left) core_sysfs (read-all-entries)
[74.919938] Starting subtest: read-all-entries
[74.923442] Subtest read-all-entries: SUCCESS (0.004s)
[75.102555] [006/134] (954s left) kms_color (ctm-negative)
[75.278496] Starting subtest: ctm-negative
[75.279430] Starting dynamic subtest: pipe-A-DP-3
[75.963942] Dynamic subtest pipe-A-DP-3: SUCCESS (0.684s)
[75.982285] Starting dynamic subtest: pipe-B-DP-3
[76.545375] Dynamic subtest pipe-B-DP-3: SUCCESS (0.582s)
[76.558129] Starting dynamic subtest: pipe-C-DP-3
[77.124351] Dynamic subtest pipe-C-DP-3: SUCCESS (0.580s)
[77.136965] Starting dynamic subtest: pipe-D-DP-3
[77.724294] Dynamic subtest pipe-D-DP-3: SUCCESS (0.599s)
[77.725207] Subtest ctm-negative: SUCCESS (2.446s)
[78.039893] [007/134] (951s left) kms_busy (extended-modeset-hang-newfb)
[78.230933] Starting subtest: extended-modeset-hang-newfb
[78.232817] Starting dynamic subtest: pipe-A
[93.952372] Dynamic subtest pipe-A: SUCCESS (15.717s)
[93.974507] Starting dynamic subtest: pipe-D
[109.660477] Dynamic subtest pipe-D: SUCCESS (15.701s)
[109.661432] Subtest extended-modeset-hang-newfb: SUCCESS (31.427s)
[109.963898] [008/134] (919s left) i915_drm_fdinfo (busy-hang)
[110.025328] Starting subtest: busy-hang
[110.026252] Starting dynamic subtest: rcs0
[110.062335] Dynamic subtest rcs0: SKIP (0.036s)
[110.071313] Starting dynamic subtest: bcs0
[110.073380] Dynamic subtest bcs0: SKIP (0.001s)
[110.081611] Starting dynamic subtest: vcs0
[110.083420] Dynamic subtest vcs0: SKIP (0.001s)
[110.091588] Starting dynamic subtest: vcs1
[110.093648] Dynamic subtest vcs1: SKIP (0.001s)
[110.101553] Starting dynamic subtest: vecs0
[110.103543] Dynamic subtest vecs0: SKIP (0.000s)
[110.111791] Starting dynamic subtest: vecs1
[110.114230] Dynamic subtest vecs1: SKIP (0.001s)
[110.121983] Starting dynamic subtest: ccs0
[110.124120] Dynamic subtest ccs0: SKIP (0.000s)
[110.126125] Subtest busy-hang: SKIP (0.041s)
[110.179483] [009/134] (919s left) kms_atomic_transition (plane-all-transition-fencing)
[110.354573] Starting subtest: plane-all-transition-fencing
[110.356560] Starting dynamic subtest: pipe-A-DP-3
[114.118345] Dynamic subtest pipe-A-DP-3: SUCCESS (3.762s)
[114.253192] Starting dynamic subtest: pipe-B-DP-3
[118.126808] Dynamic subtest pipe-B-DP-3: SUCCESS (3.882s)
[118.215424] Subtest plane-all-transition-fencing: SUCCESS (7.860s)
[118.484513] [010/134] (911s left) sriov_basic (enable-vfs-autoprobe-on)
[118.559050] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[118.631988] [011/134] (911s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[118.805256] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[118.806171] Starting dynamic subtest: pipe-A-DP-3
[118.814372] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[118.822385] Starting dynamic subtest: pipe-B-DP-3
[118.830573] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[118.838459] Starting dynamic subtest: pipe-C-DP-3
[118.846498] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[118.854369] Starting dynamic subtest: pipe-D-DP-3
[118.863062] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[118.865116] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[119.275124] [012/134] (910s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[119.451905] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[119.452824] Starting dynamic subtest: pipe-A-DP-3
[119.461551] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[119.470037] Starting dynamic subtest: pipe-B-DP-3
[119.478536] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[119.486557] Starting dynamic subtest: pipe-C-DP-3
[119.494930] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[119.502885] Starting dynamic subtest: pipe-D-DP-3
[119.511915] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[119.513980] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[119.937483] [013/134] (910s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[120.115596] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[120.116486] Starting dynamic subtest: pipe-A-valid-mode
[122.590452] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.472s)
[122.591869] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.474s)
[122.852689] [014/134] (907s left) prime_mmap_kms (buffer-sharing)
[123.025418] Starting subtest: buffer-sharing
[123.419682] Subtest buffer-sharing: SUCCESS (0.392s)
[123.747817] [015/134] (906s left) syncobj_wait (multi-wait-all-submitted)
[123.815115] Starting subtest: multi-wait-all-submitted
[123.918740] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[124.097448] [016/134] (906s left) kms_rotation_crc (multiplane-rotation)
[124.280097] Starting subtest: multiplane-rotation
[152.090973] Subtest multiplane-rotation: SUCCESS (27.811s)
[152.297830] [017/134] (878s left) gem_exec_balancer (invalid-bonds)
[152.382651] Starting subtest: invalid-bonds
[152.384540] Subtest invalid-bonds: SKIP (0.001s)
[152.772630] [018/134] (877s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[152.949609] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[152.951314] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[153.096612] [019/134] (877s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[153.277191] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[153.278982] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[153.434406] [020/134] (877s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[153.612390] Starting subtest: cursorA-vs-flipB-legacy
[153.614166] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[153.770028] [021/134] (877s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[153.950197] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[153.951105] Starting dynamic subtest: pipe-A-valid-mode
[154.032067] Dynamic subtest pipe-A-valid-mode: SKIP (0.080s)
[154.033975] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.082s)
[154.284118] [022/134] (876s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[154.353422] Starting subtest: wait-all-for-submit-delayed-submit
[154.457667] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[154.587689] [023/134] (876s left) i915_pm_rpm (system-suspend)
[157.005506] Starting subtest: system-suspend
[177.135570] Subtest system-suspend: SUCCESS (4.884s)
[177.545744] [024/134] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[177.728796] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[177.730577] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[177.923619] [025/134] (853s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[178.112355] Starting subtest: y-tiled-16bpp-rotate-270
[178.114133] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[178.275024] [026/134] (852s left) kms_prime (basic-modeset-hybrid)
[178.453371] Subtest basic-modeset-hybrid: SKIP (0.000s)
[178.666527] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[178.668578] [027/134] (852s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[178.857829] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[178.859604] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[179.057973] [028/134] (852s left) perf_pmu (busy-accuracy-50)
[179.128049] Starting subtest: busy-accuracy-50
[179.128976] Starting dynamic subtest: rcs0
[180.685155] Dynamic subtest rcs0: SUCCESS (1.556s)
[180.697076] Starting dynamic subtest: bcs0
[182.241008] Dynamic subtest bcs0: SUCCESS (1.555s)
[182.252977] Starting dynamic subtest: vcs0
[183.798361] Dynamic subtest vcs0: SUCCESS (1.556s)
[183.810562] Starting dynamic subtest: vcs1
[185.355158] Dynamic subtest vcs1: SUCCESS (1.556s)
[185.366931] Starting dynamic subtest: vecs0
[186.912896] Dynamic subtest vecs0: SUCCESS (1.557s)
[186.924488] Starting dynamic subtest: vecs1
[188.470832] Dynamic subtest vecs1: SUCCESS (1.557s)
[188.482433] Starting dynamic subtest: ccs0
[190.028644] Dynamic subtest ccs0: SUCCESS (1.557s)
[190.029512] Subtest busy-accuracy-50: SUCCESS (10.900s)
[190.225574] [029/134] (841s left) kms_invalid_mode (int-max-clock)
[190.407237] Starting subtest: int-max-clock
[190.408143] Starting dynamic subtest: pipe-A-DP-3
[190.484240] Dynamic subtest pipe-A-DP-3: SUCCESS (0.076s)
[190.499902] Starting dynamic subtest: pipe-B-DP-3
[190.501060] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[190.514762] Starting dynamic subtest: pipe-C-DP-3
[190.515961] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[190.528841] Starting dynamic subtest: pipe-D-DP-3
[190.529772] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[190.530688] Subtest int-max-clock: SUCCESS (0.086s)
[190.759741] [030/134] (840s left) i915_pm_rps (thresholds)
[190.846627] Starting subtest: thresholds
[190.848468] Subtest thresholds: SKIP (0.000s)
[191.020050] [031/134] (840s left) kms_chamelium_color (ctm-limited-range)
[191.208170] Subtest ctm-limited-range: SKIP (0.000s)
[191.267784] [032/134] (840s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[191.346261] Starting subtest: etime-single-wait-available-unsubmitted
[191.448344] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s)
[191.595018] [033/134] (840s left) syncobj_timeline (multi-wait-submitted-signaled)
[191.672250] Starting subtest: multi-wait-submitted-signaled
[191.673167] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[191.825022] [034/134] (839s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[192.017780] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[192.019460] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[192.228354] [035/134] (839s left) gem_exec_schedule (noreorder-priority)
[192.467983] Starting subtest: noreorder-priority
[192.469229] Starting dynamic subtest: rcs0
[193.654354] Dynamic subtest rcs0: SUCCESS (1.187s)
[193.669172] Starting dynamic subtest: bcs0
[194.798140] Dynamic subtest bcs0: SUCCESS (1.142s)
[194.812701] Starting dynamic subtest: vcs0
[195.919045] Dynamic subtest vcs0: SUCCESS (1.120s)
[195.931731] Starting dynamic subtest: vcs1
[197.064181] Dynamic subtest vcs1: SUCCESS (1.144s)
[197.078590] Starting dynamic subtest: vecs0
[198.209132] Dynamic subtest vecs0: SUCCESS (1.144s)
[198.224006] Starting dynamic subtest: vecs1
[199.362091] Dynamic subtest vecs1: SUCCESS (1.152s)
[199.377545] Starting dynamic subtest: ccs0
[200.482955] Dynamic subtest ccs0: SUCCESS (1.120s)
[200.483850] Subtest noreorder-priority: SUCCESS (8.018s)
[200.742749] [036/134] (831s left) gem_mmap_gtt (basic-read-write-distinct)
[200.818972] Subtest basic-read-write-distinct: SKIP (0.000s)
[200.887151] [037/134] (831s left) gem_watchdog (default-virtual)
[200.974092] Starting subtest: default-virtual
[208.298904] Subtest default-virtual: SUCCESS (7.323s)
[208.407157] [038/134] (823s left) gem_exec_schedule (u-semaphore-user)
[208.500710] Starting subtest: u-semaphore-user
[208.588124] Subtest u-semaphore-user: SUCCESS (0.087s)
[209.078051] [039/134] (822s left) kms_content_protection (mei-interface)
[209.328331] Starting subtest: mei-interface
[209.334947] Subtest mei-interface: SKIP (0.004s)
[209.542659] [040/134] (822s left) kms_cursor_crc (cursor-sliding-128x42)
[209.933192] Starting subtest: cursor-sliding-128x42
[209.938095] Starting dynamic subtest: pipe-A-DP-3
[214.183670] Dynamic subtest pipe-A-DP-3: SUCCESS (4.243s)
[214.232935] Starting dynamic subtest: pipe-D-DP-3
[218.645556] Dynamic subtest pipe-D-DP-3: SUCCESS (4.424s)
[218.646505] Subtest cursor-sliding-128x42: SUCCESS (8.713s)
[219.100234] [041/134] (813s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[219.176957] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[219.254917] [042/134] (813s left) gem_partial_pwrite_pread (writes-after-reads)
[219.337204] Subtest writes-after-reads: SKIP (0.000s)
[219.451848] [043/134] (812s left) kms_pm_rpm (cursor)
[221.275919] Starting subtest: cursor
[221.279547] Subtest cursor: SKIP (0.000s)
[221.700501] [044/134] (810s left) perf (invalid-open-flags)
[222.143691] Starting subtest: invalid-open-flags
[222.144580] Subtest invalid-open-flags: SUCCESS (0.000s)
[222.200689] [045/134] (810s left) kms_plane_multiple (2x-tiling-4)
[222.401213] Starting subtest: 2x-tiling-4
[222.402964] Subtest 2x-tiling-4: SKIP (0.000s)
[222.544221] [046/134] (810s left) gem_softpin (full)
[222.628409] Starting subtest: full
[222.643968] Subtest full: SUCCESS (0.015s)
[222.854828] [047/134] (809s left) kms_psr (pr-suspend)
[223.044028] Subtest pr-suspend: SKIP (0.000s)
[223.114005] [048/134] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[223.304931] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[223.306656] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[223.479082] [049/134] (809s left) kms_async_flips (async-flip-dpms)
[223.665241] Starting subtest: async-flip-dpms
[223.888105] Starting dynamic subtest: pipe-A-DP-3
[226.689231] Dynamic subtest pipe-A-DP-3: SUCCESS (2.801s)
[227.001148] Starting dynamic subtest: pipe-B-DP-3
[229.082423] Dynamic subtest pipe-B-DP-3: SUCCESS (2.092s)
[229.276261] Starting dynamic subtest: pipe-C-DP-3
[231.367677] Dynamic subtest pipe-C-DP-3: SUCCESS (2.103s)
[231.563203] Starting dynamic subtest: pipe-D-DP-3
[233.652754] Dynamic subtest pipe-D-DP-3: SUCCESS (2.103s)
[233.653854] Subtest async-flip-dpms: SUCCESS (9.990s)
[234.139604] [050/134] (798s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[234.329060] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[234.330783] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[234.484174] [051/134] (798s left) gem_ctx_persistence (legacy-engines-hostile)
[234.565038] Starting subtest: legacy-engines-hostile
[234.566146] Starting dynamic subtest: render
[234.688353] Dynamic subtest render: SUCCESS (0.122s)
[234.710852] Starting dynamic subtest: bsd1
[234.783006] Dynamic subtest bsd1: SUCCESS (0.092s)
[234.828084] Starting dynamic subtest: bsd2
[234.853144] Dynamic subtest bsd2: SUCCESS (0.065s)
[234.871298] Starting dynamic subtest: blt
[234.894304] Dynamic subtest blt: SUCCESS (0.039s)
[234.919721] Starting dynamic subtest: vebox
[234.920943] Dynamic subtest vebox: SUCCESS (0.021s)
[234.921999] Subtest legacy-engines-hostile: SUCCESS (0.354s)
[235.134775] [052/134] (797s left) gem_exec_flush (basic-wb-pro-default)
[235.219994] Subtest basic-wb-pro-default: SKIP (0.000s)
[235.296438] [053/134] (797s left) fbdev (pan)
[235.343729] Starting subtest: pan
[235.385623] Subtest pan: SUCCESS (0.043s)
[235.569697] [054/134] (797s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[235.758716] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[235.760503] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[235.955518] [055/134] (797s left) kms_chamelium_frames (hdmi-crc-multiple)
[236.231415] Subtest hdmi-crc-multiple: SKIP (0.000s)
[236.379341] [056/134] (796s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[236.565220] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[236.587760] Starting dynamic subtest: pipe-A-plane-0
[236.589495] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[236.601146] Starting dynamic subtest: pipe-A-plane-3
[236.603256] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[236.614390] Starting dynamic subtest: pipe-A-plane-5
[236.616182] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[236.818819] Starting dynamic subtest: pipe-B-plane-0
[236.820846] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[236.839125] Starting dynamic subtest: pipe-B-plane-3
[236.841048] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[236.853811] Starting dynamic subtest: pipe-B-plane-5
[236.855578] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[236.908734] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SKIP (0.343s)
[237.180481] [057/134] (796s left) gem_exec_whisper (basic-fds-priority-all)
[237.268704] Starting subtest: basic-fds-priority-all
[259.969223] Subtest basic-fds-priority-all: SUCCESS (22.698s)
[260.255139] [058/134] (773s left) kms_hdr (static-toggle)
[260.436286] Starting subtest: static-toggle
[261.006873] Starting dynamic subtest: pipe-A-DP-3
[262.106479] Dynamic subtest pipe-A-DP-3: SUCCESS (1.099s)
[262.112215] Subtest static-toggle: SUCCESS (1.672s)
[262.539005] [059/134] (771s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[262.726204] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[262.727081] Starting dynamic subtest: pipe-A-DP-3
[262.735238] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[262.747156] Starting dynamic subtest: pipe-B-DP-3
[262.755321] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[262.766917] Starting dynamic subtest: pipe-C-DP-3
[262.775105] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[262.786764] Starting dynamic subtest: pipe-D-DP-3
[262.796942] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[262.798774] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[263.211232] [060/134] (770s left) kms_lease (lease-invalid-crtc)
[263.396225] Starting subtest: lease-invalid-crtc
[263.397117] Starting dynamic subtest: pipe-A-DP-3
[263.398012] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[263.410212] Starting dynamic subtest: pipe-B-DP-3
[263.411335] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[263.423412] Starting dynamic subtest: pipe-C-DP-3
[263.424570] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[263.436676] Starting dynamic subtest: pipe-D-DP-3
[263.437909] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[263.439133] Subtest lease-invalid-crtc: SUCCESS (0.007s)
[263.540909] [061/134] (770s left) kms_cursor_edge_walk (128x128-top-edge)
[263.724543] Starting subtest: 128x128-top-edge
[263.726980] Starting dynamic subtest: pipe-A-DP-3
[267.192461] Dynamic subtest pipe-A-DP-3: SUCCESS (3.465s)
[267.213348] Starting dynamic subtest: pipe-D-DP-3
[270.553082] Dynamic subtest pipe-D-DP-3: SUCCESS (3.357s)
[270.554315] Subtest 128x128-top-edge: SUCCESS (6.828s)
[270.849465] [062/134] (763s left) gem_exec_gttfill (multigpu-basic)
[271.046368] Starting subtest: multigpu-basic
[289.636168] Subtest multigpu-basic: SUCCESS (18.591s)
[289.749119] [063/134] (744s left) kms_vblank (wait-busy)
[289.975499] Starting subtest: wait-busy
[289.978089] Starting dynamic subtest: pipe-A-DP-3
[292.428844] Dynamic subtest pipe-A-DP-3: SUCCESS (2.451s)
[292.458073] Starting dynamic subtest: pipe-D-DP-3
[294.869340] Dynamic subtest pipe-D-DP-3: SUCCESS (2.433s)
[294.870264] Subtest wait-busy: SUCCESS (4.894s)
[295.159382] [064/134] (738s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[295.350960] Starting subtest: fbcpsr-tiling-y
[295.352689] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[295.541753] [065/134] (738s left) vgem_basic (mmap)
[295.604382] Starting subtest: mmap
[295.627768] Subtest mmap: SUCCESS (0.023s)
[295.767763] [066/134] (738s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[295.860131] Starting subtest: multi-wait-all-for-submit-signaled
[295.861070] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[296.005195] [067/134] (738s left) syncobj_wait (invalid-reset-zero-handles)
[296.085094] Starting subtest: invalid-reset-zero-handles
[296.086160] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[296.291660] [068/134] (738s left) gem_mmap_gtt (big-copy-odd)
[296.369148] Subtest big-copy-odd: SKIP (0.000s)
[296.457081] [069/134] (737s left) kms_draw_crc (draw-method-blt)
[296.645086] Starting subtest: draw-method-blt
[296.645995] Starting dynamic subtest: xrgb8888-untiled
[297.006537] Dynamic subtest xrgb8888-untiled: SUCCESS (0.360s)
[297.047855] Starting dynamic subtest: rgb565-untiled
[297.321518] Dynamic subtest rgb565-untiled: SUCCESS (0.310s)
[297.364821] Starting dynamic subtest: xrgb2101010-untiled
[297.645356] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.312s)
[297.682098] Starting dynamic subtest: xbgr16161616f-untiled
[297.953721] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.311s)
[297.969336] Starting dynamic subtest: xrgb8888-xtiled
[298.103774] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.149s)
[298.118172] Starting dynamic subtest: rgb565-xtiled
[298.238438] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[298.282101] Starting dynamic subtest: xrgb2101010-xtiled
[298.388273] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.145s)
[298.435357] Starting dynamic subtest: xbgr16161616f-xtiled
[298.554973] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.162s)
[298.597995] Starting dynamic subtest: xrgb8888-4tiled
[298.721981] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.162s)
[298.764596] Starting dynamic subtest: rgb565-4tiled
[298.888312] Dynamic subtest rgb565-4tiled: SUCCESS (0.161s)
[298.930414] Starting dynamic subtest: xrgb2101010-4tiled
[299.038386] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.145s)
[299.078844] Starting dynamic subtest: xbgr16161616f-4tiled
[299.188397] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.145s)
[299.191470] Subtest draw-method-blt: SUCCESS (2.545s)
[299.446781] [070/134] (735s left) gen7_exec_parse (basic-rejected)
[299.537384] Subtest basic-rejected: SKIP (0.000s)
[299.599671] [071/134] (734s left) kms_big_fb (linear-16bpp-rotate-270)
[299.797315] Starting subtest: linear-16bpp-rotate-270
[299.855061] Subtest linear-16bpp-rotate-270: SKIP (0.057s)
[300.090457] [072/134] (734s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[300.279439] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[300.280254] Starting dynamic subtest: pipe-A
[300.370402] Dynamic subtest pipe-A: SUCCESS (0.090s)
[300.383986] Starting dynamic subtest: pipe-B
[300.566832] Dynamic subtest pipe-B: SUCCESS (0.195s)
[300.589641] Starting dynamic subtest: pipe-C
[300.780060] Dynamic subtest pipe-C: SUCCESS (0.211s)
[300.806294] Starting dynamic subtest: pipe-D
[300.992854] Dynamic subtest pipe-D: SUCCESS (0.211s)
[300.993910] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.714s)
[301.354468] [073/134] (733s left) kms_psr (psr2-primary-mmap-gtt)
[301.540601] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[301.603714] [074/134] (733s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[301.794927] Starting subtest: fbc-rgb565-draw-render
[304.540493] Subtest fbc-rgb565-draw-render: SUCCESS (2.745s)
[304.740219] [075/134] (730s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[304.931961] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[304.933737] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.133173] [076/134] (729s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[305.321088] Starting subtest: psr-rgb101010-draw-mmap-cpu
[305.322764] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[305.505452] [077/134] (729s left) perf (invalid-oa-exponent)
[305.766026] Starting subtest: invalid-oa-exponent
[305.792228] Subtest invalid-oa-exponent: SUCCESS (0.025s)
[305.854246] [078/134] (729s left) gem_exec_reloc (basic-wc-read)
[305.937171] Subtest basic-wc-read: SKIP (0.000s)
[306.049170] [079/134] (729s left) gem_mmap_offset (bad-flags)
[306.129305] Starting subtest: bad-flags
[306.130278] Subtest bad-flags: SUCCESS (0.000s)
[306.326275] [080/134] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[306.519804] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[306.521490] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[306.704132] [081/134] (728s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[306.901944] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[306.903740] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[307.092226] [082/134] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[307.282918] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[307.284593] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[307.440699] [083/134] (728s left) gem_mmap_wc (set-cache-level)
[307.528203] Subtest set-cache-level: SKIP (0.000s)
[307.605899] [084/134] (727s left) gem_ctx_engines (execute-oneforall)
[307.694924] Starting subtest: execute-oneforall
[308.439036] Subtest execute-oneforall: SUCCESS (0.744s)
[309.146336] [085/134] (726s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[309.332067] Starting subtest: plane-upscale-20x20-with-modifiers
[309.332778] Starting dynamic subtest: pipe-A
[309.906099] Dynamic subtest pipe-A: SUCCESS (0.575s)
[309.925181] Starting dynamic subtest: pipe-B
[310.536182] Dynamic subtest pipe-B: SUCCESS (0.629s)
[310.551527] Starting dynamic subtest: pipe-C
[311.168364] Dynamic subtest pipe-C: SUCCESS (0.630s)
[311.197830] Starting dynamic subtest: pipe-D
[311.816344] Dynamic subtest pipe-D: SUCCESS (0.646s)
[311.817583] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.486s)
[312.167013] [086/134] (723s left) kms_addfb_basic (invalid-set-prop)
[312.245866] Starting subtest: invalid-set-prop
[312.246748] Subtest invalid-set-prop: SUCCESS (0.000s)
[312.513224] [087/134] (723s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[312.708217] Starting subtest: 4-tiled-32bpp-rotate-270
[312.762760] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.054s)
[312.979676] [088/134] (722s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[313.174195] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[313.175061] Starting dynamic subtest: pipe-A-DP-3
[313.183283] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[313.195646] Starting dynamic subtest: pipe-B-DP-3
[313.203921] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[313.216091] Starting dynamic subtest: pipe-C-DP-3
[313.224261] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[313.236482] Starting dynamic subtest: pipe-D-DP-3
[313.246161] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[313.248162] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[313.675865] [089/134] (722s left) kms_getfb (getfb-handle-zero)
[313.864071] Starting subtest: getfb-handle-zero
[313.864978] Subtest getfb-handle-zero: SUCCESS (0.000s)
[314.055654] [090/134] (721s left) kms_flip (flip-vs-blocking-wf-vblank)
[314.242601] Starting subtest: flip-vs-blocking-wf-vblank
[314.247280] Starting dynamic subtest: A-DP3
[322.410809] Dynamic subtest A-DP3: SUCCESS (8.163s)
[322.426401] Starting dynamic subtest: B-DP3
[330.469900] Dynamic subtest B-DP3: SUCCESS (8.057s)
[330.485025] Starting dynamic subtest: C-DP3
[338.521928] Dynamic subtest C-DP3: SUCCESS (8.050s)
[338.537132] Starting dynamic subtest: D-DP3
[346.574924] Dynamic subtest D-DP3: SUCCESS (8.051s)
[346.577176] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.333s)
[346.957398] [091/134] (689s left) core_debugfs (read-all-entries)
[347.039553] Starting subtest: read-all-entries
[347.122872] Subtest read-all-entries: SUCCESS (0.082s)
[347.339658] [092/134] (688s left) api_intel_allocator (reserve-simple)
[347.419030] Starting subtest: reserve-simple
[347.447070] Subtest reserve-simple: SUCCESS (0.028s)
[347.623879] [093/134] (688s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[347.823206] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[347.883708] [094/134] (688s left) gem_ctx_shared (detached-shared-gtt)
[347.974162] Starting subtest: detached-shared-gtt
[350.125158] Subtest detached-shared-gtt: SUCCESS (2.152s)
[351.684246] [095/134] (684s left) syncobj_timeline (32bits-limit)
[351.760121] Starting subtest: 32bits-limit
[351.761057] Subtest 32bits-limit: SUCCESS (0.001s)
[351.935196] [096/134] (684s left) gem_mmap (pf-nonblock)
[352.010980] Subtest pf-nonblock: SKIP (0.000s)
[352.091179] [097/134] (684s left) kms_psr (fbc-psr2-basic)
[352.274624] Subtest fbc-psr2-basic: SKIP (0.000s)
[352.335125] [098/134] (684s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[352.528326] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[352.543704] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.014s)
[352.705738] [099/134] (683s left) gem_exec_reloc (basic-gtt-noreloc)
[352.793231] Subtest basic-gtt-noreloc: SKIP (0.000s)
[352.888452] [100/134] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[353.078756] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[353.080425] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[353.291450] [101/134] (683s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[353.484040] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[353.485762] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[353.672018] [102/134] (683s left) perf_pmu (module-unload)
[353.789224] Starting subtest: module-unload
[360.447745] Subtest module-unload: FAIL (6.634s)
[360.492251] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[360.493356] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[360.495726] [103/134] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[362.209786] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[362.211555] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[362.423318] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[362.425599] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[362.428295] [104/134] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[362.621980] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[362.623764] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[362.830811] [105/134] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[363.022059] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[363.023763] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[363.189987] [106/134] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[363.377961] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[363.379712] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[363.582058] [107/134] (673s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[363.781826] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[363.837563] [108/134] (673s left) kms_force_connector_basic (prune-stale-modes)
[363.944164] Starting subtest: prune-stale-modes
[363.966306] Subtest prune-stale-modes: SUCCESS (0.023s)
[364.295031] [109/134] (673s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[364.494009] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[364.555061] [110/134] (672s left) syncobj_basic (bad-flags-handle-to-fd)
[364.633358] Starting subtest: bad-flags-handle-to-fd
[364.634315] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[364.814765] [111/134] (672s left) kms_rmfb (close-fd)
[365.008055] Starting subtest: close-fd
[365.008951] Starting dynamic subtest: pipe-A-DP-3
[365.179694] Dynamic subtest pipe-A-DP-3: SUCCESS (0.171s)
[365.194998] Starting dynamic subtest: pipe-B-DP-3
[365.462602] Dynamic subtest pipe-B-DP-3: SUCCESS (0.280s)
[365.475966] Starting dynamic subtest: pipe-C-DP-3
[365.744324] Dynamic subtest pipe-C-DP-3: SUCCESS (0.280s)
[365.759925] Starting dynamic subtest: pipe-D-DP-3
[366.029295] Dynamic subtest pipe-D-DP-3: SUCCESS (0.283s)
[366.030204] Subtest close-fd: SUCCESS (1.022s)
[366.370211] [112/134] (671s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[366.563037] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[366.564734] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[366.769668] [113/134] (670s left) gem_exec_fence (basic-await)
[366.988176] Starting subtest: basic-await
[366.989166] Starting dynamic subtest: rcs0
[367.105600] Dynamic subtest rcs0: SUCCESS (0.124s)
[367.119182] Starting dynamic subtest: bcs0
[367.191009] Dynamic subtest bcs0: SUCCESS (0.084s)
[367.207489] Starting dynamic subtest: vcs0
[367.280050] Dynamic subtest vcs0: SUCCESS (0.088s)
[367.295588] Starting dynamic subtest: vcs1
[367.368322] Dynamic subtest vcs1: SUCCESS (0.087s)
[367.385478] Starting dynamic subtest: vecs0
[367.459257] Dynamic subtest vecs0: SUCCESS (0.090s)
[367.474386] Starting dynamic subtest: vecs1
[367.545703] Dynamic subtest vecs1: SUCCESS (0.085s)
[367.560444] Starting dynamic subtest: ccs0
[367.632958] Dynamic subtest ccs0: SUCCESS (0.086s)
[367.634034] Subtest basic-await: SUCCESS (0.652s)
[368.397703] [114/134] (669s left) gem_mmap_gtt (bad-object)
[368.486951] Subtest bad-object: SKIP (0.000s)
[368.598416] [115/134] (669s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[368.784195] Starting subtest: short-flip-after-cursor-toggle
[369.817543] Subtest short-flip-after-cursor-toggle: SUCCESS (1.032s)
[370.147351] [116/134] (667s left) kms_plane_alpha_blend (alpha-basic)
[370.333216] Starting subtest: alpha-basic
[370.589547] Starting dynamic subtest: pipe-A-DP-3
[373.136743] Dynamic subtest pipe-A-DP-3: SUCCESS (2.546s)
[373.171373] Starting dynamic subtest: pipe-D-DP-3
[375.870790] Dynamic subtest pipe-D-DP-3: SUCCESS (2.711s)
[375.871755] Subtest alpha-basic: SUCCESS (5.538s)
[376.188912] [117/134] (661s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[376.375212] Starting subtest: cursorA-vs-flipB-toggle
[376.376966] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[376.547720] [118/134] (661s left) gem_render_copy (y-tiled-ccs-to-linear)
[376.631442] Starting subtest: y-tiled-ccs-to-linear
[376.633604] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[376.923467] [119/134] (661s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[377.006801] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[377.009031] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[377.288745] [120/134] (661s left) gem_ctx_exec (basic-norecovery)
[377.369288] Starting subtest: basic-norecovery
[377.775205] Subtest basic-norecovery: SUCCESS (0.405s)
[378.008209] [121/134] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[378.198947] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[378.200677] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[378.361202] [122/134] (660s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[378.562176] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[378.563992] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[378.760133] [123/134] (659s left) i915_module_load (reload-no-display)
[378.808268] Starting subtest: reload-no-display
[384.798922] Subtest reload-no-display: SUCCESS (5.992s)
[384.830273] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[384.831281] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[384.833357] [124/134] (653s left) gem_softpin (noreloc)
[386.483159] Starting subtest: noreloc
[391.903310] Subtest noreloc: SUCCESS (5.420s)
[391.998290] [FACT gem_softpin (noreloc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[392.000586] [FACT gem_softpin (noreloc)] new: kernel.kmod_is_loaded.i915: true
[392.003715] [125/134] (646s left) kms_cursor_crc (cursor-onscreen-256x85)
[392.454289] Starting subtest: cursor-onscreen-256x85
[392.468803] Starting dynamic subtest: pipe-A-DP-3
[395.127834] Dynamic subtest pipe-A-DP-3: SUCCESS (2.657s)
[395.179580] Starting dynamic subtest: pipe-D-DP-3
[397.893055] Dynamic subtest pipe-D-DP-3: SUCCESS (2.725s)
[397.894073] Subtest cursor-onscreen-256x85: SUCCESS (5.439s)
[398.281322] [126/134] (640s left) gem_pxp (reject-modify-context-protection-off-3)
[400.889952] Starting subtest: reject-modify-context-protection-off-3
[400.891960] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[401.045585] [127/134] (637s left) kms_selftest (drm_format)
[401.096782] Starting subtest: drm_format
[401.128924] Starting dynamic subtest: drm_test_format_block_width_invalid
[401.217905] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.090s)
[401.231327] Starting dynamic subtest: drm_test_format_block_width_one_plane
[401.322142] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.101s)
[401.337239] Starting dynamic subtest: drm_test_format_block_width_two_plane
[401.412029] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.085s)
[401.457846] Starting dynamic subtest: drm_test_format_block_width_three_plane
[401.499091] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.083s)
[401.531015] Starting dynamic subtest: drm_test_format_block_width_tiled
[401.572756] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.071s)
[401.587309] Starting dynamic subtest: drm_test_format_block_height_invalid
[401.661974] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.085s)
[401.711439] Starting dynamic subtest: drm_test_format_block_height_one_plane
[401.758007] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.092s)
[401.790318] Starting dynamic subtest: drm_test_format_block_height_two_plane
[401.850132] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.088s)
[401.891111] Starting dynamic subtest: drm_test_format_block_height_three_plane
[401.924416] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.070s)
[401.944827] Starting dynamic subtest: drm_test_format_block_height_tiled
[402.012133] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.085s)
[402.058345] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[402.091420] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.075s)
[402.108893] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[402.197891] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.103s)
[402.242952] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[402.271450] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.070s)
[402.289237] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[402.366286] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.091s)
[402.380565] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[402.437659] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.068s)
[402.484813] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[402.516597] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.077s)
[402.536962] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[402.600124] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.080s)
[402.647003] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[402.684657] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.081s)
[402.685566] Subtest drm_format: SUCCESS (1.588s)
[402.921890] [128/134] (635s left) gem_exec_whisper (basic-sync)
[403.039931] Starting subtest: basic-sync
[409.644384] Subtest basic-sync: SUCCESS (6.603s)
[409.880147] [129/134] (629s left) kms_psr (fbc-psr-cursor-render)
[410.071607] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[410.138803] [130/134] (628s left) vgem_basic (busy-fence)
[410.195084] Starting subtest: busy-fence
[410.196149] Subtest busy-fence: SUCCESS (0.000s)
[410.327068] [131/134] (628s left) gem_ctx_param (set-priority-not-supported)
[410.403601] Starting subtest: set-priority-not-supported
[410.405381] Subtest set-priority-not-supported: SKIP (0.000s)
[410.536250] [132/134] (628s left) kms_async_flips (test-cursor)
[410.725256] Starting subtest: test-cursor
[410.946515] Starting dynamic subtest: pipe-A-DP-3
[411.254004] Dynamic subtest pipe-A-DP-3: SUCCESS (0.307s)
[411.477532] Starting dynamic subtest: pipe-B-DP-3
[411.588733] Dynamic subtest pipe-B-DP-3: SUCCESS (0.123s)
[411.804761] Starting dynamic subtest: pipe-C-DP-3
[411.907899] Dynamic subtest pipe-C-DP-3: SUCCESS (0.115s)
[412.119993] Starting dynamic subtest: pipe-D-DP-3
[412.233121] Dynamic subtest pipe-D-DP-3: SUCCESS (0.125s)
[412.234063] Subtest test-cursor: SUCCESS (1.510s)
[412.740676] [133/134] (626s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[413.014092] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[413.164841] [134/134] (626s left) gem_exec_fence (nb-await)
[413.381264] Starting subtest: nb-await
[413.382181] Starting dynamic subtest: rcs0
[413.481718] Dynamic subtest rcs0: SUCCESS (0.100s)
[413.503216] Starting dynamic subtest: bcs0
[413.551903] Dynamic subtest bcs0: SUCCESS (0.068s)
[413.598403] Starting dynamic subtest: vcs0
[413.644923] Dynamic subtest vcs0: SUCCESS (0.089s)
[413.677229] Starting dynamic subtest: vcs1
[413.722110] Dynamic subtest vcs1: SUCCESS (0.075s)
[413.760477] Starting dynamic subtest: vecs0
[413.807918] Dynamic subtest vecs0: SUCCESS (0.083s)
[413.844283] Starting dynamic subtest: vecs1
[413.890849] Dynamic subtest vecs1: SUCCESS (0.080s)
[413.908300] Starting dynamic subtest: ccs0
[413.957333] Dynamic subtest ccs0: SUCCESS (0.065s)
[413.958398] Subtest nb-await: SUCCESS (0.577s)
[414.727405] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_properties
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: core_sysfs
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_busy
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: sriov_basic
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: prime_mmap_kms
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: i915_pm_rpm
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_prime
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: i915_pm_rps
results: parsing output: 30/ for test: kms_chamelium_color
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gem_watchdog
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_content_protection
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: kms_pipe_b_c_ivb
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: kms_pm_rpm
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_plane_multiple
results: parsing output: 45/ for test: gem_softpin
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: gem_exec_flush
results: parsing output: 52/ for test: fbdev
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_chamelium_frames
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: gem_exec_whisper
results: parsing output: 57/ for test: kms_hdr
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_cursor_edge_walk
results: parsing output: 61/ for test: gem_exec_gttfill
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: vgem_basic
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_draw_crc
results: parsing output: 69/ for test: gen7_exec_parse
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: gem_mmap_offset
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: core_debugfs
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_mmap
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_force_connector_basic
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: syncobj_basic
results: parsing output: 110/ for test: kms_rmfb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_plane_alpha_blend
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_ctx_exec
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: i915_module_load
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: gem_pxp
results: parsing output: 126/ for test: kms_selftest
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: gem_ctx_param
results: parsing output: 131/ for test: kms_async_flips
results: parsing output: 132/ for test: kms_chamelium_hpd
results: parsing output: 133/ for test: gem_exec_fence
Done.