[56.686593] Initializing watchdogs [56.686641] /dev/watchdog0 [56.701039] [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.705465] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.708207] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.711571] [001/133] (960s left) gem_exec_balancer (parallel-keep-submit-fence) [56.992704] Starting subtest: parallel-keep-submit-fence [58.211091] Subtest parallel-keep-submit-fence: SUCCESS (1.236s) [58.343739] [002/133] (958s left) sriov_basic (enable-vfs-autoprobe-off) [58.392829] Starting subtest: enable-vfs-autoprobe-off [58.395149] Starting dynamic subtest: numvfs-1 [58.474639] Dynamic subtest numvfs-1: FAIL (0.034s) [58.481327] Starting dynamic subtest: numvfs-2 [58.552619] Dynamic subtest numvfs-2: FAIL (0.006s) [58.561088] Starting dynamic subtest: numvfs-3 [58.632933] Dynamic subtest numvfs-3: FAIL (0.004s) [58.640902] Starting dynamic subtest: numvfs-4 [58.712956] Dynamic subtest numvfs-4: FAIL (0.004s) [58.720656] Starting dynamic subtest: numvfs-5 [58.789187] Dynamic subtest numvfs-5: FAIL (0.004s) [58.796116] Starting dynamic subtest: numvfs-6 [58.864961] Dynamic subtest numvfs-6: FAIL (0.004s) [58.872634] Starting dynamic subtest: numvfs-7 [58.944235] Dynamic subtest numvfs-7: FAIL (0.004s) [58.952265] Starting dynamic subtest: numvfs-random [59.022636] Dynamic subtest numvfs-random: FAIL (0.004s) [59.030851] Starting dynamic subtest: numvfs-all [59.103598] Dynamic subtest numvfs-all: FAIL (0.004s) [59.105627] Subtest enable-vfs-autoprobe-off: FAIL (0.552s) [59.140348] [003/133] (958s left) i915_pm_rpm (system-suspend) [61.086719] Starting subtest: system-suspend [79.188157] Subtest system-suspend: SUCCESS (2.994s) [79.560206] [004/133] (937s left) prime_vgem (fence-flip-hang) [79.669381] Subtest fence-flip-hang: SKIP (0.000s) [79.775705] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true [79.778731] [005/133] (937s left) kms_big_fb (x-tiled-32bpp-rotate-180) [79.879202] Starting subtest: x-tiled-32bpp-rotate-180 [81.219795] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.392s) [81.347396] [006/133] (936s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [81.462267] Starting subtest: cursor-vs-flip-atomic-transitions [111.442744] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.227s) [112.278993] [007/133] (905s left) gem_exec_schedule (pi-userfault) [112.463256] Starting subtest: pi-userfault [112.465251] Starting dynamic subtest: rcs0 [112.474188] Dynamic subtest rcs0: SUCCESS (0.013s) [112.482641] Starting dynamic subtest: bcs0 [112.484953] Dynamic subtest bcs0: SUCCESS (0.008s) [112.493106] Starting dynamic subtest: vcs0 [112.495059] Dynamic subtest vcs0: SUCCESS (0.007s) [112.503579] Starting dynamic subtest: vcs1 [112.505876] Dynamic subtest vcs1: SUCCESS (0.008s) [112.514491] Starting dynamic subtest: vecs0 [112.516837] Dynamic subtest vecs0: SUCCESS (0.010s) [112.526515] Starting dynamic subtest: ccs0 [112.528705] Dynamic subtest ccs0: SUCCESS (0.007s) [112.530871] Subtest pi-userfault: SUCCESS (0.054s) [112.696126] [008/133] (904s left) gem_mmap_gtt (basic-write-read-distinct) [112.739874] Subtest basic-write-read-distinct: SKIP (0.000s) [112.798767] [009/133] (904s left) kms_prop_blob (basic) [112.857706] Starting subtest: basic [112.860000] Subtest basic: SUCCESS (0.000s) [112.953668] [010/133] (904s left) gem_mmap_offset (mmap-boundaries) [113.016103] Starting subtest: mmap-boundaries [113.018583] Starting dynamic subtest: smem0 [113.293643] Dynamic subtest smem0: SUCCESS (0.280s) [113.296049] Subtest mmap-boundaries: SUCCESS (0.280s) [113.397722] [011/133] (904s left) kms_hdmi_inject (inject-4k) [113.742287] Starting subtest: inject-4k [114.056632] Subtest inject-4k: SUCCESS (0.315s) [114.629316] [012/133] (903s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [114.757705] Starting subtest: flip-vs-cursor-atomic-transitions [122.293311] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.531s) [123.120407] [013/133] (894s left) gem_madvise (dontneed-before-mmap) [123.160259] Starting subtest: dontneed-before-mmap [123.190296] Subtest dontneed-before-mmap: SUCCESS (0.029s) [123.284840] [014/133] (894s left) gem_pxp (hw-rejects-pxp-context) [123.426747] Starting subtest: hw-rejects-pxp-context [123.431495] Subtest hw-rejects-pxp-context: SKIP (0.000s) [123.547019] [015/133] (894s left) kms_busy (basic-hang) [123.640763] Starting subtest: basic-hang [123.643260] Starting dynamic subtest: flip-pipe-A [124.264844] Dynamic subtest flip-pipe-A: SUCCESS (0.625s) [124.274868] Starting dynamic subtest: modeset-pipe-A [127.637142] Dynamic subtest modeset-pipe-A: SUCCESS (3.370s) [127.649031] Starting dynamic subtest: flip-pipe-D [128.892006] Dynamic subtest flip-pipe-D: SUCCESS (1.251s) [128.901128] Starting dynamic subtest: modeset-pipe-D [132.235957] Dynamic subtest modeset-pipe-D: SUCCESS (3.344s) [132.238365] Subtest basic-hang: SUCCESS (8.595s) [133.113696] [016/133] (884s left) kms_psr (fbc-psr2-primary-page-flip) [133.209083] Starting subtest: fbc-psr2-primary-page-flip [133.211172] Starting dynamic subtest: eDP-1 [133.215490] Dynamic subtest eDP-1: SKIP (0.000s) [133.219851] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [133.291643] [017/133] (884s left) kms_invalid_mode (clock-too-high) [133.386078] Starting subtest: clock-too-high [133.388346] Starting dynamic subtest: pipe-A-eDP-1 [133.392416] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [133.402957] Starting dynamic subtest: pipe-B-eDP-1 [133.407109] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [133.416053] Starting dynamic subtest: pipe-C-eDP-1 [133.419879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [133.427816] Starting dynamic subtest: pipe-D-eDP-1 [133.431701] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [133.435679] Subtest clock-too-high: SKIP (0.003s) [133.473812] [018/133] (884s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [133.560686] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [133.563026] Starting dynamic subtest: pipe-A-default-mode [134.737449] Dynamic subtest pipe-A-default-mode: SKIP (1.176s) [134.741878] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.177s) [134.896693] [019/133] (883s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [134.987795] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [134.990150] Starting dynamic subtest: A-eDP1 [138.645059] Dynamic subtest A-eDP1: SUCCESS (3.655s) [138.655133] Starting dynamic subtest: B-eDP1 [141.935470] Dynamic subtest B-eDP1: SUCCESS (3.290s) [141.945164] Starting dynamic subtest: C-eDP1 [145.232737] Dynamic subtest C-eDP1: SUCCESS (3.295s) [145.241838] Starting dynamic subtest: D-eDP1 [148.542384] Dynamic subtest D-eDP1: SUCCESS (3.311s) [148.544671] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.558s) [149.403466] [020/133] (868s left) kms_psr (fbc-pr-cursor-blt) [149.496409] Starting subtest: fbc-pr-cursor-blt [149.500829] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [149.583202] [021/133] (868s left) kms_fbcon_fbt (fbc) [149.646997] Starting subtest: fbc [156.134626] Subtest fbc: SUCCESS (6.489s) [157.284563] [022/133] (860s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [157.827687] Starting subtest: syncobj-stationary-timeline-chain-engines [157.921866] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.100s) [159.139045] [023/133] (858s left) i915_suspend (sysfs-reader) [159.196298] Starting subtest: sysfs-reader [177.537969] Subtest sysfs-reader: SUCCESS (3.359s) [177.618012] [024/133] (840s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [177.719867] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [181.621838] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.034s) [182.768814] [025/133] (835s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [182.830251] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [182.835809] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [183.019452] [026/133] (835s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [183.110266] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [183.115236] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [183.179624] [027/133] (835s left) kms_psr (pr-sprite-render) [183.274001] Starting subtest: pr-sprite-render [183.278940] Subtest pr-sprite-render: SKIP (0.000s) [183.345894] [028/133] (834s left) kms_lease (lease-uevent) [183.428080] Starting subtest: lease-uevent [184.438148] Subtest lease-uevent: SUCCESS (1.029s) [184.512350] [029/133] (833s left) kms_flip (flip-vs-panning-interruptible) [184.607279] Starting subtest: flip-vs-panning-interruptible [184.609908] Starting dynamic subtest: A-eDP1 [193.274356] Dynamic subtest A-eDP1: SUCCESS (8.755s) [193.292479] Starting dynamic subtest: B-eDP1 [202.005450] Dynamic subtest B-eDP1: SUCCESS (8.759s) [202.014710] Starting dynamic subtest: C-eDP1 [210.676493] Dynamic subtest C-eDP1: SUCCESS (8.680s) [210.685424] Starting dynamic subtest: D-eDP1 [219.365496] Dynamic subtest D-eDP1: SUCCESS (8.684s) [219.370441] Subtest flip-vs-panning-interruptible: SUCCESS (34.893s) [220.603224] [030/133] (797s left) kms_flip (dpms-vs-vblank-race) [220.703006] Starting subtest: dpms-vs-vblank-race [220.705637] Starting dynamic subtest: A-eDP1 [224.564658] Dynamic subtest A-eDP1: SUCCESS (3.860s) [224.577317] Starting dynamic subtest: B-eDP1 [228.050925] Dynamic subtest B-eDP1: SUCCESS (3.488s) [228.060958] Starting dynamic subtest: C-eDP1 [231.545178] Dynamic subtest C-eDP1: SUCCESS (3.490s) [231.557410] Starting dynamic subtest: D-eDP1 [236.156700] Dynamic subtest D-eDP1: SUCCESS (4.612s) [236.159045] Subtest dpms-vs-vblank-race: SUCCESS (15.459s) [236.993344] [031/133] (781s left) kms_plane_alpha_blend (alpha-basic) [237.088309] Starting subtest: alpha-basic [237.374782] Starting dynamic subtest: pipe-A-eDP-1 [239.267798] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s) [239.295796] Starting dynamic subtest: pipe-D-eDP-1 [241.949340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.659s) [241.952335] Subtest alpha-basic: SUCCESS (4.862s) [242.800538] [032/133] (775s left) syncobj_timeline (multi-wait-available-submitted-signaled) [242.855266] Starting subtest: multi-wait-available-submitted-signaled [242.857805] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [242.948817] [033/133] (775s left) kms_sequence (get-forked-busy) [243.041602] Starting subtest: get-forked-busy [243.043923] Starting dynamic subtest: pipe-A-eDP-1 [244.978535] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s) [244.988472] Starting dynamic subtest: pipe-B-eDP-1 [247.555216] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.577s) [247.565107] Starting dynamic subtest: pipe-C-eDP-1 [250.129340] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.574s) [250.139458] Starting dynamic subtest: pipe-D-eDP-1 [252.722107] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.593s) [252.724749] Subtest get-forked-busy: SUCCESS (9.686s) [253.577294] [034/133] (765s left) sysfs_preempt_timeout (timeout) [253.632487] Starting subtest: timeout [253.635409] Starting dynamic subtest: vecs0 [263.072764] Dynamic subtest vecs0: SUCCESS (9.440s) [263.083430] Starting dynamic subtest: ccs0 [264.362793] Dynamic subtest ccs0: SUCCESS (1.292s) [264.372366] Starting dynamic subtest: vcs0 [274.081657] Dynamic subtest vcs0: SUCCESS (9.717s) [274.092955] Starting dynamic subtest: bcs0 [275.367429] Dynamic subtest bcs0: SUCCESS (1.285s) [275.379453] Starting dynamic subtest: rcs0 [276.618712] Dynamic subtest rcs0: SUCCESS (1.249s) [276.630457] Starting dynamic subtest: vcs1 [286.048469] Dynamic subtest vcs1: SUCCESS (9.425s) [286.051624] Subtest timeout: SUCCESS (32.419s) [286.133103] [035/133] (732s left) kms_scaling_modes (scaling-mode-full) [286.224222] Starting subtest: scaling-mode-full [286.227462] Starting dynamic subtest: pipe-A-eDP-1 [286.320180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s) [286.329439] Starting dynamic subtest: pipe-B-eDP-1 [287.474972] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s) [287.486128] Starting dynamic subtest: pipe-C-eDP-1 [288.642436] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.166s) [288.651961] Starting dynamic subtest: pipe-D-eDP-1 [289.755683] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.112s) [289.758135] Subtest scaling-mode-full: SUCCESS (3.535s) [290.884278] [036/133] (727s left) i915_drm_fdinfo (virtual-busy-idle-all) [290.924512] Starting subtest: virtual-busy-idle-all [290.929249] Subtest virtual-busy-idle-all: SKIP (0.000s) [291.018880] [037/133] (727s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [291.107096] Starting subtest: 4-tiled-addfb-size-offset-overflow [291.109234] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [291.198346] [038/133] (727s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [291.305241] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [291.310232] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [291.396695] [039/133] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [291.492091] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [291.497140] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [291.585293] [040/133] (727s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [291.958183] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [292.761331] [041/133] (726s left) kms_color (ctm-0-25) [292.847805] Starting subtest: ctm-0-25 [292.850083] Starting dynamic subtest: pipe-A-eDP-1 [296.325006] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s) [296.337324] Starting dynamic subtest: pipe-B-eDP-1 [300.543472] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.216s) [300.552496] Starting dynamic subtest: pipe-C-eDP-1 [304.582279] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.038s) [304.593107] Starting dynamic subtest: pipe-D-eDP-1 [308.594802] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.009s) [308.597589] Subtest ctm-0-25: SUCCESS (15.745s) [309.397906] [042/133] (709s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [309.486864] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [309.489321] Starting dynamic subtest: pipe-A-eDP-1 [309.514907] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [309.526004] Starting dynamic subtest: pipe-B-eDP-1 [309.551684] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [309.560253] Starting dynamic subtest: pipe-C-eDP-1 [309.585914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [309.594699] Starting dynamic subtest: pipe-D-eDP-1 [309.620833] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [309.625429] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [311.685271] [043/133] (707s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [311.786942] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [316.369624] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.589s) [317.547058] [044/133] (701s left) gem_vm_create (create-ext) [317.613346] Starting subtest: create-ext [317.616283] Subtest create-ext: SUCCESS (0.005s) [317.735336] [045/133] (701s left) kms_cursor_legacy (cursor-vs-flip-atomic) [317.865696] Starting subtest: cursor-vs-flip-atomic [347.131221] Subtest cursor-vs-flip-atomic: SUCCESS (29.270s) [347.963754] [046/133] (671s left) kms_content_protection (atomic-hdcp14) [348.103707] Starting subtest: atomic-hdcp14 [348.108852] Subtest atomic-hdcp14: SKIP (0.000s) [348.233488] [047/133] (670s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [348.324702] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [348.327096] Starting dynamic subtest: pipe-A-eDP-1 [348.350647] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [348.360342] Starting dynamic subtest: pipe-B-eDP-1 [348.383179] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [348.392271] Starting dynamic subtest: pipe-C-eDP-1 [348.415166] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [348.427012] Starting dynamic subtest: pipe-D-eDP-1 [348.452220] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [348.457015] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [350.560259] [048/133] (668s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [350.662014] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [350.664249] Starting dynamic subtest: pipe-A-eDP-1 [350.758616] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [350.768226] Starting dynamic subtest: pipe-B-eDP-1 [351.914286] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s) [351.919662] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.254s) [353.164916] [049/133] (666s left) kms_async_flips (crc-atomic) [353.262431] Starting subtest: crc-atomic [353.637370] Starting dynamic subtest: pipe-A-eDP-1 [356.550447] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.912s) [356.933133] Starting dynamic subtest: pipe-B-eDP-1 [359.860233] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.937s) [360.241293] Starting dynamic subtest: pipe-C-eDP-1 [363.111542] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.881s) [363.479210] Starting dynamic subtest: pipe-D-eDP-1 [366.338358] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.869s) [366.341306] Subtest crc-atomic: SUCCESS (13.080s) [367.556461] [050/133] (651s left) kms_addfb_basic (basic-x-tiled-legacy) [367.619416] Starting subtest: basic-x-tiled-legacy [367.624723] Subtest basic-x-tiled-legacy: SKIP (0.000s) [367.747383] [051/133] (651s left) kms_cursor_legacy (single-bo) [367.854757] Starting subtest: single-bo [367.857289] Starting dynamic subtest: pipe-A [373.235595] Dynamic subtest pipe-A: SUCCESS (5.379s) [373.247551] Starting dynamic subtest: pipe-B [378.616748] Dynamic subtest pipe-B: SUCCESS (5.379s) [378.628190] Starting dynamic subtest: pipe-C [383.996755] Dynamic subtest pipe-C: SUCCESS (5.379s) [384.006946] Starting dynamic subtest: pipe-D [389.376492] Dynamic subtest pipe-D: SUCCESS (5.380s) [389.386470] Starting dynamic subtest: all-pipes [394.764776] Dynamic subtest all-pipes: SUCCESS (5.387s) [394.767457] Subtest single-bo: SUCCESS (26.916s) [394.908446] [052/133] (624s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [394.971268] Starting subtest: wait-all-for-submit-delayed-submit [395.072125] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [395.153164] [053/133] (624s left) gem_pipe_control_store_loop (reused-buffer) [395.219193] Starting subtest: reused-buffer [397.370174] Subtest reused-buffer: SUCCESS (2.153s) [397.490806] [054/133] (621s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [397.578029] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [397.580379] Starting dynamic subtest: pipe-A-eDP-1 [399.753149] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.176s) [399.762179] Starting dynamic subtest: pipe-B-eDP-1 [402.030246] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.276s) [402.039588] Starting dynamic subtest: pipe-C-eDP-1 [404.142949] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.112s) [404.151303] Starting dynamic subtest: pipe-D-eDP-1 [406.394879] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s) [406.397004] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.818s) [407.557945] [055/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [407.674148] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [407.679285] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [407.769933] [056/133] (611s left) kms_cursor_crc (cursor-rapid-movement-256x85) [408.036277] Starting subtest: cursor-rapid-movement-256x85 [408.083537] Subtest cursor-rapid-movement-256x85: SKIP (0.041s) [408.286093] [057/133] (611s left) gem_exec_schedule (submit-late-slice) [408.361789] Starting subtest: submit-late-slice [408.363933] Starting dynamic subtest: rcs0 [408.400025] Dynamic subtest rcs0: SUCCESS (0.049s) [408.411977] Starting dynamic subtest: bcs0 [408.428376] Dynamic subtest bcs0: SUCCESS (0.028s) [408.438242] Starting dynamic subtest: vcs0 [408.459809] Dynamic subtest vcs0: SUCCESS (0.030s) [408.473818] Starting dynamic subtest: vcs1 [408.498747] Dynamic subtest vcs1: SUCCESS (0.037s) [408.507976] Starting dynamic subtest: vecs0 [408.534043] Dynamic subtest vecs0: SUCCESS (0.034s) [408.545281] Starting dynamic subtest: ccs0 [408.564245] Dynamic subtest ccs0: SUCCESS (0.029s) [408.566716] Subtest submit-late-slice: SUCCESS (0.214s) [410.100123] [058/133] (609s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [410.210184] Starting subtest: basic-busy-flip-before-cursor-legacy [410.215432] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [410.355361] [059/133] (609s left) kms_big_fb (y-tiled-32bpp-rotate-180) [410.447057] Starting subtest: y-tiled-32bpp-rotate-180 [410.451777] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [410.527477] [060/133] (609s left) gem_exec_schedule (u-submit-golden-slice) [410.598743] Starting subtest: u-submit-golden-slice [410.600938] Starting dynamic subtest: rcs0 [410.622160] Dynamic subtest rcs0: SUCCESS (0.032s) [410.634144] Starting dynamic subtest: bcs0 [410.649071] Dynamic subtest bcs0: SUCCESS (0.026s) [410.657846] Starting dynamic subtest: vcs0 [410.683901] Dynamic subtest vcs0: SUCCESS (0.034s) [410.696895] Starting dynamic subtest: vcs1 [410.721070] Dynamic subtest vcs1: SUCCESS (0.037s) [410.730575] Starting dynamic subtest: vecs0 [410.747691] Dynamic subtest vecs0: SUCCESS (0.026s) [410.757475] Starting dynamic subtest: ccs0 [410.783424] Dynamic subtest ccs0: SUCCESS (0.035s) [410.786278] Subtest u-submit-golden-slice: SUCCESS (0.194s) [412.159946] [061/133] (607s left) gem_exec_parallel (userptr) [412.221161] Starting subtest: userptr [412.223658] Starting dynamic subtest: rcs0 [414.037859] Dynamic subtest rcs0: SUCCESS (1.815s) [414.047455] Starting dynamic subtest: bcs0 [415.863154] Dynamic subtest bcs0: SUCCESS (1.824s) [415.873852] Starting dynamic subtest: vcs0 [419.108309] Dynamic subtest vcs0: SUCCESS (3.242s) [419.118419] Starting dynamic subtest: vcs1 [421.092096] Dynamic subtest vcs1: SUCCESS (1.980s) [421.102461] Starting dynamic subtest: vecs0 [423.011963] Dynamic subtest vecs0: SUCCESS (1.916s) [423.023645] Starting dynamic subtest: ccs0 [424.894324] Dynamic subtest ccs0: SUCCESS (1.881s) [424.897448] Subtest userptr: SUCCESS (12.669s) [425.083862] [062/133] (594s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [425.143451] Subtest writes-after-reads: SKIP (0.000s) [425.213812] [063/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [425.314264] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [425.319201] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [425.422298] [064/133] (594s left) kms_getfb (getfb2-handle-protection) [425.524163] Starting subtest: getfb2-handle-protection [425.550575] Subtest getfb2-handle-protection: SUCCESS (0.027s) [425.678785] [065/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [425.787133] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [425.792720] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [425.896346] [066/133] (594s left) gem_gpgpu_fill (basic) [425.959349] Starting subtest: basic [425.961891] Starting dynamic subtest: smem [425.967723] Dynamic subtest smem: SUCCESS (0.008s) [425.970244] Subtest basic: SUCCESS (0.009s) [426.118811] [067/133] (593s left) kms_big_fb (linear-16bpp-rotate-270) [426.224081] Starting subtest: linear-16bpp-rotate-270 [426.243892] Subtest linear-16bpp-rotate-270: SKIP (0.019s) [426.346933] [068/133] (593s left) gem_ctx_sseu (engines) [426.406178] Subtest engines: SKIP (0.000s) [426.465806] [069/133] (593s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [426.559790] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [426.562101] Starting dynamic subtest: pipe-A-default-mode [429.251408] Dynamic subtest pipe-A-default-mode: SUCCESS (2.689s) [429.254320] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.690s) [430.055788] [070/133] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [430.161232] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [437.338108] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.178s) [437.473653] [071/133] (582s left) kms_chamelium_frames (hdmi-crc-multiple) [437.851386] Subtest hdmi-crc-multiple: SKIP (0.000s) [438.633272] [072/133] (581s left) syncobj_wait (invalid-signal-illegal-handle) [438.689424] Starting subtest: invalid-signal-illegal-handle [438.692274] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [438.794853] [073/133] (581s left) gem_ctx_persistence (heartbeat-hang) [438.854376] Starting subtest: heartbeat-hang [438.860253] Subtest heartbeat-hang: SKIP (0.000s) [438.953657] [074/133] (581s left) perf_pmu (render-node-busy) [439.014033] Starting subtest: render-node-busy [439.016368] Starting dynamic subtest: rcs0 [439.584259] Dynamic subtest rcs0: SUCCESS (0.568s) [439.596150] Starting dynamic subtest: bcs0 [440.153742] Dynamic subtest bcs0: SUCCESS (0.568s) [440.166606] Starting dynamic subtest: vcs0 [442.084771] Dynamic subtest vcs0: SUCCESS (1.927s) [442.096502] Starting dynamic subtest: vcs1 [444.069823] Dynamic subtest vcs1: SUCCESS (1.982s) [444.081950] Starting dynamic subtest: vecs0 [446.052661] Dynamic subtest vecs0: SUCCESS (1.979s) [446.065742] Starting dynamic subtest: ccs0 [446.622126] Dynamic subtest ccs0: SUCCESS (0.567s) [446.625274] Subtest render-node-busy: SUCCESS (7.608s) [446.700054] [075/133] (573s left) gem_ctx_engines (execute-one) [446.771600] Starting subtest: execute-one [450.583863] Subtest execute-one: SUCCESS (3.815s) [450.775908] [076/133] (569s left) syncobj_timeline (invalid-query-zero-handles) [450.833300] Starting subtest: invalid-query-zero-handles [450.836276] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [450.924083] [077/133] (569s left) gem_ccs (block-multicopy-inplace) [450.991209] Starting subtest: block-multicopy-inplace [450.996929] Subtest block-multicopy-inplace: SKIP (0.000s) [451.100671] [078/133] (569s left) gem_partial_pwrite_pread (write) [451.161451] Subtest write: SKIP (0.000s) [451.229585] [079/133] (569s left) kms_pipe_crc_basic (bad-source) [451.316349] Starting subtest: bad-source [451.319295] Subtest bad-source: SUCCESS (0.000s) [451.388686] [080/133] (569s left) core_setmaster (master-drop-set-root) [451.458343] Starting subtest: master-drop-set-root [451.483253] Subtest master-drop-set-root: SUCCESS (0.025s) [451.531792] [081/133] (569s left) kms_cursor_crc (cursor-sliding-512x170) [451.816763] Starting subtest: cursor-sliding-512x170 [451.820275] Subtest cursor-sliding-512x170: SKIP (0.001s) [451.953676] [082/133] (568s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [452.040958] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [452.043334] Starting dynamic subtest: pipe-A-eDP-1 [452.068679] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [452.082287] Starting dynamic subtest: pipe-B-eDP-1 [452.105181] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [452.114564] Starting dynamic subtest: pipe-C-eDP-1 [452.138225] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [452.147337] Starting dynamic subtest: pipe-D-eDP-1 [452.168016] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [452.171576] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [454.247046] [083/133] (566s left) kms_frontbuffer_tracking (pipe-fbc-rte) [454.334449] Starting subtest: pipe-fbc-rte [454.341253] Starting dynamic subtest: pipe-B-eDP-1 [459.775742] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.444s) [459.784214] Subtest pipe-fbc-rte: SUCCESS (5.446s) [462.059215] [084/133] (558s left) kms_psr (fbc-psr-cursor-plane-move) [462.149042] Starting subtest: fbc-psr-cursor-plane-move [462.151925] Starting dynamic subtest: eDP-1 [462.156835] Dynamic subtest eDP-1: SKIP (0.000s) [462.161603] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [462.220168] [085/133] (558s left) kms_cursor_crc (cursor-offscreen-32x32) [462.371786] Starting subtest: cursor-offscreen-32x32 [462.414429] Subtest cursor-offscreen-32x32: SKIP (0.041s) [462.686042] [086/133] (558s left) gem_mmap_gtt (cpuset-medium-copy) [462.735443] Subtest cpuset-medium-copy: SKIP (0.000s) [462.795983] [087/133] (558s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [462.848295] Starting subtest: etime-single-wait-available-unsubmitted [462.952876] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s) [463.030805] [088/133] (557s left) core_setmaster_vs_auth [463.194888] [089/133] (557s left) api_intel_bb (misplaced-blitter) [463.249459] Starting subtest: misplaced-blitter [463.256696] Subtest misplaced-blitter: SUCCESS (0.009s) [463.376816] [090/133] (557s left) kms_psr (psr-basic) [463.480957] Starting subtest: psr-basic [463.483416] Starting dynamic subtest: eDP-1 [465.124509] Dynamic subtest eDP-1: SUCCESS (1.643s) [465.127244] Subtest psr-basic: SUCCESS (1.644s) [465.953549] [091/133] (555s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [466.053365] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [466.058270] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [466.155167] [092/133] (554s left) gem_basic (bad-close) [466.223504] Starting subtest: bad-close [466.228721] Subtest bad-close: SUCCESS (0.000s) [466.310802] [093/133] (554s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [466.401023] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [466.406210] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [466.494831] [094/133] (554s left) prime_mmap (test_errors) [466.542076] Starting subtest: test_errors [466.544271] Starting dynamic subtest: test_errors-smem [466.636719] Dynamic subtest test_errors-smem: SUCCESS (0.097s) [466.639616] Subtest test_errors: SUCCESS (0.098s) [466.724137] [095/133] (554s left) prime_self_import (basic-llseek-size) [466.754289] Starting subtest: basic-llseek-size [466.775270] Subtest basic-llseek-size: SUCCESS (0.021s) [466.875831] [096/133] (554s left) syncobj_wait (single-wait-signaled) [466.927900] Starting subtest: single-wait-signaled [466.930287] Subtest single-wait-signaled: SUCCESS (0.000s) [467.029998] [097/133] (554s left) i915_drm_fdinfo (most-busy-check-all) [467.063996] Starting subtest: most-busy-check-all [467.065957] Starting dynamic subtest: rcs0 [467.070085] Dynamic subtest rcs0: SKIP (0.004s) [467.080247] Starting dynamic subtest: bcs0 [467.084847] Dynamic subtest bcs0: SKIP (0.000s) [467.094074] Starting dynamic subtest: vcs0 [467.098265] Dynamic subtest vcs0: SKIP (0.000s) [467.107434] Starting dynamic subtest: vcs1 [467.112297] Dynamic subtest vcs1: SKIP (0.000s) [467.123631] Starting dynamic subtest: vecs0 [467.128114] Dynamic subtest vecs0: SKIP (0.000s) [467.137029] Starting dynamic subtest: ccs0 [467.141302] Dynamic subtest ccs0: SKIP (0.000s) [467.145823] Subtest most-busy-check-all: SKIP (0.009s) [467.184325] [098/133] (554s left) perf (short-reads) [467.314959] Starting subtest: short-reads [467.330360] Subtest short-reads: SUCCESS (0.016s) [467.373461] [099/133] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [467.481278] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [467.486231] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [467.578710] [100/133] (553s left) gem_spin_batch (resubmit-new-all) [467.644699] Starting subtest: resubmit-new-all [467.647157] Starting dynamic subtest: rcs0 [467.662363] Dynamic subtest rcs0: SUCCESS (0.017s) [467.674301] Starting dynamic subtest: bcs0 [467.676485] Dynamic subtest bcs0: SUCCESS (0.010s) [467.686268] Starting dynamic subtest: vcs0 [467.688802] Dynamic subtest vcs0: SUCCESS (0.009s) [467.702017] Starting dynamic subtest: vcs1 [467.703943] Dynamic subtest vcs1: SUCCESS (0.011s) [467.713733] Starting dynamic subtest: vecs0 [467.716039] Dynamic subtest vecs0: SUCCESS (0.009s) [467.725469] Starting dynamic subtest: ccs0 [467.727583] Dynamic subtest ccs0: SUCCESS (0.009s) [467.729517] Subtest resubmit-new-all: SUCCESS (0.068s) [469.149565] [101/133] (552s left) kms_dp_link_training (uhbr-sst) [469.242850] Starting subtest: uhbr-sst [469.253482] Subtest uhbr-sst: SKIP (0.000s) [469.315085] [102/133] (552s left) gem_userptr_blits (create-destroy-sync) [469.379348] Starting subtest: create-destroy-sync [474.392605] Subtest create-destroy-sync: SUCCESS (5.012s) [474.516006] [103/133] (547s left) kms_addfb_basic (no-handle) [474.577639] Starting subtest: no-handle [474.580103] Subtest no-handle: SUCCESS (0.000s) [474.701739] [104/133] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [474.797490] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [482.084075] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.291s) [482.209763] [105/133] (539s left) gem_exec_reloc (basic-wc-gtt-active) [482.279328] Subtest basic-wc-gtt-active: SKIP (0.000s) [482.344106] [106/133] (539s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [482.450119] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [482.452562] Starting dynamic subtest: pipe-A-eDP-1 [482.546802] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [482.562448] Starting dynamic subtest: pipe-B-eDP-1 [483.700736] Dynamic subtest pipe-B-eDP-1: SKIP (1.150s) [483.706348] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.253s) [484.947924] [107/133] (536s left) api_intel_bb (blit-noreloc-purge-cache) [485.007232] Starting subtest: blit-noreloc-purge-cache [485.015124] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s) [485.132988] [108/133] (536s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [485.238038] Starting subtest: fbc-rgb565-draw-mmap-cpu [489.228999] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.996s) [490.375249] [109/133] (531s left) kms_pm_dc (dc5-psr) [491.471923] Starting subtest: dc5-psr [494.354846] Subtest dc5-psr: SUCCESS (2.884s) [495.151161] [110/133] (526s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [495.246946] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [495.251932] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [495.346413] [111/133] (526s left) gem_ctx_param (invalid-set-ringsize) [495.398852] Starting subtest: invalid-set-ringsize [495.401420] Subtest invalid-set-ringsize: SUCCESS (0.000s) [495.474973] [112/133] (526s left) kms_vrr (flip-suspend) [495.562232] Starting subtest: flip-suspend [495.569620] Subtest flip-suspend: SKIP (0.000s) [495.634845] [113/133] (526s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [495.722590] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [495.725162] Starting dynamic subtest: pipe-A-eDP-1 [496.216928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.466s) [496.227151] Starting dynamic subtest: pipe-B-eDP-1 [497.614918] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s) [497.626688] Starting dynamic subtest: pipe-C-eDP-1 [499.017469] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s) [499.034089] Starting dynamic subtest: pipe-D-eDP-1 [500.410174] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s) [500.412560] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.658s) [501.559376] [114/133] (520s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [501.657254] Starting subtest: plane-downscale-factor-0-5-with-rotation [501.660299] Starting dynamic subtest: pipe-A [501.678726] Dynamic subtest pipe-A: SKIP (0.015s) [501.693432] Starting dynamic subtest: pipe-B [501.703795] Dynamic subtest pipe-B: SKIP (0.027s) [501.714436] Starting dynamic subtest: pipe-C [501.732221] Dynamic subtest pipe-C: SKIP (0.027s) [501.742308] Starting dynamic subtest: pipe-D [501.759114] Dynamic subtest pipe-D: SKIP (0.027s) [501.764032] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.100s) [501.859956] [115/133] (520s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [501.918210] Starting subtest: multi-wait-for-submit-submitted-signaled [501.920895] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [502.019822] [116/133] (520s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [502.115381] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [502.739442] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s) [502.892242] [117/133] (519s left) gem_exec_balancer (bonded-false-hang) [503.156725] Starting subtest: bonded-false-hang [503.162288] Subtest bonded-false-hang: SKIP (0.000s) [503.259937] [118/133] (518s left) gen9_exec_parse (bb-secure) [503.314235] Subtest bb-secure: SKIP (0.000s) [503.402460] [119/133] (518s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [503.501298] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [503.506813] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [503.614998] [120/133] (518s left) kms_flip (blocking-absolute-wf_vblank) [503.712163] Starting subtest: blocking-absolute-wf_vblank [503.714965] Starting dynamic subtest: A-eDP1 [512.468160] Dynamic subtest A-eDP1: SUCCESS (8.759s) [512.488552] Starting dynamic subtest: B-eDP1 [521.170427] Dynamic subtest B-eDP1: SUCCESS (8.700s) [521.181528] Starting dynamic subtest: C-eDP1 [529.858428] Dynamic subtest C-eDP1: SUCCESS (8.687s) [529.879060] Starting dynamic subtest: D-eDP1 [538.556017] Dynamic subtest D-eDP1: SUCCESS (8.695s) [538.562192] Subtest blocking-absolute-wf_vblank: SUCCESS (34.857s) [539.756227] [121/133] (482s left) kms_addfb_basic (bo-too-small-due-to-tiling) [539.853846] Starting subtest: bo-too-small-due-to-tiling [539.859246] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [539.948127] [122/133] (482s left) gem_exec_params (sol-reset-not-gen7) [540.018371] Starting subtest: sol-reset-not-gen7 [540.021333] Subtest sol-reset-not-gen7: SUCCESS (0.003s) [540.139097] [123/133] (482s left) kms_plane_cursor (viewport) [540.219209] Starting subtest: viewport [540.224317] Starting dynamic subtest: pipe-A-eDP-1-size-64 [542.739108] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.521s) [542.800897] Starting dynamic subtest: pipe-A-eDP-1-size-128 [545.274135] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.482s) [545.335131] Starting dynamic subtest: pipe-A-eDP-1-size-256 [547.842302] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.515s) [548.204105] Starting dynamic subtest: pipe-B-eDP-1-size-64 [551.409385] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.220s) [551.469061] Starting dynamic subtest: pipe-B-eDP-1-size-128 [553.919175] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.460s) [553.981048] Starting dynamic subtest: pipe-B-eDP-1-size-256 [556.432275] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.460s) [556.796236] Starting dynamic subtest: pipe-C-eDP-1-size-64 [559.683683] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.900s) [559.721977] Starting dynamic subtest: pipe-C-eDP-1-size-128 [561.762139] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.047s) [561.799760] Starting dynamic subtest: pipe-C-eDP-1-size-256 [563.827804] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.035s) [564.156174] Starting dynamic subtest: pipe-D-eDP-1-size-64 [566.928198] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.783s) [566.966113] Starting dynamic subtest: pipe-D-eDP-1-size-128 [569.038960] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.081s) [569.076737] Starting dynamic subtest: pipe-D-eDP-1-size-256 [571.126753] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.058s) [571.446268] Subtest viewport: SUCCESS (31.232s) [572.247977] [124/133] (450s left) prime_vgem (coherency-gtt) [572.327455] Starting subtest: coherency-gtt [572.333424] Subtest coherency-gtt: SKIP (0.000s) [572.428542] [125/133] (450s left) kms_vrr (flip-basic) [572.534039] Starting subtest: flip-basic [572.541627] Subtest flip-basic: SKIP (0.000s) [572.613333] [126/133] (449s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [572.704411] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [572.706937] Starting dynamic subtest: pipe-A [572.767237] Dynamic subtest pipe-A: SUCCESS (0.065s) [572.777183] Starting dynamic subtest: pipe-B [573.930175] Dynamic subtest pipe-B: SUCCESS (1.162s) [573.942490] Starting dynamic subtest: pipe-C [575.106072] Dynamic subtest pipe-C: SUCCESS (1.174s) [575.117189] Starting dynamic subtest: pipe-D [576.204231] Dynamic subtest pipe-D: SUCCESS (1.097s) [576.206692] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.503s) [577.330972] [127/133] (445s left) gem_exec_flush (basic-batch-kernel-default-wb) [577.396238] Starting subtest: basic-batch-kernel-default-wb [584.998317] Subtest basic-batch-kernel-default-wb: SUCCESS (7.603s) [585.187444] [128/133] (437s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [585.288688] Starting subtest: fbcpsr-slowdraw [610.379985] Subtest fbcpsr-slowdraw: SUCCESS (25.100s) [610.516383] [129/133] (412s left) gem_pwrite (basic-random) [610.575233] Subtest basic-random: SKIP (0.000s) [610.634289] [130/133] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [610.719668] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [610.724267] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [610.821792] [131/133] (411s left) syncobj_eventfd (invalid-bad-pad) [610.877252] Starting subtest: invalid-bad-pad [610.880064] Subtest invalid-bad-pad: SUCCESS (0.000s) [610.988083] [132/133] (411s left) syncobj_wait (wait-any-interrupted) [611.035461] Starting subtest: wait-any-interrupted [611.144345] Subtest wait-any-interrupted: SUCCESS (0.108s) [611.222022] [133/133] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [611.317135] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [611.321337] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [611.421602] 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.