[55.811838] Initializing watchdogs [55.811892] /dev/watchdog0 [55.819399] [001/131] (960s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [55.932500] Starting subtest: yf-tiled-16bpp-rotate-90 [55.937178] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [56.002673] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [56.105123] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [56.109109] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [56.191643] [003/131] (960s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [56.289069] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [56.291435] Starting dynamic subtest: pipe-A-eDP-1 [56.447699] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s) [56.456123] Starting dynamic subtest: pipe-B-eDP-1 [56.478823] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.014s) [56.485073] Starting dynamic subtest: pipe-C-eDP-1 [56.504932] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [56.512411] Starting dynamic subtest: pipe-D-eDP-1 [56.531215] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [56.533066] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.186s) [58.719721] [004/131] (957s left) kms_big_fb (y-tiled-16bpp-rotate-270) [58.833931] Starting subtest: y-tiled-16bpp-rotate-270 [58.838253] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [58.912465] [005/131] (957s left) gem_ctx_persistence (saturated-hostile-nopreempt) [58.981283] Starting subtest: saturated-hostile-nopreempt [58.983691] Starting dynamic subtest: rcs0 [59.055087] Dynamic subtest rcs0: SKIP (0.072s) [59.061600] Starting dynamic subtest: bcs0 [59.073621] Dynamic subtest bcs0: SKIP (0.019s) [59.079469] Starting dynamic subtest: vcs0 [59.086652] Dynamic subtest vcs0: SKIP (0.013s) [59.092233] Starting dynamic subtest: vcs1 [59.104598] Dynamic subtest vcs1: SKIP (0.018s) [59.110511] Starting dynamic subtest: vecs0 [59.122773] Dynamic subtest vecs0: SKIP (0.018s) [59.128739] Starting dynamic subtest: ccs0 [59.135676] Dynamic subtest ccs0: SKIP (0.012s) [59.140224] Subtest saturated-hostile-nopreempt: SKIP (0.153s) [59.188871] [006/131] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [59.306212] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [59.310780] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.393591] [007/131] (957s left) kms_invalid_mode (bad-hsync-start) [59.501349] Starting subtest: bad-hsync-start [59.503724] Starting dynamic subtest: pipe-A-eDP-1 [59.783974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s) [59.790276] Starting dynamic subtest: pipe-B-eDP-1 [59.792301] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [59.797826] Starting dynamic subtest: pipe-C-eDP-1 [59.799800] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [59.806264] Starting dynamic subtest: pipe-D-eDP-1 [59.808501] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [59.810794] Subtest bad-hsync-start: SUCCESS (0.285s) [60.634078] [008/131] (955s left) kms_addfb_basic (too-wide) [60.743837] Starting subtest: too-wide [60.746064] Subtest too-wide: SUCCESS (0.000s) [60.823756] [009/131] (955s left) gem_mmap_gtt (cpuset-big-copy) [60.884911] Subtest cpuset-big-copy: SKIP (0.000s) [60.929021] [010/131] (955s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [61.067227] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [72.264893] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.213s) [73.043300] [011/131] (943s left) kms_plane_lowres (tiling-none) [73.147976] Starting subtest: tiling-none [73.150289] Starting dynamic subtest: pipe-A-eDP-1 [73.154684] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [73.439547] Starting dynamic subtest: pipe-B-eDP-1 [73.444196] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [73.451351] Starting dynamic subtest: pipe-C-eDP-1 [73.456089] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [73.462726] Starting dynamic subtest: pipe-D-eDP-1 [73.466945] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [73.471234] Subtest tiling-none: SKIP (0.290s) [74.270314] [012/131] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [74.378289] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [74.382582] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [74.457866] [013/131] (942s left) gem_exec_whisper (basic-fds-priority-all) [74.526407] Starting subtest: basic-fds-priority-all [95.886805] Subtest basic-fds-priority-all: SUCCESS (21.357s) [96.047283] [014/131] (920s left) gem_exec_flush (basic-uc-set-default) [96.103942] Starting subtest: basic-uc-set-default [101.599148] Subtest basic-uc-set-default: SUCCESS (5.495s) [101.768731] [015/131] (914s left) syncobj_wait (multi-wait-submitted-signaled) [101.835629] Starting subtest: multi-wait-submitted-signaled [101.837855] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [101.928588] [016/131] (914s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [102.036019] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [104.438986] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.407s) [104.542536] [017/131] (912s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [104.637798] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [104.639929] Starting dynamic subtest: pipe-A [105.732674] Dynamic subtest pipe-A: SUCCESS (1.095s) [105.740928] Starting dynamic subtest: pipe-B [107.849077] Dynamic subtest pipe-B: SUCCESS (2.116s) [107.856543] Starting dynamic subtest: pipe-C [108.999923] Dynamic subtest pipe-C: SUCCESS (1.149s) [109.008642] Starting dynamic subtest: pipe-D [110.123483] Dynamic subtest pipe-D: SUCCESS (1.123s) [110.125757] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.485s) [111.293459] [018/131] (905s left) i915_pm_rpm (debugfs-read) [113.122226] Starting subtest: debugfs-read [114.284049] Subtest debugfs-read: SUCCESS (1.159s) [114.623874] [019/131] (901s left) gem_busy (extended) [114.822804] Starting subtest: extended [114.825533] Starting dynamic subtest: rcs0 [114.920188] Dynamic subtest rcs0: SUCCESS (0.098s) [114.930172] Starting dynamic subtest: bcs0 [114.961630] Dynamic subtest bcs0: SUCCESS (0.040s) [114.972238] Starting dynamic subtest: vcs0 [116.905604] Dynamic subtest vcs0: SUCCESS (1.941s) [116.916917] Starting dynamic subtest: vcs1 [118.953575] Dynamic subtest vcs1: SUCCESS (2.046s) [118.964290] Starting dynamic subtest: vecs0 [120.938218] Dynamic subtest vecs0: SUCCESS (1.983s) [120.948948] Starting dynamic subtest: ccs0 [120.985366] Dynamic subtest ccs0: SUCCESS (0.047s) [120.988052] Subtest extended: SUCCESS (6.164s) [121.217302] [020/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [121.322720] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [121.935414] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.614s) [122.087759] [021/131] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [122.203189] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [122.207302] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [122.304372] [022/131] (894s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [122.403842] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [122.406200] Starting dynamic subtest: pipe-A-default-mode [122.698296] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [122.703015] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.290s) [123.535448] [023/131] (893s left) gem_vm_create (create-ext) [123.595519] Starting subtest: create-ext [123.600743] Subtest create-ext: SUCCESS (0.005s) [123.699872] [024/131] (892s left) gem_mmap_gtt (big-copy) [123.750425] Subtest big-copy: SKIP (0.000s) [123.788985] [025/131] (892s left) gem_exec_flush (basic-uc-pro-default) [123.850228] Starting subtest: basic-uc-pro-default [129.339777] Subtest basic-uc-pro-default: SUCCESS (5.489s) [129.509356] [026/131] (887s left) kms_async_flips (async-flip-suspend-resume) [129.611369] Starting subtest: async-flip-suspend-resume [129.981835] Starting dynamic subtest: pipe-A-eDP-1 [148.231997] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.980s) [148.602327] Starting dynamic subtest: pipe-B-eDP-1 [151.344965] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s) [151.707593] Starting dynamic subtest: pipe-C-eDP-1 [154.441955] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.757s) [154.798231] Starting dynamic subtest: pipe-D-eDP-1 [157.554007] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s) [157.556567] Subtest async-flip-suspend-resume: SUCCESS (12.726s) [158.700546] [027/131] (873s left) gem_userptr_blits (create-destroy-unsync) [158.760507] Subtest create-destroy-unsync: SKIP (0.000s) [158.879973] [028/131] (873s left) perf_pmu (multi-client) [158.917299] Starting subtest: multi-client [158.919758] Starting dynamic subtest: rcs0 [159.978420] Dynamic subtest rcs0: SUCCESS (1.063s) [159.988030] Starting dynamic subtest: bcs0 [161.027249] Dynamic subtest bcs0: SUCCESS (1.049s) [161.041105] Starting dynamic subtest: vcs0 [162.076606] Dynamic subtest vcs0: SUCCESS (1.050s) [162.086536] Starting dynamic subtest: vcs1 [163.208631] Dynamic subtest vcs1: SUCCESS (1.131s) [163.219194] Starting dynamic subtest: vecs0 [165.219848] Dynamic subtest vecs0: SUCCESS (1.986s) [165.229992] Starting dynamic subtest: ccs0 [167.239820] Dynamic subtest ccs0: SUCCESS (2.049s) [167.242654] Subtest multi-client: SUCCESS (8.340s) [167.348564] [029/131] (864s left) kms_flip (2x-absolute-wf_vblank) [167.449871] Starting subtest: 2x-absolute-wf_vblank [167.461188] Subtest 2x-absolute-wf_vblank: SKIP (0.011s) [167.518050] [030/131] (864s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [167.619221] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [167.623268] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [167.707901] [031/131] (864s left) sysfs_preempt_timeout (idempotent) [167.778724] Starting subtest: idempotent [167.781019] Starting dynamic subtest: vecs0 [167.783230] Dynamic subtest vecs0: SUCCESS (0.000s) [167.792980] Starting dynamic subtest: ccs0 [167.795281] Dynamic subtest ccs0: SUCCESS (0.000s) [167.804782] Starting dynamic subtest: vcs0 [167.806865] Dynamic subtest vcs0: SUCCESS (0.000s) [167.814666] Starting dynamic subtest: bcs0 [167.816763] Dynamic subtest bcs0: SUCCESS (0.000s) [167.824640] Starting dynamic subtest: rcs0 [167.826827] Dynamic subtest rcs0: SUCCESS (0.000s) [167.834726] Starting dynamic subtest: vcs1 [167.836920] Dynamic subtest vcs1: SUCCESS (0.000s) [167.839100] Subtest idempotent: SUCCESS (0.006s) [167.878905] [032/131] (864s left) kms_atomic (plane-primary-legacy) [167.972772] Starting subtest: plane-primary-legacy [167.974935] Starting dynamic subtest: pipe-A-eDP-1 [168.429621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s) [168.431932] Subtest plane-primary-legacy: SUCCESS (0.457s) [169.208970] [033/131] (862s left) syncobj_timeline (invalid-wait-illegal-handle) [169.269279] Starting subtest: invalid-wait-illegal-handle [169.271656] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [169.342074] [034/131] (862s left) sysfs_timeslice_duration (timeout) [169.398820] Starting subtest: timeout [169.401165] Starting dynamic subtest: vecs0 [179.230907] Dynamic subtest vecs0: SUCCESS (9.836s) [179.239773] Starting dynamic subtest: ccs0 [180.427067] Dynamic subtest ccs0: SUCCESS (1.196s) [180.440812] Starting dynamic subtest: vcs0 [190.232832] Dynamic subtest vcs0: SUCCESS (9.802s) [190.242621] Starting dynamic subtest: bcs0 [190.864394] Dynamic subtest bcs0: SUCCESS (0.629s) [190.875496] Starting dynamic subtest: rcs0 [192.095741] Dynamic subtest rcs0: SUCCESS (1.232s) [192.104172] Starting dynamic subtest: vcs1 [201.243436] Dynamic subtest vcs1: SUCCESS (9.147s) [201.245879] Subtest timeout: SUCCESS (31.853s) [201.298817] [035/131] (830s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [201.410204] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [201.414588] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [201.484653] [036/131] (830s left) gem_workarounds (basic-read) [201.549312] Starting subtest: basic-read [201.562396] Subtest basic-read: SUCCESS (0.012s) [201.688474] [037/131] (830s left) gem_softpin (noreloc) [201.751923] Starting subtest: noreloc [207.138520] Subtest noreloc: SUCCESS (5.386s) [207.257234] [038/131] (824s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [207.371319] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [207.375745] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [207.451568] [039/131] (824s left) kms_color (legacy-gamma-reset) [207.539771] Starting subtest: legacy-gamma-reset [207.542037] Starting dynamic subtest: pipe-A-eDP-1 [207.924354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s) [207.933301] Starting dynamic subtest: pipe-B-eDP-1 [207.935448] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s) [207.943742] Starting dynamic subtest: pipe-C-eDP-1 [207.948466] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [207.956581] Starting dynamic subtest: pipe-D-eDP-1 [207.958762] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [207.960992] Subtest legacy-gamma-reset: SUCCESS (0.418s) [208.718603] [040/131] (823s left) gem_userptr_blits (dmabuf-sync) [208.789901] Starting subtest: dmabuf-sync [208.795193] Subtest dmabuf-sync: SKIP (0.002s) [208.896469] [041/131] (823s left) api_intel_bb (render) [208.957763] Starting subtest: render [208.959774] Starting dynamic subtest: render-none-512 [209.055736] Dynamic subtest render-none-512: SUCCESS (0.100s) [209.066497] Starting dynamic subtest: render-none-1024 [209.433421] Dynamic subtest render-none-1024: SUCCESS (0.376s) [209.445054] Starting dynamic subtest: render-x-512 [209.517903] Dynamic subtest render-x-512: SUCCESS (0.085s) [209.528896] Starting dynamic subtest: render-x-1024 [209.862452] Dynamic subtest render-x-1024: SUCCESS (0.343s) [209.873029] Starting dynamic subtest: render-y-512 [209.951876] Dynamic subtest render-y-512: SUCCESS (0.090s) [209.962774] Starting dynamic subtest: render-y-1024 [210.295528] Dynamic subtest render-y-1024: SUCCESS (0.334s) [210.298007] Subtest render: SUCCESS (1.333s) [210.400415] [042/131] (821s left) drm_fdinfo (context-close-stress) [210.442479] Starting subtest: context-close-stress [221.191562] Subtest context-close-stress: SUCCESS (10.750s) [221.257904] [043/131] (810s left) kms_addfb_basic (unused-modifier) [221.496718] Starting subtest: unused-modifier [221.499147] Subtest unused-modifier: SUCCESS (0.000s) [221.617756] [044/131] (810s left) kms_properties (plane-properties-legacy) [221.720765] Starting subtest: plane-properties-legacy [221.723171] Starting dynamic subtest: pipe-A-eDP-1 [222.290377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s) [222.299844] Starting dynamic subtest: pipe-B-eDP-1 [223.607127] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.315s) [223.617195] Starting dynamic subtest: pipe-C-eDP-1 [224.824678] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s) [224.833525] Starting dynamic subtest: pipe-D-eDP-1 [226.057214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s) [226.059395] Subtest plane-properties-legacy: SUCCESS (4.336s) [226.832074] [045/131] (805s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [226.887132] Starting subtest: single-wait-all-for-submit-available-submitted [226.889491] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [226.979668] [046/131] (805s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [227.083710] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [227.087546] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [227.160733] [047/131] (805s left) kms_flip (plain-flip-fb-recreate-interruptible) [227.266250] Starting subtest: plain-flip-fb-recreate-interruptible [227.268727] Starting dynamic subtest: A-eDP1 [236.139847] Dynamic subtest A-eDP1: SUCCESS (8.875s) [236.148079] Starting dynamic subtest: B-eDP1 [244.963569] Dynamic subtest B-eDP1: SUCCESS (8.825s) [244.973936] Starting dynamic subtest: C-eDP1 [253.764481] Dynamic subtest C-eDP1: SUCCESS (8.795s) [253.774193] Starting dynamic subtest: D-eDP1 [262.589370] Dynamic subtest D-eDP1: SUCCESS (8.821s) [262.591487] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.323s) [263.744271] [048/131] (768s left) kms_psr (psr2-sprite-mmap-gtt) [263.845535] Starting subtest: psr2-sprite-mmap-gtt [263.847928] Starting dynamic subtest: eDP-1 [265.263943] Dynamic subtest eDP-1: SKIP (1.413s) [265.268758] Subtest psr2-sprite-mmap-gtt: SKIP (1.414s) [265.388040] [049/131] (766s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [265.503000] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [265.507172] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [265.603522] [050/131] (766s left) kms_psr (pr-suspend) [265.702794] Starting subtest: pr-suspend [265.707293] Subtest pr-suspend: SKIP (0.000s) [265.757164] [051/131] (766s left) gem_tiled_blits (basic) [265.823247] Subtest basic: SKIP (0.000s) [265.884375] [052/131] (766s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [265.983499] Starting subtest: primary-yf-tiled-reflect-x-0 [266.046853] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.061s) [266.130558] [053/131] (766s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [271.028954] Starting subtest: pr-plane-move-sf-dmg-area [271.033355] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s) [271.864491] [054/131] (760s left) kms_getfb (getfb-handle-valid) [271.929153] Starting subtest: getfb-handle-valid [271.931554] Subtest getfb-handle-valid: SUCCESS (0.000s) [272.030439] [055/131] (760s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [272.103960] Starting subtest: yf-tiled-ccs-to-yf-tiled [272.108677] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [272.269082] [056/131] (760s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [272.380094] Starting subtest: basic-max-pipe-crc-check [272.384459] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [272.406746] [057/131] (760s left) gem_exec_schedule (pi-userfault) [272.592563] Starting subtest: pi-userfault [272.594716] Starting dynamic subtest: rcs0 [272.599866] Dynamic subtest rcs0: SUCCESS (0.009s) [272.608786] Starting dynamic subtest: bcs0 [272.611157] Dynamic subtest bcs0: SUCCESS (0.007s) [272.619552] Starting dynamic subtest: vcs0 [272.621449] Dynamic subtest vcs0: SUCCESS (0.006s) [272.630008] Starting dynamic subtest: vcs1 [272.632350] Dynamic subtest vcs1: SUCCESS (0.008s) [272.640768] Starting dynamic subtest: vecs0 [272.642944] Dynamic subtest vecs0: SUCCESS (0.008s) [272.651405] Starting dynamic subtest: ccs0 [272.653334] Dynamic subtest ccs0: SUCCESS (0.008s) [272.655235] Subtest pi-userfault: SUCCESS (0.050s) [272.803989] [058/131] (759s left) kms_cursor_crc (cursor-onscreen-64x64) [272.964628] Starting subtest: cursor-onscreen-64x64 [272.969768] Starting dynamic subtest: pipe-A-eDP-1 [275.052886] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.083s) [275.076649] Starting dynamic subtest: pipe-D-eDP-1 [277.845334] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s) [277.847805] Subtest cursor-onscreen-64x64: SUCCESS (4.879s) [278.619074] [059/131] (753s left) kms_plane_scaling (intel-max-src-size) [278.716478] Starting subtest: intel-max-src-size [278.720944] Subtest intel-max-src-size: SKIP (0.000s) [278.814404] [060/131] (753s left) kms_prop_blob (blob-multiple) [278.872222] Starting subtest: blob-multiple [278.874568] Subtest blob-multiple: SUCCESS (0.002s) [278.959350] [061/131] (753s left) kms_getfb (getfb-handle-closed) [279.010642] Starting subtest: getfb-handle-closed [279.012897] Subtest getfb-handle-closed: SUCCESS (0.000s) [279.102492] [062/131] (753s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [279.204169] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [279.208636] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [279.287945] [063/131] (753s left) kms_flip (2x-flip-vs-panning) [279.395777] Starting subtest: 2x-flip-vs-panning [279.407667] Subtest 2x-flip-vs-panning: SKIP (0.011s) [279.470850] [064/131] (753s left) i915_query (query-regions-unallocated) [279.530060] Starting subtest: query-regions-unallocated [279.532265] Subtest query-regions-unallocated: SUCCESS (0.000s) [279.602230] [065/131] (753s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [279.693519] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [279.695456] Starting dynamic subtest: pipe-A-eDP-1 [279.715042] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [279.725970] Starting dynamic subtest: pipe-B-eDP-1 [279.743685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [279.751541] Starting dynamic subtest: pipe-C-eDP-1 [279.769535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [279.777819] Starting dynamic subtest: pipe-D-eDP-1 [279.797415] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [279.801227] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [281.866751] [066/131] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [281.980462] Starting subtest: fbcpsr-1p-rte [286.864263] Subtest fbcpsr-1p-rte: SUCCESS (4.889s) [287.002571] [067/131] (745s left) kms_feature_discovery (display-1x) [287.106722] Starting subtest: display-1x [287.109053] Subtest display-1x: SUCCESS (0.000s) [287.159752] [068/131] (745s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [287.266648] Starting subtest: psr-rgb565-draw-blt [292.101906] Subtest psr-rgb565-draw-blt: SUCCESS (4.838s) [292.238922] [069/131] (740s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [292.359604] Starting subtest: cursorA-vs-flipB-atomic [292.364133] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [292.486174] [070/131] (740s left) i915_query (query-garbage) [292.544282] Starting subtest: query-garbage [292.546768] Subtest query-garbage: SUCCESS (0.000s) [292.625672] [071/131] (740s left) gem_create (create-ext-cpu-access-big) [292.797443] Starting subtest: create-ext-cpu-access-big [292.803450] Subtest create-ext-cpu-access-big: SKIP (0.001s) [292.854822] [072/131] (739s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [292.953079] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [292.955422] Starting dynamic subtest: pipe-A-default-mode [293.242842] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [293.247493] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.285s) [294.074436] [073/131] (738s left) i915_hangman (hangcheck-unterminated) [294.146133] Starting subtest: hangcheck-unterminated [306.159148] Subtest hangcheck-unterminated: SUCCESS (12.014s) [306.287745] [074/131] (726s left) kms_psr (fbc-psr2-cursor-blt) [306.390947] Starting subtest: fbc-psr2-cursor-blt [306.393220] Starting dynamic subtest: eDP-1 [306.397658] Dynamic subtest eDP-1: SKIP (0.000s) [306.402112] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [306.445082] [075/131] (726s left) gem_ctx_shared (q-out-order) [306.517036] Starting subtest: Q-out-order [306.519242] Starting dynamic subtest: rcs0 [306.682412] Dynamic subtest rcs0: SUCCESS (0.164s) [306.701962] Starting dynamic subtest: vcs0 [306.768174] Dynamic subtest vcs0: SUCCESS (0.085s) [306.785420] Starting dynamic subtest: vcs1 [306.843639] Dynamic subtest vcs1: SUCCESS (0.074s) [306.860434] Starting dynamic subtest: vecs0 [306.918958] Dynamic subtest vecs0: SUCCESS (0.075s) [306.935581] Starting dynamic subtest: ccs0 [306.997096] Dynamic subtest ccs0: SUCCESS (0.078s) [306.999741] Subtest Q-out-order: SUCCESS (0.480s) [308.277078] [076/131] (724s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [308.373762] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [308.377653] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [308.467340] [077/131] (724s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [308.574781] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [308.577260] Starting dynamic subtest: pipe-A-eDP-1 [308.600177] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [308.610825] Starting dynamic subtest: pipe-B-eDP-1 [308.633283] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [308.642047] Starting dynamic subtest: pipe-C-eDP-1 [308.663728] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [308.674292] Starting dynamic subtest: pipe-D-eDP-1 [308.696100] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [308.700379] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s) [310.728296] [078/131] (722s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [310.843354] Starting subtest: extended-modeset-hang-oldfb-with-reset [310.845562] Starting dynamic subtest: pipe-A [322.412714] Dynamic subtest pipe-A: SUCCESS (11.571s) [322.422214] Starting dynamic subtest: pipe-D [334.659643] Dynamic subtest pipe-D: SUCCESS (12.247s) [334.662178] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.822s) [335.427729] [079/131] (697s left) gem_mmap_offset (clear-via-pagefault) [335.490460] Starting subtest: clear-via-pagefault [335.492503] Starting dynamic subtest: smem0 [367.042288] Dynamic subtest smem0: SUCCESS (31.557s) [367.044653] Subtest clear-via-pagefault: SUCCESS (31.558s) [367.135100] [080/131] (665s left) gem_exec_balancer (nohangcheck) [367.383842] Starting subtest: nohangcheck [368.164391] Subtest nohangcheck: SUCCESS (0.780s) [368.263159] [081/131] (664s left) kms_frontbuffer_tracking (fbcpsr-suspend) [368.359811] Starting subtest: fbcpsr-suspend [406.452081] Subtest fbcpsr-suspend: SUCCESS (7.605s) [406.589330] [082/131] (656s left) kms_dsc (dsc-with-formats) [406.691863] Starting subtest: dsc-with-formats [406.730847] Subtest dsc-with-formats: SKIP (0.001s) [406.748262] [083/131] (656s left) gem_exec_capture (capture-recoverable) [406.817721] Starting subtest: capture-recoverable [406.822584] Subtest capture-recoverable: SUCCESS (0.003s) [406.942395] [084/131] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [407.048126] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [407.052304] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [407.143941] [085/131] (656s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [407.256261] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [407.843019] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.592s) [407.960149] [086/131] (655s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [408.078464] Starting subtest: basic-busy-flip-before-cursor-legacy [408.082805] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [408.205771] [087/131] (655s left) api_intel_allocator (standalone) [408.253605] Starting subtest: standalone [408.272803] Subtest standalone: SUCCESS (0.021s) [408.372122] [088/131] (655s left) kms_addfb_basic (unused-offsets) [408.425452] Starting subtest: unused-offsets [408.427491] Subtest unused-offsets: SUCCESS (0.000s) [408.532277] [089/131] (655s left) kms_pm_rpm (modeset-lpsp-stress) [410.048889] Starting subtest: modeset-lpsp-stress [425.654631] Subtest modeset-lpsp-stress: SUCCESS (15.641s) [425.755964] [090/131] (637s left) sriov_basic (enable-vfs-bind-unbind-each) [425.808109] Starting subtest: enable-vfs-bind-unbind-each [425.810471] Starting dynamic subtest: numvfs-1 [425.887344] Dynamic subtest numvfs-1: FAIL (0.028s) [425.897857] Starting dynamic subtest: numvfs-2 [425.968275] Dynamic subtest numvfs-2: FAIL (0.004s) [425.979183] Starting dynamic subtest: numvfs-3 [426.053114] Dynamic subtest numvfs-3: FAIL (0.003s) [426.063240] Starting dynamic subtest: numvfs-4 [426.136657] Dynamic subtest numvfs-4: FAIL (0.003s) [426.146998] Starting dynamic subtest: numvfs-5 [426.219990] Dynamic subtest numvfs-5: FAIL (0.003s) [426.230894] Starting dynamic subtest: numvfs-6 [426.303925] Dynamic subtest numvfs-6: FAIL (0.003s) [426.314105] Starting dynamic subtest: numvfs-7 [426.387101] Dynamic subtest numvfs-7: FAIL (0.004s) [426.397028] Starting dynamic subtest: numvfs-random [426.469600] Dynamic subtest numvfs-random: FAIL (0.003s) [426.471617] Subtest enable-vfs-bind-unbind-each: FAIL (0.057s) [426.489990] [091/131] (637s left) gem_lmem_evict (dontneed-evict-race) [426.534705] Subtest dontneed-evict-race: SKIP (0.000s) [426.559532] [092/131] (637s left) kms_cursor_crc (cursor-random-64x64) [426.723555] Starting subtest: cursor-random-64x64 [426.727607] Starting dynamic subtest: pipe-A-eDP-1 [430.041661] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.317s) [430.067260] Starting dynamic subtest: pipe-D-eDP-1 [433.972797] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.913s) [433.975221] Subtest cursor-random-64x64: SUCCESS (7.250s) [434.829819] [093/131] (628s left) kms_cursor_legacy (torture-bo) [434.953826] Starting subtest: torture-bo [434.955728] Starting dynamic subtest: pipe-A [440.650353] Dynamic subtest pipe-A: SUCCESS (5.691s) [440.663054] Starting dynamic subtest: pipe-B [446.669913] Dynamic subtest pipe-B: SUCCESS (6.016s) [446.681590] Starting dynamic subtest: pipe-C [452.982380] Dynamic subtest pipe-C: SUCCESS (6.309s) [452.993824] Starting dynamic subtest: pipe-D [458.772752] Dynamic subtest pipe-D: SUCCESS (5.789s) [458.784903] Starting dynamic subtest: all-pipes [464.688093] Dynamic subtest all-pipes: SUCCESS (5.910s) [464.690369] Subtest torture-bo: SUCCESS (29.724s) [464.815935] [094/131] (598s left) kms_rotation_crc (primary-rotation-180) [464.909100] Starting subtest: primary-rotation-180 [471.853884] Subtest primary-rotation-180: SUCCESS (6.945s) [472.976077] [095/131] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [473.090742] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [477.778484] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.693s) [477.908075] [096/131] (585s left) kms_universal_plane (universal-plane-sanity) [478.001171] Starting subtest: universal-plane-sanity [478.003533] Starting dynamic subtest: pipe-A-eDP-1 [478.587917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s) [478.598388] Starting dynamic subtest: pipe-B-eDP-1 [479.757394] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s) [479.767692] Starting dynamic subtest: pipe-C-eDP-1 [480.975221] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s) [480.984419] Starting dynamic subtest: pipe-D-eDP-1 [482.196922] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s) [482.199472] Subtest universal-plane-sanity: SUCCESS (4.196s) [483.036830] [097/131] (580s left) gem_workarounds (reset-fd) [483.103123] Starting subtest: reset-fd [483.283917] Subtest reset-fd: SUCCESS (0.180s) [483.416603] [098/131] (580s left) gem_exec_reloc (basic-cpu) [483.485677] Subtest basic-cpu: SKIP (0.000s) [483.562504] [099/131] (580s left) syncobj_wait (wait-delayed-signal) [483.623644] Starting subtest: wait-delayed-signal [483.723695] Subtest wait-delayed-signal: SUCCESS (0.102s) [483.780925] [100/131] (580s left) gem_exec_schedule (u-submit-late-slice) [483.861117] Starting subtest: u-submit-late-slice [483.863081] Starting dynamic subtest: rcs0 [483.896122] Dynamic subtest rcs0: SUCCESS (0.041s) [483.906329] Starting dynamic subtest: bcs0 [483.926309] Dynamic subtest bcs0: SUCCESS (0.030s) [483.935517] Starting dynamic subtest: vcs0 [483.952342] Dynamic subtest vcs0: SUCCESS (0.026s) [483.961943] Starting dynamic subtest: vcs1 [483.983200] Dynamic subtest vcs1: SUCCESS (0.030s) [483.995785] Starting dynamic subtest: vecs0 [484.011778] Dynamic subtest vecs0: SUCCESS (0.028s) [484.021702] Starting dynamic subtest: ccs0 [484.045224] Dynamic subtest ccs0: SUCCESS (0.033s) [484.047630] Subtest u-submit-late-slice: SUCCESS (0.191s) [485.773174] [101/131] (578s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [485.888447] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [485.892569] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [485.989928] [102/131] (577s left) gem_softpin (allocator-fork) [486.048872] Starting subtest: allocator-fork [488.264567] Subtest allocator-fork: SUCCESS (2.215s) [488.385638] [103/131] (575s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [488.480105] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [488.482313] Starting dynamic subtest: pipe-A-eDP-1 [488.541106] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [488.552072] Starting dynamic subtest: pipe-B-eDP-1 [488.608599] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [488.618712] Starting dynamic subtest: pipe-C-eDP-1 [488.677512] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [488.687574] Starting dynamic subtest: pipe-D-eDP-1 [488.745284] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [488.749743] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s) [490.583678] [104/131] (573s left) kms_writeback (writeback-check-output-xrgb2101010) [490.693237] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s) [490.718170] [105/131] (573s left) gem_pxp (display-protected-crc) [491.883151] Starting subtest: display-protected-crc [493.468685] Subtest display-protected-crc: SUCCESS (1.586s) [493.588245] [106/131] (570s left) perf_pmu (busy) [493.629427] Starting subtest: busy [493.631824] Starting dynamic subtest: rcs0 [494.256174] Dynamic subtest rcs0: SUCCESS (0.630s) [494.268605] Starting dynamic subtest: bcs0 [494.825723] Dynamic subtest bcs0: SUCCESS (0.567s) [494.837711] Starting dynamic subtest: vcs0 [496.712377] Dynamic subtest vcs0: SUCCESS (1.885s) [496.724374] Starting dynamic subtest: vcs1 [497.323875] Dynamic subtest vcs1: FAIL (0.547s) [497.335918] Starting dynamic subtest: vecs0 [500.745001] Dynamic subtest vecs0: SUCCESS (3.483s) [500.755995] Starting dynamic subtest: ccs0 [501.317498] Dynamic subtest ccs0: SUCCESS (0.571s) [501.320174] Subtest busy: FAIL (7.694s) [501.418742] [107/131] (562s left) gem_pipe_control_store_loop (reused-buffer) [501.477280] Starting subtest: reused-buffer [503.634669] Subtest reused-buffer: SUCCESS (2.155s) [503.739970] [108/131] (560s left) gem_exec_schedule (in-order) [503.819714] Starting subtest: in-order [503.822125] Starting dynamic subtest: rcs0 [503.984809] Dynamic subtest rcs0: SUCCESS (0.169s) [503.994168] Starting dynamic subtest: vcs0 [504.095290] Dynamic subtest vcs0: SUCCESS (0.111s) [504.106857] Starting dynamic subtest: vcs1 [504.202105] Dynamic subtest vcs1: SUCCESS (0.106s) [504.214211] Starting dynamic subtest: vecs0 [504.309954] Dynamic subtest vecs0: SUCCESS (0.107s) [504.321913] Starting dynamic subtest: ccs0 [504.449107] Dynamic subtest ccs0: SUCCESS (0.138s) [504.452024] Subtest in-order: SUCCESS (0.634s) [505.821552] [109/131] (558s left) kms_vblank (wait-forked) [505.929844] Starting subtest: wait-forked [505.932123] Starting dynamic subtest: pipe-A-eDP-1 [507.771341] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.839s) [507.787420] Starting dynamic subtest: pipe-D-eDP-1 [510.323378] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s) [510.325332] Subtest wait-forked: SUCCESS (4.390s) [511.137049] [110/131] (552s left) kms_color (ctm-0-50) [511.234124] Starting subtest: ctm-0-50 [511.236409] Starting dynamic subtest: pipe-A-eDP-1 [514.613625] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.376s) [514.623824] Starting dynamic subtest: pipe-B-eDP-1 [518.601856] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.988s) [518.612296] Starting dynamic subtest: pipe-C-eDP-1 [522.423640] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.819s) [522.432757] Starting dynamic subtest: pipe-D-eDP-1 [526.288573] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.865s) [526.290918] Subtest ctm-0-50: SUCCESS (15.051s) [527.056501] [111/131] (536s left) gem_exec_reloc (basic-gtt-read-active) [527.124754] Subtest basic-gtt-read-active: SKIP (0.000s) [527.180499] [112/131] (536s left) kms_chamelium_hpd (dp-hpd) [527.566202] Subtest dp-hpd: SKIP (0.000s) [528.353099] [113/131] (535s left) prime_self_import (basic-with_fd_dup) [528.391781] Starting subtest: basic-with_fd_dup [528.418910] Subtest basic-with_fd_dup: SUCCESS (0.029s) [528.511355] [114/131] (535s left) kms_big_fb (linear-8bpp-rotate-270) [528.608670] Starting subtest: linear-8bpp-rotate-270 [528.628184] Subtest linear-8bpp-rotate-270: SKIP (0.019s) [528.746355] [115/131] (535s left) kms_psr (fbc-pr-cursor-plane-move) [528.848264] Starting subtest: fbc-pr-cursor-plane-move [528.852779] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [528.903855] [116/131] (535s left) sw_sync (sync_multi_producer_single_consumer) [528.943100] Starting subtest: sync_multi_producer_single_consumer [530.017765] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [530.058274] [117/131] (534s left) gem_ctx_isolation (preservation-reset) [530.229209] Starting subtest: preservation-reset [530.231726] Starting dynamic subtest: rcs0 [530.486477] Dynamic subtest rcs0: SUCCESS (0.257s) [530.498742] Starting dynamic subtest: bcs0 [530.814008] Dynamic subtest bcs0: SUCCESS (0.326s) [530.823895] Starting dynamic subtest: vcs0 [531.137703] Dynamic subtest vcs0: SUCCESS (0.323s) [531.148560] Starting dynamic subtest: vcs1 [533.038859] Dynamic subtest vcs1: SUCCESS (1.900s) [533.051151] Starting dynamic subtest: vecs0 [535.048081] Dynamic subtest vecs0: SUCCESS (2.008s) [535.060256] Starting dynamic subtest: ccs0 [537.019769] Dynamic subtest ccs0: SUCCESS (1.970s) [537.022193] Subtest preservation-reset: SUCCESS (6.792s) [537.153555] [118/131] (527s left) fbdev (pan) [537.192194] Starting subtest: pan [537.221973] Subtest pan: SUCCESS (0.032s) [537.276167] [119/131] (526s left) gem_mmap_gtt (coherency) [537.327295] Subtest coherency: SKIP (0.000s) [537.375946] [120/131] (526s left) gem_spin_batch (resubmit-new-all) [537.446745] Starting subtest: resubmit-new-all [537.449018] Starting dynamic subtest: rcs0 [537.467867] Dynamic subtest rcs0: SUCCESS (0.021s) [537.477392] Starting dynamic subtest: bcs0 [537.484664] Dynamic subtest bcs0: SUCCESS (0.016s) [537.493712] Starting dynamic subtest: vcs0 [537.498621] Dynamic subtest vcs0: SUCCESS (0.013s) [537.507805] Starting dynamic subtest: vcs1 [537.512621] Dynamic subtest vcs1: SUCCESS (0.011s) [537.521289] Starting dynamic subtest: vecs0 [537.525781] Dynamic subtest vecs0: SUCCESS (0.014s) [537.534689] Starting dynamic subtest: ccs0 [537.545865] Dynamic subtest ccs0: SUCCESS (0.020s) [537.548397] Subtest resubmit-new-all: SUCCESS (0.099s) [538.719212] [121/131] (525s left) gen9_exec_parse (unaligned-access) [538.774728] Subtest unaligned-access: SKIP (0.000s) [538.823763] [122/131] (525s left) kms_lease (implicit-plane-lease) [538.913178] Starting subtest: implicit-plane-lease [538.918203] Subtest implicit-plane-lease: SUCCESS (0.003s) [539.014018] [123/131] (525s left) kms_psr (psr-sprite-plane-move) [539.103901] Starting subtest: psr-sprite-plane-move [539.106315] Starting dynamic subtest: eDP-1 [540.829508] Dynamic subtest eDP-1: SUCCESS (1.724s) [540.831838] Subtest psr-sprite-plane-move: SUCCESS (1.725s) [541.628739] [124/131] (522s left) gem_exec_fence (syncobj-timeline-unused-fence) [542.188635] Starting subtest: syncobj-timeline-unused-fence [542.194034] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s) [543.821584] [125/131] (520s left) kms_chamelium_edid (hdmi-mode-timings) [544.205263] Subtest hdmi-mode-timings: SKIP (0.000s) [545.032407] [126/131] (519s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [545.131989] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [545.134281] Starting dynamic subtest: pipe-A [545.151218] Dynamic subtest pipe-A: SKIP (0.015s) [545.160881] Starting dynamic subtest: pipe-B [545.178242] Dynamic subtest pipe-B: SKIP (0.027s) [545.189179] Starting dynamic subtest: pipe-C [545.207644] Dynamic subtest pipe-C: SKIP (0.029s) [545.218378] Starting dynamic subtest: pipe-D [545.237172] Dynamic subtest pipe-D: SKIP (0.029s) [545.240989] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.102s) [545.314450] [127/131] (519s left) tools_test (sysfs_l3_parity) [545.365089] Starting subtest: sysfs_l3_parity [545.433898] Subtest sysfs_l3_parity: SKIP (0.078s) [545.467786] [128/131] (518s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [545.511512] Starting subtest: etime-single-wait-available-unsubmitted [545.611649] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s) [545.672993] [129/131] (518s left) kms_psr (fbc-psr2-sprite-render) [545.769749] Starting subtest: fbc-psr2-sprite-render [545.771961] Starting dynamic subtest: eDP-1 [545.776197] Dynamic subtest eDP-1: SKIP (0.000s) [545.780107] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [545.834198] [130/131] (518s left) syncobj_timeline (invalid-single-wait-unsubmitted) [545.904693] Starting subtest: invalid-single-wait-unsubmitted [545.906936] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [545.985478] [131/131] (518s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt) [546.077200] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt [550.807346] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.732s) [550.943357] Closing watchdogs Done.