[62.998716] Initializing watchdogs [62.998762] /dev/watchdog0 [63.014653] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [63.019243] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.021972] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.024025] [001/156] (960s left) kms_flip (flip-vs-dpms-off-vs-modeset) [63.116220] Starting subtest: flip-vs-dpms-off-vs-modeset [63.117214] Starting dynamic subtest: A-eDP1 [66.883563] Dynamic subtest A-eDP1: SUCCESS (3.759s) [66.891227] Starting dynamic subtest: B-eDP1 [70.101097] Dynamic subtest B-eDP1: SUCCESS (3.213s) [70.109513] Starting dynamic subtest: C-eDP1 [73.316516] Dynamic subtest C-eDP1: SUCCESS (3.211s) [73.324552] Starting dynamic subtest: D-eDP1 [76.537069] Dynamic subtest D-eDP1: SUCCESS (3.219s) [76.539085] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.410s) [77.350920] [002/156] (946s left) gem_ctx_isolation (preservation-s3) [77.405488] Starting subtest: preservation-S3 [77.406381] Starting dynamic subtest: rcs0 [94.016063] Dynamic subtest rcs0: SUCCESS (1.823s) [94.026593] Starting dynamic subtest: bcs0 [111.008505] Dynamic subtest bcs0: SUCCESS (1.758s) [111.016888] Starting dynamic subtest: vcs0 [128.009582] Dynamic subtest vcs0: SUCCESS (2.804s) [128.019002] Starting dynamic subtest: vcs1 [145.998509] Dynamic subtest vcs1: SUCCESS (5.013s) [146.007035] Starting dynamic subtest: vecs0 [163.997417] Dynamic subtest vecs0: SUCCESS (4.959s) [164.004950] Starting dynamic subtest: ccs0 [182.008341] Dynamic subtest ccs0: SUCCESS (3.193s) [182.009337] Subtest preservation-S3: SUCCESS (19.553s) [189.263903] [003/156] (841s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [189.361210] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [189.363096] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [189.426756] [004/156] (841s left) gem_exec_big (single) [189.485806] Starting subtest: single [194.573881] Subtest single: SUCCESS (5.010s) [194.777181] [005/156] (835s left) gem_render_copy (linear-to-vebox-yf-tiled) [194.871825] Starting subtest: linear-to-vebox-yf-tiled [194.873601] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [195.047692] [006/156] (835s left) prime_mmap (test_invalid_sync_flags) [195.092498] Starting subtest: test_invalid_sync_flags [195.093514] Starting dynamic subtest: test_invalid_sync_flags-smem [195.094698] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [195.095626] Subtest test_invalid_sync_flags: SUCCESS (0.000s) [195.197269] [007/156] (835s left) kms_content_protection (dp-mst-lic-type-1) [195.348089] Starting subtest: dp-mst-lic-type-1 [195.350284] Subtest dp-mst-lic-type-1: SKIP (0.000s) [195.475561] [008/156] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [195.577811] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [195.579392] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [195.676195] [009/156] (835s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move) [195.771716] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move [195.773536] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [195.858282] [010/156] (834s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [195.949759] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [199.751199] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.788s) [200.902932] [011/156] (829s left) gem_spin_batch (legacy-resubmit) [200.961633] Starting subtest: legacy-resubmit [200.962732] Starting dynamic subtest: default [200.968835] Dynamic subtest default: SUCCESS (0.007s) [200.977950] Starting dynamic subtest: render [200.978811] Dynamic subtest render: SUCCESS (0.001s) [200.986894] Starting dynamic subtest: bsd [200.987910] Dynamic subtest bsd: SUCCESS (0.002s) [200.995851] Starting dynamic subtest: bsd1 [200.996695] Dynamic subtest bsd1: SUCCESS (0.002s) [201.003949] Starting dynamic subtest: bsd2 [201.004987] Dynamic subtest bsd2: SUCCESS (0.001s) [201.012246] Starting dynamic subtest: blt [201.013116] Dynamic subtest blt: SUCCESS (0.003s) [201.020230] Starting dynamic subtest: vebox [201.021112] Dynamic subtest vebox: SUCCESS (0.003s) [201.022036] Subtest legacy-resubmit: SUCCESS (0.023s) [201.218502] [012/156] (829s left) kms_psr (fbc-psr2-sprite-plane-onoff) [201.301593] Starting subtest: fbc-psr2-sprite-plane-onoff [201.302651] Starting dynamic subtest: eDP-1 [201.304384] Dynamic subtest eDP-1: SKIP (0.000s) [201.306168] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s) [201.366552] [013/156] (829s left) syncobj_timeline (invalid-signal-zero-handles) [201.430193] Starting subtest: invalid-signal-zero-handles [201.431306] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [201.537247] [014/156] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [201.625122] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [206.194313] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.562s) [207.329810] [015/156] (823s left) gem_ctx_persistence (heartbeat-stop) [207.380197] Starting subtest: heartbeat-stop [207.382309] Subtest heartbeat-stop: SKIP (0.000s) [207.480606] [016/156] (823s left) kms_addfb_basic (invalid-set-prop-any) [207.522417] Starting subtest: invalid-set-prop-any [207.523300] Subtest invalid-set-prop-any: SUCCESS (0.000s) [207.655147] [017/156] (823s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [207.740896] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [207.742971] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [207.821723] [018/156] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [207.914875] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [207.916446] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [207.998375] [019/156] (823s left) kms_invalid_mode (zero-clock) [208.094983] Starting subtest: zero-clock [208.096078] Starting dynamic subtest: pipe-A-eDP-1 [208.389384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s) [208.397394] Starting dynamic subtest: pipe-B-eDP-1 [208.398305] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [208.405801] Starting dynamic subtest: pipe-C-eDP-1 [208.406703] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [208.414167] Starting dynamic subtest: pipe-D-eDP-1 [208.415057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [208.416105] Subtest zero-clock: SUCCESS (0.300s) [209.246220] [020/156] (821s left) i915_query (query-topology-garbage-items) [209.289747] Starting subtest: query-topology-garbage-items [209.290787] Subtest query-topology-garbage-items: SUCCESS (0.000s) [209.378995] [021/156] (821s left) syncobj_wait (invalid-signal-bad-pad) [209.436693] Starting subtest: invalid-signal-bad-pad [209.437758] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [209.526250] [022/156] (821s left) gem_basic (multigpu-create-close) [209.586517] Starting subtest: multigpu-create-close [209.588399] Subtest multigpu-create-close: SKIP (0.000s) [209.681075] [023/156] (821s left) api_intel_allocator (default-alignment) [209.726006] Starting subtest: default-alignment [209.727890] Subtest default-alignment: SUCCESS (0.003s) [209.844477] [024/156] (821s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [209.933819] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [209.934824] Starting dynamic subtest: pipe-A-eDP-1 [209.943479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [209.951633] Starting dynamic subtest: pipe-B-eDP-1 [209.959801] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [209.967446] Starting dynamic subtest: pipe-C-eDP-1 [209.975056] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [209.984262] Starting dynamic subtest: pipe-D-eDP-1 [209.991612] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [209.992402] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [212.210015] [025/156] (819s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [212.297198] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [212.298825] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [212.376350] [026/156] (818s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [212.467581] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [212.468592] Starting dynamic subtest: pipe-A [212.486076] Dynamic subtest pipe-A: SKIP (0.017s) [212.494344] Starting dynamic subtest: pipe-B [212.518946] Dynamic subtest pipe-B: SKIP (0.033s) [212.526795] Starting dynamic subtest: pipe-C [212.551873] Dynamic subtest pipe-C: SKIP (0.032s) [212.559555] Starting dynamic subtest: pipe-D [212.583707] Dynamic subtest pipe-D: SKIP (0.032s) [212.585285] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.115s) [212.666282] [027/156] (818s left) gem_reg_read (timestamp-moving) [212.727489] Starting subtest: timestamp-moving [213.738574] Subtest timestamp-moving: SUCCESS (1.000s) [213.812988] [028/156] (817s left) gem_exec_balancer (bonded-semaphore) [213.879904] Starting subtest: bonded-semaphore [213.881944] Subtest bonded-semaphore: SKIP (0.000s) [214.191096] [029/156] (817s left) i915_pm_rpm (gem-execbuf-stress) [215.739691] Starting subtest: gem-execbuf-stress [215.741302] Starting dynamic subtest: smem0 [228.697797] Dynamic subtest smem0: SUCCESS (12.958s) [228.709176] Starting dynamic subtest: extra-wait-smem0 [290.373767] Dynamic subtest extra-wait-smem0: SUCCESS (61.653s) [290.375208] Subtest gem-execbuf-stress: SUCCESS (74.615s) [290.754073] [030/156] (740s left) gem_mmap_gtt (cpuset-big-copy) [290.801289] Subtest cpuset-big-copy: SKIP (0.000s) [290.857449] [031/156] (740s left) syncobj_basic (bad-pad-handle-to-fd) [290.896998] Starting subtest: bad-pad-handle-to-fd [290.898330] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [290.986193] [032/156] (740s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt) [291.077833] Starting subtest: psrhdr-rgb565-draw-blt [291.079863] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s) [291.172240] [033/156] (740s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [291.262306] Starting subtest: plane-upscale-factor-0-25-with-modifiers [291.263090] Starting dynamic subtest: pipe-A [291.599409] Dynamic subtest pipe-A: SUCCESS (0.338s) [291.609302] Starting dynamic subtest: pipe-B [293.048396] Dynamic subtest pipe-B: SUCCESS (1.449s) [293.058026] Starting dynamic subtest: pipe-C [294.471055] Dynamic subtest pipe-C: SUCCESS (1.422s) [294.481857] Starting dynamic subtest: pipe-D [295.899607] Dynamic subtest pipe-D: SUCCESS (1.428s) [295.900419] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.639s) [297.053794] [034/156] (734s left) gem_exec_schedule (preempt) [297.118143] Starting subtest: preempt [297.119181] Starting dynamic subtest: rcs0 [297.140308] Dynamic subtest rcs0: SUCCESS (0.023s) [297.153135] Starting dynamic subtest: bcs0 [297.163796] Dynamic subtest bcs0: SUCCESS (0.023s) [297.172189] Starting dynamic subtest: vcs0 [297.190550] Dynamic subtest vcs0: SUCCESS (0.026s) [297.199052] Starting dynamic subtest: vcs1 [297.211475] Dynamic subtest vcs1: SUCCESS (0.020s) [297.219582] Starting dynamic subtest: vecs0 [297.232051] Dynamic subtest vecs0: SUCCESS (0.020s) [297.240294] Starting dynamic subtest: ccs0 [297.250903] Dynamic subtest ccs0: SUCCESS (0.018s) [297.251795] Subtest preempt: SUCCESS (0.135s) [298.466914] [035/156] (733s left) gem_mmap_gtt (coherency) [298.516776] Subtest coherency: SKIP (0.000s) [298.566984] [036/156] (733s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt) [298.661212] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt [298.662914] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [298.750262] [037/156] (732s left) kms_big_fb (yf-tiled-addfb-size-overflow) [298.849806] Starting subtest: yf-tiled-addfb-size-overflow [298.851693] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [298.938198] [038/156] (732s left) i915_drm_fdinfo (context-close-stress) [298.977100] Starting subtest: context-close-stress [309.767268] Subtest context-close-stress: SUCCESS (10.746s) [309.795715] [039/156] (721s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [310.068311] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc [310.070200] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [310.155137] [040/156] (721s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite) [310.248903] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite [310.251197] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [310.346891] [041/156] (721s left) kms_big_fb (y-tiled-32bpp-rotate-90) [310.449994] Starting subtest: y-tiled-32bpp-rotate-90 [310.451609] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [310.527323] [042/156] (721s left) i915_hangman (gt-engine-error) [310.591539] Starting subtest: gt-engine-error [310.592505] Starting dynamic subtest: rcs0 [312.319880] Dynamic subtest rcs0: SUCCESS (1.718s) [312.330513] Starting dynamic subtest: bcs0 [314.364647] Dynamic subtest bcs0: SUCCESS (2.043s) [314.376750] Starting dynamic subtest: vcs0 [316.348844] Dynamic subtest vcs0: SUCCESS (1.981s) [316.359261] Starting dynamic subtest: vcs1 [318.333610] Dynamic subtest vcs1: SUCCESS (1.982s) [318.343660] Starting dynamic subtest: vecs0 [320.317205] Dynamic subtest vecs0: SUCCESS (1.982s) [320.329206] Starting dynamic subtest: ccs0 [322.365382] Dynamic subtest ccs0: SUCCESS (2.046s) [322.366628] Subtest gt-engine-error: SUCCESS (11.764s) [322.432608] [043/156] (709s left) kms_addfb_basic (addfb25-bad-modifier) [322.537561] Starting subtest: addfb25-bad-modifier [322.538437] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [322.631084] [044/156] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [322.724837] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [322.726421] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [322.811931] [045/156] (709s left) sw_sync (sync_merge_same) [322.840411] Starting subtest: sync_merge_same [322.841491] Subtest sync_merge_same: SUCCESS (0.000s) [322.887819] [046/156] (709s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [322.944040] Starting subtest: invalid-multi-wait-unsubmitted-submitted [322.944906] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s) [323.029799] [047/156] (708s left) gem_pipe_control_store_loop (reused-buffer) [323.080061] Starting subtest: reused-buffer [325.241745] Subtest reused-buffer: SUCCESS (2.152s) [325.365450] [048/156] (706s left) kms_atomic (plane-invalid-params-fence) [325.456845] Starting subtest: plane-invalid-params-fence [325.457830] Starting dynamic subtest: pipe-A-eDP-1 [325.813044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s) [325.813972] Subtest plane-invalid-params-fence: SUCCESS (0.356s) [326.674581] [049/156] (705s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [326.770739] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [326.771686] Starting dynamic subtest: pipe-A-eDP-1 [326.793678] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [326.802129] Starting dynamic subtest: pipe-B-eDP-1 [326.823454] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [326.831633] Starting dynamic subtest: pipe-C-eDP-1 [326.852181] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [326.861445] Starting dynamic subtest: pipe-D-eDP-1 [326.882520] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [326.884104] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s) [329.034733] [050/156] (703s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-plflip-blt) [329.119411] Starting subtest: hdr-1p-primscrn-indfb-plflip-blt [329.121291] Subtest hdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [329.208452] [051/156] (702s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [329.301191] Starting subtest: psr-rgb565-draw-mmap-wc [336.271694] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.971s) [336.379898] [052/156] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [336.478151] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [336.480130] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [336.559196] [053/156] (695s left) syncobj_wait (wait-all-for-submit-complex) [336.605176] Starting subtest: wait-all-for-submit-complex [336.827843] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [336.888016] [054/156] (695s left) kms_chamelium_audio (hdmi-audio) [337.277298] Subtest hdmi-audio: SKIP (0.000s) [338.102785] [055/156] (694s left) kms_psr (psr2-sprite-plane-onoff) [338.192756] Starting subtest: psr2-sprite-plane-onoff [338.193788] Starting dynamic subtest: eDP-1 [339.928978] Dynamic subtest eDP-1: SUCCESS (1.735s) [339.929965] Subtest psr2-sprite-plane-onoff: SUCCESS (1.736s) [340.777104] [056/156] (691s left) kms_chamelium_edid (dp-mode-timings) [341.160710] Subtest dp-mode-timings: SKIP (0.000s) [341.992003] [057/156] (690s left) gem_exec_reloc (basic-wc-read) [342.053941] Subtest basic-wc-read: SKIP (0.000s) [342.112880] [058/156] (690s left) kms_atomic_transition (plane-toggle-modeset-transition) [342.202921] Starting subtest: plane-toggle-modeset-transition [342.203860] Starting dynamic subtest: pipe-A-eDP-1 [355.016993] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.810s) [355.028884] Starting dynamic subtest: pipe-B-eDP-1 [367.497285] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.473s) [367.498310] Subtest plane-toggle-modeset-transition: SUCCESS (25.288s) [368.313191] [059/156] (664s left) gem_exec_schedule (fairslice) [368.373238] Starting subtest: fairslice [368.374174] Starting dynamic subtest: rcs0 [370.398591] Dynamic subtest rcs0: SUCCESS (2.018s) [370.406582] Starting dynamic subtest: bcs0 [372.418041] Dynamic subtest bcs0: SUCCESS (2.017s) [372.426915] Starting dynamic subtest: vcs0 [374.438786] Dynamic subtest vcs0: SUCCESS (2.020s) [374.447003] Starting dynamic subtest: vcs1 [376.460954] Dynamic subtest vcs1: SUCCESS (2.020s) [376.470670] Starting dynamic subtest: vecs0 [378.484635] Dynamic subtest vecs0: SUCCESS (2.020s) [378.493691] Starting dynamic subtest: ccs0 [380.502092] Dynamic subtest ccs0: SUCCESS (2.017s) [380.503129] Subtest fairslice: SUCCESS (12.119s) [380.795155] [060/156] (651s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [380.886015] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt [380.887785] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [380.996960] [061/156] (651s left) kms_frontbuffer_tracking (basic) [381.095189] Starting subtest: basic [384.478303] Subtest basic: SUCCESS (3.383s) [384.577772] [062/156] (647s left) kms_lease (simple-lease) [384.668869] Starting subtest: simple-lease [384.669843] Starting dynamic subtest: pipe-A-eDP-1 [385.177975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s) [385.188273] Starting dynamic subtest: pipe-B-eDP-1 [386.671610] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s) [386.682167] Starting dynamic subtest: pipe-C-eDP-1 [388.160816] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s) [388.171686] Starting dynamic subtest: pipe-D-eDP-1 [389.578227] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.414s) [389.579108] Subtest simple-lease: SUCCESS (4.909s) [390.376284] [063/156] (642s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [390.470611] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [399.435782] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.965s) [399.564644] [064/156] (632s left) kms_vblank (accuracy-idle) [399.666893] Starting subtest: accuracy-idle [399.667785] Starting dynamic subtest: pipe-A-eDP-1 [401.423303] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s) [401.433699] Starting dynamic subtest: pipe-D-eDP-1 [403.860326] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.434s) [403.861184] Subtest accuracy-idle: SUCCESS (4.194s) [404.682533] [065/156] (627s left) kms_getfb (getfb2-into-addfb2) [404.768636] Starting subtest: getfb2-into-addfb2 [404.769649] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [404.855623] [066/156] (627s left) kms_chamelium_hpd (dp-hpd-after-suspend) [405.256216] Subtest dp-hpd-after-suspend: SKIP (0.000s) [406.095236] [067/156] (626s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [406.188258] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf [406.189192] Starting dynamic subtest: pipe-A-eDP-1 [416.869320] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.683s) [416.879628] Starting dynamic subtest: pipe-B-eDP-1 [428.343953] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.475s) [428.344920] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.161s) [429.199232] [068/156] (603s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt) [429.305469] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt [429.307166] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [429.418771] [069/156] (603s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [429.521461] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [429.523348] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [429.606242] [070/156] (603s left) kms_atomic_interruptible (universal-setplane-primary) [429.703173] Starting subtest: universal-setplane-primary [429.704091] Starting dynamic subtest: pipe-A-eDP-1 [437.108923] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.407s) [437.109947] Subtest universal-setplane-primary: SUCCESS (7.408s) [437.936018] [071/156] (594s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt) [438.031331] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt [438.032930] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [438.126486] [072/156] (594s left) kms_scaling_modes (scaling-mode-none) [438.219717] Starting subtest: scaling-mode-none [438.220610] Starting dynamic subtest: pipe-A-eDP-1 [438.317890] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s) [438.328737] Starting dynamic subtest: pipe-B-eDP-1 [438.352810] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s) [438.364320] Starting dynamic subtest: pipe-C-eDP-1 [438.383704] Dynamic subtest pipe-C-eDP-1: SKIP (0.030s) [438.392284] Starting dynamic subtest: pipe-D-eDP-1 [438.415397] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s) [438.417194] Subtest scaling-mode-none: SKIP (0.196s) [438.538514] [073/156] (594s left) kms_flip (plain-flip-fb-recreate) [438.633770] Starting subtest: plain-flip-fb-recreate [438.635843] Starting dynamic subtest: A-eDP1 [447.548777] Dynamic subtest A-eDP1: SUCCESS (8.914s) [447.559272] Starting dynamic subtest: B-eDP1 [456.474049] Dynamic subtest B-eDP1: SUCCESS (8.923s) [456.486557] Starting dynamic subtest: C-eDP1 [465.291524] Dynamic subtest C-eDP1: SUCCESS (8.815s) [465.302159] Starting dynamic subtest: D-eDP1 [474.112007] Dynamic subtest D-eDP1: SUCCESS (8.819s) [474.116374] Subtest plain-flip-fb-recreate: SUCCESS (35.485s) [475.282934] [074/156] (557s left) dmabuf_sync_file (import-multiple-read-write) [475.406938] Starting subtest: import-multiple-read-write [475.409142] Subtest import-multiple-read-write: SUCCESS (0.002s) [475.457209] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true [475.459553] [075/156] (557s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [475.541721] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [475.542530] Starting dynamic subtest: pipe-A-eDP-1 [492.180462] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s) [492.188531] Starting dynamic subtest: pipe-B-eDP-1 [510.162751] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.837s) [510.171584] Starting dynamic subtest: pipe-C-eDP-1 [528.137550] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.843s) [528.148290] Starting dynamic subtest: pipe-D-eDP-1 [546.124954] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.755s) [546.126064] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.256s) [553.414909] [076/156] (485s left) sysfs_defaults (readonly) [553.472786] Starting subtest: readonly [553.473941] Starting dynamic subtest: vecs0 [553.475022] Dynamic subtest vecs0: SUCCESS (0.000s) [553.484979] Starting dynamic subtest: ccs0 [553.485989] Dynamic subtest ccs0: SUCCESS (0.000s) [553.494383] Starting dynamic subtest: vcs0 [553.495232] Dynamic subtest vcs0: SUCCESS (0.000s) [553.503433] Starting dynamic subtest: bcs0 [553.504271] Dynamic subtest bcs0: SUCCESS (0.000s) [553.512885] Starting dynamic subtest: rcs0 [553.513794] Dynamic subtest rcs0: SUCCESS (0.000s) [553.522395] Starting dynamic subtest: vcs1 [553.523621] Dynamic subtest vcs1: SUCCESS (0.000s) [553.524733] Subtest readonly: SUCCESS (0.006s) [553.574525] [077/156] (485s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [553.665670] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc [553.667351] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [553.766011] [078/156] (485s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [553.812717] Starting subtest: single-wait-all-for-submit-available-signaled [553.813746] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [553.906091] [079/156] (485s left) kms_frontbuffer_tracking (fbchdr-stridechange) [554.009986] Starting subtest: fbchdr-stridechange [554.011771] Subtest fbchdr-stridechange: SKIP (0.000s) [554.120220] [080/156] (484s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc) [554.224874] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc [554.226729] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s) [554.311742] [081/156] (484s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt) [554.412508] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt [554.414310] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [554.495381] [082/156] (484s left) kms_setmode (invalid-clone-single-crtc) [554.548994] Starting subtest: invalid-clone-single-crtc [554.551640] Subtest invalid-clone-single-crtc: SKIP (0.000s) [554.652247] [083/156] (484s left) drm_read (fault-buffer) [554.786275] Starting subtest: fault-buffer [554.787397] Subtest fault-buffer: SUCCESS (0.001s) [554.910633] [084/156] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [555.008505] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [555.010293] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [555.103881] [085/156] (484s left) gem_exec_suspend (basic-s0) [555.172262] Starting subtest: basic-S0 [555.173446] Starting dynamic subtest: smem [575.544382] Dynamic subtest smem: SUCCESS (6.513s) [575.545563] Subtest basic-S0: SUCCESS (6.515s) [580.793931] [086/156] (463s left) kms_async_flips (crc) [580.889642] Starting subtest: crc [581.262690] Starting dynamic subtest: pipe-A-eDP-1 [584.180463] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.901s) [584.563486] Starting dynamic subtest: pipe-B-eDP-1 [587.440317] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.874s) [587.813852] Starting dynamic subtest: pipe-C-eDP-1 [590.763095] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.950s) [591.132162] Starting dynamic subtest: pipe-D-eDP-1 [594.011851] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.883s) [594.012803] Subtest crc: SUCCESS (13.077s) [595.170271] [087/156] (449s left) prime_self_import (reimport-vs-gem_close-race) [595.200455] Starting subtest: reimport-vs-gem_close-race [600.281483] Subtest reimport-vs-gem_close-race: SUCCESS (5.063s) [600.348391] [088/156] (444s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [600.439673] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [600.441476] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [600.517928] [089/156] (443s left) syncobj_eventfd (timeline-wait-signaled) [600.569339] Starting subtest: timeline-wait-signaled [600.570372] Subtest timeline-wait-signaled: SUCCESS (0.000s) [600.685096] [090/156] (443s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite) [600.771478] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite [600.773162] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [600.860788] [091/156] (443s left) core_debugfs (read-all-entries) [600.903870] Starting subtest: read-all-entries [600.999963] Subtest read-all-entries: SUCCESS (0.096s) [601.075609] [092/156] (443s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [601.123835] Starting subtest: multi-wait-available-unsubmitted-submitted [601.124735] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [601.233448] [093/156] (443s left) syncobj_wait (multi-wait-all-for-submit-signaled) [601.275186] Starting subtest: multi-wait-all-for-submit-signaled [601.276218] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [601.365465] [094/156] (443s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [601.452815] Starting subtest: flip-vs-dpms-on-nop-interruptible [601.455420] Starting dynamic subtest: A-eDP1 [603.285995] Dynamic subtest A-eDP1: SUCCESS (1.830s) [603.298270] Starting dynamic subtest: B-eDP1 [605.120994] Dynamic subtest B-eDP1: SUCCESS (1.832s) [605.132105] Starting dynamic subtest: C-eDP1 [606.937376] Dynamic subtest C-eDP1: SUCCESS (1.813s) [606.948903] Starting dynamic subtest: D-eDP1 [608.761254] Dynamic subtest D-eDP1: SUCCESS (1.821s) [608.762203] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.304s) [609.939328] [095/156] (434s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [610.053909] Starting subtest: basic-flip-before-cursor-varying-size [610.985629] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.931s) [611.789124] [096/156] (432s left) gem_exec_reloc (basic-gtt-read) [611.847501] Subtest basic-gtt-read: SKIP (0.000s) [611.909529] [097/156] (432s left) gem_userptr_blits (unsync-unmap) [611.975606] Subtest unsync-unmap: SKIP (0.000s) [612.112705] [098/156] (432s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [612.197549] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [612.199327] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [612.286852] [099/156] (432s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [612.374753] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [612.376530] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [612.468172] [100/156] (432s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt) [612.562673] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt [612.564548] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [612.642390] [101/156] (432s left) kms_psr (fbc-pr-cursor-blt) [612.735219] Starting subtest: fbc-pr-cursor-blt [612.737195] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [612.802961] [102/156] (432s left) kms_cursor_edge_walk (64x64-top-bottom) [612.890451] Starting subtest: 64x64-top-bottom [612.891251] Starting dynamic subtest: pipe-A-eDP-1 [616.377044] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s) [616.386326] Starting dynamic subtest: pipe-D-eDP-1 [619.516523] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s) [619.517502] Subtest 64x64-top-bottom: SUCCESS (6.627s) [620.313400] [103/156] (424s left) gem_eio (context-create) [620.542171] Starting subtest: context-create [620.891837] Subtest context-create: SUCCESS (0.350s) [621.007358] [104/156] (424s left) gem_exec_params (cliprects_ptr-dirt) [621.060517] Starting subtest: cliprects_ptr-dirt [621.061379] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [621.155016] [105/156] (423s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt) [621.248495] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt [621.250221] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [621.336578] [106/156] (423s left) kms_color (degamma) [621.422989] Starting subtest: degamma [621.423883] Starting dynamic subtest: pipe-A-eDP-1 [622.155501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s) [622.165676] Starting dynamic subtest: pipe-B-eDP-1 [623.571995] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.415s) [623.584205] Starting dynamic subtest: pipe-C-eDP-1 [624.938950] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s) [624.948505] Starting dynamic subtest: pipe-D-eDP-1 [626.366753] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s) [626.367581] Subtest degamma: SUCCESS (4.944s) [627.258394] [107/156] (417s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [627.360650] Starting subtest: yf-tiled-16bpp-rotate-270 [627.362328] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [627.456187] [108/156] (417s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [627.573528] Starting subtest: 2x-cursor-vs-flip-legacy [627.576471] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s) [627.715481] [109/156] (417s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [627.799687] Starting subtest: bad-pixel-format-y-tiled-ccs [627.800592] Starting dynamic subtest: pipe-A-eDP-1 [627.809150] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [627.818399] Starting dynamic subtest: pipe-B-eDP-1 [627.826938] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [627.836040] Starting dynamic subtest: pipe-C-eDP-1 [627.843982] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [627.852742] Starting dynamic subtest: pipe-D-eDP-1 [627.860545] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [627.862105] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [630.146551] [110/156] (415s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt) [630.243985] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt [630.246208] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [630.332658] [111/156] (414s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [630.428867] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [630.430665] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [630.545750] [112/156] (414s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [630.639872] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [630.641667] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [630.733211] [113/156] (414s left) gem_create (create-size-update) [630.786257] Starting subtest: create-size-update [630.787046] Subtest create-size-update: SUCCESS (0.000s) [630.992729] [114/156] (414s left) kms_plane_alpha_blend (alpha-opaque-fb) [631.094920] Starting subtest: alpha-opaque-fb [631.379655] Starting dynamic subtest: pipe-A-eDP-1 [632.118766] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s) [632.127902] Starting dynamic subtest: pipe-D-eDP-1 [633.514925] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.394s) [633.515965] Subtest alpha-opaque-fb: SUCCESS (2.420s) [634.320080] [115/156] (411s left) kms_getfb (getfb-handle-closed) [634.411655] Starting subtest: getfb-handle-closed [634.412595] Subtest getfb-handle-closed: SUCCESS (0.000s) [634.512882] [116/156] (410s left) kms_big_fb (x-tiled-64bpp-rotate-90) [634.619706] Starting subtest: x-tiled-64bpp-rotate-90 [634.639121] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [634.737974] [117/156] (410s left) sw_sync (alloc_merge_fence) [634.769154] Starting subtest: alloc_merge_fence [634.770151] Subtest alloc_merge_fence: SUCCESS (0.000s) [634.831632] [118/156] (410s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [634.924698] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [634.926382] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [635.023879] [119/156] (410s left) kms_feature_discovery (display-4x) [635.126713] Starting subtest: display-4x [635.128478] Subtest display-4x: SKIP (0.000s) [635.210356] [120/156] (410s left) gen9_exec_parse (bb-secure) [635.257190] Subtest bb-secure: SKIP (0.000s) [635.309447] [121/156] (410s left) kms_big_fb (linear-32bpp-rotate-90) [635.396645] Starting subtest: linear-32bpp-rotate-90 [635.415686] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [635.528257] [122/156] (410s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [635.629718] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [635.631610] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [635.712893] [123/156] (410s left) kms_properties (colorop-properties-atomic) [635.810603] Starting subtest: colorop-properties-atomic [635.811537] Starting dynamic subtest: pipe-A-eDP-1 [636.178762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s) [636.187870] Starting dynamic subtest: pipe-B-eDP-1 [637.299754] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.119s) [637.308977] Starting dynamic subtest: pipe-C-eDP-1 [638.342361] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.041s) [638.351363] Starting dynamic subtest: pipe-D-eDP-1 [639.390762] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.048s) [639.391725] Subtest colorop-properties-atomic: SUCCESS (3.581s) [640.279188] [124/156] (405s left) kms_vrr (flip-suspend) [640.369130] Starting subtest: flip-suspend [640.371794] Subtest flip-suspend: SKIP (0.000s) [640.437558] [125/156] (405s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [640.533850] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [641.204442] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.671s) [641.381317] [126/156] (404s left) gem_exec_fence (syncobj-timeline-invalid-wait) [641.950174] Starting subtest: syncobj-timeline-invalid-wait [641.951584] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [643.594700] [127/156] (402s left) kms_psr (fbc-psr-primary-render) [643.687495] Starting subtest: fbc-psr-primary-render [643.688383] Starting dynamic subtest: eDP-1 [643.690191] Dynamic subtest eDP-1: SKIP (0.000s) [643.691901] Subtest fbc-psr-primary-render: SKIP (0.001s) [643.758066] [128/156] (402s left) gem_caching (read-writes) [643.809899] Subtest read-writes: SKIP (0.000s) [643.876651] [129/156] (402s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [643.966874] Starting subtest: primary-y-tiled-reflect-x-180 [644.026982] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s) [644.127198] [130/156] (401s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite) [644.218201] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite [644.220000] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [644.311610] [131/156] (401s left) perf (polling-small-buf) [644.437087] Starting subtest: polling-small-buf [644.529023] Subtest polling-small-buf: SUCCESS (0.091s) [644.572170] [132/156] (401s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [644.659067] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [644.660947] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [644.753182] [133/156] (401s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [644.846983] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt [644.848787] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [644.942461] [134/156] (401s left) gem_exec_whisper (basic-queues-forked-all) [645.006341] Starting subtest: basic-queues-forked-all [666.748719] Subtest basic-queues-forked-all: SUCCESS (21.724s) [666.923430] [135/156] (379s left) gem_vm_create (invalid-create) [666.973889] Starting subtest: invalid-create [666.976090] Subtest invalid-create: SUCCESS (0.002s) [667.072824] [136/156] (379s left) kms_pm_rpm (modeset-lpsp-stress) [668.591008] Starting subtest: modeset-lpsp-stress [684.636075] Subtest modeset-lpsp-stress: SUCCESS (16.046s) [684.754452] [137/156] (361s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [684.850473] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [684.852081] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [684.950253] [138/156] (361s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt) [685.039539] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt [685.041131] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [685.129401] [139/156] (361s left) gem_pxp (display-protected-crc) [685.248847] Starting subtest: display-protected-crc [687.034913] Subtest display-protected-crc: SUCCESS (1.787s) [687.136830] [140/156] (359s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render) [687.223696] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render [687.225250] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [687.309606] [141/156] (359s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [688.826812] Starting subtest: modeset-lpsp-stress-no-wait [699.065434] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.242s) [699.187537] [142/156] (347s left) prime_vgem (basic-blt) [699.263723] Starting subtest: basic-blt [699.296046] Subtest basic-blt: SUCCESS (0.032s) [699.442601] [143/156] (346s left) gem_eio (reset-stress) [699.663375] Starting subtest: reset-stress [699.664688] Starting dynamic subtest: render [704.487024] Dynamic subtest render: SUCCESS (4.822s) [704.503902] Starting dynamic subtest: bsd1 [722.998555] Dynamic subtest bsd1: SUCCESS (18.509s) [723.015457] Starting dynamic subtest: bsd2 [741.030196] Dynamic subtest bsd2: SUCCESS (18.027s) [741.047804] Starting dynamic subtest: blt [741.049896] Dynamic subtest blt: SKIP (0.000s) [741.059475] Starting dynamic subtest: vebox [759.019481] Dynamic subtest vebox: SUCCESS (17.984s) [759.020655] Subtest reset-stress: SUCCESS (59.346s) [760.532228] [144/156] (285s left) kms_cursor_crc (cursor-rapid-movement-512x512) [760.828383] Starting subtest: cursor-rapid-movement-512x512 [760.830166] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [760.990791] [145/156] (285s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [761.082704] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [761.083589] Starting dynamic subtest: pipe-A-default-mode [763.880695] Dynamic subtest pipe-A-default-mode: SUCCESS (2.796s) [763.881723] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.798s) [764.724765] [146/156] (281s left) kms_debugfs (display-off-read-all) [764.813795] Starting subtest: display-off-read-all [765.121615] Subtest display-off-read-all: SUCCESS (0.308s) [765.950921] [147/156] (280s left) kms_flip (2x-flip-vs-modeset) [766.046366] Starting subtest: 2x-flip-vs-modeset [766.056825] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [766.134734] [148/156] (280s left) gem_exec_schedule (timeslicing) [766.196410] Starting subtest: timeslicing [766.197484] Starting dynamic subtest: rcs0 [766.217381] Dynamic subtest rcs0: SUCCESS (0.021s) [766.229190] Starting dynamic subtest: bcs0 [766.238293] Dynamic subtest bcs0: SUCCESS (0.020s) [766.252682] Starting dynamic subtest: vcs0 [766.259098] Dynamic subtest vcs0: SUCCESS (0.020s) [766.269216] Starting dynamic subtest: vcs1 [766.279400] Dynamic subtest vcs1: SUCCESS (0.020s) [766.291247] Starting dynamic subtest: vecs0 [766.300022] Dynamic subtest vecs0: SUCCESS (0.020s) [766.313316] Starting dynamic subtest: ccs0 [766.321069] Dynamic subtest ccs0: SUCCESS (0.020s) [766.322194] Subtest timeslicing: SUCCESS (0.126s) [767.574722] [149/156] (279s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [767.636510] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [767.638516] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [767.819911] [150/156] (278s left) kms_cursor_crc (cursor-offscreen-128x42) [768.044208] Starting subtest: cursor-offscreen-128x42 [768.090573] Subtest cursor-offscreen-128x42: SKIP (0.044s) [768.287858] [151/156] (278s left) kms_psr (pr-sprite-plane-onoff) [768.370558] Starting subtest: pr-sprite-plane-onoff [768.372359] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [768.440834] [152/156] (278s left) perf_pmu (busy-check-all) [768.475061] Starting subtest: busy-check-all [768.476208] Starting dynamic subtest: rcs0 [769.027189] Dynamic subtest rcs0: SUCCESS (0.552s) [769.042652] Starting dynamic subtest: bcs0 [769.577373] Dynamic subtest bcs0: SUCCESS (0.548s) [769.592872] Starting dynamic subtest: vcs0 [771.513025] Dynamic subtest vcs0: SUCCESS (1.923s) [771.523490] Starting dynamic subtest: vcs1 [773.496668] Dynamic subtest vcs1: SUCCESS (1.980s) [773.506983] Starting dynamic subtest: vecs0 [775.545175] Dynamic subtest vecs0: SUCCESS (2.045s) [775.554990] Starting dynamic subtest: ccs0 [776.092003] Dynamic subtest ccs0: SUCCESS (0.554s) [776.095281] Subtest busy-check-all: SUCCESS (7.616s) [776.178996] [153/156] (270s left) kms_addfb_basic (too-wide) [776.275549] Starting subtest: too-wide [776.276566] Subtest too-wide: SUCCESS (0.000s) [776.370250] [154/156] (270s left) gem_partial_pwrite_pread (reads-display) [776.432737] Subtest reads-display: SKIP (0.000s) [776.509212] [155/156] (270s left) gem_mmap_offset (partial-unmap) [776.568680] Starting subtest: partial-unmap [776.569690] Starting dynamic subtest: smem0 [777.087337] Dynamic subtest smem0: SUCCESS (0.507s) [777.089080] Subtest partial-unmap: SUCCESS (0.508s) [777.181643] [156/156] (269s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [777.281241] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [777.282891] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [777.373420] Closing watchdogs results: parsing output: 0/ for test: kms_flip results: parsing output: 1/ for test: gem_ctx_isolation results: parsing output: 2/ for test: kms_plane results: parsing output: 3/ for test: gem_exec_big results: parsing output: 4/ for test: gem_render_copy results: parsing output: 5/ for test: prime_mmap results: parsing output: 6/ for test: kms_content_protection results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_spin_batch results: parsing output: 11/ for test: kms_psr results: parsing output: 12/ for test: syncobj_timeline results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_ctx_persistence results: parsing output: 15/ for test: kms_addfb_basic results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_invalid_mode results: parsing output: 19/ for test: i915_query results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: gem_basic results: parsing output: 22/ for test: api_intel_allocator results: parsing output: 23/ for test: kms_ccs results: parsing output: 24/ for test: kms_plane results: parsing output: 25/ for test: kms_plane_scaling results: parsing output: 26/ for test: gem_reg_read results: parsing output: 27/ for test: gem_exec_balancer results: parsing output: 28/ for test: i915_pm_rpm results: parsing output: 29/ for test: gem_mmap_gtt results: parsing output: 30/ for test: syncobj_basic results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_plane_scaling results: parsing output: 33/ for test: gem_exec_schedule results: parsing output: 34/ for test: gem_mmap_gtt results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: i915_drm_fdinfo results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: i915_hangman results: parsing output: 42/ for test: kms_addfb_basic results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: sw_sync results: parsing output: 45/ for test: syncobj_timeline results: parsing output: 46/ for test: gem_pipe_control_store_loop results: parsing output: 47/ for test: kms_atomic results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: syncobj_wait results: parsing output: 53/ for test: kms_chamelium_audio results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: kms_chamelium_edid results: parsing output: 56/ for test: gem_exec_reloc results: parsing output: 57/ for test: kms_atomic_transition results: parsing output: 58/ for test: gem_exec_schedule results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_lease results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_vblank results: parsing output: 64/ for test: kms_getfb results: parsing output: 65/ for test: kms_chamelium_hpd results: parsing output: 66/ for test: kms_psr2_sf results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_atomic_interruptible results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_scaling_modes results: parsing output: 72/ for test: kms_flip results: parsing output: 73/ for test: dmabuf_sync_file results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: sysfs_defaults results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_setmode results: parsing output: 82/ for test: drm_read results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_exec_suspend results: parsing output: 85/ for test: kms_async_flips results: parsing output: 86/ for test: prime_self_import results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: syncobj_eventfd results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: core_debugfs results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: syncobj_wait results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: gem_exec_reloc results: parsing output: 96/ for test: gem_userptr_blits results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_cursor_edge_walk results: parsing output: 102/ for test: gem_eio results: parsing output: 103/ for test: gem_exec_params results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_color results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: kms_ccs results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_create results: parsing output: 113/ for test: kms_plane_alpha_blend results: parsing output: 114/ for test: kms_getfb results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: sw_sync results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: kms_feature_discovery results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_properties results: parsing output: 123/ for test: kms_vrr results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: gem_exec_fence results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: gem_caching results: parsing output: 128/ for test: kms_rotation_crc results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: perf results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: gem_exec_whisper results: parsing output: 134/ for test: gem_vm_create results: parsing output: 135/ for test: kms_pm_rpm results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: gem_pxp results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_pm_rpm results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: gem_eio results: parsing output: 143/ for test: kms_cursor_crc results: parsing output: 144/ for test: kms_flip_scaled_crc results: parsing output: 145/ for test: kms_debugfs results: parsing output: 146/ for test: kms_flip results: parsing output: 147/ for test: gem_exec_schedule results: parsing output: 148/ for test: gem_render_copy results: parsing output: 149/ for test: kms_cursor_crc results: parsing output: 150/ for test: kms_psr results: parsing output: 151/ for test: perf_pmu results: parsing output: 152/ for test: kms_addfb_basic results: parsing output: 153/ for test: gem_partial_pwrite_pread results: parsing output: 154/ for test: gem_mmap_offset results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.