[42.527034] Initializing watchdogs [42.527150] /dev/watchdog0 [42.540044] [001/144] (960s left) kms_pm_dc (dc9-dpms) [43.660938] Starting subtest: dc9-dpms [44.803942] Subtest dc9-dpms: SUCCESS (1.143s) [44.872326] [002/144] (958s left) drm_fdinfo (context-close-stress) [44.936250] Starting subtest: context-close-stress [55.681487] Subtest context-close-stress: SUCCESS (10.744s) [55.750591] [003/144] (947s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [56.357873] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [56.364037] Subtest pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [57.278532] [004/144] (945s left) gem_exec_schedule (manyslice) [57.372633] Starting subtest: manyslice [57.374967] Starting dynamic subtest: rcs0 [62.994901] Dynamic subtest rcs0: SUCCESS (5.624s) [63.009391] Starting dynamic subtest: bcs0 [82.034287] Dynamic subtest bcs0: SUCCESS (18.989s) [82.046259] Starting dynamic subtest: vcs0 [88.022878] Dynamic subtest vcs0: SUCCESS (6.039s) [88.034508] Starting dynamic subtest: vcs1 [94.060135] Dynamic subtest vcs1: SUCCESS (6.037s) [94.069578] Starting dynamic subtest: vecs0 [100.654591] Dynamic subtest vecs0: SUCCESS (6.544s) [100.661014] Starting dynamic subtest: ccs0 [107.311270] Dynamic subtest ccs0: SUCCESS (6.656s) [107.314039] Subtest manyslice: SUCCESS (49.890s) [107.563943] [005/144] (895s left) perf_pmu (multi-client) [107.625922] Starting subtest: multi-client [107.628871] Starting dynamic subtest: rcs0 [108.676555] Dynamic subtest rcs0: SUCCESS (1.051s) [108.688991] Starting dynamic subtest: bcs0 [109.735888] Dynamic subtest bcs0: SUCCESS (1.058s) [109.748553] Starting dynamic subtest: vcs0 [110.789479] Dynamic subtest vcs0: SUCCESS (1.053s) [110.801869] Starting dynamic subtest: vcs1 [112.514235] Dynamic subtest vcs1: SUCCESS (1.724s) [112.526422] Starting dynamic subtest: vecs0 [114.498076] Dynamic subtest vecs0: SUCCESS (1.983s) [114.510321] Starting dynamic subtest: ccs0 [116.482228] Dynamic subtest ccs0: SUCCESS (1.985s) [116.485173] Subtest multi-client: SUCCESS (8.857s) [116.589893] [006/144] (886s left) kms_psr (psr-primary-blt) [116.675933] Starting subtest: psr-primary-blt [116.678565] Starting dynamic subtest: eDP-1 [118.516033] Dynamic subtest eDP-1: SUCCESS (1.841s) [118.518576] Subtest psr-primary-blt: SUCCESS (1.841s) [119.421097] [007/144] (883s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-gen12-rc-ccs) [119.786219] Starting subtest: pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs [119.790642] Subtest pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s) [120.702246] [008/144] (882s left) perf (disabled-read-error) [120.831746] Starting subtest: disabled-read-error [120.853705] Subtest disabled-read-error: SUCCESS (0.024s) [120.881222] [009/144] (882s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [120.960047] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [120.964805] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [121.032972] [010/144] (882s left) sw_sync (alloc_timeline) [121.086564] Starting subtest: alloc_timeline [121.088486] Subtest alloc_timeline: SUCCESS (0.000s) [121.134117] [011/144] (882s left) gem_mmap_gtt (basic-read-write) [121.188659] Subtest basic-read-write: SKIP (0.000s) [121.223211] [012/144] (882s left) kms_sequence (queue-busy) [121.340244] Starting subtest: queue-busy [121.343050] Starting dynamic subtest: pipe-A-eDP-1 [123.271672] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s) [123.286037] Starting dynamic subtest: pipe-B-eDP-1 [125.953825] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.680s) [125.966567] Starting dynamic subtest: pipe-C-eDP-1 [128.627735] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.673s) [128.641671] Starting dynamic subtest: pipe-D-eDP-1 [131.317995] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.687s) [131.320430] Subtest queue-busy: SUCCESS (9.977s) [132.221391] [013/144] (871s left) kms_ccs (pipe-c-missing-ccs-buffer-y-tiled-ccs) [132.644520] Starting subtest: pipe-C-missing-ccs-buffer-y-tiled-ccs [132.649847] Subtest pipe-C-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s) [133.504057] [014/144] (869s left) kms_fbcon_fbt (fbc) [133.575394] Starting subtest: fbc [139.063219] Subtest fbc: SUCCESS (5.487s) [139.130172] [015/144] (864s left) gem_mmap_wc (bad-object) [139.194500] Subtest bad-object: SKIP (0.000s) [139.241310] [016/144] (864s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [139.307186] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [139.311090] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [139.384671] [017/144] (864s left) kms_lease (setcrtc-implicit-plane) [139.494614] Starting subtest: setcrtc-implicit-plane [139.497063] Starting dynamic subtest: pipe-A-eDP-1 [139.982787] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s) [139.991937] Starting dynamic subtest: pipe-B-eDP-1 [141.178949] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s) [141.190601] Starting dynamic subtest: pipe-C-eDP-1 [142.393710] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s) [142.403642] Starting dynamic subtest: pipe-D-eDP-1 [143.610749] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s) [143.613460] Subtest setcrtc-implicit-plane: SUCCESS (4.117s) [144.510675] [018/144] (858s left) gem_reg_read (timestamp-moving) [144.568413] Starting subtest: timestamp-moving [145.570639] Subtest timestamp-moving: SUCCESS (1.001s) [145.635375] [019/144] (857s left) gem_mmap (bad-object) [145.688558] Subtest bad-object: SKIP (0.000s) [145.728226] [020/144] (857s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [145.822203] Starting subtest: plane-all-transition-nonblocking-fencing [145.824553] Starting dynamic subtest: pipe-A-eDP-1 [148.324529] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s) [148.637180] Starting dynamic subtest: pipe-B-eDP-1 [151.927163] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.301s) [152.241146] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.420s) [153.150245] [021/144] (850s left) kms_big_joiner (invalid-modeset) [153.256565] Subtest invalid-modeset: SKIP (0.000s) [153.281955] [022/144] (850s left) gem_partial_pwrite_pread (writes-after-reads) [153.359067] Subtest writes-after-reads: SKIP (0.000s) [153.412367] [023/144] (850s left) kms_frontbuffer_tracking (fbc-tiling-y) [153.507445] Starting subtest: fbc-tiling-y [153.511439] Subtest fbc-tiling-y: SKIP (0.000s) [153.587840] [024/144] (850s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [153.678793] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [153.683239] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [153.747898] [025/144] (849s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [153.841769] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [153.846850] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [153.905184] [026/144] (849s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [153.978140] Starting subtest: plane-downscale-factor-0-5-with-modifiers [153.980469] Starting dynamic subtest: pipe-A-eDP-1 [154.009068] Dynamic subtest pipe-A-eDP-1: SKIP (0.028s) [154.015064] Starting dynamic subtest: pipe-B-eDP-1 [154.042974] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s) [154.051352] Starting dynamic subtest: pipe-C-eDP-1 [154.075901] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s) [154.088922] Starting dynamic subtest: pipe-D-eDP-1 [154.107656] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s) [154.111038] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.130s) [154.211435] [027/144] (849s left) gem_exec_flush (basic-wb-rw-default) [154.285220] Starting subtest: basic-wb-rw-default [159.780791] Subtest basic-wb-rw-default: SUCCESS (5.491s) [159.957965] [028/144] (843s left) kms_psr2_sf (fbc-cursor-plane-update-sf) [165.236603] Starting subtest: fbc-cursor-plane-update-sf [165.239084] Starting dynamic subtest: pipe-A-eDP-1 [166.099596] Dynamic subtest pipe-A-eDP-1: SKIP (0.861s) [166.112746] Starting dynamic subtest: pipe-B-eDP-1 [167.318215] Dynamic subtest pipe-B-eDP-1: SKIP (1.213s) [167.323069] Subtest fbc-cursor-plane-update-sf: SKIP (2.079s) [168.575458] [029/144] (835s left) gem_vm_create (create-ext) [168.641491] Starting subtest: create-ext [168.648056] Subtest create-ext: SUCCESS (0.006s) [168.751901] [030/144] (835s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [168.861666] Starting subtest: cursor-vs-flip-atomic-transitions [198.408462] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.544s) [199.296062] [031/144] (804s left) kms_properties (crtc-properties-atomic) [199.385705] Starting subtest: crtc-properties-atomic [203.253284] Subtest crtc-properties-atomic: SUCCESS (3.871s) [204.163880] [032/144] (799s left) kms_tv_load_detect (load-detect) [204.240702] Subtest load-detect: SKIP (0.000s) [204.284850] [033/144] (799s left) gem_pipe_control_store_loop (fresh-buffer) [204.347662] Starting subtest: fresh-buffer [206.562944] Subtest fresh-buffer: SUCCESS (2.153s) [206.595743] [034/144] (797s left) prime_vgem (wait) [206.726895] Starting subtest: wait [206.729534] Starting dynamic subtest: rcs0 [206.774765] Dynamic subtest rcs0: SUCCESS (0.047s) [206.787925] Starting dynamic subtest: bcs0 [206.826508] Dynamic subtest bcs0: SUCCESS (0.050s) [206.839067] Starting dynamic subtest: vcs0 [206.881435] Dynamic subtest vcs0: SUCCESS (0.054s) [206.893641] Starting dynamic subtest: vcs1 [206.940302] Dynamic subtest vcs1: SUCCESS (0.058s) [206.953613] Starting dynamic subtest: vecs0 [206.994526] Dynamic subtest vecs0: SUCCESS (0.054s) [207.006737] Starting dynamic subtest: ccs0 [207.050293] Dynamic subtest ccs0: SUCCESS (0.055s) [207.052732] Subtest wait: SUCCESS (0.323s) [207.157045] [035/144] (796s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [207.232196] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [207.234568] Starting dynamic subtest: pipe-A-eDP-1 [212.270833] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.038s) [212.287120] Starting dynamic subtest: pipe-B-eDP-1 [218.529268] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.255s) [218.540960] Starting dynamic subtest: pipe-C-eDP-1 [219.944041] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.413s) [219.960973] Starting dynamic subtest: pipe-D-eDP-1 [221.340043] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.392s) [221.344753] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (14.109s) [222.601882] [036/144] (781s left) i915_query (query-topology-kernel-writes) [222.668164] Starting subtest: query-topology-kernel-writes [222.670596] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [222.758548] [037/144] (781s left) i915_power (sanity) [222.832888] Starting subtest: sanity [226.889152] Subtest sanity: SUCCESS (4.052s) [228.552432] [038/144] (775s left) dumb_buffer (map-invalid-size) [228.623395] Starting subtest: map-invalid-size [228.625988] Subtest map-invalid-size: SUCCESS (0.000s) [228.702220] [039/144] (775s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [228.812599] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [228.816387] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [228.891928] [040/144] (775s left) kms_cursor_crc (cursor-random-256x85) [229.118808] Starting subtest: cursor-random-256x85 [229.153439] Subtest cursor-random-256x85: SKIP (0.027s) [229.305050] [041/144] (774s left) api_intel_bb (add-remove-objects) [229.393967] Starting subtest: add-remove-objects [229.404575] Subtest add-remove-objects: SUCCESS (0.013s) [229.494711] [042/144] (774s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [229.563142] Starting subtest: y-tiled-ccs-to-yf-tiled [229.567230] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [229.745288] [043/144] (774s left) kms_big_fb (x-tiled-32bpp-rotate-0) [229.821538] Starting subtest: x-tiled-32bpp-rotate-0 [231.265353] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.446s) [231.413043] [044/144] (772s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [231.482326] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [231.484710] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s) [231.562831] [045/144] (772s left) kms_chamelium_edid (dp-mode-timings) [231.935973] Subtest dp-mode-timings: SKIP (0.000s) [232.804491] [046/144] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [232.877784] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [232.881728] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [232.950168] [047/144] (771s left) vc4/vc4_purgeable_bo (free-purged-bo) [233.032969] Subtest free-purged-bo: SKIP (0.000s) [233.070543] [048/144] (771s left) gen9_exec_parse (allowed-all) [233.141271] Subtest allowed-all: SKIP (0.000s) [233.203278] [049/144] (771s left) gem_exec_fence (syncobj-timeline-chain-engines) [233.808212] Starting subtest: syncobj-timeline-chain-engines [233.956741] Subtest syncobj-timeline-chain-engines: SUCCESS (0.149s) [235.512946] [050/144] (768s left) perf_pmu (busy-idle) [235.576764] Starting subtest: busy-idle [235.579439] Starting dynamic subtest: rcs0 [236.263902] Dynamic subtest rcs0: SUCCESS (0.686s) [236.278198] Starting dynamic subtest: bcs0 [236.931863] Dynamic subtest bcs0: SUCCESS (0.667s) [236.946172] Starting dynamic subtest: vcs0 [238.469246] Dynamic subtest vcs0: SUCCESS (1.535s) [238.483544] Starting dynamic subtest: vcs1 [240.452944] Dynamic subtest vcs1: SUCCESS (1.982s) [240.468089] Starting dynamic subtest: vecs0 [242.437036] Dynamic subtest vecs0: SUCCESS (1.983s) [242.452370] Starting dynamic subtest: ccs0 [243.107921] Dynamic subtest ccs0: SUCCESS (0.670s) [243.110815] Subtest busy-idle: SUCCESS (7.532s) [243.197275] [051/144] (761s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [243.321166] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [246.709418] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.391s) [246.823340] [052/144] (757s left) kms_content_protection (srm) [246.976309] Starting subtest: srm [250.519708] Subtest srm: SKIP (3.540s) [251.778133] [053/144] (752s left) gem_ctx_persistence (userptr) [251.845835] Starting subtest: userptr [251.959449] Subtest userptr: SUCCESS (0.113s) [252.053931] [054/144] (752s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [252.158727] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [253.271221] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.114s) [253.381922] [055/144] (751s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [253.498757] Starting subtest: yf-tiled-addfb-size-offset-overflow [253.503841] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [253.576222] [056/144] (750s left) i915_pm_freq_api (freq-reset-multiple) [253.638355] Starting subtest: freq-reset-multiple [253.640592] Starting dynamic subtest: gt0 [263.621220] Dynamic subtest gt0: SUCCESS (9.981s) [263.636574] Starting dynamic subtest: gt1 [272.055336] Dynamic subtest gt1: SUCCESS (8.430s) [272.058258] Subtest freq-reset-multiple: SUCCESS (18.412s) [272.125119] [057/144] (732s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-rc-ccs) [272.541623] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs [272.547884] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s) [273.411175] [058/144] (731s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [273.839287] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [273.845297] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.001s) [274.690700] [059/144] (729s left) kms_dsc (dsc-with-formats) [274.800325] Starting subtest: dsc-with-formats [274.804272] Subtest dsc-with-formats: SKIP (0.001s) [274.861682] [060/144] (729s left) gem_mmap_gtt (pf-nonblock) [274.945302] Subtest pf-nonblock: SKIP (0.000s) [274.993929] [061/144] (729s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [277.653336] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [277.680292] [062/144] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt) [277.780771] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt [277.784761] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [277.860369] [063/144] (726s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [278.282402] Starting subtest: pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs-cc [278.288687] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [279.113090] [064/144] (725s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [279.200662] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [279.203222] Starting dynamic subtest: pipe-A-default-mode [279.491653] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [279.497112] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.289s) [280.385608] [065/144] (724s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [280.816159] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [280.822254] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.001s) [281.649710] [066/144] (723s left) gem_exec_reloc (basic-wc-cpu) [281.736411] Subtest basic-wc-cpu: SKIP (0.000s) [281.777121] [067/144] (723s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [281.879669] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [281.883600] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [281.962151] [068/144] (722s left) kms_draw_crc (fill-fb) [282.060225] Starting subtest: fill-fb [282.546074] Subtest fill-fb: SUCCESS (0.489s) [282.623254] [069/144] (722s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu) [282.709621] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu [287.304178] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.600s) [287.425602] [070/144] (717s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [287.828660] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [288.677590] [071/144] (716s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [288.778943] Starting subtest: psr-rgb101010-draw-render [293.978055] Subtest psr-rgb101010-draw-render: SUCCESS (5.203s) [294.078400] [072/144] (710s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [294.175632] Starting subtest: basic-busy-flip-before-cursor-varying-size [294.180392] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [294.313315] [073/144] (710s left) syncobj_wait (multi-wait-all-for-submit-signaled) [294.380421] Starting subtest: multi-wait-all-for-submit-signaled [294.382637] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [294.470892] [074/144] (710s left) gem_ctx_persistence (engines-queued) [294.548217] Starting subtest: engines-queued [294.550628] Starting dynamic subtest: rcs0 [294.610678] Dynamic subtest rcs0: SUCCESS (0.062s) [294.627683] Starting dynamic subtest: bcs0 [294.646638] Dynamic subtest bcs0: SUCCESS (0.035s) [294.661248] Starting dynamic subtest: vcs0 [296.419617] Dynamic subtest vcs0: SUCCESS (1.770s) [296.435195] Starting dynamic subtest: vcs1 [298.402454] Dynamic subtest vcs1: SUCCESS (1.981s) [298.418915] Starting dynamic subtest: vecs0 [300.450933] Dynamic subtest vecs0: SUCCESS (2.047s) [300.467136] Starting dynamic subtest: ccs0 [300.635048] Dynamic subtest ccs0: SUCCESS (0.184s) [300.637961] Subtest engines-queued: SUCCESS (6.087s) [300.736391] [075/144] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [300.860852] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [305.812232] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.954s) [305.914577] [076/144] (699s left) kms_pipe_crc_basic (read-crc) [306.003442] Starting subtest: read-crc [306.005789] Starting dynamic subtest: pipe-A-eDP-1 [306.756397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.751s) [306.774230] Starting dynamic subtest: pipe-B-eDP-1 [308.272564] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.512s) [308.288688] Starting dynamic subtest: pipe-C-eDP-1 [309.698042] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.421s) [309.714521] Starting dynamic subtest: pipe-D-eDP-1 [311.147394] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.448s) [311.150222] Subtest read-crc: SUCCESS (5.146s) [312.059170] [077/144] (692s left) gem_exec_parallel (fds) [312.147807] Starting subtest: fds [312.151067] Starting dynamic subtest: rcs0 [317.713620] Dynamic subtest rcs0: SUCCESS (5.564s) [317.725470] Starting dynamic subtest: bcs0 [324.289927] Dynamic subtest bcs0: SUCCESS (6.576s) [324.306487] Starting dynamic subtest: vcs0 [330.639694] Dynamic subtest vcs0: SUCCESS (6.348s) [330.655289] Starting dynamic subtest: vcs1 [336.678073] Dynamic subtest vcs1: SUCCESS (6.037s) [336.685073] Starting dynamic subtest: vecs0 [342.719109] Dynamic subtest vecs0: SUCCESS (6.039s) [342.735167] Starting dynamic subtest: ccs0 [349.704946] Dynamic subtest ccs0: SUCCESS (6.985s) [349.707730] Subtest fds: SUCCESS (37.557s) [349.907327] [078/144] (655s left) gem_mmap_gtt (medium-copy) [349.970230] Subtest medium-copy: SKIP (0.000s) [350.021559] [079/144] (655s left) prime_mmap (test_reprime) [350.089250] Starting subtest: test_reprime [350.091675] Starting dynamic subtest: test_reprime-smem [350.125545] Dynamic subtest test_reprime-smem: SUCCESS (0.038s) [350.128190] Subtest test_reprime: SUCCESS (0.038s) [350.208304] [080/144] (654s left) kms_psr (fbc-psr2-primary-page-flip) [350.288265] Starting subtest: fbc-psr2-primary-page-flip [350.290686] Starting dynamic subtest: eDP-1 [350.295511] Dynamic subtest eDP-1: SKIP (0.000s) [350.299406] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [350.392042] [081/144] (654s left) kms_vblank (wait-idle-hang) [350.513847] Starting subtest: wait-idle-hang [350.516479] Starting dynamic subtest: pipe-A-eDP-1 [364.316633] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.798s) [364.330376] Starting dynamic subtest: pipe-D-eDP-1 [379.288208] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.966s) [379.291266] Subtest wait-idle-hang: SUCCESS (28.774s) [380.227101] [082/144] (624s left) gem_exec_balancer (parallel-keep-in-fence) [380.535806] Starting subtest: parallel-keep-in-fence [381.501379] Subtest parallel-keep-in-fence: SUCCESS (0.966s) [381.577441] [083/144] (623s left) kms_big_fb (4-tiled-32bpp-rotate-0) [381.675836] Starting subtest: 4-tiled-32bpp-rotate-0 [383.264882] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.592s) [383.417291] [084/144] (621s left) kms_getfb (getfb2-handle-protection) [383.489245] Starting subtest: getfb2-handle-protection [383.513680] Subtest getfb2-handle-protection: SUCCESS (0.026s) [383.607189] [085/144] (621s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-xe2-ccs) [384.028057] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-xe2-ccs [384.034586] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-xe2-ccs: SKIP (0.000s) [384.898647] [086/144] (620s left) gem_exec_fence (concurrent) [385.091982] Starting subtest: concurrent [385.097675] Subtest concurrent: SKIP (0.000s) [386.480059] [087/144] (618s left) gem_exec_whisper (basic-sync-all) [386.566471] Starting subtest: basic-sync-all [397.508073] Subtest basic-sync-all: SUCCESS (10.939s) [397.692266] [088/144] (607s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [397.812906] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [398.621966] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.814s) [398.775455] [089/144] (606s left) syncobj_timeline (multi-wait-for-submit-signaled) [398.851842] Starting subtest: multi-wait-for-submit-signaled [398.854397] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [398.940045] [090/144] (606s left) syncobj_wait (invalid-signal-illegal-handle) [399.005044] Starting subtest: invalid-signal-illegal-handle [399.007440] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [399.078346] [091/144] (606s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [399.151384] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [399.153893] Starting dynamic subtest: pipe-A-eDP-1 [399.164257] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s) [399.179503] Starting dynamic subtest: pipe-B-eDP-1 [399.184203] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s) [399.195188] Starting dynamic subtest: pipe-C-eDP-1 [399.199846] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s) [399.209550] Starting dynamic subtest: pipe-D-eDP-1 [399.214228] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s) [399.218741] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.062s) [399.301302] [092/144] (606s left) gem_exec_schedule (timeslicing) [399.397409] Starting subtest: timeslicing [399.399785] Starting dynamic subtest: rcs0 [399.410158] Dynamic subtest rcs0: SUCCESS (0.023s) [399.422754] Starting dynamic subtest: bcs0 [399.439729] Dynamic subtest bcs0: SUCCESS (0.028s) [399.453639] Starting dynamic subtest: vcs0 [399.465882] Dynamic subtest vcs0: SUCCESS (0.025s) [399.478396] Starting dynamic subtest: vcs1 [399.494269] Dynamic subtest vcs1: SUCCESS (0.028s) [399.507821] Starting dynamic subtest: vecs0 [399.520913] Dynamic subtest vecs0: SUCCESS (0.026s) [399.533652] Starting dynamic subtest: ccs0 [399.547538] Dynamic subtest ccs0: SUCCESS (0.025s) [399.549702] Subtest timeslicing: SUCCESS (0.162s) [401.511807] [093/144] (604s left) vgem_basic (debugfs) [401.577358] Starting subtest: debugfs [401.579803] Subtest debugfs: SUCCESS (0.001s) [401.630667] [094/144] (603s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [401.758244] Starting subtest: cursorB-vs-flipB-atomic-transitions [401.762937] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s) [401.897403] [095/144] (603s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [401.972212] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [401.974728] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s) [402.067868] [096/144] (603s left) kms_big_fb (y-tiled-16bpp-rotate-270) [402.165554] Starting subtest: y-tiled-16bpp-rotate-270 [402.170460] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [402.243119] [097/144] (603s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [402.655287] Starting subtest: pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc [402.661304] Subtest pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [403.495623] [098/144] (602s left) v3d/v3d_submit_cl (bad-multisync-pad) [403.612583] Subtest bad-multisync-pad: SKIP (0.000s) [403.664000] [099/144] (602s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [404.032902] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [404.904681] [100/144] (600s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [405.295127] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs [405.300357] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s) [406.209714] [101/144] (599s left) gem_eio (in-flight-internal-10ms) [406.455343] Starting subtest: in-flight-internal-10ms [407.595168] Subtest in-flight-internal-10ms: SUCCESS (1.141s) [407.702476] [102/144] (598s left) core_auth (getclient-simple) [407.755653] Starting subtest: getclient-simple [407.768625] Subtest getclient-simple: SUCCESS (0.015s) [407.857270] [103/144] (597s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [407.942365] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [407.946363] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [408.023244] [104/144] (597s left) kms_ccs (pipe-b-bad-rotation-90-y-tiled-gen12-rc-ccs) [408.423480] Starting subtest: pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs [408.429838] Subtest pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s) [409.276520] [105/144] (596s left) kms_ccs (pipe-d-ccs-on-another-bo-4-tiled-mtl-mc-ccs) [409.667271] Starting subtest: pipe-D-ccs-on-another-bo-4-tiled-mtl-mc-ccs [409.690084] Subtest pipe-D-ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.024s) [410.499077] [106/144] (595s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [410.609630] Starting subtest: cursorB-vs-flipB-atomic [410.614426] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [410.753324] [107/144] (595s left) kms_ccs (pipe-d-missing-ccs-buffer-y-tiled-gen12-rc-ccs) [411.188373] Starting subtest: pipe-D-missing-ccs-buffer-y-tiled-gen12-rc-ccs [411.193799] Subtest pipe-D-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s) [412.034921] [108/144] (593s left) gem_exec_flush (basic-batch-kernel-default-uc) [412.122396] Starting subtest: basic-batch-kernel-default-uc [419.652797] Subtest basic-batch-kernel-default-uc: SUCCESS (7.530s) [419.841110] [109/144] (586s left) drm_read (invalid-buffer) [419.990692] Starting subtest: invalid-buffer [419.993241] Subtest invalid-buffer: SUCCESS (0.000s) [420.115580] [110/144] (585s left) kms_frontbuffer_tracking (fbc-2p-rte) [420.209820] Starting subtest: fbc-2p-rte [420.214151] Subtest fbc-2p-rte: SKIP (0.000s) [420.288073] [111/144] (585s left) gem_exec_store (basic) [420.370816] Starting subtest: basic [420.480622] Subtest basic: SUCCESS (0.113s) [420.664292] [112/144] (585s left) gem_ctx_isolation (dirty-switch) [420.751833] Starting subtest: dirty-switch [420.754695] Starting dynamic subtest: rcs0 [420.928302] Dynamic subtest rcs0: SUCCESS (0.176s) [420.945146] Starting dynamic subtest: bcs0 [421.165370] Dynamic subtest bcs0: SUCCESS (0.237s) [421.181599] Starting dynamic subtest: vcs0 [421.380879] Dynamic subtest vcs0: SUCCESS (0.215s) [421.397339] Starting dynamic subtest: vcs1 [422.647102] Dynamic subtest vcs1: SUCCESS (1.265s) [422.663669] Starting dynamic subtest: vecs0 [424.700341] Dynamic subtest vecs0: SUCCESS (2.053s) [424.711119] Starting dynamic subtest: ccs0 [426.717858] Dynamic subtest ccs0: SUCCESS (2.016s) [426.720341] Subtest dirty-switch: SUCCESS (5.966s) [426.955503] [113/144] (579s left) kms_prop_blob (invalid-set-prop) [427.036354] Starting subtest: invalid-set-prop [427.039090] Subtest invalid-set-prop: SUCCESS (0.000s) [427.122092] [114/144] (579s left) gem_exec_fair (basic-none-solo) [427.228989] Subtest basic-none-solo: SKIP (0.000s) [427.262613] [115/144] (578s left) gem_lmem_swapping (parallel-random-verify-ccs) [427.323050] Subtest parallel-random-verify-ccs: SKIP (0.000s) [427.355198] [116/144] (578s left) gem_ctx_param (basic) [427.416101] Starting subtest: basic [427.418999] Subtest basic: SUCCESS (0.001s) [427.494431] [117/144] (578s left) gem_exec_balancer (bonded-pair) [427.563516] Starting subtest: bonded-pair [427.568580] Subtest bonded-pair: SKIP (0.000s) [427.833200] [118/144] (578s left) gen3_render_mixed_blits [427.913789] [119/144] (578s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-dg2-mc-ccs) [428.309068] Starting subtest: pipe-B-bad-rotation-90-4-tiled-dg2-mc-ccs [428.315188] Subtest pipe-B-bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s) [429.180602] [120/144] (577s left) kms_psr (psr2-no-drrs) [429.252899] Starting subtest: psr2-no-drrs [429.255362] Starting dynamic subtest: eDP-1 [430.943348] Dynamic subtest eDP-1: SUCCESS (1.692s) [430.945947] Subtest psr2-no-drrs: SUCCESS (1.693s) [431.873347] [121/144] (574s left) kms_async_flips (test-cursor) [431.961795] Starting subtest: test-cursor [431.966627] Subtest test-cursor: SKIP (0.000s) [433.218713] [122/144] (573s left) kms_psr (fbc-psr-sprite-render) [433.307476] Starting subtest: fbc-psr-sprite-render [433.310030] Starting dynamic subtest: eDP-1 [433.314977] Dynamic subtest eDP-1: SKIP (0.000s) [433.319702] Subtest fbc-psr-sprite-render: SKIP (0.001s) [433.433977] [123/144] (572s left) gem_mmap_gtt (basic-small-copy-odd) [433.518254] Subtest basic-small-copy-odd: SKIP (0.000s) [433.576916] [124/144] (572s left) i915_pciid [433.712914] [125/144] (572s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu) [433.781858] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu [436.542619] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (2.765s) [436.653729] [126/144] (569s left) vc4/vc4_mmap (mmap-bo) [436.736484] Subtest mmap-bo: SKIP (0.000s) [436.789963] [127/144] (569s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [436.876073] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [441.748300] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.872s) [441.869077] [128/144] (564s left) v3d/v3d_submit_csd (bad-extension) [441.950078] Subtest bad-extension: SKIP (0.000s) [442.000488] [129/144] (564s left) fbdev (unaligned-read) [442.056279] Starting subtest: unaligned-read [442.064055] Subtest unaligned-read: SUCCESS (0.008s) [442.118022] [130/144] (564s left) kms_feature_discovery (psr2) [442.218169] Starting subtest: psr2 [442.220222] Subtest psr2: SUCCESS (0.000s) [442.287193] [131/144] (564s left) syncobj_wait (multi-wait-for-submit-signaled) [442.354305] Starting subtest: multi-wait-for-submit-signaled [442.356657] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [442.442302] [132/144] (564s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [442.516474] Starting subtest: etime-single-wait-all-available-unsubmitted [442.615643] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s) [442.688712] [133/144] (564s left) kms_vblank (ts-continuation-modeset-hang) [442.794024] Starting subtest: ts-continuation-modeset-hang [442.795754] Starting dynamic subtest: pipe-A-eDP-1 [457.285581] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.493s) [457.305042] Starting dynamic subtest: pipe-D-eDP-1 [482.313897] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s) [482.318663] Subtest ts-continuation-modeset-hang: SUCCESS (39.523s) [483.203184] [134/144] (523s left) kms_flip (plain-flip-fb-recreate-interruptible) [483.302825] Starting subtest: plain-flip-fb-recreate-interruptible [483.305385] Starting dynamic subtest: A-eDP1 [492.210346] Dynamic subtest A-eDP1: SUCCESS (8.907s) [492.226207] Starting dynamic subtest: B-eDP1 [501.169370] Dynamic subtest B-eDP1: SUCCESS (8.957s) [501.186974] Starting dynamic subtest: C-eDP1 [510.130305] Dynamic subtest C-eDP1: SUCCESS (8.960s) [510.152066] Starting dynamic subtest: D-eDP1 [519.077467] Dynamic subtest D-eDP1: SUCCESS (8.946s) [519.085461] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.785s) [520.315313] [135/144] (486s left) syncobj_wait (single-wait-submitted) [520.363703] Starting subtest: single-wait-submitted [520.463969] Subtest single-wait-submitted: SUCCESS (0.102s) [520.538781] [136/144] (486s left) kms_psr (fbc-pr-dpms) [520.630081] Starting subtest: fbc-pr-dpms [520.635110] Subtest fbc-pr-dpms: SKIP (0.000s) [520.751932] [137/144] (486s left) kms_cursor_crc (cursor-sliding-128x42) [521.019696] Starting subtest: cursor-sliding-128x42 [521.055336] Subtest cursor-sliding-128x42: SKIP (0.029s) [521.300114] [138/144] (485s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [521.398758] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [521.402664] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [521.484489] [139/144] (485s left) sysfs_preempt_timeout (idempotent) [521.568360] Starting subtest: idempotent [521.570419] Starting dynamic subtest: vecs0 [521.572488] Dynamic subtest vecs0: SUCCESS (0.001s) [521.588616] Starting dynamic subtest: ccs0 [521.590566] Dynamic subtest ccs0: SUCCESS (0.001s) [521.602694] Starting dynamic subtest: vcs0 [521.604556] Dynamic subtest vcs0: SUCCESS (0.001s) [521.619530] Starting dynamic subtest: bcs0 [521.621631] Dynamic subtest bcs0: SUCCESS (0.001s) [521.631904] Starting dynamic subtest: rcs0 [521.634370] Dynamic subtest rcs0: SUCCESS (0.001s) [521.650038] Starting dynamic subtest: vcs1 [521.652450] Dynamic subtest vcs1: SUCCESS (0.001s) [521.655257] Subtest idempotent: SUCCESS (0.012s) [521.677050] [140/144] (485s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-mtl-rc-ccs) [522.062929] Starting subtest: pipe-B-random-ccs-data-4-tiled-mtl-rc-ccs [522.889691] Subtest pipe-B-random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (0.827s) [524.098853] [141/144] (482s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [524.208228] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [528.806069] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.604s) [528.894114] [142/144] (478s left) gem_spin_batch (engines) [528.997517] Starting subtest: engines [528.999955] Starting dynamic subtest: rcs0 [532.240325] Dynamic subtest rcs0: SUCCESS (3.238s) [532.258212] Starting dynamic subtest: bcs0 [535.482490] Dynamic subtest bcs0: SUCCESS (3.240s) [535.499400] Starting dynamic subtest: vcs0 [538.775776] Dynamic subtest vcs0: SUCCESS (3.238s) [538.793380] Starting dynamic subtest: vcs1 [542.012148] Dynamic subtest vcs1: SUCCESS (3.237s) [542.028651] Starting dynamic subtest: vecs0 [545.199053] Dynamic subtest vecs0: SUCCESS (3.237s) [545.217215] Starting dynamic subtest: ccs0 [548.489414] Dynamic subtest ccs0: SUCCESS (3.237s) [548.492649] Subtest engines: SUCCESS (19.436s) [548.622094] [143/144] (458s left) v3d/v3d_create_bo (create-bo-4096) [548.718463] Subtest create-bo-4096: SKIP (0.000s) [548.769448] [144/144] (458s left) kms_addfb_basic (no-handle) [548.842116] Starting subtest: no-handle [548.844453] Subtest no-handle: SUCCESS (0.000s) [548.940212] Closing watchdogs Done.