[56.212549] Initializing watchdogs [56.212594] /dev/watchdog0 [56.227575] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.231912] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.234596] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.238078] [001/156] (960s left) prime_mmap (test_forked) [56.313559] Starting subtest: test_forked [56.315522] Starting dynamic subtest: test_forked-smem [56.355286] Dynamic subtest test_forked-smem: SUCCESS (0.046s) [56.357576] Subtest test_forked: SUCCESS (0.046s) [56.447320] [002/156] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [56.540767] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [56.543064] Starting dynamic subtest: pipe-A-eDP-1 [56.565581] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [56.576223] Starting dynamic subtest: pipe-B-eDP-1 [56.598073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [56.606058] Starting dynamic subtest: pipe-C-eDP-1 [56.627792] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [56.637673] Starting dynamic subtest: pipe-D-eDP-1 [56.660103] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [56.664205] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s) [58.861081] [003/156] (957s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt) [58.964786] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt [58.969201] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [59.060213] [004/156] (957s left) gem_linear_blits (basic) [59.372282] Starting subtest: basic [59.384825] Subtest basic: SUCCESS (0.013s) [59.521156] [005/156] (957s left) kms_flip (2x-busy-flip) [59.663039] Starting subtest: 2x-busy-flip [59.671794] Subtest 2x-busy-flip: SKIP (0.010s) [59.745179] [006/156] (957s left) kms_joiner (basic-max-non-joiner) [59.844121] Starting subtest: basic-max-non-joiner [59.848260] Subtest basic-max-non-joiner: SKIP (0.000s) [59.905492] [007/156] (957s left) prime_mmap (test_userptr) [59.958747] Starting subtest: test_userptr [59.961202] Starting dynamic subtest: test_userptr-smem [59.963592] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [59.966086] Subtest test_userptr: SUCCESS (0.001s) [60.063382] [008/156] (956s left) device_reset (unbind-cold-reset-rebind) [60.116019] Starting subtest: unbind-cold-reset-rebind [60.120601] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [60.179312] [009/156] (956s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [60.290522] Starting subtest: cursor-vs-flip-varying-size [91.511418] Subtest cursor-vs-flip-varying-size: SUCCESS (31.215s) [92.349483] [010/156] (924s left) gem_exec_fence (syncobj-timeline-invalid-wait) [92.932247] Starting subtest: syncobj-timeline-invalid-wait [92.936417] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [94.323436] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true [94.326364] [011/156] (922s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [94.428771] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [94.434074] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [94.527052] [012/156] (922s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [94.625588] Starting subtest: extended-pageflip-modeset-hang-oldfb [94.627460] Starting dynamic subtest: pipe-A [102.526808] Dynamic subtest pipe-A: SUCCESS (7.897s) [102.538080] Starting dynamic subtest: pipe-D [111.134073] Dynamic subtest pipe-D: SUCCESS (8.602s) [111.136455] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.504s) [111.996061] [013/156] (905s left) gem_mmap_gtt (cpuset-medium-copy-odd) [112.054305] Subtest cpuset-medium-copy-odd: SKIP (0.000s) [112.112218] [014/156] (905s left) gem_partial_pwrite_pread (write-uncached) [112.174228] Subtest write-uncached: SKIP (0.000s) [112.246798] [015/156] (905s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [112.349335] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [112.375760] Starting dynamic subtest: pipe-A-plane-0 [112.687247] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s) [112.695617] Starting dynamic subtest: pipe-A-plane-3 [112.919723] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [114.079576] Starting dynamic subtest: pipe-B-plane-0 [114.370411] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [114.380533] Starting dynamic subtest: pipe-B-plane-3 [114.604030] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [114.921697] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.573s) [115.765677] [016/156] (901s left) gem_lmem_swapping (heavy-verify-random-ccs) [115.814869] Subtest heavy-verify-random-ccs: SKIP (0.000s) [115.859669] [017/156] (901s left) syncobj_basic (create-signaled) [115.922718] Starting subtest: create-signaled [115.924594] Subtest create-signaled: SUCCESS (0.000s) [116.036832] [018/156] (901s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [116.135137] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [116.137075] Starting dynamic subtest: pipe-A-eDP-1 [116.866250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s) [116.876036] Starting dynamic subtest: pipe-B-eDP-1 [118.681452] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.815s) [118.691682] Starting dynamic subtest: pipe-C-eDP-1 [120.542419] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.860s) [120.552561] Starting dynamic subtest: pipe-D-eDP-1 [122.349798] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.807s) [122.351659] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.208s) [123.497181] [019/156] (893s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [123.595954] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [123.600123] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [123.681259] [020/156] (893s left) gem_set_tiling_vs_pwrite [123.799568] [021/156] (893s left) perf_pmu (busy-idle) [123.840917] Starting subtest: busy-idle [123.843198] Starting dynamic subtest: rcs0 [124.527661] Dynamic subtest rcs0: SUCCESS (0.689s) [124.540394] Starting dynamic subtest: bcs0 [125.200868] Dynamic subtest bcs0: SUCCESS (0.672s) [125.212898] Starting dynamic subtest: vcs0 [126.270778] Dynamic subtest vcs0: SUCCESS (1.066s) [126.283050] Starting dynamic subtest: vcs1 [128.317446] Dynamic subtest vcs1: SUCCESS (2.044s) [128.331727] Starting dynamic subtest: vecs0 [130.302467] Dynamic subtest vecs0: SUCCESS (1.984s) [130.314800] Starting dynamic subtest: ccs0 [130.965757] Dynamic subtest ccs0: SUCCESS (0.664s) [130.968861] Subtest busy-idle: SUCCESS (7.127s) [131.069174] [022/156] (886s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt) [131.171806] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt [131.175914] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [131.266339] [023/156] (886s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [131.373445] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu [131.377904] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [131.470790] [024/156] (886s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite) [131.566255] Starting subtest: fbchdr-rgb101010-draw-pwrite [131.570421] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s) [131.688349] [025/156] (886s left) kms_pwrite_crc (basic) [131.785379] Starting subtest: basic [132.475677] Subtest basic: SUCCESS (0.690s) [133.332403] [026/156] (884s left) kms_color (ctm-0-25) [133.418518] Starting subtest: ctm-0-25 [133.420667] Starting dynamic subtest: pipe-A-eDP-1 [136.948518] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.530s) [136.959651] Starting dynamic subtest: pipe-B-eDP-1 [141.238613] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.289s) [141.249196] Starting dynamic subtest: pipe-C-eDP-1 [145.289679] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.052s) [145.301213] Starting dynamic subtest: pipe-D-eDP-1 [149.306139] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.014s) [149.308480] Subtest ctm-0-25: SUCCESS (15.887s) [150.124742] [027/156] (867s left) gem_tiled_partial_pwrite_pread (reads) [150.180714] Subtest reads: SKIP (0.000s) [150.245432] [028/156] (867s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [150.620822] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [151.431242] [029/156] (866s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [151.529037] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [151.533676] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [151.625341] [030/156] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [151.729338] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [151.733560] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [151.829282] [031/156] (866s left) syncobj_timeline (reset-signaled) [151.883056] Starting subtest: reset-signaled [151.885412] Subtest reset-signaled: SUCCESS (0.001s) [151.974116] [032/156] (866s left) syncobj_timeline (invalid-transfer-bad-pad) [152.024149] Starting subtest: invalid-transfer-bad-pad [152.026412] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [152.116369] [033/156] (865s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [152.216677] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [152.221126] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [152.299290] [034/156] (865s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [152.395407] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [152.399105] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [152.507204] [035/156] (865s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt) [152.612321] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt [152.616099] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [152.730241] [036/156] (865s left) kms_psr (fbc-psr-cursor-blt) [152.829078] Starting subtest: fbc-psr-cursor-blt [152.831055] Starting dynamic subtest: eDP-1 [152.834581] Dynamic subtest eDP-1: SKIP (0.000s) [152.838069] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [152.912666] [037/156] (865s left) kms_lease (lease-invalid-crtc) [153.005072] Starting subtest: lease-invalid-crtc [153.007057] Starting dynamic subtest: pipe-A-eDP-1 [153.009025] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [153.017893] Starting dynamic subtest: pipe-B-eDP-1 [153.019523] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [153.028512] Starting dynamic subtest: pipe-C-eDP-1 [153.030325] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [153.038987] Starting dynamic subtest: pipe-D-eDP-1 [153.040653] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [153.042380] Subtest lease-invalid-crtc: SUCCESS (0.003s) [153.079498] [038/156] (865s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [153.188826] Starting subtest: psr-shrfb-scaledprimary [158.918249] Subtest psr-shrfb-scaledprimary: SUCCESS (5.734s) [159.007405] [039/156] (859s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [159.106987] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [166.466555] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.366s) [166.592065] [040/156] (851s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [166.711852] Starting subtest: verify-pxp-execution-after-suspend-resume [174.656594] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.947s) [174.822944] [041/156] (843s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt) [174.943531] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt [174.947786] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [175.045936] [042/156] (843s left) gem_render_copy (y-tiled-to-vebox-linear) [175.116849] Starting subtest: y-tiled-to-vebox-linear [175.121491] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [175.294838] [043/156] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [175.401531] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [175.405767] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [175.507180] [044/156] (843s left) syncobj_timeline (single-wait-all-signaled) [175.556854] Starting subtest: single-wait-all-signaled [175.559272] Subtest single-wait-all-signaled: SUCCESS (0.000s) [175.653801] [045/156] (842s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [175.748014] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [180.323857] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.581s) [181.507937] [046/156] (837s left) prime_vgem (basic-fence-flip) [181.580529] Starting subtest: basic-fence-flip [181.879876] Subtest basic-fence-flip: SUCCESS (0.299s) [181.998105] [047/156] (836s left) kms_pm_rpm (cursor-dpms) [183.523650] Starting subtest: cursor-dpms [183.528325] Subtest cursor-dpms: SKIP (0.000s) [184.236822] [048/156] (834s left) kms_flip (2x-flip-vs-suspend) [184.341668] Starting subtest: 2x-flip-vs-suspend [184.345867] Subtest 2x-flip-vs-suspend: SKIP (0.002s) [184.423890] [049/156] (834s left) kms_dsc (dsc-with-formats) [184.512182] Starting subtest: dsc-with-formats [184.552470] Subtest dsc-with-formats: SKIP (0.001s) [184.597633] [050/156] (834s left) gem_userptr_blits (unsync-overlap) [184.675098] Subtest unsync-overlap: SKIP (0.000s) [184.822237] [051/156] (834s left) kms_psr (psr2-suspend) [184.910231] Starting subtest: psr2-suspend [184.912473] Starting dynamic subtest: eDP-1 [202.796094] Dynamic subtest eDP-1: SUCCESS (2.857s) [202.798522] Subtest psr2-suspend: SUCCESS (2.858s) [203.686079] [052/156] (815s left) gem_spin_batch (user-each) [203.757537] Starting subtest: user-each [207.124463] Subtest user-each: SUCCESS (3.360s) [207.359104] [053/156] (811s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [207.451703] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [207.453863] Starting dynamic subtest: pipe-A-default-mode [208.650242] Dynamic subtest pipe-A-default-mode: SKIP (1.196s) [208.654168] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.197s) [208.772420] [054/156] (810s left) gem_exec_schedule (pi-common) [208.954053] Starting subtest: pi-common [208.956313] Starting dynamic subtest: rcs0 [208.978570] Dynamic subtest rcs0: SUCCESS (0.027s) [208.993678] Starting dynamic subtest: bcs0 [209.006212] Dynamic subtest bcs0: SUCCESS (0.027s) [209.020946] Starting dynamic subtest: vcs0 [209.034413] Dynamic subtest vcs0: SUCCESS (0.027s) [209.050017] Starting dynamic subtest: vcs1 [209.061000] Dynamic subtest vcs1: SUCCESS (0.026s) [209.076100] Starting dynamic subtest: vecs0 [209.086488] Dynamic subtest vecs0: SUCCESS (0.025s) [209.101093] Starting dynamic subtest: ccs0 [209.113213] Dynamic subtest ccs0: SUCCESS (0.026s) [209.115469] Subtest pi-common: SUCCESS (0.162s) [209.340154] [055/156] (809s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [209.435203] Starting subtest: y-tiled-addfb-size-offset-overflow [209.439673] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [209.544884] [056/156] (809s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [209.632955] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [209.635264] Starting dynamic subtest: pipe-A-eDP-1 [209.658411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [209.670671] Starting dynamic subtest: pipe-B-eDP-1 [209.692772] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [209.702724] Starting dynamic subtest: pipe-C-eDP-1 [209.724696] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [209.734310] Starting dynamic subtest: pipe-D-eDP-1 [209.757582] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [209.761718] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [211.876473] [057/156] (807s left) gem_eio (wait-wedge-10ms) [212.078362] Starting subtest: wait-wedge-10ms [213.356219] Subtest wait-wedge-10ms: SUCCESS (1.277s) [213.511227] [058/156] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [213.618133] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [220.166498] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.551s) [220.286781] [059/156] (798s left) gem_ctx_exec (basic-nohangcheck) [220.351085] Starting subtest: basic-nohangcheck [220.588998] Subtest basic-nohangcheck: SUCCESS (0.238s) [220.697304] [060/156] (798s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render) [220.793834] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render [220.798270] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [220.894761] [061/156] (798s left) gem_userptr_blits (create-destroy-sync) [220.965195] Starting subtest: create-destroy-sync [225.983467] Subtest create-destroy-sync: SUCCESS (5.015s) [226.122561] [062/156] (793s left) gem_mmap_offset (open-flood) [226.170936] Starting subtest: open-flood [247.660721] Subtest open-flood: SUCCESS (21.491s) [247.775549] [063/156] (771s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [247.867287] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [247.894623] Starting dynamic subtest: pipe-A-plane-0 [248.295810] Dynamic subtest pipe-A-plane-0: SUCCESS (0.400s) [248.306924] Starting dynamic subtest: pipe-A-plane-3 [248.616728] Dynamic subtest pipe-A-plane-3: SUCCESS (0.322s) [249.704534] Starting dynamic subtest: pipe-B-plane-0 [250.113802] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s) [250.125926] Starting dynamic subtest: pipe-B-plane-3 [250.436187] Dynamic subtest pipe-B-plane-3: SUCCESS (0.322s) [250.748832] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.880s) [251.573980] [064/156] (767s left) gem_exec_capture (capture) [251.645179] Starting subtest: capture [251.647373] Starting dynamic subtest: rcs0-smem [252.477056] Dynamic subtest rcs0-smem: SUCCESS (0.831s) [252.487549] Starting dynamic subtest: bcs0-smem [253.304314] Dynamic subtest bcs0-smem: SUCCESS (0.826s) [253.314840] Starting dynamic subtest: vcs0-smem [254.135169] Dynamic subtest vcs0-smem: SUCCESS (0.828s) [254.147760] Starting dynamic subtest: vcs1-smem [254.957174] Dynamic subtest vcs1-smem: SUCCESS (0.824s) [254.970635] Starting dynamic subtest: vecs0-smem [256.358828] Dynamic subtest vecs0-smem: FAIL (1.338s) [256.373739] Starting dynamic subtest: ccs0-smem [257.621188] Dynamic subtest ccs0-smem: SUCCESS (1.322s) [257.623686] Subtest capture: FAIL (5.973s) [257.757082] [065/156] (761s left) gem_exec_schedule (preempt-user) [257.826866] Starting subtest: preempt-user [257.828830] Starting dynamic subtest: rcs0 [257.860045] Dynamic subtest rcs0: SUCCESS (0.040s) [257.874177] Starting dynamic subtest: bcs0 [257.897899] Dynamic subtest bcs0: SUCCESS (0.036s) [257.909447] Starting dynamic subtest: vcs0 [257.928593] Dynamic subtest vcs0: SUCCESS (0.029s) [257.940001] Starting dynamic subtest: vcs1 [257.954312] Dynamic subtest vcs1: SUCCESS (0.025s) [257.965597] Starting dynamic subtest: vecs0 [257.978444] Dynamic subtest vecs0: SUCCESS (0.023s) [257.989168] Starting dynamic subtest: ccs0 [258.013603] Dynamic subtest ccs0: SUCCESS (0.035s) [258.015884] Subtest preempt-user: SUCCESS (0.194s) [259.390164] [066/156] (760s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt) [259.488718] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt [259.492822] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [259.593110] [067/156] (759s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [259.711220] Starting subtest: basic-flip-before-cursor-legacy [260.627175] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.915s) [261.504241] [068/156] (758s left) kms_setmode (invalid-clone-exclusive-crtc) [261.554161] Starting subtest: invalid-clone-exclusive-crtc [261.560492] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [261.646811] [069/156] (757s left) kms_psr (fbc-psr2-sprite-plane-onoff) [261.730721] Starting subtest: fbc-psr2-sprite-plane-onoff [261.733165] Starting dynamic subtest: eDP-1 [261.737317] Dynamic subtest eDP-1: SKIP (0.000s) [261.742205] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [261.801367] [070/156] (757s left) kms_cursor_crc (cursor-random-512x512) [262.077054] Starting subtest: cursor-random-512x512 [262.081813] Subtest cursor-random-512x512: SKIP (0.001s) [262.233247] [071/156] (757s left) kms_psr (pr-sprite-render) [262.328203] Starting subtest: pr-sprite-render [262.332333] Subtest pr-sprite-render: SKIP (0.000s) [262.416011] [072/156] (757s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [262.464869] Starting subtest: invalid-multi-wait-unsubmitted [262.467251] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [262.562225] [073/156] (757s left) perf_pmu (init-wait) [262.601105] Starting subtest: init-wait [262.603194] Starting dynamic subtest: rcs0 [262.605290] Dynamic subtest rcs0: SUCCESS (0.002s) [262.618270] Starting dynamic subtest: bcs0 [262.620140] Dynamic subtest bcs0: SUCCESS (0.000s) [262.630104] Starting dynamic subtest: vcs0 [262.632002] Dynamic subtest vcs0: SUCCESS (0.001s) [262.641597] Starting dynamic subtest: vcs1 [262.643458] Dynamic subtest vcs1: SUCCESS (0.000s) [262.653288] Starting dynamic subtest: vecs0 [262.654912] Dynamic subtest vecs0: SUCCESS (0.001s) [262.664786] Starting dynamic subtest: ccs0 [262.666624] Dynamic subtest ccs0: SUCCESS (0.000s) [262.668582] Subtest init-wait: SUCCESS (0.008s) [262.712521] [074/156] (757s left) gem_userptr_blits (probe) [262.788773] Starting subtest: probe [262.864401] Subtest probe: SUCCESS (0.077s) [262.992284] [075/156] (756s left) kms_properties (colorop-properties-atomic) [263.078109] Starting subtest: colorop-properties-atomic [263.080207] Starting dynamic subtest: pipe-A-eDP-1 [263.449663] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.369s) [263.460242] Starting dynamic subtest: pipe-B-eDP-1 [264.489625] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s) [264.502761] Starting dynamic subtest: pipe-C-eDP-1 [265.623641] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.132s) [265.638021] Starting dynamic subtest: pipe-D-eDP-1 [266.672635] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.048s) [266.674955] Subtest colorop-properties-atomic: SUCCESS (3.594s) [267.472111] [076/156] (752s left) prime_vgem (basic-fence-blt) [267.544925] Starting subtest: basic-fence-blt [267.636758] Subtest basic-fence-blt: SUCCESS (0.092s) [267.768481] [077/156] (752s left) gem_sync (basic-store-all) [267.833322] Starting subtest: basic-store-all [272.060646] Subtest basic-store-all: SUCCESS (4.238s) [272.247805] [078/156] (747s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [272.348299] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu [272.352241] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [272.437477] [079/156] (747s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-onoff) [272.534843] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-onoff [272.538862] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [272.627932] [080/156] (747s left) kms_async_flips (crc) [272.714684] Starting subtest: crc [273.085491] Starting dynamic subtest: pipe-A-eDP-1 [275.970922] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.884s) [276.349111] Starting dynamic subtest: pipe-B-eDP-1 [279.328368] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.988s) [279.705521] Starting dynamic subtest: pipe-C-eDP-1 [282.620462] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.927s) [282.994375] Starting dynamic subtest: pipe-D-eDP-1 [285.855758] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.872s) [285.858242] Subtest crc: SUCCESS (13.139s) [287.028892] [081/156] (733s left) kms_cursor_crc (cursor-onscreen-64x64) [287.215219] Starting subtest: cursor-onscreen-64x64 [287.220359] Starting dynamic subtest: pipe-A-eDP-1 [289.323225] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.100s) [289.355795] Starting dynamic subtest: pipe-D-eDP-1 [292.104230] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.760s) [292.106589] Subtest cursor-onscreen-64x64: SUCCESS (4.889s) [292.987239] [082/156] (727s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt) [293.089246] Starting subtest: psrhdr-farfromfence-mmap-gtt [293.093287] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [293.188425] [083/156] (726s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [293.308602] Starting subtest: cursorA-vs-flipA-legacy [304.434847] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.126s) [305.322587] [084/156] (714s left) syncobj_basic (test-valid-cycle) [305.372321] Starting subtest: test-valid-cycle [305.374733] Subtest test-valid-cycle: SUCCESS (0.000s) [305.464512] [085/156] (714s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [305.548192] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [305.550084] Starting dynamic subtest: pipe-A-eDP-1 [305.570339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s) [305.581216] Starting dynamic subtest: pipe-B-eDP-1 [305.600694] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [305.613831] Starting dynamic subtest: pipe-C-eDP-1 [305.633457] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [305.644044] Starting dynamic subtest: pipe-D-eDP-1 [305.663070] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [305.664983] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s) [307.901104] [086/156] (712s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [308.006197] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [308.985480] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.980s) [309.129219] [087/156] (711s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [309.227787] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [309.231879] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [309.328275] [088/156] (711s left) kms_atomic (plane-overlay-legacy) [309.418080] Starting subtest: plane-overlay-legacy [309.419936] Starting dynamic subtest: pipe-A-eDP-1 [309.817817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s) [309.820318] Subtest plane-overlay-legacy: SUCCESS (0.401s) [310.632330] [089/156] (709s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [310.736667] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [310.748792] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s) [310.825620] [090/156] (709s left) kms_plane_alpha_blend (coverage-7efc) [310.920090] Starting subtest: coverage-7efc [311.206759] Starting dynamic subtest: pipe-A-eDP-1 [311.770335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s) [311.799855] Starting dynamic subtest: pipe-D-eDP-1 [313.145105] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s) [313.147289] Subtest coverage-7efc: SUCCESS (2.225s) [313.990650] [091/156] (706s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [314.092032] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [314.096545] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [314.212700] [092/156] (706s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render) [314.318279] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render [314.322434] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [314.407204] [093/156] (706s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [314.501032] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [314.503194] Starting dynamic subtest: pipe-A-eDP-1 [320.373683] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.874s) [320.384916] Starting dynamic subtest: pipe-B-eDP-1 [327.026195] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.649s) [327.028446] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.527s) [327.895042] [094/156] (692s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [328.014837] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [328.018899] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [328.090286] [095/156] (692s left) kms_hdr (brightness-with-hdr) [328.189253] Starting subtest: brightness-with-hdr [328.191566] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [328.195944] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [328.207164] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [328.211178] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [328.215237] Subtest brightness-with-hdr: SKIP (0.003s) [328.263791] [096/156] (692s left) gem_mmap_wc (pf-nonblock) [328.325155] Subtest pf-nonblock: SKIP (0.000s) [328.387598] [097/156] (692s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [328.489651] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [328.493814] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [328.575338] [098/156] (692s left) vgem_basic (create) [328.618528] Starting subtest: create [328.680871] Subtest create: FAIL (0.007s) [328.722725] [099/156] (692s left) gem_eio (in-flight-suspend) [328.952410] Starting subtest: in-flight-suspend [371.671371] Subtest in-flight-suspend: SUCCESS (13.420s) [371.842938] [100/156] (649s left) fbdev (unaligned-write) [371.896138] Starting subtest: unaligned-write [371.995841] Subtest unaligned-write: SUCCESS (0.099s) [372.061687] [101/156] (648s left) sw_sync (sync_multi_consumer) [372.096929] Starting subtest: sync_multi_consumer [372.527661] Subtest sync_multi_consumer: SUCCESS (0.434s) [372.590974] [102/156] (648s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [372.700632] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [372.705003] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [372.798861] [103/156] (648s left) gem_exec_balancer (full-pulse) [372.860630] Starting subtest: full-pulse [377.500898] Subtest full-pulse: SUCCESS (4.638s) [377.835514] [104/156] (643s left) kms_color_pipeline (plane-ctm3x4) [377.943119] Starting subtest: plane-ctm3x4 [378.078376] Starting dynamic subtest: pipe-A-plane-0 [378.222728] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [378.233827] Starting dynamic subtest: pipe-A-plane-1 [378.378501] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s) [378.392426] Starting dynamic subtest: pipe-A-plane-2 [378.492616] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s) [379.738777] Starting dynamic subtest: pipe-B-plane-0 [379.873854] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [379.885069] Starting dynamic subtest: pipe-B-plane-1 [379.996855] Dynamic subtest pipe-B-plane-1: SUCCESS (0.122s) [380.012038] Starting dynamic subtest: pipe-B-plane-2 [380.130085] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s) [381.378462] Starting dynamic subtest: pipe-C-plane-0 [381.491119] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s) [381.505854] Starting dynamic subtest: pipe-C-plane-1 [381.602216] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s) [381.613909] Starting dynamic subtest: pipe-C-plane-2 [381.713346] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s) [382.901438] Starting dynamic subtest: pipe-D-plane-0 [383.002672] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s) [383.016417] Starting dynamic subtest: pipe-D-plane-1 [383.136198] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [383.148131] Starting dynamic subtest: pipe-D-plane-2 [383.247385] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s) [383.536363] Subtest plane-ctm3x4: SUCCESS (5.590s) [384.375768] [105/156] (636s left) kms_cursor_crc (cursor-sliding-256x85) [384.652909] Starting subtest: cursor-sliding-256x85 [384.710359] Subtest cursor-sliding-256x85: SKIP (0.051s) [384.896305] [106/156] (636s left) gem_eio (in-flight-internal-1us) [385.133150] Starting subtest: in-flight-internal-1us [386.666766] Subtest in-flight-internal-1us: SUCCESS (1.532s) [386.786320] [107/156] (634s left) gem_ctx_isolation (nonpriv-switch) [386.851768] Starting subtest: nonpriv-switch [386.854028] Starting dynamic subtest: rcs0 [387.139946] Dynamic subtest rcs0: SUCCESS (0.288s) [387.152800] Starting dynamic subtest: bcs0 [387.437406] Dynamic subtest bcs0: SUCCESS (0.296s) [387.450132] Starting dynamic subtest: vcs0 [387.727112] Dynamic subtest vcs0: SUCCESS (0.289s) [387.739513] Starting dynamic subtest: vcs1 [388.896982] Dynamic subtest vcs1: SUCCESS (1.168s) [388.908530] Starting dynamic subtest: vecs0 [390.926198] Dynamic subtest vecs0: SUCCESS (2.027s) [390.941996] Starting dynamic subtest: ccs0 [392.961155] Dynamic subtest ccs0: SUCCESS (2.032s) [392.963409] Subtest nonpriv-switch: SUCCESS (6.107s) [393.213179] [108/156] (628s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [393.317087] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [397.478268] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.162s) [398.692076] [109/156] (622s left) kms_addfb_basic (bad-pitch-65536) [398.751093] Starting subtest: bad-pitch-65536 [398.753479] Subtest bad-pitch-65536: SUCCESS (0.000s) [398.882497] [110/156] (622s left) gen9_exec_parse (unaligned-jump) [398.955259] Subtest unaligned-jump: SKIP (0.000s) [399.022210] [111/156] (622s left) i915_pm_rpm (gem-execbuf-stress-pc8) [400.761726] Starting subtest: gem-execbuf-stress-pc8 [400.806464] Subtest gem-execbuf-stress-pc8: SKIP (0.041s) [401.343928] [112/156] (620s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [401.399498] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [401.401788] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [401.520461] [113/156] (619s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite) [401.614773] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite [401.619154] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [401.699378] [114/156] (619s left) gem_exec_whisper (basic-forked-all) [401.755959] Starting subtest: basic-forked-all [415.276984] Subtest basic-forked-all: SUCCESS (13.514s) [415.477472] [115/156] (606s left) vgem_basic (busy-fence) [415.517910] Starting subtest: busy-fence [415.519877] Subtest busy-fence: SUCCESS (0.000s) [415.577014] [116/156] (606s left) i915_selftest (mock) [418.188649] Starting subtest: mock [418.191410] Starting dynamic subtest: sanitycheck [418.910556] Dynamic subtest sanitycheck: SUCCESS (0.723s) [418.921559] Starting dynamic subtest: shmem [419.598423] Dynamic subtest shmem: SUCCESS (0.685s) [419.609728] Starting dynamic subtest: fence [427.742229] Dynamic subtest fence: SUCCESS (8.138s) [427.757281] Starting dynamic subtest: scatterlist [429.440415] Dynamic subtest scatterlist: SUCCESS (1.696s) [429.452055] Starting dynamic subtest: syncmap [432.582547] Dynamic subtest syncmap: SUCCESS (3.139s) [432.594493] Starting dynamic subtest: uncore [433.236372] Dynamic subtest uncore: SUCCESS (0.651s) [433.247730] Starting dynamic subtest: ring [433.923454] Dynamic subtest ring: SUCCESS (0.685s) [433.934856] Starting dynamic subtest: engine [434.584405] Dynamic subtest engine: SUCCESS (0.659s) [434.595660] Starting dynamic subtest: timelines [438.462140] Dynamic subtest timelines: SUCCESS (3.873s) [438.473119] Starting dynamic subtest: requests [442.000959] Dynamic subtest requests: SUCCESS (3.537s) [442.013947] Starting dynamic subtest: objects [442.779085] Dynamic subtest objects: SUCCESS (0.775s) [442.789952] Starting dynamic subtest: phys [443.555484] Dynamic subtest phys: SUCCESS (0.775s) [443.566888] Starting dynamic subtest: dmabuf [444.328392] Dynamic subtest dmabuf: SUCCESS (0.771s) [444.339786] Starting dynamic subtest: vma [450.003339] Dynamic subtest vma: SUCCESS (5.671s) [450.014509] Starting dynamic subtest: evict [451.439712] Dynamic subtest evict: SUCCESS (1.433s) [451.449083] Starting dynamic subtest: gtt [454.762642] Dynamic subtest gtt: SUCCESS (3.321s) [454.772170] Starting dynamic subtest: hugepages [455.670147] Dynamic subtest hugepages: SUCCESS (0.905s) [455.681146] Starting dynamic subtest: memory_region [458.213561] Dynamic subtest memory_region: SUCCESS (2.541s) [458.216258] Subtest mock: SUCCESS (40.015s) [458.245939] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [458.246639] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [458.249638] [117/156] (563s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [459.819415] Starting subtest: plane-scaler-unity-scaling-with-rotation [459.821871] Starting dynamic subtest: pipe-A [460.059175] Dynamic subtest pipe-A: SUCCESS (0.243s) [460.068989] Starting dynamic subtest: pipe-B [461.349356] Dynamic subtest pipe-B: SUCCESS (1.288s) [461.362217] Starting dynamic subtest: pipe-C [462.676648] Dynamic subtest pipe-C: SUCCESS (1.326s) [462.686665] Starting dynamic subtest: pipe-D [463.996272] Dynamic subtest pipe-D: SUCCESS (1.318s) [463.998633] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.179s) [465.162467] [FACT kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [465.163631] [FACT kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)] new: kernel.kmod_is_loaded.i915: true [465.167907] [118/156] (556s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render) [465.280260] Starting subtest: hdr-rgb565-draw-render [465.284504] Subtest hdr-rgb565-draw-render: SKIP (0.000s) [465.379444] [119/156] (556s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move) [465.478009] Starting subtest: hdr-2p-primscrn-cur-indfb-move [465.482281] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [465.608615] [120/156] (556s left) kms_addfb_basic (bo-too-small) [465.704946] Starting subtest: bo-too-small [465.706926] Subtest bo-too-small: SUCCESS (0.000s) [465.805673] [121/156] (556s left) kms_universal_plane (universal-plane-functional) [465.899088] Starting subtest: universal-plane-functional [465.901384] Starting dynamic subtest: pipe-A-eDP-1 [469.785182] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.884s) [469.795810] Starting dynamic subtest: pipe-B-eDP-1 [474.291149] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.507s) [474.301015] Starting dynamic subtest: pipe-C-eDP-1 [478.550708] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.261s) [478.563773] Starting dynamic subtest: pipe-D-eDP-1 [482.860845] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.306s) [482.862982] Subtest universal-plane-functional: SUCCESS (16.964s) [483.697419] [122/156] (538s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [483.800527] Starting subtest: yf-tiled-16bpp-rotate-90 [483.804364] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [483.899139] [123/156] (538s left) gem_ctx_persistence (userptr) [483.960012] Starting subtest: userptr [484.110990] Subtest userptr: SUCCESS (0.153s) [484.191149] [124/156] (537s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [484.290838] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [484.295273] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [484.385441] [125/156] (537s left) api_intel_bb (destroy-bb) [484.429980] Starting subtest: destroy-bb [484.441728] Subtest destroy-bb: SUCCESS (0.011s) [484.566872] [126/156] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [484.656677] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [484.660088] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [484.774458] [127/156] (537s left) prime_mmap_kms (buffer-sharing) [484.857964] Starting subtest: buffer-sharing [485.292757] Subtest buffer-sharing: SUCCESS (0.435s) [486.103012] [128/156] (536s left) gem_ctx_param (set-priority-not-supported) [486.165246] Starting subtest: set-priority-not-supported [486.169350] Subtest set-priority-not-supported: SKIP (0.000s) [486.240168] [129/156] (535s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [486.298712] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [486.401473] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [486.480622] [130/156] (535s left) kms_flip (basic-flip-vs-modeset) [486.570184] Starting subtest: basic-flip-vs-modeset [486.572553] Starting dynamic subtest: A-eDP1 [489.191677] Dynamic subtest A-eDP1: SUCCESS (2.617s) [489.202904] Starting dynamic subtest: B-eDP1 [491.369939] Dynamic subtest B-eDP1: SUCCESS (2.176s) [491.382118] Starting dynamic subtest: C-eDP1 [493.533013] Dynamic subtest C-eDP1: SUCCESS (2.166s) [493.545315] Starting dynamic subtest: D-eDP1 [495.735149] Dynamic subtest D-eDP1: SUCCESS (2.199s) [495.737299] Subtest basic-flip-vs-modeset: SUCCESS (9.167s) [496.623026] [131/156] (525s left) gen7_exec_parse (load-register-reg) [496.684954] Subtest load-register-reg: SKIP (0.000s) [496.756501] [132/156] (525s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [496.851319] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu [496.855452] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [496.941570] [133/156] (525s left) gem_ctx_shared (q-out-order) [496.998535] Starting subtest: Q-out-order [497.000788] Starting dynamic subtest: rcs0 [497.095477] Dynamic subtest rcs0: SUCCESS (0.096s) [497.113411] Starting dynamic subtest: vcs0 [497.175097] Dynamic subtest vcs0: SUCCESS (0.078s) [497.193467] Starting dynamic subtest: vcs1 [497.252249] Dynamic subtest vcs1: SUCCESS (0.076s) [497.269132] Starting dynamic subtest: vecs0 [497.325303] Dynamic subtest vecs0: SUCCESS (0.071s) [497.343714] Starting dynamic subtest: ccs0 [497.405250] Dynamic subtest ccs0: SUCCESS (0.078s) [497.408463] Subtest Q-out-order: SUCCESS (0.405s) [498.700540] [134/156] (523s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [498.794948] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [505.651588] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.862s) [505.752660] [135/156] (516s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-pwrite) [505.851694] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-pwrite [505.855789] Subtest hdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [505.962358] [136/156] (516s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [506.047026] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [506.049297] Starting dynamic subtest: pipe-A-eDP-1 [506.072336] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [506.085221] Starting dynamic subtest: pipe-B-eDP-1 [506.107280] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [506.117771] Starting dynamic subtest: pipe-C-eDP-1 [506.139510] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [506.149648] Starting dynamic subtest: pipe-D-eDP-1 [506.171692] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [506.175800] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [508.319536] [137/156] (514s left) kms_vblank (wait-forked) [508.422298] Starting subtest: wait-forked [508.424299] Starting dynamic subtest: pipe-A-eDP-1 [510.238635] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s) [510.255485] Starting dynamic subtest: pipe-D-eDP-1 [512.719196] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.479s) [512.721546] Subtest wait-forked: SUCCESS (4.299s) [513.583170] [138/156] (508s left) kms_big_fb (4-tiled-32bpp-rotate-270) [513.681382] Starting subtest: 4-tiled-32bpp-rotate-270 [513.701724] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s) [513.810320] [139/156] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [513.910642] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [513.914612] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [514.028512] [140/156] (508s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [514.121359] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [514.123656] Starting dynamic subtest: pipe-A [515.169463] Dynamic subtest pipe-A: SUCCESS (1.050s) [515.179387] Starting dynamic subtest: pipe-B [517.281301] Dynamic subtest pipe-B: SUCCESS (2.110s) [517.293407] Starting dynamic subtest: pipe-C [518.483668] Dynamic subtest pipe-C: SUCCESS (1.201s) [518.494226] Starting dynamic subtest: pipe-D [519.721449] Dynamic subtest pipe-D: SUCCESS (1.237s) [519.723662] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.603s) [520.923068] [141/156] (501s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [521.027947] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc [521.032491] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [521.133072] [142/156] (501s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [521.278121] Starting subtest: dp-mst-lic-type-0-hdcp14 [521.282727] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [521.416516] [143/156] (501s left) kms_cursor_legacy (single-move) [521.541225] Starting subtest: single-move [521.543462] Starting dynamic subtest: pipe-A [526.923089] Dynamic subtest pipe-A: SUCCESS (5.378s) [526.934772] Starting dynamic subtest: pipe-B [532.306262] Dynamic subtest pipe-B: SUCCESS (5.379s) [532.318856] Starting dynamic subtest: pipe-C [537.689159] Dynamic subtest pipe-C: SUCCESS (5.379s) [537.701902] Starting dynamic subtest: pipe-D [543.072435] Dynamic subtest pipe-D: SUCCESS (5.380s) [543.083102] Starting dynamic subtest: all-pipes [548.465655] Dynamic subtest all-pipes: SUCCESS (5.387s) [548.468161] Subtest single-move: SUCCESS (26.917s) [548.622781] [144/156] (474s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu) [548.738815] Starting subtest: hdr-rgb101010-draw-mmap-cpu [548.742832] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [548.827123] [145/156] (474s left) gem_exec_params (invalid-fence-in-submit) [548.885843] Starting subtest: invalid-fence-in-submit [548.895615] Subtest invalid-fence-in-submit: SUCCESS (0.007s) [549.017993] [146/156] (473s left) i915_pm_freq_api (freq-reset) [549.071891] Starting subtest: freq-reset [549.074234] Starting dynamic subtest: gt0 [549.267954] Dynamic subtest gt0: SUCCESS (0.193s) [549.279774] Starting dynamic subtest: gt1 [549.436292] Dynamic subtest gt1: SUCCESS (0.168s) [549.438710] Subtest freq-reset: SUCCESS (0.363s) [549.516395] [147/156] (473s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt) [549.619251] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt [549.623506] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [549.708437] [148/156] (473s left) api_intel_allocator (reloc-allocator) [549.764016] Starting subtest: reloc-allocator [549.766429] Starting dynamic subtest: basic [549.768454] Dynamic subtest basic: SUCCESS (0.003s) [549.781788] Starting dynamic subtest: parallel-one [549.783950] Dynamic subtest parallel-one: SUCCESS (0.008s) [549.795388] Starting dynamic subtest: print [549.797258] Dynamic subtest print: SUCCESS (0.000s) [549.808081] Starting dynamic subtest: reuse [549.810057] Dynamic subtest reuse: SUCCESS (0.000s) [549.820052] Starting dynamic subtest: fork-reopen-allocator [549.822300] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s) [549.824175] Subtest reloc-allocator: SUCCESS (0.026s) [549.933346] [149/156] (473s left) gem_softpin (noreloc-s3) [549.990643] Starting subtest: noreloc-S3 [569.731446] Subtest noreloc-S3: SUCCESS (5.410s) [569.863703] [150/156] (453s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-onoff) [569.971623] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-onoff [569.975976] Subtest fbchdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [570.065885] [151/156] (453s left) kms_prop_blob (blob-prop-lifetime) [570.124260] Starting subtest: blob-prop-lifetime [570.126404] Subtest blob-prop-lifetime: SUCCESS (0.001s) [570.244636] [152/156] (452s left) tools_test (sysfs_l3_parity) [570.297207] Starting subtest: sysfs_l3_parity [570.365422] Subtest sysfs_l3_parity: SKIP (0.081s) [570.424315] [153/156] (452s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [570.524919] Starting subtest: psr-rgb565-draw-mmap-wc [577.353342] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.822s) [577.467140] [154/156] (445s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [577.570640] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [577.574755] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [577.670947] [155/156] (445s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite) [577.766072] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite [577.770311] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [577.848670] [156/156] (445s left) gem_reg_read (bad-register) [577.898813] Starting subtest: bad-register [577.900733] Subtest bad-register: SUCCESS (0.000s) [577.999890] Closing watchdogs results: parsing output: 0/ for test: prime_mmap results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_linear_blits results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: kms_joiner results: parsing output: 6/ for test: prime_mmap results: parsing output: 7/ for test: device_reset results: parsing output: 8/ for test: kms_cursor_legacy results: parsing output: 9/ for test: gem_exec_fence results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_busy results: parsing output: 12/ for test: gem_mmap_gtt results: parsing output: 13/ for test: gem_partial_pwrite_pread results: parsing output: 14/ for test: kms_plane results: parsing output: 15/ for test: gem_lmem_swapping results: parsing output: 16/ for test: syncobj_basic results: parsing output: 17/ for test: kms_ccs results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_set_tiling_vs_pwrite results: parsing output: 20/ for test: perf_pmu results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_pwrite_crc results: parsing output: 25/ for test: kms_color results: parsing output: 26/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 27/ for test: kms_chamelium_frames results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: syncobj_timeline results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_psr results: parsing output: 36/ for test: kms_lease results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_pxp results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_render_copy results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: prime_vgem results: parsing output: 46/ for test: kms_pm_rpm results: parsing output: 47/ for test: kms_flip results: parsing output: 48/ for test: kms_dsc results: parsing output: 49/ for test: gem_userptr_blits results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: gem_spin_batch results: parsing output: 52/ for test: kms_flip_scaled_crc results: parsing output: 53/ for test: gem_exec_schedule results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: gem_eio results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_ctx_exec results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_userptr_blits results: parsing output: 61/ for test: gem_mmap_offset results: parsing output: 62/ for test: kms_plane results: parsing output: 63/ for test: gem_exec_capture results: parsing output: 64/ for test: gem_exec_schedule results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: kms_setmode results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_cursor_crc results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: perf_pmu results: parsing output: 73/ for test: gem_userptr_blits results: parsing output: 74/ for test: kms_properties results: parsing output: 75/ for test: prime_vgem results: parsing output: 76/ for test: gem_sync results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_async_flips results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: syncobj_basic results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_atomic results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: kms_plane_alpha_blend results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_psr2_sf results: parsing output: 93/ for test: kms_psr2_sf results: parsing output: 94/ for test: kms_hdr results: parsing output: 95/ for test: gem_mmap_wc results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: vgem_basic results: parsing output: 98/ for test: gem_eio results: parsing output: 99/ for test: fbdev results: parsing output: 100/ for test: sw_sync results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: gem_exec_balancer results: parsing output: 103/ for test: kms_color_pipeline results: parsing output: 104/ for test: kms_cursor_crc results: parsing output: 105/ for test: gem_eio results: parsing output: 106/ for test: gem_ctx_isolation results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_addfb_basic results: parsing output: 109/ for test: gen9_exec_parse results: parsing output: 110/ for test: i915_pm_rpm results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_exec_whisper results: parsing output: 114/ for test: vgem_basic results: parsing output: 115/ for test: i915_selftest results: parsing output: 116/ for test: kms_plane_scaling results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_addfb_basic results: parsing output: 120/ for test: kms_universal_plane results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: gem_ctx_persistence results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: api_intel_bb results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: prime_mmap_kms results: parsing output: 127/ for test: gem_ctx_param results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: gen7_exec_parse results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_ctx_shared 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_ccs results: parsing output: 136/ for test: kms_vblank results: parsing output: 137/ for test: kms_big_fb results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_plane_scaling results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_content_protection results: parsing output: 142/ for test: kms_cursor_legacy results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: gem_exec_params results: parsing output: 145/ for test: i915_pm_freq_api results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: api_intel_allocator results: parsing output: 148/ for test: gem_softpin results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_prop_blob results: parsing output: 151/ for test: tools_test results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_big_fb results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: gem_reg_read Done.