[41.049290] Initializing watchdogs [41.049319] /dev/watchdog0 [41.055341] [001/129] (960s left) intel_hwmon (hwmon-write) [41.137323] Subtest hwmon-write: SKIP (0.000s) [41.174567] [002/129] (960s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [41.281096] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [71.379176] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (29.877s) [72.264978] [003/129] (929s left) gem_pread (self) [72.323370] Subtest self: SKIP (0.000s) [72.352425] [004/129] (929s left) gem_create (create-ext-cpu-access-big) [72.506313] Starting subtest: create-ext-cpu-access-big [72.511848] Subtest create-ext-cpu-access-big: SKIP (0.001s) [72.555614] [005/129] (929s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [77.684062] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [77.686688] Starting dynamic subtest: pipe-A-eDP-1 [84.450703] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.762s) [84.459304] Starting dynamic subtest: pipe-B-eDP-1 [91.168923] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.715s) [91.171998] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.480s) [92.041711] [006/129] (909s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [92.096543] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [92.101934] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [92.252789] [007/129] (909s left) gen9_exec_parse (valid-registers) [92.309914] Subtest valid-registers: SKIP (0.000s) [92.345832] [008/129] (909s left) gem_mmap_offset (bad-object) [92.393549] Starting subtest: bad-object [92.395928] Subtest bad-object: SUCCESS (0.001s) [92.446123] [009/129] (909s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [92.545846] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [92.548417] Starting dynamic subtest: pipe-A [92.610978] Dynamic subtest pipe-A: SUCCESS (0.065s) [92.617676] Starting dynamic subtest: pipe-B [93.852929] Dynamic subtest pipe-B: SUCCESS (1.241s) [93.861675] Starting dynamic subtest: pipe-C [95.047905] Dynamic subtest pipe-C: SUCCESS (1.195s) [95.053521] Starting dynamic subtest: pipe-D [96.263660] Dynamic subtest pipe-D: SUCCESS (1.216s) [96.266064] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.717s) [97.481160] [010/129] (904s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [97.568741] Starting subtest: bad-rotation-90-yf-tiled-ccs [97.571110] Starting dynamic subtest: pipe-A-eDP-1 [97.593255] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [97.598199] Starting dynamic subtest: pipe-B-eDP-1 [97.623175] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [97.629668] Starting dynamic subtest: pipe-C-eDP-1 [97.653426] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [97.658612] Starting dynamic subtest: pipe-D-eDP-1 [97.681596] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [97.685972] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.002s) [97.698626] [011/129] (904s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [97.790971] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [97.795781] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [97.864667] [012/129] (904s left) syncobj_wait (multi-wait-submitted) [97.906231] Starting subtest: multi-wait-submitted [98.011992] Subtest multi-wait-submitted: SUCCESS (0.106s) [98.059842] [013/129] (903s left) kms_big_fb (4-tiled-addfb-size-overflow) [98.152469] Starting subtest: 4-tiled-addfb-size-overflow [98.154618] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [98.213344] [014/129] (903s left) gem_userptr_blits (create-destroy-unsync) [98.259792] Subtest create-destroy-unsync: SKIP (0.000s) [98.350990] [015/129] (903s left) gem_eio (create-ext) [98.530807] Starting subtest: create-ext [98.807458] Subtest create-ext: SUCCESS (0.275s) [98.896176] [016/129] (903s left) gem_exec_params (batch-first) [98.944686] Starting subtest: batch-first [98.947939] Subtest batch-first: SUCCESS (0.006s) [99.025488] [017/129] (902s left) kms_cursor_crc (cursor-random-128x128) [99.185827] Starting subtest: cursor-random-128x128 [99.190105] Starting dynamic subtest: pipe-A-eDP-1 [102.474041] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.284s) [102.493929] Starting dynamic subtest: pipe-D-eDP-1 [106.531791] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.043s) [106.534463] Subtest cursor-random-128x128: SUCCESS (7.343s) [107.392110] [018/129] (894s left) syncobj_wait (invalid-wait-zero-handles) [107.435720] Starting subtest: invalid-wait-zero-handles [107.494080] Subtest invalid-wait-zero-handles: FAIL (0.007s) [107.506482] [019/129] (894s left) syncobj_wait (wait-any-complex) [107.566457] Starting subtest: wait-any-complex [107.627241] Subtest wait-any-complex: SUCCESS (0.062s) [107.676262] [020/129] (894s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [107.767729] Starting subtest: primary-y-tiled-reflect-x-90 [107.771927] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [107.817771] [021/129] (894s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [107.907793] Starting subtest: fbc-dirtyfb-ioctl [107.910075] Starting dynamic subtest: A-eDP-1 [109.449966] Dynamic subtest A-eDP-1: SUCCESS (1.539s) [109.452340] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.540s) [110.343461] [022/129] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [110.457211] Starting subtest: basic-busy-flip-before-cursor-atomic [110.461824] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [110.544723] [023/129] (891s left) prime_mmap_coherency (write) [110.597169] Starting subtest: write [115.975503] Subtest write: SUCCESS (5.378s) [116.189737] [024/129] (885s left) kms_pm_rpm (drm-resources-equal) [117.509849] Starting subtest: drm-resources-equal [123.055550] Subtest drm-resources-equal: SUCCESS (5.546s) [123.116142] [025/129] (878s left) kms_fbcon_fbt (fbc) [123.171785] Starting subtest: fbc [128.647477] Subtest fbc: SUCCESS (5.474s) [128.699577] [026/129] (873s left) gem_exec_balancer (parallel-keep-submit-fence) [128.905055] Starting subtest: parallel-keep-submit-fence [129.755271] Subtest parallel-keep-submit-fence: SUCCESS (0.850s) [129.837498] [027/129] (872s left) gem_workarounds (reset) [129.894851] Starting subtest: reset [130.070053] Subtest reset: SUCCESS (0.175s) [130.169347] [028/129] (871s left) syncobj_wait (multi-wait-all-submitted-signaled) [130.211745] Starting subtest: multi-wait-all-submitted-signaled [130.316063] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s) [130.367142] [029/129] (871s left) kms_chamelium_hpd (vga-hpd-after-suspend) [130.748801] Subtest vga-hpd-after-suspend: SKIP (0.000s) [131.637424] [030/129] (870s left) kms_psr (fbc-psr-primary-mmap-gtt) [131.732891] Starting subtest: fbc-psr-primary-mmap-gtt [131.735338] Starting dynamic subtest: eDP-1 [131.739847] Dynamic subtest eDP-1: SKIP (0.000s) [131.744329] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [131.779695] [031/129] (870s left) gem_reg_read (timestamp-moving) [131.815445] Starting subtest: timestamp-moving [132.814972] Subtest timestamp-moving: SUCCESS (1.001s) [132.869188] [032/129] (869s left) gem_mmap_gtt (basic-read) [132.919211] Subtest basic-read: SKIP (0.000s) [132.960267] [033/129] (869s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [133.049873] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [133.052181] Starting dynamic subtest: pipe-A-default-mode [135.870273] Dynamic subtest pipe-A-default-mode: SUCCESS (2.818s) [135.873151] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.819s) [136.782051] [034/129] (865s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [136.876107] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [141.717796] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.846s) [141.834111] [035/129] (860s left) gem_ctx_persistence (saturated-hostile-nopreempt) [141.896031] Starting subtest: saturated-hostile-nopreempt [141.898568] Starting dynamic subtest: rcs0 [141.971593] Dynamic subtest rcs0: SKIP (0.073s) [141.979649] Starting dynamic subtest: bcs0 [141.988617] Dynamic subtest bcs0: SKIP (0.017s) [141.994239] Starting dynamic subtest: vcs0 [142.012637] Dynamic subtest vcs0: SKIP (0.024s) [142.018573] Starting dynamic subtest: vcs1 [142.026533] Dynamic subtest vcs1: SKIP (0.014s) [142.032015] Starting dynamic subtest: vecs0 [142.050522] Dynamic subtest vecs0: SKIP (0.024s) [142.056564] Starting dynamic subtest: ccs0 [142.068512] Dynamic subtest ccs0: SKIP (0.018s) [142.073051] Subtest saturated-hostile-nopreempt: SKIP (0.171s) [142.121311] [036/129] (860s left) gem_exec_balancer (sequential) [142.167663] Starting subtest: sequential [144.824685] Subtest sequential: SUCCESS (2.657s) [145.057329] [037/129] (857s left) kms_getfb (getfb2-into-addfb2) [145.098843] Starting subtest: getfb2-into-addfb2 [145.101499] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [145.157289] [038/129] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [145.248430] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [145.252900] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [145.315519] [039/129] (856s left) kms_psr (psr2-basic) [145.398394] Starting subtest: psr2-basic [145.400709] Starting dynamic subtest: eDP-1 [147.055196] Dynamic subtest eDP-1: SUCCESS (1.652s) [147.058148] Subtest psr2-basic: SUCCESS (1.653s) [147.913621] [040/129] (854s left) gem_exec_reloc (basic-wc-read-active) [147.973032] Subtest basic-wc-read-active: SKIP (0.000s) [148.015367] [041/129] (854s left) kms_draw_crc (draw-method-blt) [148.107242] Starting subtest: draw-method-blt [148.109164] Starting dynamic subtest: xrgb8888-untiled [148.304737] Dynamic subtest xrgb8888-untiled: SUCCESS (0.200s) [148.311292] Starting dynamic subtest: rgb565-untiled [148.481995] Dynamic subtest rgb565-untiled: SUCCESS (0.177s) [148.489383] Starting dynamic subtest: xrgb2101010-untiled [148.660031] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.178s) [148.666921] Starting dynamic subtest: xrgb8888-xtiled [148.771107] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s) [148.778621] Starting dynamic subtest: rgb565-xtiled [148.882078] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s) [148.888997] Starting dynamic subtest: xrgb2101010-xtiled [148.970997] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.088s) [148.977552] Starting dynamic subtest: xrgb8888-4tiled [149.070962] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.100s) [149.076855] Starting dynamic subtest: rgb565-4tiled [149.159520] Dynamic subtest rgb565-4tiled: SUCCESS (0.089s) [149.166276] Starting dynamic subtest: xrgb2101010-4tiled [149.249596] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.089s) [149.251687] Subtest draw-method-blt: SUCCESS (1.145s) [149.351186] [042/129] (852s left) gem_lmem_swapping (verify-ccs) [149.384496] Subtest verify-ccs: SKIP (0.000s) [149.403337] [043/129] (852s left) gem_linear_blits (normal) [149.728861] Starting subtest: normal [152.134653] Subtest normal: SUCCESS (2.404s) [152.222253] [044/129] (850s left) kms_lease (master-vs-lease) [152.354965] Starting subtest: master-vs-lease [152.357265] Subtest master-vs-lease: SUCCESS (0.001s) [152.437825] [045/129] (849s left) gem_userptr_blits (unsync-unmap) [152.504615] Subtest unsync-unmap: SKIP (0.000s) [152.622058] [046/129] (849s left) vgem_basic (sysfs) [152.722169] Starting subtest: sysfs [152.724239] Subtest sysfs: SUCCESS (0.000s) [152.756662] [047/129] (849s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [152.849705] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [152.853775] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [152.915473] [048/129] (849s left) i915_pm_rpm (sysfs-read) [154.544179] Starting subtest: sysfs-read [155.708535] Subtest sysfs-read: SUCCESS (1.160s) [156.027804] [049/129] (846s left) gem_exec_capture (userptr) [156.080779] Starting subtest: userptr [156.911653] Subtest userptr: SUCCESS (0.829s) [157.010152] [050/129] (845s left) gem_lmem_swapping (basic) [157.047491] Subtest basic: SKIP (0.000s) [157.071931] [051/129] (845s left) perf (stress-open-close) [157.204387] Starting subtest: stress-open-close [157.206807] Starting dynamic subtest: 0-rcs0 [159.371807] Dynamic subtest 0-rcs0: SUCCESS (2.168s) [159.380821] Starting dynamic subtest: 1-vecs0 [161.534594] Dynamic subtest 1-vecs0: SUCCESS (2.162s) [161.536407] Subtest stress-open-close: SUCCESS (4.331s) [161.551231] [052/129] (840s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [161.674852] Starting subtest: 2x-long-cursor-vs-flip-atomic [161.678823] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [161.760728] [053/129] (840s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [161.853836] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [166.433910] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.582s) [166.521061] [054/129] (835s left) gem_ctx_bad_destroy (invalid-pad) [166.565281] Starting subtest: invalid-pad [166.568177] Subtest invalid-pad: SUCCESS (0.000s) [166.611620] [055/129] (835s left) perf (create-destroy-userspace-config) [166.689713] Starting subtest: create-destroy-userspace-config [166.705904] Subtest create-destroy-userspace-config: SUCCESS (0.014s) [166.720883] [056/129] (835s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [166.809172] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [166.824772] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.014s) [166.876266] [057/129] (835s left) kms_chamelium_edid (dp-edid-read) [167.243694] Subtest dp-edid-read: SKIP (0.000s) [168.121800] [058/129] (834s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [173.242549] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [173.245511] Starting dynamic subtest: pipe-A-eDP-1 [180.150857] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.908s) [180.161289] Starting dynamic subtest: pipe-B-eDP-1 [187.085234] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.934s) [187.087710] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.845s) [187.946112] [059/129] (814s left) kms_atomic_interruptible (legacy-cursor) [188.046226] Starting subtest: legacy-cursor [188.048560] Starting dynamic subtest: pipe-A-eDP-1 [195.504371] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.457s) [195.507054] Subtest legacy-cursor: SUCCESS (7.458s) [196.361517] [060/129] (806s left) kms_psr (fbc-psr2-sprite-plane-onoff) [196.447911] Starting subtest: fbc-psr2-sprite-plane-onoff [196.450240] Starting dynamic subtest: eDP-1 [196.454779] Dynamic subtest eDP-1: SKIP (0.000s) [196.459238] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [196.498723] [061/129] (806s left) prime_mmap (test_dup) [196.545668] Starting subtest: test_dup [196.547573] Starting dynamic subtest: test_dup-smem [196.567877] Dynamic subtest test_dup-smem: SUCCESS (0.023s) [196.570514] Subtest test_dup: SUCCESS (0.024s) [196.616354] [062/129] (806s left) kms_cursor_crc (cursor-rapid-movement-64x21) [196.769606] Starting subtest: cursor-rapid-movement-64x21 [196.801799] Subtest cursor-rapid-movement-64x21: SKIP (0.028s) [196.988107] [063/129] (805s left) syncobj_timeline (invalid-wait-bad-flags) [197.040769] Starting subtest: invalid-wait-bad-flags [197.043218] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [197.115199] [064/129] (805s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [197.203859] Starting subtest: crc-primary-basic-y-tiled-ccs [197.206153] Starting dynamic subtest: pipe-A-eDP-1 [197.228857] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [197.235676] Starting dynamic subtest: pipe-B-eDP-1 [197.257586] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [197.264171] Starting dynamic subtest: pipe-C-eDP-1 [197.286187] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [197.292236] Starting dynamic subtest: pipe-D-eDP-1 [197.314411] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [197.318810] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s) [197.331945] [065/129] (805s left) drm_fdinfo (busy) [197.369633] Starting subtest: busy [197.371589] Starting dynamic subtest: rcs0 [197.383261] Dynamic subtest rcs0: SKIP (0.011s) [197.390531] Starting dynamic subtest: bcs0 [197.394364] Dynamic subtest bcs0: SKIP (0.011s) [197.401679] Starting dynamic subtest: vcs0 [197.405173] Dynamic subtest vcs0: SKIP (0.000s) [197.413721] Starting dynamic subtest: vcs1 [197.417635] Dynamic subtest vcs1: SKIP (0.000s) [197.423818] Starting dynamic subtest: vecs0 [197.428057] Dynamic subtest vecs0: SKIP (0.000s) [197.433877] Starting dynamic subtest: ccs0 [197.437938] Dynamic subtest ccs0: SKIP (0.000s) [197.442035] Subtest busy: SKIP (0.025s) [197.454132] [066/129] (805s left) gem_exec_reloc (basic-range-active) [197.500198] Subtest basic-range-active: SKIP (0.000s) [197.542346] [067/129] (805s left) kms_cursor_crc (cursor-offscreen-256x85) [197.745588] Starting subtest: cursor-offscreen-256x85 [197.778940] Subtest cursor-offscreen-256x85: SKIP (0.028s) [197.919925] [068/129] (804s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [198.005793] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [198.007754] Starting dynamic subtest: pipe-A-eDP-1 [198.055437] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [198.063152] Starting dynamic subtest: pipe-B-eDP-1 [198.111272] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [198.118298] Starting dynamic subtest: pipe-C-eDP-1 [198.166102] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [198.173136] Starting dynamic subtest: pipe-D-eDP-1 [198.220837] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [198.224634] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.006s) [198.238834] [069/129] (804s left) i915_query (engine-info-invalid) [198.280642] Starting subtest: engine-info-invalid [198.282633] Subtest engine-info-invalid: SUCCESS (0.000s) [198.337423] [070/129] (804s left) kms_vrr (max-min) [198.432424] Starting subtest: max-min [198.438047] Subtest max-min: SKIP (0.000s) [198.479792] [071/129] (804s left) perf_pmu (render-node-busy-idle) [198.551543] Starting subtest: render-node-busy-idle [198.553847] Starting dynamic subtest: rcs0 [199.248927] Dynamic subtest rcs0: SUCCESS (0.696s) [199.258056] Starting dynamic subtest: bcs0 [199.911319] Dynamic subtest bcs0: SUCCESS (0.661s) [199.920527] Starting dynamic subtest: vcs0 [201.384466] Dynamic subtest vcs0: SUCCESS (1.471s) [201.393364] Starting dynamic subtest: vcs1 [202.077355] Dynamic subtest vcs1: FAIL (0.636s) [202.085135] Starting dynamic subtest: vecs0 [205.352557] Dynamic subtest vecs0: SUCCESS (3.329s) [205.363092] Starting dynamic subtest: ccs0 [206.027218] Dynamic subtest ccs0: SUCCESS (0.674s) [206.030155] Subtest render-node-busy-idle: FAIL (7.473s) [206.078779] [072/129] (796s left) kms_color (ctm-signed) [206.184072] Starting subtest: ctm-signed [206.186340] Starting dynamic subtest: pipe-A-eDP-1 [208.267213] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.081s) [208.276957] Starting dynamic subtest: pipe-B-eDP-1 [211.085257] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.817s) [211.092291] Starting dynamic subtest: pipe-C-eDP-1 [213.785499] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.697s) [213.793535] Starting dynamic subtest: pipe-D-eDP-1 [216.480758] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.695s) [216.483093] Subtest ctm-signed: SUCCESS (10.294s) [217.352933] [073/129] (785s left) kms_sequence (queue-busy) [217.446738] Starting subtest: queue-busy [217.449018] Starting dynamic subtest: pipe-A-eDP-1 [219.343057] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.894s) [219.351163] Starting dynamic subtest: pipe-B-eDP-1 [222.004461] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.658s) [222.011025] Starting dynamic subtest: pipe-C-eDP-1 [224.693842] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.688s) [224.700259] Starting dynamic subtest: pipe-D-eDP-1 [227.373411] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.677s) [227.376249] Subtest queue-busy: SUCCESS (9.922s) [228.234967] [074/129] (774s left) kms_prime (basic-crc-vgem) [228.915217] Starting subtest: basic-crc-vgem [228.917529] Starting dynamic subtest: second-to-first [229.748050] Dynamic subtest second-to-first: SUCCESS (0.837s) [229.750184] Subtest basic-crc-vgem: SUCCESS (0.838s) [229.808223] [075/129] (773s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [229.891596] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [230.725241] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.832s) [230.823925] [076/129] (772s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [230.872508] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [230.919969] [077/129] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [231.009691] Starting subtest: psr-2p-scndscrn-cur-indfb-move [231.014699] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [231.067347] [078/129] (771s left) kms_psr (psr-primary-blt) [231.145487] Starting subtest: psr-primary-blt [231.147479] Starting dynamic subtest: eDP-1 [232.951100] Dynamic subtest eDP-1: SUCCESS (1.803s) [232.953538] Subtest psr-primary-blt: SUCCESS (1.804s) [233.864024] [079/129] (769s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [233.909115] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [234.012164] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [234.063893] [080/129] (768s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [234.162661] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [239.042517] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.883s) [239.151772] [081/129] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [239.249777] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [239.253925] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [239.319805] [082/129] (763s left) gem_sync (basic-all) [239.387493] Starting subtest: basic-all [243.369734] Subtest basic-all: SUCCESS (3.996s) [243.528704] [083/129] (759s left) gem_ccs (ctrl-surf-copy-new-ctx) [243.582968] Starting subtest: ctrl-surf-copy-new-ctx [243.587632] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [243.676019] [084/129] (759s left) syncobj_wait (reset-multiple-signaled) [243.729356] Starting subtest: reset-multiple-signaled [243.731727] Subtest reset-multiple-signaled: SUCCESS (0.000s) [243.818842] [085/129] (759s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [243.924589] Starting subtest: fbcpsr-farfromfence-mmap-gtt [243.929130] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [243.995609] [086/129] (758s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [244.086999] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [244.091313] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [244.153225] [087/129] (758s left) gem_exec_schedule (semaphore-user) [244.221444] Starting subtest: semaphore-user [244.270291] Subtest semaphore-user: SUCCESS (0.056s) [245.366498] [088/129] (757s left) gem_userptr_blits (process-exit-busy) [245.425372] Starting subtest: process-exit-busy [245.431052] Subtest process-exit-busy: SUCCESS (0.010s) [245.524383] [089/129] (757s left) syncobj_timeline (single-wait-for-submit-available-signaled) [245.569647] Starting subtest: single-wait-for-submit-available-signaled [245.572100] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [245.642982] [090/129] (757s left) gem_set_tiling_vs_blt (tiled-to-tiled) [245.695294] Subtest tiled-to-tiled: SKIP (0.000s) [245.729210] [091/129] (757s left) gem_tiled_wb [245.824929] [092/129] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [245.914908] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [245.920063] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [245.983185] [093/129] (757s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [246.064262] Starting subtest: basic-max-pipe-crc-check [246.069469] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [246.094760] [094/129] (757s left) kms_busy (extended-modeset-hang-oldfb) [246.186916] Starting subtest: extended-modeset-hang-oldfb [246.189234] Starting dynamic subtest: pipe-A [257.996859] Dynamic subtest pipe-A: SUCCESS (11.808s) [258.005208] Starting dynamic subtest: pipe-D [270.800040] Dynamic subtest pipe-D: SUCCESS (12.799s) [270.803162] Subtest extended-modeset-hang-oldfb: SUCCESS (24.610s) [271.691664] [095/129] (731s left) drm_fdinfo (virtual-busy-all) [271.723391] Starting subtest: virtual-busy-all [271.727733] Subtest virtual-busy-all: SKIP (0.000s) [271.765090] [096/129] (731s left) gem_softpin (zero) [271.820389] Starting subtest: zero [271.825632] Subtest zero: SUCCESS (0.004s) [271.924105] [097/129] (731s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [272.029777] Starting subtest: cursorB-vs-flipA-atomic [272.034459] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [272.121063] [098/129] (731s left) kms_plane_multiple (tiling-4) [272.199803] Starting subtest: tiling-4 [272.202097] Starting dynamic subtest: pipe-A-eDP-1 [276.125822] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.923s) [276.133656] Starting dynamic subtest: pipe-B-eDP-1 [280.858199] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.732s) [280.866769] Starting dynamic subtest: pipe-C-eDP-1 [285.573835] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.715s) [285.583749] Starting dynamic subtest: pipe-D-eDP-1 [290.309158] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.734s) [290.311277] Subtest tiling-4: SUCCESS (18.107s) [291.211363] [099/129] (711s left) gem_exec_schedule (independent) [291.285022] Starting subtest: independent [291.287046] Starting dynamic subtest: rcs0 [292.392732] Dynamic subtest rcs0: SUCCESS (1.117s) [292.403447] Starting dynamic subtest: vcs0 [294.391700] Dynamic subtest vcs0: SUCCESS (1.998s) [294.401658] Starting dynamic subtest: vcs1 [296.384021] Dynamic subtest vcs1: SUCCESS (1.991s) [296.396161] Starting dynamic subtest: vecs0 [298.449624] Dynamic subtest vecs0: SUCCESS (2.065s) [298.457888] Starting dynamic subtest: ccs0 [300.391150] Dynamic subtest ccs0: SUCCESS (1.941s) [300.393761] Subtest independent: SUCCESS (9.117s) [300.667232] [100/129] (702s left) gem_ctx_persistence (heartbeat-close) [300.712606] Starting subtest: heartbeat-close [300.717291] Subtest heartbeat-close: SKIP (0.000s) [300.788155] [101/129] (702s left) kms_flip_event_leak (basic) [300.864819] Starting subtest: basic [300.867167] Starting dynamic subtest: pipe-A-eDP-1 [301.274989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s) [301.283613] Starting dynamic subtest: pipe-B-eDP-1 [302.457664] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.184s) [302.466552] Starting dynamic subtest: pipe-C-eDP-1 [303.663063] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.204s) [303.670850] Starting dynamic subtest: pipe-D-eDP-1 [304.816136] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.151s) [304.818942] Subtest basic: SUCCESS (3.948s) [305.672946] [102/129] (697s left) gem_exec_fence (parallel) [305.833309] Starting subtest: parallel [305.835914] Starting dynamic subtest: rcs0 [307.979830] Dynamic subtest rcs0: SUCCESS (2.148s) [307.991763] Starting dynamic subtest: bcs0 [310.136828] Dynamic subtest bcs0: SUCCESS (2.156s) [310.145396] Starting dynamic subtest: vcs0 [312.286060] Dynamic subtest vcs0: SUCCESS (2.149s) [312.293879] Starting dynamic subtest: vcs1 [314.435967] Dynamic subtest vcs1: SUCCESS (2.150s) [314.444669] Starting dynamic subtest: vecs0 [316.591194] Dynamic subtest vecs0: SUCCESS (2.154s) [316.599526] Starting dynamic subtest: ccs0 [318.746083] Dynamic subtest ccs0: SUCCESS (2.154s) [318.748342] Subtest parallel: SUCCESS (12.913s) [319.473030] [103/129] (683s left) kms_psr (psr-sprite-mmap-gtt) [319.555797] Starting subtest: psr-sprite-mmap-gtt [319.558097] Starting dynamic subtest: eDP-1 [321.068910] Dynamic subtest eDP-1: SKIP (1.508s) [321.073511] Subtest psr-sprite-mmap-gtt: SKIP (1.509s) [321.223247] [104/129] (682s left) api_intel_allocator (execbuf-with-allocator) [321.268815] Starting subtest: execbuf-with-allocator [321.275180] Subtest execbuf-with-allocator: SUCCESS (0.008s) [321.335376] [105/129] (681s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [321.437937] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [325.723726] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.286s) [325.813480] [106/129] (677s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [325.860366] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [325.862726] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [325.931971] [107/129] (677s left) perf_pmu (busy-check-all) [325.970307] Starting subtest: busy-check-all [325.972635] Starting dynamic subtest: rcs0 [326.530330] Dynamic subtest rcs0: SUCCESS (0.560s) [326.540507] Starting dynamic subtest: bcs0 [327.081638] Dynamic subtest bcs0: SUCCESS (0.550s) [327.091211] Starting dynamic subtest: vcs0 [328.359804] Dynamic subtest vcs0: SUCCESS (1.276s) [328.369761] Starting dynamic subtest: vcs1 [330.343937] Dynamic subtest vcs1: SUCCESS (1.983s) [330.354490] Starting dynamic subtest: vecs0 [332.392349] Dynamic subtest vecs0: SUCCESS (2.047s) [332.402401] Starting dynamic subtest: ccs0 [332.947100] Dynamic subtest ccs0: SUCCESS (0.555s) [332.949912] Subtest busy-check-all: SUCCESS (6.977s) [333.018221] [108/129] (670s left) drm_read (empty-nonblock) [333.145989] Starting subtest: empty-nonblock [333.148647] Subtest empty-nonblock: SUCCESS (0.000s) [333.261765] [109/129] (670s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [333.357081] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [334.306234] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (0.955s) [334.418356] [110/129] (668s left) kms_atomic (crtc-invalid-params) [334.508175] Starting subtest: crtc-invalid-params [334.510576] Starting dynamic subtest: pipe-A-eDP-1 [334.860229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.349s) [334.862999] Subtest crtc-invalid-params: SUCCESS (0.350s) [335.756859] [111/129] (667s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [335.854446] Starting subtest: psr-rgb101010-draw-mmap-gtt [335.859371] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [335.921637] [112/129] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [336.012522] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [336.016711] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [336.082681] [113/129] (667s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [336.130090] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [336.236490] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s) [336.289847] [114/129] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [336.380694] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [336.385602] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [336.447261] [115/129] (666s left) gem_userptr_blits (sync-unmap-cycles) [336.500983] Starting subtest: sync-unmap-cycles [341.871948] Subtest sync-unmap-cycles: SUCCESS (5.372s) [341.985851] [116/129] (661s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [344.574921] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s) [344.617090] [117/129] (658s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [344.731960] Starting subtest: cursorB-vs-flipA-toggle [344.736742] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [344.818218] [118/129] (658s left) gem_exec_whisper (basic-fds-priority) [344.869316] Starting subtest: basic-fds-priority [369.034053] Subtest basic-fds-priority: SUCCESS (24.161s) [369.190767] [119/129] (634s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [374.304034] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf [374.306281] Starting dynamic subtest: pipe-A-eDP-1 [375.150156] Dynamic subtest pipe-A-eDP-1: SKIP (0.842s) [375.160296] Starting dynamic subtest: pipe-B-eDP-1 [376.367054] Dynamic subtest pipe-B-eDP-1: SKIP (1.216s) [376.371449] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (2.061s) [377.615682] [120/129] (625s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [377.707894] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [377.710254] Starting dynamic subtest: pipe-A-eDP-1 [378.425233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [378.431547] Starting dynamic subtest: pipe-B-eDP-1 [380.292849] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.866s) [380.299838] Starting dynamic subtest: pipe-C-eDP-1 [382.156597] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.863s) [382.164421] Starting dynamic subtest: pipe-D-eDP-1 [384.003215] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.844s) [384.005756] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.285s) [385.162849] [121/129] (618s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [385.257472] Starting subtest: x-tiled-addfb-size-offset-overflow [385.259797] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [385.315081] [122/129] (618s left) debugfs_test (basic-hwmon) [385.364867] Starting subtest: basic-hwmon [385.369531] Subtest basic-hwmon: SKIP (0.000s) [385.450591] [123/129] (618s left) gem_tiled_pread_basic [385.526739] [124/129] (618s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [385.602915] Starting subtest: plane-scaler-unity-scaling-with-modifiers [385.605253] Starting dynamic subtest: pipe-A [385.944317] Dynamic subtest pipe-A: SUCCESS (0.341s) [385.952572] Starting dynamic subtest: pipe-B [387.434342] Dynamic subtest pipe-B: SUCCESS (1.489s) [387.444906] Starting dynamic subtest: pipe-C [388.904996] Dynamic subtest pipe-C: SUCCESS (1.470s) [388.912894] Starting dynamic subtest: pipe-D [390.374072] Dynamic subtest pipe-D: SUCCESS (1.469s) [390.376414] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.771s) [391.561439] [125/129] (612s left) gen9_exec_parse (bb-start-cmd) [391.612715] Subtest bb-start-cmd: SKIP (0.000s) [391.656257] [126/129] (611s left) gem_watchdog (default-physical) [391.720581] Starting subtest: default-physical [393.469966] Subtest default-physical: SUCCESS (1.764s) [393.557696] [127/129] (610s left) kms_flip (flip-vs-expired-vblank) [393.654010] Starting subtest: flip-vs-expired-vblank [393.656322] Starting dynamic subtest: A-eDP1 [402.386639] Dynamic subtest A-eDP1: SUCCESS (8.731s) [402.395933] Starting dynamic subtest: B-eDP1 [411.156905] Dynamic subtest B-eDP1: SUCCESS (8.769s) [411.169210] Starting dynamic subtest: C-eDP1 [419.912467] Dynamic subtest C-eDP1: SUCCESS (8.754s) [419.922043] Starting dynamic subtest: D-eDP1 [428.682829] Dynamic subtest D-eDP1: SUCCESS (8.768s) [428.688826] Subtest flip-vs-expired-vblank: SUCCESS (35.033s) [429.963233] [128/129] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [430.076638] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [432.715197] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.645s) [432.830375] [129/129] (570s left) gem_exec_fence (syncobj-timeline-unused-fence) [433.322798] Starting subtest: syncobj-timeline-unused-fence [433.329345] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s) [434.404144] Closing watchdogs Done.