[59.395946] Initializing watchdogs [59.395994] /dev/watchdog0 [59.410425] [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] [59.414836] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.417467] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.420866] [001/133] (960s left) gem_partial_pwrite_pread (writes-after-reads) [59.514079] Subtest writes-after-reads: SKIP (0.000s) [59.583539] [002/133] (960s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [59.638353] Starting subtest: single-wait-all-for-submit-available-signaled [59.640633] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [59.745842] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [59.846197] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [59.850254] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [59.963122] [004/133] (960s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [60.082325] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [60.213476] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.135s) [60.339223] [005/133] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [60.429865] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [60.433163] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [60.519529] [006/133] (959s left) gem_mmap_wc (write-read-distinct) [60.574488] Subtest write-read-distinct: SKIP (0.000s) [60.625442] [007/133] (959s left) kms_big_fb (y-tiled-64bpp-rotate-90) [60.726914] Starting subtest: y-tiled-64bpp-rotate-90 [60.730539] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [60.814091] [008/133] (959s left) kms_addfb_basic (bo-too-small-due-to-tiling) [60.895075] Starting subtest: bo-too-small-due-to-tiling [60.898834] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [60.979982] [009/133] (959s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [61.068964] Starting subtest: async-flip-with-page-flip-events-linear-atomic [61.459488] Starting dynamic subtest: pipe-A-eDP-1 [64.191334] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.739s) [64.558844] Starting dynamic subtest: pipe-B-eDP-1 [67.310547] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s) [67.683259] Starting dynamic subtest: pipe-C-eDP-1 [70.438764] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s) [70.803359] Starting dynamic subtest: pipe-D-eDP-1 [73.569430] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s) [73.572041] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.526s) [74.751297] [010/133] (945s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [74.851593] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [74.855916] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [74.955418] [011/133] (945s left) i915_drm_fdinfo (context-close-stress) [74.998843] Starting subtest: context-close-stress [85.743647] Subtest context-close-stress: SUCCESS (10.745s) [85.815964] [012/133] (934s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [86.100291] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [87.270034] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.171s) [87.393353] [013/133] (932s left) prime_mmap (test_reprime) [87.455344] Starting subtest: test_reprime [87.457100] Starting dynamic subtest: test_reprime-smem [87.484609] Dynamic subtest test_reprime-smem: SUCCESS (0.030s) [87.486659] Subtest test_reprime: SUCCESS (0.031s) [87.577380] [014/133] (932s left) kms_pm_rpm (i2c) [89.108988] Starting subtest: i2c [94.503083] Subtest i2c: SUCCESS (5.395s) [94.586056] [015/133] (925s left) gem_linear_blits (basic) [94.991290] Starting subtest: basic [94.999922] Subtest basic: SUCCESS (0.009s) [95.132175] [016/133] (925s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [95.257638] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [95.259872] Starting dynamic subtest: pipe-A-default-mode [96.438605] Dynamic subtest pipe-A-default-mode: SKIP (1.178s) [96.442624] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.179s) [96.584157] [017/133] (923s left) api_intel_bb (reset-flags) [96.660903] Starting subtest: reset-flags [96.666921] Subtest reset-flags: SUCCESS (0.007s) [96.785847] [018/133] (923s left) gem_exec_reloc (basic-concurrent0) [96.845530] Subtest basic-concurrent0: SKIP (0.000s) [96.907763] [019/133] (923s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [96.997233] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [97.001179] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [97.062501] [020/133] (923s left) kms_scaling_modes (scaling-mode-center) [97.158130] Starting subtest: scaling-mode-center [97.160427] Starting dynamic subtest: pipe-A-eDP-1 [97.250051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s) [97.257552] Starting dynamic subtest: pipe-B-eDP-1 [98.432196] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s) [98.443231] Starting dynamic subtest: pipe-C-eDP-1 [99.550417] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s) [99.559235] Starting dynamic subtest: pipe-D-eDP-1 [100.683342] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s) [100.685631] Subtest scaling-mode-center: SUCCESS (3.528s) [101.838999] [021/133] (918s left) kms_psr (psr-cursor-blt) [101.932327] Starting subtest: psr-cursor-blt [101.934615] Starting dynamic subtest: eDP-1 [103.631608] Dynamic subtest eDP-1: SUCCESS (1.701s) [103.634028] Subtest psr-cursor-blt: SUCCESS (1.702s) [104.510200] [022/133] (916s left) kms_invalid_mode (bad-vtotal) [104.605527] Starting subtest: bad-vtotal [104.607857] Starting dynamic subtest: pipe-A-eDP-1 [104.892231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [104.901643] Starting dynamic subtest: pipe-B-eDP-1 [104.903956] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [104.911479] Starting dynamic subtest: pipe-C-eDP-1 [104.913815] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [104.920865] Starting dynamic subtest: pipe-D-eDP-1 [104.922877] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [104.924869] Subtest bad-vtotal: SUCCESS (0.292s) [105.746957] [023/133] (915s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [105.845165] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [105.849383] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [105.920525] [024/133] (914s left) kms_feature_discovery (display-1x) [106.009076] Starting subtest: display-1x [106.011432] Subtest display-1x: SUCCESS (0.000s) [106.078063] [025/133] (914s left) sw_sync (sync_busy_fork) [106.118291] Starting subtest: sync_busy_fork [107.129654] Subtest sync_busy_fork: SUCCESS (1.010s) [107.190849] [026/133] (913s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [107.298309] Starting subtest: verify-pxp-key-change-after-suspend-resume [115.402447] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.105s) [115.523609] [027/133] (905s left) kms_plane_multiple (tiling-x) [115.633044] Starting subtest: tiling-x [115.634988] Starting dynamic subtest: pipe-A-eDP-1 [119.405670] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.774s) [119.415604] Starting dynamic subtest: pipe-B-eDP-1 [123.879789] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.473s) [123.890809] Starting dynamic subtest: pipe-C-eDP-1 [128.292083] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.411s) [128.301714] Starting dynamic subtest: pipe-D-eDP-1 [132.635521] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.345s) [132.637859] Subtest tiling-x: SUCCESS (17.006s) [133.442772] [028/133] (887s left) vgem_basic (create) [133.572773] Starting subtest: create [133.575076] Subtest create: SUCCESS (0.000s) [133.626821] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true [133.629844] [029/133] (887s left) gem_userptr_blits (set-cache-level) [133.710108] Starting subtest: set-cache-level [133.714398] Subtest set-cache-level: SKIP (0.000s) [133.865340] [030/133] (887s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [133.980237] Starting subtest: flip-vs-cursor-crc-legacy [134.664218] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.683s) [135.482457] [031/133] (885s left) kms_content_protection (dp-mst-type-0-hdcp14) [135.621016] Starting subtest: dp-mst-type-0-hdcp14 [135.625507] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [135.727752] [032/133] (885s left) gen9_exec_parse (bb-start-cmd) [135.792055] Subtest bb-start-cmd: SKIP (0.000s) [135.865347] [033/133] (885s left) kms_dp_link_training (uhbr-mst) [135.954224] Starting subtest: uhbr-mst [135.963284] Subtest uhbr-mst: SKIP (0.000s) [136.044738] [034/133] (885s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [136.153396] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [137.199670] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.046s) [137.308331] [035/133] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [137.410381] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [137.413860] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [137.499560] [036/133] (883s left) gem_exec_create (legacy) [137.574066] Starting subtest: legacy [137.575983] Starting dynamic subtest: smem [140.888402] Dynamic subtest smem: SUCCESS (3.312s) [140.891071] Subtest legacy: SUCCESS (3.314s) [141.072931] [037/133] (880s left) gem_exec_whisper (basic-contexts-forked-all) [141.136148] Starting subtest: basic-contexts-forked-all [163.701068] Subtest basic-contexts-forked-all: SUCCESS (22.563s) [163.881816] [038/133] (857s left) kms_big_fb (linear-64bpp-rotate-90) [163.992195] Starting subtest: linear-64bpp-rotate-90 [164.012266] Subtest linear-64bpp-rotate-90: SKIP (0.020s) [164.141597] [039/133] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [164.241306] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [164.245545] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [164.341181] [040/133] (857s left) gem_lmem_swapping (smem-oom) [164.383603] Subtest smem-oom: SKIP (0.000s) [164.429759] [041/133] (857s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [164.530790] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [164.535113] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [164.646245] [042/133] (856s left) gem_render_copy (y-tiled-to-vebox-linear) [164.716250] Starting subtest: y-tiled-to-vebox-linear [164.720962] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [164.900391] [043/133] (856s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [164.995478] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [165.000051] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [165.083683] [044/133] (856s left) gem_softpin (allocator-fork) [165.148673] Starting subtest: allocator-fork [167.360370] Subtest allocator-fork: SUCCESS (2.210s) [167.477212] [045/133] (854s left) kms_addfb_basic (too-wide) [167.582806] Starting subtest: too-wide [167.585098] Subtest too-wide: SUCCESS (0.000s) [167.675825] [046/133] (854s left) perf_pmu (busy-double-start) [167.721063] Starting subtest: busy-double-start [167.722933] Starting dynamic subtest: rcs0 [171.363762] Dynamic subtest rcs0: FAIL (3.589s) [171.374058] Starting dynamic subtest: bcs0 [174.876676] Dynamic subtest bcs0: SUCCESS (3.567s) [174.887730] Starting dynamic subtest: vcs0 [179.415894] Dynamic subtest vcs0: SUCCESS (4.537s) [179.425787] Starting dynamic subtest: vcs1 [183.454966] Dynamic subtest vcs1: SUCCESS (4.037s) [183.473933] Starting dynamic subtest: vecs0 [187.446773] Dynamic subtest vecs0: SUCCESS (3.990s) [187.458154] Starting dynamic subtest: ccs0 [191.084685] Dynamic subtest ccs0: FAIL (3.566s) [191.086601] Subtest busy-double-start: FAIL (23.295s) [191.126041] [047/133] (830s left) kms_plane_scaling (planes-upscale-20x20) [191.218623] Starting subtest: planes-upscale-20x20 [191.220919] Starting dynamic subtest: pipe-A [191.280757] Dynamic subtest pipe-A: SUCCESS (0.062s) [191.294876] Starting dynamic subtest: pipe-B [192.398943] Dynamic subtest pipe-B: SUCCESS (1.116s) [192.413697] Starting dynamic subtest: pipe-C [193.498551] Dynamic subtest pipe-C: SUCCESS (1.098s) [193.509072] Starting dynamic subtest: pipe-D [194.632505] Dynamic subtest pipe-D: SUCCESS (1.133s) [194.634843] Subtest planes-upscale-20x20: SUCCESS (3.414s) [195.786948] [048/133] (825s left) i915_pm_rpm (gem-execbuf) [198.117716] Starting subtest: gem-execbuf [198.120240] Starting dynamic subtest: smem0 [200.167376] Dynamic subtest smem0: SUCCESS (2.053s) [200.169669] Subtest gem-execbuf: SUCCESS (2.055s) [200.267979] [049/133] (821s left) kms_chamelium_edid (dp-edid-resolution-list) [200.648164] Subtest dp-edid-resolution-list: SKIP (0.000s) [201.428549] [050/133] (820s left) vgem_basic (dmabuf-export) [201.477370] Starting subtest: dmabuf-export [201.507688] Subtest dmabuf-export: SUCCESS (0.032s) [201.628546] [051/133] (820s left) kms_vblank (ts-continuation-idle) [201.728750] Starting subtest: ts-continuation-idle [201.730622] Starting dynamic subtest: pipe-A-eDP-1 [202.126613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s) [202.141693] Starting dynamic subtest: pipe-D-eDP-1 [203.236483] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.109s) [203.238956] Subtest ts-continuation-idle: SUCCESS (1.509s) [204.117920] [052/133] (817s left) kms_psr (fbc-psr-no-drrs) [204.218751] Starting subtest: fbc-psr-no-drrs [204.221266] Starting dynamic subtest: eDP-1 [204.225665] Dynamic subtest eDP-1: SKIP (0.000s) [204.229746] Subtest fbc-psr-no-drrs: SKIP (0.001s) [204.290977] [053/133] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [204.391214] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [211.681696] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.293s) [211.819220] [054/133] (810s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [211.916342] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [211.920190] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [212.004235] [055/133] (810s left) kms_async_flips (test-cursor) [212.092227] Starting subtest: test-cursor [212.463060] Starting dynamic subtest: pipe-A-eDP-1 [213.215533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s) [213.604700] Starting dynamic subtest: pipe-B-eDP-1 [214.348266] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s) [214.716719] Starting dynamic subtest: pipe-C-eDP-1 [215.472836] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [215.852711] Starting dynamic subtest: pipe-D-eDP-1 [216.616134] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s) [216.618451] Subtest test-cursor: SUCCESS (4.527s) [217.801094] [056/133] (804s left) gem_ctx_shared (q-promotion) [217.866909] Starting subtest: Q-promotion [217.869332] Starting dynamic subtest: rcs0 [217.972747] Dynamic subtest rcs0: SUCCESS (0.105s) [217.991090] Starting dynamic subtest: vcs0 [218.076305] Dynamic subtest vcs0: SUCCESS (0.102s) [218.094196] Starting dynamic subtest: vcs1 [218.162092] Dynamic subtest vcs1: SUCCESS (0.084s) [218.179176] Starting dynamic subtest: vecs0 [218.242717] Dynamic subtest vecs0: SUCCESS (0.079s) [218.260349] Starting dynamic subtest: ccs0 [218.315892] Dynamic subtest ccs0: SUCCESS (0.072s) [218.318722] Subtest Q-promotion: SUCCESS (0.448s) [220.005083] [057/133] (802s left) kms_color (ctm-signed) [220.107046] Starting subtest: ctm-signed [220.109264] Starting dynamic subtest: pipe-A-eDP-1 [222.180192] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.073s) [222.189883] Starting dynamic subtest: pipe-B-eDP-1 [224.948893] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s) [224.962432] Starting dynamic subtest: pipe-C-eDP-1 [227.563351] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.615s) [227.574179] Starting dynamic subtest: pipe-D-eDP-1 [230.222381] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.657s) [230.224783] Subtest ctm-signed: SUCCESS (10.117s) [231.055329] [058/133] (791s left) gem_eio (in-flight-internal-10ms) [231.276026] Starting subtest: in-flight-internal-10ms [232.992469] Subtest in-flight-internal-10ms: SUCCESS (1.715s) [233.144443] [059/133] (789s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [233.205423] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [233.313516] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s) [233.392696] [060/133] (788s left) kms_rotation_crc (sprite-rotation-180) [233.494397] Starting subtest: sprite-rotation-180 [240.250083] Subtest sprite-rotation-180: SUCCESS (6.758s) [241.412307] [061/133] (780s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [241.522126] Starting subtest: fbcpsr-stridechange [247.732631] Subtest fbcpsr-stridechange: SUCCESS (6.211s) [247.859244] [062/133] (774s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [247.956792] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [247.959082] Starting dynamic subtest: pipe-A-eDP-1 [248.017272] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [248.029093] Starting dynamic subtest: pipe-B-eDP-1 [248.085293] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [248.096552] Starting dynamic subtest: pipe-C-eDP-1 [248.152681] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [248.165555] Starting dynamic subtest: pipe-D-eDP-1 [248.222203] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [248.226586] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s) [250.120198] [063/133] (772s left) kms_cursor_legacy (cursor-vs-flip-legacy) [250.243435] Starting subtest: cursor-vs-flip-legacy [279.897283] Subtest cursor-vs-flip-legacy: SUCCESS (29.652s) [280.755137] [064/133] (741s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [280.859285] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [280.861089] Starting dynamic subtest: pipe-A-eDP-1 [281.270963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s) [281.282062] Starting dynamic subtest: pipe-B-eDP-1 [281.302788] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [281.314620] Starting dynamic subtest: pipe-C-eDP-1 [281.335610] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [281.355506] Starting dynamic subtest: pipe-D-eDP-1 [281.376039] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [281.378404] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.428s) [283.606517] [065/133] (738s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [283.698811] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [283.703206] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [283.792898] [066/133] (738s left) gem_exec_fence (syncobj-timeline-chain-engines) [284.358561] Starting subtest: syncobj-timeline-chain-engines [284.488593] Subtest syncobj-timeline-chain-engines: SUCCESS (0.133s) [285.900360] [067/133] (736s left) gem_mmap_gtt (basic-small-bo-tiledy) [285.961357] Subtest basic-small-bo-tiledY: SKIP (0.000s) [286.052357] [068/133] (736s left) gem_mmap_wc (write-read) [286.101209] Subtest write-read: SKIP (0.000s) [286.166744] [069/133] (736s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [286.283028] Starting subtest: psr-rgb101010-draw-mmap-cpu [293.378539] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.099s) [293.491351] [070/133] (729s left) gem_mmap_offset (oob-read) [293.549249] Starting subtest: oob-read [293.551588] Subtest oob-read: SUCCESS (0.000s) [293.635401] [071/133] (729s left) gem_barrier_race (remote-request) [293.710430] Starting subtest: remote-request [293.712380] Starting dynamic subtest: rcs0 [298.911590] Dynamic subtest rcs0: SUCCESS (5.203s) [298.916229] Subtest remote-request: SUCCESS (5.204s) [299.072325] [072/133] (723s left) gem_exec_reloc (basic-write-gtt) [299.128872] Subtest basic-write-gtt: SKIP (0.000s) [299.193587] [073/133] (723s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [299.278057] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [306.036484] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.758s) [306.154606] [074/133] (716s left) gem_ctx_isolation (nonpriv-switch) [306.225940] Starting subtest: nonpriv-switch [306.228015] Starting dynamic subtest: rcs0 [306.490880] Dynamic subtest rcs0: SUCCESS (0.266s) [306.502677] Starting dynamic subtest: bcs0 [306.792244] Dynamic subtest bcs0: SUCCESS (0.300s) [306.803485] Starting dynamic subtest: vcs0 [307.095843] Dynamic subtest vcs0: SUCCESS (0.303s) [307.106586] Starting dynamic subtest: vcs1 [309.169690] Dynamic subtest vcs1: SUCCESS (2.072s) [309.180917] Starting dynamic subtest: vecs0 [311.226117] Dynamic subtest vecs0: SUCCESS (2.055s) [311.236262] Starting dynamic subtest: ccs0 [313.262201] Dynamic subtest ccs0: SUCCESS (2.034s) [313.264944] Subtest nonpriv-switch: SUCCESS (7.038s) [313.488577] [075/133] (709s left) gem_linear_blits (interruptible) [313.700990] Starting subtest: interruptible [319.127583] Subtest interruptible: SUCCESS (5.426s) [319.304312] [076/133] (703s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [319.454808] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [319.457076] Starting dynamic subtest: pipe-A-eDP-1 [330.431980] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.979s) [330.442634] Starting dynamic subtest: pipe-B-eDP-1 [342.174325] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.740s) [342.176812] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.722s) [343.030124] [077/133] (680s left) kms_atomic_interruptible (universal-setplane-primary) [343.133607] Starting subtest: universal-setplane-primary [343.135937] Starting dynamic subtest: pipe-A-eDP-1 [350.555673] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.420s) [350.558064] Subtest universal-setplane-primary: SUCCESS (7.421s) [351.387350] [078/133] (671s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [351.464786] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [351.467046] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [351.567918] [079/133] (671s left) kms_chamelium_color (ctm-max) [351.661315] Subtest ctm-max: SKIP (0.000s) [351.708291] [080/133] (671s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [351.801824] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [351.804068] Starting dynamic subtest: pipe-A-eDP-1 [351.828101] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [351.841091] Starting dynamic subtest: pipe-B-eDP-1 [351.862577] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [351.872068] Starting dynamic subtest: pipe-C-eDP-1 [351.893450] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [351.902782] Starting dynamic subtest: pipe-D-eDP-1 [351.924500] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [351.928584] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s) [353.961372] [081/133] (669s left) kms_psr (fbc-pr-sprite-plane-onoff) [354.058100] Starting subtest: fbc-pr-sprite-plane-onoff [354.062518] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [354.132018] [082/133] (669s left) kms_chamelium_frames (vga-frame-dump) [354.509332] Subtest vga-frame-dump: SKIP (0.000s) [355.367065] [083/133] (667s left) kms_pm_backlight (fade-with-suspend) [355.458848] Starting subtest: fade-with-suspend [372.179962] Starting dynamic subtest: eDP-1 [374.649567] Dynamic subtest eDP-1: SUCCESS (2.512s) [374.651460] Subtest fade-with-suspend: SUCCESS (3.723s) [375.439672] [084/133] (647s left) gem_ctx_persistence (legacy-engines-hang) [375.518814] Starting subtest: legacy-engines-hang [375.521170] Starting dynamic subtest: render [375.635167] Dynamic subtest render: SUCCESS (0.117s) [375.648189] Starting dynamic subtest: bsd1 [375.739117] Dynamic subtest bsd1: SUCCESS (0.103s) [375.751922] Starting dynamic subtest: bsd2 [375.829759] Dynamic subtest bsd2: SUCCESS (0.090s) [375.845158] Starting dynamic subtest: blt [375.907908] Dynamic subtest blt: SUCCESS (0.076s) [375.918972] Starting dynamic subtest: vebox [376.030289] Dynamic subtest vebox: SUCCESS (0.121s) [376.032867] Subtest legacy-engines-hang: SUCCESS (0.520s) [376.118469] [085/133] (647s left) gem_exec_params (no-bsd) [376.198373] Starting subtest: no-bsd [376.200644] Subtest no-bsd: SUCCESS (0.002s) [377.455697] [086/133] (645s left) kms_properties (get_properties-sanity-atomic) [377.540622] Starting subtest: get_properties-sanity-atomic [377.542939] Subtest get_properties-sanity-atomic: SUCCESS (0.002s) [377.627089] [087/133] (645s left) kms_cursor_legacy (cursor-vs-flip-atomic) [377.750925] Starting subtest: cursor-vs-flip-atomic [407.310452] Subtest cursor-vs-flip-atomic: SUCCESS (29.657s) [408.124752] [088/133] (615s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf) [408.224954] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf [408.227070] Starting dynamic subtest: pipe-A-eDP-1 [424.711063] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.484s) [424.721420] Starting dynamic subtest: pipe-B-eDP-1 [441.891228] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.183s) [441.893477] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.670s) [442.695503] [089/133] (580s left) drm_read (invalid-buffer) [442.850202] Starting subtest: invalid-buffer [442.852499] Subtest invalid-buffer: SUCCESS (0.000s) [442.972317] [090/133] (580s left) i915_pm_freq_api (freq-suspend) [443.023005] Starting subtest: freq-suspend [443.025327] Starting dynamic subtest: gt0 [459.190152] Dynamic subtest gt0: SUCCESS (1.221s) [459.203314] Starting dynamic subtest: gt1 [475.214388] Dynamic subtest gt1: SUCCESS (1.242s) [475.217066] Subtest freq-suspend: SUCCESS (2.466s) [475.295487] [091/133] (548s left) kms_cursor_crc (cursor-sliding-128x42) [475.528085] Starting subtest: cursor-sliding-128x42 [475.573668] Subtest cursor-sliding-128x42: SKIP (0.041s) [475.772772] [092/133] (547s left) core_setmaster (master-drop-set-root) [475.839442] Starting subtest: master-drop-set-root [475.863703] Subtest master-drop-set-root: SUCCESS (0.024s) [475.912940] [093/133] (547s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [476.005443] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [476.996492] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.013s) [477.115570] [094/133] (546s left) syncobj_timeline (etime-single-wait-all-submitted) [477.183504] Starting subtest: etime-single-wait-all-submitted [477.283916] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s) [477.364237] [095/133] (546s left) api_intel_bb (blit-noreloc-purge-cache) [477.429580] Starting subtest: blit-noreloc-purge-cache [477.437418] Subtest blit-noreloc-purge-cache: SUCCESS (0.013s) [477.572135] [096/133] (546s left) kms_psr (pr-cursor-mmap-cpu) [477.676352] Starting subtest: pr-cursor-mmap-cpu [477.681316] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [477.752489] [097/133] (546s left) gem_exec_nop (basic-parallel) [477.820790] Starting subtest: basic-parallel [493.121572] Subtest basic-parallel: SUCCESS (15.435s) [493.343847] [098/133] (530s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [493.452898] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [493.458113] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [493.554559] [099/133] (530s left) gem_lmem_swapping (heavy-verify-multi) [493.600065] Subtest heavy-verify-multi: SKIP (0.000s) [493.645068] [100/133] (530s left) sysfs_heartbeat_interval (mixed) [493.719444] Starting subtest: mixed [493.721981] Starting dynamic subtest: vecs0 [498.949614] Dynamic subtest vecs0: SUCCESS (5.240s) [498.962367] Starting dynamic subtest: ccs0 [504.159613] Dynamic subtest ccs0: SUCCESS (5.215s) [504.172094] Starting dynamic subtest: vcs0 [509.368844] Dynamic subtest vcs0: SUCCESS (5.208s) [509.381116] Starting dynamic subtest: bcs0 [514.589613] Dynamic subtest bcs0: SUCCESS (5.218s) [514.601055] Starting dynamic subtest: rcs0 [519.800580] Dynamic subtest rcs0: SUCCESS (5.209s) [519.813864] Starting dynamic subtest: vcs1 [524.994729] Dynamic subtest vcs1: SUCCESS (5.192s) [524.997912] Subtest mixed: SUCCESS (31.291s) [525.077138] [101/133] (498s left) gem_shrink (reclaim) [525.133519] Starting subtest: reclaim [527.547289] Subtest reclaim: SUCCESS (2.414s) [527.694889] [102/133] (496s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [527.821921] Starting subtest: cursor-tearing-framebuffer-change [527.824746] Starting dynamic subtest: pipe-A-eDP-1 [528.392293] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s) [528.403422] Starting dynamic subtest: pipe-D-eDP-1 [529.573690] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.183s) [529.576332] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.753s) [530.405845] [103/133] (493s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [530.526867] Starting subtest: flip-vs-cursor-atomic-transitions [538.426346] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.903s) [539.228991] [104/133] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [539.345698] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [539.350748] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [539.446424] [105/133] (484s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [539.530195] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [539.532873] Starting dynamic subtest: pipe-A [540.712401] Dynamic subtest pipe-A: SUCCESS (1.185s) [540.725623] Starting dynamic subtest: pipe-B [543.003175] Dynamic subtest pipe-B: SUCCESS (2.289s) [543.013493] Starting dynamic subtest: pipe-C [544.148284] Dynamic subtest pipe-C: SUCCESS (1.145s) [544.161565] Starting dynamic subtest: pipe-D [545.380801] Dynamic subtest pipe-D: SUCCESS (1.232s) [545.383371] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.855s) [546.583058] [106/133] (477s left) kms_rotation_crc (exhaust-fences) [546.678293] Starting subtest: exhaust-fences [546.683924] Subtest exhaust-fences: SKIP (0.000s) [546.755989] [107/133] (477s left) i915_power (sanity) [546.805081] Starting subtest: sanity [550.843112] Subtest sanity: SUCCESS (4.032s) [552.145263] [108/133] (472s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [552.236855] Starting subtest: primary-yf-tiled-reflect-x-180 [552.297715] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [552.403810] [109/133] (472s left) perf_pmu (idle) [552.458302] Starting subtest: idle [552.461178] Starting dynamic subtest: rcs0 [552.996071] Dynamic subtest rcs0: SUCCESS (0.539s) [553.012754] Starting dynamic subtest: bcs0 [553.513897] Dynamic subtest bcs0: SUCCESS (0.515s) [553.526979] Starting dynamic subtest: vcs0 [554.033410] Dynamic subtest vcs0: SUCCESS (0.517s) [554.045548] Starting dynamic subtest: vcs1 [554.550796] Dynamic subtest vcs1: SUCCESS (0.514s) [554.564229] Starting dynamic subtest: vecs0 [555.065832] Dynamic subtest vecs0: SUCCESS (0.513s) [555.077242] Starting dynamic subtest: ccs0 [555.584568] Dynamic subtest ccs0: SUCCESS (0.516s) [555.588245] Subtest idle: SUCCESS (3.130s) [555.682481] [110/133] (468s left) kms_lease (invalid-create-leases) [555.785954] Starting subtest: invalid-create-leases [555.792933] Subtest invalid-create-leases: SUCCESS (0.006s) [555.943600] [111/133] (468s left) kms_plane_alpha_blend (alpha-basic) [556.064011] Starting subtest: alpha-basic [556.345132] Starting dynamic subtest: pipe-A-eDP-1 [558.265631] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.919s) [558.292435] Starting dynamic subtest: pipe-D-eDP-1 [560.954878] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.670s) [560.957911] Subtest alpha-basic: SUCCESS (4.892s) [561.835974] [112/133] (462s left) gem_exec_schedule (implicit-write-read) [561.917055] Starting subtest: implicit-write-read [561.919360] Starting dynamic subtest: rcs0 [562.014048] Dynamic subtest rcs0: SUCCESS (0.110s) [562.028366] Starting dynamic subtest: vcs0 [562.096336] Dynamic subtest vcs0: SUCCESS (0.081s) [562.112402] Starting dynamic subtest: vcs1 [562.174975] Dynamic subtest vcs1: SUCCESS (0.078s) [562.188739] Starting dynamic subtest: vecs0 [562.252456] Dynamic subtest vecs0: SUCCESS (0.077s) [562.265501] Starting dynamic subtest: ccs0 [562.336821] Dynamic subtest ccs0: SUCCESS (0.083s) [562.339923] Subtest implicit-write-read: SUCCESS (0.434s) [563.242363] [113/133] (461s left) prime_busy (hang-wait) [563.293543] Starting subtest: hang-wait [563.296117] Starting dynamic subtest: rcs0 [589.661799] Dynamic subtest rcs0: SUCCESS (26.359s) [589.674873] Starting dynamic subtest: bcs0 [596.817106] Dynamic subtest bcs0: SUCCESS (7.151s) [596.830270] Starting dynamic subtest: vcs0 [603.726873] Dynamic subtest vcs0: SUCCESS (6.906s) [603.739002] Starting dynamic subtest: vcs1 [610.766268] Dynamic subtest vcs1: SUCCESS (7.036s) [610.778908] Starting dynamic subtest: vecs0 [617.740406] Dynamic subtest vecs0: SUCCESS (6.973s) [617.752910] Starting dynamic subtest: ccs0 [631.643354] Dynamic subtest ccs0: SUCCESS (13.902s) [631.646078] Subtest hang-wait: SUCCESS (68.341s) [631.758625] [114/133] (392s left) gem_exec_schedule (timeslicing) [631.836066] Starting subtest: timeslicing [631.838858] Starting dynamic subtest: rcs0 [631.849670] Dynamic subtest rcs0: SUCCESS (0.027s) [631.867113] Starting dynamic subtest: bcs0 [631.881068] Dynamic subtest bcs0: SUCCESS (0.029s) [631.895675] Starting dynamic subtest: vcs0 [631.907097] Dynamic subtest vcs0: SUCCESS (0.024s) [631.917382] Starting dynamic subtest: vcs1 [631.930439] Dynamic subtest vcs1: SUCCESS (0.023s) [631.940679] Starting dynamic subtest: vecs0 [631.954262] Dynamic subtest vecs0: SUCCESS (0.023s) [631.964628] Starting dynamic subtest: ccs0 [631.978579] Dynamic subtest ccs0: SUCCESS (0.024s) [631.981327] Subtest timeslicing: SUCCESS (0.156s) [633.134200] [115/133] (391s left) prime_self_import (basic-llseek-size) [633.176001] Starting subtest: basic-llseek-size [633.190097] Subtest basic-llseek-size: SUCCESS (0.015s) [633.283816] [116/133] (391s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [633.377840] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [637.670483] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.298s) [638.818852] [117/133] (386s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [638.910073] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [643.059928] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.156s) [644.204821] [118/133] (380s left) kms_sequence (get-busy) [644.298968] Starting subtest: get-busy [644.301914] Starting dynamic subtest: pipe-A-eDP-1 [646.235246] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s) [646.253623] Starting dynamic subtest: pipe-B-eDP-1 [648.804146] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.564s) [648.815072] Starting dynamic subtest: pipe-C-eDP-1 [651.435127] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.632s) [651.447220] Starting dynamic subtest: pipe-D-eDP-1 [654.046401] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s) [654.048891] Subtest get-busy: SUCCESS (9.752s) [654.849421] [119/133] (370s left) gem_exec_reloc (basic-cpu-active) [654.919644] Subtest basic-cpu-active: SKIP (0.000s) [654.998476] [120/133] (369s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [655.094270] Starting subtest: bad-rotation-90-y-tiled-ccs [655.096613] Starting dynamic subtest: pipe-A-eDP-1 [655.121299] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [655.132889] Starting dynamic subtest: pipe-B-eDP-1 [655.157827] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [655.167680] Starting dynamic subtest: pipe-C-eDP-1 [655.192891] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [655.202660] Starting dynamic subtest: pipe-D-eDP-1 [655.228106] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [655.233042] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s) [657.321094] [121/133] (367s left) kms_flip_event_leak (basic) [657.410875] Starting subtest: basic [657.412947] Starting dynamic subtest: pipe-A-eDP-1 [657.833410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s) [657.843736] Starting dynamic subtest: pipe-B-eDP-1 [658.940954] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.106s) [658.952496] Starting dynamic subtest: pipe-C-eDP-1 [660.051939] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s) [660.062707] Starting dynamic subtest: pipe-D-eDP-1 [661.182216] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s) [661.185060] Subtest basic: SUCCESS (3.774s) [662.050602] [122/133] (363s left) kms_cursor_crc (cursor-onscreen-32x32) [662.194607] Starting subtest: cursor-onscreen-32x32 [662.238847] Subtest cursor-onscreen-32x32: SKIP (0.039s) [662.513766] [123/133] (362s left) kms_big_fb (yf-tiled-addfb-size-overflow) [662.624331] Starting subtest: yf-tiled-addfb-size-overflow [662.629440] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [662.712968] [124/133] (362s left) kms_cursor_legacy (flip-vs-cursor-atomic) [662.837307] Starting subtest: flip-vs-cursor-atomic [670.267840] Subtest flip-vs-cursor-atomic: SUCCESS (7.434s) [671.079251] [125/133] (354s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [671.226090] Starting subtest: short-flip-after-cursor-toggle [672.139886] Subtest short-flip-after-cursor-toggle: SUCCESS (0.913s) [673.013127] [126/133] (352s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [673.145680] Starting subtest: 2x-flip-vs-cursor-legacy [673.150859] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [673.289869] [127/133] (351s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [673.388587] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [673.392888] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [673.484168] [128/133] (351s left) gem_exec_balancer (bonded-sync) [673.559413] Starting subtest: bonded-sync [673.564834] Subtest bonded-sync: SKIP (0.000s) [673.855672] [129/133] (351s left) gem_create (create-ext-placement-each) [674.026922] Starting subtest: create-ext-placement-each [674.029627] Subtest create-ext-placement-each: SUCCESS (0.000s) [674.153613] [130/133] (351s left) syncobj_timeline (invalid-wait-illegal-handle) [674.213064] Starting subtest: invalid-wait-illegal-handle [674.216093] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [674.346226] [131/133] (351s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [674.439846] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [674.444845] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [674.541468] [132/133] (351s left) gem_exec_params (dr1-dirt) [674.596320] Starting subtest: DR1-dirt [674.599246] Subtest DR1-dirt: SUCCESS (0.000s) [674.690095] [133/133] (350s left) kms_addfb_basic (basic) [674.748786] Starting subtest: basic [674.750962] Subtest basic: SUCCESS (0.000s) [674.870168] Closing watchdogs results: parsing output: 0/ for test: gem_partial_pwrite_pread results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_pxp results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gem_mmap_wc results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_addfb_basic results: parsing output: 8/ for test: kms_async_flips results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: i915_drm_fdinfo results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: prime_mmap results: parsing output: 13/ for test: kms_pm_rpm results: parsing output: 14/ for test: gem_linear_blits results: parsing output: 15/ for test: kms_flip_scaled_crc results: parsing output: 16/ for test: api_intel_bb results: parsing output: 17/ for test: gem_exec_reloc results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: kms_scaling_modes results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_invalid_mode results: parsing output: 22/ for test: kms_plane results: parsing output: 23/ for test: kms_feature_discovery results: parsing output: 24/ for test: sw_sync results: parsing output: 25/ for test: gem_pxp results: parsing output: 26/ for test: kms_plane_multiple results: parsing output: 27/ for test: vgem_basic results: parsing output: 28/ for test: gem_userptr_blits results: parsing output: 29/ for test: kms_cursor_legacy results: parsing output: 30/ for test: kms_content_protection results: parsing output: 31/ for test: gen9_exec_parse results: parsing output: 32/ for test: kms_dp_link_training results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_exec_create results: parsing output: 36/ for test: gem_exec_whisper results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_lmem_swapping results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_render_copy results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_softpin results: parsing output: 44/ for test: kms_addfb_basic results: parsing output: 45/ for test: perf_pmu results: parsing output: 46/ for test: kms_plane_scaling results: parsing output: 47/ for test: i915_pm_rpm results: parsing output: 48/ for test: kms_chamelium_edid results: parsing output: 49/ for test: vgem_basic results: parsing output: 50/ for test: kms_vblank results: parsing output: 51/ for test: kms_psr results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_async_flips results: parsing output: 55/ for test: gem_ctx_shared results: parsing output: 56/ for test: kms_color results: parsing output: 57/ for test: gem_eio results: parsing output: 58/ for test: syncobj_timeline results: parsing output: 59/ for test: kms_rotation_crc results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: kms_ccs results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_exec_fence results: parsing output: 66/ for test: gem_mmap_gtt results: parsing output: 67/ for test: gem_mmap_wc results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_mmap_offset results: parsing output: 70/ for test: gem_barrier_race results: parsing output: 71/ for test: gem_exec_reloc results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: gem_ctx_isolation results: parsing output: 74/ for test: gem_linear_blits results: parsing output: 75/ for test: kms_psr2_sf results: parsing output: 76/ for test: kms_atomic_interruptible results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_chamelium_color results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: kms_psr results: parsing output: 81/ for test: kms_chamelium_frames results: parsing output: 82/ for test: kms_pm_backlight results: parsing output: 83/ for test: gem_ctx_persistence results: parsing output: 84/ for test: gem_exec_params results: parsing output: 85/ for test: kms_properties results: parsing output: 86/ for test: kms_cursor_legacy results: parsing output: 87/ for test: kms_psr2_sf results: parsing output: 88/ for test: drm_read results: parsing output: 89/ for test: i915_pm_freq_api results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: core_setmaster results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: api_intel_bb results: parsing output: 95/ for test: kms_psr results: parsing output: 96/ for test: gem_exec_nop results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_lmem_swapping results: parsing output: 99/ for test: sysfs_heartbeat_interval results: parsing output: 100/ for test: gem_shrink results: parsing output: 101/ for test: kms_cursor_crc results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_plane_scaling results: parsing output: 105/ for test: kms_rotation_crc results: parsing output: 106/ for test: i915_power results: parsing output: 107/ for test: kms_rotation_crc results: parsing output: 108/ for test: perf_pmu results: parsing output: 109/ for test: kms_lease results: parsing output: 110/ for test: kms_plane_alpha_blend results: parsing output: 111/ for test: gem_exec_schedule results: parsing output: 112/ for test: prime_busy results: parsing output: 113/ for test: gem_exec_schedule results: parsing output: 114/ for test: prime_self_import results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_sequence results: parsing output: 118/ for test: gem_exec_reloc results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: kms_flip_event_leak results: parsing output: 121/ for test: kms_cursor_crc results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_cursor_legacy results: parsing output: 124/ for test: kms_cursor_legacy results: parsing output: 125/ for test: kms_cursor_legacy results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_exec_balancer results: parsing output: 128/ for test: gem_create results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: gem_exec_params results: parsing output: 132/ for test: kms_addfb_basic Done.