[61.634151] Initializing watchdogs [61.634201] /dev/watchdog0 [61.656457] [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] [61.661244] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.663775] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.666988] [001/156] (960s left) perf (stress-open-close) [61.845402] Starting subtest: stress-open-close [61.847623] Starting dynamic subtest: 0-rcs0 [64.016348] Dynamic subtest 0-rcs0: SUCCESS (2.172s) [64.026757] Starting dynamic subtest: 1-vecs0 [66.179808] Dynamic subtest 1-vecs0: SUCCESS (2.163s) [66.181641] Subtest stress-open-close: SUCCESS (4.336s) [66.218725] [002/156] (955s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [66.332134] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt [66.335736] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [66.444911] [003/156] (955s left) prime_vgem (fence-write-hang) [66.545071] Subtest fence-write-hang: SKIP (0.000s) [66.644060] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [66.646622] [004/156] (955s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [66.746936] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [66.749199] Starting dynamic subtest: pipe-A-eDP-1 [66.767517] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [66.775813] Starting dynamic subtest: pipe-B-eDP-1 [66.793450] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [66.801067] Starting dynamic subtest: pipe-C-eDP-1 [66.818215] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [66.825439] Starting dynamic subtest: pipe-D-eDP-1 [66.843674] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [66.846993] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s) [69.315497] [005/156] (953s left) i915_pm_sseu (full-enable) [69.378769] Subtest full-enable: SKIP (0.000s) [69.487972] [006/156] (952s left) kms_vblank (ts-continuation-modeset) [69.577065] Starting subtest: ts-continuation-modeset [69.579203] Starting dynamic subtest: pipe-A-eDP-1 [71.091192] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.512s) [71.104383] Starting dynamic subtest: pipe-D-eDP-1 [73.267110] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.174s) [73.269979] Subtest ts-continuation-modeset: SUCCESS (3.689s) [74.079074] [007/156] (948s left) kms_busy (extended-modeset-hang-newfb) [74.188290] Starting subtest: extended-modeset-hang-newfb [74.190625] Starting dynamic subtest: pipe-A [108.170393] Dynamic subtest pipe-A: SUCCESS (33.978s) [108.179825] Starting dynamic subtest: pipe-D [131.224487] Dynamic subtest pipe-D: SUCCESS (23.052s) [131.226781] Subtest extended-modeset-hang-newfb: SUCCESS (57.035s) [132.118266] [008/156] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [132.215816] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [138.930065] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.720s) [139.054005] [009/156] (883s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [139.158063] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [139.160293] Starting dynamic subtest: pipe-A-eDP-1 [155.852870] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.284s) [155.863926] Starting dynamic subtest: pipe-B-eDP-1 [172.804513] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.420s) [172.814463] Starting dynamic subtest: pipe-C-eDP-1 [189.771341] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.431s) [189.781375] Starting dynamic subtest: pipe-D-eDP-1 [206.774947] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.375s) [206.777356] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.514s) [208.013118] [010/156] (814s left) syncobj_timeline (device-signal-unordered) [208.076141] Starting subtest: device-signal-unordered [208.078535] Subtest device-signal-unordered: SUCCESS (0.001s) [208.189715] [011/156] (814s left) kms_prime (basic-modeset-hybrid) [208.277719] Subtest basic-modeset-hybrid: SKIP (0.000s) [208.382274] [012/156] (814s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [208.480443] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc [208.484478] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [208.606575] [013/156] (814s left) syncobj_timeline (reset-unsignaled) [208.659784] Starting subtest: reset-unsignaled [208.662085] Subtest reset-unsignaled: SUCCESS (0.000s) [208.780493] [014/156] (813s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [208.871282] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [208.873669] Starting dynamic subtest: A-eDP1 [212.442213] Dynamic subtest A-eDP1: SUCCESS (3.567s) [212.452573] Starting dynamic subtest: B-eDP1 [215.657619] Dynamic subtest B-eDP1: SUCCESS (3.213s) [215.668263] Starting dynamic subtest: C-eDP1 [218.868938] Dynamic subtest C-eDP1: SUCCESS (3.209s) [218.881692] Starting dynamic subtest: D-eDP1 [222.083933] Dynamic subtest D-eDP1: SUCCESS (3.213s) [222.086364] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.209s) [222.886988] [015/156] (799s left) fbdev (eof) [222.937118] Starting subtest: eof [222.939338] Subtest eof: SUCCESS (0.000s) [223.029342] [016/156] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [223.139098] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [223.143446] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [223.233880] [017/156] (799s left) kms_sequence (get-busy) [223.324102] Starting subtest: get-busy [223.326568] Starting dynamic subtest: pipe-A-eDP-1 [225.270409] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s) [225.280945] Starting dynamic subtest: pipe-B-eDP-1 [227.890494] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.620s) [227.900211] Starting dynamic subtest: pipe-C-eDP-1 [230.508341] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.615s) [230.520522] Starting dynamic subtest: pipe-D-eDP-1 [233.131095] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s) [233.133515] Subtest get-busy: SUCCESS (9.806s) [234.017678] [018/156] (788s left) perf_pmu (multi-client) [234.063796] Starting subtest: multi-client [234.066571] Starting dynamic subtest: rcs0 [235.134014] Dynamic subtest rcs0: SUCCESS (1.067s) [235.144414] Starting dynamic subtest: bcs0 [236.183373] Dynamic subtest bcs0: SUCCESS (1.048s) [236.194972] Starting dynamic subtest: vcs0 [237.234335] Dynamic subtest vcs0: SUCCESS (1.048s) [237.245777] Starting dynamic subtest: vcs1 [238.386541] Dynamic subtest vcs1: SUCCESS (1.150s) [238.398025] Starting dynamic subtest: vecs0 [240.438134] Dynamic subtest vecs0: SUCCESS (2.049s) [240.452104] Starting dynamic subtest: ccs0 [242.421599] Dynamic subtest ccs0: SUCCESS (1.981s) [242.424552] Subtest multi-client: SUCCESS (8.355s) [242.540511] [019/156] (780s left) kms_flip (basic-plain-flip) [242.640196] Starting subtest: basic-plain-flip [242.642544] Starting dynamic subtest: A-eDP1 [244.335004] Dynamic subtest A-eDP1: SUCCESS (1.693s) [244.345333] Starting dynamic subtest: B-eDP1 [246.052509] Dynamic subtest B-eDP1: SUCCESS (1.715s) [246.064111] Starting dynamic subtest: C-eDP1 [247.781061] Dynamic subtest C-eDP1: SUCCESS (1.727s) [247.796489] Starting dynamic subtest: D-eDP1 [249.501775] Dynamic subtest D-eDP1: SUCCESS (1.718s) [249.504255] Subtest basic-plain-flip: SUCCESS (6.864s) [250.668583] [020/156] (772s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [250.768884] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [250.773059] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [250.863512] [021/156] (772s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [250.962988] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [250.967378] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [251.034622] [022/156] (771s left) kms_color (ctm-green-to-red) [251.124014] Starting subtest: ctm-green-to-red [251.126219] Starting dynamic subtest: pipe-A-eDP-1 [251.840490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s) [251.850847] Starting dynamic subtest: pipe-B-eDP-1 [253.288705] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s) [253.299204] Starting dynamic subtest: pipe-C-eDP-1 [254.635930] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s) [254.646699] Starting dynamic subtest: pipe-D-eDP-1 [255.983789] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s) [255.985760] Subtest ctm-green-to-red: SUCCESS (4.859s) [256.786212] [023/156] (766s left) gen9_exec_parse (bb-large) [256.839799] Subtest bb-large: SKIP (0.000s) [256.922565] [024/156] (766s left) syncobj_wait (invalid-signal-zero-handles) [256.972805] Starting subtest: invalid-signal-zero-handles [256.974656] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [257.075584] [025/156] (766s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [257.175151] Starting subtest: plane-scaler-unity-scaling-with-rotation [257.177379] Starting dynamic subtest: pipe-A [257.401347] Dynamic subtest pipe-A: SUCCESS (0.228s) [257.413242] Starting dynamic subtest: pipe-B [258.673926] Dynamic subtest pipe-B: SUCCESS (1.272s) [258.685079] Starting dynamic subtest: pipe-C [260.002948] Dynamic subtest pipe-C: SUCCESS (1.328s) [260.013102] Starting dynamic subtest: pipe-D [261.346095] Dynamic subtest pipe-D: SUCCESS (1.342s) [261.348369] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.174s) [262.519786] [026/156] (760s left) gem_softpin (softpin) [262.587933] Starting subtest: softpin [294.858075] Subtest softpin: SUCCESS (32.261s) [294.961736] [027/156] (728s left) kms_psr (fbc-psr2-cursor-blt) [295.061168] Starting subtest: fbc-psr2-cursor-blt [295.063493] Starting dynamic subtest: eDP-1 [295.067646] Dynamic subtest eDP-1: SKIP (0.000s) [295.071893] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [295.136748] [028/156] (728s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [295.241788] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [295.246275] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [295.334994] [029/156] (727s left) gem_ctx_persistence (engines-hostile-preempt) [295.394420] Starting subtest: engines-hostile-preempt [295.396323] Starting dynamic subtest: rcs0 [295.465422] Dynamic subtest rcs0: SUCCESS (0.074s) [295.480476] Starting dynamic subtest: bcs0 [295.514605] Dynamic subtest bcs0: SUCCESS (0.046s) [295.525202] Starting dynamic subtest: vcs0 [297.409575] Dynamic subtest vcs0: SUCCESS (1.891s) [297.422231] Starting dynamic subtest: vcs1 [299.386475] Dynamic subtest vcs1: SUCCESS (1.975s) [299.399530] Starting dynamic subtest: vecs0 [301.367593] Dynamic subtest vecs0: SUCCESS (1.978s) [301.379825] Starting dynamic subtest: ccs0 [301.430048] Dynamic subtest ccs0: SUCCESS (0.062s) [301.432695] Subtest engines-hostile-preempt: SUCCESS (6.038s) [301.514044] [030/156] (721s left) kms_pm_rpm (fences-dpms) [303.549969] Starting subtest: fences-dpms [303.555021] Subtest fences-dpms: SKIP (0.000s) [303.930587] [031/156] (719s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [304.051502] Starting subtest: basic-flip-before-cursor-varying-size [304.992737] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.938s) [305.841298] [032/156] (717s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [305.945673] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [306.323485] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [309.121274] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.797s) [309.134151] Starting dynamic subtest: pipe-A-eDP-1-4 [311.305293] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.183s) [311.319614] Starting dynamic subtest: pipe-A-eDP-1-4 [313.314970] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [313.327140] Starting dynamic subtest: pipe-A-eDP-1-x [315.505126] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s) [315.875072] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [318.652411] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s) [318.664779] Starting dynamic subtest: pipe-B-eDP-1-4 [320.847859] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.195s) [320.860476] Starting dynamic subtest: pipe-B-eDP-1-4 [322.857786] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [322.870878] Starting dynamic subtest: pipe-B-eDP-1-x [325.048001] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [325.423699] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [328.182013] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.766s) [328.195530] Starting dynamic subtest: pipe-C-eDP-1-4 [330.367131] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s) [330.379546] Starting dynamic subtest: pipe-C-eDP-1-4 [332.376927] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [332.387009] Starting dynamic subtest: pipe-C-eDP-1-x [334.555920] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.176s) [334.919184] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [337.706744] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.796s) [337.720111] Starting dynamic subtest: pipe-D-eDP-1-4 [339.881212] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s) [339.893638] Starting dynamic subtest: pipe-D-eDP-1-4 [341.890918] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [341.903963] Starting dynamic subtest: pipe-D-eDP-1-x [344.069884] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [344.073059] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.131s) [345.297850] [033/156] (678s left) i915_pm_rc6_residency (rc6-fence) [345.364595] Starting subtest: rc6-fence [345.397567] Starting dynamic subtest: gt0 [357.719930] Dynamic subtest gt0: SUCCESS (12.322s) [357.735089] Starting dynamic subtest: gt1 [372.347676] Dynamic subtest gt1: SUCCESS (14.623s) [372.351657] Subtest rc6-fence: SUCCESS (26.984s) [372.481176] [034/156] (651s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [372.612607] Starting subtest: cursorB-vs-flipA-atomic [372.617186] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [372.771870] [035/156] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [372.871850] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [372.876015] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [372.962937] [036/156] (650s left) gem_mmap_offset (partial-remap) [373.009907] Starting subtest: partial-remap [373.011741] Starting dynamic subtest: smem0 [373.021183] Dynamic subtest smem0: SUCCESS (0.004s) [373.023109] Subtest partial-remap: SUCCESS (0.005s) [373.172864] [037/156] (650s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [373.283009] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [373.287485] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [373.394012] [038/156] (650s left) kms_atomic_transition (modeset-transition-nonblocking) [373.477560] Starting subtest: modeset-transition-nonblocking [373.479230] Starting dynamic subtest: 1x-outputs [384.625676] Dynamic subtest 1x-outputs: SUCCESS (11.145s) [384.628094] Subtest modeset-transition-nonblocking: SUCCESS (11.147s) [385.501243] [039/156] (638s left) kms_chamelium_audio (hdmi-audio) [385.897531] Subtest hdmi-audio: SKIP (0.000s) [386.704168] [040/156] (637s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [386.802614] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [386.805062] Starting dynamic subtest: pipe-A-eDP-1 [386.825900] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [386.838328] Starting dynamic subtest: pipe-B-eDP-1 [386.857615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [386.867313] Starting dynamic subtest: pipe-C-eDP-1 [386.886275] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [386.895726] Starting dynamic subtest: pipe-D-eDP-1 [386.915433] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [386.917651] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [389.085576] [041/156] (634s left) i915_hangman (hangcheck-unterminated) [389.149458] Starting subtest: hangcheck-unterminated [400.346083] Subtest hangcheck-unterminated: SUCCESS (11.196s) [400.465422] [042/156] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [400.584085] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [400.588614] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [400.676267] [043/156] (623s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [400.776102] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [401.789263] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.013s) [401.950863] [044/156] (622s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [402.052605] Starting subtest: fbc-pr-plane-move-sf-dmg-area [402.056186] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [402.124005] [045/156] (621s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [402.215725] Starting subtest: plane-upscale-factor-0-25-with-modifiers [402.217728] Starting dynamic subtest: pipe-A [402.552479] Dynamic subtest pipe-A: SUCCESS (0.338s) [402.564078] Starting dynamic subtest: pipe-B [403.974622] Dynamic subtest pipe-B: SUCCESS (1.421s) [403.985098] Starting dynamic subtest: pipe-C [405.409299] Dynamic subtest pipe-C: SUCCESS (1.434s) [405.424757] Starting dynamic subtest: pipe-D [406.847591] Dynamic subtest pipe-D: SUCCESS (1.437s) [406.849905] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.634s) [408.025237] [046/156] (616s left) gem_exec_reloc (basic-write-read-noreloc) [408.081205] Subtest basic-write-read-noreloc: SKIP (0.000s) [408.143822] [047/156] (616s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render) [408.243978] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render [408.248100] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [408.359942] [048/156] (615s left) kms_invalid_mode (uint-max-clock) [408.461273] Starting subtest: uint-max-clock [408.463599] Starting dynamic subtest: pipe-A-eDP-1 [408.743436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [408.753706] Starting dynamic subtest: pipe-B-eDP-1 [408.755822] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [408.765886] Starting dynamic subtest: pipe-C-eDP-1 [408.767750] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [408.777346] Starting dynamic subtest: pipe-D-eDP-1 [408.779283] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [408.781138] Subtest uint-max-clock: SUCCESS (0.291s) [409.558703] [049/156] (614s left) gem_mmap (pf-nonblock) [409.610325] Subtest pf-nonblock: SKIP (0.000s) [409.683322] [050/156] (614s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt) [409.783821] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt [409.788332] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [409.872047] [051/156] (614s left) kms_plane (pixel-format-yf-tiled-modifier) [409.962213] Starting subtest: pixel-format-yf-tiled-modifier [409.966296] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s) [410.036082] [052/156] (614s left) syncobj_timeline (etime-multi-wait-submitted) [410.084116] Starting subtest: etime-multi-wait-submitted [410.192080] Subtest etime-multi-wait-submitted: SUCCESS (0.107s) [410.270053] [053/156] (614s left) gem_readwrite (beyond-eob) [410.326691] Subtest beyond-EOB: SKIP (0.000s) [410.391426] [054/156] (614s left) kms_big_fb (y-tiled-16bpp-rotate-180) [410.496778] Starting subtest: y-tiled-16bpp-rotate-180 [410.501149] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [410.590630] [055/156] (613s left) syncobj_timeline (invalid-query-one-illegal-handle) [410.647817] Starting subtest: invalid-query-one-illegal-handle [410.650103] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [410.749107] [056/156] (613s left) gem_ctx_persistence (userptr) [410.801192] Starting subtest: userptr [410.978689] Subtest userptr: SUCCESS (0.180s) [411.059732] [057/156] (613s left) gem_mmap_wc (coherency) [411.113660] Subtest coherency: SKIP (0.000s) [411.170126] [058/156] (613s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [411.273232] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [411.276819] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [411.362312] [059/156] (613s left) kms_lease (invalid-create-leases) [411.456250] Starting subtest: invalid-create-leases [411.460138] Subtest invalid-create-leases: SUCCESS (0.006s) [411.572108] [060/156] (613s left) kms_plane_multiple (tiling-yf) [411.665739] Starting subtest: tiling-yf [411.669247] Subtest tiling-yf: SKIP (0.000s) [411.738900] [061/156] (613s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [411.830827] Starting subtest: psr-2p-scndscrn-spr-indfb-move [411.834480] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [411.926486] [062/156] (612s left) gem_ctx_engines (independent) [411.985781] Starting subtest: independent [411.988155] Starting dynamic subtest: rcs0 [412.136602] Dynamic subtest rcs0: SUCCESS (0.149s) [412.147251] Starting dynamic subtest: bcs0 [412.285119] Dynamic subtest bcs0: SUCCESS (0.147s) [412.299099] Starting dynamic subtest: vcs0 [412.424855] Dynamic subtest vcs0: SUCCESS (0.139s) [412.436024] Starting dynamic subtest: vcs1 [412.550307] Dynamic subtest vcs1: SUCCESS (0.125s) [412.560668] Starting dynamic subtest: vecs0 [412.687652] Dynamic subtest vecs0: SUCCESS (0.135s) [412.699807] Starting dynamic subtest: ccs0 [412.831722] Dynamic subtest ccs0: SUCCESS (0.145s) [412.841964] Starting dynamic subtest: all-engines [413.291021] Dynamic subtest all-engines: SUCCESS (0.457s) [413.294445] Subtest independent: SUCCESS (1.305s) [413.534962] [063/156] (611s left) gem_exec_whisper (basic-sync) [413.600219] Starting subtest: basic-sync [422.803768] Subtest basic-sync: SUCCESS (9.205s) [423.003160] [064/156] (601s left) gem_exec_balancer (waits) [423.059131] Starting subtest: waits [429.635512] Subtest waits: SUCCESS (6.574s) [429.956829] [065/156] (594s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [430.057915] Starting subtest: coverage-vs-premult-vs-constant [430.344969] Starting dynamic subtest: pipe-A-eDP-1 [430.969112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s) [430.982533] Starting dynamic subtest: pipe-D-eDP-1 [432.290323] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s) [432.292512] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.232s) [433.132451] [066/156] (591s left) perf_pmu (busy-check-all) [433.172151] Starting subtest: busy-check-all [433.174580] Starting dynamic subtest: rcs0 [433.721766] Dynamic subtest rcs0: SUCCESS (0.549s) [433.740755] Starting dynamic subtest: bcs0 [434.272340] Dynamic subtest bcs0: SUCCESS (0.548s) [434.285751] Starting dynamic subtest: vcs0 [435.388119] Dynamic subtest vcs0: SUCCESS (1.112s) [435.400762] Starting dynamic subtest: vcs1 [437.372180] Dynamic subtest vcs1: SUCCESS (1.980s) [437.388464] Starting dynamic subtest: vecs0 [437.980780] Dynamic subtest vecs0: FAIL (0.539s) [437.992537] Starting dynamic subtest: ccs0 [439.420432] Dynamic subtest ccs0: SUCCESS (1.505s) [439.423429] Subtest busy-check-all: FAIL (6.248s) [439.552604] [067/156] (585s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [439.659287] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [440.770354] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.112s) [440.914381] [068/156] (584s left) kms_cursor_edge_walk (64x64-top-bottom) [441.012513] Starting subtest: 64x64-top-bottom [441.014335] Starting dynamic subtest: pipe-A-eDP-1 [444.481792] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s) [444.494652] Starting dynamic subtest: pipe-D-eDP-1 [447.609236] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s) [447.611667] Subtest 64x64-top-bottom: SUCCESS (6.598s) [448.427817] [069/156] (576s left) syncobj_timeline (wait-all-interrupted) [448.477877] Starting subtest: wait-all-interrupted [448.585024] Subtest wait-all-interrupted: SUCCESS (0.105s) [448.660655] [070/156] (576s left) gem_eio (create) [448.863502] Starting subtest: create [449.168362] Subtest create: SUCCESS (0.302s) [449.287236] [071/156] (575s left) gem_userptr_blits (access-control) [449.354386] Starting subtest: access-control [449.359053] Subtest access-control: SKIP (0.000s) [449.468266] [072/156] (575s left) prime_vgem (fence-read-hang) [449.530354] Subtest fence-read-hang: SKIP (0.000s) [449.621661] [073/156] (575s left) vgem_basic (bad-pad) [449.659552] Starting subtest: bad-pad [449.661190] Subtest bad-pad: SUCCESS (0.000s) [449.717681] [074/156] (575s left) vgem_slow (nohang) [449.758303] Starting subtest: nohang [459.993602] Subtest nohang: SUCCESS (10.233s) [460.059982] [075/156] (565s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt) [460.171770] Starting subtest: hdr-rgb101010-draw-mmap-gtt [460.176112] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [460.272997] [076/156] (565s left) kms_properties (connector-properties-atomic) [460.359299] Starting subtest: connector-properties-atomic [460.361582] Starting dynamic subtest: pipe-A-eDP-1 [468.473252] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.114s) [468.483605] Starting dynamic subtest: pipe-None-DP-1 [468.487849] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [468.497597] Starting dynamic subtest: pipe-None-HDMI-A-1 [468.501758] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [468.511339] Starting dynamic subtest: pipe-None-DP-2 [468.515223] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [468.524791] Starting dynamic subtest: pipe-None-HDMI-A-2 [468.528749] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [468.539276] Starting dynamic subtest: pipe-None-DP-3 [468.543894] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [468.566120] Starting dynamic subtest: pipe-None-DP-4 [468.571520] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [468.573866] Subtest connector-properties-atomic: SUCCESS (8.125s) [469.332748] [077/156] (556s left) kms_psr2_su (frontbuffer-xrgb8888) [469.392316] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [469.456557] [078/156] (556s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff) [469.564305] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff [469.568413] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [469.670547] [079/156] (555s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [469.776613] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [469.780776] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [469.891240] [080/156] (555s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render) [470.001782] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render [470.005852] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [470.137121] [081/156] (555s left) gem_create (create-invalid-size) [470.196974] Starting subtest: create-invalid-size [470.199319] Subtest create-invalid-size: SUCCESS (0.000s) [470.398138] [082/156] (555s left) kms_frontbuffer_tracking (fbc-tiling-y) [470.498274] Starting subtest: fbc-tiling-y [470.502762] Subtest fbc-tiling-y: SKIP (0.000s) [470.592280] [083/156] (555s left) kms_cursor_crc (cursor-alpha-opaque) [470.688373] Starting subtest: cursor-alpha-opaque [470.690581] Starting dynamic subtest: pipe-A-eDP-1 [471.299366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s) [471.313631] Starting dynamic subtest: pipe-D-eDP-1 [472.611127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s) [472.613354] Subtest cursor-alpha-opaque: SUCCESS (1.924s) [473.504438] [084/156] (552s left) gem_exec_reloc (basic-cpu-wc-active) [473.559413] Subtest basic-cpu-wc-active: SKIP (0.000s) [473.629003] [085/156] (552s left) gem_spin_batch (legacy-resubmit) [473.695645] Starting subtest: legacy-resubmit [473.697977] Starting dynamic subtest: default [473.703118] Dynamic subtest default: SUCCESS (0.005s) [473.714765] Starting dynamic subtest: render [473.716961] Dynamic subtest render: SUCCESS (0.001s) [473.727425] Starting dynamic subtest: bsd [473.729613] Dynamic subtest bsd: SUCCESS (0.002s) [473.739714] Starting dynamic subtest: bsd1 [473.741866] Dynamic subtest bsd1: SUCCESS (0.001s) [473.752194] Starting dynamic subtest: bsd2 [473.754451] Dynamic subtest bsd2: SUCCESS (0.002s) [473.764837] Starting dynamic subtest: blt [473.767099] Dynamic subtest blt: SUCCESS (0.002s) [473.777288] Starting dynamic subtest: vebox [473.779466] Dynamic subtest vebox: SUCCESS (0.002s) [473.781608] Subtest legacy-resubmit: SUCCESS (0.022s) [475.442923] [086/156] (550s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [475.536933] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [475.540881] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s) [475.610685] [087/156] (550s left) gem_exec_whisper (basic-contexts-forked-all) [475.675687] Starting subtest: basic-contexts-forked-all [498.407245] Subtest basic-contexts-forked-all: SUCCESS (22.728s) [498.594804] [088/156] (527s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [498.701082] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [503.708848] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.013s) [504.897616] [089/156] (521s left) kms_psr (pr-primary-mmap-gtt) [504.989666] Starting subtest: pr-primary-mmap-gtt [504.994139] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [505.065569] [090/156] (520s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy) [505.175209] Starting subtest: psrhdr-modesetfrombusy [505.179343] Subtest psrhdr-modesetfrombusy: SKIP (0.000s) [505.285250] [091/156] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [505.379742] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [505.383783] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [505.493298] [092/156] (520s left) gem_userptr_blits (stress-purge) [505.558954] Starting subtest: stress-purge [510.969714] Subtest stress-purge: SUCCESS (5.413s) [511.103190] [093/156] (515s left) kms_rotation_crc (sprite-rotation-270) [511.242236] Starting subtest: sprite-rotation-270 [511.245793] Subtest sprite-rotation-270: SKIP (0.001s) [511.344326] [094/156] (514s left) core_auth (basic-auth) [511.399370] Starting subtest: basic-auth [511.401716] Subtest basic-auth: SUCCESS (0.002s) [511.511634] [095/156] (514s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [511.631006] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [512.512547] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.882s) [512.678897] [096/156] (513s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [512.774835] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [512.779084] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [512.877968] [097/156] (513s left) gem_exec_schedule (u-semaphore-noskip) [512.965364] Starting subtest: u-semaphore-noskip [513.378964] Subtest u-semaphore-noskip: SUCCESS (0.416s) [513.723386] [098/156] (512s left) kms_pipe_crc_basic (bad-source) [513.829688] Starting subtest: bad-source [513.831845] Subtest bad-source: SUCCESS (0.000s) [513.907578] [099/156] (512s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [514.014387] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [514.018588] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [514.105686] [100/156] (512s left) gem_exec_flush (basic-batch-kernel-default-uc) [514.165538] Starting subtest: basic-batch-kernel-default-uc [521.458260] Subtest basic-batch-kernel-default-uc: SUCCESS (7.293s) [521.647234] [101/156] (504s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [521.768826] Starting subtest: pr-overlay-primary-update-sf-dmg-area [521.772883] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [521.839480] [102/156] (504s left) sw_sync (alloc_fence_invalid_timeline) [521.874273] Starting subtest: alloc_fence_invalid_timeline [521.876554] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [521.929576] [103/156] (504s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [522.024071] Starting subtest: fbc-rgb565-draw-pwrite [526.642442] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.627s) [527.778576] [104/156] (498s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [527.878233] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [527.882645] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [528.001063] [105/156] (498s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt) [528.101614] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt [528.105734] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [528.202131] [106/156] (498s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [528.273479] Starting subtest: y-tiled-to-vebox-x-tiled [528.277591] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [528.457396] [107/156] (498s left) kms_flip (basic-flip-vs-modeset) [528.568722] Starting subtest: basic-flip-vs-modeset [528.570595] Starting dynamic subtest: A-eDP1 [531.155859] Dynamic subtest A-eDP1: SUCCESS (2.588s) [531.168239] Starting dynamic subtest: B-eDP1 [533.349443] Dynamic subtest B-eDP1: SUCCESS (2.191s) [533.361928] Starting dynamic subtest: C-eDP1 [535.524123] Dynamic subtest C-eDP1: SUCCESS (2.172s) [535.538381] Starting dynamic subtest: D-eDP1 [537.712666] Dynamic subtest D-eDP1: SUCCESS (2.186s) [537.715008] Subtest basic-flip-vs-modeset: SUCCESS (9.147s) [538.524882] [108/156] (488s left) gem_exec_flush (basic-wb-rw-default) [538.590455] Starting subtest: basic-wb-rw-default [544.049642] Subtest basic-wb-rw-default: SUCCESS (5.460s) [544.242998] [109/156] (482s left) dmabuf_sync_file (export-basic) [544.288452] Starting subtest: export-basic [544.291008] Subtest export-basic: SUCCESS (0.001s) [544.346494] [110/156] (482s left) gem_partial_pwrite_pread (reads-display) [544.403636] Subtest reads-display: SKIP (0.000s) [544.483765] [111/156] (482s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [544.590706] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [549.148953] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.565s) [550.337318] [112/156] (476s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [550.446132] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [557.503674] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.062s) [557.641997] [113/156] (469s left) gem_exec_schedule (pi-distinct-iova) [557.836135] Starting subtest: pi-distinct-iova [557.838059] Starting dynamic subtest: rcs0 [557.907866] Dynamic subtest rcs0: SUCCESS (0.074s) [557.925868] Starting dynamic subtest: vcs0 [557.964955] Dynamic subtest vcs0: SUCCESS (0.057s) [557.983997] Starting dynamic subtest: vcs1 [558.022092] Dynamic subtest vcs1: SUCCESS (0.056s) [558.034840] Starting dynamic subtest: vecs0 [558.081267] Dynamic subtest vecs0: SUCCESS (0.058s) [558.092978] Starting dynamic subtest: ccs0 [558.161077] Dynamic subtest ccs0: SUCCESS (0.078s) [558.163557] Subtest pi-distinct-iova: SUCCESS (0.329s) [559.521331] [114/156] (467s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [559.621859] Starting subtest: psr-farfromfence-mmap-gtt [559.626283] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [559.719302] [115/156] (467s left) gem_close_race (basic-process) [559.792680] Starting subtest: basic-process [559.843742] Subtest basic-process: SUCCESS (0.051s) [560.044285] [116/156] (467s left) kms_flip (flip-vs-panning) [560.126394] Starting subtest: flip-vs-panning [560.128799] Starting dynamic subtest: A-eDP1 [568.859620] Dynamic subtest A-eDP1: SUCCESS (8.732s) [568.871335] Starting dynamic subtest: B-eDP1 [577.594459] Dynamic subtest B-eDP1: SUCCESS (8.732s) [577.609318] Starting dynamic subtest: C-eDP1 [586.320896] Dynamic subtest C-eDP1: SUCCESS (8.723s) [586.336096] Starting dynamic subtest: D-eDP1 [595.051538] Dynamic subtest D-eDP1: SUCCESS (8.727s) [595.053669] Subtest flip-vs-panning: SUCCESS (34.926s) [596.321404] [117/156] (430s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [596.447421] Starting subtest: basic-flip-after-cursor-legacy [597.390468] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.942s) [598.253581] [118/156] (428s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [598.352105] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [598.354446] Starting dynamic subtest: pipe-A-eDP-1 [598.374834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [598.388620] Starting dynamic subtest: pipe-B-eDP-1 [598.408225] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [598.419526] Starting dynamic subtest: pipe-C-eDP-1 [598.438663] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [598.449691] Starting dynamic subtest: pipe-D-eDP-1 [598.469397] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [598.471617] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [600.632801] [119/156] (426s left) kms_color (ctm-0-25) [600.725130] Starting subtest: ctm-0-25 [600.727607] Starting dynamic subtest: pipe-A-eDP-1 [604.239742] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.517s) [604.251931] Starting dynamic subtest: pipe-B-eDP-1 [608.547414] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.303s) [608.559360] Starting dynamic subtest: pipe-C-eDP-1 [612.597998] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.051s) [612.612023] Starting dynamic subtest: pipe-D-eDP-1 [616.598653] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s) [616.600942] Subtest ctm-0-25: SUCCESS (15.873s) [617.412327] [120/156] (409s left) gem_ctx_param (invalid-param-get) [617.464875] Starting subtest: invalid-param-get [617.467263] Subtest invalid-param-get: SUCCESS (0.001s) [617.559376] [121/156] (409s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary) [617.663466] Starting subtest: psrhdr-shrfb-scaledprimary [617.667337] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s) [617.772199] [122/156] (409s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [617.829630] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [617.832004] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [617.966475] [123/156] (409s left) kms_cursor_legacy (single-move) [618.088753] Starting subtest: single-move [618.091286] Starting dynamic subtest: pipe-A [623.471808] Dynamic subtest pipe-A: SUCCESS (5.379s) [623.484403] Starting dynamic subtest: pipe-B [628.854329] Dynamic subtest pipe-B: SUCCESS (5.379s) [628.866993] Starting dynamic subtest: pipe-C [634.237075] Dynamic subtest pipe-C: SUCCESS (5.379s) [634.251203] Starting dynamic subtest: pipe-D [639.619966] Dynamic subtest pipe-D: SUCCESS (5.380s) [639.636784] Starting dynamic subtest: all-pipes [645.008952] Dynamic subtest all-pipes: SUCCESS (5.386s) [645.011467] Subtest single-move: SUCCESS (26.917s) [645.156151] [124/156] (382s left) gem_mmap_gtt (fault-concurrent-x) [645.226733] Subtest fault-concurrent-X: SKIP (0.000s) [645.292022] [125/156] (382s left) core_getclient (basic) [645.348842] Starting subtest: basic [645.351097] Subtest basic: SUCCESS (0.000s) [645.473631] [126/156] (382s left) kms_psr (fbc-psr-cursor-mmap-cpu) [645.575316] Starting subtest: fbc-psr-cursor-mmap-cpu [645.577123] Starting dynamic subtest: eDP-1 [645.581118] Dynamic subtest eDP-1: SKIP (0.000s) [645.585018] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [645.665293] [127/156] (381s left) kms_pwrite_crc (basic) [645.757155] Starting subtest: basic [646.429108] Subtest basic: SUCCESS (0.671s) [647.251328] [128/156] (380s left) kms_draw_crc (draw-method-blt) [647.358245] Starting subtest: draw-method-blt [647.360151] Starting dynamic subtest: xrgb8888-untiled [647.589616] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s) [647.601265] Starting dynamic subtest: rgb565-untiled [647.812402] Dynamic subtest rgb565-untiled: SUCCESS (0.222s) [647.824630] Starting dynamic subtest: xrgb2101010-untiled [648.034239] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s) [648.046116] Starting dynamic subtest: xbgr16161616f-untiled [648.256295] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [648.267828] Starting dynamic subtest: xrgb8888-xtiled [648.378268] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [648.393225] Starting dynamic subtest: rgb565-xtiled [648.489522] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [648.500581] Starting dynamic subtest: xrgb2101010-xtiled [648.600441] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [648.611741] Starting dynamic subtest: xbgr16161616f-xtiled [648.711928] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.109s) [648.724592] Starting dynamic subtest: xrgb8888-4tiled [648.834104] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [648.847530] Starting dynamic subtest: rgb565-4tiled [648.956051] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s) [648.967551] Starting dynamic subtest: xrgb2101010-4tiled [649.067305] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s) [649.078868] Starting dynamic subtest: xbgr16161616f-4tiled [649.178740] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s) [649.180783] Subtest draw-method-blt: SUCCESS (1.824s) [649.308085] [129/156] (378s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [649.406940] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc [649.410546] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [649.503453] [130/156] (378s left) kms_cursor_crc (cursor-offscreen-32x10) [649.659147] Starting subtest: cursor-offscreen-32x10 [649.708521] Subtest cursor-offscreen-32x10: SKIP (0.045s) [650.005901] [131/156] (377s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt) [650.095062] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt [650.098617] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [650.193753] [132/156] (377s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [650.308099] Starting subtest: verify-pxp-stale-buf-optout-execution [651.370119] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.063s) [651.505695] [133/156] (376s left) gem_exec_params (mmapped) [651.560750] Starting subtest: mmapped [651.563308] Subtest mmapped: SUCCESS (0.003s) [651.693272] [134/156] (376s left) gem_mmap_wc (write-read) [651.742214] Subtest write-read: SKIP (0.000s) [651.804797] [135/156] (376s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [651.906922] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [652.974968] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.069s) [653.090616] [136/156] (374s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [653.193758] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [653.197043] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [653.287256] [137/156] (374s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt) [653.378296] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt [653.381733] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [653.480859] [138/156] (374s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite) [653.575943] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite [653.579638] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [653.697115] [139/156] (374s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc) [653.805917] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc [653.809333] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [653.901668] [140/156] (374s left) kms_cursor_crc (cursor-random-256x256) [654.145338] Starting subtest: cursor-random-256x256 [654.150237] Starting dynamic subtest: pipe-A-eDP-1 [657.482984] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.332s) [657.516563] Starting dynamic subtest: pipe-D-eDP-1 [661.562228] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.056s) [661.564559] Subtest cursor-random-256x256: SUCCESS (7.415s) [662.418725] [141/156] (365s left) gem_exec_fence (syncobj-timeline-invalid-flags) [662.988335] Starting subtest: syncobj-timeline-invalid-flags [662.990976] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [664.475771] [142/156] (363s left) gem_ctx_bad_destroy (invalid-ctx) [664.523045] Starting subtest: invalid-ctx [664.525400] Subtest invalid-ctx: SUCCESS (0.000s) [664.599309] [143/156] (363s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [664.697558] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [671.378862] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.685s) [671.530300] [144/156] (356s left) kms_chamelium_edid (dp-edid-change-during-suspend) [671.916481] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [672.756785] [145/156] (355s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc) [672.867120] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc [672.871576] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [672.961583] [146/156] (355s left) gem_exec_balancer (full-late-pulse) [673.032637] Starting subtest: full-late-pulse [677.307809] Subtest full-late-pulse: SUCCESS (4.275s) [677.655247] [147/156] (350s left) i915_drm_fdinfo (isolation) [677.696089] Starting subtest: isolation [677.697977] Starting dynamic subtest: rcs0 [677.721578] Dynamic subtest rcs0: SKIP (0.026s) [677.735818] Starting dynamic subtest: bcs0 [677.740688] Dynamic subtest bcs0: SKIP (0.000s) [677.754294] Starting dynamic subtest: vcs0 [677.758427] Dynamic subtest vcs0: SKIP (0.000s) [677.772720] Starting dynamic subtest: vcs1 [677.776940] Dynamic subtest vcs1: SKIP (0.000s) [677.788235] Starting dynamic subtest: vecs0 [677.792262] Dynamic subtest vecs0: SKIP (0.000s) [677.806019] Starting dynamic subtest: ccs0 [677.810275] Dynamic subtest ccs0: SKIP (0.000s) [677.814302] Subtest isolation: SKIP (0.031s) [677.853305] [148/156] (350s left) syncobj_wait (reset-during-wait-for-submit) [677.912667] Starting subtest: reset-during-wait-for-submit [678.015931] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [678.107180] [149/156] (350s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [678.214925] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [678.219121] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [678.317977] [150/156] (350s left) kms_psr (psr2-primary-blt) [678.410354] Starting subtest: psr2-primary-blt [678.412699] Starting dynamic subtest: eDP-1 [680.160015] Dynamic subtest eDP-1: SUCCESS (1.748s) [680.162349] Subtest psr2-primary-blt: SUCCESS (1.749s) [681.038807] [151/156] (347s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt) [681.137923] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt [681.141931] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [681.251280] [152/156] (347s left) syncobj_wait (wait-any-interrupted) [681.306770] Starting subtest: wait-any-interrupted [681.406821] Subtest wait-any-interrupted: SUCCESS (0.101s) [681.488248] [153/156] (347s left) kms_flip (2x-flip-vs-rmfb) [681.576107] Starting subtest: 2x-flip-vs-rmfb [681.585573] Subtest 2x-flip-vs-rmfb: SKIP (0.011s) [681.667905] [154/156] (347s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [681.770796] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [681.775235] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [681.855892] [155/156] (347s left) syncobj_wait (wait-all-for-submit-snapshot) [681.911846] Starting subtest: wait-all-for-submit-snapshot [681.992857] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [682.072436] [156/156] (346s left) gem_userptr_blits (input-checking) [682.130888] Starting subtest: input-checking [682.132536] Subtest input-checking: SUCCESS (0.000s) [682.264231] Closing watchdogs results: parsing output: 0/ for test: perf results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: prime_vgem results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: i915_pm_sseu results: parsing output: 5/ for test: kms_vblank results: parsing output: 6/ for test: kms_busy results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_ccs results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: kms_prime results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: syncobj_timeline results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: fbdev results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_sequence results: parsing output: 17/ for test: perf_pmu results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_flip_scaled_crc results: parsing output: 21/ for test: kms_color results: parsing output: 22/ for test: gen9_exec_parse results: parsing output: 23/ for test: syncobj_wait results: parsing output: 24/ for test: kms_plane_scaling results: parsing output: 25/ for test: gem_softpin results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_ctx_persistence results: parsing output: 29/ for test: kms_pm_rpm results: parsing output: 30/ for test: kms_cursor_legacy results: parsing output: 31/ for test: kms_async_flips results: parsing output: 32/ for test: i915_pm_rc6_residency results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_mmap_offset results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_atomic_transition results: parsing output: 38/ for test: kms_chamelium_audio results: parsing output: 39/ for test: kms_ccs results: parsing output: 40/ for test: i915_hangman results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: kms_psr2_sf results: parsing output: 44/ for test: kms_plane_scaling results: parsing output: 45/ for test: gem_exec_reloc results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_invalid_mode results: parsing output: 48/ for test: gem_mmap results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_plane results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: gem_readwrite results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: gem_ctx_persistence results: parsing output: 56/ for test: gem_mmap_wc results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_lease results: parsing output: 59/ for test: kms_plane_multiple results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_ctx_engines results: parsing output: 62/ for test: gem_exec_whisper results: parsing output: 63/ for test: gem_exec_balancer results: parsing output: 64/ for test: kms_plane_alpha_blend results: parsing output: 65/ for test: perf_pmu results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_cursor_edge_walk results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: gem_eio results: parsing output: 70/ for test: gem_userptr_blits results: parsing output: 71/ for test: prime_vgem results: parsing output: 72/ for test: vgem_basic results: parsing output: 73/ for test: vgem_slow results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_properties results: parsing output: 76/ for test: kms_psr2_su results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_create results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_cursor_crc results: parsing output: 83/ for test: gem_exec_reloc results: parsing output: 84/ for test: gem_spin_batch results: parsing output: 85/ for test: kms_flip_scaled_crc results: parsing output: 86/ for test: gem_exec_whisper results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: kms_rotation_crc results: parsing output: 93/ for test: core_auth results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_exec_schedule results: parsing output: 97/ for test: kms_pipe_crc_basic results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_exec_flush results: parsing output: 100/ for test: kms_psr2_sf results: parsing output: 101/ for test: sw_sync results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_render_copy results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: gem_exec_flush results: parsing output: 108/ for test: dmabuf_sync_file results: parsing output: 109/ for test: gem_partial_pwrite_pread results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_exec_schedule results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_close_race results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: kms_color results: parsing output: 119/ for test: gem_ctx_param results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: syncobj_wait results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: gem_mmap_gtt results: parsing output: 124/ for test: core_getclient results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_pwrite_crc results: parsing output: 127/ for test: kms_draw_crc results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_cursor_crc results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: gem_pxp results: parsing output: 132/ for test: gem_exec_params results: parsing output: 133/ for test: gem_mmap_wc results: parsing output: 134/ for test: kms_big_fb results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_cursor_crc results: parsing output: 140/ for test: gem_exec_fence results: parsing output: 141/ for test: gem_ctx_bad_destroy results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_chamelium_edid results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: gem_exec_balancer results: parsing output: 146/ for test: i915_drm_fdinfo results: parsing output: 147/ for test: syncobj_wait results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_psr results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: syncobj_wait results: parsing output: 152/ for test: kms_flip results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: syncobj_wait results: parsing output: 155/ for test: gem_userptr_blits Done.