[56.547523] Initializing watchdogs [56.547670] /dev/watchdog0 [56.563832] [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] [56.568340] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.571113] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.574422] [001/156] (960s left) kms_flip (flip-vs-dpms-off-vs-modeset) [56.699758] Starting subtest: flip-vs-dpms-off-vs-modeset [56.702357] Starting dynamic subtest: A-eDP1 [60.330370] Dynamic subtest A-eDP1: SUCCESS (3.656s) [60.340770] Starting dynamic subtest: B-eDP1 [63.555182] Dynamic subtest B-eDP1: SUCCESS (3.236s) [63.564892] Starting dynamic subtest: C-eDP1 [66.762135] Dynamic subtest C-eDP1: SUCCESS (3.215s) [66.770449] Starting dynamic subtest: D-eDP1 [69.972530] Dynamic subtest D-eDP1: SUCCESS (3.214s) [69.974826] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.328s) [70.781333] [002/156] (946s left) gem_ctx_isolation (preservation-s3) [70.852952] Starting subtest: preservation-S3 [70.855366] Starting dynamic subtest: rcs0 [87.164757] Dynamic subtest rcs0: SUCCESS (1.402s) [87.178837] Starting dynamic subtest: bcs0 [103.148317] Dynamic subtest bcs0: SUCCESS (1.914s) [103.157291] Starting dynamic subtest: vcs0 [119.149420] Dynamic subtest vcs0: SUCCESS (3.247s) [119.159769] Starting dynamic subtest: vcs1 [137.140720] Dynamic subtest vcs1: SUCCESS (5.027s) [137.151863] Starting dynamic subtest: vecs0 [155.138635] Dynamic subtest vecs0: SUCCESS (5.032s) [155.148517] Starting dynamic subtest: ccs0 [173.144019] Dynamic subtest ccs0: SUCCESS (3.258s) [173.148223] Subtest preservation-S3: SUCCESS (19.884s) [173.369001] [003/156] (843s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [173.465109] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [173.469638] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [173.537441] [004/156] (843s left) gem_exec_big (single) [173.586865] Starting subtest: single [176.928808] Subtest single: FAIL (3.293s) [176.973474] [005/156] (840s left) gem_render_copy (linear-to-vebox-yf-tiled) [177.097004] Starting subtest: linear-to-vebox-yf-tiled [177.101521] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [177.281278] [006/156] (839s left) prime_mmap (test_invalid_sync_flags) [177.345263] Starting subtest: test_invalid_sync_flags [177.347660] Starting dynamic subtest: test_invalid_sync_flags-smem [177.349643] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [177.351623] Subtest test_invalid_sync_flags: SUCCESS (0.000s) [177.450617] [007/156] (839s left) kms_content_protection (dp-mst-lic-type-1) [177.609654] Starting subtest: dp-mst-lic-type-1 [177.614168] Subtest dp-mst-lic-type-1: SKIP (0.000s) [177.726179] [008/156] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [177.830019] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [177.834173] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [177.904698] [009/156] (839s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move) [178.001466] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move [178.005462] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [178.084915] [010/156] (839s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [178.194537] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [181.869929] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.691s) [183.065918] [011/156] (834s left) gem_spin_batch (legacy-resubmit) [183.135410] Starting subtest: legacy-resubmit [183.137719] Starting dynamic subtest: default [183.140101] Dynamic subtest default: SUCCESS (0.006s) [183.151737] Starting dynamic subtest: render [183.154007] Dynamic subtest render: SUCCESS (0.001s) [183.164109] Starting dynamic subtest: bsd [183.166358] Dynamic subtest bsd: SUCCESS (0.002s) [183.175491] Starting dynamic subtest: bsd1 [183.177675] Dynamic subtest bsd1: SUCCESS (0.001s) [183.188057] Starting dynamic subtest: bsd2 [183.190358] Dynamic subtest bsd2: SUCCESS (0.003s) [183.199525] Starting dynamic subtest: blt [183.201717] Dynamic subtest blt: SUCCESS (0.002s) [183.210652] Starting dynamic subtest: vebox [183.212896] Dynamic subtest vebox: SUCCESS (0.003s) [183.215084] Subtest legacy-resubmit: SUCCESS (0.021s) [183.375994] [012/156] (834s left) kms_psr (fbc-psr2-sprite-plane-onoff) [183.471447] Starting subtest: fbc-psr2-sprite-plane-onoff [183.473741] Starting dynamic subtest: eDP-1 [183.477905] Dynamic subtest eDP-1: SKIP (0.000s) [183.482075] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s) [183.545235] [013/156] (834s left) syncobj_timeline (invalid-signal-zero-handles) [183.609990] Starting subtest: invalid-signal-zero-handles [183.612339] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [183.736478] [014/156] (833s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [183.841342] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [188.404943] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.576s) [189.562729] [015/156] (828s left) gem_ctx_persistence (heartbeat-stop) [189.627715] Starting subtest: heartbeat-stop [189.632553] Subtest heartbeat-stop: SKIP (0.000s) [189.729125] [016/156] (827s left) kms_addfb_basic (invalid-set-prop-any) [189.778167] Starting subtest: invalid-set-prop-any [189.779985] Subtest invalid-set-prop-any: SUCCESS (0.000s) [189.910732] [017/156] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [190.006283] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [190.010789] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [190.120911] [018/156] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [190.217563] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [190.222082] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [190.304896] [019/156] (827s left) kms_invalid_mode (zero-clock) [190.403885] Starting subtest: zero-clock [190.406356] Starting dynamic subtest: pipe-A-eDP-1 [190.686079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [190.698915] Starting dynamic subtest: pipe-B-eDP-1 [190.701002] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [190.710924] Starting dynamic subtest: pipe-C-eDP-1 [190.713196] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [190.722438] Starting dynamic subtest: pipe-D-eDP-1 [190.724746] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [190.727056] Subtest zero-clock: SUCCESS (0.290s) [191.579649] [020/156] (826s left) i915_query (query-topology-garbage-items) [191.645488] Starting subtest: query-topology-garbage-items [191.647796] Subtest query-topology-garbage-items: SUCCESS (0.000s) [191.751319] [021/156] (826s left) syncobj_wait (invalid-signal-bad-pad) [191.799353] Starting subtest: invalid-signal-bad-pad [191.801607] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [191.884091] [022/156] (826s left) gem_basic (multigpu-create-close) [191.937898] Starting subtest: multigpu-create-close [191.942366] Subtest multigpu-create-close: SKIP (0.000s) [192.021006] [023/156] (825s left) api_intel_allocator (default-alignment) [192.078984] Starting subtest: default-alignment [192.081363] Subtest default-alignment: SUCCESS (0.003s) [192.192517] [024/156] (825s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [192.279063] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [192.280829] Starting dynamic subtest: pipe-A-eDP-1 [192.297775] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [192.307255] Starting dynamic subtest: pipe-B-eDP-1 [192.323424] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [192.332372] Starting dynamic subtest: pipe-C-eDP-1 [192.347923] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [192.357090] Starting dynamic subtest: pipe-D-eDP-1 [192.373098] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [192.374927] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [194.540622] [025/156] (823s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [194.636220] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [194.640826] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [194.703424] [026/156] (823s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [194.801837] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [194.804184] Starting dynamic subtest: pipe-A [194.821017] Dynamic subtest pipe-A: SKIP (0.017s) [194.831113] Starting dynamic subtest: pipe-B [194.853458] Dynamic subtest pipe-B: SKIP (0.032s) [194.862794] Starting dynamic subtest: pipe-C [194.886287] Dynamic subtest pipe-C: SKIP (0.031s) [194.898066] Starting dynamic subtest: pipe-D [194.917274] Dynamic subtest pipe-D: SKIP (0.031s) [194.920949] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.112s) [195.004302] [027/156] (823s left) gem_reg_read (timestamp-moving) [195.065256] Starting subtest: timestamp-moving [196.067798] Subtest timestamp-moving: SUCCESS (1.002s) [196.140828] [028/156] (822s left) gem_exec_balancer (bonded-semaphore) [196.210341] Starting subtest: bonded-semaphore [196.215043] Subtest bonded-semaphore: SKIP (0.000s) [196.512329] [029/156] (821s left) i915_pm_rpm (gem-execbuf-stress) [198.074721] Starting subtest: gem-execbuf-stress [198.077364] Starting dynamic subtest: smem0 [212.106618] Dynamic subtest smem0: SUCCESS (14.067s) [212.119883] Starting dynamic subtest: extra-wait-smem0 [274.161381] Dynamic subtest extra-wait-smem0: SUCCESS (62.077s) [274.164519] Subtest gem-execbuf-stress: SUCCESS (76.148s) [274.558595] [030/156] (743s left) gem_mmap_gtt (cpuset-big-copy) [274.623525] Subtest cpuset-big-copy: SKIP (0.000s) [274.691609] [031/156] (743s left) syncobj_basic (bad-pad-handle-to-fd) [274.745119] Starting subtest: bad-pad-handle-to-fd [274.748031] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [274.841110] [032/156] (743s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt) [274.945236] Starting subtest: psrhdr-rgb565-draw-blt [274.949478] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s) [275.046274] [033/156] (743s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [275.133835] Starting subtest: plane-upscale-factor-0-25-with-modifiers [275.136142] Starting dynamic subtest: pipe-A [275.468869] Dynamic subtest pipe-A: SUCCESS (0.338s) [275.479264] Starting dynamic subtest: pipe-B [276.851968] Dynamic subtest pipe-B: SUCCESS (1.383s) [276.861992] Starting dynamic subtest: pipe-C [278.293726] Dynamic subtest pipe-C: SUCCESS (1.441s) [278.305583] Starting dynamic subtest: pipe-D [279.727598] Dynamic subtest pipe-D: SUCCESS (1.434s) [279.729916] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.598s) [280.903983] [034/156] (737s left) gem_exec_schedule (preempt) [280.976477] Starting subtest: preempt [280.978425] Starting dynamic subtest: rcs0 [280.996770] Dynamic subtest rcs0: SUCCESS (0.024s) [281.010390] Starting dynamic subtest: bcs0 [281.018376] Dynamic subtest bcs0: SUCCESS (0.021s) [281.031570] Starting dynamic subtest: vcs0 [281.039627] Dynamic subtest vcs0: SUCCESS (0.020s) [281.050377] Starting dynamic subtest: vcs1 [281.063321] Dynamic subtest vcs1: SUCCESS (0.023s) [281.075542] Starting dynamic subtest: vecs0 [281.087778] Dynamic subtest vecs0: SUCCESS (0.023s) [281.097801] Starting dynamic subtest: ccs0 [281.112230] Dynamic subtest ccs0: SUCCESS (0.024s) [281.114569] Subtest preempt: SUCCESS (0.140s) [282.977133] [035/156] (735s left) gem_mmap_gtt (coherency) [283.042539] Subtest coherency: SKIP (0.000s) [283.102440] [036/156] (735s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt) [283.207847] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt [283.212240] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [283.340345] [037/156] (735s left) kms_big_fb (yf-tiled-addfb-size-overflow) [283.439868] Starting subtest: yf-tiled-addfb-size-overflow [283.443899] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [283.542019] [038/156] (735s left) i915_drm_fdinfo (context-close-stress) [283.587401] Starting subtest: context-close-stress [294.328655] Subtest context-close-stress: SUCCESS (10.745s) [294.414530] [039/156] (724s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [294.677704] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc [294.681953] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [294.767390] [040/156] (723s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite) [294.862345] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite [294.866780] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [294.964015] [041/156] (723s left) kms_big_fb (y-tiled-32bpp-rotate-90) [295.061355] Starting subtest: y-tiled-32bpp-rotate-90 [295.065802] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [295.178117] [042/156] (723s left) i915_hangman (gt-engine-error) [295.243432] Starting subtest: gt-engine-error [295.245785] Starting dynamic subtest: rcs0 [296.823847] Dynamic subtest rcs0: SUCCESS (1.580s) [296.836124] Starting dynamic subtest: bcs0 [298.868924] Dynamic subtest bcs0: SUCCESS (2.043s) [298.882440] Starting dynamic subtest: vcs0 [300.852034] Dynamic subtest vcs0: SUCCESS (1.981s) [300.862949] Starting dynamic subtest: vcs1 [302.835647] Dynamic subtest vcs1: SUCCESS (1.980s) [302.850262] Starting dynamic subtest: vecs0 [304.822341] Dynamic subtest vecs0: SUCCESS (1.983s) [304.836197] Starting dynamic subtest: ccs0 [306.869433] Dynamic subtest ccs0: SUCCESS (2.043s) [306.872563] Subtest gt-engine-error: SUCCESS (11.624s) [306.996929] [043/156] (711s left) kms_addfb_basic (addfb25-bad-modifier) [307.092334] Starting subtest: addfb25-bad-modifier [307.094721] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [307.212824] [044/156] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [307.305459] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [307.309501] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [307.398934] [045/156] (711s left) sw_sync (sync_merge_same) [307.432955] Starting subtest: sync_merge_same [307.435383] Subtest sync_merge_same: SUCCESS (0.000s) [307.485541] [046/156] (711s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [307.536929] Starting subtest: invalid-multi-wait-unsubmitted-submitted [307.539381] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [307.624310] [047/156] (711s left) gem_pipe_control_store_loop (reused-buffer) [307.681087] Starting subtest: reused-buffer [309.834209] Subtest reused-buffer: SUCCESS (2.152s) [309.967580] [048/156] (709s left) kms_atomic (plane-invalid-params-fence) [310.057379] Starting subtest: plane-invalid-params-fence [310.059667] Starting dynamic subtest: pipe-A-eDP-1 [310.413499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s) [310.415719] Subtest plane-invalid-params-fence: SUCCESS (0.356s) [311.224036] [049/156] (707s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [311.322629] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [311.324963] Starting dynamic subtest: pipe-A-eDP-1 [311.385065] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [311.396063] Starting dynamic subtest: pipe-B-eDP-1 [311.453652] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [311.464375] Starting dynamic subtest: pipe-C-eDP-1 [311.521100] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [311.532264] Starting dynamic subtest: pipe-D-eDP-1 [311.593722] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [311.597922] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s) [313.594397] [050/156] (705s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-plflip-blt) [313.699670] Starting subtest: hdr-1p-primscrn-indfb-plflip-blt [313.703671] Subtest hdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [313.812013] [051/156] (705s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [313.909969] Starting subtest: psr-rgb565-draw-mmap-wc [320.819553] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.913s) [320.926489] [052/156] (698s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [321.036513] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [321.040726] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [321.127110] [053/156] (698s left) syncobj_wait (wait-all-for-submit-complex) [321.183507] Starting subtest: wait-all-for-submit-complex [321.397740] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [321.485842] [054/156] (697s left) kms_chamelium_audio (hdmi-audio) [321.878095] Subtest hdmi-audio: SKIP (0.000s) [322.746415] [055/156] (696s left) kms_psr (psr2-sprite-plane-onoff) [322.837342] Starting subtest: psr2-sprite-plane-onoff [322.839570] Starting dynamic subtest: eDP-1 [324.600425] Dynamic subtest eDP-1: SUCCESS (1.762s) [324.602664] Subtest psr2-sprite-plane-onoff: SUCCESS (1.763s) [325.431994] [056/156] (693s left) kms_chamelium_edid (dp-mode-timings) [325.823268] Subtest dp-mode-timings: SKIP (0.000s) [326.635188] [057/156] (692s left) gem_exec_reloc (basic-wc-read) [326.707436] Subtest basic-wc-read: SKIP (0.000s) [326.783096] [058/156] (692s left) kms_atomic_transition (plane-toggle-modeset-transition) [326.880428] Starting subtest: plane-toggle-modeset-transition [326.882316] Starting dynamic subtest: pipe-A-eDP-1 [339.657924] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.778s) [339.670485] Starting dynamic subtest: pipe-B-eDP-1 [352.116877] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.455s) [352.119875] Subtest plane-toggle-modeset-transition: SUCCESS (25.239s) [352.943645] [059/156] (666s left) gem_exec_schedule (fairslice) [353.009432] Starting subtest: fairslice [353.011342] Starting dynamic subtest: rcs0 [355.024847] Dynamic subtest rcs0: SUCCESS (2.021s) [355.037503] Starting dynamic subtest: bcs0 [357.043741] Dynamic subtest bcs0: SUCCESS (2.017s) [357.057190] Starting dynamic subtest: vcs0 [359.063175] Dynamic subtest vcs0: SUCCESS (2.019s) [359.072778] Starting dynamic subtest: vcs1 [361.084198] Dynamic subtest vcs1: SUCCESS (2.020s) [361.096936] Starting dynamic subtest: vecs0 [363.106985] Dynamic subtest vecs0: SUCCESS (2.024s) [363.118004] Starting dynamic subtest: ccs0 [365.128131] Dynamic subtest ccs0: SUCCESS (2.020s) [365.130402] Subtest fairslice: SUCCESS (12.124s) [365.425544] [060/156] (654s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [365.527574] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt [365.531905] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [365.622595] [061/156] (653s left) kms_frontbuffer_tracking (basic) [365.722678] Starting subtest: basic [369.067153] Subtest basic: SUCCESS (3.351s) [369.205339] [062/156] (650s left) kms_lease (simple-lease) [369.303006] Starting subtest: simple-lease [369.305045] Starting dynamic subtest: pipe-A-eDP-1 [369.801972] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.498s) [369.813224] Starting dynamic subtest: pipe-B-eDP-1 [371.286509] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s) [371.298875] Starting dynamic subtest: pipe-C-eDP-1 [372.700361] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.410s) [372.710194] Starting dynamic subtest: pipe-D-eDP-1 [374.118874] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.416s) [374.121071] Subtest simple-lease: SUCCESS (4.816s) [374.950063] [063/156] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [375.051795] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [383.785948] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.740s) [383.932648] [064/156] (635s left) kms_vblank (accuracy-idle) [384.032637] Starting subtest: accuracy-idle [384.034539] Starting dynamic subtest: pipe-A-eDP-1 [385.796087] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.765s) [385.810934] Starting dynamic subtest: pipe-D-eDP-1 [388.237354] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s) [388.239253] Subtest accuracy-idle: SUCCESS (4.206s) [389.057393] [065/156] (630s left) kms_getfb (getfb2-into-addfb2) [389.140448] Starting subtest: getfb2-into-addfb2 [389.142725] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [389.254470] [066/156] (630s left) kms_chamelium_hpd (dp-hpd-after-suspend) [389.646099] Subtest dp-hpd-after-suspend: SKIP (0.000s) [390.472921] [067/156] (629s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [390.584063] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf [390.586391] Starting dynamic subtest: pipe-A-eDP-1 [401.265469] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.687s) [401.277364] Starting dynamic subtest: pipe-B-eDP-1 [412.695535] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.429s) [412.698157] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.118s) [413.539897] [068/156] (606s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt) [413.639040] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt [413.643134] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [413.729417] [069/156] (606s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [413.825895] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [413.829809] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [413.938882] [070/156] (605s left) kms_atomic_interruptible (universal-setplane-primary) [414.038506] Starting subtest: universal-setplane-primary [414.040755] Starting dynamic subtest: pipe-A-eDP-1 [421.457345] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.419s) [421.459613] Subtest universal-setplane-primary: SUCCESS (7.420s) [422.302736] [071/156] (597s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt) [422.412717] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt [422.416784] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [422.512993] [072/156] (597s left) kms_scaling_modes (scaling-mode-none) [422.599661] Starting subtest: scaling-mode-none [422.601955] Starting dynamic subtest: pipe-A-eDP-1 [422.692966] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s) [422.704885] Starting dynamic subtest: pipe-B-eDP-1 [422.731721] Dynamic subtest pipe-B-eDP-1: SKIP (0.036s) [422.744202] Starting dynamic subtest: pipe-C-eDP-1 [422.762352] Dynamic subtest pipe-C-eDP-1: SKIP (0.030s) [422.773476] Starting dynamic subtest: pipe-D-eDP-1 [422.796024] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s) [422.800101] Subtest scaling-mode-none: SKIP (0.197s) [422.909484] [073/156] (597s left) kms_flip (plain-flip-fb-recreate) [422.995981] Starting subtest: plain-flip-fb-recreate [422.998238] Starting dynamic subtest: A-eDP1 [431.878604] Dynamic subtest A-eDP1: SUCCESS (8.884s) [431.891958] Starting dynamic subtest: B-eDP1 [440.722271] Dynamic subtest B-eDP1: SUCCESS (8.840s) [440.732873] Starting dynamic subtest: C-eDP1 [449.546629] Dynamic subtest C-eDP1: SUCCESS (8.820s) [449.557192] Starting dynamic subtest: D-eDP1 [458.384365] Dynamic subtest D-eDP1: SUCCESS (8.834s) [458.388305] Subtest plain-flip-fb-recreate: SUCCESS (35.388s) [459.571611] [074/156] (560s left) dmabuf_sync_file (import-multiple-read-write) [459.719203] Starting subtest: import-multiple-read-write [459.721124] Subtest import-multiple-read-write: SUCCESS (0.003s) [459.772649] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true [459.775833] [075/156] (560s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [459.873343] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [459.875781] Starting dynamic subtest: pipe-A-eDP-1 [476.316333] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.413s) [476.326621] Starting dynamic subtest: pipe-B-eDP-1 [493.308878] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.396s) [493.319947] Starting dynamic subtest: pipe-C-eDP-1 [510.293164] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.459s) [510.311858] Starting dynamic subtest: pipe-D-eDP-1 [527.266561] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.381s) [527.269058] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.655s) [528.488372] [076/156] (491s left) sysfs_defaults (readonly) [528.568806] Starting subtest: readonly [528.571624] Starting dynamic subtest: vecs0 [528.574248] Dynamic subtest vecs0: SUCCESS (0.000s) [528.584675] Starting dynamic subtest: ccs0 [528.587381] Dynamic subtest ccs0: SUCCESS (0.000s) [528.597723] Starting dynamic subtest: vcs0 [528.600505] Dynamic subtest vcs0: SUCCESS (0.000s) [528.610631] Starting dynamic subtest: bcs0 [528.613422] Dynamic subtest bcs0: SUCCESS (0.000s) [528.625494] Starting dynamic subtest: rcs0 [528.627715] Dynamic subtest rcs0: SUCCESS (0.000s) [528.638358] Starting dynamic subtest: vcs1 [528.641351] Dynamic subtest vcs1: SUCCESS (0.000s) [528.644430] Subtest readonly: SUCCESS (0.006s) [528.684976] [077/156] (491s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [528.779481] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc [528.785388] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [528.880720] [078/156] (491s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [528.937712] Starting subtest: single-wait-all-for-submit-available-signaled [528.940582] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [529.037536] [079/156] (491s left) kms_frontbuffer_tracking (fbchdr-stridechange) [529.140624] Starting subtest: fbchdr-stridechange [529.146229] Subtest fbchdr-stridechange: SKIP (0.000s) [529.239170] [080/156] (491s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc) [529.340920] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc [529.345449] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s) [529.431388] [081/156] (490s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt) [529.525464] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt [529.529391] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [529.601071] [082/156] (490s left) kms_setmode (invalid-clone-single-crtc) [529.665983] Starting subtest: invalid-clone-single-crtc [529.673453] Subtest invalid-clone-single-crtc: SKIP (0.000s) [529.773836] [083/156] (490s left) drm_read (fault-buffer) [529.913706] Starting subtest: fault-buffer [529.916353] Subtest fault-buffer: SUCCESS (0.000s) [530.068815] [084/156] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [530.172314] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [530.176977] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [530.275017] [085/156] (490s left) gem_exec_suspend (basic-s0) [530.337124] Starting subtest: basic-S0 [530.339326] Starting dynamic subtest: smem [550.070702] Dynamic subtest smem: SUCCESS (6.421s) [550.073860] Subtest basic-S0: SUCCESS (6.424s) [550.258884] [086/156] (470s left) kms_async_flips (crc) [550.365878] Starting subtest: crc [550.750795] Starting dynamic subtest: pipe-A-eDP-1 [553.692846] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.951s) [554.060221] Starting dynamic subtest: pipe-B-eDP-1 [557.015002] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.971s) [557.393665] Starting dynamic subtest: pipe-C-eDP-1 [560.325752] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.949s) [560.705791] Starting dynamic subtest: pipe-D-eDP-1 [563.561080] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.872s) [563.563944] Subtest crc: SUCCESS (13.226s) [564.741325] [087/156] (455s left) prime_self_import (reimport-vs-gem_close-race) [564.782719] Starting subtest: reimport-vs-gem_close-race [569.870229] Subtest reimport-vs-gem_close-race: SUCCESS (5.093s) [569.948939] [088/156] (450s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [570.057557] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [570.062543] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [570.152534] [089/156] (450s left) syncobj_eventfd (timeline-wait-signaled) [570.212690] Starting subtest: timeline-wait-signaled [570.215389] Subtest timeline-wait-signaled: SUCCESS (0.000s) [570.306852] [090/156] (450s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite) [570.410398] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite [570.414897] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [570.512270] [091/156] (450s left) core_debugfs (read-all-entries) [570.565572] Starting subtest: read-all-entries [570.661896] Subtest read-all-entries: SUCCESS (0.096s) [570.728857] [092/156] (450s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [570.791689] Starting subtest: multi-wait-available-unsubmitted-submitted [570.794352] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [570.888309] [093/156] (450s left) syncobj_wait (multi-wait-all-for-submit-signaled) [570.937849] Starting subtest: multi-wait-all-for-submit-signaled [570.940255] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [571.041723] [094/156] (449s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [571.125985] Starting subtest: flip-vs-dpms-on-nop-interruptible [571.128568] Starting dynamic subtest: A-eDP1 [573.038715] Dynamic subtest A-eDP1: SUCCESS (1.912s) [573.049672] Starting dynamic subtest: B-eDP1 [574.865903] Dynamic subtest B-eDP1: SUCCESS (1.826s) [574.881052] Starting dynamic subtest: C-eDP1 [576.687700] Dynamic subtest C-eDP1: SUCCESS (1.821s) [576.698543] Starting dynamic subtest: D-eDP1 [578.515382] Dynamic subtest D-eDP1: SUCCESS (1.827s) [578.517827] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.396s) [579.692559] [095/156] (441s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [579.819436] Starting subtest: basic-flip-before-cursor-varying-size [580.742862] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.926s) [581.617561] [096/156] (439s left) gem_exec_reloc (basic-gtt-read) [581.667371] Subtest basic-gtt-read: SKIP (0.000s) [581.735480] [097/156] (439s left) gem_userptr_blits (unsync-unmap) [581.793703] Subtest unsync-unmap: SKIP (0.000s) [581.901887] [098/156] (439s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [581.997966] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [582.002803] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [582.085044] [099/156] (439s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [582.183556] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [582.188883] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [582.271848] [100/156] (438s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt) [582.376608] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt [582.381426] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [582.466780] [101/156] (438s left) kms_psr (fbc-pr-cursor-blt) [582.563336] Starting subtest: fbc-pr-cursor-blt [582.567534] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [582.634548] [102/156] (438s left) kms_cursor_edge_walk (64x64-top-bottom) [582.719435] Starting subtest: 64x64-top-bottom [582.721652] Starting dynamic subtest: pipe-A-eDP-1 [586.163274] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s) [586.175534] Starting dynamic subtest: pipe-D-eDP-1 [589.365221] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.207s) [589.367928] Subtest 64x64-top-bottom: SUCCESS (6.663s) [590.183980] [103/156] (431s left) gem_eio (context-create) [590.415067] Starting subtest: context-create [590.758198] Subtest context-create: SUCCESS (0.345s) [590.910465] [104/156] (430s left) gem_exec_params (cliprects_ptr-dirt) [590.971839] Starting subtest: cliprects_ptr-dirt [590.973972] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [591.066452] [105/156] (430s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt) [591.162294] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt [591.166462] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [591.254891] [106/156] (430s left) kms_color (degamma) [591.345377] Starting subtest: degamma [591.347731] Starting dynamic subtest: pipe-A-eDP-1 [592.078325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s) [592.089066] Starting dynamic subtest: pipe-B-eDP-1 [593.531045] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.453s) [593.542029] Starting dynamic subtest: pipe-C-eDP-1 [594.877272] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s) [594.889741] Starting dynamic subtest: pipe-D-eDP-1 [596.328962] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.448s) [596.331512] Subtest degamma: SUCCESS (4.988s) [597.211415] [107/156] (424s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [597.309865] Starting subtest: yf-tiled-16bpp-rotate-270 [597.314908] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [597.407608] [108/156] (424s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [597.518493] Starting subtest: 2x-cursor-vs-flip-legacy [597.523329] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s) [597.662314] [109/156] (423s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [597.748405] Starting subtest: bad-pixel-format-y-tiled-ccs [597.750722] Starting dynamic subtest: pipe-A-eDP-1 [597.774553] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [597.786520] Starting dynamic subtest: pipe-B-eDP-1 [597.812057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [597.822969] Starting dynamic subtest: pipe-C-eDP-1 [597.848481] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [597.859881] Starting dynamic subtest: pipe-D-eDP-1 [597.885625] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [597.889930] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [600.057800] [110/156] (421s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt) [600.164710] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt [600.169798] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [600.263557] [111/156] (421s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [600.360246] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [600.365436] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [600.458775] [112/156] (421s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [600.559805] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [600.564706] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [600.651259] [113/156] (421s left) gem_create (create-size-update) [600.700845] Starting subtest: create-size-update [600.703330] Subtest create-size-update: SUCCESS (0.000s) [600.903509] [114/156] (420s left) kms_plane_alpha_blend (alpha-opaque-fb) [601.010821] Starting subtest: alpha-opaque-fb [601.305955] Starting dynamic subtest: pipe-A-eDP-1 [602.004854] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [602.016831] Starting dynamic subtest: pipe-D-eDP-1 [603.438678] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s) [603.441126] Subtest alpha-opaque-fb: SUCCESS (2.432s) [604.319317] [115/156] (417s left) kms_getfb (getfb-handle-closed) [604.413865] Starting subtest: getfb-handle-closed [604.416751] Subtest getfb-handle-closed: SUCCESS (0.000s) [604.515260] [116/156] (417s left) kms_big_fb (x-tiled-64bpp-rotate-90) [604.614390] Starting subtest: x-tiled-64bpp-rotate-90 [604.634787] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [604.739746] [117/156] (417s left) sw_sync (alloc_merge_fence) [604.775911] Starting subtest: alloc_merge_fence [604.778495] Subtest alloc_merge_fence: SUCCESS (0.000s) [604.838031] [118/156] (417s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [604.931186] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [604.935707] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [605.021185] [119/156] (416s left) kms_feature_discovery (display-4x) [605.109861] Starting subtest: display-4x [605.115295] Subtest display-4x: SKIP (0.000s) [605.186703] [120/156] (416s left) gen9_exec_parse (bb-secure) [605.248766] Subtest bb-secure: SKIP (0.000s) [605.328402] [121/156] (416s left) kms_big_fb (linear-32bpp-rotate-90) [605.441859] Starting subtest: linear-32bpp-rotate-90 [605.461830] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [605.575942] [122/156] (416s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [605.675222] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [605.679915] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [605.787251] [123/156] (416s left) kms_properties (colorop-properties-atomic) [605.882488] Starting subtest: colorop-properties-atomic [605.884705] Starting dynamic subtest: pipe-A-eDP-1 [606.238801] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s) [606.250490] Starting dynamic subtest: pipe-B-eDP-1 [607.295981] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.055s) [607.307922] Starting dynamic subtest: pipe-C-eDP-1 [608.431088] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.137s) [608.443634] Starting dynamic subtest: pipe-D-eDP-1 [609.556915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s) [609.559496] Subtest colorop-properties-atomic: SUCCESS (3.675s) [610.366334] [124/156] (411s left) kms_vrr (flip-suspend) [610.458681] Starting subtest: flip-suspend [610.465843] Subtest flip-suspend: SKIP (0.000s) [610.530903] [125/156] (411s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [610.622856] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [611.324221] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.703s) [611.477485] [126/156] (410s left) gem_exec_fence (syncobj-timeline-invalid-wait) [612.034227] Starting subtest: syncobj-timeline-invalid-wait [612.036970] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [613.135344] [127/156] (409s left) kms_psr (fbc-psr-primary-render) [613.222890] Starting subtest: fbc-psr-primary-render [613.225198] Starting dynamic subtest: eDP-1 [613.229728] Dynamic subtest eDP-1: SKIP (0.000s) [613.234693] Subtest fbc-psr-primary-render: SKIP (0.001s) [613.300575] [128/156] (409s left) gem_caching (read-writes) [613.359708] Subtest read-writes: SKIP (0.000s) [613.441210] [129/156] (409s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [613.538296] Starting subtest: primary-y-tiled-reflect-x-180 [613.609035] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s) [613.717592] [130/156] (408s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite) [613.826264] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite [613.830873] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [613.935222] [131/156] (408s left) perf (polling-small-buf) [614.085478] Starting subtest: polling-small-buf [614.176993] Subtest polling-small-buf: SUCCESS (0.093s) [614.228453] [132/156] (408s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [614.332339] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [614.336701] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [614.429732] [133/156] (408s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [614.537440] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt [614.541820] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [614.635222] [134/156] (408s left) gem_exec_whisper (basic-queues-forked-all) [614.699867] Starting subtest: basic-queues-forked-all [638.302390] Subtest basic-queues-forked-all: SUCCESS (23.599s) [638.489179] [135/156] (384s left) gem_vm_create (invalid-create) [638.549060] Starting subtest: invalid-create [638.551800] Subtest invalid-create: SUCCESS (0.002s) [638.647383] [136/156] (384s left) kms_pm_rpm (modeset-lpsp-stress) [640.172306] Starting subtest: modeset-lpsp-stress [656.808892] Subtest modeset-lpsp-stress: SUCCESS (16.639s) [656.911425] [137/156] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [657.011044] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [657.016031] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [657.106514] [138/156] (365s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt) [657.207726] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt [657.212320] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [657.291311] [139/156] (365s left) gem_pxp (display-protected-crc) [657.412815] Starting subtest: display-protected-crc [659.364085] Subtest display-protected-crc: SUCCESS (1.954s) [659.483595] [140/156] (363s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render) [659.591926] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render [659.596879] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [659.705689] [141/156] (363s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [661.250082] Starting subtest: modeset-lpsp-stress-no-wait [671.596675] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.352s) [671.700831] [142/156] (351s left) prime_vgem (basic-blt) [671.773056] Starting subtest: basic-blt [671.821427] Subtest basic-blt: SUCCESS (0.049s) [671.935590] [143/156] (351s left) gem_eio (reset-stress) [672.150697] Starting subtest: reset-stress [672.152707] Starting dynamic subtest: render [676.871989] Dynamic subtest render: SUCCESS (4.719s) [676.890516] Starting dynamic subtest: bsd1 [694.496822] Dynamic subtest bsd1: SUCCESS (17.617s) [694.514589] Starting dynamic subtest: bsd2 [712.567609] Dynamic subtest bsd2: SUCCESS (18.067s) [712.585504] Starting dynamic subtest: blt [712.589764] Dynamic subtest blt: SKIP (0.000s) [712.601229] Starting dynamic subtest: vebox [730.544083] Dynamic subtest vebox: SUCCESS (17.976s) [730.546463] Subtest reset-stress: SUCCESS (58.385s) [732.079448] [144/156] (291s left) kms_cursor_crc (cursor-rapid-movement-512x512) [732.390708] Starting subtest: cursor-rapid-movement-512x512 [732.396498] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [732.573892] [145/156] (290s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [732.659002] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [732.661753] Starting dynamic subtest: pipe-A-default-mode [735.394365] Dynamic subtest pipe-A-default-mode: SUCCESS (2.734s) [735.396864] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.736s) [736.262026] [146/156] (286s left) kms_debugfs (display-off-read-all) [736.358800] Starting subtest: display-off-read-all [736.658854] Subtest display-off-read-all: SUCCESS (0.301s) [737.501807] [147/156] (285s left) kms_flip (2x-flip-vs-modeset) [737.601710] Starting subtest: 2x-flip-vs-modeset [737.613071] Subtest 2x-flip-vs-modeset: SKIP (0.010s) [737.724918] [148/156] (285s left) gem_exec_schedule (timeslicing) [737.799860] Starting subtest: timeslicing [737.802837] Starting dynamic subtest: rcs0 [737.810035] Dynamic subtest rcs0: SUCCESS (0.022s) [737.823478] Starting dynamic subtest: bcs0 [737.828915] Dynamic subtest bcs0: SUCCESS (0.019s) [737.841215] Starting dynamic subtest: vcs0 [737.849977] Dynamic subtest vcs0: SUCCESS (0.022s) [737.861961] Starting dynamic subtest: vcs1 [737.870972] Dynamic subtest vcs1: SUCCESS (0.021s) [737.882967] Starting dynamic subtest: vecs0 [737.892089] Dynamic subtest vecs0: SUCCESS (0.021s) [737.904248] Starting dynamic subtest: ccs0 [737.915036] Dynamic subtest ccs0: SUCCESS (0.022s) [737.917862] Subtest timeslicing: SUCCESS (0.131s) [739.105705] [149/156] (284s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [739.162448] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [739.167762] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [739.349178] [150/156] (284s left) kms_cursor_crc (cursor-offscreen-128x42) [739.590463] Starting subtest: cursor-offscreen-128x42 [739.638878] Subtest cursor-offscreen-128x42: SKIP (0.043s) [739.836387] [151/156] (283s left) kms_psr (pr-sprite-plane-onoff) [739.931927] Starting subtest: pr-sprite-plane-onoff [739.937034] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [740.011595] [152/156] (283s left) perf_pmu (busy-check-all) [740.051029] Starting subtest: busy-check-all [740.053724] Starting dynamic subtest: rcs0 [740.601986] Dynamic subtest rcs0: SUCCESS (0.551s) [740.620227] Starting dynamic subtest: bcs0 [741.159210] Dynamic subtest bcs0: SUCCESS (0.554s) [741.176645] Starting dynamic subtest: vcs0 [743.029821] Dynamic subtest vcs0: SUCCESS (1.867s) [743.045850] Starting dynamic subtest: vcs1 [745.013882] Dynamic subtest vcs1: SUCCESS (1.982s) [745.029403] Starting dynamic subtest: vecs0 [747.063450] Dynamic subtest vecs0: SUCCESS (2.046s) [747.079623] Starting dynamic subtest: ccs0 [747.624443] Dynamic subtest ccs0: SUCCESS (0.560s) [747.627365] Subtest busy-check-all: SUCCESS (7.576s) [747.733864] [153/156] (275s left) kms_addfb_basic (too-wide) [747.841712] Starting subtest: too-wide [747.844439] Subtest too-wide: SUCCESS (0.000s) [747.953330] [154/156] (275s left) gem_partial_pwrite_pread (reads-display) [748.017101] Subtest reads-display: SKIP (0.000s) [748.089577] [155/156] (275s left) gem_mmap_offset (partial-unmap) [748.145000] Starting subtest: partial-unmap [748.147426] Starting dynamic subtest: smem0 [748.653657] Dynamic subtest smem0: SUCCESS (0.508s) [748.656806] Subtest partial-unmap: SUCCESS (0.509s) [748.764045] [156/156] (274s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [748.858860] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [748.863849] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [748.950056] 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.