[56.928659] Initializing watchdogs [56.928704] /dev/watchdog0 [56.941750] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.945980] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.948088] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.951315] [001/132] (960s left) kms_psr (fbc-psr2-dpms) [57.077970] Starting subtest: fbc-psr2-dpms [57.080343] Starting dynamic subtest: eDP-1 [57.084530] Dynamic subtest eDP-1: SKIP (0.000s) [57.088769] Subtest fbc-psr2-dpms: SKIP (0.000s) [57.172313] [002/132] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [57.278204] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [57.282377] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [57.409718] [003/132] (960s left) perf_pmu (idle-no-semaphores) [57.451875] Starting subtest: idle-no-semaphores [57.454113] Starting dynamic subtest: rcs0 [58.028506] Dynamic subtest rcs0: SUCCESS (0.574s) [58.039017] Starting dynamic subtest: bcs0 [58.559817] Dynamic subtest bcs0: SUCCESS (0.531s) [58.570060] Starting dynamic subtest: vcs0 [59.087215] Dynamic subtest vcs0: SUCCESS (0.527s) [59.097734] Starting dynamic subtest: vcs1 [59.613322] Dynamic subtest vcs1: SUCCESS (0.526s) [59.624307] Starting dynamic subtest: vecs0 [60.147078] Dynamic subtest vecs0: SUCCESS (0.533s) [60.157507] Starting dynamic subtest: ccs0 [60.674363] Dynamic subtest ccs0: SUCCESS (0.526s) [60.677308] Subtest idle-no-semaphores: SUCCESS (3.226s) [60.804390] [004/132] (956s left) gem_spin_batch (legacy) [60.873186] Starting subtest: legacy [60.875583] Starting dynamic subtest: default [64.110753] Dynamic subtest default: SUCCESS (3.235s) [64.118081] Starting dynamic subtest: render [67.340671] Dynamic subtest render: SUCCESS (3.230s) [67.350893] Starting dynamic subtest: bsd [70.573013] Dynamic subtest bsd: SUCCESS (3.231s) [70.580600] Starting dynamic subtest: bsd1 [73.809921] Dynamic subtest bsd1: SUCCESS (3.234s) [73.819435] Starting dynamic subtest: bsd2 [77.039612] Dynamic subtest bsd2: SUCCESS (3.230s) [77.049146] Starting dynamic subtest: blt [80.272283] Dynamic subtest blt: SUCCESS (3.231s) [80.281923] Starting dynamic subtest: vebox [83.508943] Dynamic subtest vebox: SUCCESS (3.235s) [83.511687] Subtest legacy: SUCCESS (22.639s) [84.050786] [005/132] (933s left) kms_addfb_basic (unused-handle) [84.116052] Starting subtest: unused-handle [84.118349] Subtest unused-handle: SUCCESS (0.000s) [84.274138] [006/132] (933s left) kms_properties (plane-properties-legacy) [84.364221] Starting subtest: plane-properties-legacy [84.366680] Starting dynamic subtest: pipe-A-eDP-1 [84.965489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s) [84.975062] Starting dynamic subtest: pipe-B-eDP-1 [86.289696] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.325s) [86.299790] Starting dynamic subtest: pipe-C-eDP-1 [87.523970] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.231s) [87.533277] Starting dynamic subtest: pipe-D-eDP-1 [88.757327] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [88.759330] Subtest plane-properties-legacy: SUCCESS (4.390s) [89.590544] [007/132] (928s left) i915_pm_freq_api (freq-reset-multiple) [89.669124] Starting subtest: freq-reset-multiple [89.671436] Starting dynamic subtest: gt0 [98.370901] Dynamic subtest gt0: SUCCESS (8.701s) [98.380826] Starting dynamic subtest: gt1 [105.912838] Dynamic subtest gt1: SUCCESS (7.540s) [105.915841] Subtest freq-reset-multiple: SUCCESS (16.242s) [106.012329] [008/132] (911s left) kms_cursor_crc (cursor-rapid-movement-64x64) [106.193968] Starting subtest: cursor-rapid-movement-64x64 [106.198770] Starting dynamic subtest: pipe-A-eDP-1 [106.740526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s) [106.769241] Starting dynamic subtest: pipe-D-eDP-1 [107.959240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s) [107.961302] Subtest cursor-rapid-movement-64x64: SUCCESS (1.763s) [108.838887] [009/132] (908s left) kms_atomic (plane-immutable-zpos) [108.937303] Starting subtest: plane-immutable-zpos [108.939749] Starting dynamic subtest: pipe-A-eDP-1 [109.550294] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s) [109.552656] Subtest plane-immutable-zpos: SUCCESS (0.613s) [110.371936] [010/132] (907s left) syncobj_timeline (single-wait-for-submit-signaled) [110.437041] Starting subtest: single-wait-for-submit-signaled [110.439452] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [110.580366] [011/132] (907s left) kms_cursor_edge_walk (64x64-top-edge) [110.674839] Starting subtest: 64x64-top-edge [110.677101] Starting dynamic subtest: pipe-A-eDP-1 [114.115353] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.441s) [114.124107] Starting dynamic subtest: pipe-D-eDP-1 [117.224109] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.108s) [117.226431] Subtest 64x64-top-edge: SUCCESS (6.551s) [118.059911] [012/132] (899s left) kms_big_fb (y-tiled-64bpp-rotate-270) [118.178250] Starting subtest: y-tiled-64bpp-rotate-270 [118.182150] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [118.302868] [013/132] (899s left) gem_ctx_isolation (preservation-s3) [118.367086] Starting subtest: preservation-S3 [118.369432] Starting dynamic subtest: rcs0 [134.956825] Dynamic subtest rcs0: SUCCESS (4.981s) [134.966671] Starting dynamic subtest: bcs0 [150.923297] Dynamic subtest bcs0: SUCCESS (1.325s) [150.934763] Starting dynamic subtest: vcs0 [166.925712] Dynamic subtest vcs0: SUCCESS (2.325s) [166.938279] Starting dynamic subtest: vcs1 [184.930951] Dynamic subtest vcs1: SUCCESS (5.018s) [184.940390] Starting dynamic subtest: vecs0 [202.920432] Dynamic subtest vecs0: SUCCESS (5.018s) [202.929689] Starting dynamic subtest: ccs0 [220.930354] Dynamic subtest ccs0: SUCCESS (3.248s) [220.932622] Subtest preservation-S3: SUCCESS (21.918s) [221.190594] [014/132] (796s left) kms_flip (plain-flip-ts-check-interruptible) [221.299656] Starting subtest: plain-flip-ts-check-interruptible [221.301917] Starting dynamic subtest: A-eDP1 [230.119826] Dynamic subtest A-eDP1: SUCCESS (8.851s) [230.128893] Starting dynamic subtest: B-eDP1 [238.921519] Dynamic subtest B-eDP1: SUCCESS (8.813s) [238.933542] Starting dynamic subtest: C-eDP1 [247.744669] Dynamic subtest C-eDP1: SUCCESS (8.829s) [247.753410] Starting dynamic subtest: D-eDP1 [256.575675] Dynamic subtest D-eDP1: SUCCESS (8.833s) [256.581148] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.335s) [257.778543] [015/132] (760s left) gem_partial_pwrite_pread (reads-display) [257.843323] Subtest reads-display: SKIP (0.000s) [257.906200] [016/132] (760s left) gen9_exec_parse (bb-oversize) [257.980206] Subtest bb-oversize: SKIP (0.000s) [258.065867] [017/132] (760s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [258.159824] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [258.162151] Starting dynamic subtest: pipe-A-default-mode [258.456132] Dynamic subtest pipe-A-default-mode: SKIP (0.292s) [258.461166] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.294s) [259.311158] [018/132] (758s left) gem_fenced_exec_thrash (no-spare-fences) [259.374495] Subtest no-spare-fences: SKIP (0.000s) [259.456720] [019/132] (758s left) vgem_basic (bad-fence) [259.546097] Starting subtest: bad-fence [259.548491] Subtest bad-fence: SUCCESS (0.000s) [259.640909] [FACT vgem_basic (bad-fence)] new: kernel.kmod_is_loaded.vgem: true [259.644261] [020/132] (758s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [259.745820] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [260.724215] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.978s) [260.893199] [021/132] (757s left) gem_ctx_persistence (idempotent) [260.958531] Starting subtest: idempotent [260.960910] Subtest idempotent: SUCCESS (0.000s) [261.088217] [022/132] (757s left) syncobj_basic (bad-create-flags) [261.145384] Starting subtest: bad-create-flags [261.147253] Subtest bad-create-flags: SUCCESS (0.000s) [261.318833] [023/132] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [261.417968] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [284.115008] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.709s) [284.283994] [024/132] (734s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [284.385658] Starting subtest: primary-yf-tiled-reflect-x-0 [284.444996] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s) [284.566870] [025/132] (733s left) fbdev (pan) [284.607699] Starting subtest: pan [284.631889] Subtest pan: SUCCESS (0.027s) [284.728106] [026/132] (733s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [284.838335] Starting subtest: addfb25-y-tiled-small-legacy [284.841910] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [284.966029] [027/132] (733s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [285.054812] Starting subtest: crc-primary-suspend-y-tiled-ccs [285.057140] Starting dynamic subtest: pipe-A-eDP-1 [285.065520] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [285.076640] Starting dynamic subtest: pipe-B-eDP-1 [285.084295] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [285.093419] Starting dynamic subtest: pipe-C-eDP-1 [285.100401] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [285.108774] Starting dynamic subtest: pipe-D-eDP-1 [285.115502] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [285.118894] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s) [287.293087] [028/132] (731s left) gem_mmap_gtt (basic-short) [287.364044] Subtest basic-short: SKIP (0.000s) [287.434717] [029/132] (731s left) kms_force_connector_basic (force-connector-state) [287.523446] Starting subtest: force-connector-state [288.131531] Subtest force-connector-state: SUCCESS (0.610s) [289.143477] [030/132] (729s left) syncobj_wait (invalid-reset-illegal-handle) [289.209025] Starting subtest: invalid-reset-illegal-handle [289.211265] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [289.341275] [031/132] (729s left) kms_addfb_basic (too-wide) [289.436757] Starting subtest: too-wide [289.438653] Subtest too-wide: SUCCESS (0.000s) [289.572897] [032/132] (729s left) kms_chamelium_color (degamma) [289.669118] Subtest degamma: SKIP (0.000s) [289.722819] [033/132] (729s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [289.811531] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [289.813829] Starting dynamic subtest: pipe-A-default-mode [290.933844] Dynamic subtest pipe-A-default-mode: SKIP (1.118s) [290.938232] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.120s) [291.116209] [034/132] (727s left) gem_ctx_create (basic-files) [291.181988] Starting subtest: basic-files [293.187323] Subtest basic-files: SUCCESS (2.006s) [294.711033] [035/132] (724s left) gem_exec_fence (syncobj-timeline-invalid-wait) [295.310688] Starting subtest: syncobj-timeline-invalid-wait [295.313147] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.007s) [296.691438] [036/132] (722s left) gem_mmap_offset (bad-object) [296.739520] Starting subtest: bad-object [296.741873] Subtest bad-object: SUCCESS (0.002s) [296.870124] [037/132] (722s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [296.973752] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [296.977976] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [297.095565] [038/132] (721s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [297.187133] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [297.191522] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [297.311529] [039/132] (721s left) kms_selftest (drm_format_helper) [297.352525] Starting subtest: drm_format_helper [297.361418] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [297.498704] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.136s) [297.509788] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [297.636740] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.139s) [297.647330] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [297.786026] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.145s) [297.795306] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [297.938263] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.154s) [297.947543] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [298.044558] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.104s) [298.053922] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [298.158750] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.112s) [298.168227] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [298.311565] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.154s) [298.320128] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [298.460162] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.145s) [298.468903] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [298.598646] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.137s) [298.607915] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [298.736782] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.138s) [298.745493] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [298.888579] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.150s) [298.898994] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [299.029659] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.141s) [299.038299] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [299.177719] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.147s) [299.186492] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [299.331971] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.155s) [299.340763] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [299.474899] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.140s) [299.483682] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [299.631553] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.155s) [299.641972] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [299.722029] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.090s) [299.724003] Subtest drm_format_helper: SUCCESS (2.369s) [299.909860] [040/132] (719s left) gem_exec_capture (capture-invisible) [299.962771] Starting subtest: capture-invisible [299.965059] Starting dynamic subtest: smem0 [299.969600] Dynamic subtest smem0: SKIP (0.000s) [299.973892] Subtest capture-invisible: SKIP (0.001s) [300.113007] [041/132] (718s left) kms_psr (pr-cursor-mmap-cpu) [300.209631] Starting subtest: pr-cursor-mmap-cpu [300.214079] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [300.304393] [042/132] (718s left) kms_cursor_crc (cursor-onscreen-64x64) [300.488177] Starting subtest: cursor-onscreen-64x64 [300.493130] Starting dynamic subtest: pipe-A-eDP-1 [302.581485] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.087s) [302.608383] Starting dynamic subtest: pipe-D-eDP-1 [305.376368] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s) [305.378753] Subtest cursor-onscreen-64x64: SUCCESS (4.888s) [306.226441] [043/132] (712s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [306.338276] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [307.438749] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.101s) [307.607195] [044/132] (711s left) prime_vgem (busy) [307.692024] Starting subtest: busy [307.693895] Starting dynamic subtest: rcs0 [307.777221] Dynamic subtest rcs0: SUCCESS (0.086s) [307.787507] Starting dynamic subtest: bcs0 [307.851213] Dynamic subtest bcs0: SUCCESS (0.074s) [307.860501] Starting dynamic subtest: vcs0 [307.898666] Dynamic subtest vcs0: SUCCESS (0.047s) [307.907467] Starting dynamic subtest: vcs1 [307.942355] Dynamic subtest vcs1: SUCCESS (0.043s) [307.950880] Starting dynamic subtest: vecs0 [307.991198] Dynamic subtest vecs0: SUCCESS (0.048s) [307.999637] Starting dynamic subtest: ccs0 [308.038648] Dynamic subtest ccs0: SUCCESS (0.046s) [308.040592] Subtest busy: SUCCESS (0.350s) [308.201874] [045/132] (711s left) i915_pm_rps (thresholds-idle) [308.266924] Starting subtest: thresholds-idle [308.270199] Subtest thresholds-idle: SKIP (0.001s) [308.397559] [046/132] (710s left) gem_mmap (basic) [308.446314] Subtest basic: SKIP (0.000s) [308.509841] [047/132] (710s left) gem_mmap_gtt (cpuset-big-copy) [308.562375] Subtest cpuset-big-copy: SKIP (0.000s) [308.628740] [048/132] (710s left) kms_big_fb (linear-16bpp-rotate-90) [308.723424] Starting subtest: linear-16bpp-rotate-90 [308.743497] Subtest linear-16bpp-rotate-90: SKIP (0.020s) [308.887853] [049/132] (710s left) i915_pm_rpm (gem-evict-pwrite) [310.768343] Starting subtest: gem-evict-pwrite [310.773108] Subtest gem-evict-pwrite: SKIP (0.000s) [311.236361] [050/132] (708s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [311.365583] Starting subtest: verify-pxp-key-change-after-suspend-resume [318.561096] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.199s) [318.705548] [051/132] (700s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [318.778968] Starting subtest: etime-multi-wait-for-submit-unsubmitted [318.886916] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [319.000667] [052/132] (700s left) syncobj_basic (bad-destroy) [319.055376] Starting subtest: bad-destroy [319.057566] Subtest bad-destroy: SUCCESS (0.000s) [319.186294] [053/132] (700s left) kms_plane (planar-pixel-format-settings) [319.275348] Starting subtest: planar-pixel-format-settings [319.317059] Subtest planar-pixel-format-settings: SUCCESS (0.043s) [319.444851] [054/132] (700s left) kms_psr (psr2-cursor-plane-move) [319.541624] Starting subtest: psr2-cursor-plane-move [319.543741] Starting dynamic subtest: eDP-1 [321.241816] Dynamic subtest eDP-1: SUCCESS (1.699s) [321.243971] Subtest psr2-cursor-plane-move: SUCCESS (1.700s) [322.109672] [055/132] (697s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [322.208370] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [322.212690] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [323.317516] [056/132] (696s left) kms_legacy_colorkey (basic) [323.421511] Starting subtest: basic [323.423615] Starting dynamic subtest: pipe-A [323.464520] Dynamic subtest pipe-A: SUCCESS (0.045s) [323.476722] Starting dynamic subtest: pipe-B [323.478847] Dynamic subtest pipe-B: SUCCESS (0.001s) [323.487673] Starting dynamic subtest: pipe-C [323.489526] Dynamic subtest pipe-C: SUCCESS (0.001s) [323.497936] Starting dynamic subtest: pipe-D [323.500119] Dynamic subtest pipe-D: SUCCESS (0.000s) [323.502185] Subtest basic: SUCCESS (0.053s) [323.570578] [057/132] (696s left) kms_atomic_interruptible (legacy-setmode) [323.664321] Starting subtest: legacy-setmode [323.666537] Starting dynamic subtest: pipe-A-eDP-1 [330.564415] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.899s) [330.566826] Subtest legacy-setmode: SUCCESS (6.901s) [331.424486] [058/132] (688s left) kms_flip (bo-too-big-interruptible) [331.516865] Starting subtest: bo-too-big-interruptible [331.519094] Starting dynamic subtest: A-eDP1 [332.811210] Dynamic subtest A-eDP1: SUCCESS (1.293s) [332.822816] Starting dynamic subtest: B-eDP1 [334.116828] Dynamic subtest B-eDP1: SUCCESS (1.305s) [334.127386] Starting dynamic subtest: C-eDP1 [335.417441] Dynamic subtest C-eDP1: SUCCESS (1.300s) [335.429083] Starting dynamic subtest: D-eDP1 [336.719259] Dynamic subtest D-eDP1: SUCCESS (1.301s) [336.722124] Subtest bo-too-big-interruptible: SUCCESS (5.206s) [337.933733] [059/132] (681s left) kms_plane_alpha_blend (constant-alpha-max) [338.038635] Starting subtest: constant-alpha-max [338.320743] Starting dynamic subtest: pipe-A-eDP-1 [339.285627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.964s) [339.295947] Starting dynamic subtest: pipe-D-eDP-1 [340.870654] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.582s) [340.872971] Subtest constant-alpha-max: SUCCESS (2.832s) [341.723370] [060/132] (678s left) perf (polling-parameterized) [341.873185] Starting subtest: polling-parameterized [361.894604] Subtest polling-parameterized: SUCCESS (20.022s) [361.942380] [061/132] (657s left) kms_pm_rpm (modeset-pc8-residency-stress) [363.774308] Starting subtest: modeset-pc8-residency-stress [363.779289] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [364.230154] [062/132] (655s left) gem_pwrite (basic-exhaustion) [364.295332] Subtest basic-exhaustion: SKIP (0.000s) [364.360017] [063/132] (655s left) kms_psr (fbc-pr-sprite-mmap-cpu) [364.458556] Starting subtest: fbc-pr-sprite-mmap-cpu [364.462805] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [364.579345] [064/132] (655s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [364.967982] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [365.773271] [065/132] (654s left) perf_pmu (all-busy-idle-check-all) [365.813914] Starting subtest: all-busy-idle-check-all [367.604830] Subtest all-busy-idle-check-all: SUCCESS (1.790s) [367.746472] [066/132] (652s left) drm_read (short-buffer-block) [367.897519] Starting subtest: short-buffer-block [367.899957] Subtest short-buffer-block: SUCCESS (0.000s) [368.071334] [067/132] (652s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [368.180730] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [368.184858] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [368.325640] [068/132] (651s left) gem_create (create-ext-cpu-access-big) [368.509084] Starting subtest: create-ext-cpu-access-big [368.513604] Subtest create-ext-cpu-access-big: SKIP (0.002s) [368.610361] [069/132] (651s left) gem_eio (suspend) [368.815933] Starting subtest: suspend [381.047797] Subtest suspend: SUCCESS (12.233s) [381.214024] [070/132] (639s left) gem_exec_reloc (basic-active) [381.294952] Subtest basic-active: SKIP (0.000s) [381.395137] [071/132] (638s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [381.449172] Starting subtest: invalid-single-wait-all-unsubmitted [381.451315] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [381.573723] [072/132] (638s left) dumb_buffer (invalid-bpp) [381.634923] Starting subtest: invalid-bpp [381.637203] Subtest invalid-bpp: SUCCESS (0.000s) [381.744203] [073/132] (638s left) prime_vgem (fence-write-hang) [381.831751] Subtest fence-write-hang: SKIP (0.000s) [381.943779] [074/132] (638s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [382.039448] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [389.325656] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.288s) [389.497226] [075/132] (631s left) kms_color (gamma) [389.598886] Starting subtest: gamma [389.601218] Starting dynamic subtest: pipe-A-eDP-1 [390.305018] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [390.315209] Starting dynamic subtest: pipe-B-eDP-1 [391.786011] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s) [391.796365] Starting dynamic subtest: pipe-C-eDP-1 [393.102302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s) [393.112145] Starting dynamic subtest: pipe-D-eDP-1 [394.510297] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.408s) [394.512699] Subtest gamma: SUCCESS (4.916s) [395.408662] [076/132] (625s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [395.491391] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [395.493564] Starting dynamic subtest: pipe-A-eDP-1 [395.515532] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [395.526014] Starting dynamic subtest: pipe-B-eDP-1 [395.547116] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [395.556271] Starting dynamic subtest: pipe-C-eDP-1 [395.576825] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [395.585715] Starting dynamic subtest: pipe-D-eDP-1 [395.607484] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [395.611554] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [397.701136] [077/132] (622s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [397.795720] Starting subtest: crc-primary-basic-yf-tiled-ccs [397.797988] Starting dynamic subtest: pipe-A-eDP-1 [397.820881] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [397.836078] Starting dynamic subtest: pipe-B-eDP-1 [397.858532] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [397.869954] Starting dynamic subtest: pipe-C-eDP-1 [397.892006] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [397.902667] Starting dynamic subtest: pipe-D-eDP-1 [397.924968] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [397.929278] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s) [400.002669] [078/132] (620s left) gem_exec_whisper (basic-sync-all) [400.062672] Starting subtest: basic-sync-all [407.441706] Subtest basic-sync-all: SUCCESS (7.378s) [407.655462] [079/132] (613s left) kms_invalid_mode (bad-hsync-start) [407.754795] Starting subtest: bad-hsync-start [407.757159] Starting dynamic subtest: pipe-A-eDP-1 [408.040994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [408.055143] Starting dynamic subtest: pipe-B-eDP-1 [408.057091] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [408.066158] Starting dynamic subtest: pipe-C-eDP-1 [408.068409] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [408.077205] Starting dynamic subtest: pipe-D-eDP-1 [408.079434] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [408.081642] Subtest bad-hsync-start: SUCCESS (0.294s) [408.898900] [080/132] (611s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [409.007719] Starting subtest: yf-tiled-8bpp-rotate-90 [409.011537] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [409.128415] [081/132] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [409.229117] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [409.233538] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [409.365343] [082/132] (611s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [409.418209] Starting subtest: single-wait-all-for-submit-unsubmitted [409.527404] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [409.627468] [083/132] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [409.731262] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [409.735760] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [409.865218] [084/132] (611s left) prime_mmap (test_forked) [409.929051] Starting subtest: test_forked [409.931250] Starting dynamic subtest: test_forked-smem [409.962946] Dynamic subtest test_forked-smem: SUCCESS (0.035s) [409.965595] Subtest test_forked: SUCCESS (0.037s) [410.099465] [085/132] (610s left) gem_exec_balancer (parallel) [410.355813] Starting subtest: parallel [411.272398] Subtest parallel: SUCCESS (0.916s) [411.704169] [086/132] (609s left) gem_exec_flush (basic-batch-kernel-default-uc) [411.765972] Starting subtest: basic-batch-kernel-default-uc [417.957940] Subtest basic-batch-kernel-default-uc: SUCCESS (6.194s) [418.173024] [087/132] (602s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [418.274136] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [424.901921] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.631s) [425.061947] [088/132] (596s left) kms_chamelium_frames (dp-crc-multiple) [425.446106] Subtest dp-crc-multiple: SKIP (0.000s) [426.246839] [089/132] (594s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [431.256497] Starting subtest: psr2-primary-plane-update-sf-dmg-area [431.258745] Starting dynamic subtest: pipe-A-eDP-1 [437.719797] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.462s) [437.736511] Starting dynamic subtest: pipe-B-eDP-1 [444.217687] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.497s) [444.220068] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.964s) [445.096617] [090/132] (576s left) kms_atomic_transition (plane-all-transition-nonblocking) [445.199757] Starting subtest: plane-all-transition-nonblocking [445.202026] Starting dynamic subtest: pipe-A-eDP-1 [447.696787] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [448.000100] Starting dynamic subtest: pipe-B-eDP-1 [451.272398] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.281s) [451.570265] Subtest plane-all-transition-nonblocking: SUCCESS (6.371s) [452.386359] [091/132] (568s left) gem_ctx_shared (q-independent) [452.453551] Starting subtest: Q-independent [452.455997] Starting dynamic subtest: rcs0 [452.519526] Dynamic subtest rcs0: SUCCESS (0.065s) [452.532194] Starting dynamic subtest: vcs0 [452.557652] Dynamic subtest vcs0: SUCCESS (0.038s) [452.566990] Starting dynamic subtest: vcs1 [452.598236] Dynamic subtest vcs1: SUCCESS (0.040s) [452.608831] Starting dynamic subtest: vecs0 [452.638596] Dynamic subtest vecs0: SUCCESS (0.040s) [452.649024] Starting dynamic subtest: ccs0 [452.692201] Dynamic subtest ccs0: SUCCESS (0.052s) [452.694660] Subtest Q-independent: SUCCESS (0.239s) [453.774430] [092/132] (567s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [453.874538] Starting subtest: plane-primary-toggle-with-vblank-wait [453.876749] Starting dynamic subtest: pipe-A-eDP-1 [454.047359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s) [454.356767] Starting dynamic subtest: pipe-B-eDP-1 [455.238186] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.890s) [455.535148] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.660s) [456.396155] [093/132] (564s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [456.505087] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [460.915656] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.415s) [462.094748] [094/132] (559s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [462.214110] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [462.216538] Starting dynamic subtest: A-eDP1 [465.896241] Dynamic subtest A-eDP1: SUCCESS (3.679s) [465.916091] Starting dynamic subtest: B-eDP1 [469.203364] Dynamic subtest B-eDP1: SUCCESS (3.308s) [469.213612] Starting dynamic subtest: C-eDP1 [472.480331] Dynamic subtest C-eDP1: SUCCESS (3.277s) [472.490532] Starting dynamic subtest: D-eDP1 [475.800056] Dynamic subtest D-eDP1: SUCCESS (3.321s) [475.802405] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.593s) [476.693431] [095/132] (544s left) syncobj_basic (bad-pad-fd-to-handle) [476.755853] Starting subtest: bad-pad-fd-to-handle [476.757949] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [476.893446] [096/132] (544s left) kms_psr (psr-sprite-plane-onoff) [476.980316] Starting subtest: psr-sprite-plane-onoff [476.982464] Starting dynamic subtest: eDP-1 [478.776926] Dynamic subtest eDP-1: SUCCESS (1.798s) [478.779281] Subtest psr-sprite-plane-onoff: SUCCESS (1.799s) [479.589544] [097/132] (541s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [479.644423] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [479.751274] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.106s) [479.850594] [098/132] (541s left) gem_exec_schedule (u-submit-early-slice) [479.929167] Starting subtest: u-submit-early-slice [479.931296] Starting dynamic subtest: rcs0 [479.963101] Dynamic subtest rcs0: SUCCESS (0.043s) [479.976229] Starting dynamic subtest: bcs0 [480.001864] Dynamic subtest bcs0: SUCCESS (0.039s) [480.012301] Starting dynamic subtest: vcs0 [480.039486] Dynamic subtest vcs0: SUCCESS (0.037s) [480.049745] Starting dynamic subtest: vcs1 [480.083283] Dynamic subtest vcs1: SUCCESS (0.043s) [480.099013] Starting dynamic subtest: vecs0 [480.126770] Dynamic subtest vecs0: SUCCESS (0.041s) [480.139927] Starting dynamic subtest: ccs0 [480.165914] Dynamic subtest ccs0: SUCCESS (0.039s) [480.168193] Subtest u-submit-early-slice: SUCCESS (0.247s) [481.780010] [099/132] (539s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [481.896783] Starting subtest: cursorA-vs-flipB-varying-size [481.901299] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [482.078595] [100/132] (539s left) kms_properties (connector-properties-atomic) [482.173434] Starting subtest: connector-properties-atomic [482.175719] Starting dynamic subtest: pipe-A-eDP-1 [490.323225] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.148s) [490.333399] Starting dynamic subtest: pipe-None-DP-1 [490.337766] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [490.346932] Starting dynamic subtest: pipe-None-HDMI-A-1 [490.351294] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [490.360509] Starting dynamic subtest: pipe-None-DP-2 [490.364676] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [490.373889] Starting dynamic subtest: pipe-None-HDMI-A-2 [490.378206] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [490.387301] Starting dynamic subtest: pipe-None-DP-3 [490.391678] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [490.400847] Starting dynamic subtest: pipe-None-DP-4 [490.404677] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [490.406508] Subtest connector-properties-atomic: SUCCESS (8.160s) [491.174834] [101/132] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [491.277506] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [491.281275] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [491.392855] [102/132] (530s left) kms_cursor_crc (cursor-alpha-transparent) [491.484123] Starting subtest: cursor-alpha-transparent [491.486289] Starting dynamic subtest: pipe-A-eDP-1 [492.102702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s) [492.112739] Starting dynamic subtest: pipe-D-eDP-1 [493.408853] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s) [493.411241] Subtest cursor-alpha-transparent: SUCCESS (1.928s) [494.269246] [103/132] (527s left) gem_exec_schedule (pi-ringfull) [494.462548] Starting subtest: pi-ringfull [494.465193] Starting dynamic subtest: rcs0 [494.493932] Dynamic subtest rcs0: SUCCESS (0.032s) [494.503835] Starting dynamic subtest: bcs0 [494.533687] Dynamic subtest bcs0: SUCCESS (0.041s) [494.556400] Starting dynamic subtest: vcs0 [494.566232] Dynamic subtest vcs0: SUCCESS (0.032s) [494.581302] Starting dynamic subtest: vcs1 [494.593725] Dynamic subtest vcs1: SUCCESS (0.027s) [494.607807] Starting dynamic subtest: vecs0 [494.622837] Dynamic subtest vecs0: SUCCESS (0.028s) [494.636874] Starting dynamic subtest: ccs0 [494.650550] Dynamic subtest ccs0: SUCCESS (0.027s) [494.652867] Subtest pi-ringfull: SUCCESS (0.192s) [494.900897] [104/132] (526s left) kms_flip (2x-flip-vs-fences-interruptible) [495.016388] Starting subtest: 2x-flip-vs-fences-interruptible [495.021026] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [495.155011] [105/132] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [495.252886] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [495.257230] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [495.392893] [106/132] (526s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [495.473966] Starting subtest: yf-tiled-ccs-to-y-tiled [495.478437] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [495.683315] [107/132] (526s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [495.789252] Starting subtest: plane-upscale-20x20-with-modifiers [495.791908] Starting dynamic subtest: pipe-A [496.123386] Dynamic subtest pipe-A: SUCCESS (0.337s) [496.137264] Starting dynamic subtest: pipe-B [497.504410] Dynamic subtest pipe-B: SUCCESS (1.378s) [497.517087] Starting dynamic subtest: pipe-C [498.905957] Dynamic subtest pipe-C: SUCCESS (1.401s) [498.922679] Starting dynamic subtest: pipe-D [500.320619] Dynamic subtest pipe-D: SUCCESS (1.414s) [500.322993] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.537s) [501.489998] [108/132] (520s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [501.606747] Starting subtest: basic-flip-after-cursor-atomic [502.518735] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.914s) [503.374254] [109/132] (518s left) kms_vrr (flipline) [503.475519] Starting subtest: flipline [503.481558] Subtest flipline: SKIP (0.000s) [503.573800] [110/132] (518s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [503.677589] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [503.681522] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [503.812131] [111/132] (518s left) kms_big_fb (4-tiled-8bpp-rotate-0) [503.916501] Starting subtest: 4-tiled-8bpp-rotate-0 [505.176200] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.260s) [505.366964] [112/132] (516s left) kms_sequence (queue-idle) [505.463516] Starting subtest: queue-idle [505.465029] Starting dynamic subtest: pipe-A-eDP-1 [507.278558] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.814s) [507.288283] Starting dynamic subtest: pipe-B-eDP-1 [509.796603] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.518s) [509.806827] Starting dynamic subtest: pipe-C-eDP-1 [512.275147] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.477s) [512.286087] Starting dynamic subtest: pipe-D-eDP-1 [514.764240] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.488s) [514.766111] Subtest queue-idle: SUCCESS (9.302s) [515.675064] [113/132] (506s left) gem_exec_reloc (basic-wc) [515.741303] Subtest basic-wc: SKIP (0.000s) [515.830240] [114/132] (506s left) gem_mmap_gtt (basic-read-write-distinct) [515.896070] Subtest basic-read-write-distinct: SKIP (0.000s) [515.968148] [115/132] (506s left) gem_eio (in-flight-contexts-10ms) [516.200288] Starting subtest: in-flight-contexts-10ms [527.693337] Subtest in-flight-contexts-10ms: SUCCESS (11.493s) [527.906579] [116/132] (494s left) kms_cursor_legacy (torture-move) [528.031085] Starting subtest: torture-move [528.033309] Starting dynamic subtest: pipe-A [534.207908] Dynamic subtest pipe-A: SUCCESS (6.175s) [534.221706] Starting dynamic subtest: pipe-B [540.773194] Dynamic subtest pipe-B: SUCCESS (6.563s) [540.786430] Starting dynamic subtest: pipe-C [548.218264] Dynamic subtest pipe-C: SUCCESS (7.444s) [548.230593] Starting dynamic subtest: pipe-D [555.035054] Dynamic subtest pipe-D: SUCCESS (6.818s) [555.051062] Starting dynamic subtest: all-pipes [562.849392] Dynamic subtest all-pipes: SUCCESS (7.814s) [562.852192] Subtest torture-move: SUCCESS (34.826s) [563.033099] [117/132] (459s left) kms_feature_discovery (display-2x) [563.142526] Starting subtest: display-2x [563.146958] Subtest display-2x: SKIP (0.000s) [563.239833] [118/132] (459s left) syncobj_timeline (single-wait-for-submit-available-signaled) [563.309932] Starting subtest: single-wait-for-submit-available-signaled [563.312231] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [563.450936] [119/132] (458s left) i915_drm_fdinfo (isolation) [563.487614] Starting subtest: isolation [563.490058] Starting dynamic subtest: rcs0 [563.510481] Dynamic subtest rcs0: SKIP (0.021s) [563.521737] Starting dynamic subtest: bcs0 [563.532798] Dynamic subtest bcs0: SKIP (0.022s) [563.542316] Starting dynamic subtest: vcs0 [563.546341] Dynamic subtest vcs0: SKIP (0.000s) [563.555844] Starting dynamic subtest: vcs1 [563.560268] Dynamic subtest vcs1: SKIP (0.000s) [563.569747] Starting dynamic subtest: vecs0 [563.573712] Dynamic subtest vecs0: SKIP (0.000s) [563.582682] Starting dynamic subtest: ccs0 [563.586599] Dynamic subtest ccs0: SKIP (0.000s) [563.590593] Subtest isolation: SKIP (0.050s) [563.631655] [120/132] (458s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [563.734748] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [563.737025] Starting dynamic subtest: pipe-A [563.754626] Dynamic subtest pipe-A: SKIP (0.016s) [563.765251] Starting dynamic subtest: pipe-B [563.785275] Dynamic subtest pipe-B: SKIP (0.030s) [563.795947] Starting dynamic subtest: pipe-C [563.815438] Dynamic subtest pipe-C: SKIP (0.030s) [563.825349] Starting dynamic subtest: pipe-D [563.844952] Dynamic subtest pipe-D: SKIP (0.029s) [563.849090] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.108s) [563.981822] [121/132] (458s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [564.098991] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [564.102306] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [564.233161] [122/132] (458s left) api_intel_bb (intel-bb-blit-y) [564.297808] Starting subtest: intel-bb-blit-y [568.495020] Subtest intel-bb-blit-y: SUCCESS (4.197s) [568.660179] [123/132] (453s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [568.766507] Starting subtest: psr-1p-pri-indfb-multidraw [591.383361] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.624s) [591.545249] [124/132] (431s left) gem_partial_pwrite_pread (writes-after-reads-display) [591.606248] Subtest writes-after-reads-display: SKIP (0.000s) [591.681271] [125/132] (430s left) kms_getfb (getfb-handle-protection) [591.781842] Starting subtest: getfb-handle-protection [591.806742] Subtest getfb-handle-protection: SUCCESS (0.026s) [591.951319] [126/132] (430s left) gem_exec_schedule (u-fairslice-all) [592.035407] Starting subtest: u-fairslice-all [594.094242] Subtest u-fairslice-all: SUCCESS (2.063s) [594.437032] [127/132] (428s left) syncobj_wait (wait-for-submit-delayed-submit) [594.505326] Starting subtest: wait-for-submit-delayed-submit [594.606541] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [594.714418] [128/132] (428s left) gem_madvise (dontneed-after-mmap) [594.749628] Starting subtest: dontneed-after-mmap [594.776521] Subtest dontneed-after-mmap: SUCCESS (0.031s) [594.914614] [129/132] (427s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [599.901122] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [599.903464] Starting dynamic subtest: pipe-A-eDP-1 [600.657893] Dynamic subtest pipe-A-eDP-1: SKIP (0.754s) [600.668757] Starting dynamic subtest: pipe-B-eDP-1 [601.770016] Dynamic subtest pipe-B-eDP-1: SKIP (1.110s) [601.774670] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.868s) [603.027699] [130/132] (419s left) kms_frontbuffer_tracking (fbc-tiling-linear) [603.131690] Starting subtest: fbc-tiling-linear [606.819081] Subtest fbc-tiling-linear: SUCCESS (3.691s) [608.048828] [131/132] (414s left) gem_userptr_blits (huge-split) [608.124509] Starting subtest: huge-split [608.131508] Subtest huge-split: SUCCESS (0.007s) [608.300637] [132/132] (414s left) kms_properties (colorop-properties-legacy) [608.387616] Starting subtest: colorop-properties-legacy [608.389904] Starting dynamic subtest: pipe-A-eDP-1 [608.753134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.366s) [608.764155] Starting dynamic subtest: pipe-B-eDP-1 [609.850306] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.094s) [609.861391] Starting dynamic subtest: pipe-C-eDP-1 [610.953113] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s) [610.963183] Starting dynamic subtest: pipe-D-eDP-1 [612.045761] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.092s) [612.047920] Subtest colorop-properties-legacy: SUCCESS (3.660s) [612.931486] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: perf_pmu results: parsing output: 3/ for test: gem_spin_batch results: parsing output: 4/ for test: kms_addfb_basic results: parsing output: 5/ for test: kms_properties results: parsing output: 6/ for test: i915_pm_freq_api results: parsing output: 7/ for test: kms_cursor_crc results: parsing output: 8/ for test: kms_atomic results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: kms_cursor_edge_walk results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: gem_ctx_isolation results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: gem_partial_pwrite_pread results: parsing output: 15/ for test: gen9_exec_parse results: parsing output: 16/ for test: kms_flip_scaled_crc results: parsing output: 17/ for test: gem_fenced_exec_thrash results: parsing output: 18/ for test: vgem_basic results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: gem_ctx_persistence results: parsing output: 21/ for test: syncobj_basic results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_rotation_crc results: parsing output: 24/ for test: fbdev results: parsing output: 25/ for test: kms_addfb_basic results: parsing output: 26/ for test: kms_ccs results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_force_connector_basic results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: kms_addfb_basic results: parsing output: 31/ for test: kms_chamelium_color results: parsing output: 32/ for test: kms_flip_scaled_crc results: parsing output: 33/ for test: gem_ctx_create results: parsing output: 34/ for test: gem_exec_fence results: parsing output: 35/ for test: gem_mmap_offset results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_selftest results: parsing output: 39/ for test: gem_exec_capture results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: kms_cursor_crc results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: prime_vgem results: parsing output: 44/ for test: i915_pm_rps results: parsing output: 45/ for test: gem_mmap results: parsing output: 46/ for test: gem_mmap_gtt results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: i915_pm_rpm results: parsing output: 49/ for test: gem_pxp results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: syncobj_basic results: parsing output: 52/ for test: kms_plane results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: kms_legacy_colorkey results: parsing output: 56/ for test: kms_atomic_interruptible results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_plane_alpha_blend results: parsing output: 59/ for test: perf results: parsing output: 60/ for test: kms_pm_rpm results: parsing output: 61/ for test: gem_pwrite results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_chamelium_hpd results: parsing output: 64/ for test: perf_pmu results: parsing output: 65/ for test: drm_read results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: gem_create results: parsing output: 68/ for test: gem_eio results: parsing output: 69/ for test: gem_exec_reloc results: parsing output: 70/ for test: syncobj_timeline results: parsing output: 71/ for test: dumb_buffer results: parsing output: 72/ for test: prime_vgem results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_color results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: gem_exec_whisper results: parsing output: 78/ for test: kms_invalid_mode results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: syncobj_wait results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: prime_mmap results: parsing output: 84/ for test: gem_exec_balancer results: parsing output: 85/ for test: gem_exec_flush results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_chamelium_frames results: parsing output: 88/ for test: kms_psr2_sf results: parsing output: 89/ for test: kms_atomic_transition results: parsing output: 90/ for test: gem_ctx_shared results: parsing output: 91/ for test: kms_atomic_transition results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: syncobj_basic results: parsing output: 95/ for test: kms_psr results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_properties results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_cursor_crc results: parsing output: 102/ for test: gem_exec_schedule results: parsing output: 103/ for test: kms_flip 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_plane_scaling results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: kms_vrr results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_sequence results: parsing output: 112/ for test: gem_exec_reloc results: parsing output: 113/ for test: gem_mmap_gtt results: parsing output: 114/ for test: gem_eio results: parsing output: 115/ for test: kms_cursor_legacy results: parsing output: 116/ for test: kms_feature_discovery results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: i915_drm_fdinfo results: parsing output: 119/ for test: kms_plane_scaling results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: api_intel_bb results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: gem_partial_pwrite_pread results: parsing output: 124/ for test: kms_getfb results: parsing output: 125/ for test: gem_exec_schedule results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: gem_madvise results: parsing output: 128/ for test: kms_psr2_sf results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_userptr_blits results: parsing output: 131/ for test: kms_properties Done.