[57.308423] Initializing watchdogs [57.308546] /dev/watchdog0 [57.324117] [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] [57.328929] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.331327] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.335458] [001/133] (960s left) gem_exec_balancer (parallel-keep-submit-fence) [57.626276] Starting subtest: parallel-keep-submit-fence [58.765652] Subtest parallel-keep-submit-fence: SUCCESS (1.133s) [58.882094] [002/133] (958s left) sriov_basic (enable-vfs-autoprobe-off) [58.931233] Starting subtest: enable-vfs-autoprobe-off [58.933671] Starting dynamic subtest: numvfs-1 [59.014531] Dynamic subtest numvfs-1: FAIL (0.032s) [59.023147] Starting dynamic subtest: numvfs-2 [59.095697] Dynamic subtest numvfs-2: FAIL (0.004s) [59.104066] Starting dynamic subtest: numvfs-3 [59.177905] Dynamic subtest numvfs-3: FAIL (0.004s) [59.186421] Starting dynamic subtest: numvfs-4 [59.259574] Dynamic subtest numvfs-4: FAIL (0.003s) [59.269134] Starting dynamic subtest: numvfs-5 [59.341454] Dynamic subtest numvfs-5: FAIL (0.004s) [59.348574] Starting dynamic subtest: numvfs-6 [59.418151] Dynamic subtest numvfs-6: FAIL (0.004s) [59.425248] Starting dynamic subtest: numvfs-7 [59.496280] Dynamic subtest numvfs-7: FAIL (0.004s) [59.503310] Starting dynamic subtest: numvfs-random [59.575070] Dynamic subtest numvfs-random: FAIL (0.004s) [59.582084] Starting dynamic subtest: numvfs-all [59.651693] Dynamic subtest numvfs-all: FAIL (0.494s) [59.653847] Subtest enable-vfs-autoprobe-off: FAIL (0.555s) [59.691537] [003/133] (958s left) i915_pm_rpm (system-suspend) [61.242777] Starting subtest: system-suspend [79.037181] Subtest system-suspend: SUCCESS (2.963s) [79.444860] [004/133] (938s left) prime_vgem (fence-flip-hang) [79.560260] Subtest fence-flip-hang: SKIP (0.000s) [79.653298] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true [79.656720] [005/133] (938s left) kms_big_fb (x-tiled-32bpp-rotate-180) [79.764860] Starting subtest: x-tiled-32bpp-rotate-180 [81.197913] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.402s) [81.347685] [006/133] (936s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [81.467562] Starting subtest: cursor-vs-flip-atomic-transitions [111.983961] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.362s) [112.857711] [007/133] (905s left) gem_exec_schedule (pi-userfault) [113.049689] Starting subtest: pi-userfault [113.052046] Starting dynamic subtest: rcs0 [113.060830] Dynamic subtest rcs0: SUCCESS (0.014s) [113.070357] Starting dynamic subtest: bcs0 [113.072543] Dynamic subtest bcs0: SUCCESS (0.009s) [113.080878] Starting dynamic subtest: vcs0 [113.083032] Dynamic subtest vcs0: SUCCESS (0.009s) [113.091235] Starting dynamic subtest: vcs1 [113.093350] Dynamic subtest vcs1: SUCCESS (0.008s) [113.101568] Starting dynamic subtest: vecs0 [113.103784] Dynamic subtest vecs0: SUCCESS (0.011s) [113.111636] Starting dynamic subtest: ccs0 [113.113534] Dynamic subtest ccs0: SUCCESS (0.007s) [113.115450] Subtest pi-userfault: SUCCESS (0.058s) [113.290208] [008/133] (904s left) gem_mmap_gtt (basic-write-read-distinct) [113.352622] Subtest basic-write-read-distinct: SKIP (0.000s) [113.406959] [009/133] (904s left) kms_prop_blob (basic) [113.462388] Starting subtest: basic [113.464840] Subtest basic: SUCCESS (0.000s) [113.580961] [010/133] (904s left) gem_mmap_offset (mmap-boundaries) [113.641335] Starting subtest: mmap-boundaries [113.643363] Starting dynamic subtest: smem0 [113.924288] Dynamic subtest smem0: SUCCESS (0.284s) [113.926803] Subtest mmap-boundaries: SUCCESS (0.285s) [114.044651] [011/133] (904s left) kms_hdmi_inject (inject-4k) [114.389916] Starting subtest: inject-4k [114.711718] Subtest inject-4k: SUCCESS (0.322s) [115.239971] [012/133] (903s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [115.393367] Starting subtest: flip-vs-cursor-atomic-transitions [123.013194] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.616s) [123.907448] [013/133] (894s left) gem_madvise (dontneed-before-mmap) [123.944116] Starting subtest: dontneed-before-mmap [123.961432] Subtest dontneed-before-mmap: SUCCESS (0.018s) [124.061140] [014/133] (894s left) gem_pxp (hw-rejects-pxp-context) [124.175087] Starting subtest: hw-rejects-pxp-context [124.179933] Subtest hw-rejects-pxp-context: SKIP (0.000s) [124.282253] [015/133] (894s left) kms_busy (basic-hang) [124.384146] Starting subtest: basic-hang [124.386529] Starting dynamic subtest: flip-pipe-A [124.976046] Dynamic subtest flip-pipe-A: SUCCESS (0.590s) [124.986342] Starting dynamic subtest: modeset-pipe-A [128.561609] Dynamic subtest modeset-pipe-A: SUCCESS (3.584s) [128.572966] Starting dynamic subtest: flip-pipe-D [129.787551] Dynamic subtest flip-pipe-D: SUCCESS (1.222s) [129.797144] Starting dynamic subtest: modeset-pipe-D [133.126925] Dynamic subtest modeset-pipe-D: SUCCESS (3.338s) [133.129202] Subtest basic-hang: SUCCESS (8.740s) [133.990927] [016/133] (884s left) kms_psr (fbc-psr2-primary-page-flip) [134.090092] Starting subtest: fbc-psr2-primary-page-flip [134.092206] Starting dynamic subtest: eDP-1 [134.096495] Dynamic subtest eDP-1: SKIP (0.000s) [134.100805] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [134.174645] [017/133] (884s left) kms_invalid_mode (clock-too-high) [134.269430] Starting subtest: clock-too-high [134.271701] Starting dynamic subtest: pipe-A-eDP-1 [134.275683] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [134.286827] Starting dynamic subtest: pipe-B-eDP-1 [134.291059] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [134.299362] Starting dynamic subtest: pipe-C-eDP-1 [134.303385] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [134.311448] Starting dynamic subtest: pipe-D-eDP-1 [134.315592] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [134.319665] Subtest clock-too-high: SKIP (0.003s) [134.363769] [018/133] (884s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [134.446181] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [134.448335] Starting dynamic subtest: pipe-A-default-mode [135.634289] Dynamic subtest pipe-A-default-mode: SKIP (1.184s) [135.638050] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.186s) [135.781124] [019/133] (882s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [135.871839] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [135.874042] Starting dynamic subtest: A-eDP1 [139.534548] Dynamic subtest A-eDP1: SUCCESS (3.660s) [139.545324] Starting dynamic subtest: B-eDP1 [142.835455] Dynamic subtest B-eDP1: SUCCESS (3.298s) [142.846263] Starting dynamic subtest: C-eDP1 [146.125698] Dynamic subtest C-eDP1: SUCCESS (3.288s) [146.135809] Starting dynamic subtest: D-eDP1 [149.414028] Dynamic subtest D-eDP1: SUCCESS (3.288s) [149.416208] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.540s) [150.304975] [020/133] (868s left) kms_psr (fbc-pr-cursor-blt) [150.411689] Starting subtest: fbc-pr-cursor-blt [150.416227] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [150.485252] [021/133] (868s left) kms_fbcon_fbt (fbc) [150.544045] Starting subtest: fbc [157.037304] Subtest fbc: SUCCESS (6.491s) [158.180487] [022/133] (860s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [158.717299] Starting subtest: syncobj-stationary-timeline-chain-engines [158.842284] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.125s) [159.788345] [023/133] (858s left) i915_suspend (sysfs-reader) [159.841894] Starting subtest: sysfs-reader [177.216747] Subtest sysfs-reader: SUCCESS (3.939s) [177.274109] [024/133] (841s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [177.370210] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [181.399091] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.949s) [182.595573] [025/133] (836s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [182.665581] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [182.670473] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [182.850724] [026/133] (836s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [182.943970] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [182.948269] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [183.023622] [027/133] (835s left) kms_psr (pr-sprite-render) [183.119068] Starting subtest: pr-sprite-render [183.123489] Subtest pr-sprite-render: SKIP (0.000s) [183.193017] [028/133] (835s left) kms_lease (lease-uevent) [183.283724] Starting subtest: lease-uevent [184.294858] Subtest lease-uevent: SUCCESS (1.000s) [184.393984] [029/133] (834s left) kms_flip (flip-vs-panning-interruptible) [184.498728] Starting subtest: flip-vs-panning-interruptible [184.503581] Starting dynamic subtest: A-eDP1 [193.192105] Dynamic subtest A-eDP1: SUCCESS (8.636s) [193.203950] Starting dynamic subtest: B-eDP1 [201.926359] Dynamic subtest B-eDP1: SUCCESS (8.713s) [201.937821] Starting dynamic subtest: C-eDP1 [210.653903] Dynamic subtest C-eDP1: SUCCESS (8.717s) [210.663009] Starting dynamic subtest: D-eDP1 [219.361575] Dynamic subtest D-eDP1: SUCCESS (8.703s) [219.366380] Subtest flip-vs-panning-interruptible: SUCCESS (34.781s) [220.582545] [030/133] (798s left) kms_flip (dpms-vs-vblank-race) [220.686711] Starting subtest: dpms-vs-vblank-race [220.688569] Starting dynamic subtest: A-eDP1 [224.536135] Dynamic subtest A-eDP1: SUCCESS (3.847s) [224.548981] Starting dynamic subtest: B-eDP1 [228.058215] Dynamic subtest B-eDP1: SUCCESS (3.520s) [228.067188] Starting dynamic subtest: C-eDP1 [231.550465] Dynamic subtest C-eDP1: SUCCESS (3.489s) [231.559286] Starting dynamic subtest: D-eDP1 [235.030315] Dynamic subtest D-eDP1: SUCCESS (3.477s) [235.035692] Subtest dpms-vs-vblank-race: SUCCESS (14.345s) [235.893128] [031/133] (783s left) kms_plane_alpha_blend (alpha-basic) [235.986245] Starting subtest: alpha-basic [236.277714] Starting dynamic subtest: pipe-A-eDP-1 [238.191663] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.911s) [238.223447] Starting dynamic subtest: pipe-D-eDP-1 [240.840175] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.625s) [240.842551] Subtest alpha-basic: SUCCESS (4.853s) [241.683604] [032/133] (777s left) syncobj_timeline (multi-wait-available-submitted-signaled) [241.745394] Starting subtest: multi-wait-available-submitted-signaled [241.747658] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [241.867006] [033/133] (777s left) kms_sequence (get-forked-busy) [241.964235] Starting subtest: get-forked-busy [241.966465] Starting dynamic subtest: pipe-A-eDP-1 [243.898912] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [243.912422] Starting dynamic subtest: pipe-B-eDP-1 [246.484702] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s) [246.494739] Starting dynamic subtest: pipe-C-eDP-1 [249.044695] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.558s) [249.056216] Starting dynamic subtest: pipe-D-eDP-1 [251.624742] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.577s) [251.627268] Subtest get-forked-busy: SUCCESS (9.657s) [252.490601] [034/133] (766s left) sysfs_preempt_timeout (timeout) [252.554207] Starting subtest: timeout [252.556557] Starting dynamic subtest: vecs0 [262.115582] Dynamic subtest vecs0: SUCCESS (9.560s) [262.127494] Starting dynamic subtest: ccs0 [263.452411] Dynamic subtest ccs0: SUCCESS (1.332s) [263.462659] Starting dynamic subtest: vcs0 [273.123628] Dynamic subtest vcs0: SUCCESS (9.663s) [273.135821] Starting dynamic subtest: bcs0 [274.383576] Dynamic subtest bcs0: SUCCESS (1.260s) [274.392738] Starting dynamic subtest: rcs0 [275.601073] Dynamic subtest rcs0: SUCCESS (1.217s) [275.609705] Starting dynamic subtest: vcs1 [285.157279] Dynamic subtest vcs1: SUCCESS (9.555s) [285.159940] Subtest timeout: SUCCESS (32.599s) [285.234051] [035/133] (734s left) kms_scaling_modes (scaling-mode-full) [285.325662] Starting subtest: scaling-mode-full [285.327591] Starting dynamic subtest: pipe-A-eDP-1 [285.418235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s) [285.429524] Starting dynamic subtest: pipe-B-eDP-1 [286.572274] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s) [286.581870] Starting dynamic subtest: pipe-C-eDP-1 [287.759695] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.186s) [287.769075] Starting dynamic subtest: pipe-D-eDP-1 [288.880259] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s) [288.882531] Subtest scaling-mode-full: SUCCESS (3.558s) [290.081093] [036/133] (729s left) i915_drm_fdinfo (virtual-busy-idle-all) [290.128417] Starting subtest: virtual-busy-idle-all [290.133308] Subtest virtual-busy-idle-all: SKIP (0.000s) [290.194803] [037/133] (729s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [290.287570] Starting subtest: 4-tiled-addfb-size-offset-overflow [290.289908] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [290.404234] [038/133] (729s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [290.509429] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [290.513863] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [290.623449] [039/133] (728s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [290.726446] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [290.730746] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [290.826127] [040/133] (728s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [291.203994] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [291.983693] [041/133] (727s left) kms_color (ctm-0-25) [292.075433] Starting subtest: ctm-0-25 [292.077683] Starting dynamic subtest: pipe-A-eDP-1 [295.554550] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s) [295.564368] Starting dynamic subtest: pipe-B-eDP-1 [299.732408] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.178s) [299.741717] Starting dynamic subtest: pipe-C-eDP-1 [303.803358] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.071s) [303.812913] Starting dynamic subtest: pipe-D-eDP-1 [307.803967] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s) [307.806577] Subtest ctm-0-25: SUCCESS (15.728s) [308.688319] [042/133] (710s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [308.780692] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [308.782948] Starting dynamic subtest: pipe-A-eDP-1 [308.805062] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [308.819656] Starting dynamic subtest: pipe-B-eDP-1 [308.841550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [308.852942] Starting dynamic subtest: pipe-C-eDP-1 [308.873854] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [308.885226] Starting dynamic subtest: pipe-D-eDP-1 [308.906745] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [308.910978] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [310.980954] [043/133] (708s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [311.070712] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [315.632062] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.564s) [316.803087] [044/133] (702s left) gem_vm_create (create-ext) [316.852443] Starting subtest: create-ext [316.857997] Subtest create-ext: SUCCESS (0.006s) [316.995876] [045/133] (702s left) kms_cursor_legacy (cursor-vs-flip-atomic) [317.119244] Starting subtest: cursor-vs-flip-atomic [346.498317] Subtest cursor-vs-flip-atomic: SUCCESS (29.370s) [347.300012] [046/133] (672s left) kms_content_protection (atomic-hdcp14) [347.447254] Starting subtest: atomic-hdcp14 [347.451841] Subtest atomic-hdcp14: SKIP (0.000s) [347.577509] [047/133] (672s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [347.673747] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [347.676082] Starting dynamic subtest: pipe-A-eDP-1 [347.698800] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [347.708789] Starting dynamic subtest: pipe-B-eDP-1 [347.730215] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [347.739237] Starting dynamic subtest: pipe-C-eDP-1 [347.759906] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [347.768437] Starting dynamic subtest: pipe-D-eDP-1 [347.791204] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [347.795703] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [349.894784] [048/133] (669s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [350.008335] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [350.010675] Starting dynamic subtest: pipe-A-eDP-1 [350.083616] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [350.099241] Starting dynamic subtest: pipe-B-eDP-1 [351.235965] Dynamic subtest pipe-B-eDP-1: SKIP (1.148s) [351.240242] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.231s) [352.495090] [049/133] (667s left) kms_async_flips (crc-atomic) [352.598293] Starting subtest: crc-atomic [352.971511] Starting dynamic subtest: pipe-A-eDP-1 [355.886505] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.913s) [356.264340] Starting dynamic subtest: pipe-B-eDP-1 [359.163577] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.908s) [359.539400] Starting dynamic subtest: pipe-C-eDP-1 [362.450376] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.920s) [362.825048] Starting dynamic subtest: pipe-D-eDP-1 [365.743126] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.927s) [365.745171] Subtest crc-atomic: SUCCESS (13.143s) [366.922345] [050/133] (653s left) kms_addfb_basic (basic-x-tiled-legacy) [366.984681] Starting subtest: basic-x-tiled-legacy [366.989410] Subtest basic-x-tiled-legacy: SKIP (0.000s) [367.167093] [051/133] (652s left) kms_cursor_legacy (single-bo) [367.312864] Starting subtest: single-bo [367.314960] Starting dynamic subtest: pipe-A [372.696501] Dynamic subtest pipe-A: SUCCESS (5.379s) [372.708658] Starting dynamic subtest: pipe-B [378.080480] Dynamic subtest pipe-B: SUCCESS (5.380s) [378.092280] Starting dynamic subtest: pipe-C [383.464233] Dynamic subtest pipe-C: SUCCESS (5.379s) [383.475478] Starting dynamic subtest: pipe-D [388.848262] Dynamic subtest pipe-D: SUCCESS (5.379s) [388.859718] Starting dynamic subtest: all-pipes [394.238801] Dynamic subtest all-pipes: SUCCESS (5.386s) [394.241200] Subtest single-bo: SUCCESS (26.916s) [394.384745] [052/133] (625s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [394.434576] Starting subtest: wait-all-for-submit-delayed-submit [394.541685] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.105s) [394.618126] [053/133] (625s left) gem_pipe_control_store_loop (reused-buffer) [394.674668] Starting subtest: reused-buffer [396.826202] Subtest reused-buffer: SUCCESS (2.151s) [396.951355] [054/133] (623s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [397.054722] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [397.056593] Starting dynamic subtest: pipe-A-eDP-1 [399.260837] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.206s) [399.270368] Starting dynamic subtest: pipe-B-eDP-1 [401.480110] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.218s) [401.489330] Starting dynamic subtest: pipe-C-eDP-1 [403.561527] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.081s) [403.570680] Starting dynamic subtest: pipe-D-eDP-1 [405.758825] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.197s) [405.760771] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.707s) [406.988850] [055/133] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [407.096025] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [407.100406] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [407.199778] [056/133] (612s left) kms_cursor_crc (cursor-rapid-movement-256x85) [407.461921] Starting subtest: cursor-rapid-movement-256x85 [407.510797] Subtest cursor-rapid-movement-256x85: SKIP (0.044s) [407.701220] [057/133] (612s left) gem_exec_schedule (submit-late-slice) [407.785274] Starting subtest: submit-late-slice [407.787433] Starting dynamic subtest: rcs0 [407.813366] Dynamic subtest rcs0: SUCCESS (0.035s) [407.822875] Starting dynamic subtest: bcs0 [407.844479] Dynamic subtest bcs0: SUCCESS (0.030s) [407.853669] Starting dynamic subtest: vcs0 [407.878574] Dynamic subtest vcs0: SUCCESS (0.033s) [407.887731] Starting dynamic subtest: vcs1 [407.920324] Dynamic subtest vcs1: SUCCESS (0.041s) [407.935011] Starting dynamic subtest: vecs0 [407.959234] Dynamic subtest vecs0: SUCCESS (0.038s) [407.971168] Starting dynamic subtest: ccs0 [407.994307] Dynamic subtest ccs0: SUCCESS (0.035s) [407.996253] Subtest submit-late-slice: SUCCESS (0.217s) [409.216575] [058/133] (611s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [409.337375] Starting subtest: basic-busy-flip-before-cursor-legacy [409.341925] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [409.493827] [059/133] (610s left) kms_big_fb (y-tiled-32bpp-rotate-180) [409.595078] Starting subtest: y-tiled-32bpp-rotate-180 [409.599364] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [409.697184] [060/133] (610s left) gem_exec_schedule (u-submit-golden-slice) [409.775815] Starting subtest: u-submit-golden-slice [409.778198] Starting dynamic subtest: rcs0 [409.803712] Dynamic subtest rcs0: SUCCESS (0.032s) [409.814392] Starting dynamic subtest: bcs0 [409.837303] Dynamic subtest bcs0: SUCCESS (0.033s) [409.846546] Starting dynamic subtest: vcs0 [409.875021] Dynamic subtest vcs0: SUCCESS (0.037s) [409.884358] Starting dynamic subtest: vcs1 [409.907712] Dynamic subtest vcs1: SUCCESS (0.032s) [409.917153] Starting dynamic subtest: vecs0 [409.944312] Dynamic subtest vecs0: SUCCESS (0.036s) [409.954517] Starting dynamic subtest: ccs0 [409.984988] Dynamic subtest ccs0: SUCCESS (0.040s) [409.987413] Subtest u-submit-golden-slice: SUCCESS (0.214s) [411.265243] [061/133] (609s left) gem_exec_parallel (userptr) [411.339198] Starting subtest: userptr [411.341550] Starting dynamic subtest: rcs0 [412.838063] Dynamic subtest rcs0: SUCCESS (1.502s) [412.847765] Starting dynamic subtest: bcs0 [414.332918] Dynamic subtest bcs0: SUCCESS (1.493s) [414.342521] Starting dynamic subtest: vcs0 [416.165660] Dynamic subtest vcs0: SUCCESS (1.829s) [416.177817] Starting dynamic subtest: vcs1 [418.149007] Dynamic subtest vcs1: SUCCESS (1.981s) [418.161418] Starting dynamic subtest: vecs0 [420.132661] Dynamic subtest vecs0: SUCCESS (1.982s) [420.143311] Starting dynamic subtest: ccs0 [421.605603] Dynamic subtest ccs0: SUCCESS (1.472s) [421.608048] Subtest userptr: SUCCESS (10.274s) [421.810205] [062/133] (598s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [421.881448] Subtest writes-after-reads: SKIP (0.000s) [421.943907] [063/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [422.047027] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [422.051092] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [422.145232] [064/133] (598s left) kms_getfb (getfb2-handle-protection) [422.231589] Starting subtest: getfb2-handle-protection [422.246299] Subtest getfb2-handle-protection: SUCCESS (0.016s) [422.355992] [065/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [422.456860] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [422.461027] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [422.553017] [066/133] (598s left) gem_gpgpu_fill (basic) [422.607867] Starting subtest: basic [422.609790] Starting dynamic subtest: smem [422.614541] Dynamic subtest smem: SUCCESS (0.006s) [422.616783] Subtest basic: SUCCESS (0.007s) [422.759403] [067/133] (597s left) kms_big_fb (linear-16bpp-rotate-270) [422.868685] Starting subtest: linear-16bpp-rotate-270 [422.888876] Subtest linear-16bpp-rotate-270: SKIP (0.019s) [423.014574] [068/133] (597s left) gem_ctx_sseu (engines) [423.069758] Subtest engines: SKIP (0.000s) [423.131228] [069/133] (597s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [423.229569] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [423.231399] Starting dynamic subtest: pipe-A-default-mode [425.981612] Dynamic subtest pipe-A-default-mode: SUCCESS (2.752s) [425.983888] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.753s) [426.784286] [070/133] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [426.885041] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [434.120748] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.242s) [434.256805] [071/133] (586s left) kms_chamelium_frames (hdmi-crc-multiple) [434.652112] Subtest hdmi-crc-multiple: SKIP (0.000s) [435.458071] [072/133] (585s left) syncobj_wait (invalid-signal-illegal-handle) [435.505768] Starting subtest: invalid-signal-illegal-handle [435.508209] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [435.591319] [073/133] (585s left) gem_ctx_persistence (heartbeat-hang) [435.662205] Starting subtest: heartbeat-hang [435.666698] Subtest heartbeat-hang: SKIP (0.000s) [435.767181] [074/133] (585s left) perf_pmu (render-node-busy) [435.847591] Starting subtest: render-node-busy [435.850224] Starting dynamic subtest: rcs0 [436.447860] Dynamic subtest rcs0: SUCCESS (0.600s) [436.459293] Starting dynamic subtest: bcs0 [437.008685] Dynamic subtest bcs0: SUCCESS (0.559s) [437.021008] Starting dynamic subtest: vcs0 [438.117418] Dynamic subtest vcs0: SUCCESS (1.105s) [438.131160] Starting dynamic subtest: vcs1 [440.167131] Dynamic subtest vcs1: SUCCESS (2.045s) [440.180289] Starting dynamic subtest: vecs0 [442.149896] Dynamic subtest vecs0: SUCCESS (1.980s) [442.162267] Starting dynamic subtest: ccs0 [442.723877] Dynamic subtest ccs0: SUCCESS (0.572s) [442.726273] Subtest render-node-busy: SUCCESS (6.879s) [442.804977] [075/133] (578s left) gem_ctx_engines (execute-one) [442.885844] Starting subtest: execute-one [446.263974] Subtest execute-one: SUCCESS (3.382s) [446.456167] [076/133] (574s left) syncobj_timeline (invalid-query-zero-handles) [446.511921] Starting subtest: invalid-query-zero-handles [446.514132] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [446.611620] [077/133] (574s left) gem_ccs (block-multicopy-inplace) [446.666264] Starting subtest: block-multicopy-inplace [446.670794] Subtest block-multicopy-inplace: SKIP (0.000s) [446.764608] [078/133] (574s left) gem_partial_pwrite_pread (write) [446.815691] Subtest write: SKIP (0.000s) [446.894202] [079/133] (574s left) kms_pipe_crc_basic (bad-source) [446.982442] Starting subtest: bad-source [446.984678] Subtest bad-source: SUCCESS (0.000s) [447.057662] [080/133] (574s left) core_setmaster (master-drop-set-root) [447.114438] Starting subtest: master-drop-set-root [447.142254] Subtest master-drop-set-root: SUCCESS (0.025s) [447.190538] [081/133] (574s left) kms_cursor_crc (cursor-sliding-512x170) [447.462115] Starting subtest: cursor-sliding-512x170 [447.465984] Subtest cursor-sliding-512x170: SKIP (0.001s) [447.600865] [082/133] (573s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [447.691115] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [447.693101] Starting dynamic subtest: pipe-A-eDP-1 [447.714717] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [447.726380] Starting dynamic subtest: pipe-B-eDP-1 [447.745871] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [447.755524] Starting dynamic subtest: pipe-C-eDP-1 [447.775324] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [447.784380] Starting dynamic subtest: pipe-D-eDP-1 [447.804449] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [447.807857] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s) [449.987004] [083/133] (571s left) kms_frontbuffer_tracking (pipe-fbc-rte) [450.085104] Starting subtest: pipe-fbc-rte [450.091957] Starting dynamic subtest: pipe-B-eDP-1 [455.493991] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.413s) [455.501485] Subtest pipe-fbc-rte: SUCCESS (5.415s) [457.773330] [084/133] (563s left) kms_psr (fbc-psr-cursor-plane-move) [457.878600] Starting subtest: fbc-psr-cursor-plane-move [457.880966] Starting dynamic subtest: eDP-1 [457.885321] Dynamic subtest eDP-1: SKIP (0.000s) [457.889767] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [457.952893] [085/133] (563s left) kms_cursor_crc (cursor-offscreen-32x32) [458.095296] Starting subtest: cursor-offscreen-32x32 [458.144116] Subtest cursor-offscreen-32x32: SKIP (0.043s) [458.442816] [086/133] (563s left) gem_mmap_gtt (cpuset-medium-copy) [458.495468] Subtest cpuset-medium-copy: SKIP (0.000s) [458.549743] [087/133] (562s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [458.609890] Starting subtest: etime-single-wait-available-unsubmitted [458.713587] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s) [458.807539] [088/133] (562s left) core_setmaster_vs_auth [458.995810] [089/133] (562s left) api_intel_bb (misplaced-blitter) [459.043199] Starting subtest: misplaced-blitter [459.047982] Subtest misplaced-blitter: SUCCESS (0.007s) [459.181067] [090/133] (562s left) kms_psr (psr-basic) [459.279647] Starting subtest: psr-basic [459.281823] Starting dynamic subtest: eDP-1 [460.928255] Dynamic subtest eDP-1: SUCCESS (1.648s) [460.930393] Subtest psr-basic: SUCCESS (1.649s) [461.771736] [091/133] (559s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [461.868902] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [461.873025] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [461.978714] [092/133] (559s left) gem_basic (bad-close) [462.035378] Starting subtest: bad-close [462.039348] Subtest bad-close: SUCCESS (0.000s) [462.124330] [093/133] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [462.221383] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [462.225431] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [462.310026] [094/133] (559s left) prime_mmap (test_errors) [462.359626] Starting subtest: test_errors [462.362180] Starting dynamic subtest: test_errors-smem [462.510085] Dynamic subtest test_errors-smem: SUCCESS (0.152s) [462.512685] Subtest test_errors: SUCCESS (0.153s) [462.630467] [095/133] (559s left) prime_self_import (basic-llseek-size) [462.668933] Starting subtest: basic-llseek-size [462.680764] Subtest basic-llseek-size: SUCCESS (0.014s) [462.799970] [096/133] (559s left) syncobj_wait (single-wait-signaled) [462.848139] Starting subtest: single-wait-signaled [462.850067] Subtest single-wait-signaled: SUCCESS (0.000s) [462.942031] [097/133] (558s left) i915_drm_fdinfo (most-busy-check-all) [462.984826] Starting subtest: most-busy-check-all [462.987032] Starting dynamic subtest: rcs0 [462.991551] Dynamic subtest rcs0: SKIP (0.003s) [463.001484] Starting dynamic subtest: bcs0 [463.005896] Dynamic subtest bcs0: SKIP (0.000s) [463.016220] Starting dynamic subtest: vcs0 [463.020691] Dynamic subtest vcs0: SKIP (0.000s) [463.030197] Starting dynamic subtest: vcs1 [463.034571] Dynamic subtest vcs1: SKIP (0.000s) [463.044160] Starting dynamic subtest: vecs0 [463.048487] Dynamic subtest vecs0: SKIP (0.000s) [463.058191] Starting dynamic subtest: ccs0 [463.062551] Dynamic subtest ccs0: SKIP (0.000s) [463.066899] Subtest most-busy-check-all: SKIP (0.009s) [463.109113] [098/133] (558s left) perf (short-reads) [463.240522] Starting subtest: short-reads [463.253663] Subtest short-reads: SUCCESS (0.014s) [463.293793] [099/133] (558s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [463.428381] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [463.432262] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [463.516616] [100/133] (558s left) gem_spin_batch (resubmit-new-all) [463.589232] Starting subtest: resubmit-new-all [463.591102] Starting dynamic subtest: rcs0 [463.600168] Dynamic subtest rcs0: SUCCESS (0.013s) [463.611079] Starting dynamic subtest: bcs0 [463.613055] Dynamic subtest bcs0: SUCCESS (0.010s) [463.622268] Starting dynamic subtest: vcs0 [463.624185] Dynamic subtest vcs0: SUCCESS (0.011s) [463.633305] Starting dynamic subtest: vcs1 [463.635115] Dynamic subtest vcs1: SUCCESS (0.011s) [463.644219] Starting dynamic subtest: vecs0 [463.646149] Dynamic subtest vecs0: SUCCESS (0.008s) [463.655217] Starting dynamic subtest: ccs0 [463.657093] Dynamic subtest ccs0: SUCCESS (0.009s) [463.658845] Subtest resubmit-new-all: SUCCESS (0.068s) [465.169938] [101/133] (556s left) kms_dp_link_training (uhbr-sst) [465.258431] Starting subtest: uhbr-sst [465.266532] Subtest uhbr-sst: SKIP (0.000s) [465.334448] [102/133] (556s left) gem_userptr_blits (create-destroy-sync) [465.404156] Starting subtest: create-destroy-sync [470.415682] Subtest create-destroy-sync: SUCCESS (5.010s) [470.539746] [103/133] (551s left) kms_addfb_basic (no-handle) [470.597660] Starting subtest: no-handle [470.600118] Subtest no-handle: SUCCESS (0.000s) [470.736377] [104/133] (551s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [470.835532] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [478.136254] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.304s) [478.273883] [105/133] (543s left) gem_exec_reloc (basic-wc-gtt-active) [478.335293] Subtest basic-wc-gtt-active: SKIP (0.000s) [478.410645] [106/133] (543s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [478.510446] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [478.512788] Starting dynamic subtest: pipe-A-eDP-1 [478.609136] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [478.620194] Starting dynamic subtest: pipe-B-eDP-1 [479.721924] Dynamic subtest pipe-B-eDP-1: SKIP (1.114s) [479.726496] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.216s) [480.982282] [107/133] (541s left) api_intel_bb (blit-noreloc-purge-cache) [481.035989] Starting subtest: blit-noreloc-purge-cache [481.043896] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s) [481.128669] [108/133] (541s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [481.231132] Starting subtest: fbc-rgb565-draw-mmap-cpu [485.254875] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.027s) [486.388104] [109/133] (536s left) kms_pm_dc (dc5-psr) [487.490331] Starting subtest: dc5-psr [490.383877] Subtest dc5-psr: SUCCESS (2.891s) [491.190191] [110/133] (531s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [491.297780] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [491.302061] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [491.418388] [111/133] (531s left) gem_ctx_param (invalid-set-ringsize) [491.478704] Starting subtest: invalid-set-ringsize [491.481402] Subtest invalid-set-ringsize: SUCCESS (0.000s) [491.555316] [112/133] (531s left) kms_vrr (flip-suspend) [491.654544] Starting subtest: flip-suspend [491.661070] Subtest flip-suspend: SKIP (0.000s) [491.740024] [113/133] (530s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [491.838982] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [491.841226] Starting dynamic subtest: pipe-A-eDP-1 [492.306746] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s) [492.319192] Starting dynamic subtest: pipe-B-eDP-1 [493.811627] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s) [493.822068] Starting dynamic subtest: pipe-C-eDP-1 [495.242021] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.429s) [495.252442] Starting dynamic subtest: pipe-D-eDP-1 [496.629393] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.387s) [496.631472] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.762s) [497.780183] [114/133] (524s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [497.868849] Starting subtest: plane-downscale-factor-0-5-with-rotation [497.871118] Starting dynamic subtest: pipe-A [497.888674] Dynamic subtest pipe-A: SKIP (0.017s) [497.899859] Starting dynamic subtest: pipe-B [497.919660] Dynamic subtest pipe-B: SKIP (0.031s) [497.929772] Starting dynamic subtest: pipe-C [497.951308] Dynamic subtest pipe-C: SKIP (0.030s) [497.961053] Starting dynamic subtest: pipe-D [497.981418] Dynamic subtest pipe-D: SKIP (0.030s) [497.985085] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.111s) [498.081568] [115/133] (524s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [498.139075] Starting subtest: multi-wait-for-submit-submitted-signaled [498.141326] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [498.254205] [116/133] (524s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [498.344923] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [498.958298] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.615s) [499.146718] [117/133] (523s left) gem_exec_balancer (bonded-false-hang) [499.406623] Starting subtest: bonded-false-hang [499.411512] Subtest bonded-false-hang: SKIP (0.000s) [499.519188] [118/133] (523s left) gen9_exec_parse (bb-secure) [499.588359] Subtest bb-secure: SKIP (0.000s) [499.670718] [119/133] (523s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [499.773246] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [499.777538] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [499.873236] [120/133] (523s left) kms_flip (blocking-absolute-wf_vblank) [499.969693] Starting subtest: blocking-absolute-wf_vblank [499.971946] Starting dynamic subtest: A-eDP1 [508.701888] Dynamic subtest A-eDP1: SUCCESS (8.730s) [508.714952] Starting dynamic subtest: B-eDP1 [517.409579] Dynamic subtest B-eDP1: SUCCESS (8.704s) [517.423204] Starting dynamic subtest: C-eDP1 [526.099104] Dynamic subtest C-eDP1: SUCCESS (8.684s) [526.109697] Starting dynamic subtest: D-eDP1 [534.791104] Dynamic subtest D-eDP1: SUCCESS (8.688s) [534.796945] Subtest blocking-absolute-wf_vblank: SUCCESS (34.823s) [535.981061] [121/133] (486s left) kms_addfb_basic (bo-too-small-due-to-tiling) [536.087882] Starting subtest: bo-too-small-due-to-tiling [536.092087] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [536.198827] [122/133] (486s left) gem_exec_params (sol-reset-not-gen7) [536.257965] Starting subtest: sol-reset-not-gen7 [536.260252] Subtest sol-reset-not-gen7: SUCCESS (0.002s) [536.396211] [123/133] (486s left) kms_plane_cursor (viewport) [536.489379] Starting subtest: viewport [536.493855] Starting dynamic subtest: pipe-A-eDP-1-size-64 [538.999434] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.510s) [539.059983] Starting dynamic subtest: pipe-A-eDP-1-size-128 [541.579303] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.526s) [541.640648] Starting dynamic subtest: pipe-A-eDP-1-size-256 [544.091267] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.459s) [544.441332] Starting dynamic subtest: pipe-B-eDP-1-size-64 [547.622682] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.192s) [547.684990] Starting dynamic subtest: pipe-B-eDP-1-size-128 [550.103614] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.427s) [550.162908] Starting dynamic subtest: pipe-B-eDP-1-size-256 [552.660838] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.505s) [553.012256] Starting dynamic subtest: pipe-C-eDP-1-size-64 [555.924910] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.923s) [555.962562] Starting dynamic subtest: pipe-C-eDP-1-size-128 [558.079958] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.125s) [558.119991] Starting dynamic subtest: pipe-C-eDP-1-size-256 [560.314064] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.202s) [560.644138] Starting dynamic subtest: pipe-D-eDP-1-size-64 [563.469948] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.836s) [563.516305] Starting dynamic subtest: pipe-D-eDP-1-size-128 [565.669864] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.168s) [565.709441] Starting dynamic subtest: pipe-D-eDP-1-size-256 [567.826020] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.125s) [568.146163] Subtest viewport: SUCCESS (31.650s) [568.975216] [124/133] (454s left) prime_vgem (coherency-gtt) [569.061109] Starting subtest: coherency-gtt [569.065529] Subtest coherency-gtt: SKIP (0.000s) [569.154112] [125/133] (453s left) kms_vrr (flip-basic) [569.257292] Starting subtest: flip-basic [569.263737] Subtest flip-basic: SKIP (0.000s) [569.331909] [126/133] (453s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [569.447163] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [569.449386] Starting dynamic subtest: pipe-A [569.522426] Dynamic subtest pipe-A: SUCCESS (0.075s) [569.535805] Starting dynamic subtest: pipe-B [570.669261] Dynamic subtest pipe-B: SUCCESS (1.144s) [570.680591] Starting dynamic subtest: pipe-C [571.755947] Dynamic subtest pipe-C: SUCCESS (1.084s) [571.766661] Starting dynamic subtest: pipe-D [572.861494] Dynamic subtest pipe-D: SUCCESS (1.104s) [572.863906] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.415s) [574.084355] [127/133] (449s left) gem_exec_flush (basic-batch-kernel-default-wb) [574.144335] Starting subtest: basic-batch-kernel-default-wb [581.117943] Subtest basic-batch-kernel-default-wb: SUCCESS (6.972s) [581.307423] [128/133] (441s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [581.415072] Starting subtest: fbcpsr-slowdraw [606.607587] Subtest fbcpsr-slowdraw: SUCCESS (25.189s) [606.746427] [129/133] (416s left) gem_pwrite (basic-random) [606.818171] Subtest basic-random: SKIP (0.000s) [606.884861] [130/133] (416s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [606.982253] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [606.986343] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [607.080839] [131/133] (416s left) syncobj_eventfd (invalid-bad-pad) [607.143193] Starting subtest: invalid-bad-pad [607.145350] Subtest invalid-bad-pad: SUCCESS (0.000s) [607.254969] [132/133] (416s left) syncobj_wait (wait-any-interrupted) [607.326438] Starting subtest: wait-any-interrupted [607.434001] Subtest wait-any-interrupted: SUCCESS (0.107s) [607.513126] [133/133] (415s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [607.603857] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [607.608140] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [607.709006] Closing watchdogs results: parsing output: 0/ for test: gem_exec_balancer results: parsing output: 1/ for test: sriov_basic results: parsing output: 2/ for test: i915_pm_rpm results: parsing output: 3/ for test: prime_vgem results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_cursor_legacy results: parsing output: 6/ for test: gem_exec_schedule results: parsing output: 7/ for test: gem_mmap_gtt results: parsing output: 8/ for test: kms_prop_blob results: parsing output: 9/ for test: gem_mmap_offset results: parsing output: 10/ for test: kms_hdmi_inject results: parsing output: 11/ for test: kms_cursor_legacy results: parsing output: 12/ for test: gem_madvise results: parsing output: 13/ for test: gem_pxp results: parsing output: 14/ for test: kms_busy results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: kms_invalid_mode results: parsing output: 17/ for test: kms_flip_scaled_crc results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: kms_fbcon_fbt results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: i915_suspend results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_render_copy results: parsing output: 25/ for test: kms_plane results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: kms_lease results: parsing output: 28/ for test: kms_flip results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: kms_plane_alpha_blend results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: kms_sequence results: parsing output: 33/ for test: sysfs_preempt_timeout results: parsing output: 34/ for test: kms_scaling_modes results: parsing output: 35/ for test: i915_drm_fdinfo results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_chamelium_hpd results: parsing output: 40/ for test: kms_color results: parsing output: 41/ for test: kms_ccs results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_vm_create results: parsing output: 44/ for test: kms_cursor_legacy results: parsing output: 45/ for test: kms_content_protection results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_psr2_sf results: parsing output: 48/ for test: kms_async_flips results: parsing output: 49/ for test: kms_addfb_basic results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: gem_pipe_control_store_loop results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: gem_exec_schedule results: parsing output: 57/ for test: kms_cursor_legacy results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: gem_exec_schedule results: parsing output: 60/ for test: gem_exec_parallel results: parsing output: 61/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_getfb results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_gpgpu_fill results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: gem_ctx_sseu results: parsing output: 68/ for test: kms_flip_scaled_crc results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_chamelium_frames results: parsing output: 71/ for test: syncobj_wait results: parsing output: 72/ for test: gem_ctx_persistence results: parsing output: 73/ for test: perf_pmu results: parsing output: 74/ for test: gem_ctx_engines results: parsing output: 75/ for test: syncobj_timeline results: parsing output: 76/ for test: gem_ccs results: parsing output: 77/ for test: gem_partial_pwrite_pread results: parsing output: 78/ for test: kms_pipe_crc_basic results: parsing output: 79/ for test: core_setmaster results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_mmap_gtt results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: core_setmaster_vs_auth results: parsing output: 88/ for test: api_intel_bb results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_basic results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: prime_mmap results: parsing output: 94/ for test: prime_self_import results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: i915_drm_fdinfo results: parsing output: 97/ for test: perf results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_spin_batch results: parsing output: 100/ for test: kms_dp_link_training results: parsing output: 101/ for test: gem_userptr_blits results: parsing output: 102/ for test: kms_addfb_basic results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_exec_reloc results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: api_intel_bb results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_pm_dc results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_ctx_param results: parsing output: 111/ for test: kms_vrr results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_plane_scaling results: parsing output: 114/ for test: syncobj_wait results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: gem_exec_balancer results: parsing output: 117/ for test: gen9_exec_parse results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: kms_addfb_basic results: parsing output: 121/ for test: gem_exec_params results: parsing output: 122/ for test: kms_plane_cursor results: parsing output: 123/ for test: prime_vgem results: parsing output: 124/ for test: kms_vrr results: parsing output: 125/ for test: kms_plane_scaling results: parsing output: 126/ for test: gem_exec_flush results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_pwrite results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: syncobj_eventfd results: parsing output: 131/ for test: syncobj_wait results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.