[66.689702] Initializing watchdogs [66.689771] /dev/watchdog0 [66.713007] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [66.725822] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [66.729886] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [66.732324] [001/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [68.290202] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc [68.292010] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [68.467764] [002/156] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [70.016913] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [70.018748] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [70.163851] [003/156] (957s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [71.718563] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [72.521722] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.803s) [72.745226] [004/156] (954s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt) [74.263996] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt [74.266040] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [74.458102] [005/156] (953s left) gem_exec_schedule (noreorder) [74.699048] Starting subtest: noreorder [74.700417] Starting dynamic subtest: rcs0 [74.809361] Dynamic subtest rcs0: SUCCESS (0.112s) [74.819559] Starting dynamic subtest: bcs0 [74.865535] Dynamic subtest bcs0: SUCCESS (0.056s) [74.881299] Starting dynamic subtest: vcs0 [74.939804] Dynamic subtest vcs0: SUCCESS (0.073s) [74.970475] Starting dynamic subtest: vcs1 [75.024907] Dynamic subtest vcs1: SUCCESS (0.084s) [75.048267] Starting dynamic subtest: vecs0 [75.096082] Dynamic subtest vecs0: SUCCESS (0.070s) [75.126795] Starting dynamic subtest: vecs1 [75.179404] Dynamic subtest vecs1: SUCCESS (0.083s) [75.196421] Starting dynamic subtest: ccs0 [75.235803] Dynamic subtest ccs0: SUCCESS (0.056s) [75.237451] Subtest noreorder: SUCCESS (0.538s) [75.512308] [006/156] (952s left) i915_drm_fdinfo (memory-info-active) [75.576716] Starting subtest: memory-info-active [75.577637] Starting dynamic subtest: lmem0 [78.581443] Dynamic subtest lmem0: SUCCESS (3.004s) [78.590116] Starting dynamic subtest: smem0 [82.387651] Dynamic subtest smem0: SUCCESS (3.796s) [82.388577] Subtest memory-info-active: SUCCESS (6.801s) [82.465726] [007/156] (945s left) kms_big_fb (linear-32bpp-rotate-270) [83.982559] Starting subtest: linear-32bpp-rotate-270 [84.040731] Subtest linear-32bpp-rotate-270: SKIP (0.058s) [84.217956] [008/156] (943s left) gem_render_copy (yf-tiled) [84.297713] Starting subtest: yf-tiled [84.300190] Subtest yf-tiled: SKIP (0.000s) [84.542048] [009/156] (943s left) gem_ctx_param (vm) [84.610385] Starting subtest: vm [84.702148] Subtest vm: SUCCESS (0.092s) [84.897958] [010/156] (943s left) prime_vgem (basic-read) [85.047770] Starting subtest: basic-read [85.053687] Subtest basic-read: SKIP (0.006s) [85.207809] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true [85.209783] [011/156] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [86.734842] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [86.736532] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [86.849354] [012/156] (941s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [88.383153] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [88.384931] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [88.472779] [013/156] (939s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [90.013444] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [90.015304] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [90.152731] [014/156] (938s left) gem_exec_params (invalid-fence-in-submit) [90.269173] Starting subtest: invalid-fence-in-submit [90.271607] Subtest invalid-fence-in-submit: SUCCESS (0.002s) [90.444852] [015/156] (937s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte) [91.962465] Starting subtest: fbcpsrhdr-2p-rte [91.964291] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s) [92.101751] [016/156] (936s left) gem_userptr_blits (sync-unmap-cycles) [92.226205] Starting subtest: sync-unmap-cycles [97.609037] Subtest sync-unmap-cycles: SUCCESS (5.383s) [97.749137] [017/156] (930s left) i915_pm_rpm (system-suspend-devices) [102.008740] Starting subtest: system-suspend-devices [110.385035] Subtest system-suspend-devices: SUCCESS (8.378s) [119.351629] [018/156] (917s left) kms_psr (pr-primary-mmap-cpu) [120.874178] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [120.935052] [019/156] (915s left) gem_exec_reloc (basic-range-active) [121.025528] Subtest basic-range-active: SKIP (0.000s) [121.103499] [020/156] (915s left) kms_vrr (lobf) [122.618482] Starting subtest: lobf [122.620281] Subtest lobf: SKIP (0.000s) [122.781765] [021/156] (913s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render) [124.324925] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render [124.326667] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [124.468682] [022/156] (912s left) kms_frontbuffer_tracking (hdr-modesetfrombusy) [126.020498] Starting subtest: hdr-modesetfrombusy [126.022250] Subtest hdr-modesetfrombusy: SKIP (0.000s) [126.167881] [023/156] (910s left) syncobj_wait (multi-wait-all-signaled) [126.278250] Starting subtest: multi-wait-all-signaled [126.279201] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [126.428615] [024/156] (910s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [127.945430] Starting subtest: nonblocking-crc-frame-sequence [127.946392] Starting dynamic subtest: pipe-A-HDMI-A-3 [128.644401] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.699s) [128.655629] Starting dynamic subtest: pipe-B-HDMI-A-3 [129.171349] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.525s) [129.181508] Starting dynamic subtest: pipe-C-HDMI-A-3 [129.703122] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.531s) [129.713390] Starting dynamic subtest: pipe-D-HDMI-A-3 [130.239454] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.536s) [130.240411] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.295s) [130.460899] [025/156] (906s left) kms_cursor_crc (cursor-offscreen-64x21) [132.144409] Starting subtest: cursor-offscreen-64x21 [132.149066] Starting dynamic subtest: pipe-A-HDMI-A-3 [134.638479] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.489s) [134.679595] Starting dynamic subtest: pipe-D-HDMI-A-3 [137.068180] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.398s) [137.069067] Subtest cursor-offscreen-64x21: SUCCESS (4.923s) [137.478634] [026/156] (899s left) gem_pipe_control_store_loop (reused-buffer) [137.567275] Starting subtest: reused-buffer [139.747293] Subtest reused-buffer: SUCCESS (2.180s) [139.918808] [027/156] (897s left) sw_sync (sync_multi_consumer) [139.968476] Starting subtest: sync_multi_consumer [140.328906] Subtest sync_multi_consumer: SUCCESS (0.361s) [140.415835] [028/156] (896s left) gem_exec_whisper (basic-fds-priority) [140.508983] Starting subtest: basic-fds-priority [163.125322] Subtest basic-fds-priority: SUCCESS (22.615s) [163.359883] [029/156] (873s left) gem_basic (bad-close) [163.439148] Starting subtest: bad-close [163.441196] Subtest bad-close: SUCCESS (0.000s) [163.583697] [030/156] (873s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [165.101167] Starting subtest: primary-4-tiled-reflect-x-0 [175.593847] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.492s) [175.909026] [031/156] (861s left) gem_exec_schedule (u-submit-golden-slice) [176.006987] Starting subtest: u-submit-golden-slice [176.007980] Starting dynamic subtest: rcs0 [176.086054] Dynamic subtest rcs0: SUCCESS (0.077s) [176.097135] Starting dynamic subtest: bcs0 [176.130197] Dynamic subtest bcs0: SUCCESS (0.047s) [176.141310] Starting dynamic subtest: vcs0 [176.178306] Dynamic subtest vcs0: SUCCESS (0.047s) [176.189405] Starting dynamic subtest: vcs1 [176.227940] Dynamic subtest vcs1: SUCCESS (0.050s) [176.238507] Starting dynamic subtest: vecs0 [176.280195] Dynamic subtest vecs0: SUCCESS (0.052s) [176.290682] Starting dynamic subtest: vecs1 [176.328498] Dynamic subtest vecs1: SUCCESS (0.048s) [176.339056] Starting dynamic subtest: ccs0 [176.378108] Dynamic subtest ccs0: SUCCESS (0.049s) [176.379134] Subtest u-submit-golden-slice: SUCCESS (0.372s) [176.858666] [032/156] (860s left) gem_busy (extended) [177.116971] Starting subtest: extended [177.117896] Starting dynamic subtest: rcs0 [177.193685] Dynamic subtest rcs0: SUCCESS (0.077s) [177.206854] Starting dynamic subtest: bcs0 [177.235227] Dynamic subtest bcs0: SUCCESS (0.041s) [177.248214] Starting dynamic subtest: vcs0 [177.276442] Dynamic subtest vcs0: SUCCESS (0.041s) [177.294782] Starting dynamic subtest: vcs1 [177.318938] Dynamic subtest vcs1: SUCCESS (0.042s) [177.344609] Starting dynamic subtest: vecs0 [177.362885] Dynamic subtest vecs0: SUCCESS (0.043s) [177.383518] Starting dynamic subtest: vecs1 [177.406493] Dynamic subtest vecs1: SUCCESS (0.043s) [177.424165] Starting dynamic subtest: ccs0 [177.448398] Dynamic subtest ccs0: SUCCESS (0.041s) [177.449566] Subtest extended: SUCCESS (0.333s) [177.742446] [033/156] (859s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [177.827049] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [177.913346] [034/156] (859s left) kms_force_connector_basic (prune-stale-modes) [178.070403] Starting subtest: prune-stale-modes [178.094524] Subtest prune-stale-modes: SUCCESS (0.024s) [179.810072] [035/156] (857s left) kms_big_fb (x-tiled-8bpp-rotate-180) [181.364693] Starting subtest: x-tiled-8bpp-rotate-180 [182.964976] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.600s) [183.092810] [036/156] (854s left) gem_exec_balancer (semaphore) [183.189139] Starting subtest: semaphore [184.878445] Subtest semaphore: SUCCESS (1.689s) [185.283644] [037/156] (852s left) kms_psr2_su (page_flip-xrgb8888) [185.357926] Subtest page_flip-XRGB8888: SKIP (0.000s) [185.428391] [038/156] (852s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw) [186.950523] Starting subtest: hdr-2p-pri-indfb-multidraw [186.952249] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s) [187.096852] [039/156] (850s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [187.787305] Starting subtest: syncobj-backward-timeline-chain-engines [187.968312] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.183s) [188.284110] [040/156] (849s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [189.807941] Starting subtest: fbc-shrfb-scaledprimary [191.148364] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.342s) [191.321044] [041/156] (846s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt) [192.848515] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt [192.850232] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [193.003750] [042/156] (845s left) kms_pm_rpm (modeset-lpsp) [196.998803] Starting subtest: modeset-lpsp [197.923095] Subtest modeset-lpsp: SKIP (0.924s) [198.944652] [043/156] (839s left) api_intel_allocator (gem-pool) [199.021225] Starting subtest: gem-pool [199.062512] Subtest gem-pool: SUCCESS (0.041s) [199.233239] [044/156] (839s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu) [200.754151] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu [200.755935] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [200.891580] [045/156] (837s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [202.439355] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [202.440264] Starting dynamic subtest: pipe-A-HDMI-A-3 [210.934431] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (8.491s) [210.945751] Starting dynamic subtest: pipe-B-HDMI-A-3 [211.643345] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.707s) [211.654539] Starting dynamic subtest: pipe-C-HDMI-A-3 [212.355021] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.707s) [212.370494] Starting dynamic subtest: pipe-D-HDMI-A-3 [213.063158] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.704s) [213.064795] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (10.620s) [213.383828] [046/156] (825s left) gem_mmap_wc (close) [213.468244] Subtest close: SKIP (0.000s) [213.554311] [047/156] (824s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [215.072275] Starting subtest: fbcpsr-rgb101010-draw-blt [215.074050] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s) [215.300425] [048/156] (823s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [216.835994] Starting subtest: extended-modeset-hang-oldfb-with-reset [216.836950] Starting dynamic subtest: pipe-A [227.631431] Dynamic subtest pipe-A: SUCCESS (10.794s) [227.644455] Starting dynamic subtest: pipe-D [238.337177] Dynamic subtest pipe-D: SUCCESS (10.703s) [238.338144] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.503s) [238.569122] [049/156] (800s left) gem_reg_read (timestamp-monotonic) [238.653241] Starting subtest: timestamp-monotonic [243.226358] Subtest timestamp-monotonic: SUCCESS (4.573s) [243.326078] [050/156] (795s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [244.844592] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [244.845507] Starting dynamic subtest: pipe-A-HDMI-A-3 [244.854423] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [244.866176] Starting dynamic subtest: pipe-B-HDMI-A-3 [244.875159] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [244.886539] Starting dynamic subtest: pipe-C-HDMI-A-3 [244.895206] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [244.906750] Starting dynamic subtest: pipe-D-HDMI-A-3 [244.915763] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [244.917504] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.005s) [245.164151] [051/156] (793s left) kms_cursor_edge_walk (64x64-top-bottom) [246.677310] Starting subtest: 64x64-top-bottom [246.678234] Starting dynamic subtest: pipe-A-HDMI-A-3 [250.019112] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.340s) [250.030786] Starting dynamic subtest: pipe-D-HDMI-A-3 [253.269248] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.249s) [253.270235] Subtest 64x64-top-bottom: SUCCESS (6.592s) [253.476469] [052/156] (785s left) sysfs_preempt_timeout (idempotent) [253.562554] Starting subtest: idempotent [253.563495] Starting dynamic subtest: vecs0 [253.564423] Dynamic subtest vecs0: SUCCESS (0.001s) [253.577125] Starting dynamic subtest: ccs0 [253.578320] Dynamic subtest ccs0: SUCCESS (0.001s) [253.589923] Starting dynamic subtest: vcs0 [253.591125] Dynamic subtest vcs0: SUCCESS (0.001s) [253.602607] Starting dynamic subtest: bcs0 [253.603520] Dynamic subtest bcs0: SUCCESS (0.001s) [253.615296] Starting dynamic subtest: vecs1 [253.616481] Dynamic subtest vecs1: SUCCESS (0.001s) [253.629186] Starting dynamic subtest: rcs0 [253.630267] Dynamic subtest rcs0: SUCCESS (0.001s) [253.641563] Starting dynamic subtest: vcs1 [253.642706] Dynamic subtest vcs1: SUCCESS (0.001s) [253.643788] Subtest idempotent: SUCCESS (0.010s) [253.690893] [053/156] (785s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [255.219430] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [255.221424] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [255.441804] [054/156] (783s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [256.964226] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt [256.966066] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [257.132283] [055/156] (782s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [257.233392] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [257.340034] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s) [257.477898] [056/156] (781s left) gen9_exec_parse (allowed-single) [257.567733] Subtest allowed-single: SKIP (0.000s) [257.634351] [057/156] (781s left) kms_color_pipeline (plane-ctm3x4) [259.153786] Starting subtest: plane-ctm3x4 [259.370935] Starting dynamic subtest: pipe-A-plane-0 [259.587455] Dynamic subtest pipe-A-plane-0: SUCCESS (0.216s) [259.625413] Starting dynamic subtest: pipe-A-plane-1 [259.787170] Dynamic subtest pipe-A-plane-1: SUCCESS (0.198s) [259.822292] Starting dynamic subtest: pipe-A-plane-2 [259.970506] Dynamic subtest pipe-A-plane-2: SUCCESS (0.181s) [260.275881] Starting dynamic subtest: pipe-B-plane-0 [260.407369] Dynamic subtest pipe-B-plane-0: SUCCESS (0.165s) [260.421055] Starting dynamic subtest: pipe-B-plane-1 [260.558382] Dynamic subtest pipe-B-plane-1: SUCCESS (0.150s) [260.594083] Starting dynamic subtest: pipe-B-plane-2 [260.741954] Dynamic subtest pipe-B-plane-2: SUCCESS (0.181s) [261.051133] Starting dynamic subtest: pipe-C-plane-0 [261.200940] Dynamic subtest pipe-C-plane-0: SUCCESS (0.183s) [261.237275] Starting dynamic subtest: pipe-C-plane-1 [261.401277] Dynamic subtest pipe-C-plane-1: SUCCESS (0.198s) [261.436623] Starting dynamic subtest: pipe-C-plane-2 [261.601299] Dynamic subtest pipe-C-plane-2: SUCCESS (0.198s) [261.936603] Starting dynamic subtest: pipe-D-plane-0 [262.101527] Dynamic subtest pipe-D-plane-0: SUCCESS (0.199s) [262.136602] Starting dynamic subtest: pipe-D-plane-1 [262.268131] Dynamic subtest pipe-D-plane-1: SUCCESS (0.164s) [262.301723] Starting dynamic subtest: pipe-D-plane-2 [262.451442] Dynamic subtest pipe-D-plane-2: SUCCESS (0.181s) [262.508597] Subtest plane-ctm3x4: SUCCESS (3.355s) [262.760973] [058/156] (776s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [264.280564] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu [264.282280] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [264.490869] [059/156] (775s left) i915_drm_fdinfo (virtual-busy-idle-all) [264.567494] Starting subtest: virtual-busy-idle-all [264.569339] Subtest virtual-busy-idle-all: SKIP (0.000s) [264.672990] [060/156] (774s left) gem_softpin (allocator-nopin-reserve) [264.761408] Starting subtest: allocator-nopin-reserve [265.007124] Subtest allocator-nopin-reserve: SUCCESS (0.246s) [265.190239] [061/156] (774s left) kms_chamelium_frames (dp-crc-multiple) [266.755668] Subtest dp-crc-multiple: SKIP (0.000s) [266.896270] [062/156] (772s left) kms_pm_rpm (dpms-non-lpsp) [271.078531] Starting subtest: dpms-non-lpsp [271.247347] Subtest dpms-non-lpsp: SUCCESS (0.169s) [272.114790] [063/156] (767s left) prime_busy (before) [272.214948] Starting subtest: before [272.220642] Starting dynamic subtest: rcs0 [272.274335] Dynamic subtest rcs0: SUCCESS (0.054s) [272.286402] Starting dynamic subtest: bcs0 [272.329563] Dynamic subtest bcs0: SUCCESS (0.054s) [272.350293] Starting dynamic subtest: vcs0 [272.370870] Dynamic subtest vcs0: SUCCESS (0.040s) [272.392391] Starting dynamic subtest: vcs1 [272.412126] Dynamic subtest vcs1: SUCCESS (0.040s) [272.436160] Starting dynamic subtest: vecs0 [272.454068] Dynamic subtest vecs0: SUCCESS (0.041s) [272.475405] Starting dynamic subtest: vecs1 [272.495850] Dynamic subtest vecs1: SUCCESS (0.041s) [272.517113] Starting dynamic subtest: ccs0 [272.537889] Dynamic subtest ccs0: SUCCESS (0.041s) [272.650156] Subtest before: SUCCESS (0.434s) [272.820849] [064/156] (767s left) gem_mmap_offset (open-flood) [272.899202] Starting subtest: open-flood [294.383901] Subtest open-flood: SUCCESS (21.484s) [294.543915] [065/156] (745s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [296.058410] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [296.060232] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s) [296.176622] [066/156] (743s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff) [297.717500] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff [297.719226] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [297.861292] [067/156] (742s left) gen7_exec_parse (basic-allocation) [297.976431] Subtest basic-allocation: SKIP (0.000s) [298.058659] [068/156] (742s left) kms_draw_crc (draw-method-mmap-cpu) [299.578277] Starting subtest: draw-method-mmap-cpu [299.579173] Starting dynamic subtest: xrgb8888-untiled [299.893854] Dynamic subtest xrgb8888-untiled: SUCCESS (0.316s) [299.934252] Starting dynamic subtest: rgb565-untiled [300.227362] Dynamic subtest rgb565-untiled: SUCCESS (0.331s) [300.265135] Starting dynamic subtest: xrgb2101010-untiled [300.526541] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s) [300.540499] Starting dynamic subtest: xbgr16161616f-untiled [300.827443] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.299s) [300.864601] Starting dynamic subtest: xrgb8888-xtiled [301.010961] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.181s) [301.050796] Starting dynamic subtest: rgb565-xtiled [301.194208] Dynamic subtest rgb565-xtiled: SUCCESS (0.180s) [301.234219] Starting dynamic subtest: xrgb2101010-xtiled [301.360794] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s) [301.378764] Starting dynamic subtest: xbgr16161616f-xtiled [301.509992] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.147s) [301.522384] Starting dynamic subtest: xrgb8888-4tiled [301.677703] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s) [301.716706] Starting dynamic subtest: rgb565-4tiled [301.877597] Dynamic subtest rgb565-4tiled: SUCCESS (0.197s) [301.893103] Starting dynamic subtest: xrgb2101010-4tiled [302.027530] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.147s) [302.067747] Starting dynamic subtest: xbgr16161616f-4tiled [302.226610] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.197s) [302.227543] Subtest draw-method-mmap-cpu: SUCCESS (2.650s) [302.387671] [069/156] (737s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu) [303.915163] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu [303.916782] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [304.140680] [070/156] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [305.662935] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [305.664624] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [305.887033] [071/156] (734s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [307.410872] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [307.411791] Starting dynamic subtest: pipe-A-HDMI-A-3 [307.415220] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [307.427367] Starting dynamic subtest: pipe-B-HDMI-A-3 [307.431052] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [307.443013] Starting dynamic subtest: pipe-C-HDMI-A-3 [307.446855] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [307.458383] Starting dynamic subtest: pipe-D-HDMI-A-3 [307.462326] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [307.464619] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.007s) [307.736749] [072/156] (732s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt) [309.261764] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt [309.263442] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [309.487753] [073/156] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [311.008518] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [311.010262] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [311.159746] [074/156] (729s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [312.713436] Starting subtest: psr-modesetfrombusy [312.715193] Subtest psr-modesetfrombusy: SKIP (0.000s) [312.897815] [075/156] (728s left) kms_properties (crtc-properties-atomic) [314.431994] Starting subtest: crtc-properties-atomic [314.432982] Starting dynamic subtest: pipe-A-HDMI-A-3 [314.743323] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.311s) [314.762815] Starting dynamic subtest: pipe-B-HDMI-A-3 [315.035149] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.290s) [315.048618] Starting dynamic subtest: pipe-C-HDMI-A-3 [315.337480] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.300s) [315.349508] Starting dynamic subtest: pipe-D-HDMI-A-3 [315.620208] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.282s) [315.621206] Subtest crtc-properties-atomic: SUCCESS (1.190s) [315.836180] [076/156] (725s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [315.923528] Starting subtest: y-tiled-to-vebox-y-tiled [315.925438] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [316.139878] [077/156] (724s left) syncobj_basic (bad-fd-to-handle) [316.221566] Starting subtest: bad-fd-to-handle [316.222445] Subtest bad-fd-to-handle: SUCCESS (0.000s) [316.419189] [078/156] (724s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite) [317.939152] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite [317.940978] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [318.133567] [079/156] (723s left) gem_pxp (create-valid-protected-context) [320.752219] Starting subtest: create-valid-protected-context [320.754292] Subtest create-valid-protected-context: SKIP (0.000s) [320.848041] [080/156] (720s left) gem_mmap_gtt (medium-copy-odd) [320.929165] Subtest medium-copy-odd: SKIP (0.000s) [321.006346] [081/156] (720s left) syncobj_timeline (signal-point-0) [321.086373] Starting subtest: signal-point-0 [321.087306] Subtest signal-point-0: SUCCESS (0.000s) [321.208771] [082/156] (720s left) gem_close_race (multigpu-basic-process) [321.334599] Starting subtest: multigpu-basic-process [321.336698] Subtest multigpu-basic-process: SKIP (0.000s) [321.620274] [083/156] (719s left) kms_vrr (flipline) [323.141168] Starting subtest: flipline [323.144342] Subtest flipline: SKIP (0.000s) [323.232862] [084/156] (718s left) prime_self_import (basic-with_one_bo_two_files) [323.293280] Starting subtest: basic-with_one_bo_two_files [323.342393] Subtest basic-with_one_bo_two_files: SUCCESS (0.049s) [323.535917] [085/156] (718s left) kms_atomic (plane-invalid-params-fence) [325.052993] Starting subtest: plane-invalid-params-fence [325.053974] Starting dynamic subtest: pipe-A-HDMI-A-3 [325.565671] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.513s) [325.566563] Subtest plane-invalid-params-fence: SUCCESS (0.514s) [325.807057] [086/156] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [327.335953] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [327.337712] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [327.485173] [087/156] (714s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt) [329.033426] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt [329.035135] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [329.163722] [088/156] (712s left) i915_query (test-query-geometry-subslices) [329.265540] Starting subtest: test-query-geometry-subslices [329.266472] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [329.431233] [089/156] (712s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [330.956125] Starting subtest: fbc-rgb565-draw-blt [333.559472] Subtest fbc-rgb565-draw-blt: SUCCESS (2.604s) [333.773735] [090/156] (708s left) gem_ctx_persistence (idempotent) [333.863265] Starting subtest: idempotent [333.864136] Subtest idempotent: SUCCESS (0.000s) [333.981446] [091/156] (708s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [335.499195] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [336.531574] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.033s) [336.727853] [092/156] (705s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [338.251118] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [338.252821] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [338.409452] [093/156] (703s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [339.961908] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt [339.963570] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [340.151553] [094/156] (702s left) syncobj_timeline (multi-wait-available-submitted-signaled) [340.238044] Starting subtest: multi-wait-available-submitted-signaled [340.238999] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s) [340.428679] [095/156] (701s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [341.942181] Starting subtest: cursorB-vs-flipA-atomic-transitions [341.944008] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s) [342.049483] [096/156] (700s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [343.581839] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [343.582702] Starting dynamic subtest: pipe-A [345.256176] Dynamic subtest pipe-A: SUCCESS (1.675s) [345.287138] Starting dynamic subtest: pipe-B [346.914461] Dynamic subtest pipe-B: SUCCESS (1.656s) [346.931514] Starting dynamic subtest: pipe-C [347.156059] Dynamic subtest pipe-C: SUCCESS (0.240s) [347.187070] Starting dynamic subtest: pipe-D [347.413415] Dynamic subtest pipe-D: SUCCESS (0.255s) [347.414625] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.835s) [347.716383] [097/156] (694s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [347.800655] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [347.914937] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [348.047899] [098/156] (694s left) drm_read (empty-nonblock) [349.653958] Starting subtest: empty-nonblock [349.654917] Subtest empty-nonblock: SUCCESS (0.000s) [349.862690] [099/156] (692s left) kms_psr (fbc-psr2-primary-mmap-gtt) [351.382590] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s) [351.450566] [100/156] (691s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [352.973134] Starting subtest: 2x-long-flip-vs-cursor-atomic [352.976271] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s) [353.079144] [101/156] (689s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [354.611066] Starting subtest: planes-downscale-factor-0-5-unity-scaling [354.611993] Starting dynamic subtest: pipe-A [354.702980] Dynamic subtest pipe-A: SUCCESS (0.092s) [354.722066] Starting dynamic subtest: pipe-B [354.882390] Dynamic subtest pipe-B: SUCCESS (0.178s) [354.905461] Starting dynamic subtest: pipe-C [355.039643] Dynamic subtest pipe-C: SUCCESS (0.156s) [355.054439] Starting dynamic subtest: pipe-D [355.180437] Dynamic subtest pipe-D: SUCCESS (0.140s) [355.181422] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.571s) [355.464188] [102/156] (687s left) kms_psr (psr2-sprite-plane-onoff) [356.987357] Subtest psr2-sprite-plane-onoff: SKIP (0.000s) [357.050653] [103/156] (685s left) api_intel_bb (full-batch) [357.134596] Starting subtest: full-batch [357.168778] Subtest full-batch: SUCCESS (0.034s) [357.375721] [104/156] (685s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt) [358.901248] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt [358.903066] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [359.060185] [105/156] (684s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite) [360.608764] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite [360.610447] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [360.748703] [106/156] (682s left) kms_flip (dpms-vs-vblank-race) [362.293396] Starting subtest: dpms-vs-vblank-race [362.299209] Starting dynamic subtest: A-HDMI-A3 [365.410862] Dynamic subtest A-HDMI-A3: SUCCESS (3.111s) [365.427648] Starting dynamic subtest: B-HDMI-A3 [368.427097] Dynamic subtest B-HDMI-A3: SUCCESS (3.013s) [368.440058] Starting dynamic subtest: C-HDMI-A3 [371.492267] Dynamic subtest C-HDMI-A3: SUCCESS (3.063s) [371.509141] Starting dynamic subtest: D-HDMI-A3 [374.523341] Dynamic subtest D-HDMI-A3: SUCCESS (3.030s) [374.524341] Subtest dpms-vs-vblank-race: SUCCESS (12.230s) [374.746903] [107/156] (668s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [376.267994] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [376.268978] Starting dynamic subtest: pipe-A-HDMI-A-3 [376.538981] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.255s) [376.580327] Starting dynamic subtest: pipe-B-HDMI-A-3 [376.932236] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.386s) [376.957810] Starting dynamic subtest: pipe-C-HDMI-A-3 [377.240830] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.303s) [377.266752] Starting dynamic subtest: pipe-D-HDMI-A-3 [377.549833] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.303s) [377.551464] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SUCCESS (1.267s) [377.862190] [108/156] (665s left) dumb_buffer (map-invalid-size) [377.950513] Starting subtest: map-invalid-size [377.951467] Subtest map-invalid-size: SUCCESS (0.000s) [378.109213] [109/156] (665s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary) [379.639176] Starting subtest: psrhdr-shrfb-scaledprimary [379.641050] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s) [379.755430] [110/156] (663s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt) [381.282158] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt [381.283953] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [381.442570] [111/156] (662s left) syncobj_wait (invalid-multi-wait-unsubmitted) [381.552497] Starting subtest: invalid-multi-wait-unsubmitted [381.553598] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [381.725153] [112/156] (662s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [383.241191] Starting subtest: 2x-long-cursor-vs-flip-atomic [383.243009] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s) [383.338012] [113/156] (660s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-blt) [384.872316] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-blt [384.874183] Subtest hdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [385.019191] [114/156] (658s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite) [386.571258] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite [386.573074] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [386.713145] [115/156] (657s left) kms_fbcon_fbt (psr) [386.823588] Starting subtest: psr [386.825406] Subtest psr: SKIP (0.000s) [387.036381] [116/156] (657s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [388.592287] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [388.725781] [117/156] (655s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [390.254431] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [390.307106] [118/156] (653s left) gem_mmap_gtt (close-race) [390.390164] Subtest close-race: SKIP (0.000s) [390.458881] [119/156] (653s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc) [391.980204] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc [391.982153] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [392.126536] [120/156] (652s left) kms_flip (2x-flip-vs-panning) [393.671147] Starting subtest: 2x-flip-vs-panning [393.683165] Subtest 2x-flip-vs-panning: SKIP (0.013s) [393.784361] [121/156] (650s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [395.309142] Starting subtest: basic-busy-flip-before-cursor-atomic [395.311065] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [395.432642] [122/156] (649s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move) [396.975895] Starting subtest: hdr-2p-scndscrn-cur-indfb-move [396.977568] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [397.129583] [123/156] (647s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [398.678956] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [401.411730] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.734s) [401.564603] [124/156] (643s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [403.094257] Starting subtest: yf-tiled-64bpp-rotate-270 [403.095932] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [403.244137] [125/156] (641s left) gem_madvise (dontneed-before-exec) [403.326137] Starting subtest: dontneed-before-exec [403.360333] Subtest dontneed-before-exec: SKIP (0.033s) [403.456368] [126/156] (641s left) kms_display_modes (extended-mode-basic) [404.974842] Starting subtest: extended-mode-basic [404.977170] Subtest extended-mode-basic: SKIP (0.000s) [405.040504] [127/156] (639s left) kms_big_fb (4-tiled-8bpp-rotate-180) [406.573202] Starting subtest: 4-tiled-8bpp-rotate-180 [408.145570] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.571s) [408.335931] [128/156] (636s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [409.853177] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [409.878029] Starting dynamic subtest: pipe-A-plane-0 [410.394901] Dynamic subtest pipe-A-plane-0: SUCCESS (0.516s) [410.431163] Starting dynamic subtest: pipe-A-plane-3 [410.761169] Dynamic subtest pipe-A-plane-3: SUCCESS (0.362s) [410.944456] Starting dynamic subtest: pipe-B-plane-0 [411.315262] Dynamic subtest pipe-B-plane-0: SUCCESS (0.383s) [411.351462] Starting dynamic subtest: pipe-B-plane-3 [411.648419] Dynamic subtest pipe-B-plane-3: SUCCESS (0.330s) [411.738948] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SUCCESS (1.886s) [411.994648] [129/156] (632s left) gem_softpin (evict-active-interruptible) [412.086013] Starting subtest: evict-active-interruptible [412.108662] Subtest evict-active-interruptible: SUCCESS (0.023s) [412.295439] [130/156] (632s left) kms_lease (possible-crtcs-filtering) [413.814261] Starting subtest: possible-crtcs-filtering [413.822428] Subtest possible-crtcs-filtering: SUCCESS (0.009s) [413.955628] [131/156] (631s left) kms_psr2_sf (pr-cursor-plane-update-sf) [415.502454] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [415.564413] [132/156] (629s left) sw_sync (sync_merge) [415.615323] Starting subtest: sync_merge [415.616226] Subtest sync_merge: SUCCESS (0.000s) [415.705894] [133/156] (629s left) kms_content_protection (uevent) [417.289482] Starting subtest: uevent [417.292224] Subtest uevent: SKIP (0.002s) [417.478346] [134/156] (627s left) kms_getfb (getfb-addfb-different-handles) [418.995249] Starting subtest: getfb-addfb-different-handles [418.996161] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [419.175351] [135/156] (626s left) gem_eio (create) [419.570493] Starting subtest: create [420.161253] Subtest create: SUCCESS (0.591s) [421.788459] [136/156] (623s left) kms_addfb_basic (addfb25-y-tiled-legacy) [423.322204] Starting subtest: addfb25-y-tiled-legacy [423.323051] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [423.462504] [137/156] (622s left) kms_force_connector_basic (force-load-detect) [423.644436] Starting subtest: force-load-detect [423.646237] Subtest force-load-detect: SKIP (0.000s) [424.616613] [138/156] (621s left) syncobj_timeline (invalid-signal-bad-pad) [424.700458] Starting subtest: invalid-signal-bad-pad [424.701441] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [424.895318] [139/156] (620s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt) [426.424842] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt [426.426535] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [426.554554] [140/156] (619s left) gem_lmem_swapping (massive-random) [431.148814] Starting subtest: massive-random [431.150296] Starting dynamic subtest: lmem0 [435.362274] Dynamic subtest lmem0: SUCCESS (4.214s) [435.363641] Subtest massive-random: SUCCESS (4.216s) [436.733485] [FACT gem_lmem_swapping (massive-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [436.734616] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true [436.736577] [141/156] (609s left) kms_selftest (drm_plane_helper) [436.780545] Starting subtest: drm_plane_helper [436.786710] Starting dynamic subtest: drm_test_check_plane_state [436.857284] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.071s) [436.868591] Starting dynamic subtest: drm_test_check_invalid_plane_state [436.927090] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.066s) [436.928660] Subtest drm_plane_helper: SUCCESS (0.146s) [437.072890] [142/156] (608s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [442.026264] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [442.028026] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [442.110658] [FACT kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [442.113568] [FACT kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)] new: kernel.kmod_is_loaded.i915: true [442.116724] [143/156] (603s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [443.653921] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [443.655698] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [443.789676] [144/156] (602s left) kms_invalid_mode (bad-vsync-start) [445.334967] Starting subtest: bad-vsync-start [445.335897] Starting dynamic subtest: pipe-A-HDMI-A-3 [445.374128] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.039s) [445.384830] Starting dynamic subtest: pipe-B-HDMI-A-3 [445.385992] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [445.396483] Starting dynamic subtest: pipe-C-HDMI-A-3 [445.397563] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [445.407924] Starting dynamic subtest: pipe-D-HDMI-A-3 [445.409192] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [445.410269] Subtest bad-vsync-start: SUCCESS (0.048s) [445.597077] [145/156] (600s left) kms_addfb_basic (unused-modifier) [445.680838] Starting subtest: unused-modifier [445.681688] Subtest unused-modifier: SUCCESS (0.000s) [447.237427] [146/156] (599s left) gem_exec_flush (basic-wb-prw-default) [447.348277] Subtest basic-wb-prw-default: SKIP (0.000s) [447.446428] [147/156] (598s left) kms_flip (blocking-absolute-wf_vblank) [448.967044] Starting subtest: blocking-absolute-wf_vblank [448.971925] Starting dynamic subtest: A-HDMI-A3 [456.778048] Dynamic subtest A-HDMI-A3: SUCCESS (7.806s) [456.792075] Starting dynamic subtest: B-HDMI-A3 [464.479739] Dynamic subtest B-HDMI-A3: SUCCESS (7.700s) [464.492594] Starting dynamic subtest: C-HDMI-A3 [472.181380] Dynamic subtest C-HDMI-A3: SUCCESS (7.700s) [472.194937] Starting dynamic subtest: D-HDMI-A3 [479.880703] Dynamic subtest D-HDMI-A3: SUCCESS (7.698s) [479.881595] Subtest blocking-absolute-wf_vblank: SUCCESS (30.916s) [480.112849] [148/156] (566s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [481.634094] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [481.635995] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [481.802415] [149/156] (564s left) kms_psr (fbc-psr-sprite-blt) [483.339570] Subtest fbc-psr-sprite-blt: SKIP (0.000s) [483.400893] [150/156] (563s left) vgem_basic (dmabuf-export) [483.472483] Starting subtest: dmabuf-export [483.506757] Subtest dmabuf-export: SUCCESS (0.035s) [483.657884] [151/156] (562s left) kms_chamelium_color (ctm-0-50) [485.179543] Subtest ctm-0-50: SKIP (0.000s) [485.233960] [152/156] (561s left) perf_pmu (busy-idle-check-all) [485.311421] Starting subtest: busy-idle-check-all [485.312515] Starting dynamic subtest: rcs0 [486.009555] Dynamic subtest rcs0: SUCCESS (0.698s) [486.024453] Starting dynamic subtest: bcs0 [486.669142] Dynamic subtest bcs0: SUCCESS (0.657s) [486.688751] Starting dynamic subtest: vcs0 [487.330491] Dynamic subtest vcs0: SUCCESS (0.658s) [487.345997] Starting dynamic subtest: vcs1 [487.988535] Dynamic subtest vcs1: SUCCESS (0.654s) [488.005546] Starting dynamic subtest: vecs0 [488.648674] Dynamic subtest vecs0: SUCCESS (0.656s) [488.664130] Starting dynamic subtest: vecs1 [489.308505] Dynamic subtest vecs1: SUCCESS (0.656s) [489.325386] Starting dynamic subtest: ccs0 [489.970513] Dynamic subtest ccs0: SUCCESS (0.658s) [489.975490] Subtest busy-idle-check-all: SUCCESS (4.661s) [490.143676] [153/156] (556s left) gem_exec_balancer (bonded-true-hang) [490.499492] Starting subtest: bonded-true-hang [490.501366] Subtest bonded-true-hang: SKIP (0.000s) [490.641350] [154/156] (556s left) kms_cursor_crc (cursor-random-256x256) [492.402935] Starting subtest: cursor-random-256x256 [492.417208] Starting dynamic subtest: pipe-A-HDMI-A-3 [496.945054] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.527s) [496.979919] Starting dynamic subtest: pipe-D-HDMI-A-3 [501.452439] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.484s) [501.453414] Subtest cursor-random-256x256: SUCCESS (9.049s) [501.777171] [155/156] (545s left) kms_rotation_crc (primary-rotation-180) [503.292207] Starting subtest: primary-rotation-180 [513.707034] Subtest primary-rotation-180: SUCCESS (10.416s) [513.970270] [156/156] (532s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [515.490152] Starting subtest: flip-vs-cursor-busy-crc-atomic [516.083733] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.594s) [516.332663] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_schedule results: parsing output: 5/ for test: i915_drm_fdinfo results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: gem_render_copy results: parsing output: 8/ for test: gem_ctx_param results: parsing output: 9/ for test: prime_vgem results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_flip_scaled_crc results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_exec_params results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_userptr_blits results: parsing output: 16/ for test: i915_pm_rpm results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: gem_exec_reloc results: parsing output: 19/ for test: kms_vrr results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: kms_pipe_crc_basic results: parsing output: 24/ for test: kms_cursor_crc results: parsing output: 25/ for test: gem_pipe_control_store_loop results: parsing output: 26/ for test: sw_sync results: parsing output: 27/ for test: gem_exec_whisper results: parsing output: 28/ for test: gem_basic results: parsing output: 29/ for test: kms_rotation_crc results: parsing output: 30/ for test: gem_exec_schedule results: parsing output: 31/ for test: gem_busy results: parsing output: 32/ for test: kms_pipe_b_c_ivb results: parsing output: 33/ for test: kms_force_connector_basic results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_exec_balancer results: parsing output: 36/ for test: kms_psr2_su results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_exec_fence results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_pm_rpm results: parsing output: 42/ for test: api_intel_allocator results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_ccs results: parsing output: 45/ for test: gem_mmap_wc results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_busy results: parsing output: 48/ for test: gem_reg_read results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_cursor_edge_walk results: parsing output: 51/ for test: sysfs_preempt_timeout results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: gen9_exec_parse results: parsing output: 56/ for test: kms_color_pipeline results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: i915_drm_fdinfo results: parsing output: 59/ for test: gem_softpin results: parsing output: 60/ for test: kms_chamelium_frames results: parsing output: 61/ for test: kms_pm_rpm results: parsing output: 62/ for test: prime_busy results: parsing output: 63/ for test: gem_mmap_offset results: parsing output: 64/ for test: kms_plane results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gen7_exec_parse results: parsing output: 67/ for test: kms_draw_crc results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_properties results: parsing output: 75/ for test: gem_render_copy results: parsing output: 76/ for test: syncobj_basic results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_pxp results: parsing output: 79/ for test: gem_mmap_gtt results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: gem_close_race results: parsing output: 82/ for test: kms_vrr results: parsing output: 83/ for test: prime_self_import results: parsing output: 84/ for test: kms_atomic results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: i915_query results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_ctx_persistence results: parsing output: 90/ for test: kms_cursor_legacy results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: kms_plane_scaling results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: drm_read results: parsing output: 98/ for test: kms_psr results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_plane_scaling results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: api_intel_bb results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: dumb_buffer results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: kms_cursor_legacy results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_fbcon_fbt results: parsing output: 115/ for test: kms_chamelium_hpd results: parsing output: 116/ for test: kms_psr2_sf results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: kms_cursor_legacy results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: gem_madvise results: parsing output: 125/ for test: kms_display_modes results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: kms_plane results: parsing output: 128/ for test: gem_softpin results: parsing output: 129/ for test: kms_lease results: parsing output: 130/ for test: kms_psr2_sf results: parsing output: 131/ for test: sw_sync results: parsing output: 132/ for test: kms_content_protection results: parsing output: 133/ for test: kms_getfb results: parsing output: 134/ for test: gem_eio results: parsing output: 135/ for test: kms_addfb_basic results: parsing output: 136/ for test: kms_force_connector_basic results: parsing output: 137/ for test: syncobj_timeline results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: gem_lmem_swapping results: parsing output: 140/ for test: kms_selftest results: parsing output: 141/ for test: kms_flip_scaled_crc results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_invalid_mode results: parsing output: 144/ for test: kms_addfb_basic results: parsing output: 145/ for test: gem_exec_flush results: parsing output: 146/ for test: kms_flip results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_psr results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: kms_chamelium_color results: parsing output: 151/ for test: perf_pmu results: parsing output: 152/ for test: gem_exec_balancer results: parsing output: 153/ for test: kms_cursor_crc results: parsing output: 154/ for test: kms_rotation_crc results: parsing output: 155/ for test: kms_cursor_legacy Done.