[62.745429] Initializing watchdogs [62.745511] /dev/watchdog0 [62.776547] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [62.792153] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [62.796953] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.800417] [001/156] (960s left) kms_plane_cursor (primary) [64.300472] Starting subtest: primary [64.303255] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64 [67.385466] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.079s) [67.443930] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128 [70.489676] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.050s) [70.546206] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256 [73.674946] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.134s) [73.758915] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64 [76.960270] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.209s) [77.001051] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128 [80.161805] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.167s) [80.201122] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256 [83.345859] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.150s) [83.428954] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64 [86.644319] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.223s) [86.693557] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128 [89.876025] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.200s) [89.922166] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256 [93.061353] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.150s) [93.127413] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64 [96.326564] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.208s) [96.367238] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128 [99.494751] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.134s) [99.534032] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256 [102.677898] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.150s) [102.735433] Subtest primary: SUCCESS (38.420s) [102.951362] [002/156] (920s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [104.444391] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [104.484228] Starting dynamic subtest: pipe-A-plane-0 [105.035660] Dynamic subtest pipe-A-plane-0: SUCCESS (0.550s) [105.071946] Starting dynamic subtest: pipe-A-plane-3 [105.385131] Dynamic subtest pipe-A-plane-3: SUCCESS (0.349s) [105.417481] Starting dynamic subtest: pipe-A-plane-5 [105.735250] Dynamic subtest pipe-A-plane-5: SUCCESS (0.349s) [105.768256] Starting dynamic subtest: pipe-A-plane-7 [105.772035] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [105.909970] Starting dynamic subtest: pipe-B-plane-0 [106.302735] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s) [106.335618] Starting dynamic subtest: pipe-B-plane-3 [106.653556] Dynamic subtest pipe-B-plane-3: SUCCESS (0.349s) [106.692847] Starting dynamic subtest: pipe-B-plane-5 [106.986929] Dynamic subtest pipe-B-plane-5: SUCCESS (0.332s) [107.025610] Starting dynamic subtest: pipe-B-plane-7 [107.029830] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [107.075049] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SUCCESS (2.630s) [107.246725] [003/156] (916s left) gem_exec_schedule (preempt-self) [107.316608] Starting subtest: preempt-self [107.318239] Starting dynamic subtest: rcs0 [107.357932] Dynamic subtest rcs0: SUCCESS (0.041s) [107.368738] Starting dynamic subtest: bcs0 [107.380900] Dynamic subtest bcs0: SUCCESS (0.023s) [107.390790] Starting dynamic subtest: vcs0 [107.406469] Dynamic subtest vcs0: SUCCESS (0.025s) [107.416183] Starting dynamic subtest: vcs1 [107.431426] Dynamic subtest vcs1: SUCCESS (0.024s) [107.441204] Starting dynamic subtest: vecs0 [107.454850] Dynamic subtest vecs0: SUCCESS (0.023s) [107.456872] Subtest preempt-self: SUCCESS (0.138s) [107.903521] [004/156] (915s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [109.402928] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [109.406810] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [109.565712] [005/156] (914s left) kms_ccs (random-ccs-data-y-tiled-ccs) [111.058140] Starting subtest: random-ccs-data-y-tiled-ccs [111.059680] Starting dynamic subtest: pipe-A-HDMI-A-3 [111.076498] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [111.086153] Starting dynamic subtest: pipe-B-HDMI-A-3 [111.103269] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [111.112651] Starting dynamic subtest: pipe-C-HDMI-A-3 [111.129934] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [111.139217] Starting dynamic subtest: pipe-D-HDMI-A-3 [111.158901] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [111.162252] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s) [111.322432] [006/156] (912s left) kms_flip (dpms-off-confusion) [112.813175] Starting subtest: dpms-off-confusion [112.819224] Starting dynamic subtest: A-HDMI-A3 [120.609893] Dynamic subtest A-HDMI-A3: SUCCESS (7.790s) [120.620812] Starting dynamic subtest: B-HDMI-A3 [128.307208] Dynamic subtest B-HDMI-A3: SUCCESS (7.695s) [128.320244] Starting dynamic subtest: C-HDMI-A3 [135.999287] Dynamic subtest C-HDMI-A3: SUCCESS (7.689s) [136.009648] Starting dynamic subtest: D-HDMI-A3 [143.693267] Dynamic subtest D-HDMI-A3: SUCCESS (7.693s) [143.694717] Subtest dpms-off-confusion: SUCCESS (30.882s) [143.909903] [007/156] (879s left) perf_pmu (all-busy-check-all) [143.962695] Starting subtest: all-busy-check-all [144.532727] Subtest all-busy-check-all: SUCCESS (0.570s) [144.643881] [008/156] (879s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [146.135046] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [146.205682] [009/156] (877s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc) [147.703669] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc [147.706864] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [147.870720] [010/156] (876s left) syncobj_timeline (wait-delayed-signal) [147.922992] Starting subtest: wait-delayed-signal [148.029949] Subtest wait-delayed-signal: SUCCESS (0.105s) [148.199234] [011/156] (875s left) syncobj_timeline (reset-signaled) [148.245183] Starting subtest: reset-signaled [148.246822] Subtest reset-signaled: SUCCESS (0.001s) [148.343488] [012/156] (875s left) gem_exec_reloc (basic-range) [148.396928] Subtest basic-range: SKIP (0.000s) [148.489485] [013/156] (875s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [149.988210] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu [149.991698] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [150.161986] [014/156] (874s left) gem_mmap_gtt (bad-object) [150.214973] Subtest bad-object: SKIP (0.000s) [150.289063] [015/156] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [151.784225] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [151.787712] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [151.971179] [016/156] (872s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt) [153.472444] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt [153.476194] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [153.655692] [017/156] (870s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [155.146094] Starting subtest: cursorB-vs-flipB-atomic-transitions [155.149079] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [155.291584] [018/156] (869s left) kms_psr (pr-primary-blt) [156.793946] Subtest pr-primary-blt: SKIP (0.000s) [156.967814] [019/156] (867s left) gem_exec_params (invalid-ring2) [157.035193] Starting subtest: invalid-ring2 [157.036787] Subtest invalid-ring2: SUCCESS (0.000s) [157.159740] [020/156] (867s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [158.655967] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [158.675091] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.019s) [158.792904] [021/156] (866s left) kms_feature_discovery (psr2) [160.292776] Starting subtest: psr2 [160.295306] Subtest psr2: SKIP (0.000s) [160.403469] [022/156] (864s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs) [161.902719] Starting subtest: random-ccs-data-4-tiled-bmg-ccs [161.906210] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s) [162.130671] [023/156] (863s left) syncobj_basic (test-valid-cycle) [162.177805] Starting subtest: test-valid-cycle [162.179195] Subtest test-valid-cycle: SUCCESS (0.000s) [162.279872] [024/156] (862s left) kms_addfb_basic (bo-too-small) [163.767183] Starting subtest: bo-too-small [163.768814] Subtest bo-too-small: SUCCESS (0.000s) [163.948571] [025/156] (861s left) gem_mmap_wc (write-gtt-read-wc) [164.001934] Subtest write-gtt-read-wc: SKIP (0.000s) [164.108515] [026/156] (861s left) kms_frontbuffer_tracking (fbchdr-tiling-4) [165.606560] Starting subtest: fbchdr-tiling-4 [165.609628] Subtest fbchdr-tiling-4: SKIP (0.000s) [165.788017] [027/156] (859s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [167.288270] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [167.292172] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [167.469198] [028/156] (858s left) kms_big_fb (4-tiled-8bpp-rotate-0) [168.985253] Starting subtest: 4-tiled-8bpp-rotate-0 [168.988982] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s) [169.124269] [029/156] (856s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [170.624948] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [170.628833] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [170.787949] [030/156] (855s left) gem_exec_params (larger-than-life-batch) [170.845035] Starting subtest: larger-than-life-batch [181.985847] Subtest larger-than-life-batch: SUCCESS (11.138s) [182.589130] [031/156] (843s left) kms_dirtyfb (default-dirtyfb-ioctl) [184.132813] Starting subtest: default-dirtyfb-ioctl [184.134208] Starting dynamic subtest: A-HDMI-A-3 [185.557512] Dynamic subtest A-HDMI-A-3: SUCCESS (1.422s) [185.558922] Subtest default-dirtyfb-ioctl: SUCCESS (1.424s) [185.749782] [032/156] (840s left) gem_exec_whisper (basic-contexts-priority-all) [185.825501] Starting subtest: basic-contexts-priority-all [199.782821] Subtest basic-contexts-priority-all: SUCCESS (13.952s) [200.022536] [033/156] (826s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [200.082148] Starting subtest: etime-single-wait-all-for-submit-submitted [200.193526] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s) [200.348670] [034/156] (825s left) perf_pmu (busy-idle-no-semaphores) [200.400879] Starting subtest: busy-idle-no-semaphores [200.402333] Starting dynamic subtest: rcs0 [201.076434] Dynamic subtest rcs0: SUCCESS (0.671s) [201.088739] Starting dynamic subtest: bcs0 [201.736599] Dynamic subtest bcs0: SUCCESS (0.657s) [201.752895] Starting dynamic subtest: vcs0 [202.391133] Dynamic subtest vcs0: SUCCESS (0.651s) [202.406908] Starting dynamic subtest: vcs1 [203.045309] Dynamic subtest vcs1: SUCCESS (0.652s) [203.086160] Starting dynamic subtest: vecs0 [203.701714] Dynamic subtest vecs0: SUCCESS (0.654s) [203.704562] Subtest busy-idle-no-semaphores: SUCCESS (3.298s) [203.871255] [035/156] (822s left) kms_big_fb (y-tiled-8bpp-rotate-0) [205.386050] Starting subtest: y-tiled-8bpp-rotate-0 [207.107888] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.718s) [207.348546] [036/156] (819s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [208.859942] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [210.104704] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.244s) [210.298966] [037/156] (816s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [211.810707] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [211.814112] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [211.965779] [038/156] (814s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt) [213.466758] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt [213.470238] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [213.671540] [039/156] (813s left) gem_set_tiling_vs_blt (tiled-to-untiled) [213.729532] Subtest tiled-to-untiled: SKIP (0.000s) [213.818951] [040/156] (812s left) gem_exec_flush (basic-uc-prw-default) [213.875025] Subtest basic-uc-prw-default: SKIP (0.000s) [213.982747] [041/156] (812s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [215.481992] Starting subtest: fbcpsr-rgb565-draw-blt [215.485761] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s) [215.633148] [042/156] (811s left) kms_flip (nonblocking-read) [217.131484] Starting subtest: nonblocking-read [217.133203] Subtest nonblocking-read: SUCCESS (0.000s) [217.270644] [043/156] (809s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [218.784131] Starting subtest: fbc-rgb101010-draw-pwrite [219.704714] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (0.923s) [219.881277] [044/156] (807s left) kms_chamelium_edid (dp-edid-change-during-suspend) [221.412874] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [221.537779] [045/156] (805s left) syncobj_wait (multi-wait-all-for-submit-signaled) [221.589473] Starting subtest: multi-wait-all-for-submit-signaled [221.591161] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [221.695713] [046/156] (805s left) gem_userptr_blits (stress-purge) [221.758499] Starting subtest: stress-purge [227.136923] Subtest stress-purge: SUCCESS (5.378s) [227.315754] [047/156] (799s left) gen7_exec_parse (load-register-reg) [227.438672] Subtest load-register-reg: SKIP (0.000s) [227.523148] [048/156] (799s left) gem_render_copy (y-tiled) [227.581124] Starting subtest: y-tiled [227.582728] Starting dynamic subtest: smem [227.681518] Dynamic subtest smem: SUCCESS (0.100s) [227.693500] Starting dynamic subtest: lmem0 [228.440583] Dynamic subtest lmem0: SUCCESS (0.755s) [228.442239] Subtest y-tiled: SUCCESS (0.856s) [228.692578] [049/156] (798s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [230.194041] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [230.195505] Starting dynamic subtest: pipe-A-HDMI-A-3 [230.209930] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [230.222287] Starting dynamic subtest: pipe-B-HDMI-A-3 [230.236876] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [230.248802] Starting dynamic subtest: pipe-C-HDMI-A-3 [230.263727] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [230.275822] Starting dynamic subtest: pipe-D-HDMI-A-3 [230.292955] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [230.296520] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.006s) [230.471581] [050/156] (797s left) api_intel_bb (purge-bb) [230.522593] Starting subtest: purge-bb [230.538617] Subtest purge-bb: SUCCESS (0.017s) [230.741945] [051/156] (796s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [232.234144] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [232.313863] [052/156] (795s left) gem_userptr_blits (usage-restrictions) [232.370284] Starting subtest: usage-restrictions [232.371915] Subtest usage-restrictions: SUCCESS (0.000s) [232.558595] [053/156] (795s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [234.049572] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [234.051312] Starting dynamic subtest: pipe-A-valid-mode [234.871682] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.821s) [234.873191] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.823s) [235.103237] [054/156] (792s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [236.605037] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [236.608906] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [236.759474] [055/156] (791s left) gem_flink_race (flink_close) [236.807906] Starting subtest: flink_close [241.840100] Subtest flink_close: SUCCESS (5.031s) [241.991802] [056/156] (786s left) prime_busy (after) [242.067665] Starting subtest: after [242.073956] Starting dynamic subtest: rcs0 [242.117293] Dynamic subtest rcs0: SUCCESS (0.043s) [242.129105] Starting dynamic subtest: bcs0 [242.156129] Dynamic subtest bcs0: SUCCESS (0.038s) [242.168773] Starting dynamic subtest: vcs0 [242.197234] Dynamic subtest vcs0: SUCCESS (0.040s) [242.224239] Starting dynamic subtest: vcs1 [242.241454] Dynamic subtest vcs1: SUCCESS (0.043s) [242.268160] Starting dynamic subtest: vecs0 [242.282694] Dynamic subtest vecs0: SUCCESS (0.040s) [242.408512] Subtest after: SUCCESS (0.336s) [242.573375] [057/156] (785s left) gem_ctx_param (invalid-ctx-set) [242.621480] Starting subtest: invalid-ctx-set [242.622919] Subtest invalid-ctx-set: SUCCESS (0.001s) [242.737294] [058/156] (785s left) kms_plane (pixel-format-4-tiled-modifier) [244.225956] Starting subtest: pixel-format-4-tiled-modifier [244.228821] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s) [244.363048] [059/156] (783s left) gem_exec_schedule (pi-shared-iova) [244.612558] Starting subtest: pi-shared-iova [244.614582] Starting dynamic subtest: rcs0 [244.795030] Dynamic subtest rcs0: SUCCESS (0.180s) [244.807687] Starting dynamic subtest: bcs0 [244.899493] Dynamic subtest bcs0: SUCCESS (0.107s) [244.911877] Starting dynamic subtest: vcs0 [245.021232] Dynamic subtest vcs0: SUCCESS (0.118s) [245.033620] Starting dynamic subtest: vcs1 [245.142572] Dynamic subtest vcs1: SUCCESS (0.120s) [245.154986] Starting dynamic subtest: vecs0 [245.264981] Dynamic subtest vecs0: SUCCESS (0.121s) [245.266846] Subtest pi-shared-iova: SUCCESS (0.651s) [245.597374] [060/156] (782s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt) [247.095164] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt [247.103248] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [247.270893] [061/156] (781s left) vgem_basic (bad-flag) [247.390793] Starting subtest: bad-flag [247.393913] Subtest bad-flag: SUCCESS (0.000s) [247.490605] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true [247.493453] [062/156] (781s left) kms_psr (fbc-psr2-cursor-render) [248.985041] Subtest fbc-psr2-cursor-render: SKIP (0.000s) [249.071371] [063/156] (779s left) gem_partial_pwrite_pread (reads) [249.127872] Subtest reads: SKIP (0.000s) [249.220029] [064/156] (779s left) kms_invalid_mode (bad-vsync-start) [250.710739] Starting subtest: bad-vsync-start [250.712300] Starting dynamic subtest: pipe-A-HDMI-A-3 [250.746958] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.034s) [250.759677] Starting dynamic subtest: pipe-B-HDMI-A-3 [250.761394] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [250.773353] Starting dynamic subtest: pipe-C-HDMI-A-3 [250.775041] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [250.787206] Starting dynamic subtest: pipe-D-HDMI-A-3 [250.788834] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [250.790486] Subtest bad-vsync-start: SUCCESS (0.043s) [250.945133] [065/156] (777s left) kms_psr (fbc-psr-cursor-render) [252.435902] Subtest fbc-psr-cursor-render: SKIP (0.000s) [252.512890] [066/156] (776s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [252.568329] Starting subtest: x-tiled-to-vebox-y-tiled [252.569908] Starting dynamic subtest: smem [252.652416] Dynamic subtest smem: SUCCESS (0.084s) [252.664788] Starting dynamic subtest: lmem0 [253.403908] Dynamic subtest lmem0: SUCCESS (0.747s) [253.405813] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.833s) [253.678815] [067/156] (775s left) kms_rotation_crc (primary-rotation-180) [255.167364] Starting subtest: primary-rotation-180 [265.775747] Subtest primary-rotation-180: SUCCESS (10.609s) [266.018672] [068/156] (763s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt) [267.518143] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt [267.521680] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [267.684692] [069/156] (761s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [269.184228] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [269.187648] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [269.398429] [070/156] (759s left) gem_spin_batch (legacy) [269.460617] Starting subtest: legacy [269.462170] Starting dynamic subtest: default [272.709557] Dynamic subtest default: SUCCESS (3.243s) [272.722164] Starting dynamic subtest: render [275.945322] Dynamic subtest render: SUCCESS (3.231s) [275.957487] Starting dynamic subtest: bsd [279.179976] Dynamic subtest bsd: SUCCESS (3.229s) [279.192539] Starting dynamic subtest: bsd1 [282.416598] Dynamic subtest bsd1: SUCCESS (3.231s) [282.429035] Starting dynamic subtest: bsd2 [285.651825] Dynamic subtest bsd2: SUCCESS (3.231s) [285.664469] Starting dynamic subtest: blt [288.888590] Dynamic subtest blt: SUCCESS (3.232s) [288.901010] Starting dynamic subtest: vebox [292.122788] Dynamic subtest vebox: SUCCESS (3.229s) [292.124476] Subtest legacy: SUCCESS (22.659s) [292.370382] [071/156] (737s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render) [293.870055] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render [293.873880] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [294.053043] [072/156] (735s left) gem_pwrite (basic-random) [294.104061] Subtest basic-random: SKIP (0.000s) [294.204331] [073/156] (735s left) kms_psr (fbc-pr-cursor-plane-onoff) [295.694402] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [295.774202] [074/156] (733s left) kms_atomic_transition (modeset-transition-nonblocking) [297.266450] Starting subtest: modeset-transition-nonblocking [297.267995] Starting dynamic subtest: 1x-outputs [299.465391] Dynamic subtest 1x-outputs: SUCCESS (2.195s) [299.468263] Subtest modeset-transition-nonblocking: SUCCESS (2.198s) [299.684711] [075/156] (730s left) kms_cursor_crc (cursor-sliding-256x85) [301.418986] Starting subtest: cursor-sliding-256x85 [301.423954] Starting dynamic subtest: pipe-A-HDMI-A-3 [305.861742] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.438s) [305.896047] Starting dynamic subtest: pipe-D-HDMI-A-3 [310.203253] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.317s) [310.204744] Subtest cursor-sliding-256x85: SUCCESS (8.784s) [310.596736] [076/156] (719s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [312.089333] Starting subtest: cursorA-vs-flipA-atomic-transitions [323.008484] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.920s) [323.212353] [077/156] (706s left) kms_color_pipeline (plane-ctm3x4-lut1d) [324.734730] Starting subtest: plane-ctm3x4-lut1d [324.933248] Starting dynamic subtest: pipe-A-plane-0 [325.181034] Dynamic subtest pipe-A-plane-0: SUCCESS (0.248s) [325.226120] Starting dynamic subtest: pipe-A-plane-1 [325.379108] Dynamic subtest pipe-A-plane-1: SUCCESS (0.192s) [325.391883] Starting dynamic subtest: pipe-A-plane-2 [325.549911] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [325.850671] Starting dynamic subtest: pipe-B-plane-0 [326.009046] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s) [326.048018] Starting dynamic subtest: pipe-B-plane-1 [326.211304] Dynamic subtest pipe-B-plane-1: SUCCESS (0.192s) [326.244905] Starting dynamic subtest: pipe-B-plane-2 [326.412136] Dynamic subtest pipe-B-plane-2: SUCCESS (0.192s) [326.750054] Starting dynamic subtest: pipe-C-plane-0 [326.922066] Dynamic subtest pipe-C-plane-0: SUCCESS (0.196s) [326.962600] Starting dynamic subtest: pipe-C-plane-1 [327.138750] Dynamic subtest pipe-C-plane-1: SUCCESS (0.209s) [327.181492] Starting dynamic subtest: pipe-C-plane-2 [327.355095] Dynamic subtest pipe-C-plane-2: SUCCESS (0.209s) [327.709406] Starting dynamic subtest: pipe-D-plane-0 [327.885847] Dynamic subtest pipe-D-plane-0: SUCCESS (0.213s) [327.902378] Starting dynamic subtest: pipe-D-plane-1 [328.069119] Dynamic subtest pipe-D-plane-1: SUCCESS (0.178s) [328.104468] Starting dynamic subtest: pipe-D-plane-2 [328.285970] Dynamic subtest pipe-D-plane-2: SUCCESS (0.209s) [328.340427] Subtest plane-ctm3x4-lut1d: SUCCESS (3.606s) [328.599435] [078/156] (701s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [328.655411] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [328.730507] [079/156] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [330.226833] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [330.230879] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [330.397806] [080/156] (699s left) kms_prop_blob (blob-prop-validate) [330.449177] Starting subtest: blob-prop-validate [330.450824] Subtest blob-prop-validate: SUCCESS (0.000s) [330.660239] [081/156] (699s left) i915_pm_rpm (system-suspend) [335.085835] Starting subtest: system-suspend [362.209386] Subtest system-suspend: SUCCESS (12.081s) [367.180198] [082/156] (667s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [367.255996] Starting subtest: yf-tiled-to-vebox-x-tiled [367.257587] Starting dynamic subtest: smem [367.338501] Dynamic subtest smem: SUCCESS (0.082s) [367.353066] Starting dynamic subtest: lmem0 [368.096545] Dynamic subtest lmem0: SUCCESS (0.753s) [368.098255] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.838s) [368.349494] [083/156] (666s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [369.849103] Starting subtest: hdr-rgb565-draw-blt [369.852566] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [370.033065] [084/156] (664s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [371.532474] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt [371.535755] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [371.700683] [085/156] (663s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [373.201759] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu [373.205142] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [373.384510] [086/156] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [374.884192] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [374.887176] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [375.112996] [087/156] (659s left) kms_vrr (flip-basic-fastset) [376.604158] Starting subtest: flip-basic-fastset [376.609827] Subtest flip-basic-fastset: SKIP (0.000s) [376.728482] [088/156] (658s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [378.238818] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt [378.242607] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [378.394759] [089/156] (656s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [379.909606] Starting subtest: yf-tiled-8bpp-rotate-270 [379.912810] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [380.095200] [090/156] (655s left) gen3_render_tiledy_blits [380.228107] [091/156] (655s left) gem_ctx_param (non-root-set) [380.299214] Starting subtest: non-root-set [380.323296] Subtest non-root-set: SUCCESS (0.029s) [380.490546] [092/156] (655s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary) [381.991955] Starting subtest: fbcpsrhdr-shrfb-scaledprimary [381.995790] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s) [382.151720] [093/156] (653s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [383.653144] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [383.656552] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [383.825226] [094/156] (651s left) kms_cursor_crc (cursor-offscreen-64x21) [385.471789] Starting subtest: cursor-offscreen-64x21 [385.475706] Starting dynamic subtest: pipe-A-HDMI-A-3 [387.982751] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.507s) [388.021248] Starting dynamic subtest: pipe-D-HDMI-A-3 [390.394147] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.385s) [390.395798] Subtest cursor-offscreen-64x21: SUCCESS (4.923s) [390.882458] [095/156] (644s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [392.385172] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [392.388866] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [392.560775] [096/156] (643s left) syncobj_wait (reset-signaled) [392.613790] Starting subtest: reset-signaled [392.615833] Subtest reset-signaled: SUCCESS (0.000s) [392.740105] [097/156] (643s left) kms_flip (2x-flip-vs-modeset-vs-hang) [394.234398] Starting subtest: 2x-flip-vs-modeset-vs-hang [394.237594] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.003s) [394.403857] [098/156] (641s left) kms_vblank (query-busy-hang) [395.893486] Starting subtest: query-busy-hang [395.897452] Starting dynamic subtest: pipe-A-HDMI-A-3 [422.500100] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.605s) [422.518490] Starting dynamic subtest: pipe-D-HDMI-A-3 [447.503455] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.999s) [447.505146] Subtest query-busy-hang: SUCCESS (51.612s) [447.723284] [099/156] (588s left) kms_cursor_crc (cursor-random-32x32) [449.300724] Starting subtest: cursor-random-32x32 [449.351475] Subtest cursor-random-32x32: SKIP (0.047s) [449.768663] [100/156] (586s left) gem_mmap_offset (mmap-unmap) [449.817181] Starting subtest: mmap-unmap [449.818781] Starting dynamic subtest: lmem0 [451.491347] Dynamic subtest lmem0: SUCCESS (1.671s) [451.506434] Starting dynamic subtest: smem0 [453.876211] Dynamic subtest smem0: SUCCESS (2.383s) [453.877854] Subtest mmap-unmap: SUCCESS (4.057s) [454.114528] [101/156] (582s left) kms_psr (psr-sprite-mmap-cpu) [455.607219] Subtest psr-sprite-mmap-cpu: SKIP (0.000s) [455.696913] [102/156] (580s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-render) [457.199861] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-render [457.203842] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [457.377896] [103/156] (579s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [458.869393] Starting subtest: plane-upscale-factor-0-25-with-modifiers [458.870797] Starting dynamic subtest: pipe-A [459.593594] Dynamic subtest pipe-A: SUCCESS (0.725s) [459.614475] Starting dynamic subtest: pipe-B [460.367912] Dynamic subtest pipe-B: SUCCESS (0.772s) [460.383246] Starting dynamic subtest: pipe-C [461.140676] Dynamic subtest pipe-C: SUCCESS (0.771s) [461.162883] Starting dynamic subtest: pipe-D [461.914801] Dynamic subtest pipe-D: SUCCESS (0.772s) [461.916666] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (3.048s) [462.151422] [104/156] (574s left) gem_userptr_blits (dmabuf-sync) [462.218587] Starting subtest: dmabuf-sync [462.221502] Subtest dmabuf-sync: SKIP (0.003s) [462.428381] [105/156] (574s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt) [463.928646] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt [463.932489] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [464.170560] [106/156] (572s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [465.686715] Starting subtest: 2x-flip-vs-blocking-wf-vblank [465.706845] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.019s) [465.835166] [107/156] (571s left) gem_lmem_swapping (parallel-multi) [470.207075] Starting subtest: parallel-multi [470.208487] Starting dynamic subtest: lmem0 [525.217546] Dynamic subtest lmem0: SUCCESS (55.017s) [525.219987] Subtest parallel-multi: SUCCESS (55.019s) [526.201371] [FACT gem_lmem_swapping (parallel-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [526.202493] [FACT gem_lmem_swapping (parallel-multi)] deleted: kernel.kmod_is_loaded.i915: true [526.205848] [108/156] (510s left) gem_ctx_shared (q-in-order) [529.536541] Starting subtest: Q-in-order [529.538493] Starting dynamic subtest: rcs0 [529.738502] Dynamic subtest rcs0: SUCCESS (0.199s) [529.753554] Starting dynamic subtest: bcs0 [529.859654] Dynamic subtest bcs0: SUCCESS (0.122s) [529.874014] Starting dynamic subtest: vcs0 [529.985779] Dynamic subtest vcs0: SUCCESS (0.123s) [530.000424] Starting dynamic subtest: vcs1 [530.111691] Dynamic subtest vcs1: SUCCESS (0.124s) [530.125678] Starting dynamic subtest: vecs0 [530.248730] Dynamic subtest vecs0: SUCCESS (0.135s) [530.250538] Subtest Q-in-order: SUCCESS (0.712s) [530.540191] [FACT gem_ctx_shared (q-in-order)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [530.543493] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.i915: true [530.547882] [109/156] (506s left) perf_pmu (semaphore-wait-idle) [530.604927] Starting subtest: semaphore-wait-idle [530.606691] Starting dynamic subtest: rcs0 [531.140541] Dynamic subtest rcs0: SUCCESS (0.531s) [531.154936] Starting dynamic subtest: bcs0 [531.655767] Dynamic subtest bcs0: SUCCESS (0.510s) [531.708609] Starting dynamic subtest: vcs0 [532.188542] Dynamic subtest vcs0: SUCCESS (0.525s) [532.202822] Starting dynamic subtest: vcs1 [532.703379] Dynamic subtest vcs1: SUCCESS (0.509s) [532.717774] Starting dynamic subtest: vecs0 [533.218387] Dynamic subtest vecs0: SUCCESS (0.510s) [533.220118] Subtest semaphore-wait-idle: SUCCESS (2.614s) [533.400112] [110/156] (503s left) kms_chamelium_hpd (hdmi-hpd-storm) [534.935063] Subtest hdmi-hpd-storm: SKIP (0.000s) [535.067993] [111/156] (502s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [536.569565] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [536.573646] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [536.756504] [112/156] (500s left) syncobj_wait (wait-any-interrupted) [536.813784] Starting subtest: wait-any-interrupted [536.913809] Subtest wait-any-interrupted: SUCCESS (0.106s) [537.123847] [113/156] (500s left) kms_content_protection (lic-type-0) [538.676625] Starting subtest: lic-type-0 [538.681581] Subtest lic-type-0: SKIP (0.002s) [538.862354] [114/156] (498s left) kms_big_fb (linear-8bpp-rotate-0) [540.372861] Starting subtest: linear-8bpp-rotate-0 [541.166420] Subtest linear-8bpp-rotate-0: FAIL (0.087s) [541.271659] [115/156] (496s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt) [542.769362] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt [542.772328] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [543.025808] [116/156] (494s left) syncobj_timeline (multi-wait-available-signaled) [543.076576] Starting subtest: multi-wait-available-signaled [543.077922] Subtest multi-wait-available-signaled: SUCCESS (0.001s) [543.195081] [117/156] (494s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt) [544.694882] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt [544.698918] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [544.907528] [118/156] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [546.410772] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [546.415006] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [546.554135] [119/156] (491s left) gem_ctx_isolation (nonpriv) [546.616353] Starting subtest: nonpriv [546.617805] Starting dynamic subtest: rcs0 [547.668362] Dynamic subtest rcs0: SUCCESS (1.052s) [547.683372] Starting dynamic subtest: bcs0 [548.828119] Dynamic subtest bcs0: SUCCESS (1.156s) [548.841835] Starting dynamic subtest: vcs0 [549.956558] Dynamic subtest vcs0: SUCCESS (1.127s) [549.970449] Starting dynamic subtest: vcs1 [551.052884] Dynamic subtest vcs1: SUCCESS (1.098s) [551.067201] Starting dynamic subtest: vecs0 [552.181771] Dynamic subtest vecs0: SUCCESS (1.124s) [552.183417] Subtest nonpriv: SUCCESS (5.565s) [552.470584] [120/156] (485s left) api_intel_allocator (fork-simple-once) [552.532916] Starting subtest: fork-simple-once [552.570817] Subtest fork-simple-once: SUCCESS (0.040s) [552.784490] [121/156] (485s left) gem_compute (compute-square) [552.852785] Starting subtest: compute-square [552.876152] Subtest compute-square: SUCCESS (0.024s) [553.096649] [122/156] (485s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [553.157114] Starting subtest: etime-multi-wait-available-unsubmitted [553.249864] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s) [553.438328] [123/156] (485s left) gem_exec_balancer (persistence) [553.812268] Starting subtest: persistence [555.906125] Subtest persistence: SUCCESS (2.091s) [556.038863] [124/156] (482s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [557.538936] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [557.542545] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [557.795057] [125/156] (480s left) gem_ctx_persistence (legacy-engines-persistence) [557.864185] Starting subtest: legacy-engines-persistence [557.865715] Starting dynamic subtest: render [558.643770] Dynamic subtest render: SUCCESS (0.778s) [558.661855] Starting dynamic subtest: bsd1 [559.400702] Dynamic subtest bsd1: SUCCESS (0.754s) [559.418864] Starting dynamic subtest: bsd2 [560.167611] Dynamic subtest bsd2: SUCCESS (0.765s) [560.184789] Starting dynamic subtest: blt [560.940661] Dynamic subtest blt: SUCCESS (0.771s) [560.958106] Starting dynamic subtest: vebox [561.712780] Dynamic subtest vebox: SUCCESS (0.769s) [561.714606] Subtest legacy-engines-persistence: SUCCESS (3.850s) [561.965582] [126/156] (476s left) gem_mmap_gtt (basic) [562.017650] Subtest basic: SKIP (0.000s) [562.107333] [127/156] (476s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [563.626397] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [563.629815] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [563.819524] [128/156] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [565.320709] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [565.326652] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [565.572319] [129/156] (473s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [567.069587] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [567.072811] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [567.252497] [130/156] (472s left) gem_mmap_gtt (basic-small-bo-tiledx) [567.303058] Subtest basic-small-bo-tiledX: SKIP (0.000s) [567.383325] [131/156] (472s left) kms_pm_dc (dc6-dpms) [569.881447] Starting subtest: dc6-dpms [569.885772] Subtest dc6-dpms: SKIP (0.000s) [570.031672] [132/156] (469s left) gem_exec_fence (syncobj-invalid-wait) [570.467840] Starting subtest: syncobj-invalid-wait [570.469467] Subtest syncobj-invalid-wait: SUCCESS (0.001s) [570.999160] [133/156] (468s left) gem_blits (basic) [571.069440] Starting subtest: basic [578.865218] Subtest basic: SUCCESS (7.793s) [579.119187] [134/156] (460s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [580.617489] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc [580.621315] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [580.819706] [135/156] (459s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [582.322802] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [582.326200] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [582.504612] [136/156] (457s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc) [584.003132] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc [584.006405] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [584.191188] [137/156] (455s left) kms_addfb_basic (addfb25-x-tiled-legacy) [585.683131] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [585.945439] [138/156] (454s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [587.445777] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [587.449599] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [587.682964] [139/156] (452s left) gem_exec_balancer (invalid-balancer) [587.744474] Starting subtest: invalid-balancer [589.801890] Subtest invalid-balancer: SUCCESS (2.054s) [590.301838] [140/156] (450s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [591.790934] Starting subtest: bad-rotation-90-yf-tiled-ccs [591.792683] Starting dynamic subtest: pipe-A-HDMI-A-3 [591.808602] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [591.822555] Starting dynamic subtest: pipe-B-HDMI-A-3 [591.835508] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [591.849321] Starting dynamic subtest: pipe-C-HDMI-A-3 [591.862490] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [591.876596] Starting dynamic subtest: pipe-D-HDMI-A-3 [591.891686] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [591.894545] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.010s) [592.067844] [141/156] (448s left) kms_psr (psr2-sprite-mmap-gtt) [593.591441] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s) [593.773409] [142/156] (446s left) gem_eio (hibernate) [593.972385] Starting subtest: hibernate [610.788913] Subtest hibernate: SUCCESS (16.816s) [617.358177] [143/156] (428s left) gem_softpin (overlap) [617.414320] Starting subtest: overlap [621.166134] Subtest overlap: SUCCESS (3.748s) [621.318308] [144/156] (424s left) gem_render_copy (y-tiled-ccs-to-linear) [621.386289] Starting subtest: y-tiled-ccs-to-linear [621.387934] Starting dynamic subtest: smem [621.475490] Dynamic subtest smem: SUCCESS (0.088s) [621.493168] Starting dynamic subtest: lmem0 [621.788710] Dynamic subtest lmem0: SUCCESS (0.308s) [621.790675] Subtest y-tiled-ccs-to-linear: SUCCESS (0.400s) [622.052852] [145/156] (423s left) i915_hangman (engine-engine-hang) [622.122658] Starting subtest: engine-engine-hang [622.124349] Starting dynamic subtest: rcs0 [622.817803] Dynamic subtest rcs0: SUCCESS (0.695s) [622.833818] Starting dynamic subtest: bcs0 [623.484673] Dynamic subtest bcs0: SUCCESS (0.665s) [623.501433] Starting dynamic subtest: vcs0 [624.153790] Dynamic subtest vcs0: SUCCESS (0.667s) [624.170595] Starting dynamic subtest: vcs1 [624.828835] Dynamic subtest vcs1: SUCCESS (0.673s) [624.847779] Starting dynamic subtest: vecs0 [625.493795] Dynamic subtest vecs0: SUCCESS (0.663s) [625.495389] Subtest engine-engine-hang: SUCCESS (3.372s) [625.714449] [146/156] (420s left) gem_exec_flush (basic-uc-rw-default) [625.769837] Subtest basic-uc-rw-default: SKIP (0.000s) [625.892420] [147/156] (420s left) i915_drm_fdinfo (basics) [625.948669] Starting subtest: basics [625.950646] Subtest basics: SUCCESS (0.000s) [626.076057] [148/156] (420s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [627.569569] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [627.572548] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.000s) [627.693868] [149/156] (418s left) drm_mm (drm_mm) [627.756094] Starting subtest: drm_mm [627.831021] Starting dynamic subtest: drm_test_mm_init [627.864856] Dynamic subtest drm_test_mm_init: SUCCESS (0.071s) [627.908407] Starting dynamic subtest: drm_test_mm_debug [627.938280] Dynamic subtest drm_test_mm_debug: SUCCESS (0.071s) [627.963606] Starting dynamic subtest: drm_test_mm_align32 [628.028489] Dynamic subtest drm_test_mm_align32: SUCCESS (0.087s) [628.080374] Starting dynamic subtest: drm_test_mm_align64 [628.118023] Dynamic subtest drm_test_mm_align64: SUCCESS (0.083s) [628.136606] Starting dynamic subtest: drm_test_mm_lowest [628.188710] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.069s) [628.231525] Starting dynamic subtest: drm_test_mm_highest [628.270663] Dynamic subtest drm_test_mm_highest: SUCCESS (0.077s) [628.272673] Subtest drm_mm: SUCCESS (0.514s) [628.547009] [150/156] (417s left) gem_tiled_partial_pwrite_pread (reads) [628.602046] Subtest reads: SKIP (0.000s) [628.695518] [151/156] (417s left) i915_query (test-query-geometry-subslices) [628.754745] Starting subtest: test-query-geometry-subslices [628.758027] Subtest test-query-geometry-subslices: SKIP (0.000s) [628.871858] [152/156] (417s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [630.362999] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [630.364735] Starting dynamic subtest: pipe-A-HDMI-A-3 [630.369865] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [630.386073] Starting dynamic subtest: pipe-B-HDMI-A-3 [630.391318] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [630.406933] Starting dynamic subtest: pipe-C-HDMI-A-3 [630.412203] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [630.427554] Starting dynamic subtest: pipe-D-HDMI-A-3 [630.432859] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [630.435633] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s) [630.646146] [153/156] (416s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [632.138518] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [632.140015] Starting dynamic subtest: pipe-A-HDMI-A-3 [632.154429] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [632.170477] Starting dynamic subtest: pipe-B-HDMI-A-3 [632.185411] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [632.200819] Starting dynamic subtest: pipe-C-HDMI-A-3 [632.216049] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [632.231218] Starting dynamic subtest: pipe-D-HDMI-A-3 [632.248040] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [632.251121] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.010s) [632.423475] [154/156] (414s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [633.944586] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [633.946073] Starting dynamic subtest: pipe-A [636.667876] Dynamic subtest pipe-A: SUCCESS (2.723s) [636.706540] Starting dynamic subtest: pipe-B [639.473660] Dynamic subtest pipe-B: SUCCESS (2.803s) [639.507732] Starting dynamic subtest: pipe-C [639.797388] Dynamic subtest pipe-C: SUCCESS (0.321s) [639.825698] Starting dynamic subtest: pipe-D [640.120896] Dynamic subtest pipe-D: SUCCESS (0.321s) [640.122950] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.179s) [640.359303] [155/156] (406s left) kms_lease (possible-crtcs-filtering) [641.891883] Starting subtest: possible-crtcs-filtering [641.898685] Subtest possible-crtcs-filtering: SUCCESS (0.007s) [642.075632] [156/156] (404s left) kms_getfb (getfb-reject-nv12) [643.567129] Starting subtest: getfb-reject-nv12 [643.568860] Subtest getfb-reject-nv12: SUCCESS (0.002s) [643.772146] Closing watchdogs results: parsing output: 0/ for test: kms_plane_cursor results: parsing output: 1/ for test: kms_plane results: parsing output: 2/ for test: gem_exec_schedule results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_flip results: parsing output: 6/ for test: perf_pmu results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: gem_exec_reloc results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_mmap_gtt results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: gem_exec_params results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: kms_feature_discovery results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: syncobj_basic results: parsing output: 23/ for test: kms_addfb_basic results: parsing output: 24/ for test: gem_mmap_wc results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_exec_params results: parsing output: 30/ for test: kms_dirtyfb results: parsing output: 31/ for test: gem_exec_whisper results: parsing output: 32/ for test: syncobj_timeline results: parsing output: 33/ for test: perf_pmu results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_set_tiling_vs_blt results: parsing output: 39/ for test: gem_exec_flush results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_flip results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_chamelium_edid results: parsing output: 44/ for test: syncobj_wait results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: gen7_exec_parse results: parsing output: 47/ for test: gem_render_copy results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: api_intel_bb results: parsing output: 50/ for test: kms_psr2_sf results: parsing output: 51/ for test: gem_userptr_blits results: parsing output: 52/ for test: kms_flip_scaled_crc results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_flink_race results: parsing output: 55/ for test: prime_busy results: parsing output: 56/ for test: gem_ctx_param results: parsing output: 57/ for test: kms_plane results: parsing output: 58/ for test: gem_exec_schedule results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: vgem_basic results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: gem_partial_pwrite_pread results: parsing output: 63/ for test: kms_invalid_mode results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: gem_render_copy results: parsing output: 66/ for test: kms_rotation_crc results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_spin_batch results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: gem_pwrite results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_atomic_transition results: parsing output: 74/ for test: kms_cursor_crc results: parsing output: 75/ for test: kms_cursor_legacy results: parsing output: 76/ for test: kms_color_pipeline results: parsing output: 77/ for test: kms_pipe_b_c_ivb results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_prop_blob results: parsing output: 80/ for test: i915_pm_rpm results: parsing output: 81/ for test: gem_render_copy results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_vrr results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: gen3_render_tiledy_blits results: parsing output: 90/ for test: gem_ctx_param results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_cursor_crc results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: kms_vblank results: parsing output: 98/ for test: kms_cursor_crc results: parsing output: 99/ for test: gem_mmap_offset results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_plane_scaling results: parsing output: 103/ for test: gem_userptr_blits results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: gem_lmem_swapping results: parsing output: 107/ for test: gem_ctx_shared results: parsing output: 108/ for test: perf_pmu results: parsing output: 109/ for test: kms_chamelium_hpd results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_content_protection results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: syncobj_timeline results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_ctx_isolation results: parsing output: 119/ for test: api_intel_allocator results: parsing output: 120/ for test: gem_compute results: parsing output: 121/ for test: syncobj_timeline results: parsing output: 122/ for test: gem_exec_balancer results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_ctx_persistence results: parsing output: 125/ for test: gem_mmap_gtt results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_mmap_gtt results: parsing output: 130/ for test: kms_pm_dc results: parsing output: 131/ for test: gem_exec_fence results: parsing output: 132/ for test: gem_blits results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_addfb_basic results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: gem_exec_balancer results: parsing output: 139/ for test: kms_ccs results: parsing output: 140/ for test: kms_psr results: parsing output: 141/ for test: gem_eio results: parsing output: 142/ for test: gem_softpin results: parsing output: 143/ for test: gem_render_copy results: parsing output: 144/ for test: i915_hangman results: parsing output: 145/ for test: gem_exec_flush results: parsing output: 146/ for test: i915_drm_fdinfo results: parsing output: 147/ for test: kms_flip_scaled_crc results: parsing output: 148/ for test: drm_mm results: parsing output: 149/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 150/ for test: i915_query results: parsing output: 151/ for test: kms_ccs results: parsing output: 152/ for test: kms_ccs results: parsing output: 153/ for test: kms_plane_scaling results: parsing output: 154/ for test: kms_lease results: parsing output: 155/ for test: kms_getfb Done.