[61.673026] Initializing watchdogs
[61.673101]   /dev/watchdog0
[61.692559] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.703447] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.707168] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.710414] [001/133] (960s left) syncobj_eventfd (invalid-bad-pad)
[61.800220] Starting subtest: invalid-bad-pad
[61.801160] Subtest invalid-bad-pad: SUCCESS (0.000s)
[62.002141] [002/133] (960s left) kms_pwrite_crc
[63.194992] [003/133] (959s left) kms_frontbuffer_tracking (fbc-1p-rte)
[63.375648] Starting subtest: fbc-1p-rte
[66.898129] Subtest fbc-1p-rte: SUCCESS (3.523s)
[67.372657] [004/133] (955s left) gem_eio (in-flight-immediate)
[67.810278] Starting subtest: in-flight-immediate
[72.936465] Subtest in-flight-immediate: SUCCESS (5.126s)
[73.189973] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[73.191780] [005/133] (949s left) gem_render_copy_redux (interruptible)
[73.278963] Starting subtest: interruptible
[74.046932] Subtest interruptible: SUCCESS (0.768s)
[74.198159] [006/133] (948s left) kms_lease (lease-unleased-connector)
[74.385883] Starting subtest: lease-unleased-connector
[74.386791] Starting dynamic subtest: pipe-A-DP-3
[74.490212] Dynamic subtest pipe-A-DP-3: SUCCESS (0.103s)
[74.498716] Starting dynamic subtest: pipe-B-DP-3
[74.594280] Dynamic subtest pipe-B-DP-3: SUCCESS (0.102s)
[74.603104] Starting dynamic subtest: pipe-C-DP-3
[74.699597] Dynamic subtest pipe-C-DP-3: SUCCESS (0.106s)
[74.709702] Starting dynamic subtest: pipe-D-DP-3
[74.807325] Dynamic subtest pipe-D-DP-3: SUCCESS (0.107s)
[74.808240] Subtest lease-unleased-connector: SUCCESS (0.422s)
[74.931440] [007/133] (947s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[75.133386] Starting subtest: 4-tiled-64bpp-rotate-180
[77.052723] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.918s)
[77.316293] [008/133] (945s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[77.499183] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[77.500115] Starting dynamic subtest: pipe-A-DP-3
[77.508524] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[77.517218] Starting dynamic subtest: pipe-B-DP-3
[77.525424] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[77.533954] Starting dynamic subtest: pipe-C-DP-3
[77.542020] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[77.550356] Starting dynamic subtest: pipe-D-DP-3
[77.560137] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[77.561802] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[77.981329] [009/133] (944s left) perf (enable-disable)
[78.383299] Starting subtest: enable-disable
[78.384190] Starting dynamic subtest: 0-rcs0
[80.613924] Dynamic subtest 0-rcs0: SUCCESS (2.230s)
[80.614903] Subtest enable-disable: SUCCESS (2.230s)
[80.673332] [010/133] (942s left) i915_drm_fdinfo (most-busy-idle-check-all)
[80.743866] Starting subtest: most-busy-idle-check-all
[80.744714] Starting dynamic subtest: rcs0
[80.770996] Dynamic subtest rcs0: SKIP (0.027s)
[80.779951] Starting dynamic subtest: bcs0
[80.781731] Dynamic subtest bcs0: SKIP (0.000s)
[80.790494] Starting dynamic subtest: vcs0
[80.792591] Dynamic subtest vcs0: SKIP (0.000s)
[80.801594] Starting dynamic subtest: vcs1
[80.803904] Dynamic subtest vcs1: SKIP (0.000s)
[80.812471] Starting dynamic subtest: vecs0
[80.814418] Dynamic subtest vecs0: SKIP (0.000s)
[80.822898] Starting dynamic subtest: vecs1
[80.825203] Dynamic subtest vecs1: SKIP (0.000s)
[80.836477] Starting dynamic subtest: ccs0
[80.838584] Dynamic subtest ccs0: SKIP (0.000s)
[80.840813] Subtest most-busy-idle-check-all: SKIP (0.031s)
[80.882714] [011/133] (941s left) kms_prime (basic-crc-hybrid)
[81.073485] Subtest basic-crc-hybrid: SKIP (0.000s)
[81.268247] [012/133] (941s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[81.383067] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[81.385136] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[81.645022] [013/133] (941s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[81.835795] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[81.837489] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[81.966381] [014/133] (941s left) api_intel_bb (simple-bb)
[82.046208] Starting subtest: simple-bb
[82.075560] Subtest simple-bb: SUCCESS (0.029s)
[82.230861] [015/133] (940s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[82.421224] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[82.422052] Starting dynamic subtest: pipe-A
[82.513978] Dynamic subtest pipe-A: SUCCESS (0.092s)
[82.526902] Starting dynamic subtest: pipe-B
[82.743302] Dynamic subtest pipe-B: SUCCESS (0.229s)
[82.753534] Starting dynamic subtest: pipe-C
[82.941824] Dynamic subtest pipe-C: SUCCESS (0.198s)
[82.956298] Starting dynamic subtest: pipe-D
[83.154026] Dynamic subtest pipe-D: SUCCESS (0.212s)
[83.154999] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.733s)
[83.514297] [016/133] (939s left) kms_psr (fbc-psr2-suspend)
[83.708264] Subtest fbc-psr2-suspend: SKIP (0.000s)
[83.774914] [017/133] (939s left) kms_flip (blocking-wf_vblank)
[83.958812] Starting subtest: blocking-wf_vblank
[83.962640] Starting dynamic subtest: A-DP3
[92.106575] Dynamic subtest A-DP3: SUCCESS (8.143s)
[92.118124] Starting dynamic subtest: B-DP3
[100.160584] Dynamic subtest B-DP3: SUCCESS (8.053s)
[100.170130] Starting dynamic subtest: C-DP3
[108.217222] Dynamic subtest C-DP3: SUCCESS (8.056s)
[108.227281] Starting dynamic subtest: D-DP3
[116.274133] Dynamic subtest D-DP3: SUCCESS (8.056s)
[116.276125] Subtest blocking-wf_vblank: SUCCESS (32.315s)
[116.637156] [018/133] (906s left) kms_vblank (wait-busy-hang)
[116.829124] Starting subtest: wait-busy-hang
[116.829966] Starting dynamic subtest: pipe-A-DP-3
[143.545494] Dynamic subtest pipe-A-DP-3: SUCCESS (26.716s)
[143.557285] Starting dynamic subtest: pipe-D-DP-3
[168.572272] Dynamic subtest pipe-D-DP-3: SUCCESS (25.023s)
[168.573234] Subtest wait-busy-hang: SUCCESS (51.744s)
[168.872299] [019/133] (854s left) gem_exec_balancer (parallel-keep-submit-fence)
[169.261651] Starting subtest: parallel-keep-submit-fence
[171.491666] Subtest parallel-keep-submit-fence: SUCCESS (2.230s)
[171.643776] [020/133] (851s left) kms_joiner (invalid-modeset-force-big-joiner)
[171.833402] Starting subtest: invalid-modeset-force-big-joiner
[171.834189] Starting dynamic subtest: big_joiner_on_last_pipe
[172.044366] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.213s)
[172.045240] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.213s)
[172.325317] [021/133] (851s left) syncobj_timeline (multi-wait-for-submit-signaled)
[172.401940] Starting subtest: multi-wait-for-submit-signaled
[172.402906] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[172.590552] [022/133] (851s left) gem_exec_reloc (basic-cpu-read-active)
[172.673178] Subtest basic-cpu-read-active: SKIP (0.000s)
[172.750586] [023/133] (850s left) gem_exec_params (invalid-flag)
[172.832830] Starting subtest: invalid-flag
[172.833741] Subtest invalid-flag: SUCCESS (0.000s)
[172.996628] [024/133] (850s left) gem_ctx_shared (q-smoketest-all)
[173.098029] Starting subtest: Q-smoketest-all
[205.396474] Subtest Q-smoketest-all: SUCCESS (32.292s)
[205.770854] [025/133] (818s left) kms_addfb_basic (legacy-format)
[205.855156] Starting subtest: legacy-format
[205.884416] Subtest legacy-format: SUCCESS (0.028s)
[206.125738] [026/133] (817s left) gem_userptr_blits (stress-mm-invalidate-close)
[206.219136] Starting subtest: stress-mm-invalidate-close
[208.366931] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[208.587405] [027/133] (815s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[208.773201] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[208.774159] Starting dynamic subtest: pipe-A-DP-3
[208.782218] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[208.791527] Starting dynamic subtest: pipe-B-DP-3
[208.799960] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[208.809084] Starting dynamic subtest: pipe-C-DP-3
[208.817014] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[208.826053] Starting dynamic subtest: pipe-D-DP-3
[208.836539] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[208.838526] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[209.230448] [028/133] (814s left) dumb_buffer (create-valid-dumb)
[209.313999] Starting subtest: create-valid-dumb
[209.314940] Subtest create-valid-dumb: SUCCESS (0.000s)
[209.465823] [029/133] (814s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[209.652113] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[209.712386] [030/133] (814s left) gem_mmap_gtt (zero-extend)
[209.789054] Subtest zero-extend: SKIP (0.000s)
[209.868416] [031/133] (814s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[210.063062] Starting subtest: y-tiled-16bpp-rotate-270
[210.064941] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[210.248948] [032/133] (814s left) perf (non-sampling-read-error)
[210.521101] Starting subtest: non-sampling-read-error
[210.537425] Subtest non-sampling-read-error: SUCCESS (0.016s)
[210.598194] [033/133] (813s left) kms_plane_cursor (overlay)
[210.784053] Starting subtest: overlay
[210.785763] Starting dynamic subtest: pipe-A-DP-3-size-64
[214.037963] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.253s)
[214.115437] Starting dynamic subtest: pipe-A-DP-3-size-128
[217.353904] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.249s)
[217.433391] Starting dynamic subtest: pipe-A-DP-3-size-256
[220.688267] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.266s)
[220.826642] Starting dynamic subtest: pipe-B-DP-3-size-64
[224.064706] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.249s)
[224.134545] Starting dynamic subtest: pipe-B-DP-3-size-128
[227.331614] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.216s)
[227.389953] Starting dynamic subtest: pipe-B-DP-3-size-256
[230.564652] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.183s)
[230.684325] Starting dynamic subtest: pipe-C-DP-3-size-64
[234.009532] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.335s)
[234.081581] Starting dynamic subtest: pipe-C-DP-3-size-128
[237.277096] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.216s)
[237.347659] Starting dynamic subtest: pipe-C-DP-3-size-256
[240.593042] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.266s)
[240.730382] Starting dynamic subtest: pipe-D-DP-3-size-64
[244.052718] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.332s)
[244.128803] Starting dynamic subtest: pipe-D-DP-3-size-128
[247.370244] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.266s)
[247.441843] Starting dynamic subtest: pipe-D-DP-3-size-256
[250.669840] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.249s)
[250.796751] Subtest overlay: SUCCESS (40.012s)
[251.131777] [034/133] (773s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[251.220375] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[251.221286] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[251.399132] [035/133] (773s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[251.591132] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[251.592862] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[251.798671] [036/133] (772s left) gem_exec_reloc (basic-gtt)
[251.879450] Subtest basic-gtt: SKIP (0.000s)
[251.991978] [037/133] (772s left) kms_feature_discovery (psr1)
[252.180767] Starting subtest: psr1
[252.182354] Subtest psr1: SKIP (0.000s)
[252.296119] [038/133] (772s left) kms_chamelium_frames (hdmi-aspect-ratio)
[252.562183] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[252.714058] [039/133] (772s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[252.901449] Starting subtest: cursor-vs-flip-atomic-transitions
[283.651851] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.750s)
[283.949934] [040/133] (740s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[284.143499] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[284.145219] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[284.347703] [041/133] (740s left) prime_vgem (busy)
[284.452932] Starting subtest: busy
[284.453996] Starting dynamic subtest: rcs0
[284.549492] Dynamic subtest rcs0: SUCCESS (0.096s)
[284.560370] Starting dynamic subtest: bcs0
[284.603817] Dynamic subtest bcs0: SUCCESS (0.053s)
[284.618888] Starting dynamic subtest: vcs0
[284.649402] Dynamic subtest vcs0: SUCCESS (0.044s)
[284.670617] Starting dynamic subtest: vcs1
[284.693220] Dynamic subtest vcs1: SUCCESS (0.041s)
[284.714449] Starting dynamic subtest: vecs0
[284.736776] Dynamic subtest vecs0: SUCCESS (0.041s)
[284.754900] Starting dynamic subtest: vecs1
[284.780551] Dynamic subtest vecs1: SUCCESS (0.042s)
[284.798567] Starting dynamic subtest: ccs0
[284.825228] Dynamic subtest ccs0: SUCCESS (0.043s)
[284.826294] Subtest busy: SUCCESS (0.373s)
[285.033974] [042/133] (740s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[285.220519] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[285.222976] Starting dynamic subtest: pipe-A-DP-3
[285.231131] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[285.240288] Starting dynamic subtest: pipe-B-DP-3
[285.248376] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[285.257512] Starting dynamic subtest: pipe-C-DP-3
[285.265585] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[285.274719] Starting dynamic subtest: pipe-D-DP-3
[285.283547] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[285.285405] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[285.699265] [043/133] (739s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[285.883431] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[285.885127] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[286.050916] [044/133] (739s left) gem_mmap_wc (write)
[286.128274] Subtest write: SKIP (0.000s)
[286.216747] [045/133] (739s left) i915_module_load (resize-bar)
[286.264166] Starting subtest: resize-bar
[341.996063] Subtest resize-bar: SUCCESS (55.731s)
[342.024395] [FACT i915_module_load (resize-bar)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[342.025798] [FACT i915_module_load (resize-bar)] deleted: kernel.kmod_is_loaded.i915: true
[342.027785] [046/133] (683s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[343.759542] Starting subtest: plane-ctm3x4-lut1d
[343.800335] Starting dynamic subtest: pipe-A-DP-3
[344.199521] Dynamic subtest pipe-A-DP-3: SUCCESS (0.398s)
[344.414938] Starting dynamic subtest: pipe-B-DP-3
[344.754608] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[344.931364] Starting dynamic subtest: pipe-C-DP-3
[345.271158] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[345.479125] Starting dynamic subtest: pipe-D-DP-3
[345.784463] Dynamic subtest pipe-D-DP-3: SUCCESS (0.314s)
[345.859562] Subtest plane-ctm3x4-lut1d: SUCCESS (2.099s)
[346.120224] [FACT kms_color_pipeline (plane-ctm3x4-lut1d)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[346.122493] [FACT kms_color_pipeline (plane-ctm3x4-lut1d)] new: kernel.kmod_is_loaded.i915: true
[346.125091] [047/133] (679s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[346.208720] Starting subtest: invalid-multi-wait-all-unsubmitted
[346.209590] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[346.365224] [048/133] (679s left) kms_rotation_crc (multiplane-rotation)
[346.552537] Starting subtest: multiplane-rotation
[375.365458] Subtest multiplane-rotation: SUCCESS (28.812s)
[375.595567] [049/133] (650s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[375.793345] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[375.794946] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[375.974157] [050/133] (649s left) vgem_basic (create)
[376.029748] Starting subtest: create
[376.030587] Subtest create: SUCCESS (0.000s)
[376.160380] [051/133] (649s left) gem_ctx_param (invalid-set-no-zeromap)
[376.240951] Starting subtest: invalid-set-no-zeromap
[376.241894] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[376.380122] [052/133] (649s left) kms_addfb_basic (too-wide)
[376.570265] Starting subtest: too-wide
[376.571041] Subtest too-wide: SUCCESS (0.000s)
[376.777046] [053/133] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[376.971939] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[376.973562] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[377.163365] [054/133] (648s left) gem_caching (read-writes)
[377.256192] Starting subtest: read-writes
[386.305294] Subtest read-writes: SUCCESS (9.048s)
[386.477112] [055/133] (639s left) kms_content_protection (dp-mst-lic-type-0)
[386.726730] Starting subtest: dp-mst-lic-type-0
[386.728446] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[386.942233] [056/133] (639s left) gem_madvise (dontneed-before-mmap)
[386.990237] Starting subtest: dontneed-before-mmap
[387.038443] Subtest dontneed-before-mmap: SUCCESS (0.048s)
[387.226138] [057/133] (639s left) prime_vgem (fence-flip-hang)
[387.326669] Subtest fence-flip-hang: SKIP (0.000s)
[387.493758] [058/133] (638s left) syncobj_wait (invalid-reset-zero-handles)
[387.573354] Starting subtest: invalid-reset-zero-handles
[387.574296] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[387.704166] [059/133] (638s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[387.900962] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[387.902619] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[388.093511] [060/133] (638s left) kms_psr (fbc-psr-suspend)
[388.279600] Subtest fbc-psr-suspend: SKIP (0.000s)
[388.338765] [061/133] (638s left) gem_pread (snoop)
[388.416173] Subtest snoop: SKIP (0.000s)
[388.493085] [062/133] (638s left) kms_atomic_transition (modeset-transition-nonblocking)
[388.681283] Starting subtest: modeset-transition-nonblocking
[388.682178] Starting dynamic subtest: 1x-outputs
[391.306064] Dynamic subtest 1x-outputs: SUCCESS (2.624s)
[391.311930] Subtest modeset-transition-nonblocking: SUCCESS (2.627s)
[391.588901] [063/133] (635s left) kms_cursor_crc (cursor-offscreen-64x21)
[391.937545] Starting subtest: cursor-offscreen-64x21
[391.942795] Starting dynamic subtest: pipe-A-DP-3
[394.486180] Dynamic subtest pipe-A-DP-3: SUCCESS (2.541s)
[394.532564] Starting dynamic subtest: pipe-D-DP-3
[397.001965] Dynamic subtest pipe-D-DP-3: SUCCESS (2.476s)
[397.003074] Subtest cursor-offscreen-64x21: SUCCESS (5.064s)
[397.477742] [064/133] (629s left) gem_pxp (display-protected-crc)
[400.081803] Starting subtest: display-protected-crc
[400.083507] Subtest display-protected-crc: SKIP (0.000s)
[400.208956] [065/133] (626s left) perf_pmu (rc6)
[400.279354] Starting subtest: rc6
[400.280394] Starting dynamic subtest: gt0
[406.639916] Dynamic subtest gt0: SUCCESS (6.360s)
[406.653121] Starting dynamic subtest: runtime-pm-gt0
[414.792543] Dynamic subtest runtime-pm-gt0: SUCCESS (8.148s)
[414.804397] Starting dynamic subtest: runtime-pm-long-gt0
[427.486312] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.691s)
[427.497526] Starting dynamic subtest: other-idle-gt0
[427.499318] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[427.500230] Subtest rc6: SUCCESS (27.210s)
[427.671361] [066/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[427.860168] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[427.861869] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[427.928231] [067/133] (598s left) gem_mmap_gtt (hang)
[428.004210] Subtest hang: SKIP (0.000s)
[428.078615] [068/133] (598s left) kms_cursor_crc (cursor-random-64x64)
[428.398438] Starting subtest: cursor-random-64x64
[428.403714] Starting dynamic subtest: pipe-A-DP-3
[432.963909] Dynamic subtest pipe-A-DP-3: SUCCESS (4.561s)
[433.017444] Starting dynamic subtest: pipe-D-DP-3
[437.513661] Dynamic subtest pipe-D-DP-3: SUCCESS (4.505s)
[437.514558] Subtest cursor-random-64x64: SUCCESS (9.115s)
[437.944780] [069/133] (589s left) perf_pmu (busy-accuracy-50)
[438.016672] Starting subtest: busy-accuracy-50
[438.017549] Starting dynamic subtest: rcs0
[439.574640] Dynamic subtest rcs0: SUCCESS (1.557s)
[439.585054] Starting dynamic subtest: bcs0
[441.132684] Dynamic subtest bcs0: SUCCESS (1.556s)
[441.149589] Starting dynamic subtest: vcs0
[442.693865] Dynamic subtest vcs0: SUCCESS (1.559s)
[442.704225] Starting dynamic subtest: vcs1
[444.249945] Dynamic subtest vcs1: SUCCESS (1.555s)
[444.260292] Starting dynamic subtest: vecs0
[445.804213] Dynamic subtest vecs0: SUCCESS (1.553s)
[445.815368] Starting dynamic subtest: vecs1
[447.357508] Dynamic subtest vecs1: SUCCESS (1.552s)
[447.368129] Starting dynamic subtest: ccs0
[448.911375] Dynamic subtest ccs0: SUCCESS (1.552s)
[448.912278] Subtest busy-accuracy-50: SUCCESS (10.894s)
[449.040627] [070/133] (578s left) kms_big_fb (linear-16bpp-rotate-0)
[449.241939] Starting subtest: linear-16bpp-rotate-0
[451.106874] Subtest linear-16bpp-rotate-0: SUCCESS (1.864s)
[451.301453] [071/133] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[451.492028] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[451.493840] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[451.570425] [072/133] (575s left) gem_exec_reloc (basic-softpin)
[451.656542] Subtest basic-softpin: SKIP (0.000s)
[451.763825] [073/133] (575s left) kms_psr2_su (page_flip-nv12)
[451.842182] Subtest page_flip-NV12: SKIP (0.000s)
[451.919219] [074/133] (575s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[452.106983] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[452.166543] [075/133] (575s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[452.355011] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[452.416937] [076/133] (574s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[452.606745] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[452.607584] Starting dynamic subtest: pipe-A
[454.555406] Dynamic subtest pipe-A: SUCCESS (1.948s)
[454.571831] Starting dynamic subtest: pipe-B
[456.618603] Dynamic subtest pipe-B: SUCCESS (2.062s)
[456.638027] Starting dynamic subtest: pipe-C
[456.931857] Dynamic subtest pipe-C: SUCCESS (0.311s)
[456.953705] Starting dynamic subtest: pipe-D
[457.243744] Dynamic subtest pipe-D: SUCCESS (0.310s)
[457.244639] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (4.638s)
[457.507702] [077/133] (569s left) gem_exec_schedule (independent)
[457.599428] Starting subtest: independent
[457.600322] Starting dynamic subtest: rcs0
[458.048507] Dynamic subtest rcs0: SUCCESS (0.450s)
[458.062555] Starting dynamic subtest: bcs0
[458.443427] Dynamic subtest bcs0: SUCCESS (0.393s)
[458.462554] Starting dynamic subtest: vcs0
[458.836679] Dynamic subtest vcs0: SUCCESS (0.392s)
[458.849984] Starting dynamic subtest: vcs1
[459.230519] Dynamic subtest vcs1: SUCCESS (0.392s)
[459.244260] Starting dynamic subtest: vecs0
[459.631023] Dynamic subtest vecs0: SUCCESS (0.398s)
[459.649249] Starting dynamic subtest: vecs1
[460.013367] Dynamic subtest vecs1: SUCCESS (0.379s)
[460.027886] Starting dynamic subtest: ccs0
[460.373575] Dynamic subtest ccs0: SUCCESS (0.359s)
[460.374594] Subtest independent: SUCCESS (2.776s)
[460.711036] [078/133] (566s left) kms_cursor_edge_walk (256x256-top-edge)
[460.899300] Starting subtest: 256x256-top-edge
[460.900200] Starting dynamic subtest: pipe-A-DP-3
[464.379253] Dynamic subtest pipe-A-DP-3: SUCCESS (3.479s)
[464.399167] Starting dynamic subtest: pipe-D-DP-3
[467.719047] Dynamic subtest pipe-D-DP-3: SUCCESS (3.336s)
[467.720044] Subtest 256x256-top-edge: SUCCESS (6.820s)
[467.895306] [079/133] (559s left) gem_render_copy (linear-to-vebox-y-tiled)
[467.985786] Starting subtest: linear-to-vebox-y-tiled
[467.987928] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[468.215377] [080/133] (559s left) i915_suspend (fence-restore-untiled)
[468.304577] Starting subtest: fence-restore-untiled
[468.306406] Subtest fence-restore-untiled: SKIP (0.000s)
[468.389072] [081/133] (559s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[468.580150] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[471.671655] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.092s)
[471.848322] [082/133] (555s left) kms_chamelium_color (ctm-negative)
[472.038411] Subtest ctm-negative: SKIP (0.000s)
[472.098810] [083/133] (555s left) kms_plane_cursor (viewport)
[472.290406] Starting subtest: viewport
[472.292162] Starting dynamic subtest: pipe-A-DP-3-size-64
[475.571471] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.280s)
[475.676984] Starting dynamic subtest: pipe-A-DP-3-size-128
[478.888641] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.248s)
[478.975023] Starting dynamic subtest: pipe-A-DP-3-size-256
[482.171669] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.216s)
[482.345527] Starting dynamic subtest: pipe-B-DP-3-size-64
[485.673455] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.340s)
[485.751877] Starting dynamic subtest: pipe-B-DP-3-size-128
[489.007595] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.282s)
[489.069747] Starting dynamic subtest: pipe-B-DP-3-size-256
[492.290391] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.231s)
[492.430985] Starting dynamic subtest: pipe-C-DP-3-size-64
[495.705389] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.286s)
[495.780247] Starting dynamic subtest: pipe-C-DP-3-size-128
[499.006316] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.249s)
[499.075073] Starting dynamic subtest: pipe-C-DP-3-size-256
[502.255874] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.199s)
[502.397789] Starting dynamic subtest: pipe-D-DP-3-size-64
[505.701534] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.316s)
[505.773255] Starting dynamic subtest: pipe-D-DP-3-size-128
[508.968475] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.216s)
[509.028058] Starting dynamic subtest: pipe-D-DP-3-size-256
[512.235268] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.217s)
[512.343012] Subtest viewport: SUCCESS (40.053s)
[512.535172] [084/133] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[512.725243] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[512.726948] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[512.792898] [085/133] (515s left) perf_pmu (faulting-read)
[512.862573] Starting subtest: faulting-read
[512.863474] Starting dynamic subtest: fixed
[512.864328] Dynamic subtest fixed: SUCCESS (0.001s)
[512.865221] Subtest faulting-read: SUCCESS (0.002s)
[512.958193] [086/133] (515s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[513.041411] Starting subtest: invalid-bsd2-flag-on-blt
[513.042298] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[513.161561] [087/133] (514s left) gem_exec_params (rs-invalid)
[513.246116] Starting subtest: rs-invalid
[513.249960] Subtest rs-invalid: SUCCESS (0.002s)
[513.358594] [088/133] (514s left) gem_exec_balancer (parallel-bb-first)
[513.716381] Starting subtest: parallel-bb-first
[515.324800] Subtest parallel-bb-first: SUCCESS (1.622s)
[515.391995] [089/133] (512s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[515.579432] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[515.580296] Starting dynamic subtest: pipe-A-DP-3
[515.588707] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[515.599111] Starting dynamic subtest: pipe-B-DP-3
[515.607214] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[515.617300] Starting dynamic subtest: pipe-C-DP-3
[515.625390] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[515.635621] Starting dynamic subtest: pipe-D-DP-3
[515.646493] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[515.648534] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[515.979845] [090/133] (512s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[516.174961] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[516.176576] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[516.262666] [091/133] (512s left) gem_huc_copy (huc-copy)
[516.371676] Starting subtest: huc-copy
[516.377887] Subtest huc-copy: SUCCESS (0.006s)
[516.525143] [092/133] (511s left) gem_userptr_blits (mmap-offset-banned)
[516.617973] Starting subtest: mmap-offset-banned
[516.618929] Starting dynamic subtest: fixed
[516.619868] Dynamic subtest fixed: SUCCESS (0.000s)
[516.620778] Subtest mmap-offset-banned: SUCCESS (0.001s)
[516.752102] [093/133] (511s left) gem_lmem_swapping (random-engines)
[519.267771] Starting subtest: random-engines
[519.268598] Starting dynamic subtest: lmem0
[520.228816] Dynamic subtest lmem0: SUCCESS (0.960s)
[520.229747] Subtest random-engines: SUCCESS (0.961s)
[523.122914] [FACT gem_lmem_swapping (random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[523.123940] [FACT gem_lmem_swapping (random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[523.126011] [094/133] (505s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[524.696494] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[524.698269] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[524.762924] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[524.765259] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[524.768269] [095/133] (503s left) gem_exec_flush (basic-wb-ro-before-default)
[524.863348] Subtest basic-wb-ro-before-default: SKIP (0.000s)
[524.935121] [096/133] (503s left) syncobj_wait (single-wait-signaled)
[525.015428] Starting subtest: single-wait-signaled
[525.016330] Subtest single-wait-signaled: SUCCESS (0.000s)
[525.118640] [097/133] (503s left) gem_eio (in-flight-1us)
[525.361372] Starting subtest: in-flight-1us
[529.769513] Subtest in-flight-1us: SUCCESS (4.408s)
[529.938144] [098/133] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[530.134191] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[530.135938] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[530.226696] [099/133] (498s left) gem_exec_schedule (u-independent)
[530.316461] Starting subtest: u-independent
[530.317418] Starting dynamic subtest: rcs0
[530.777732] Dynamic subtest rcs0: SUCCESS (0.460s)
[530.793811] Starting dynamic subtest: bcs0
[531.155527] Dynamic subtest bcs0: SUCCESS (0.376s)
[531.170071] Starting dynamic subtest: vcs0
[531.552375] Dynamic subtest vcs0: SUCCESS (0.395s)
[531.566296] Starting dynamic subtest: vcs1
[531.945548] Dynamic subtest vcs1: SUCCESS (0.392s)
[531.965580] Starting dynamic subtest: vecs0
[532.342375] Dynamic subtest vecs0: SUCCESS (0.395s)
[532.356460] Starting dynamic subtest: vecs1
[532.726390] Dynamic subtest vecs1: SUCCESS (0.382s)
[532.744303] Starting dynamic subtest: ccs0
[533.102219] Dynamic subtest ccs0: SUCCESS (0.372s)
[533.103375] Subtest u-independent: SUCCESS (2.784s)
[533.476889] [100/133] (495s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[533.561317] Starting subtest: invalid-bsd1-flag-on-blt
[533.562330] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[533.637147] [101/133] (495s left) gem_softpin (allocator-evict)
[533.722629] Starting subtest: allocator-evict
[533.723492] Starting dynamic subtest: rcs0
[560.697521] Dynamic subtest rcs0: SUCCESS (26.974s)
[560.708550] Starting dynamic subtest: bcs0
[587.838638] Dynamic subtest bcs0: SUCCESS (27.139s)
[587.849544] Starting dynamic subtest: vcs0
[615.124418] Dynamic subtest vcs0: SUCCESS (27.284s)
[615.135507] Starting dynamic subtest: vcs1
[642.674589] Dynamic subtest vcs1: SUCCESS (27.548s)
[642.685620] Starting dynamic subtest: vecs0
[669.732483] Dynamic subtest vecs0: SUCCESS (27.056s)
[669.743499] Starting dynamic subtest: vecs1
[697.196466] Dynamic subtest vecs1: SUCCESS (27.462s)
[697.207367] Starting dynamic subtest: ccs0
[724.337472] Dynamic subtest ccs0: SUCCESS (27.139s)
[724.338455] Subtest allocator-evict: SUCCESS (190.612s)
[724.464971] [102/133] (304s left) i915_pm_rps (reset)
[724.582512] Starting subtest: reset
[729.397266] Subtest reset: SUCCESS (4.815s)
[729.501951] [103/133] (299s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[729.690795] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[729.692385] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[729.747459] [104/133] (299s left) syncobj_wait (invalid-single-wait-unsubmitted)
[729.837372] Starting subtest: invalid-single-wait-unsubmitted
[729.838312] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[729.896517] [105/133] (299s left) syncobj_timeline (single-wait-signaled)
[729.974311] Starting subtest: single-wait-signaled
[729.975228] Subtest single-wait-signaled: SUCCESS (0.000s)
[730.069117] [106/133] (299s left) gem_exec_whisper (basic-contexts-priority-all)
[730.157501] Starting subtest: basic-contexts-priority-all
[752.568226] Subtest basic-contexts-priority-all: SUCCESS (22.409s)
[752.777465] [107/133] (276s left) gem_exec_reloc (basic-gtt-wc)
[752.861371] Subtest basic-gtt-wc: SKIP (0.000s)
[752.962884] [108/133] (276s left) gem_exec_fence (syncobj-invalid-flags)
[753.517740] Starting subtest: syncobj-invalid-flags
[753.518622] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[753.883375] [109/133] (275s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[754.090228] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[755.217695] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.127s)
[755.366009] [110/133] (274s left) gem_ccs (ctrl-surf-copy)
[755.455990] Starting subtest: ctrl-surf-copy
[755.456906] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[755.512867] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.056s)
[755.525540] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[755.726045] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.211s)
[755.739206] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[755.754978] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s)
[755.768040] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[755.976488] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.220s)
[755.989947] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[756.008540] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.031s)
[756.022261] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[756.229142] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.219s)
[756.242498] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[756.258067] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s)
[756.271126] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[756.478511] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.219s)
[756.479445] Subtest ctrl-surf-copy: SUCCESS (1.023s)
[756.584297] [111/133] (272s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[756.776120] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[756.777857] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[756.874880] [112/133] (272s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[757.066268] Starting subtest: pixel-format-y-tiled-ccs-modifier
[757.101667] Starting dynamic subtest: pipe-A-plane-0
[757.103431] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[757.115218] Starting dynamic subtest: pipe-A-plane-3
[757.117369] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[757.128528] Starting dynamic subtest: pipe-A-plane-5
[757.130312] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[757.342231] Starting dynamic subtest: pipe-B-plane-0
[757.344470] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[757.365802] Starting dynamic subtest: pipe-B-plane-3
[757.367640] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[757.381192] Starting dynamic subtest: pipe-B-plane-5
[757.383551] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[757.410552] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.344s)
[757.591253] [113/133] (271s left) gen9_exec_parse (allowed-single)
[757.682217] Subtest allowed-single: SKIP (0.000s)
[757.750649] [114/133] (271s left) kms_psr (psr2-primary-page-flip)
[757.941074] Subtest psr2-primary-page-flip: SKIP (0.000s)
[758.015396] [115/133] (271s left) api_intel_allocator (reopen)
[758.094681] Starting subtest: reopen
[758.123982] Subtest reopen: SUCCESS (0.031s)
[758.235670] [116/133] (271s left) gem_create (hog-create)
[758.314538] Starting subtest: hog-create
[758.315470] Starting dynamic subtest: lmem0
[790.600239] Dynamic subtest lmem0: SUCCESS (32.285s)
[790.613628] Starting dynamic subtest: smem0
[822.877341] Dynamic subtest smem0: SUCCESS (32.275s)
[822.878342] Subtest hog-create: SUCCESS (64.562s)
[823.072135] [117/133] (206s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[823.280212] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[823.281871] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[823.350831] [118/133] (206s left) kms_selftest (drm_format)
[823.405295] Starting subtest: drm_format
[823.447591] Starting dynamic subtest: drm_test_format_block_width_invalid
[823.543628] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.095s)
[823.587070] Starting dynamic subtest: drm_test_format_block_width_one_plane
[823.638861] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.091s)
[823.681299] Starting dynamic subtest: drm_test_format_block_width_two_plane
[823.726911] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.084s)
[823.765697] Starting dynamic subtest: drm_test_format_block_width_three_plane
[823.803095] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.074s)
[823.831549] Starting dynamic subtest: drm_test_format_block_width_tiled
[823.891291] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.085s)
[823.932432] Starting dynamic subtest: drm_test_format_block_height_invalid
[823.973317] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.079s)
[824.003037] Starting dynamic subtest: drm_test_format_block_height_one_plane
[824.072479] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.096s)
[824.088074] Starting dynamic subtest: drm_test_format_block_height_two_plane
[824.154511] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.079s)
[824.167879] Starting dynamic subtest: drm_test_format_block_height_three_plane
[824.234291] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.077s)
[824.250067] Starting dynamic subtest: drm_test_format_block_height_tiled
[824.327274] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.089s)
[824.370755] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[824.407320] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.077s)
[824.438908] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[824.498279] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.087s)
[824.511905] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[824.575269] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.073s)
[824.617174] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[824.656104] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.077s)
[824.685530] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[824.739451] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.080s)
[824.781406] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[824.844523] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.100s)
[824.887020] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[824.936292] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.087s)
[824.951628] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[825.015296] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.075s)
[825.016835] Subtest drm_format: SUCCESS (1.610s)
[825.188120] [119/133] (204s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[825.368980] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[825.370823] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[825.434514] [120/133] (204s left) syncobj_basic (bad-fd-to-handle)
[825.512559] Starting subtest: bad-fd-to-handle
[825.513412] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[825.628684] [121/133] (204s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[825.822567] Starting subtest: x-tiled-32bpp-rotate-180
[827.604122] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.782s)
[827.763358] [122/133] (202s left) gem_tiled_wc
[827.945050] [123/133] (202s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[828.130579] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[828.133055] Starting dynamic subtest: pipe-A-DP-3
[828.141399] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[828.152959] Starting dynamic subtest: pipe-B-DP-3
[828.161056] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[828.172482] Starting dynamic subtest: pipe-C-DP-3
[828.180740] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[828.192041] Starting dynamic subtest: pipe-D-DP-3
[828.202627] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[828.204861] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[828.534176] [124/133] (201s left) gem_softpin (softpin)
[828.618774] Starting subtest: softpin
[861.030451] Subtest softpin: SUCCESS (32.410s)
[861.120801] [125/133] (169s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[861.308133] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[861.309882] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[861.410950] [126/133] (168s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[861.678590] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[861.833811] [127/133] (168s left) sysfs_preempt_timeout (idempotent)
[861.929606] Starting subtest: idempotent
[861.931846] Starting dynamic subtest: vecs0
[861.932754] Dynamic subtest vecs0: SUCCESS (0.001s)
[861.945438] Starting dynamic subtest: ccs0
[861.946592] Dynamic subtest ccs0: SUCCESS (0.001s)
[861.958671] Starting dynamic subtest: vcs0
[861.959874] Dynamic subtest vcs0: SUCCESS (0.001s)
[861.971600] Starting dynamic subtest: bcs0
[861.972498] Dynamic subtest bcs0: SUCCESS (0.001s)
[861.984704] Starting dynamic subtest: vecs1
[861.985879] Dynamic subtest vecs1: SUCCESS (0.001s)
[861.997662] Starting dynamic subtest: rcs0
[861.998810] Dynamic subtest rcs0: SUCCESS (0.001s)
[862.010374] Starting dynamic subtest: vcs1
[862.011643] Dynamic subtest vcs1: SUCCESS (0.001s)
[862.012847] Subtest idempotent: SUCCESS (0.013s)
[862.059181] [128/133] (168s left) gem_userptr_blits (dmabuf-unsync)
[862.145885] Subtest dmabuf-unsync: SKIP (0.000s)
[862.261760] [129/133] (168s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[862.450201] Starting subtest: psr-rgb101010-draw-pwrite
[862.451955] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[862.520573] [130/133] (168s left) kms_pm_dc (dc9-dpms)
[863.714262] Starting subtest: dc9-dpms
[864.214692] Subtest dc9-dpms: SUCCESS (0.501s)
[864.353148] [131/133] (166s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[864.546052] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[864.547918] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[864.645213] [132/133] (166s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[864.831426] Starting subtest: fb-8bpc-vs-panel-6bpc
[864.832306] Starting dynamic subtest: pipe-A-DP-3
[865.248706] Dynamic subtest pipe-A-DP-3: SUCCESS (0.414s)
[865.249964] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (0.418s)
[865.433725] [133/133] (165s left) gem_ctx_persistence (hostile)
[865.516408] Starting subtest: hostile
[875.674237] Subtest hostile: SUCCESS (10.153s)
[875.823097] Closing watchdogs
results: parsing output: 0/ for test: syncobj_eventfd
results: parsing output: 1/ for test: kms_pwrite_crc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_eio
results: parsing output: 4/ for test: gem_render_copy_redux
results: parsing output: 5/ for test: kms_lease
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: kms_prime
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_vblank
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_joiner
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: gem_ctx_shared
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: dumb_buffer
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_plane_cursor
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_feature_discovery
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: i915_module_load
results: parsing output: 45/ for test: kms_color_pipeline
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_rotation_crc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: vgem_basic
results: parsing output: 50/ for test: gem_ctx_param
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_caching
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: gem_madvise
results: parsing output: 56/ for test: prime_vgem
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_pread
results: parsing output: 61/ for test: kms_atomic_transition
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: gem_pxp
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_psr2_su
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_cursor_edge_walk
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: i915_suspend
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_chamelium_color
results: parsing output: 82/ for test: kms_plane_cursor
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_huc_copy
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_flush
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: i915_pm_rps
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: api_intel_allocator
results: parsing output: 115/ for test: gem_create
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_selftest
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: syncobj_basic
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_tiled_wc
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: sysfs_preempt_timeout
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_pm_dc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_dither
results: parsing output: 132/ for test: gem_ctx_persistence
Done.