[40.243349] Initializing watchdogs [40.243413] /dev/watchdog0 [40.250246] [001/130] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [40.350698] Starting subtest: psr-rgb565-draw-render [45.018422] Subtest psr-rgb565-draw-render: SUCCESS (4.671s) [45.119320] [002/130] (955s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [50.280089] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf [50.285215] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [51.167989] [003/130] (949s left) syncobj_timeline (wait-all-interrupted) [51.219081] Starting subtest: wait-all-interrupted [51.320301] Subtest wait-all-interrupted: SUCCESS (0.100s) [51.369827] [004/130] (949s left) vgem_basic (sysfs) [51.438313] Starting subtest: sysfs [51.440235] Subtest sysfs: SUCCESS (0.000s) [51.474927] [005/130] (949s left) dmabuf_sync_file (export-wait-after-attach) [51.507727] Starting subtest: export-wait-after-attach [51.510310] Subtest export-wait-after-attach: SUCCESS (0.000s) [51.536812] [006/130] (949s left) gem_exec_reloc (basic-wc-cpu) [51.586087] Subtest basic-wc-cpu: SKIP (0.000s) [51.629321] [007/130] (949s left) kms_vblank (ts-continuation-idle) [51.712035] Starting subtest: ts-continuation-idle [51.714433] Starting dynamic subtest: pipe-A-eDP-1 [52.103984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s) [52.116853] Starting dynamic subtest: pipe-D-eDP-1 [53.306539] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.183s) [53.309268] Subtest ts-continuation-idle: SUCCESS (1.571s) [54.173373] [008/130] (946s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [54.259813] Starting subtest: random-ccs-data-yf-tiled-ccs [54.262222] Starting dynamic subtest: pipe-A-eDP-1 [54.287217] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [54.292857] Starting dynamic subtest: pipe-B-eDP-1 [54.317544] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [54.323029] Starting dynamic subtest: pipe-C-eDP-1 [54.348118] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [54.353890] Starting dynamic subtest: pipe-D-eDP-1 [54.381939] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [54.386538] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.002s) [56.603643] [009/130] (944s left) kms_addfb_basic (basic-x-tiled-legacy) [56.650385] Starting subtest: basic-x-tiled-legacy [56.655044] Subtest basic-x-tiled-legacy: SKIP (0.000s) [56.769234] [010/130] (944s left) kms_big_fb (y-tiled-32bpp-rotate-0) [56.866484] Starting subtest: y-tiled-32bpp-rotate-0 [56.870685] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [56.936005] [011/130] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [57.024562] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [57.029080] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [57.091959] [012/130] (943s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [57.186714] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [57.191024] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [57.270792] [013/130] (943s left) gem_userptr_blits (coherency-sync) [57.334393] Starting subtest: coherency-sync [57.589428] Subtest coherency-sync: SKIP (0.236s) [57.692202] [014/130] (943s left) gem_exec_fence (syncobj-timeline-invalid-wait) [58.209991] Starting subtest: syncobj-timeline-invalid-wait [58.212706] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [59.448972] [015/130] (941s left) gem_exec_alignment (single) [59.504145] Starting subtest: single [59.506739] Subtest single: SUCCESS (0.003s) [59.602019] [016/130] (941s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [59.692793] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [59.695162] Starting dynamic subtest: pipe-A [60.792933] Dynamic subtest pipe-A: SUCCESS (1.094s) [60.800325] Starting dynamic subtest: pipe-B [63.026227] Dynamic subtest pipe-B: SUCCESS (2.224s) [63.034726] Starting dynamic subtest: pipe-C [64.284251] Dynamic subtest pipe-C: SUCCESS (1.254s) [64.292095] Starting dynamic subtest: pipe-D [65.564490] Dynamic subtest pipe-D: SUCCESS (1.277s) [65.566830] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.849s) [66.782811] [017/130] (934s left) api_intel_allocator (gem-pool) [66.835959] Starting subtest: gem-pool [66.840876] Subtest gem-pool: SUCCESS (0.007s) [66.941301] [018/130] (934s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [67.043688] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [67.048130] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [67.130649] [019/130] (934s left) gem_mmap_offset (bad-extensions) [67.178147] Starting subtest: bad-extensions [67.180759] Subtest bad-extensions: SUCCESS (0.000s) [67.247538] [020/130] (933s left) drm_fdinfo (memory-info-active) [67.280122] Starting subtest: memory-info-active [67.282203] Starting dynamic subtest: smem0 [69.984578] Dynamic subtest smem0: SUCCESS (2.702s) [69.986989] Subtest memory-info-active: SUCCESS (2.702s) [70.033145] [021/130] (931s left) perf_pmu (rc6-all-gts) [70.063723] Starting subtest: rc6-all-gts [76.425187] Subtest rc6-all-gts: SUCCESS (6.353s) [77.283756] [022/130] (923s left) gem_softpin (reverse) [77.333704] Starting subtest: reverse [77.343179] Subtest reverse: SUCCESS (0.009s) [77.444938] [023/130] (923s left) prime_vgem (basic-fence-blt) [77.490559] Starting subtest: basic-fence-blt [77.562240] Subtest basic-fence-blt: SUCCESS (0.071s) [77.649280] [024/130] (923s left) kms_color (ctm-green-to-red) [77.740480] Starting subtest: ctm-green-to-red [77.742537] Starting dynamic subtest: pipe-A-eDP-1 [78.381087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.639s) [78.389938] Starting dynamic subtest: pipe-B-eDP-1 [79.796925] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.415s) [79.804428] Starting dynamic subtest: pipe-C-eDP-1 [81.150301] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.352s) [81.156238] Starting dynamic subtest: pipe-D-eDP-1 [82.493321] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s) [82.496196] Subtest ctm-green-to-red: SUCCESS (4.748s) [83.353168] [025/130] (917s left) gem_exec_schedule (fairslice) [83.429131] Starting subtest: fairslice [83.430992] Starting dynamic subtest: rcs0 [85.439992] Dynamic subtest rcs0: SUCCESS (2.015s) [85.446086] Starting dynamic subtest: bcs0 [87.453509] Dynamic subtest bcs0: SUCCESS (2.013s) [87.463941] Starting dynamic subtest: vcs0 [89.472369] Dynamic subtest vcs0: SUCCESS (2.018s) [89.481083] Starting dynamic subtest: vcs1 [91.487082] Dynamic subtest vcs1: SUCCESS (2.015s) [91.495567] Starting dynamic subtest: vecs0 [93.505709] Dynamic subtest vecs0: SUCCESS (2.017s) [93.513612] Starting dynamic subtest: ccs0 [95.523374] Dynamic subtest ccs0: SUCCESS (2.016s) [95.525548] Subtest fairslice: SUCCESS (12.094s) [95.795150] [026/130] (905s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [95.882713] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [96.723506] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.844s) [96.837181] [027/130] (904s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [96.929670] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [96.934274] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [96.994788] [028/130] (904s left) kms_cursor_crc (cursor-rapid-movement-64x21) [97.149547] Starting subtest: cursor-rapid-movement-64x21 [97.184851] Subtest cursor-rapid-movement-64x21: SKIP (0.030s) [97.388322] [029/130] (903s left) syncobj_timeline (etime-single-wait-submitted) [97.439730] Starting subtest: etime-single-wait-submitted [97.540736] Subtest etime-single-wait-submitted: SUCCESS (0.102s) [97.593462] [030/130] (903s left) debugfs_test (basic-hwmon) [97.650714] Starting subtest: basic-hwmon [97.655044] Subtest basic-hwmon: SKIP (0.000s) [97.736281] [031/130] (903s left) gem_exec_create (basic) [97.794259] Starting subtest: basic [97.796645] Starting dynamic subtest: smem [101.434040] Dynamic subtest smem: SUCCESS (3.637s) [101.436571] Subtest basic: SUCCESS (3.637s) [101.592860] [032/130] (899s left) gem_ppgtt (flink-and-close-vma-leak) [101.637441] Starting subtest: flink-and-close-vma-leak [101.680823] Subtest flink-and-close-vma-leak: SUCCESS (0.044s) [101.786756] [033/130] (899s left) gem_exercise_blt (fast-copy-emit) [101.837690] Starting subtest: fast-copy-emit [101.839971] Starting dynamic subtest: linear-smem-smem-emit [101.860542] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s) [101.866683] Starting dynamic subtest: xmajor-smem-smem-emit [101.879977] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.019s) [101.885829] Starting dynamic subtest: tile4-smem-smem-emit [101.898730] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.019s) [101.904470] Starting dynamic subtest: tile64-smem-smem-emit [101.917778] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.019s) [101.919976] Subtest fast-copy-emit: SUCCESS (0.080s) [102.034413] [034/130] (899s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [102.132100] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [102.136397] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [102.200011] [035/130] (899s left) kms_psr (psr-sprite-plane-move) [102.300720] Starting subtest: psr-sprite-plane-move [102.302904] Starting dynamic subtest: eDP-1 [104.112754] Dynamic subtest eDP-1: SUCCESS (1.809s) [104.115821] Subtest psr-sprite-plane-move: SUCCESS (1.810s) [104.986616] [036/130] (896s left) gem_set_tiling_vs_blt (tiled-to-untiled) [105.040411] Subtest tiled-to-untiled: SKIP (0.000s) [105.085272] [037/130] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [105.176748] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [105.180901] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [105.236412] [038/130] (896s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [105.319720] Starting subtest: plane-scaler-unity-scaling-with-modifiers [105.321967] Starting dynamic subtest: pipe-A [105.660501] Dynamic subtest pipe-A: SUCCESS (0.340s) [105.669232] Starting dynamic subtest: pipe-B [107.128820] Dynamic subtest pipe-B: SUCCESS (1.468s) [107.134770] Starting dynamic subtest: pipe-C [108.601479] Dynamic subtest pipe-C: SUCCESS (1.472s) [108.607572] Starting dynamic subtest: pipe-D [110.071808] Dynamic subtest pipe-D: SUCCESS (1.470s) [110.074073] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.752s) [111.259103] [039/130] (890s left) kms_cursor_crc (cursor-onscreen-128x42) [111.437414] Starting subtest: cursor-onscreen-128x42 [111.474113] Subtest cursor-onscreen-128x42: SKIP (0.032s) [111.640134] [040/130] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [111.736364] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [116.674138] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.939s) [116.762032] [041/130] (884s left) kms_psr (psr2-cursor-plane-move) [116.855985] Starting subtest: psr2-cursor-plane-move [116.858268] Starting dynamic subtest: eDP-1 [118.574150] Dynamic subtest eDP-1: SUCCESS (1.716s) [118.577034] Subtest psr2-cursor-plane-move: SUCCESS (1.716s) [119.451769] [042/130] (882s left) gem_userptr_blits (coherency-unsync) [119.511511] Subtest coherency-unsync: SKIP (0.000s) [119.612168] [043/130] (881s left) gem_ctx_persistence (heartbeat-hang) [119.663214] Starting subtest: heartbeat-hang [119.667644] Subtest heartbeat-hang: SKIP (0.000s) [119.737386] [044/130] (881s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [119.853176] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [119.857968] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [119.941090] [045/130] (881s left) gem_render_copy (linear) [120.003857] Starting subtest: linear [120.006388] Starting dynamic subtest: smem [120.040563] Dynamic subtest smem: SUCCESS (0.037s) [120.042951] Subtest linear: SUCCESS (0.037s) [120.242378] [046/130] (881s left) gem_pwrite (basic-random) [120.296362] Subtest basic-random: SKIP (0.000s) [120.333388] [047/130] (881s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [120.429529] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [120.433999] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [120.502198] [048/130] (881s left) kms_addfb_basic (tile-pitch-mismatch) [120.556757] Starting subtest: tile-pitch-mismatch [120.561218] Subtest tile-pitch-mismatch: SKIP (0.000s) [120.662302] [049/130] (880s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [120.754061] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [125.042339] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.291s) [125.130095] [050/130] (876s left) gem_exec_capture (capture-invisible) [125.184539] Starting subtest: capture-invisible [125.186924] Starting dynamic subtest: smem0 [125.191174] Dynamic subtest smem0: SKIP (0.000s) [125.195309] Subtest capture-invisible: SKIP (0.000s) [125.256966] [051/130] (876s left) kms_getfb (getfb-handle-valid) [125.304210] Starting subtest: getfb-handle-valid [125.306464] Subtest getfb-handle-valid: SUCCESS (0.000s) [125.391751] [052/130] (876s left) kms_dp_aux_dev [125.716489] [053/130] (875s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [125.816694] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [125.821272] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [125.883110] [054/130] (875s left) gem_eio (execbuf) [126.098593] Starting subtest: execbuf [126.430752] Subtest execbuf: SUCCESS (0.329s) [126.522417] [055/130] (875s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [126.616118] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [126.619552] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [126.685489] [056/130] (875s left) gem_exec_params (dr1-dirt) [126.741146] Starting subtest: DR1-dirt [126.743021] Subtest DR1-dirt: SUCCESS (0.000s) [126.815500] [057/130] (874s left) kms_pm_dc (dc5-retention-flops) [126.894946] Starting subtest: dc5-retention-flops [126.899312] Subtest dc5-retention-flops: SKIP (0.000s) [126.945138] [058/130] (874s left) gem_ctx_shared (q-independent) [126.998168] Starting subtest: Q-independent [127.000141] Starting dynamic subtest: rcs0 [127.075730] Dynamic subtest rcs0: SUCCESS (0.077s) [127.084271] Starting dynamic subtest: vcs0 [127.108432] Dynamic subtest vcs0: SUCCESS (0.033s) [127.115222] Starting dynamic subtest: vcs1 [127.148596] Dynamic subtest vcs1: SUCCESS (0.040s) [127.157168] Starting dynamic subtest: vecs0 [127.186558] Dynamic subtest vecs0: SUCCESS (0.038s) [127.193470] Starting dynamic subtest: ccs0 [127.251497] Dynamic subtest ccs0: SUCCESS (0.064s) [127.253698] Subtest Q-independent: SUCCESS (0.253s) [128.461620] [059/130] (873s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [128.547963] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [128.552743] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [129.695210] [060/130] (872s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [129.746830] Starting subtest: multi-wait-available-unsubmitted-signaled [129.749130] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [129.812855] [061/130] (872s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt) [129.913306] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt [134.483791] Subtest psr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.573s) [134.582187] [062/130] (867s left) sysfs_timeslice_duration (timeout) [134.632922] Starting subtest: timeout [134.635752] Starting dynamic subtest: vecs0 [144.387120] Dynamic subtest vecs0: SUCCESS (9.751s) [144.394272] Starting dynamic subtest: ccs0 [145.688808] Dynamic subtest ccs0: SUCCESS (1.302s) [145.698355] Starting dynamic subtest: vcs0 [155.388669] Dynamic subtest vcs0: SUCCESS (9.697s) [155.395804] Starting dynamic subtest: bcs0 [155.974192] Dynamic subtest bcs0: SUCCESS (0.586s) [155.981125] Starting dynamic subtest: rcs0 [157.251910] Dynamic subtest rcs0: SUCCESS (1.280s) [157.260099] Starting dynamic subtest: vcs1 [166.408347] Dynamic subtest vcs1: SUCCESS (9.155s) [166.411635] Subtest timeout: SUCCESS (31.775s) [166.465195] [063/130] (835s left) syncobj_timeline (invalid-transfer-non-existent-point) [166.507626] Starting subtest: invalid-transfer-non-existent-point [166.509908] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [166.582607] [064/130] (835s left) kms_psr (psr-primary-blt) [166.678928] Starting subtest: psr-primary-blt [166.681194] Starting dynamic subtest: eDP-1 [168.453132] Dynamic subtest eDP-1: SUCCESS (1.773s) [168.455579] Subtest psr-primary-blt: SUCCESS (1.773s) [169.372321] [065/130] (832s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [174.521366] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [174.524063] Starting dynamic subtest: pipe-A-eDP-1 [175.359076] Dynamic subtest pipe-A-eDP-1: SKIP (0.834s) [175.366229] Starting dynamic subtest: pipe-B-eDP-1 [176.577068] Dynamic subtest pipe-B-eDP-1: SKIP (1.216s) [176.581409] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (2.053s) [177.820373] [066/130] (824s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [177.917034] Starting subtest: yf-tiled-32bpp-rotate-90 [177.921295] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [177.980881] [067/130] (823s left) gem_ccs (block-multicopy-inplace) [178.031151] Starting subtest: block-multicopy-inplace [178.035908] Subtest block-multicopy-inplace: SKIP (0.000s) [178.130123] [068/130] (823s left) gem_ctx_engines (invalid-engines) [178.177690] Starting subtest: invalid-engines [178.184039] Subtest invalid-engines: SUCCESS (0.006s) [178.393759] [069/130] (823s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [178.506164] Starting subtest: basic-busy-flip-before-cursor-atomic [178.510548] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [178.583344] [070/130] (823s left) gem_userptr_blits (stress-mm-invalidate-close) [178.644600] Starting subtest: stress-mm-invalidate-close [180.791624] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [180.882756] [071/130] (821s left) kms_content_protection (dp-mst-type-0) [181.010730] Starting subtest: dp-mst-type-0 [181.015391] Subtest dp-mst-type-0: SKIP (0.000s) [181.119843] [072/130] (820s left) kms_big_fb (y-tiled-64bpp-rotate-90) [181.210407] Starting subtest: y-tiled-64bpp-rotate-90 [181.214548] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [181.280187] [073/130] (820s left) kms_psr (fbc-psr2-sprite-plane-move) [181.368853] Starting subtest: fbc-psr2-sprite-plane-move [181.371095] Starting dynamic subtest: eDP-1 [181.375225] Dynamic subtest eDP-1: SKIP (0.000s) [181.379278] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s) [181.417231] [074/130] (820s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [186.552349] Starting subtest: psr2-plane-move-sf-dmg-area [186.554642] Starting dynamic subtest: pipe-A-eDP-1 [191.934867] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.381s) [191.942988] Starting dynamic subtest: pipe-B-eDP-1 [197.309183] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.373s) [197.311747] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.757s) [198.174556] [075/130] (803s left) kms_pm_rpm (pm-caching) [199.591159] Starting subtest: pm-caching [199.597639] Subtest pm-caching: SKIP (0.000s) [199.911893] [076/130] (802s left) i915_pm_rps (thresholds-idle-park) [199.955595] Starting subtest: thresholds-idle-park [199.960963] Subtest thresholds-idle-park: SKIP (0.000s) [200.018996] [077/130] (802s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [200.108061] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [202.939626] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.835s) [203.038895] [078/130] (799s left) kms_cursor_edge_walk (64x64-top-edge) [203.118947] Starting subtest: 64x64-top-edge [203.121060] Starting dynamic subtest: pipe-A-eDP-1 [206.650837] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.530s) [206.661370] Starting dynamic subtest: pipe-D-eDP-1 [209.843970] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.192s) [209.846640] Subtest 64x64-top-edge: SUCCESS (6.724s) [210.717689] [079/130] (791s left) gem_exec_balancer (full-pulse) [210.771568] Starting subtest: full-pulse [214.891949] Subtest full-pulse: SUCCESS (4.120s) [215.118944] [080/130] (786s left) gem_exec_fence (concurrent) [215.287982] Starting subtest: concurrent [215.293080] Subtest concurrent: SKIP (0.000s) [217.473421] [081/130] (784s left) i915_pciid [217.583737] [082/130] (784s left) gem_lmem_swapping (parallel-random-engines) [217.612814] Subtest parallel-random-engines: SKIP (0.000s) [217.634600] [083/130] (784s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [217.719776] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [217.722146] Starting dynamic subtest: pipe-A-eDP-1 [217.744368] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [217.751833] Starting dynamic subtest: pipe-B-eDP-1 [217.775042] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [217.780893] Starting dynamic subtest: pipe-C-eDP-1 [217.804058] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [217.810093] Starting dynamic subtest: pipe-D-eDP-1 [217.834339] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [217.838991] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [220.058978] [084/130] (782s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [220.173528] Starting subtest: 2x-flip-vs-cursor-legacy [220.177971] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.003s) [220.262259] [085/130] (781s left) kms_flip (2x-flip-vs-panning-vs-hang) [220.361142] Starting subtest: 2x-flip-vs-panning-vs-hang [220.375053] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.014s) [220.426498] [086/130] (781s left) gem_userptr_blits (mmap-offset-banned) [220.487704] Starting subtest: mmap-offset-banned [220.490071] Starting dynamic subtest: wb [220.491996] Dynamic subtest wb: SUCCESS (0.000s) [220.498396] Starting dynamic subtest: wc [220.500622] Dynamic subtest wc: SUCCESS (0.000s) [220.506480] Starting dynamic subtest: uc [220.508870] Dynamic subtest uc: SUCCESS (0.000s) [220.511110] Subtest mmap-offset-banned: SUCCESS (0.001s) [220.592183] [087/130] (781s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [220.684042] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [220.688539] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [220.766165] [088/130] (781s left) kms_plane (pixel-format-source-clamping) [220.847821] Starting subtest: pixel-format-source-clamping [220.877295] Starting dynamic subtest: pipe-A-plane-0 [225.499088] Dynamic subtest pipe-A-plane-0: SUCCESS (4.622s) [225.505766] Starting dynamic subtest: pipe-A-plane-3 [228.010605] Dynamic subtest pipe-A-plane-3: SUCCESS (2.511s) [228.019030] Starting dynamic subtest: pipe-A-plane-5 [228.020696] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s) [229.191604] Starting dynamic subtest: pipe-B-plane-0 [233.719505] Dynamic subtest pipe-B-plane-0: SUCCESS (4.533s) [233.726701] Starting dynamic subtest: pipe-B-plane-3 [236.220393] Dynamic subtest pipe-B-plane-3: SUCCESS (2.500s) [236.227746] Starting dynamic subtest: pipe-B-plane-5 [236.229459] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s) [236.527810] Subtest pixel-format-source-clamping: SUCCESS (15.677s) [237.404845] [089/130] (764s left) kms_vblank (query-forked-busy) [237.498919] Starting subtest: query-forked-busy [237.501220] Starting dynamic subtest: pipe-A-eDP-1 [239.375226] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [239.389570] Starting dynamic subtest: pipe-D-eDP-1 [242.045416] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.666s) [242.048078] Subtest query-forked-busy: SUCCESS (4.543s) [242.909154] [090/130] (759s left) gem_eio (in-flight-1us) [243.118854] Starting subtest: in-flight-1us [251.167806] Subtest in-flight-1us: SUCCESS (8.048s) [251.264679] [091/130] (751s left) kms_addfb_basic (invalid-set-prop-any) [251.312146] Starting subtest: invalid-set-prop-any [251.314120] Subtest invalid-set-prop-any: SUCCESS (0.000s) [251.422389] [092/130] (750s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [251.509892] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [251.512185] Starting dynamic subtest: pipe-A-eDP-1 [251.535105] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [251.543577] Starting dynamic subtest: pipe-B-eDP-1 [251.565636] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [251.572561] Starting dynamic subtest: pipe-C-eDP-1 [251.594593] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [251.601238] Starting dynamic subtest: pipe-D-eDP-1 [251.623606] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [251.627703] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s) [253.857759] [093/130] (748s left) i915_pipe_stress (stress-xrgb8888-untiled) [253.954900] Starting subtest: stress-xrgb8888-untiled [259.982569] Subtest stress-xrgb8888-untiled: SUCCESS (6.029s) [260.005797] [094/130] (742s left) kms_chamelium_frames (hdmi-crc-multiple) [260.386320] Subtest hdmi-crc-multiple: SKIP (0.000s) [261.255025] [095/130] (741s left) gen9_exec_parse (batch-invalid-length) [261.310383] Subtest batch-invalid-length: SKIP (0.000s) [261.354089] [096/130] (741s left) kms_chamelium_hpd (dp-hpd-fast) [261.733893] Subtest dp-hpd-fast: SKIP (0.000s) [262.601835] [097/130] (739s left) kms_invalid_mode (bad-htotal) [262.698732] Starting subtest: bad-htotal [262.701353] Starting dynamic subtest: pipe-A-eDP-1 [262.976929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.279s) [262.986988] Starting dynamic subtest: pipe-B-eDP-1 [262.989625] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [262.996569] Starting dynamic subtest: pipe-C-eDP-1 [262.999050] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [263.005794] Starting dynamic subtest: pipe-D-eDP-1 [263.008206] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [263.010536] Subtest bad-htotal: SUCCESS (0.283s) [263.837268] [098/130] (738s left) gem_exec_schedule (preempt-queue-chain) [263.902547] Subtest preempt-queue-chain: SKIP (0.000s) [264.164070] [099/130] (738s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [264.245274] Starting subtest: 2x-wf_vblank-ts-check-interruptible [264.261861] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.014s) [264.313853] [100/130] (738s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [264.403163] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [264.405669] Starting dynamic subtest: pipe-A-default-mode [264.687679] Dynamic subtest pipe-A-default-mode: SKIP (0.280s) [264.692960] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.281s) [265.570048] [101/130] (736s left) syncobj_wait (wait-any-snapshot) [265.610579] Starting subtest: wait-any-snapshot [265.694148] Subtest wait-any-snapshot: SUCCESS (0.082s) [265.747416] [102/130] (736s left) gem_exec_reloc (basic-write-read) [265.794609] Subtest basic-write-read: SKIP (0.000s) [265.818428] [103/130] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [265.912562] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [270.941231] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.033s) [271.064206] [104/130] (731s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [271.149959] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [271.695168] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.547s) [271.822316] [105/130] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [271.908763] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [271.912731] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [271.974520] [106/130] (730s left) kms_cursor_crc (cursor-size-change) [272.060975] Starting subtest: cursor-size-change [272.063316] Starting dynamic subtest: pipe-A-eDP-1 [272.812663] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.749s) [272.821341] Starting dynamic subtest: pipe-D-eDP-1 [274.318829] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s) [274.321857] Subtest cursor-size-change: SUCCESS (2.255s) [275.179256] [107/130] (727s left) kms_frontbuffer_tracking (psr-suspend) [275.285770] Starting subtest: psr-suspend [311.029332] Subtest psr-suspend: SUCCESS (5.294s) [311.134002] [108/130] (721s left) kms_flip (2x-flip-vs-fences) [311.220666] Starting subtest: 2x-flip-vs-fences [311.225096] Subtest 2x-flip-vs-fences: SKIP (0.000s) [311.318975] [109/130] (721s left) gem_exec_schedule (u-semaphore-user) [311.383580] Starting subtest: u-semaphore-user [311.429226] Subtest u-semaphore-user: SUCCESS (0.054s) [312.807503] [110/130] (720s left) kms_getfb (getfb-handle-closed) [312.853979] Starting subtest: getfb-handle-closed [312.856225] Subtest getfb-handle-closed: SUCCESS (0.000s) [312.929728] [111/130] (720s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [313.016717] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [313.018997] Starting dynamic subtest: pipe-A-default-mode [313.295349] Dynamic subtest pipe-A-default-mode: SKIP (0.268s) [313.300266] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.269s) [314.173781] [112/130] (718s left) prime_mmap (test_errors) [314.219798] Starting subtest: test_errors [314.222029] Starting dynamic subtest: test_errors-smem [314.290845] Dynamic subtest test_errors-smem: SUCCESS (0.071s) [314.293592] Subtest test_errors: SUCCESS (0.072s) [314.361909] [113/130] (718s left) gem_eio (create-ext) [314.593450] Starting subtest: create-ext [314.921855] Subtest create-ext: SUCCESS (0.325s) [315.015763] [114/130] (718s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [315.101587] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [315.105107] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [315.189642] [115/130] (718s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [315.273151] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [315.277268] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [316.475789] [116/130] (716s left) kms_psr (fbc-psr-sprite-plane-onoff) [316.559699] Starting subtest: fbc-psr-sprite-plane-onoff [316.562070] Starting dynamic subtest: eDP-1 [316.566553] Dynamic subtest eDP-1: SKIP (0.000s) [316.571104] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s) [316.612833] [117/130] (716s left) kms_lease (master-vs-lease) [316.702572] Starting subtest: master-vs-lease [316.704995] Subtest master-vs-lease: SUCCESS (0.001s) [316.779940] [118/130] (716s left) kms_big_fb (4-tiled-16bpp-rotate-180) [316.861537] Starting subtest: 4-tiled-16bpp-rotate-180 [317.917820] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.044s) [318.031058] [119/130] (715s left) syncobj_eventfd (binary-wait) [318.085467] Starting subtest: binary-wait [318.093697] Subtest binary-wait: SUCCESS (0.010s) [318.159111] [120/130] (715s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [318.249254] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [318.251135] Starting dynamic subtest: pipe-A-eDP-1 [319.658112] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.391s) [319.936553] Starting dynamic subtest: pipe-B-eDP-1 [321.067101] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s) [321.338663] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (3.056s) [322.237672] [121/130] (711s left) perf (non-zero-reason) [322.371816] Starting subtest: non-zero-reason [322.374197] Starting dynamic subtest: 0-rcs0 [328.062116] Dynamic subtest 0-rcs0: SUCCESS (5.662s) [328.074750] Starting dynamic subtest: 1-vcs0 [332.082016] Dynamic subtest 1-vcs0: SUCCESS (4.008s) [332.085563] Subtest non-zero-reason: SUCCESS (9.671s) [332.111717] [122/130] (701s left) gem_exec_nop (basic-series) [332.187390] Starting subtest: basic-series [348.822813] Subtest basic-series: SUCCESS (16.641s) [349.035893] [123/130] (684s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [349.078382] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [349.082811] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [349.238433] [124/130] (684s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [349.336398] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [350.222393] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (0.888s) [350.324748] [125/130] (683s left) gem_pxp (protected-raw-src-copy-not-readible) [352.906773] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s) [352.955123] [126/130] (680s left) gem_mmap (big-bo) [353.007714] Subtest big-bo: SKIP (0.000s) [353.046316] [127/130] (680s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [353.148458] Starting subtest: fbcpsr-farfromfence-mmap-gtt [353.153025] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [353.217126] [128/130] (680s left) prime_mmap (test_correct_cpu_write) [353.270414] Starting subtest: test_correct_cpu_write [353.272905] Starting dynamic subtest: test_correct_cpu_write-smem [353.275338] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [353.277726] Subtest test_correct_cpu_write: SUCCESS (0.001s) [353.357635] [129/130] (680s left) gem_readwrite (beyond-eob) [353.407488] Subtest beyond-EOB: SKIP (0.000s) [353.446830] [130/130] (680s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [353.532183] Starting subtest: compare-crc-sanitycheck-nv12 [353.534913] Starting dynamic subtest: pipe-A-eDP-1 [354.183801] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.651s) [354.192649] Starting dynamic subtest: pipe-B-eDP-1 [355.472810] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.287s) [355.482456] Starting dynamic subtest: pipe-C-eDP-1 [356.727586] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.253s) [356.737532] Starting dynamic subtest: pipe-D-eDP-1 [357.980585] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.256s) [357.982827] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.450s) [358.901535] Closing watchdogs Done.