[59.968381] Initializing watchdogs [59.968430] /dev/watchdog0 [59.982909] [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.987652] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.990017] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.993606] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [60.113702] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [67.549159] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.420s) [67.822449] [002/133] (952s left) kms_pm_dc (dc9-dpms) [69.001084] Starting subtest: dc9-dpms [70.426885] Subtest dc9-dpms: SUCCESS (1.426s) [70.525277] [003/133] (950s left) kms_flip (basic-plain-flip) [70.637331] Starting subtest: basic-plain-flip [70.639792] Starting dynamic subtest: A-eDP1 [72.385987] Dynamic subtest A-eDP1: SUCCESS (1.750s) [72.395794] Starting dynamic subtest: B-eDP1 [74.006894] Dynamic subtest B-eDP1: SUCCESS (1.618s) [74.016243] Starting dynamic subtest: C-eDP1 [75.649054] Dynamic subtest C-eDP1: SUCCESS (1.639s) [75.659217] Starting dynamic subtest: D-eDP1 [77.277887] Dynamic subtest D-eDP1: SUCCESS (1.627s) [77.282979] Subtest basic-plain-flip: SUCCESS (6.645s) [78.452955] [004/133] (942s left) gem_eio (create) [78.615330] Starting subtest: create [78.812868] Subtest create: SUCCESS (0.196s) [78.922367] [005/133] (941s left) gem_eio (banned) [79.085234] Starting subtest: banned [79.493037] Subtest banned: SUCCESS (0.409s) [79.654589] [006/133] (941s left) kms_content_protection (dp-mst-lic-type-1) [79.798516] Starting subtest: dp-mst-lic-type-1 [79.802228] Subtest dp-mst-lic-type-1: SKIP (0.000s) [79.912615] [007/133] (940s left) kms_rotation_crc (sprite-rotation-90) [80.002069] Starting subtest: sprite-rotation-90 [80.006051] Subtest sprite-rotation-90: SKIP (0.001s) [80.071046] [008/133] (940s left) kms_scaling_modes (scaling-mode-none) [80.158334] Starting subtest: scaling-mode-none [80.160242] Starting dynamic subtest: pipe-A-eDP-1 [80.255821] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s) [80.263663] Starting dynamic subtest: pipe-B-eDP-1 [80.289730] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s) [80.297115] Starting dynamic subtest: pipe-C-eDP-1 [80.322479] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s) [80.329842] Starting dynamic subtest: pipe-D-eDP-1 [80.359655] Dynamic subtest pipe-D-eDP-1: SKIP (0.036s) [80.363373] Subtest scaling-mode-none: SKIP (0.202s) [80.501152] [009/133] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [80.604510] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [80.607894] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [80.712556] [010/133] (940s left) gem_pxp (hw-rejects-pxp-context) [80.834926] Starting subtest: hw-rejects-pxp-context [80.838889] Subtest hw-rejects-pxp-context: SKIP (0.000s) [80.962952] [011/133] (940s left) gem_exec_reloc (basic-concurrent0) [81.019113] Subtest basic-concurrent0: SKIP (0.000s) [81.085126] [012/133] (939s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [81.178041] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [81.179992] Starting dynamic subtest: pipe-A-eDP-1 [81.198544] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [81.206755] Starting dynamic subtest: pipe-B-eDP-1 [81.224114] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [81.231042] Starting dynamic subtest: pipe-C-eDP-1 [81.247831] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [81.254882] Starting dynamic subtest: pipe-D-eDP-1 [81.273049] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [81.276472] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s) [83.408851] [013/133] (937s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [83.509320] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [83.513578] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [83.576286] [014/133] (937s left) syncobj_timeline (wait-any-interrupted) [83.629906] Starting subtest: wait-any-interrupted [83.732040] Subtest wait-any-interrupted: SUCCESS (0.102s) [83.804426] [015/133] (937s left) kms_pm_rpm (i2c) [86.033900] Starting subtest: i2c [91.030698] Subtest i2c: SUCCESS (4.996s) [91.121799] [016/133] (930s left) gem_userptr_blits (relocations) [91.205773] Starting subtest: relocations [91.210463] Subtest relocations: SKIP (0.001s) [91.343075] [017/133] (929s left) kms_psr (fbc-psr-cursor-plane-onoff) [91.440846] Starting subtest: fbc-psr-cursor-plane-onoff [91.443143] Starting dynamic subtest: eDP-1 [91.447602] Dynamic subtest eDP-1: SKIP (0.000s) [91.452100] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [91.522086] [018/133] (929s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [91.580352] Starting subtest: invalid-single-wait-all-unsubmitted [91.582779] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [91.690578] [019/133] (929s left) gem_pxp (create-protected-buffer) [91.797993] Starting subtest: create-protected-buffer [91.800456] Subtest create-protected-buffer: SUCCESS (0.000s) [91.901594] [020/133] (929s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [92.016701] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [98.584202] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.569s) [98.686425] [021/133] (922s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [98.754390] Starting subtest: legacy-engines-hostile-preempt [98.756824] Starting dynamic subtest: render [98.813872] Dynamic subtest render: SUCCESS (0.059s) [98.824719] Starting dynamic subtest: bsd1 [99.917664] Dynamic subtest bsd1: SUCCESS (1.101s) [99.929206] Starting dynamic subtest: bsd2 [101.887790] Dynamic subtest bsd2: SUCCESS (1.968s) [101.898636] Starting dynamic subtest: blt [101.983220] Dynamic subtest blt: SUCCESS (0.095s) [101.996087] Starting dynamic subtest: vebox [103.868879] Dynamic subtest vebox: SUCCESS (1.882s) [103.871651] Subtest legacy-engines-hostile-preempt: SUCCESS (5.113s) [104.009161] [022/133] (917s left) sw_sync (sync_random_merge) [104.050261] Starting subtest: sync_random_merge [104.094582] Subtest sync_random_merge: SUCCESS (0.046s) [104.168947] [023/133] (917s left) gem_exec_suspend (basic) [104.253271] Starting subtest: basic [104.255765] Starting dynamic subtest: smem [105.944280] Dynamic subtest smem: SUCCESS (1.688s) [105.947244] Subtest basic: SUCCESS (1.689s) [106.152095] [024/133] (915s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [106.245659] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [106.272653] Starting dynamic subtest: pipe-A-plane-0 [106.594823] Dynamic subtest pipe-A-plane-0: SUCCESS (0.322s) [106.603707] Starting dynamic subtest: pipe-A-plane-3 [106.839431] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s) [106.847270] Starting dynamic subtest: pipe-A-plane-5 [106.851099] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [107.912261] Starting dynamic subtest: pipe-B-plane-0 [108.206019] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [108.214879] Starting dynamic subtest: pipe-B-plane-3 [108.439033] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [108.446848] Starting dynamic subtest: pipe-B-plane-5 [108.451152] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [108.748279] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.501s) [109.589820] [025/133] (911s left) sw_sync (sync_busy_fork) [109.626404] Starting subtest: sync_busy_fork [110.636339] Subtest sync_busy_fork: SUCCESS (1.011s) [110.698101] [026/133] (910s left) kms_cursor_crc (cursor-rapid-movement-512x170) [110.999898] Starting subtest: cursor-rapid-movement-512x170 [111.005734] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [111.190667] [027/133] (910s left) kms_invalid_mode (zero-clock) [111.291392] Starting subtest: zero-clock [111.293648] Starting dynamic subtest: pipe-A-eDP-1 [111.575056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [111.584504] Starting dynamic subtest: pipe-B-eDP-1 [111.586388] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [111.596843] Starting dynamic subtest: pipe-C-eDP-1 [111.599213] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [111.607790] Starting dynamic subtest: pipe-D-eDP-1 [111.610135] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [111.612365] Subtest zero-clock: SUCCESS (0.290s) [112.415208] [028/133] (909s left) gem_exec_balancer (sequential) [112.483694] Starting subtest: sequential [115.562784] Subtest sequential: SUCCESS (3.079s) [115.890134] [029/133] (905s left) kms_flip_tiling (flip-change-tiling) [116.000773] Starting subtest: flip-change-tiling [116.002727] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [116.198415] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.198s) [116.209898] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [116.343546] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s) [116.354898] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [116.477081] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s) [116.490863] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [116.620305] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s) [116.630059] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [116.775719] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.154s) [116.788962] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [116.919187] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s) [116.933055] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [117.052993] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s) [117.062805] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [117.164577] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s) [117.175121] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [117.309391] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s) [117.320828] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [117.453574] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s) [117.465199] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [117.597544] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s) [117.608523] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [117.741831] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s) [117.754152] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [117.875859] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [117.886506] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [118.010624] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [118.021838] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [118.120463] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s) [118.131704] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [118.293620] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.171s) [118.303503] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [118.436238] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s) [118.446465] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [118.580621] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s) [118.590460] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [118.725620] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s) [118.737452] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [118.870239] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s) [118.882309] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [119.014471] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.143s) [119.025832] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [119.136542] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.121s) [119.147525] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [119.308766] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.170s) [119.319499] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [119.452234] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.143s) [119.465670] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [119.597565] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.144s) [119.609969] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [119.741086] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s) [119.751621] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [119.913275] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.170s) [119.924068] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [120.068719] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.154s) [120.078911] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [120.224295] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.154s) [120.235406] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [120.369082] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s) [120.379630] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [120.513579] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s) [120.523816] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [120.657326] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s) [120.671623] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [120.802532] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s) [120.813823] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [120.946248] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.143s) [120.957371] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [121.102846] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.154s) [121.113807] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [121.224329] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.121s) [121.277452] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [122.488308] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.217s) [122.499399] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [122.622522] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s) [122.632730] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [122.755744] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [122.767082] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [122.899490] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s) [122.911240] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [123.043162] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s) [123.054216] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [123.187551] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s) [123.199290] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [123.321382] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s) [123.332599] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [123.432455] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s) [123.443280] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [123.567497] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s) [123.581013] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [123.710652] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [123.721795] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [123.854358] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s) [123.864459] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [123.998867] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s) [124.009144] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [124.143754] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.143s) [124.154862] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [124.278044] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s) [124.289033] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [124.387775] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [124.398716] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [124.533042] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s) [124.544592] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [124.676604] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [124.687520] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [124.821035] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s) [124.831732] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [124.965298] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s) [124.976676] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [125.110501] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s) [125.120644] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [125.256301] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.144s) [125.267816] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [125.404058] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.147s) [125.413923] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [125.548733] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s) [125.562914] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [125.703843] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.155s) [125.714070] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [125.848288] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s) [125.863853] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [125.993246] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s) [126.005456] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [126.137911] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s) [126.149889] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [126.281543] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.143s) [126.292450] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [126.404625] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.121s) [126.425507] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [126.549034] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.143s) [126.560446] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [126.693213] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s) [126.706917] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [126.838108] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s) [126.849606] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [126.981918] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s) [126.992930] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [127.126622] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.143s) [127.137348] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [127.283908] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.155s) [127.294959] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [127.404716] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.119s) [127.457413] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [128.723171] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.272s) [128.737311] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [128.822859] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s) [128.835718] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [128.922685] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s) [128.933224] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [129.033508] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s) [129.043917] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [129.144638] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.108s) [129.156262] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [129.255534] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s) [129.266248] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [129.355724] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s) [129.367125] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [129.455938] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s) [129.466781] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [129.555854] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s) [129.566172] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [129.666754] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s) [129.676060] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [129.777564] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s) [129.792274] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [129.888533] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s) [129.899542] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [129.988773] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s) [129.999197] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [130.088879] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s) [130.099426] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [130.188769] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s) [130.205986] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [130.300323] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s) [130.311231] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [130.411039] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s) [130.421257] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [130.522023] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s) [130.532693] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [130.633429] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s) [130.644082] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [130.744836] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s) [130.757094] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [130.855675] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s) [130.866766] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [130.977753] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.120s) [130.988271] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [131.088758] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s) [131.098184] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [131.199701] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s) [131.207803] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [131.311105] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s) [131.321166] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [131.422182] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s) [131.432559] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [131.533359] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s) [131.543940] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [131.655309] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.121s) [131.665677] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [131.766564] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s) [131.777367] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [131.877853] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s) [131.887316] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [131.988848] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [131.998308] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [132.099985] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [132.110739] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [132.211151] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s) [132.221837] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [132.322114] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s) [132.332893] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [132.433641] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s) [132.444650] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [132.544479] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s) [132.585950] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [133.859021] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.279s) [133.869833] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [133.959180] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s) [133.970589] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [134.059425] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [134.072958] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [134.170295] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s) [134.181208] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [134.281050] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s) [134.294032] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [134.391769] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s) [134.402187] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [134.491987] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s) [134.503043] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [134.592234] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s) [134.602854] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [134.692707] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s) [134.702358] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [134.803460] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s) [134.814183] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [134.914141] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s) [134.924490] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [135.024874] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s) [135.035412] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [135.125298] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s) [135.135493] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [135.225708] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s) [135.236558] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [135.336860] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s) [135.346574] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [135.447653] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [135.458616] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [135.558221] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s) [135.568591] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [135.669562] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s) [135.679593] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [135.769824] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s) [135.780366] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [135.881326] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [135.891548] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [135.992509] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [136.003558] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [136.103307] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [136.113980] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [136.214026] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [136.223649] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [136.347523] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.132s) [136.361831] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [136.458576] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s) [136.473211] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [136.569670] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s) [136.580249] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [136.680717] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [136.691275] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [136.791953] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s) [136.802225] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [136.903294] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s) [136.917053] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [137.025903] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.121s) [137.037620] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [137.136201] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s) [137.146912] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [137.248629] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s) [137.260884] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [137.358571] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s) [137.368248] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [137.469623] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s) [137.479676] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [137.581489] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s) [137.595130] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [137.692601] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [137.725108] Subtest flip-change-tiling: SUCCESS (21.726s) [138.940574] [030/133] (882s left) gem_exec_flush (basic-uc-rw-default) [139.003514] Starting subtest: basic-uc-rw-default [144.455523] Subtest basic-uc-rw-default: SUCCESS (5.454s) [144.644070] [031/133] (877s left) kms_atomic (plane-primary-overlay-mutable-zpos) [144.729065] Starting subtest: plane-primary-overlay-mutable-zpos [148.184084] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.453s) [149.368791] [032/133] (872s left) kms_chamelium_audio (dp-audio) [149.752148] Subtest dp-audio: SKIP (0.000s) [150.575224] [033/133] (871s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [150.665676] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [150.669872] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [150.778287] [034/133] (871s left) syncobj_wait (invalid-reset-one-illegal-handle) [150.825608] Starting subtest: invalid-reset-one-illegal-handle [150.827792] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [150.938818] [035/133] (871s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [151.030251] Starting subtest: plane-upscale-20x20-with-modifiers [151.032814] Starting dynamic subtest: pipe-A [151.366193] Dynamic subtest pipe-A: SUCCESS (0.338s) [151.375879] Starting dynamic subtest: pipe-B [152.788283] Dynamic subtest pipe-B: SUCCESS (1.420s) [152.798134] Starting dynamic subtest: pipe-C [154.226213] Dynamic subtest pipe-C: SUCCESS (1.437s) [154.235662] Starting dynamic subtest: pipe-D [155.658669] Dynamic subtest pipe-D: SUCCESS (1.431s) [155.661181] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.631s) [156.837063] [036/133] (865s left) kms_chamelium_hpd (vga-hpd-after-suspend) [157.222720] Subtest vga-hpd-after-suspend: SKIP (0.000s) [158.047925] [037/133] (864s left) kms_atomic_transition (plane-toggle-modeset-transition) [158.136823] Starting subtest: plane-toggle-modeset-transition [158.138750] Starting dynamic subtest: pipe-A-eDP-1 [170.813282] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.677s) [170.823673] Starting dynamic subtest: pipe-B-eDP-1 [183.191255] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.373s) [183.193933] Subtest plane-toggle-modeset-transition: SUCCESS (25.056s) [184.017258] [038/133] (838s left) kms_draw_crc (draw-method-mmap-cpu) [184.113460] Starting subtest: draw-method-mmap-cpu [184.115751] Starting dynamic subtest: xrgb8888-untiled [184.377383] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [184.385541] Starting dynamic subtest: rgb565-untiled [184.588631] Dynamic subtest rgb565-untiled: SUCCESS (0.210s) [184.597180] Starting dynamic subtest: xrgb2101010-untiled [184.811044] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [184.822878] Starting dynamic subtest: xbgr16161616f-untiled [185.032618] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [185.042253] Starting dynamic subtest: xrgb8888-xtiled [185.177280] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [185.185729] Starting dynamic subtest: rgb565-xtiled [185.310392] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s) [185.318462] Starting dynamic subtest: xrgb2101010-xtiled [185.432708] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [185.440862] Starting dynamic subtest: xbgr16161616f-xtiled [185.566158] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [185.574674] Starting dynamic subtest: xrgb8888-4tiled [185.721533] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [185.729776] Starting dynamic subtest: rgb565-4tiled [185.865824] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [185.874176] Starting dynamic subtest: xrgb2101010-4tiled [185.999446] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [186.007607] Starting dynamic subtest: xbgr16161616f-4tiled [186.143842] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [186.145798] Subtest draw-method-mmap-cpu: SUCCESS (2.034s) [186.241786] [039/133] (835s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [186.331999] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [186.335476] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [186.419895] [040/133] (835s left) gem_vm_create (isolation) [186.488779] Starting subtest: isolation [186.497465] Subtest isolation: SUCCESS (0.009s) [186.623562] [041/133] (835s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [186.749577] Starting subtest: cursorB-vs-flipB-atomic-transitions [186.753455] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [186.888930] [042/133] (835s left) api_intel_bb (object-noreloc-purge-cache-simple) [186.943427] Starting subtest: object-noreloc-purge-cache-simple [186.947386] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s) [187.061331] [043/133] (835s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [187.156125] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [187.159599] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [187.241080] [044/133] (835s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [187.346556] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [187.348452] Starting dynamic subtest: pipe-A-eDP-1 [187.395053] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [187.402729] Starting dynamic subtest: pipe-B-eDP-1 [187.448038] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [187.456288] Starting dynamic subtest: pipe-C-eDP-1 [187.502386] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [187.511325] Starting dynamic subtest: pipe-D-eDP-1 [187.558353] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [187.561848] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s) [189.594577] [045/133] (832s left) api_intel_allocator (two-level-inception) [189.659254] Starting subtest: two-level-inception [195.059389] Subtest two-level-inception: SUCCESS (5.401s) [195.235098] [046/133] (827s left) kms_getfb (getfb2-into-addfb2) [195.350965] Starting subtest: getfb2-into-addfb2 [195.353229] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [195.472448] [047/133] (827s left) gem_mmap_gtt (cpuset-big-copy-odd) [195.536591] Subtest cpuset-big-copy-odd: SKIP (0.000s) [195.602695] [048/133] (826s left) kms_cursor_crc (cursor-offscreen-256x256) [195.860970] Starting subtest: cursor-offscreen-256x256 [195.863298] Starting dynamic subtest: pipe-A-eDP-1 [197.819823] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.954s) [197.852725] Starting dynamic subtest: pipe-D-eDP-1 [200.378621] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.533s) [200.381062] Subtest cursor-offscreen-256x256: SUCCESS (4.518s) [201.236905] [049/133] (821s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [201.331768] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [201.978699] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s) [202.142852] [050/133] (820s left) gem_exec_schedule (reorder-wide) [202.330502] Subtest reorder-wide: SKIP (0.000s) [202.524141] [051/133] (820s left) syncobj_wait (multi-wait-signaled) [202.580454] Starting subtest: multi-wait-signaled [202.582376] Subtest multi-wait-signaled: SUCCESS (0.000s) [202.681064] [052/133] (820s left) core_auth (basic-auth) [202.739392] Starting subtest: basic-auth [202.741738] Subtest basic-auth: SUCCESS (0.001s) [202.852870] [053/133] (819s left) gem_eio (in-flight-10ms) [203.094969] Starting subtest: in-flight-10ms [212.050059] Subtest in-flight-10ms: SUCCESS (8.953s) [212.225797] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true [212.228992] [054/133] (810s left) kms_psr (psr-cursor-mmap-gtt) [212.334492] Starting subtest: psr-cursor-mmap-gtt [212.336874] Starting dynamic subtest: eDP-1 [214.037559] Dynamic subtest eDP-1: SUCCESS (1.702s) [214.039852] Subtest psr-cursor-mmap-gtt: SUCCESS (1.703s) [214.916986] [055/133] (807s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [215.022180] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [215.026523] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [215.128490] [056/133] (807s left) gem_exec_fence (syncobj-repeat) [215.552419] Starting subtest: syncobj-repeat [215.739826] Subtest syncobj-repeat: SUCCESS (0.186s) [216.980535] [057/133] (805s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [217.076994] Starting subtest: fbc-shrfb-scaledprimary [220.131120] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.057s) [221.340118] [058/133] (801s left) kms_psr (pr-cursor-render) [221.450353] Starting subtest: pr-cursor-render [221.454777] Subtest pr-cursor-render: SKIP (0.000s) [221.521213] [059/133] (801s left) syncobj_wait (signal) [221.585063] Starting subtest: signal [221.587726] Subtest signal: SUCCESS (0.000s) [221.681330] [060/133] (801s left) kms_vblank (wait-idle-hang) [221.779725] Starting subtest: wait-idle-hang [221.782050] Starting dynamic subtest: pipe-A-eDP-1 [248.673420] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.891s) [248.687744] Starting dynamic subtest: pipe-D-eDP-1 [273.695577] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.020s) [273.697796] Subtest wait-idle-hang: SUCCESS (51.916s) [274.568670] [061/133] (748s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [274.665601] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [274.667950] Starting dynamic subtest: pipe-A-eDP-1 [274.691626] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [274.700693] Starting dynamic subtest: pipe-B-eDP-1 [274.722377] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [274.730958] Starting dynamic subtest: pipe-C-eDP-1 [274.753071] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [274.761380] Starting dynamic subtest: pipe-D-eDP-1 [274.783080] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [274.787056] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [276.932776] [062/133] (746s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [277.029026] Starting subtest: async-flip-with-page-flip-events-tiled [277.406117] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [280.193708] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.787s) [280.205604] Starting dynamic subtest: pipe-A-eDP-1-4 [282.400928] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.206s) [282.409608] Starting dynamic subtest: pipe-A-eDP-1-4 [284.411486] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [284.420079] Starting dynamic subtest: pipe-A-eDP-1-x [286.590539] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s) [286.968062] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [289.727308] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.764s) [289.739295] Starting dynamic subtest: pipe-B-eDP-1-4 [291.912390] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [291.921173] Starting dynamic subtest: pipe-B-eDP-1-4 [293.922921] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [293.931698] Starting dynamic subtest: pipe-B-eDP-1-x [296.111905] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [296.477471] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [299.249801] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.778s) [299.260698] Starting dynamic subtest: pipe-C-eDP-1-4 [301.424705] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [301.435859] Starting dynamic subtest: pipe-C-eDP-1-4 [303.434369] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s) [303.443331] Starting dynamic subtest: pipe-C-eDP-1-x [305.613084] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s) [305.983466] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [308.780261] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.812s) [308.789956] Starting dynamic subtest: pipe-D-eDP-1-4 [310.965328] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s) [310.974281] Starting dynamic subtest: pipe-D-eDP-1-4 [312.974963] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [312.985097] Starting dynamic subtest: pipe-D-eDP-1-x [315.165570] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [315.168773] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.137s) [316.376681] [063/133] (706s left) sw_sync (sync_merge) [316.424333] Starting subtest: sync_merge [316.426631] Subtest sync_merge: SUCCESS (0.000s) [316.485583] [064/133] (706s left) kms_psr (fbc-pr-primary-mmap-cpu) [316.573290] Starting subtest: fbc-pr-primary-mmap-cpu [316.577652] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [316.662409] [065/133] (706s left) kms_cursor_edge_walk (64x64-left-edge) [316.745235] Starting subtest: 64x64-left-edge [316.747427] Starting dynamic subtest: pipe-A-eDP-1 [320.226351] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s) [320.235265] Starting dynamic subtest: pipe-D-eDP-1 [323.351501] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s) [323.353432] Subtest 64x64-left-edge: SUCCESS (6.606s) [324.154418] [066/133] (699s left) kms_usb4_switch (undock-during-suspend) [324.263100] Subtest undock-during-suspend: SKIP (0.000s) [324.304032] [067/133] (699s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [324.360348] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [324.427821] [068/133] (698s left) syncobj_timeline (invalid-signal-zero-handles) [324.488570] Starting subtest: invalid-signal-zero-handles [324.491132] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [324.586971] [069/133] (698s left) prime_busy (hang-wait) [324.645456] Starting subtest: hang-wait [324.647799] Starting dynamic subtest: rcs0 [350.386873] Dynamic subtest rcs0: SUCCESS (25.735s) [350.396833] Starting dynamic subtest: bcs0 [357.544955] Dynamic subtest bcs0: SUCCESS (7.155s) [357.555140] Starting dynamic subtest: vcs0 [364.520950] Dynamic subtest vcs0: SUCCESS (6.974s) [364.530186] Starting dynamic subtest: vcs1 [371.493081] Dynamic subtest vcs1: SUCCESS (6.970s) [371.501620] Starting dynamic subtest: vecs0 [378.531029] Dynamic subtest vecs0: SUCCESS (7.037s) [378.539614] Starting dynamic subtest: ccs0 [392.371395] Dynamic subtest ccs0: SUCCESS (13.835s) [392.373704] Subtest hang-wait: SUCCESS (67.719s) [392.476992] [070/133] (630s left) syncobj_timeline (invalid-wait-illegal-handle) [392.528216] Starting subtest: invalid-wait-illegal-handle [392.530136] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [392.620309] [071/133] (630s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [392.734231] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [393.870892] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.136s) [393.995482] [072/133] (629s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [394.098695] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [394.102458] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [394.192897] [073/133] (629s left) kms_busy (extended-pageflip-hang-oldfb) [394.294518] Starting subtest: extended-pageflip-hang-oldfb [394.296535] Starting dynamic subtest: pipe-A [394.682971] Dynamic subtest pipe-A: SUCCESS (0.389s) [394.698537] Starting dynamic subtest: pipe-D [395.775388] Dynamic subtest pipe-D: SUCCESS (1.087s) [395.777781] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.481s) [396.616868] [074/133] (627s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [396.720423] Starting subtest: psr2-cursor-plane-move-continuous-sf [396.722786] Starting dynamic subtest: pipe-A-eDP-1 [407.072356] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.358s) [407.082876] Starting dynamic subtest: pipe-B-eDP-1 [418.191218] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.116s) [418.193508] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.477s) [418.978449] [075/133] (604s left) kms_dither (fb-8bpc-vs-panel-8bpc) [419.078119] Starting subtest: fb-8bpc-vs-panel-8bpc [419.080413] Starting dynamic subtest: pipe-A-eDP-1 [420.461435] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.382s) [420.463356] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.383s) [421.258214] [076/133] (602s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [421.361941] Starting subtest: primary-yf-tiled-reflect-x-180 [421.421544] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s) [421.534982] [077/133] (602s left) gem_eio (execbuf) [421.731149] Starting subtest: execbuf [422.005482] Subtest execbuf: SUCCESS (0.274s) [422.170869] [078/133] (601s left) kms_big_fb (linear-16bpp-rotate-0) [422.266470] Starting subtest: linear-16bpp-rotate-0 [423.672145] Subtest linear-16bpp-rotate-0: SUCCESS (1.404s) [423.793179] [079/133] (600s left) i915_drm_fdinfo (busy-hang) [423.840528] Starting subtest: busy-hang [423.842516] Starting dynamic subtest: rcs0 [423.874596] Dynamic subtest rcs0: SKIP (0.032s) [423.884908] Starting dynamic subtest: bcs0 [423.888269] Dynamic subtest bcs0: SKIP (0.001s) [423.896687] Starting dynamic subtest: vcs0 [423.900227] Dynamic subtest vcs0: SKIP (0.000s) [423.908225] Starting dynamic subtest: vcs1 [423.911571] Dynamic subtest vcs1: SKIP (0.000s) [423.919235] Starting dynamic subtest: vecs0 [423.922622] Dynamic subtest vecs0: SKIP (0.000s) [423.930185] Starting dynamic subtest: ccs0 [423.933515] Dynamic subtest ccs0: SKIP (0.000s) [423.936839] Subtest busy-hang: SKIP (0.039s) [423.972655] [080/133] (599s left) kms_plane_lowres (tiling-y) [424.075392] Starting subtest: tiling-y [424.078835] Subtest tiling-y: SKIP (0.000s) [424.147341] [081/133] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [424.239151] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [431.056954] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.819s) [431.207081] [082/133] (592s left) i915_pm_rc6_residency (rc6-idle) [431.268791] Starting subtest: rc6-idle [431.283707] Starting dynamic subtest: gt0-rcs0 [455.570449] Dynamic subtest gt0-rcs0: SUCCESS (24.285s) [455.580050] Starting dynamic subtest: gt0-bcs0 [479.850408] Dynamic subtest gt0-bcs0: SUCCESS (24.276s) [479.861716] Starting dynamic subtest: gt0-ccs0 [504.207161] Dynamic subtest gt0-ccs0: SUCCESS (24.355s) [504.218087] Starting dynamic subtest: gt1-vcs0 [510.380632] Dynamic subtest gt1-vcs0: SUCCESS (6.169s) [510.392451] Starting dynamic subtest: gt1-vecs0 [516.553129] Dynamic subtest gt1-vecs0: SUCCESS (6.169s) [516.555794] Subtest rc6-idle: SUCCESS (85.285s) [516.647963] [083/133] (507s left) gem_spin_batch (legacy) [516.726520] Starting subtest: legacy [516.728764] Starting dynamic subtest: default [519.969852] Dynamic subtest default: SUCCESS (3.238s) [519.981360] Starting dynamic subtest: render [523.204866] Dynamic subtest render: SUCCESS (3.231s) [523.215646] Starting dynamic subtest: bsd [526.444290] Dynamic subtest bsd: SUCCESS (3.236s) [526.459438] Starting dynamic subtest: bsd1 [529.677968] Dynamic subtest bsd1: SUCCESS (3.231s) [529.689075] Starting dynamic subtest: bsd2 [532.916955] Dynamic subtest bsd2: SUCCESS (3.236s) [532.928598] Starting dynamic subtest: blt [536.155054] Dynamic subtest blt: SUCCESS (3.234s) [536.166401] Starting dynamic subtest: vebox [539.391692] Dynamic subtest vebox: SUCCESS (3.233s) [539.393802] Subtest legacy: SUCCESS (22.661s) [539.914402] [084/133] (484s left) gem_ctx_param (invalid-param-set) [539.963373] Starting subtest: invalid-param-set [539.965847] Subtest invalid-param-set: SUCCESS (0.000s) [540.043513] [085/133] (484s left) gem_exec_whisper (basic-queues-forked) [540.101600] Starting subtest: basic-queues-forked [563.154593] Subtest basic-queues-forked: SUCCESS (23.047s) [563.340000] [086/133] (460s left) gem_exec_balancer (nop) [563.400788] Starting subtest: nop [610.056706] Subtest nop: SUCCESS (46.656s) [610.375307] [087/133] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [610.494995] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [610.499667] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [610.591083] [088/133] (413s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [610.690760] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [610.694963] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [610.794236] [089/133] (413s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [610.885136] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [610.889213] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s) [610.968915] [090/133] (413s left) gem_mmap_gtt (medium-copy-xy) [611.038097] Subtest medium-copy-XY: SKIP (0.000s) [611.098066] [091/133] (413s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [611.211482] Starting subtest: flip-vs-cursor-atomic-transitions [619.111863] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.901s) [619.910602] [092/133] (404s left) syncobj_timeline (etime-multi-wait-all-submitted) [619.985651] Starting subtest: etime-multi-wait-all-submitted [620.090444] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s) [620.170865] [093/133] (404s left) gem_ctx_isolation (preservation-reset) [620.348468] Starting subtest: preservation-reset [620.350935] Starting dynamic subtest: rcs0 [620.626152] Dynamic subtest rcs0: SUCCESS (0.281s) [620.637563] Starting dynamic subtest: bcs0 [620.962515] Dynamic subtest bcs0: SUCCESS (0.335s) [620.974267] Starting dynamic subtest: vcs0 [621.298637] Dynamic subtest vcs0: SUCCESS (0.335s) [621.308362] Starting dynamic subtest: vcs1 [623.233100] Dynamic subtest vcs1: SUCCESS (1.933s) [623.244895] Starting dynamic subtest: vecs0 [625.202887] Dynamic subtest vecs0: SUCCESS (1.968s) [625.212516] Starting dynamic subtest: ccs0 [627.211790] Dynamic subtest ccs0: SUCCESS (2.008s) [627.216629] Subtest preservation-reset: SUCCESS (6.869s) [627.364859] [094/133] (397s left) gem_readwrite (read-bad-handle) [627.420114] Subtest read-bad-handle: SKIP (0.000s) [627.476198] [095/133] (397s left) prime_vgem (sync) [627.557254] Starting subtest: sync [627.559326] Starting dynamic subtest: rcs0 [627.608732] Dynamic subtest rcs0: SUCCESS (0.054s) [627.623574] Starting dynamic subtest: bcs0 [627.678397] Dynamic subtest bcs0: SUCCESS (0.064s) [627.687269] Starting dynamic subtest: vcs0 [627.728167] Dynamic subtest vcs0: SUCCESS (0.049s) [627.737345] Starting dynamic subtest: vcs1 [627.777107] Dynamic subtest vcs1: SUCCESS (0.047s) [627.786261] Starting dynamic subtest: vecs0 [627.827313] Dynamic subtest vecs0: SUCCESS (0.050s) [627.836349] Starting dynamic subtest: ccs0 [627.875855] Dynamic subtest ccs0: SUCCESS (0.047s) [627.878398] Subtest sync: SUCCESS (0.322s) [628.001947] [096/133] (396s left) i915_suspend (fence-restore-tiled2untiled) [628.059853] Starting subtest: fence-restore-tiled2untiled [628.063391] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [628.163937] [097/133] (396s left) gem_exec_params (secure-non-root) [628.220758] Starting subtest: secure-non-root [628.224570] Subtest secure-non-root: SKIP (0.000s) [628.325584] [098/133] (396s left) kms_big_fb (x-tiled-8bpp-rotate-180) [628.419946] Starting subtest: x-tiled-8bpp-rotate-180 [629.679589] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.259s) [629.802357] [099/133] (394s left) kms_plane_scaling (invalid-parameters) [629.891572] Starting subtest: invalid-parameters [629.893563] Starting dynamic subtest: less-than-1-height-src [629.905459] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s) [629.914690] Starting dynamic subtest: less-than-1-width-src [629.919073] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s) [629.921069] Subtest invalid-parameters: SUCCESS (0.029s) [630.024783] [100/133] (394s left) gem_exec_schedule (pi-distinct-iova) [630.217612] Starting subtest: pi-distinct-iova [630.219683] Starting dynamic subtest: rcs0 [630.293331] Dynamic subtest rcs0: SUCCESS (0.079s) [630.308560] Starting dynamic subtest: vcs0 [630.348778] Dynamic subtest vcs0: SUCCESS (0.055s) [630.360505] Starting dynamic subtest: vcs1 [630.421546] Dynamic subtest vcs1: SUCCESS (0.072s) [630.434355] Starting dynamic subtest: vecs0 [630.482202] Dynamic subtest vecs0: SUCCESS (0.060s) [630.491541] Starting dynamic subtest: ccs0 [630.551436] Dynamic subtest ccs0: SUCCESS (0.067s) [630.554242] Subtest pi-distinct-iova: SUCCESS (0.337s) [631.984037] [101/133] (392s left) kms_big_fb (yf-tiled-addfb) [632.098785] Starting subtest: yf-tiled-addfb [632.103325] Subtest yf-tiled-addfb: SKIP (0.000s) [632.204837] [102/133] (392s left) kms_scaling_modes (scaling-mode-full) [632.287902] Starting subtest: scaling-mode-full [632.290095] Starting dynamic subtest: pipe-A-eDP-1 [632.386704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s) [632.396669] Starting dynamic subtest: pipe-B-eDP-1 [633.546660] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s) [633.556915] Starting dynamic subtest: pipe-C-eDP-1 [634.671756] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s) [634.683761] Starting dynamic subtest: pipe-D-eDP-1 [635.783860] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.111s) [635.786259] Subtest scaling-mode-full: SUCCESS (3.497s) [636.956264] [103/133] (387s left) kms_chamelium_color (gamma) [637.054203] Subtest gamma: SKIP (0.000s) [637.097883] [104/133] (387s left) kms_setmode (invalid-clone-single-crtc-stealing) [637.150970] Starting subtest: invalid-clone-single-crtc-stealing [637.157218] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [637.235027] [105/133] (387s left) gem_create (create-ext-cpu-access-big) [637.408868] Starting subtest: create-ext-cpu-access-big [637.413520] Subtest create-ext-cpu-access-big: SKIP (0.001s) [637.482593] [106/133] (387s left) kms_lease (lease-again) [637.571355] Starting subtest: lease-again [637.573725] Starting dynamic subtest: pipe-A-eDP-1 [637.576043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s) [637.587280] Starting dynamic subtest: pipe-B-eDP-1 [637.589584] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [637.598581] Starting dynamic subtest: pipe-C-eDP-1 [637.600773] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [637.609719] Starting dynamic subtest: pipe-D-eDP-1 [637.611862] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.003s) [637.614083] Subtest lease-again: SUCCESS (0.015s) [637.692643] [107/133] (387s left) prime_mmap (test_correct_cpu_write) [637.750111] Starting subtest: test_correct_cpu_write [637.752374] Starting dynamic subtest: test_correct_cpu_write-smem [637.754302] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [637.756245] Subtest test_correct_cpu_write: SUCCESS (0.001s) [637.841550] [108/133] (387s left) gem_exec_schedule (smoketest-all) [637.908845] Starting subtest: smoketest-all [670.303267] Subtest smoketest-all: SUCCESS (32.351s) [671.941981] [109/133] (353s left) gem_softpin (evict-snoop-interruptible) [672.014210] Starting subtest: evict-snoop-interruptible [672.018739] Subtest evict-snoop-interruptible: SKIP (0.000s) [672.124129] [110/133] (353s left) prime_mmap_kms (buffer-sharing) [672.220424] Starting subtest: buffer-sharing [672.681037] Subtest buffer-sharing: SUCCESS (0.465s) [673.485007] [111/133] (351s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [673.609772] Starting subtest: basic-flip-after-cursor-varying-size [674.541818] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.932s) [675.409845] [112/133] (349s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [675.498108] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [675.500374] Starting dynamic subtest: pipe-A-eDP-1 [675.523072] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [675.534541] Starting dynamic subtest: pipe-B-eDP-1 [675.555914] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [675.564909] Starting dynamic subtest: pipe-C-eDP-1 [675.586191] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [675.594927] Starting dynamic subtest: pipe-D-eDP-1 [675.616455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [675.620805] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s) [677.685242] [113/133] (347s left) kms_color (ctm-signed) [677.783975] Starting subtest: ctm-signed [677.785808] Starting dynamic subtest: pipe-A-eDP-1 [679.861721] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.078s) [679.871400] Starting dynamic subtest: pipe-B-eDP-1 [682.743901] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.880s) [682.753587] Starting dynamic subtest: pipe-C-eDP-1 [685.462710] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.718s) [685.472236] Starting dynamic subtest: pipe-D-eDP-1 [688.106412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.642s) [688.108731] Subtest ctm-signed: SUCCESS (10.322s) [688.938366] [114/133] (336s left) gem_exec_store (dword) [688.998078] Starting subtest: dword [689.000279] Starting dynamic subtest: rcs0 [689.071762] Dynamic subtest rcs0: SUCCESS (0.076s) [689.083716] Starting dynamic subtest: bcs0 [689.113538] Dynamic subtest bcs0: SUCCESS (0.040s) [689.130269] Starting dynamic subtest: vcs0 [689.158327] Dynamic subtest vcs0: SUCCESS (0.042s) [689.171396] Starting dynamic subtest: vcs1 [689.201126] Dynamic subtest vcs1: SUCCESS (0.041s) [689.211563] Starting dynamic subtest: vecs0 [689.242203] Dynamic subtest vecs0: SUCCESS (0.039s) [689.254176] Starting dynamic subtest: ccs0 [689.283509] Dynamic subtest ccs0: SUCCESS (0.040s) [689.285743] Subtest dword: SUCCESS (0.289s) [689.469998] [115/133] (335s left) gem_exec_nop (basic-parallel) [689.546431] Starting subtest: basic-parallel [705.880363] Subtest basic-parallel: SUCCESS (16.341s) [706.109281] [116/133] (319s left) perf_pmu (busy-accuracy-2) [706.148893] Starting subtest: busy-accuracy-2 [706.150817] Starting dynamic subtest: rcs0 [709.195452] Dynamic subtest rcs0: SUCCESS (3.045s) [709.206676] Starting dynamic subtest: bcs0 [712.253917] Dynamic subtest bcs0: SUCCESS (3.057s) [712.264881] Starting dynamic subtest: vcs0 [715.300393] Dynamic subtest vcs0: SUCCESS (3.044s) [715.312036] Starting dynamic subtest: vcs1 [718.347771] Dynamic subtest vcs1: SUCCESS (3.045s) [718.358274] Starting dynamic subtest: vecs0 [721.396810] Dynamic subtest vecs0: SUCCESS (3.046s) [721.408439] Starting dynamic subtest: ccs0 [724.456624] Dynamic subtest ccs0: SUCCESS (3.057s) [724.459522] Subtest busy-accuracy-2: SUCCESS (18.308s) [724.573608] [117/133] (300s left) gem_ccs (block-multicopy-inplace) [724.639631] Starting subtest: block-multicopy-inplace [724.644365] Subtest block-multicopy-inplace: SKIP (0.000s) [724.736884] [118/133] (300s left) kms_pipe_stress (stress-xrgb8888-xtiled) [724.847232] Starting subtest: stress-xrgb8888-xtiled [730.755519] Subtest stress-xrgb8888-xtiled: SUCCESS (5.908s) [730.813636] [119/133] (294s left) gem_softpin (softpin) [730.874054] Starting subtest: softpin [763.122786] Subtest softpin: SUCCESS (32.242s) [763.246533] [120/133] (262s left) gen9_exec_parse (bb-large) [763.310345] Subtest bb-large: SKIP (0.000s) [763.388614] [121/133] (262s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [763.490627] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [763.492936] Starting dynamic subtest: pipe-A-eDP-1 [763.590279] Dynamic subtest pipe-A-eDP-1: SKIP (0.103s) [763.601337] Starting dynamic subtest: pipe-B-eDP-1 [764.714993] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s) [764.719524] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.229s) [765.900805] [122/133] (259s left) gem_mmap_gtt (zero-extend) [765.971333] Subtest zero-extend: SKIP (0.000s) [766.025579] [123/133] (259s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [766.131631] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [772.706110] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.578s) [772.853139] [124/133] (252s left) dmabuf (all-tests) [772.890063] Starting subtest: all-tests [772.892242] Starting dynamic subtest: sanitycheck [773.033911] Dynamic subtest sanitycheck: SUCCESS (0.144s) [773.046816] Starting dynamic subtest: dma_fence [773.228770] Dynamic subtest dma_fence: SUCCESS (0.192s) [773.240975] Starting dynamic subtest: dma_fence_chain [782.371527] Dynamic subtest dma_fence_chain: SUCCESS (9.139s) [782.383999] Starting dynamic subtest: dma_fence_unwrap [782.467527] Dynamic subtest dma_fence_unwrap: SUCCESS (0.094s) [782.479869] Starting dynamic subtest: dma_resv [782.567558] Dynamic subtest dma_resv: SUCCESS (0.098s) [782.570071] Subtest all-tests: SUCCESS (9.680s) [782.635183] [125/133] (243s left) kms_flip (2x-blocking-wf_vblank) [782.736921] Starting subtest: 2x-blocking-wf_vblank [782.744988] Subtest 2x-blocking-wf_vblank: SKIP (0.011s) [782.826458] [126/133] (242s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [782.937442] Starting subtest: 2x-long-flip-vs-cursor-atomic [782.941866] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [783.083636] [127/133] (242s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [783.140565] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [783.145087] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [783.324068] [128/133] (242s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear) [783.425067] Starting subtest: fbcpsr-tiling-linear [790.037327] Subtest fbcpsr-tiling-linear: SUCCESS (6.615s) [790.209875] [129/133] (235s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [790.263546] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [790.265866] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [790.367517] [130/133] (235s left) i915_hangman (engine-engine-hang) [790.429633] Starting subtest: engine-engine-hang [790.431511] Starting dynamic subtest: rcs0 [791.862770] Dynamic subtest rcs0: SUCCESS (1.432s) [791.875309] Starting dynamic subtest: bcs0 [793.844344] Dynamic subtest bcs0: SUCCESS (1.979s) [793.857325] Starting dynamic subtest: vcs0 [795.892576] Dynamic subtest vcs0: SUCCESS (2.046s) [795.904118] Starting dynamic subtest: vcs1 [797.876059] Dynamic subtest vcs1: SUCCESS (1.980s) [797.888733] Starting dynamic subtest: vecs0 [799.860307] Dynamic subtest vecs0: SUCCESS (1.982s) [799.872802] Starting dynamic subtest: ccs0 [801.845153] Dynamic subtest ccs0: SUCCESS (1.981s) [801.847978] Subtest engine-engine-hang: SUCCESS (11.416s) [801.973908] [131/133] (224s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [802.070937] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [802.075105] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [802.170808] [132/133] (223s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [802.268654] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [802.273057] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [802.364326] [133/133] (223s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [802.452103] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [802.456075] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [802.524084] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_pm_dc results: parsing output: 2/ for test: kms_flip results: parsing output: 3/ for test: gem_eio results: parsing output: 4/ for test: gem_eio results: parsing output: 5/ for test: kms_content_protection results: parsing output: 6/ for test: kms_rotation_crc results: parsing output: 7/ for test: kms_scaling_modes results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_pxp results: parsing output: 10/ for test: gem_exec_reloc results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: kms_psr2_sf results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: kms_pm_rpm results: parsing output: 15/ for test: gem_userptr_blits results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: gem_pxp results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: gem_ctx_persistence results: parsing output: 21/ for test: sw_sync results: parsing output: 22/ for test: gem_exec_suspend results: parsing output: 23/ for test: kms_plane results: parsing output: 24/ for test: sw_sync results: parsing output: 25/ for test: kms_cursor_crc results: parsing output: 26/ for test: kms_invalid_mode results: parsing output: 27/ for test: gem_exec_balancer results: parsing output: 28/ for test: kms_flip_tiling results: parsing output: 29/ for test: gem_exec_flush results: parsing output: 30/ for test: kms_atomic results: parsing output: 31/ for test: kms_chamelium_audio results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: syncobj_wait results: parsing output: 34/ for test: kms_plane_scaling results: parsing output: 35/ for test: kms_chamelium_hpd results: parsing output: 36/ for test: kms_atomic_transition results: parsing output: 37/ for test: kms_draw_crc results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_vm_create results: parsing output: 40/ for test: kms_cursor_legacy results: parsing output: 41/ for test: api_intel_bb results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: api_intel_allocator results: parsing output: 45/ for test: kms_getfb results: parsing output: 46/ for test: gem_mmap_gtt results: parsing output: 47/ for test: kms_cursor_crc results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: gem_exec_schedule results: parsing output: 50/ for test: syncobj_wait results: parsing output: 51/ for test: core_auth results: parsing output: 52/ for test: gem_eio results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_exec_fence results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: syncobj_wait results: parsing output: 59/ for test: kms_vblank results: parsing output: 60/ for test: kms_ccs results: parsing output: 61/ for test: kms_async_flips results: parsing output: 62/ for test: sw_sync results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: kms_cursor_edge_walk results: parsing output: 65/ for test: kms_usb4_switch results: parsing output: 66/ for test: gem_exec_reloc results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: prime_busy results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_big_fb results: parsing output: 72/ for test: kms_busy results: parsing output: 73/ for test: kms_psr2_sf results: parsing output: 74/ for test: kms_dither results: parsing output: 75/ for test: kms_rotation_crc results: parsing output: 76/ for test: gem_eio results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: i915_drm_fdinfo results: parsing output: 79/ for test: kms_plane_lowres results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: i915_pm_rc6_residency results: parsing output: 82/ for test: gem_spin_batch results: parsing output: 83/ for test: gem_ctx_param results: parsing output: 84/ for test: gem_exec_whisper results: parsing output: 85/ for test: gem_exec_balancer results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_flip_scaled_crc results: parsing output: 89/ for test: gem_mmap_gtt results: parsing output: 90/ for test: kms_cursor_legacy results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: gem_ctx_isolation results: parsing output: 93/ for test: gem_readwrite results: parsing output: 94/ for test: prime_vgem results: parsing output: 95/ for test: i915_suspend results: parsing output: 96/ for test: gem_exec_params results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_plane_scaling results: parsing output: 99/ for test: gem_exec_schedule results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: kms_scaling_modes results: parsing output: 102/ for test: kms_chamelium_color results: parsing output: 103/ for test: kms_setmode results: parsing output: 104/ for test: gem_create results: parsing output: 105/ for test: kms_lease results: parsing output: 106/ for test: prime_mmap results: parsing output: 107/ for test: gem_exec_schedule results: parsing output: 108/ for test: gem_softpin results: parsing output: 109/ for test: prime_mmap_kms results: parsing output: 110/ for test: kms_cursor_legacy results: parsing output: 111/ for test: kms_ccs results: parsing output: 112/ for test: kms_color results: parsing output: 113/ for test: gem_exec_store results: parsing output: 114/ for test: gem_exec_nop results: parsing output: 115/ for test: perf_pmu results: parsing output: 116/ for test: gem_ccs results: parsing output: 117/ for test: kms_pipe_stress results: parsing output: 118/ for test: gem_softpin results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: kms_psr2_sf results: parsing output: 121/ for test: gem_mmap_gtt results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: dmabuf results: parsing output: 124/ for test: kms_flip results: parsing output: 125/ for test: kms_cursor_legacy results: parsing output: 126/ for test: gem_render_copy results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: i915_hangman results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_flip_scaled_crc Done.