[70.871357] Initializing watchdogs
[70.871441]   /dev/watchdog0
[70.899873] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[70.913494] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[70.918274] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.920864] [001/131] (960s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[73.071186] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[73.073941] Starting dynamic subtest: pipe-A-HDMI-A-4
[74.991426] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.916s)
[74.998508] Starting dynamic subtest: pipe-B-HDMI-A-4
[75.098301] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.105s)
[75.105447] Starting dynamic subtest: pipe-C-HDMI-A-4
[75.201402] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.102s)
[75.208861] Starting dynamic subtest: pipe-D-HDMI-A-4
[75.305059] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.103s)
[75.305895] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.231s)
[75.539501] [002/131] (955s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[77.540973] Starting subtest: addfb25-y-tiled-legacy
[77.541875] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[77.692703] [003/131] (953s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[79.712327] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[79.713322] Starting dynamic subtest: pipe-A-HDMI-A-4
[79.723044] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[79.730465] Starting dynamic subtest: pipe-B-HDMI-A-4
[79.740283] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[79.747410] Starting dynamic subtest: pipe-C-HDMI-A-4
[79.757560] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[79.764596] Starting dynamic subtest: pipe-D-HDMI-A-4
[79.774495] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[79.776532] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[79.933030] [004/131] (951s left) kms_psr (fbc-psr2-sprite-render)
[81.934999] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[81.993340] [005/131] (949s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[83.992567] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[83.993463] Starting dynamic subtest: pipe-A-valid-mode
[86.394260] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.401s)
[86.396124] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (2.402s)
[86.568489] [006/131] (945s left) drm_fdinfo (virtual-idle)
[86.627490] Starting subtest: virtual-idle
[89.208343] Subtest virtual-idle: SUCCESS (2.577s)
[89.306552] [007/131] (942s left) gem_ctx_exec (basic)
[89.358812] Starting subtest: basic
[89.362537] Subtest basic: SUCCESS (0.005s)
[89.526111] [008/131] (942s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[89.585529] Starting subtest: y-tiled-ccs-to-y-tiled
[89.586406] Starting dynamic subtest: smem
[89.675199] Dynamic subtest smem: SUCCESS (0.089s)
[89.682351] Starting dynamic subtest: lmem0
[90.619379] Dynamic subtest lmem0: SUCCESS (0.941s)
[90.620563] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (1.031s)
[90.888738] [009/131] (941s left) sysfs_heartbeat_interval (nopreempt)
[90.944140] Starting subtest: nopreempt
[90.945111] Starting dynamic subtest: vecs0
[96.527174] Dynamic subtest vecs0: SUCCESS (5.582s)
[96.535518] Starting dynamic subtest: vcs0
[100.392328] Dynamic subtest vcs0: SUCCESS (3.862s)
[100.422405] Starting dynamic subtest: bcs0
[104.257219] Dynamic subtest bcs0: SUCCESS (3.866s)
[104.265388] Starting dynamic subtest: rcs0
[108.165293] Dynamic subtest rcs0: SUCCESS (3.908s)
[108.177319] Starting dynamic subtest: vcs1
[112.047574] Dynamic subtest vcs1: SUCCESS (3.882s)
[112.048809] Subtest nopreempt: SUCCESS (21.103s)
[112.200047] [010/131] (919s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[114.203199] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[114.257803] [011/131] (917s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[116.257870] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[116.258871] Starting dynamic subtest: pipe-A-valid-mode
[116.298837] Dynamic subtest pipe-A-valid-mode: SKIP (0.041s)
[116.300427] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.042s)
[116.432691] [012/131] (915s left) kms_cursor_crc (cursor-offscreen-max-size)
[118.674717] Starting subtest: cursor-offscreen-max-size
[118.677453] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[118.901610] [013/131] (913s left) kms_plane (pixel-format-source-clamping)
[120.899502] Starting subtest: pixel-format-source-clamping
[120.939526] Starting dynamic subtest: pipe-A-plane-0
[128.439109] Dynamic subtest pipe-A-plane-0: SUCCESS (7.499s)
[128.448475] Starting dynamic subtest: pipe-A-plane-3
[134.654400] Dynamic subtest pipe-A-plane-3: SUCCESS (6.215s)
[134.663589] Starting dynamic subtest: pipe-A-plane-5
[138.370585] Dynamic subtest pipe-A-plane-5: SUCCESS (3.716s)
[138.379832] Starting dynamic subtest: pipe-A-plane-7
[138.381066] Dynamic subtest pipe-A-plane-7: SUCCESS (0.000s)
[138.512734] Starting dynamic subtest: pipe-B-plane-0
[145.854395] Dynamic subtest pipe-B-plane-0: SUCCESS (7.349s)
[145.863433] Starting dynamic subtest: pipe-B-plane-3
[152.186880] Dynamic subtest pipe-B-plane-3: SUCCESS (6.332s)
[152.195930] Starting dynamic subtest: pipe-B-plane-5
[156.136428] Dynamic subtest pipe-B-plane-5: SUCCESS (3.949s)
[156.145941] Starting dynamic subtest: pipe-B-plane-7
[156.147344] Dynamic subtest pipe-B-plane-7: SUCCESS (0.000s)
[156.208540] Subtest pixel-format-source-clamping: SUCCESS (35.309s)
[156.387900] [014/131] (875s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[158.385902] Starting subtest: cursorA-vs-flipB-atomic
[158.388935] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[158.502806] [015/131] (873s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[160.539123] Starting subtest: x-tiled-16bpp-rotate-90
[160.631537] Subtest x-tiled-16bpp-rotate-90: SKIP (0.092s)
[160.795779] [016/131] (871s left) gem_exec_schedule (u-semaphore-noskip)
[160.863444] Starting subtest: u-semaphore-noskip
[161.276929] Subtest u-semaphore-noskip: SUCCESS (0.410s)
[161.671341] [017/131] (870s left) syncobj_timeline (32bits-limit)
[161.721479] Starting subtest: 32bits-limit
[161.723477] Subtest 32bits-limit: SUCCESS (0.001s)
[161.835899] [018/131] (870s left) gem_linear_blits (interruptible)
[162.345463] Starting subtest: interruptible
[169.865907] Subtest interruptible: SUCCESS (7.519s)
[170.022226] [019/131] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[172.081893] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[172.084063] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[172.260889] [020/131] (860s left) kms_psr (psr2-primary-page-flip)
[174.264357] Subtest psr2-primary-page-flip: SKIP (0.000s)
[174.327767] [021/131] (858s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[176.368413] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[176.470660] [022/131] (856s left) kms_dirtyfb (default-dirtyfb-ioctl)
[178.482052] Starting subtest: default-dirtyfb-ioctl
[178.488215] Starting dynamic subtest: A-HDMI-A-4
[179.939770] Dynamic subtest A-HDMI-A-4: SUCCESS (1.454s)
[179.940605] Subtest default-dirtyfb-ioctl: SUCCESS (1.462s)
[180.097525] [023/131] (852s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[180.154874] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[180.155882] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[180.270850] [024/131] (852s left) prime_vgem (coherency-blt)
[180.418856] Starting subtest: coherency-blt
[182.703837] Subtest coherency-blt: SUCCESS (2.282s)
[182.867181] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[182.869651] [025/131] (850s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[184.870051] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[184.872120] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[185.073230] [026/131] (848s left) kms_prop_blob (blob-prop-lifetime)
[185.125197] Starting subtest: blob-prop-lifetime
[185.126116] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[185.254929] [027/131] (847s left) drm_fdinfo (busy-idle)
[185.309944] Starting subtest: busy-idle
[185.310885] Starting dynamic subtest: rcs0
[185.312820] Dynamic subtest rcs0: SKIP (0.000s)
[185.322301] Starting dynamic subtest: bcs0
[185.324082] Dynamic subtest bcs0: SKIP (0.000s)
[185.333144] Starting dynamic subtest: vcs0
[185.335132] Dynamic subtest vcs0: SKIP (0.000s)
[185.344189] Starting dynamic subtest: vcs1
[185.345957] Dynamic subtest vcs1: SKIP (0.000s)
[185.354755] Starting dynamic subtest: vecs0
[185.357483] Dynamic subtest vecs0: SKIP (0.000s)
[185.359243] Subtest busy-idle: SKIP (0.006s)
[185.415381] [028/131] (847s left) gem_gpgpu_fill (offset-16x16)
[185.467268] Starting subtest: offset-16x16
[185.485159] Subtest offset-16x16: SUCCESS (0.018s)
[185.648479] [029/131] (847s left) kms_pm_dc (dc5-psr)
[188.655380] Starting subtest: dc5-psr
[188.657262] Subtest dc5-psr: SKIP (0.000s)
[188.797400] [030/131] (844s left) gem_pxp (fail-invalid-protected-context)
[191.394403] Starting subtest: fail-invalid-protected-context
[191.396456] Subtest fail-invalid-protected-context: SKIP (0.000s)
[191.515823] [031/131] (841s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[193.514217] Starting subtest: crc-primary-basic-y-tiled-ccs
[193.515209] Starting dynamic subtest: pipe-A-HDMI-A-4
[193.523664] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[193.533125] Starting dynamic subtest: pipe-B-HDMI-A-4
[193.541906] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[193.551073] Starting dynamic subtest: pipe-C-HDMI-A-4
[193.559776] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[193.568708] Starting dynamic subtest: pipe-D-HDMI-A-4
[193.577530] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[193.579256] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.011s)
[193.745682] [032/131] (839s left) gem_render_copy (yf-tiled-ccs-to-linear)
[193.806687] Starting subtest: yf-tiled-ccs-to-linear
[193.807571] Starting dynamic subtest: smem
[193.892179] Dynamic subtest smem: SUCCESS (0.085s)
[193.901554] Starting dynamic subtest: lmem0
[194.200451] Dynamic subtest lmem0: SUCCESS (0.305s)
[194.201460] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.391s)
[194.447915] [033/131] (839s left) core_setmaster_vs_auth
[194.631531] [034/131] (839s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[194.682827] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[194.683731] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[194.795365] [035/131] (838s left) vgem_basic (dmabuf-fence-before)
[194.851297] Starting subtest: dmabuf-fence-before
[194.852311] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[194.957154] [036/131] (838s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[196.958999] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[196.960857] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[197.171336] [037/131] (836s left) kms_big_fb (linear-16bpp-rotate-180)
[199.187098] Starting subtest: linear-16bpp-rotate-180
[201.071390] Subtest linear-16bpp-rotate-180: SUCCESS (1.880s)
[201.303487] [038/131] (832s left) syncobj_timeline (wait-all-interrupted)
[201.356785] Starting subtest: wait-all-interrupted
[201.462049] Subtest wait-all-interrupted: SUCCESS (0.102s)
[201.596060] [039/131] (832s left) gem_exec_reloc (basic-cpu-active)
[201.650107] Subtest basic-cpu-active: SKIP (0.000s)
[201.739288] [040/131] (832s left) gem_ctx_param (non-root-set)
[201.790551] Starting subtest: non-root-set
[201.811867] Subtest non-root-set: SUCCESS (0.021s)
[201.979930] [041/131] (832s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[203.981919] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[203.983824] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[204.175844] [042/131] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[206.182211] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[206.184120] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[206.374451] [043/131] (828s left) gem_userptr_blits (input-checking)
[206.434798] Starting subtest: input-checking
[206.435664] Subtest input-checking: SUCCESS (0.000s)
[206.605138] [044/131] (828s left) api_intel_allocator (fork-simple-once)
[206.657131] Starting subtest: fork-simple-once
[206.687452] Subtest fork-simple-once: SUCCESS (0.031s)
[206.872416] [045/131] (827s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[208.869473] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[208.870348] Starting dynamic subtest: pipe-A-HDMI-A-4
[208.880129] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[208.889791] Starting dynamic subtest: pipe-B-HDMI-A-4
[208.899627] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[208.908986] Starting dynamic subtest: pipe-C-HDMI-A-4
[208.919386] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[208.928413] Starting dynamic subtest: pipe-D-HDMI-A-4
[208.938739] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[208.940616] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[209.102737] [046/131] (825s left) syncobj_timeline (signal)
[209.154558] Starting subtest: signal
[209.155507] Subtest signal: SUCCESS (0.000s)
[209.267322] [047/131] (825s left) perf (gen12-group-concurrent-oa-buffer-read)
[209.403153] Starting subtest: gen12-group-concurrent-oa-buffer-read
[219.449922] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.043s)
[219.517121] [048/131] (815s left) gem_create (create-ext-set-pat)
[219.705410] Starting subtest: create-ext-set-pat
[219.709771] Subtest create-ext-set-pat: SKIP (0.000s)
[219.864440] [049/131] (815s left) gem_exec_reloc (basic-gtt)
[219.919164] Subtest basic-gtt: SKIP (0.000s)
[220.014594] [050/131] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[222.016122] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[222.017978] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[222.176335] [051/131] (812s left) gem_userptr_blits (set-cache-level)
[222.246687] Starting subtest: set-cache-level
[222.247803] Subtest set-cache-level: SUCCESS (0.000s)
[222.447963] [052/131] (812s left) gem_exec_big (single)
[222.503135] Starting subtest: single
[229.758146] Subtest single: SUCCESS (7.252s)
[230.682466] [053/131] (804s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[232.741912] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[232.743796] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[232.866146] [054/131] (802s left) kms_getfb (getfb2-handle-closed)
[232.922110] Starting subtest: getfb2-handle-closed
[232.923111] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[233.098379] [055/131] (802s left) kms_vblank (query-idle-hang)
[235.093353] Starting subtest: query-idle-hang
[235.094352] Starting dynamic subtest: pipe-A-HDMI-A-4
[261.492427] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.397s)
[261.505650] Starting dynamic subtest: pipe-D-HDMI-A-4
[286.513291] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.014s)
[286.514113] Subtest query-idle-hang: SUCCESS (51.419s)
[286.695626] [056/131] (748s left) gem_exec_reloc (basic-write-read-noreloc)
[286.756053] Subtest basic-write-read-noreloc: SKIP (0.000s)
[286.837972] [057/131] (748s left) syncobj_timeline (invalid-signal-illegal-handle)
[286.894378] Starting subtest: invalid-signal-illegal-handle
[286.895226] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[287.007167] [058/131] (748s left) gem_exec_schedule (promotion)
[287.075984] Starting subtest: promotion
[287.076919] Starting dynamic subtest: rcs0
[287.264678] Dynamic subtest rcs0: SUCCESS (0.185s)
[287.273863] Starting dynamic subtest: bcs0
[287.396417] Dynamic subtest bcs0: SUCCESS (0.134s)
[287.405794] Starting dynamic subtest: vcs0
[287.531489] Dynamic subtest vcs0: SUCCESS (0.134s)
[287.541073] Starting dynamic subtest: vcs1
[287.676480] Dynamic subtest vcs1: SUCCESS (0.144s)
[287.685990] Starting dynamic subtest: vecs0
[287.822761] Dynamic subtest vecs0: SUCCESS (0.145s)
[287.823781] Subtest promotion: SUCCESS (0.747s)
[288.341230] [059/131] (747s left) kms_lease (lease-get)
[290.340197] Starting subtest: lease-get
[290.341111] Starting dynamic subtest: pipe-A-HDMI-A-4
[290.341999] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[290.353987] Starting dynamic subtest: pipe-B-HDMI-A-4
[290.354966] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[290.364474] Starting dynamic subtest: pipe-C-HDMI-A-4
[290.365402] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[290.374975] Starting dynamic subtest: pipe-D-HDMI-A-4
[290.375981] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[290.376969] Subtest lease-get: SUCCESS (0.012s)
[290.481872] [060/131] (745s left) gem_exec_gttfill (basic)
[290.567166] Starting subtest: basic
[297.075432] Subtest basic: SUCCESS (6.505s)
[297.413262] [061/131] (738s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[297.521399] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[297.629133] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[297.726154] [062/131] (738s left) gem_exec_fence (submit67)
[297.906579] Starting subtest: submit67
[297.908364] Subtest submit67: SKIP (0.000s)
[298.580203] [063/131] (737s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[300.589544] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[300.652045] [064/131] (735s left) i915_pciid
[300.818711] [065/131] (735s left) gem_mmap_gtt (cpuset-big-copy-odd)
[300.870421] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[300.937044] [066/131] (735s left) kms_fbcon_fbt (psr)
[300.992798] Starting subtest: psr
[300.994538] Subtest psr: SKIP (0.000s)
[301.143309] [067/131] (735s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[303.142704] Starting subtest: invalid-modeset-force-ultra-joiner
[303.144657] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[303.258399] [068/131] (733s left) kms_busy (basic)
[305.280259] Starting subtest: basic
[305.281138] Starting dynamic subtest: flip
[305.970598] Dynamic subtest flip: SUCCESS (0.690s)
[305.980303] Starting dynamic subtest: modeset
[306.613437] Dynamic subtest modeset: SUCCESS (0.642s)
[306.614270] Subtest basic: SUCCESS (1.335s)
[306.794534] [069/131] (729s left) gem_eio (in-flight-contexts-1us)
[306.992140] Starting subtest: in-flight-contexts-1us
[320.918438] Subtest in-flight-contexts-1us: SUCCESS (13.926s)
[323.005400] [070/131] (713s left) gem_ctx_param (vm)
[323.085881] Starting subtest: vm
[323.149124] Subtest vm: SUCCESS (0.064s)
[323.379750] [071/131] (713s left) kms_psr (fbc-pr-sprite-plane-onoff)
[325.378260] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[325.454167] [072/131] (711s left) gem_ccs (block-multicopy-compressed)
[325.511060] Starting subtest: block-multicopy-compressed
[325.513364] Subtest block-multicopy-compressed: SKIP (0.000s)
[325.669983] [073/131] (711s left) kms_chamelium_edid (dp-mode-timings)
[327.706318] Subtest dp-mode-timings: SKIP (0.000s)
[327.812023] [074/131] (709s left) i915_pm_rpm (gem-idle)
[332.082769] Starting subtest: gem-idle
[338.443753] Subtest gem-idle: SUCCESS (6.361s)
[339.550696] [075/131] (697s left) api_intel_bb (bb-with-allocator)
[339.621155] Starting subtest: bb-with-allocator
[339.637944] Subtest bb-with-allocator: SUCCESS (0.017s)
[339.843182] [076/131] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[341.843618] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[341.845233] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[342.073853] [077/131] (695s left) kms_atomic (atomic-plane-damage)
[344.073174] Starting subtest: atomic-plane-damage
[344.324357] Starting dynamic subtest: pipe-A-HDMI-A-4
[344.977737] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.654s)
[344.978738] Subtest atomic-plane-damage: SUCCESS (0.905s)
[345.164091] [078/131] (692s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[347.163435] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[347.164289] Starting dynamic subtest: pipe-A-HDMI-A-4
[347.167638] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[347.177375] Starting dynamic subtest: pipe-B-HDMI-A-4
[347.180773] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[347.190288] Starting dynamic subtest: pipe-C-HDMI-A-4
[347.193756] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[347.203222] Starting dynamic subtest: pipe-D-HDMI-A-4
[347.206790] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[347.208443] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.010s)
[347.406303] [079/131] (689s left) kms_psr (fbc-psr-primary-mmap-gtt)
[349.405706] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[349.484945] [080/131] (687s left) gem_exec_async (forked-writes)
[349.551287] Starting subtest: forked-writes
[349.552205] Starting dynamic subtest: rcs0
[349.606470] Dynamic subtest rcs0: SUCCESS (0.055s)
[349.617829] Starting dynamic subtest: bcs0
[349.650221] Dynamic subtest bcs0: SUCCESS (0.043s)
[349.661474] Starting dynamic subtest: vcs0
[349.693145] Dynamic subtest vcs0: SUCCESS (0.042s)
[349.704429] Starting dynamic subtest: vcs1
[349.735759] Dynamic subtest vcs1: SUCCESS (0.041s)
[349.746990] Starting dynamic subtest: vecs0
[349.777779] Dynamic subtest vecs0: SUCCESS (0.041s)
[349.778725] Subtest forked-writes: SUCCESS (0.227s)
[350.147300] [081/131] (687s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[352.150007] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[352.151761] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[352.380262] [082/131] (685s left) gem_exec_balancer (invalid-balancer)
[352.444300] Starting subtest: invalid-balancer
[354.037851] Subtest invalid-balancer: SUCCESS (1.590s)
[354.406440] [083/131] (683s left) gem_mmap_gtt (basic-short)
[354.457082] Subtest basic-short: SKIP (0.000s)
[354.534346] [084/131] (683s left) gem_mmap_offset (mmap-boundaries)
[354.587067] Starting subtest: mmap-boundaries
[354.588054] Starting dynamic subtest: lmem0
[354.866144] Dynamic subtest lmem0: SUCCESS (0.276s)
[354.876162] Starting dynamic subtest: smem0
[356.693424] Dynamic subtest smem0: SUCCESS (1.826s)
[356.694420] Subtest mmap-boundaries: SUCCESS (2.105s)
[357.005865] [085/131] (680s left) gem_reg_read (bad-register)
[357.053702] Starting subtest: bad-register
[357.054584] Subtest bad-register: SUCCESS (0.000s)
[357.156692] [086/131] (680s left) tools_test (tools_test)
[357.213652] Starting subtest: tools_test
[357.324327] Subtest tools_test: SUCCESS (0.118s)
[357.411443] [087/131] (680s left) kms_cursor_crc (cursor-sliding-256x85)
[359.586468] Starting subtest: cursor-sliding-256x85
[359.591361] Starting dynamic subtest: pipe-A-HDMI-A-4
[364.001040] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.409s)
[364.035290] Starting dynamic subtest: pipe-D-HDMI-A-4
[368.326730] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.301s)
[368.327680] Subtest cursor-sliding-256x85: SUCCESS (8.741s)
[368.638566] [088/131] (669s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[370.642167] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[370.643998] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[370.829087] [089/131] (667s left) gem_exec_schedule (lateslice)
[370.900622] Starting subtest: lateslice
[370.901525] Starting dynamic subtest: rcs0
[370.933978] Dynamic subtest rcs0: SUCCESS (0.034s)
[370.945674] Starting dynamic subtest: bcs0
[370.953534] Dynamic subtest bcs0: SUCCESS (0.018s)
[370.965220] Starting dynamic subtest: vcs0
[370.972591] Dynamic subtest vcs0: SUCCESS (0.018s)
[370.986383] Starting dynamic subtest: vcs1
[370.991529] Dynamic subtest vcs1: SUCCESS (0.018s)
[371.002942] Starting dynamic subtest: vecs0
[371.011248] Dynamic subtest vecs0: SUCCESS (0.018s)
[371.012099] Subtest lateslice: SUCCESS (0.113s)
[371.495284] [090/131] (666s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[373.500469] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[373.508949] Starting dynamic subtest: A-HDMI-A4
[381.655434] Dynamic subtest A-HDMI-A4: SUCCESS (8.146s)
[381.668108] Starting dynamic subtest: B-HDMI-A4
[389.752255] Dynamic subtest B-HDMI-A4: SUCCESS (8.094s)
[389.764514] Starting dynamic subtest: C-HDMI-A4
[397.848554] Dynamic subtest C-HDMI-A4: SUCCESS (8.095s)
[397.860446] Starting dynamic subtest: D-HDMI-A4
[405.948251] Dynamic subtest D-HDMI-A4: SUCCESS (8.098s)
[405.949158] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.448s)
[406.181092] [091/131] (632s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[408.180055] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[408.181979] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[408.389257] [092/131] (630s left) kms_psr (psr-suspend)
[410.389334] Subtest psr-suspend: SKIP (0.000s)
[410.458456] [093/131] (628s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[412.471459] Starting subtest: yf-tiled-32bpp-rotate-90
[412.473240] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[412.663294] [094/131] (625s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[414.667604] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[414.669277] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[414.860292] [095/131] (623s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[416.860484] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[416.861376] Starting dynamic subtest: pipe-A
[417.010679] Dynamic subtest pipe-A: SUCCESS (0.151s)
[417.025511] Starting dynamic subtest: pipe-B
[417.170036] Dynamic subtest pipe-B: SUCCESS (0.158s)
[417.181225] Starting dynamic subtest: pipe-C
[417.310858] Dynamic subtest pipe-C: SUCCESS (0.140s)
[417.322506] Starting dynamic subtest: pipe-D
[417.451269] Dynamic subtest pipe-D: SUCCESS (0.139s)
[417.452161] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.593s)
[417.636165] [096/131] (621s left) gem_mmap_gtt (hang)
[417.687350] Subtest hang: SKIP (0.000s)
[417.764915] [097/131] (621s left) gem_softpin (evict-prime)
[417.822236] Starting subtest: evict-prime
[417.823161] Starting dynamic subtest: rcs0
[419.043438] Dynamic subtest rcs0: SUCCESS (1.221s)
[419.058541] Starting dynamic subtest: bcs0
[420.265528] Dynamic subtest bcs0: SUCCESS (1.217s)
[420.275988] Starting dynamic subtest: vcs0
[421.446421] Dynamic subtest vcs0: SUCCESS (1.183s)
[421.459768] Starting dynamic subtest: vcs1
[422.632511] Dynamic subtest vcs1: SUCCESS (1.184s)
[422.647589] Starting dynamic subtest: vecs0
[423.830578] Dynamic subtest vecs0: SUCCESS (1.197s)
[423.843247] Starting dynamic subtest: all
[425.055593] Dynamic subtest all: SUCCESS (1.220s)
[425.056690] Subtest evict-prime: SUCCESS (7.231s)
[425.222375] [098/131] (613s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[427.224437] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[427.242958] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.018s)
[427.374306] [099/131] (611s left) gem_exec_whisper (basic-contexts)
[427.457917] Starting subtest: basic-contexts
[432.794979] Subtest basic-contexts: SUCCESS (5.333s)
[433.055873] [100/131] (606s left) core_hotunplug (unbind-rebind)
[433.174566] Starting subtest: unbind-rebind
[439.601452] Subtest unbind-rebind: SUCCESS (6.428s)
[439.664327] [101/131] (599s left) kms_dp_link_training (non-uhbr-mst)
[441.668250] Starting subtest: non-uhbr-mst
[441.672217] Subtest non-uhbr-mst: SKIP (0.000s)
[441.801297] [102/131] (597s left) kms_panel_fitting (legacy)
[443.819963] Starting subtest: legacy
[443.822048] Subtest legacy: SKIP (0.000s)
[443.951656] [103/131] (595s left) gem_ctx_persistence (saturated-hostile)
[444.029768] Starting subtest: saturated-hostile
[444.030848] Starting dynamic subtest: rcs0
[444.802435] Dynamic subtest rcs0: SUCCESS (0.774s)
[444.817231] Starting dynamic subtest: bcs0
[445.589917] Dynamic subtest bcs0: SUCCESS (0.784s)
[445.602552] Starting dynamic subtest: vcs0
[446.373889] Dynamic subtest vcs0: SUCCESS (0.781s)
[446.386240] Starting dynamic subtest: vcs1
[447.155914] Dynamic subtest vcs1: SUCCESS (0.779s)
[447.167862] Starting dynamic subtest: vecs0
[447.950815] Dynamic subtest vecs0: SUCCESS (0.792s)
[447.953402] Subtest saturated-hostile: SUCCESS (3.924s)
[448.099215] [104/131] (591s left) gem_eio (hibernate)
[448.261585] Starting subtest: hibernate
[465.630509] Subtest hibernate: SUCCESS (17.369s)
[467.637560] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         2260 [max: 8192]
 direct dependencies:                 26780 [max: 524288]
 indirect dependencies:              209124
 all direct dependencies:            558906
 dependency chains:                   43103 [max: 524288]
 dependency chain hlocks used:       197964 [max: 2621440]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     398
 in-softirq chains:                    1111
 in-process chains:                   41594
 stack-trace entries:                282752 [max: 524288]
 number of stack traces:              13142
 number of stack hash chains:          8982
 combined max dependencies:      1275333176
 hardirq-safe locks:                    121
 hardirq-unsafe locks:                 1337
 softirq-safe locks:                    256
 softirq-unsafe locks:                 1232
 irq-safe locks:                        277
 irq-unsafe locks:                     1337
 hardirq-read-safe locks:                 5
 hardirq-read-unsafe locks:             410
 softirq-read-safe locks:                 9
 softirq-read-unsafe locks:             405
 irq-read-safe locks:                     9
 irq-read-unsafe locks:                 410
 uncategorized locks:                   370
 unused locks:                            1
 max locking depth:                      18
 max bfs queue depth:                   390
 max lock class index:                 2259
 debug_locks:                             0

 zapped classes:                         16
 zapped lock chains:                   2268
 large chain blocks:                      1

[467.668039] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: drm_fdinfo
results: parsing output: 6/ for test: gem_ctx_exec
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: sysfs_heartbeat_interval
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_linear_blits
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_dirtyfb
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: prime_vgem
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_prop_blob
results: parsing output: 26/ for test: drm_fdinfo
results: parsing output: 27/ for test: gem_gpgpu_fill
results: parsing output: 28/ for test: kms_pm_dc
results: parsing output: 29/ for test: gem_pxp
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: core_setmaster_vs_auth
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: api_intel_allocator
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: gem_create
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: gem_exec_big
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_getfb
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: gem_exec_gttfill
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: i915_pciid
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_fbcon_fbt
results: parsing output: 66/ for test: kms_joiner
results: parsing output: 67/ for test: kms_busy
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_ccs
results: parsing output: 72/ for test: kms_chamelium_edid
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: api_intel_bb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_atomic
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_exec_async
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: gem_reg_read
results: parsing output: 85/ for test: tools_test
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: core_hotunplug
results: parsing output: 100/ for test: kms_dp_link_training
results: parsing output: 101/ for test: kms_panel_fitting
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_sequence
results: no output, setting notrun
results: parsing output: 105/ for test: kms_writeback
results: no output, setting notrun
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 108/ for test: gem_watchdog
results: no output, setting notrun
results: parsing output: 109/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 110/ for test: gem_ctx_param
results: no output, setting notrun
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 112/ for test: kms_color
results: no output, setting notrun
results: parsing output: 113/ for test: gen9_exec_parse
results: no output, setting notrun
results: parsing output: 114/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 115/ for test: gem_exec_flush
results: no output, setting notrun
results: parsing output: 116/ for test: gem_ctx_param
results: no output, setting notrun
results: parsing output: 117/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 118/ for test: gem_caching
results: no output, setting notrun
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 120/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 121/ for test: prime_busy
results: no output, setting notrun
results: parsing output: 122/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 123/ for test: kms_pm_rpm
results: no output, setting notrun
results: parsing output: 124/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: no output, setting notrun
results: parsing output: 126/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 127/ for test: gem_eio
results: no output, setting notrun
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 129/ for test: gem_mmap_wc
results: no output, setting notrun
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: no output, setting notrun
Done.