[38.851174] Initializing watchdogs [38.851206] /dev/watchdog0 [38.856609] [001/130] (960s left) kms_invalid_mode (zero-vdisplay) [38.941529] Starting subtest: zero-vdisplay [38.942554] Starting dynamic subtest: pipe-A-eDP-1 [39.222811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s) [39.228579] Starting dynamic subtest: pipe-B-eDP-1 [39.229402] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [39.232612] Starting dynamic subtest: pipe-C-eDP-1 [39.233494] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [39.236615] Starting dynamic subtest: pipe-D-eDP-1 [39.237456] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [39.238309] Subtest zero-vdisplay: SUCCESS (0.284s) [40.089117] [002/130] (959s left) gem_softpin (evict-snoop-interruptible) [40.137567] Starting subtest: evict-snoop-interruptible [40.139943] Subtest evict-snoop-interruptible: SKIP (0.000s) [40.221664] [003/130] (959s left) kms_plane_alpha_blend (alpha-basic) [40.307536] Starting subtest: alpha-basic [40.594507] Starting dynamic subtest: pipe-A-eDP-1 [42.529760] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [42.548611] Starting dynamic subtest: pipe-D-eDP-1 [45.241696] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.697s) [45.243193] Subtest alpha-basic: SUCCESS (4.934s) [46.102297] [004/130] (953s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [46.185450] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [46.186369] Starting dynamic subtest: pipe-A-default-mode [46.468958] Dynamic subtest pipe-A-default-mode: SKIP (0.281s) [46.471608] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.282s) [47.380625] [005/130] (952s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [47.465468] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [47.466500] Starting dynamic subtest: pipe-A-eDP-1 [47.476327] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [47.481176] Starting dynamic subtest: pipe-B-eDP-1 [47.490501] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [47.494101] Starting dynamic subtest: pipe-C-eDP-1 [47.502876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [47.506608] Starting dynamic subtest: pipe-D-eDP-1 [47.515588] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [47.517155] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.002s) [49.809240] [006/130] (949s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [49.895226] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [49.896976] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [49.959898] [007/130] (949s left) fbdev (nullptr) [49.991829] Starting subtest: nullptr [49.993116] Subtest nullptr: SUCCESS (0.000s) [50.024089] [008/130] (949s left) gem_softpin (overlap) [50.066819] Starting subtest: overlap [50.687125] Subtest overlap: SUCCESS (0.629s) [50.782711] [009/130] (948s left) gem_ctx_engines (execute-oneforall) [50.830841] Starting subtest: execute-oneforall [51.205649] Subtest execute-oneforall: SUCCESS (0.381s) [52.494712] [010/130] (946s left) kms_cursor_legacy (cursor-vs-flip-toggle) [52.596815] Starting subtest: cursor-vs-flip-toggle [81.850809] Subtest cursor-vs-flip-toggle: SUCCESS (29.346s) [82.710863] [011/130] (916s left) kms_hdr (brightness-with-hdr) [82.790448] Starting subtest: brightness-with-hdr [82.793374] Subtest brightness-with-hdr: SKIP (0.000s) [82.837047] [012/130] (916s left) gem_exec_params (mmapped) [82.891037] Starting subtest: mmapped [82.894379] Subtest mmapped: SUCCESS (0.003s) [82.989995] [013/130] (916s left) gem_mmap_offset (ptrace) [83.038505] Starting subtest: ptrace [83.041878] Starting dynamic subtest: smem0-wb [83.063546] Dynamic subtest smem0-wb: SUCCESS (0.022s) [83.069873] Starting dynamic subtest: smem0-wc [83.084261] Dynamic subtest smem0-wc: SUCCESS (0.020s) [83.089025] Starting dynamic subtest: smem0-uc [83.108400] Dynamic subtest smem0-uc: SUCCESS (0.024s) [83.109303] Subtest ptrace: SUCCESS (0.071s) [83.175524] [014/130] (916s left) gem_exec_fence (invalid-fence-array) [83.590187] Starting subtest: invalid-fence-array [83.592355] Subtest invalid-fence-array: SUCCESS (0.002s) [85.433664] [015/130] (913s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [85.526017] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [90.047119] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.523s) [90.135162] [016/130] (909s left) kms_psr2_su (page_flip-nv12) [90.183203] Subtest page_flip-NV12: SKIP (0.000s) [90.218103] [017/130] (909s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [90.305449] Starting subtest: primary-y-tiled-reflect-x-90 [90.307630] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [90.351820] [018/130] (908s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [90.433984] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [90.447511] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.014s) [90.500116] [019/130] (908s left) kms_setmode (basic) [90.542617] Starting subtest: basic [90.860763] Starting dynamic subtest: pipe-A-eDP-1 [92.999888] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.134s) [93.330903] Starting dynamic subtest: pipe-B-eDP-1 [95.473597] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.144s) [95.779981] Subtest basic: SUCCESS (5.234s) [96.661980] [020/130] (902s left) gem_readwrite (beyond-eob) [96.703726] Subtest beyond-EOB: SKIP (0.000s) [96.735309] [021/130] (902s left) kms_tiled_display (basic-test-pattern) [96.833700] Subtest basic-test-pattern: SKIP (0.000s) [96.853296] [022/130] (902s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [96.929510] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [96.930598] Starting dynamic subtest: pipe-A [96.935845] Dynamic subtest pipe-A: SKIP (0.004s) [96.941305] Starting dynamic subtest: pipe-B [96.950307] Dynamic subtest pipe-B: SKIP (0.014s) [96.954615] Starting dynamic subtest: pipe-C [96.966550] Dynamic subtest pipe-C: SKIP (0.017s) [96.970856] Starting dynamic subtest: pipe-D [96.980519] Dynamic subtest pipe-D: SKIP (0.014s) [96.982247] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.049s) [97.054806] [023/130] (902s left) gem_lmem_swapping (verify-random-ccs) [97.086295] Subtest verify-random-ccs: SKIP (0.000s) [97.097822] [024/130] (902s left) sysfs_timeslice_duration (duration) [97.136792] Starting subtest: duration [97.137660] Starting dynamic subtest: vecs0 [110.302896] Dynamic subtest vecs0: SUCCESS (13.165s) [110.310341] Starting dynamic subtest: ccs0 [123.488678] Dynamic subtest ccs0: SUCCESS (13.182s) [123.495967] Starting dynamic subtest: vcs0 [137.301070] Dynamic subtest vcs0: SUCCESS (13.812s) [137.308892] Starting dynamic subtest: bcs0 [150.455238] Dynamic subtest bcs0: SUCCESS (13.155s) [150.463237] Starting dynamic subtest: rcs0 [163.611933] Dynamic subtest rcs0: SUCCESS (13.156s) [163.622936] Starting dynamic subtest: vcs1 [178.324885] Dynamic subtest vcs1: SUCCESS (14.709s) [178.326886] Subtest duration: SUCCESS (81.182s) [178.376101] [025/130] (821s left) perf (sysctl-defaults) [178.462639] Starting subtest: sysctl-defaults [178.463757] Subtest sysctl-defaults: SUCCESS (0.000s) [178.516301] [026/130] (820s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [178.598411] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [179.123789] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.525s) [179.267860] [027/130] (820s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [179.318778] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [179.427277] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s) [179.473346] [028/130] (819s left) kms_flip_event_leak (basic) [179.548442] Starting subtest: basic [179.549277] Starting dynamic subtest: pipe-A-eDP-1 [179.954331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s) [179.959681] Starting dynamic subtest: pipe-B-eDP-1 [181.143959] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.189s) [181.149234] Starting dynamic subtest: pipe-C-eDP-1 [182.332088] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s) [182.336726] Starting dynamic subtest: pipe-D-eDP-1 [183.484135] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.151s) [183.485184] Subtest basic: SUCCESS (3.934s) [184.341703] [029/130] (815s left) gem_mmap_gtt (hang) [184.388394] Subtest hang: SKIP (0.000s) [184.426496] [030/130] (815s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [184.508196] Starting subtest: psr-rgb101010-draw-mmap-wc [189.111730] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.605s) [189.209866] [031/130] (810s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [189.298538] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [189.299591] Starting dynamic subtest: pipe-A-eDP-1 [189.323047] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [189.328430] Starting dynamic subtest: pipe-B-eDP-1 [189.349771] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [189.354143] Starting dynamic subtest: pipe-C-eDP-1 [189.375454] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [189.379841] Starting dynamic subtest: pipe-D-eDP-1 [189.400880] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [189.402446] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [191.643578] [032/130] (807s left) gem_mmap (basic) [191.688086] Subtest basic: SKIP (0.000s) [191.724853] [033/130] (807s left) gem_exec_store (cachelines) [191.773626] Starting subtest: cachelines [191.774687] Starting dynamic subtest: rcs0 [191.840907] Dynamic subtest rcs0: SUCCESS (0.067s) [191.848342] Starting dynamic subtest: bcs0 [191.898064] Dynamic subtest bcs0: SUCCESS (0.057s) [191.905107] Starting dynamic subtest: vcs0 [191.953526] Dynamic subtest vcs0: SUCCESS (0.055s) [191.960673] Starting dynamic subtest: vcs1 [192.006505] Dynamic subtest vcs1: SUCCESS (0.053s) [192.013075] Starting dynamic subtest: vecs0 [192.061854] Dynamic subtest vecs0: SUCCESS (0.055s) [192.069087] Starting dynamic subtest: ccs0 [192.118483] Dynamic subtest ccs0: SUCCESS (0.057s) [192.119712] Subtest cachelines: SUCCESS (0.345s) [192.274158] [034/130] (807s left) gem_eio (unwedge-stress) [192.465097] Starting subtest: unwedge-stress [234.812479] Subtest unwedge-stress: SUCCESS (42.344s) [236.423786] [035/130] (763s left) i915_suspend (basic-s3-without-i915) [236.457679] Starting subtest: basic-s3-without-i915 [238.604759] Subtest basic-s3-without-i915: SKIP (2.144s) [239.562899] [036/130] (759s left) kms_cursor_crc (cursor-rapid-movement-256x85) [239.743952] Starting subtest: cursor-rapid-movement-256x85 [239.780153] Subtest cursor-rapid-movement-256x85: SKIP (0.034s) [239.919708] [037/130] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [240.021560] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [240.023405] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [240.093609] [038/130] (759s left) gem_ccs (ctrl-surf-copy-new-ctx) [240.142816] Starting subtest: ctrl-surf-copy-new-ctx [240.145254] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [240.212076] [039/130] (759s left) syncobj_timeline (reset-during-wait-for-submit) [240.254896] Starting subtest: reset-during-wait-for-submit [240.359837] Subtest reset-during-wait-for-submit: SUCCESS (0.102s) [240.410038] [040/130] (759s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [240.501844] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [243.443174] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.943s) [243.529469] [041/130] (756s left) gem_userptr_blits (sync-unmap-after-close) [243.572156] Starting subtest: sync-unmap-after-close [243.581889] Subtest sync-unmap-after-close: SUCCESS (0.010s) [243.691339] [042/130] (755s left) kms_pwrite_crc [245.271335] [043/130] (754s left) syncobj_timeline (invalid-transfer-non-existent-point) [245.316895] Starting subtest: invalid-transfer-non-existent-point [245.318039] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [245.372154] [044/130] (754s left) gem_exec_balancer (waits) [245.424354] Starting subtest: waits [251.533210] Subtest waits: SUCCESS (6.106s) [251.763065] [045/130] (747s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [251.867874] Starting subtest: flip-vs-cursor-busy-crc-legacy [252.682338] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.814s) [253.589380] [046/130] (746s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [253.685577] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [253.686619] Starting dynamic subtest: pipe-A-eDP-1 [253.695964] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [253.701719] Starting dynamic subtest: pipe-B-eDP-1 [253.710532] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [253.714842] Starting dynamic subtest: pipe-C-eDP-1 [253.723413] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [253.728057] Starting dynamic subtest: pipe-D-eDP-1 [253.736290] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [253.737895] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s) [256.022782] [047/130] (743s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [256.116566] Starting subtest: bad-aux-stride-yf-tiled-ccs [256.117571] Starting dynamic subtest: pipe-A-eDP-1 [256.126479] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [256.132209] Starting dynamic subtest: pipe-B-eDP-1 [256.140820] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [256.145675] Starting dynamic subtest: pipe-C-eDP-1 [256.154617] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [256.158744] Starting dynamic subtest: pipe-D-eDP-1 [256.167034] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [256.168722] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s) [258.453568] [048/130] (741s left) kms_cursor_crc (cursor-rapid-movement-32x32) [258.554844] Starting subtest: cursor-rapid-movement-32x32 [258.586444] Subtest cursor-rapid-movement-32x32: SKIP (0.029s) [258.801174] [049/130] (740s left) perf_pmu (idle-no-semaphores) [258.833339] Starting subtest: idle-no-semaphores [258.834477] Starting dynamic subtest: rcs0 [259.357731] Dynamic subtest rcs0: SUCCESS (0.521s) [259.363997] Starting dynamic subtest: bcs0 [259.876921] Dynamic subtest bcs0: SUCCESS (0.518s) [259.883316] Starting dynamic subtest: vcs0 [260.397244] Dynamic subtest vcs0: SUCCESS (0.519s) [260.403551] Starting dynamic subtest: vcs1 [260.929777] Dynamic subtest vcs1: SUCCESS (0.531s) [260.936077] Starting dynamic subtest: vecs0 [261.450993] Dynamic subtest vecs0: SUCCESS (0.521s) [261.459087] Starting dynamic subtest: ccs0 [261.966127] Dynamic subtest ccs0: SUCCESS (0.514s) [261.967692] Subtest idle-no-semaphores: SUCCESS (3.131s) [262.032421] [050/130] (737s left) gem_softpin (32b-excludes-last-page) [262.080598] Starting subtest: 32b-excludes-last-page [262.084200] Subtest 32b-excludes-last-page: SUCCESS (0.004s) [262.184073] [051/130] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [262.274351] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [266.578343] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.306s) [266.686316] [052/130] (733s left) i915_selftest (perf) [268.598317] Starting subtest: perf [268.600075] Starting dynamic subtest: engine_cs [271.001497] Dynamic subtest engine_cs: SUCCESS (2.403s) [271.008074] Starting dynamic subtest: request [275.787633] Dynamic subtest request: SUCCESS (4.785s) [275.792762] Starting dynamic subtest: migrate [278.292839] Dynamic subtest migrate: SUCCESS (2.504s) [278.299660] Starting dynamic subtest: region [282.203512] Dynamic subtest region: SUCCESS (3.910s) [282.205258] Subtest perf: SUCCESS (13.605s) [282.215107] [053/130] (717s left) i915_pm_rpm (sysfs-read) [284.618057] Starting subtest: sysfs-read [285.776375] Subtest sysfs-read: SUCCESS (1.157s) [286.156367] [054/130] (713s left) kms_chamelium_frames (dp-crc-single) [286.530063] Subtest dp-crc-single: SKIP (0.000s) [287.426394] [055/130] (712s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [287.512459] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [292.368487] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (4.857s) [292.477832] [056/130] (707s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [292.560711] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [292.561748] Starting dynamic subtest: pipe-A-eDP-1 [292.571763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [292.576547] Starting dynamic subtest: pipe-B-eDP-1 [292.585657] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [292.590748] Starting dynamic subtest: pipe-C-eDP-1 [292.603905] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [292.608384] Starting dynamic subtest: pipe-D-eDP-1 [292.616858] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [292.618520] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s) [294.869392] [057/130] (704s left) prime_busy (before-wait) [294.916747] Starting subtest: before-wait [294.919194] Starting dynamic subtest: rcs0 [294.933499] Dynamic subtest rcs0: SUCCESS (0.015s) [294.940321] Starting dynamic subtest: bcs0 [294.994621] Dynamic subtest bcs0: SUCCESS (0.060s) [295.000999] Starting dynamic subtest: vcs0 [295.034784] Dynamic subtest vcs0: SUCCESS (0.040s) [295.040315] Starting dynamic subtest: vcs1 [295.076198] Dynamic subtest vcs1: SUCCESS (0.041s) [295.082069] Starting dynamic subtest: vecs0 [295.116667] Dynamic subtest vecs0: SUCCESS (0.040s) [295.122093] Starting dynamic subtest: ccs0 [295.157415] Dynamic subtest ccs0: SUCCESS (0.041s) [295.266642] Subtest before-wait: SUCCESS (0.347s) [295.315108] [058/130] (704s left) kms_big_fb (linear-64bpp-rotate-90) [295.404972] Starting subtest: linear-64bpp-rotate-90 [295.423263] Subtest linear-64bpp-rotate-90: SKIP (0.018s) [295.524260] [059/130] (704s left) perf (invalid-remove-userspace-config) [295.607471] Starting subtest: invalid-remove-userspace-config [295.613626] Subtest invalid-remove-userspace-config: SUCCESS (0.007s) [295.631288] [060/130] (704s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [295.719886] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [295.721806] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [295.797072] [061/130] (704s left) kms_big_fb (x-tiled-32bpp-rotate-180) [295.885902] Starting subtest: x-tiled-32bpp-rotate-180 [297.152583] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.267s) [297.261356] [062/130] (702s left) gem_exec_schedule (preempt-queue-chain) [297.311424] Subtest preempt-queue-chain: SKIP (0.000s) [297.578238] [063/130] (702s left) gem_exec_balancer (parallel-contexts) [297.781362] Starting subtest: parallel-contexts [299.570412] Subtest parallel-contexts: SUCCESS (1.789s) [299.643266] [064/130] (700s left) kms_pm_backlight (fade-with-suspend) [299.724907] Starting subtest: fade-with-suspend [315.892986] Starting dynamic subtest: eDP-1 [318.524463] Dynamic subtest eDP-1: SUCCESS (2.676s) [318.525751] Subtest fade-with-suspend: SUCCESS (3.779s) [319.398275] [065/130] (695s left) debugfs_test (read_all_entries_display_off) [319.497111] Starting subtest: read_all_entries_display_off [320.599362] Subtest read_all_entries_display_off: SUCCESS (1.117s) [320.870127] [066/130] (693s left) kms_psr (psr-primary-page-flip) [320.951132] Starting subtest: psr-primary-page-flip [320.952076] Starting dynamic subtest: eDP-1 [322.716267] Dynamic subtest eDP-1: SUCCESS (1.784s) [322.717503] Subtest psr-primary-page-flip: SUCCESS (1.785s) [323.627564] [067/130] (691s left) gem_ppgtt (blt-vs-render-ctxn) [323.681951] Starting subtest: blt-vs-render-ctxN [356.519392] Subtest blt-vs-render-ctxN: SUCCESS (32.907s) [356.637080] [068/130] (658s left) gen7_exec_parse (oacontrol-tracking) [356.699107] Subtest oacontrol-tracking: SKIP (0.000s) [356.741819] [069/130] (658s left) gem_ctx_shared (q-in-order) [356.795757] Starting subtest: Q-in-order [356.797433] Starting dynamic subtest: rcs0 [356.990781] Dynamic subtest rcs0: SUCCESS (0.193s) [357.004679] Starting dynamic subtest: vcs0 [357.078933] Dynamic subtest vcs0: SUCCESS (0.089s) [357.094971] Starting dynamic subtest: vcs1 [357.168631] Dynamic subtest vcs1: SUCCESS (0.089s) [357.184220] Starting dynamic subtest: vecs0 [357.264854] Dynamic subtest vecs0: SUCCESS (0.096s) [357.278659] Starting dynamic subtest: ccs0 [357.383396] Dynamic subtest ccs0: SUCCESS (0.117s) [357.385461] Subtest Q-in-order: SUCCESS (0.586s) [358.536169] [070/130] (656s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [363.636301] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [363.639813] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s) [364.526838] [071/130] (650s left) gem_reg_read (bad-register) [364.573732] Starting subtest: bad-register [364.574985] Subtest bad-register: SUCCESS (0.000s) [364.639906] [072/130] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [364.729635] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [364.731253] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [364.797000] [073/130] (650s left) gem_mmap_wc (fault-concurrent) [364.842812] Subtest fault-concurrent: SKIP (0.000s) [364.886473] [074/130] (649s left) gem_lmem_swapping (heavy-verify-random-ccs) [364.915104] Subtest heavy-verify-random-ccs: SKIP (0.000s) [364.941728] [075/130] (649s left) kms_flip (blocking-absolute-wf_vblank) [365.032420] Starting subtest: blocking-absolute-wf_vblank [365.034046] Starting dynamic subtest: A-eDP1 [373.866536] Dynamic subtest A-eDP1: SUCCESS (8.835s) [373.874755] Starting dynamic subtest: B-eDP1 [382.698608] Dynamic subtest B-eDP1: SUCCESS (8.834s) [382.709659] Starting dynamic subtest: C-eDP1 [391.521704] Dynamic subtest C-eDP1: SUCCESS (8.826s) [391.528318] Starting dynamic subtest: D-eDP1 [400.287657] Dynamic subtest D-eDP1: SUCCESS (8.769s) [400.290289] Subtest blocking-absolute-wf_vblank: SUCCESS (35.272s) [401.519613] [076/130] (613s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [406.626753] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [406.630006] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [407.533839] [077/130] (607s left) drm_fdinfo (all-busy-idle-check-all) [407.559330] Starting subtest: all-busy-idle-check-all [407.563850] Subtest all-busy-idle-check-all: SKIP (0.004s) [407.600409] [078/130] (607s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [407.709454] Starting subtest: cursorB-vs-flipA-varying-size [407.712395] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s) [407.829733] [079/130] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [407.925188] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [407.926977] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [408.012164] [080/130] (606s left) prime_vgem (basic-fence-read) [408.081046] Starting subtest: basic-fence-read [408.086648] Subtest basic-fence-read: SKIP (0.005s) [408.172358] [081/130] (606s left) kms_force_connector_basic (prune-stale-modes) [408.242868] Starting subtest: prune-stale-modes [408.482018] Subtest prune-stale-modes: SKIP (0.237s) [408.604803] [082/130] (606s left) kms_atomic (plane-cursor-legacy) [408.701090] Starting subtest: plane-cursor-legacy [408.701968] Starting dynamic subtest: pipe-A-eDP-1 [409.051909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.349s) [409.053402] Subtest plane-cursor-legacy: SUCCESS (0.350s) [409.961175] [083/130] (604s left) kms_psr (psr2-sprite-render) [410.060281] Starting subtest: psr2-sprite-render [410.061319] Starting dynamic subtest: eDP-1 [411.860782] Dynamic subtest eDP-1: SUCCESS (1.799s) [411.861878] Subtest psr2-sprite-render: SUCCESS (1.800s) [412.781258] [084/130] (602s left) gen9_exec_parse (secure-batches) [412.828272] Subtest secure-batches: SKIP (0.000s) [412.867677] [085/130] (602s left) gem_mmap_gtt (hang-user) [412.907927] Subtest hang-user: SKIP (0.000s) [412.946952] [086/130] (602s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc) [413.040839] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc [415.718313] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.677s) [415.816737] [087/130] (599s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [415.901480] Starting subtest: yf-tiled-16bpp-rotate-270 [415.903143] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [415.968029] [088/130] (599s left) gem_readwrite (write-bad-handle) [416.002830] Subtest write-bad-handle: SKIP (0.000s) [416.027614] [089/130] (598s left) gem_mmap_wc (write-read-distinct) [416.078415] Subtest write-read-distinct: SKIP (0.000s) [416.117603] [090/130] (598s left) kms_psr (pr-no-drrs) [416.200210] Starting subtest: pr-no-drrs [416.202177] Subtest pr-no-drrs: SKIP (0.000s) [416.252350] [091/130] (598s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [416.333808] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [421.123570] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.788s) [421.226211] [092/130] (593s left) kms_content_protection (dp-mst-lic-type-0) [421.344032] Starting subtest: dp-mst-lic-type-0 [421.345986] Subtest dp-mst-lic-type-0: SKIP (0.000s) [421.425813] [093/130] (593s left) kms_psr (fbc-psr-cursor-plane-move) [421.504194] Starting subtest: fbc-psr-cursor-plane-move [421.505192] Starting dynamic subtest: eDP-1 [421.507060] Dynamic subtest eDP-1: SKIP (0.000s) [421.508748] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [421.553525] [094/130] (593s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [421.628530] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [421.630378] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [421.688860] [095/130] (593s left) gem_exec_schedule (pi-distinct-iova) [421.848402] Starting subtest: pi-distinct-iova [421.849239] Starting dynamic subtest: rcs0 [421.916140] Dynamic subtest rcs0: SUCCESS (0.069s) [421.922152] Starting dynamic subtest: vcs0 [421.961087] Dynamic subtest vcs0: SUCCESS (0.045s) [421.970696] Starting dynamic subtest: vcs1 [422.003137] Dynamic subtest vcs1: SUCCESS (0.041s) [422.011618] Starting dynamic subtest: vecs0 [422.038662] Dynamic subtest vecs0: SUCCESS (0.035s) [422.045855] Starting dynamic subtest: ccs0 [422.087245] Dynamic subtest ccs0: SUCCESS (0.048s) [422.088429] Subtest pi-distinct-iova: SUCCESS (0.240s) [423.515437] [096/130] (591s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [423.601886] Starting subtest: fbcpsr-rgb565-draw-pwrite [428.278814] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (4.676s) [428.365821] [097/130] (586s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format) [428.445415] Starting subtest: plane-downscale-factor-0-25-with-pixel-format [428.446639] Starting dynamic subtest: pipe-A [428.456981] Dynamic subtest pipe-A: SKIP (0.009s) [428.462947] Starting dynamic subtest: pipe-B [428.474442] Dynamic subtest pipe-B: SKIP (0.018s) [428.480498] Starting dynamic subtest: pipe-C [428.493384] Dynamic subtest pipe-C: SKIP (0.018s) [428.499131] Starting dynamic subtest: pipe-D [428.511637] Dynamic subtest pipe-D: SKIP (0.018s) [428.513324] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.064s) [428.581462] [098/130] (586s left) kms_frontbuffer_tracking (fbc-tiling-4) [428.668844] Starting subtest: fbc-tiling-4 [431.722618] Subtest fbc-tiling-4: SUCCESS (3.053s) [431.833397] [099/130] (583s left) kms_flip (busy-flip) [431.917921] Starting subtest: busy-flip [431.920013] Starting dynamic subtest: A-eDP1 [433.705112] Dynamic subtest A-eDP1: SUCCESS (1.784s) [433.712897] Starting dynamic subtest: B-eDP1 [435.497732] Dynamic subtest B-eDP1: SUCCESS (1.791s) [435.508655] Starting dynamic subtest: C-eDP1 [437.213435] Dynamic subtest C-eDP1: SUCCESS (1.714s) [437.221387] Starting dynamic subtest: D-eDP1 [438.941651] Dynamic subtest D-eDP1: SUCCESS (1.727s) [438.944998] Subtest busy-flip: SUCCESS (7.026s) [440.173736] [100/130] (574s left) syncobj_wait (wait-for-submit-snapshot) [440.226488] Starting subtest: wait-for-submit-snapshot [440.308691] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [440.363319] [101/130] (574s left) syncobj_wait (wait-all-for-submit-delayed-submit) [440.405777] Starting subtest: wait-all-for-submit-delayed-submit [440.507518] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [440.560757] [102/130] (574s left) gem_exec_reloc (basic-wc-active) [440.607290] Subtest basic-wc-active: SKIP (0.000s) [440.652224] [103/130] (574s left) kms_3d [442.853465] [104/130] (572s left) kms_dsc (dsc-with-formats) [442.940360] Starting subtest: dsc-with-formats [442.942532] Subtest dsc-with-formats: SKIP (0.001s) [442.988335] [105/130] (572s left) kms_writeback (writeback-fb-id) [443.066366] Subtest writeback-fb-id: SKIP (0.000s) [443.091530] [106/130] (572s left) kms_psr (fbc-psr2-sprite-render) [443.170249] Starting subtest: fbc-psr2-sprite-render [443.171347] Starting dynamic subtest: eDP-1 [443.173510] Dynamic subtest eDP-1: SKIP (0.000s) [443.175627] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [443.218976] [107/130] (572s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [443.258926] Starting subtest: yf-tiled-to-vebox-x-tiled [443.261074] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [443.436637] [108/130] (571s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [443.524999] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [443.526644] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [443.596943] [109/130] (571s left) kms_vblank (ts-continuation-dpms-suspend) [443.677270] Starting subtest: ts-continuation-dpms-suspend [443.678264] Starting dynamic subtest: pipe-A-eDP-1 [462.701164] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.009s) [462.709487] Starting dynamic subtest: pipe-D-eDP-1 [480.400852] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.389s) [480.402067] Subtest ts-continuation-dpms-suspend: SUCCESS (6.401s) [485.321313] [110/130] (564s left) syncobj_timeline (single-wait-available-submitted) [485.373059] Starting subtest: single-wait-available-submitted [485.373941] Subtest single-wait-available-submitted: SUCCESS (0.000s) [485.462746] [111/130] (564s left) gem_exec_balancer (bonded-sync) [485.500726] Starting subtest: bonded-sync [485.502594] Subtest bonded-sync: SKIP (0.000s) [485.728946] [112/130] (563s left) gem_exec_fence (basic-wait-all) [485.774257] Starting subtest: basic-wait-all [485.889436] Subtest basic-wait-all: SUCCESS (0.114s) [487.869672] [113/130] (561s left) kms_display_modes (extended-mode-basic) [487.948101] Starting subtest: extended-mode-basic [487.950203] Subtest extended-mode-basic: SKIP (0.000s) [487.971139] [114/130] (561s left) gem_exec_await (wide-all) [488.114367] Starting subtest: wide-all [511.485368] Subtest wide-all: SUCCESS (23.372s) [511.652846] [115/130] (538s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [511.785492] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [511.787206] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [511.857270] [116/130] (537s left) gem_mmap_gtt (big-bo) [511.903258] Subtest big-bo: SKIP (0.000s) [511.944978] [117/130] (537s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [512.028504] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [514.910719] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.883s) [515.036093] [118/130] (534s left) kms_plane (pixel-format) [515.119086] Starting subtest: pixel-format [515.149017] Starting dynamic subtest: pipe-A-plane-0 [519.703024] Dynamic subtest pipe-A-plane-0: SUCCESS (4.555s) [519.709835] Starting dynamic subtest: pipe-A-plane-3 [522.191785] Dynamic subtest pipe-A-plane-3: SUCCESS (2.489s) [522.199494] Starting dynamic subtest: pipe-A-plane-5 [522.346700] Dynamic subtest pipe-A-plane-5: SUCCESS (0.155s) [523.534053] Starting dynamic subtest: pipe-B-plane-0 [528.092918] Dynamic subtest pipe-B-plane-0: SUCCESS (4.567s) [528.099450] Starting dynamic subtest: pipe-B-plane-3 [530.603309] Dynamic subtest pipe-B-plane-3: SUCCESS (2.511s) [530.612059] Starting dynamic subtest: pipe-B-plane-5 [530.803493] Dynamic subtest pipe-B-plane-5: SUCCESS (0.200s) [531.119893] Subtest pixel-format: SUCCESS (16.004s) [532.005921] [119/130] (517s left) gem_mmap_gtt (basic-read) [532.063778] Subtest basic-read: SKIP (0.000s) [532.097872] [120/130] (517s left) syncobj_timeline (etime-single-wait-submitted) [532.141876] Starting subtest: etime-single-wait-submitted [532.250442] Subtest etime-single-wait-submitted: SUCCESS (0.105s) [532.300726] [121/130] (517s left) api_intel_bb (blit-noreloc-purge-cache) [532.341730] Starting subtest: blit-noreloc-purge-cache [532.349989] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s) [532.459340] [122/130] (517s left) gem_userptr_blits (unsync-overlap) [532.517815] Subtest unsync-overlap: SKIP (0.000s) [532.621799] [123/130] (517s left) kms_frontbuffer_tracking (psr-2p-rte) [532.703967] Starting subtest: psr-2p-rte [532.705953] Subtest psr-2p-rte: SKIP (0.000s) [532.770567] [124/130] (517s left) kms_content_protection (lic-type-1) [532.887258] Starting subtest: lic-type-1 [536.391406] Subtest lic-type-1: SKIP (3.504s) [537.629566] [125/130] (512s left) kms_pm_rpm (legacy-planes) [539.950666] Starting subtest: legacy-planes [539.952202] Starting dynamic subtest: plane-41 [548.198369] Dynamic subtest plane-41: SUCCESS (8.252s) [548.210819] Starting dynamic subtest: plane-50 [556.536582] Dynamic subtest plane-50: SUCCESS (8.341s) [556.545842] Starting dynamic subtest: plane-59 [564.869995] Dynamic subtest plane-59: SUCCESS (8.334s) [564.879341] Starting dynamic subtest: plane-68 [573.543866] Dynamic subtest plane-68: SUCCESS (8.675s) [573.545526] Subtest legacy-planes: SUCCESS (33.606s) [573.863885] [126/130] (475s left) gem_ctx_persistence (engines-hostile) [573.923474] Starting subtest: engines-hostile [573.924764] Starting dynamic subtest: rcs0 [573.999732] Dynamic subtest rcs0: SUCCESS (0.076s) [574.008698] Starting dynamic subtest: bcs0 [574.107661] Dynamic subtest bcs0: SUCCESS (0.107s) [574.117477] Starting dynamic subtest: vcs0 [574.185702] Dynamic subtest vcs0: SUCCESS (0.077s) [574.193533] Starting dynamic subtest: vcs1 [574.308078] Dynamic subtest vcs1: SUCCESS (0.122s) [574.317200] Starting dynamic subtest: vecs0 [574.392548] Dynamic subtest vecs0: SUCCESS (0.083s) [574.401988] Starting dynamic subtest: ccs0 [574.476138] Dynamic subtest ccs0: SUCCESS (0.083s) [574.477387] Subtest engines-hostile: SUCCESS (0.554s) [574.531857] [127/130] (475s left) kms_chamelium_hpd (common-hpd-after-suspend) [574.896136] Subtest common-hpd-after-suspend: SKIP (0.000s) [575.751916] [128/130] (474s left) api_intel_bb (lot-of-buffers) [575.795643] Starting subtest: lot-of-buffers [576.522737] Subtest lot-of-buffers: SUCCESS (0.726s) [576.788147] [129/130] (473s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [576.835871] Starting subtest: x-tiled-to-vebox-yf-tiled [576.837570] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [576.992823] [130/130] (472s left) gem_userptr_blits (nohangcheck) [577.041268] Starting subtest: nohangcheck [577.260051] Subtest nohangcheck: SUCCESS (0.216s) [577.364333] Closing watchdogs Done.