[59.364640] Initializing watchdogs [59.364723] /dev/watchdog0 [59.381348] [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.386149] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.388463] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.391885] [001/155] (960s left) gem_wait (wait) [59.474708] Starting subtest: wait [59.477170] Starting dynamic subtest: all-engines [61.309661] Dynamic subtest all-engines: SUCCESS (1.832s) [61.318796] Starting dynamic subtest: rcs0 [62.355657] Dynamic subtest rcs0: SUCCESS (1.047s) [62.365343] Starting dynamic subtest: bcs0 [63.403043] Dynamic subtest bcs0: SUCCESS (1.046s) [63.414266] Starting dynamic subtest: vcs0 [64.449784] Dynamic subtest vcs0: SUCCESS (1.046s) [64.459976] Starting dynamic subtest: vcs1 [65.494879] Dynamic subtest vcs1: SUCCESS (1.044s) [65.503795] Starting dynamic subtest: vecs0 [66.538157] Dynamic subtest vecs0: SUCCESS (1.043s) [66.549425] Starting dynamic subtest: ccs0 [67.585037] Dynamic subtest ccs0: SUCCESS (1.046s) [67.587710] Subtest wait: SUCCESS (8.111s) [67.780752] [002/155] (952s left) kms_content_protection (dp-mst-lic-type-0) [67.930842] Starting subtest: dp-mst-lic-type-0 [67.935408] Subtest dp-mst-lic-type-0: SKIP (0.000s) [68.047080] [003/155] (951s left) kms_cursor_crc (cursor-sliding-256x85) [68.297595] Starting subtest: cursor-sliding-256x85 [68.357262] Subtest cursor-sliding-256x85: SKIP (0.055s) [68.518877] [004/155] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [68.623496] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [68.627821] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [68.709296] [005/155] (951s left) kms_vblank (crtc-id) [68.802656] Starting subtest: crtc-id [68.804585] Starting dynamic subtest: pipe-A-eDP-1 [69.277422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s) [69.290884] Starting dynamic subtest: pipe-D-eDP-1 [70.429724] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s) [70.431892] Subtest crtc-id: SUCCESS (1.625s) [71.271112] [006/155] (948s left) gem_exec_schedule (preempt-other-chain) [71.337184] Starting subtest: preempt-other-chain [71.339393] Starting dynamic subtest: rcs0 [71.420350] Dynamic subtest rcs0: SUCCESS (0.089s) [71.432859] Starting dynamic subtest: bcs0 [71.507341] Dynamic subtest bcs0: SUCCESS (0.088s) [71.526677] Starting dynamic subtest: vcs0 [71.590289] Dynamic subtest vcs0: SUCCESS (0.083s) [71.599144] Starting dynamic subtest: vcs1 [71.674338] Dynamic subtest vcs1: SUCCESS (0.084s) [71.684053] Starting dynamic subtest: vecs0 [71.760575] Dynamic subtest vecs0: SUCCESS (0.085s) [71.776099] Starting dynamic subtest: ccs0 [71.842594] Dynamic subtest ccs0: SUCCESS (0.081s) [71.845220] Subtest preempt-other-chain: SUCCESS (0.512s) [73.468207] [007/155] (946s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt) [73.588164] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt [73.592312] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [73.680985] [008/155] (946s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite) [73.789047] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite [73.793392] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [73.899336] [009/155] (946s left) perf_pmu (busy-check-all) [73.939510] Starting subtest: busy-check-all [73.941369] Starting dynamic subtest: rcs0 [74.491469] Dynamic subtest rcs0: SUCCESS (0.553s) [74.503721] Starting dynamic subtest: bcs0 [75.040785] Dynamic subtest bcs0: SUCCESS (0.548s) [75.051194] Starting dynamic subtest: vcs0 [76.286098] Dynamic subtest vcs0: SUCCESS (1.241s) [76.296045] Starting dynamic subtest: vcs1 [78.269431] Dynamic subtest vcs1: SUCCESS (1.984s) [78.281369] Starting dynamic subtest: vecs0 [80.317419] Dynamic subtest vecs0: SUCCESS (2.047s) [80.329572] Starting dynamic subtest: ccs0 [80.871827] Dynamic subtest ccs0: SUCCESS (0.554s) [80.874678] Subtest busy-check-all: SUCCESS (6.933s) [80.984762] [010/155] (939s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [81.088998] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [81.115098] Starting dynamic subtest: pipe-A-plane-0 [81.404183] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [81.413150] Starting dynamic subtest: pipe-A-plane-3 [81.648368] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s) [81.657047] Starting dynamic subtest: pipe-A-plane-5 [81.661289] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [82.759240] Starting dynamic subtest: pipe-B-plane-0 [83.061582] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [83.071082] Starting dynamic subtest: pipe-B-plane-3 [83.294892] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [83.303576] Starting dynamic subtest: pipe-B-plane-5 [83.307729] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [83.608568] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.521s) [84.428528] [011/155] (935s left) gem_eio (unwedge-stress) [84.641995] Starting subtest: unwedge-stress [84.644435] Starting dynamic subtest: render [89.056895] Dynamic subtest render: SUCCESS (4.411s) [89.071719] Starting dynamic subtest: bsd1 [106.777577] Dynamic subtest bsd1: SUCCESS (17.711s) [106.787627] Starting dynamic subtest: bsd2 [124.721331] Dynamic subtest bsd2: SUCCESS (17.952s) [124.737381] Starting dynamic subtest: blt [124.741337] Dynamic subtest blt: SKIP (0.000s) [124.750168] Starting dynamic subtest: vebox [142.721879] Dynamic subtest vebox: SUCCESS (18.000s) [142.724302] Subtest unwedge-stress: SUCCESS (58.076s) [144.358526] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true [144.361966] [012/155] (875s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [144.492091] Starting subtest: cursorB-vs-flipA-atomic [144.496823] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [144.649947] [013/155] (875s left) gem_exec_parallel (basic) [144.719889] Starting subtest: basic [144.722133] Starting dynamic subtest: rcs0 [146.161671] Dynamic subtest rcs0: SUCCESS (1.444s) [146.172579] Starting dynamic subtest: bcs0 [147.642963] Dynamic subtest bcs0: SUCCESS (1.481s) [147.653142] Starting dynamic subtest: vcs0 [149.283480] Dynamic subtest vcs0: SUCCESS (1.638s) [149.294334] Starting dynamic subtest: vcs1 [151.228568] Dynamic subtest vcs1: SUCCESS (1.945s) [151.237819] Starting dynamic subtest: vecs0 [153.277277] Dynamic subtest vecs0: SUCCESS (2.047s) [153.289829] Starting dynamic subtest: ccs0 [154.761582] Dynamic subtest ccs0: SUCCESS (1.484s) [154.763960] Subtest basic: SUCCESS (10.044s) [154.961787] [014/155] (865s left) gem_ccs (block-multicopy-compressed) [155.015991] Starting subtest: block-multicopy-compressed [155.020672] Subtest block-multicopy-compressed: SKIP (0.000s) [155.128043] [015/155] (865s left) kms_plane_cursor (overlay) [155.237011] Starting subtest: overlay [155.241409] Starting dynamic subtest: pipe-A-eDP-1-size-64 [157.944502] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.709s) [158.005313] Starting dynamic subtest: pipe-A-eDP-1-size-128 [160.702638] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.707s) [160.762424] Starting dynamic subtest: pipe-A-eDP-1-size-256 [163.458536] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.705s) [163.808716] Starting dynamic subtest: pipe-B-eDP-1-size-64 [167.239324] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.443s) [167.300718] Starting dynamic subtest: pipe-B-eDP-1-size-128 [170.018164] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.727s) [170.079995] Starting dynamic subtest: pipe-B-eDP-1-size-256 [172.775520] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.705s) [173.130357] Starting dynamic subtest: pipe-C-eDP-1-size-64 [176.203392] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.086s) [176.243920] Starting dynamic subtest: pipe-C-eDP-1-size-128 [178.603891] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.370s) [178.641255] Starting dynamic subtest: pipe-C-eDP-1-size-256 [180.992706] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.359s) [181.319864] Starting dynamic subtest: pipe-D-eDP-1-size-64 [184.385624] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.076s) [184.426188] Starting dynamic subtest: pipe-D-eDP-1-size-128 [186.775753] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.358s) [186.812866] Starting dynamic subtest: pipe-D-eDP-1-size-256 [189.163457] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.358s) [189.483876] Subtest overlay: SUCCESS (34.245s) [190.379025] [016/155] (830s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [190.475118] Starting subtest: basic-max-pipe-crc-check [190.479381] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [190.524151] [017/155] (830s left) kms_frontbuffer_tracking (hdr-2p-rte) [190.629083] Starting subtest: hdr-2p-rte [190.633140] Subtest hdr-2p-rte: SKIP (0.000s) [190.729409] [018/155] (829s left) syncobj_wait (wait-any-snapshot) [190.783605] Starting subtest: wait-any-snapshot [190.864909] Subtest wait-any-snapshot: SUCCESS (0.082s) [190.944885] [019/155] (829s left) i915_pm_rps (engine-order) [191.000400] Starting subtest: engine-order [196.076591] Subtest engine-order: SUCCESS (5.075s) [196.201133] [020/155] (824s left) gem_exec_balancer (hang) [196.472207] Starting subtest: hang [198.271064] Subtest hang: SUCCESS (1.799s) [198.398875] [021/155] (822s left) kms_fbcon_fbt (fbc-suspend) [198.452217] Starting subtest: fbc-suspend [247.486145] Subtest fbc-suspend: SUCCESS (19.114s) [248.836404] [022/155] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [248.948764] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [255.898237] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.953s) [256.034464] [023/155] (764s left) syncobj_timeline (invalid-signal-bad-pad) [256.087858] Starting subtest: invalid-signal-bad-pad [256.090166] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [256.188821] [024/155] (764s left) gem_ctx_isolation (clean) [256.248670] Starting subtest: clean [256.250931] Starting dynamic subtest: rcs0 [256.297702] Dynamic subtest rcs0: SUCCESS (0.048s) [256.308934] Starting dynamic subtest: bcs0 [256.371299] Dynamic subtest bcs0: SUCCESS (0.072s) [256.381910] Starting dynamic subtest: vcs0 [256.409756] Dynamic subtest vcs0: SUCCESS (0.037s) [256.422729] Starting dynamic subtest: vcs1 [258.204042] Dynamic subtest vcs1: SUCCESS (1.792s) [258.214851] Starting dynamic subtest: vecs0 [260.210650] Dynamic subtest vecs0: SUCCESS (2.004s) [260.221253] Starting dynamic subtest: ccs0 [262.260858] Dynamic subtest ccs0: SUCCESS (2.049s) [262.263200] Subtest clean: SUCCESS (6.011s) [262.507062] [025/155] (758s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [262.601569] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [262.606309] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [263.749874] [026/155] (757s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [263.857333] Starting subtest: psr-1p-primscrn-spr-indfb-move [271.292275] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.439s) [271.434170] [027/155] (749s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier) [271.528920] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier [271.533280] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s) [271.601435] [028/155] (749s left) kms_selftest (drm_damage_helper) [271.640684] Starting subtest: drm_damage_helper [271.688022] Starting dynamic subtest: drm_test_damage_iter_no_damage [271.795086] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.106s) [271.806800] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [271.902272] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.107s) [271.914671] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [272.016420] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.114s) [272.026371] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [272.116847] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.099s) [272.127187] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [272.228292] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.111s) [272.238708] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [272.335054] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.104s) [272.345403] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [272.441553] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.105s) [272.459119] Starting dynamic subtest: drm_test_damage_iter_simple_damage [272.559027] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.118s) [272.571061] Starting dynamic subtest: drm_test_damage_iter_single_damage [272.652804] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.090s) [272.663428] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [272.750326] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.097s) [272.760484] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [272.844794] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.093s) [272.854662] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [272.947904] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.100s) [272.958620] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [273.048682] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.102s) [273.058821] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [273.158954] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.109s) [273.168950] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [273.261938] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.101s) [273.271760] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [273.353439] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.089s) [273.364235] Starting dynamic subtest: drm_test_damage_iter_damage [273.452822] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.101s) [273.462765] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [273.570295] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.114s) [273.580453] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [273.670730] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.099s) [273.681143] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [273.774968] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.103s) [273.785281] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [273.882145] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.107s) [273.884397] Subtest drm_damage_helper: SUCCESS (2.242s) [274.048126] [029/155] (747s left) api_intel_bb (full-batch) [274.099860] Starting subtest: full-batch [274.106092] Subtest full-batch: SUCCESS (0.008s) [274.234857] [030/155] (746s left) kms_big_fb (4-tiled-8bpp-rotate-270) [274.347078] Starting subtest: 4-tiled-8bpp-rotate-270 [274.368452] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [274.493728] [031/155] (746s left) kms_prop_blob (invalid-get-prop-any) [274.548786] Starting subtest: invalid-get-prop-any [274.551009] Subtest invalid-get-prop-any: SUCCESS (0.000s) [274.661889] [032/155] (746s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [274.758433] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [274.762838] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s) [274.836521] [033/155] (746s left) gem_mmap_gtt (cpuset-medium-copy-xy) [274.887328] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [274.956239] [034/155] (746s left) kms_addfb_basic (invalid-get-prop) [275.004777] Starting subtest: invalid-get-prop [275.006904] Subtest invalid-get-prop: SUCCESS (0.000s) [275.143281] [035/155] (746s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [275.189609] Subtest no-spare-fences-interruptible: SKIP (0.000s) [275.264291] [036/155] (746s left) kms_psr (fbc-psr2-sprite-plane-move) [275.350653] Starting subtest: fbc-psr2-sprite-plane-move [275.352617] Starting dynamic subtest: eDP-1 [275.356180] Dynamic subtest eDP-1: SKIP (0.000s) [275.359748] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [275.424355] [037/155] (745s left) kms_vblank (query-forked-busy) [275.516208] Starting subtest: query-forked-busy [275.518166] Starting dynamic subtest: pipe-A-eDP-1 [277.394522] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s) [277.409860] Starting dynamic subtest: pipe-D-eDP-1 [280.020441] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s) [280.022658] Subtest query-forked-busy: SUCCESS (4.503s) [280.838405] [038/155] (740s left) api_intel_bb (blit-reloc-purge-cache) [280.892849] Starting subtest: blit-reloc-purge-cache [280.897537] Subtest blit-reloc-purge-cache: SKIP (0.001s) [281.024427] [039/155] (740s left) kms_atomic (plane-overlay-legacy) [281.111344] Starting subtest: plane-overlay-legacy [281.113607] Starting dynamic subtest: pipe-A-eDP-1 [281.548911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s) [281.551188] Subtest plane-overlay-legacy: SUCCESS (0.440s) [282.367650] [040/155] (739s left) gem_render_copy (linear) [282.427412] Starting subtest: linear [282.429765] Starting dynamic subtest: smem [282.469203] Dynamic subtest smem: SUCCESS (0.041s) [282.471687] Subtest linear: SUCCESS (0.042s) [282.695317] [041/155] (738s left) gem_create (create-valid-nonaligned) [282.743047] Starting subtest: create-valid-nonaligned [282.744942] Subtest create-valid-nonaligned: SUCCESS (0.000s) [282.928248] [042/155] (738s left) gem_ctx_persistence (legacy-engines-mixed) [282.977140] Starting subtest: legacy-engines-mixed [282.979359] Starting dynamic subtest: render [283.042763] Dynamic subtest render: SUCCESS (0.067s) [283.055733] Starting dynamic subtest: bsd1 [283.087636] Dynamic subtest bsd1: SUCCESS (0.043s) [283.099109] Starting dynamic subtest: bsd2 [283.141550] Dynamic subtest bsd2: SUCCESS (0.051s) [283.152919] Starting dynamic subtest: blt [283.185540] Dynamic subtest blt: SUCCESS (0.043s) [283.196929] Starting dynamic subtest: vebox [283.229370] Dynamic subtest vebox: SUCCESS (0.042s) [283.231905] Subtest legacy-engines-mixed: SUCCESS (0.255s) [283.309486] [043/155] (738s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt) [283.418257] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt [283.422273] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [283.517329] [044/155] (738s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [283.619747] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [283.623966] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [283.714479] [045/155] (738s left) kms_cursor_crc (cursor-rapid-movement-512x512) [283.961913] Starting subtest: cursor-rapid-movement-512x512 [283.965789] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [284.138316] [046/155] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [284.242700] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [293.868207] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.627s) [294.019290] [047/155] (727s left) perf (create-destroy-userspace-config) [294.157620] Starting subtest: create-destroy-userspace-config [294.179459] Subtest create-destroy-userspace-config: SUCCESS (0.022s) [294.229127] [048/155] (727s left) sysfs_timeslice_duration (idempotent) [294.282551] Starting subtest: idempotent [294.284994] Starting dynamic subtest: vecs0 [294.287316] Dynamic subtest vecs0: SUCCESS (0.000s) [294.299274] Starting dynamic subtest: ccs0 [294.301501] Dynamic subtest ccs0: SUCCESS (0.000s) [294.312098] Starting dynamic subtest: vcs0 [294.313963] Dynamic subtest vcs0: SUCCESS (0.000s) [294.323989] Starting dynamic subtest: bcs0 [294.325862] Dynamic subtest bcs0: SUCCESS (0.000s) [294.335933] Starting dynamic subtest: rcs0 [294.337818] Dynamic subtest rcs0: SUCCESS (0.000s) [294.348719] Starting dynamic subtest: vcs1 [294.350962] Dynamic subtest vcs1: SUCCESS (0.002s) [294.353189] Subtest idempotent: SUCCESS (0.009s) [294.404008] [049/155] (727s left) i915_pm_rps (waitboost) [294.470916] Starting subtest: waitboost [299.656820] Subtest waitboost: FAIL (4.840s) [300.444171] [050/155] (721s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff) [300.546781] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff [300.550275] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [300.646033] [051/155] (721s left) kms_color (legacy-gamma-reset) [300.743109] Starting subtest: legacy-gamma-reset [300.744705] Starting dynamic subtest: pipe-A-eDP-1 [301.124185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.381s) [301.139157] Starting dynamic subtest: pipe-B-eDP-1 [301.141504] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s) [301.152763] Starting dynamic subtest: pipe-C-eDP-1 [301.155264] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.018s) [301.166120] Starting dynamic subtest: pipe-D-eDP-1 [301.168489] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [301.170917] Subtest legacy-gamma-reset: SUCCESS (0.424s) [301.970970] [052/155] (720s left) gem_exec_fence (syncobj-timeline-export) [302.537276] Starting subtest: syncobj-timeline-export [302.543738] Subtest syncobj-timeline-export: SUCCESS (0.007s) [304.326704] [053/155] (717s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [304.444762] Starting subtest: cursorA-vs-flipB-legacy [304.449372] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [304.605098] [054/155] (717s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [304.695184] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [304.697038] Starting dynamic subtest: pipe-A-eDP-1 [307.023282] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.329s) [307.034028] Starting dynamic subtest: pipe-B-eDP-1 [309.646622] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.621s) [309.657496] Starting dynamic subtest: pipe-C-eDP-1 [312.004400] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.357s) [312.015016] Starting dynamic subtest: pipe-D-eDP-1 [314.297235] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.291s) [314.299264] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.604s) [315.499511] [055/155] (706s left) kms_frontbuffer_tracking (psrhdr-slowdraw) [315.606841] Starting subtest: psrhdr-slowdraw [315.611058] Subtest psrhdr-slowdraw: SKIP (0.000s) [315.698686] [056/155] (706s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render) [315.806994] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render [315.811436] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [315.909030] [057/155] (706s left) kms_chamelium_frames (dp-crc-single) [316.296074] Subtest dp-crc-single: SKIP (0.000s) [317.107928] [058/155] (705s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [317.218943] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc [317.223195] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [317.322618] [059/155] (705s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [317.432758] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [317.437011] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [317.530534] [060/155] (704s left) gem_mmap_gtt (basic-small-bo-tiledx) [317.583006] Subtest basic-small-bo-tiledX: SKIP (0.000s) [317.643810] [061/155] (704s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [317.730926] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [317.733215] Starting dynamic subtest: pipe-A-eDP-1 [317.756156] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [317.768476] Starting dynamic subtest: pipe-B-eDP-1 [317.790465] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [317.800653] Starting dynamic subtest: pipe-C-eDP-1 [317.820983] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [317.831353] Starting dynamic subtest: pipe-D-eDP-1 [317.852501] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [317.856616] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s) [320.002099] [062/155] (702s left) kms_big_fb (y-tiled-32bpp-rotate-180) [320.104168] Starting subtest: y-tiled-32bpp-rotate-180 [320.108320] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [320.204286] [063/155] (702s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [320.261423] Starting subtest: etime-multi-wait-available-unsubmitted [320.366417] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.105s) [320.447396] [064/155] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [320.541493] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [320.545829] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [320.641541] [065/155] (702s left) kms_pm_rpm (modeset-non-lpsp-stress) [322.368078] Starting subtest: modeset-non-lpsp-stress [323.523786] Subtest modeset-non-lpsp-stress: SKIP (1.156s) [323.939623] [066/155] (698s left) syncobj_timeline (single-wait-all-for-submit-signaled) [323.997190] Starting subtest: single-wait-all-for-submit-signaled [323.999572] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [324.130522] [067/155] (698s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [324.187092] Starting subtest: invalid-multi-wait-unsubmitted-submitted [324.189329] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [324.285622] [068/155] (698s left) kms_plane (plane-panning-bottom-right-suspend) [324.373053] Starting subtest: plane-panning-bottom-right-suspend [324.375267] Starting dynamic subtest: pipe-A [341.833635] Dynamic subtest pipe-A: SUCCESS (2.885s) [341.845365] Starting dynamic subtest: pipe-B [360.832292] Dynamic subtest pipe-B: SUCCESS (3.490s) [360.834720] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.377s) [361.725146] [069/155] (661s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move) [361.835040] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move [361.839764] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [361.929520] [070/155] (660s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [362.048428] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt [362.052975] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [362.146414] [071/155] (660s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [362.268526] Starting subtest: flip-vs-cursor-busy-crc-atomic [363.007394] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.737s) [363.871934] [072/155] (659s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [363.978398] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [370.910795] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.934s) [371.051045] [073/155] (651s left) gem_exec_reloc (basic-wc) [371.115971] Subtest basic-wc: SKIP (0.000s) [371.201916] [074/155] (651s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [371.302531] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [371.306787] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [371.412046] [075/155] (651s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt) [371.508901] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt [371.512899] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [371.613040] [076/155] (651s left) gen7_exec_parse (oacontrol-tracking) [371.679402] Subtest oacontrol-tracking: SKIP (0.000s) [371.757917] [077/155] (651s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render) [371.867090] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render [371.871071] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [371.967780] [078/155] (651s left) kms_addfb_basic (invalid-get-prop-any) [372.021927] Starting subtest: invalid-get-prop-any [372.023800] Subtest invalid-get-prop-any: SUCCESS (0.000s) [372.172798] [079/155] (651s left) kms_psr (pr-sprite-plane-move) [372.264790] Starting subtest: pr-sprite-plane-move [372.268228] Subtest pr-sprite-plane-move: SKIP (0.000s) [372.350920] [080/155] (650s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [372.470404] Starting subtest: 2x-cursor-vs-flip-atomic [372.474215] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s) [372.629802] [081/155] (650s left) kms_cursor_crc (cursor-onscreen-256x256) [372.872040] Starting subtest: cursor-onscreen-256x256 [372.876249] Starting dynamic subtest: pipe-A-eDP-1 [374.996627] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s) [375.033152] Starting dynamic subtest: pipe-D-eDP-1 [377.801014] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s) [377.803238] Subtest cursor-onscreen-256x256: SUCCESS (4.925s) [378.672720] [082/155] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [378.786259] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [385.815556] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (7.030s) [385.947790] [083/155] (637s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [386.006592] Starting subtest: multi-wait-for-submit-available-submitted [386.008776] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [386.100832] [084/155] (637s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [386.193994] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [386.198317] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s) [386.270106] [085/155] (637s left) gem_ctx_bad_destroy (double-destroy) [386.333369] Starting subtest: double-destroy [386.335361] Subtest double-destroy: SUCCESS (0.000s) [386.407639] [086/155] (637s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [386.503805] Starting subtest: fbcpsr-modesetfrombusy [392.829747] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.330s) [392.970174] [087/155] (630s left) perf_pmu (event-wait) [393.008833] Starting subtest: event-wait [393.010867] Starting dynamic subtest: rcs0 [393.014335] Dynamic subtest rcs0: SKIP (0.000s) [393.017669] Subtest event-wait: SKIP (0.001s) [393.114344] [088/155] (630s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [393.210794] Starting subtest: yf-tiled-64bpp-rotate-270 [393.214691] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [393.314705] [089/155] (630s left) kms_psr (fbc-psr-basic) [393.403440] Starting subtest: fbc-psr-basic [393.405276] Starting dynamic subtest: eDP-1 [393.408636] Dynamic subtest eDP-1: SKIP (0.000s) [393.412039] Subtest fbc-psr-basic: SKIP (0.001s) [393.476930] [090/155] (630s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move) [393.572642] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move [393.576274] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [393.668974] [091/155] (630s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [393.767593] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [394.593160] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s) [394.757581] [092/155] (629s left) gem_exec_fence (basic-busy-all) [394.815649] Starting subtest: basic-busy-all [394.903602] Subtest basic-busy-all: SUCCESS (0.088s) [396.395148] [093/155] (627s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [396.492220] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [397.571480] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.080s) [397.685332] [094/155] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [397.798692] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [421.111192] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.310s) [421.237709] [095/155] (602s left) prime_mmap (test_refcounting) [421.305826] Starting subtest: test_refcounting [421.307511] Starting dynamic subtest: test_refcounting-smem [421.337041] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s) [421.339223] Subtest test_refcounting: SUCCESS (0.034s) [421.438445] [096/155] (602s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [421.535957] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [421.540042] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [421.647198] [097/155] (602s left) kms_pm_rpm (fences-dpms) [423.474286] Starting subtest: fences-dpms [423.480073] Subtest fences-dpms: SKIP (0.000s) [423.920934] [098/155] (600s left) kms_addfb_basic (basic-x-tiled-legacy) [423.973457] Starting subtest: basic-x-tiled-legacy [423.978403] Subtest basic-x-tiled-legacy: SKIP (0.000s) [424.096806] [099/155] (600s left) gem_exec_parallel (engines) [424.162335] Starting subtest: engines [424.164567] Starting dynamic subtest: basic [426.271361] Dynamic subtest basic: SUCCESS (2.106s) [426.285722] Starting dynamic subtest: contexts [430.664228] Dynamic subtest contexts: SUCCESS (4.389s) [430.675698] Starting dynamic subtest: fds [434.437959] Dynamic subtest fds: SUCCESS (3.770s) [434.452718] Starting dynamic subtest: userptr [436.251683] Dynamic subtest userptr: SUCCESS (1.810s) [436.254476] Subtest engines: SUCCESS (12.086s) [436.447306] [100/155] (587s left) core_getversion (basic) [436.489005] Starting subtest: basic [436.493301] Subtest basic: SUCCESS (0.000s) [436.562435] [101/155] (587s left) kms_invalid_mode (clock-too-high) [436.661770] Starting subtest: clock-too-high [436.664396] Starting dynamic subtest: pipe-A-eDP-1 [436.943783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [436.958515] Starting dynamic subtest: pipe-B-eDP-1 [436.962787] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [436.974189] Starting dynamic subtest: pipe-C-eDP-1 [436.978593] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [436.989926] Starting dynamic subtest: pipe-D-eDP-1 [436.994584] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [436.996982] Subtest clock-too-high: SUCCESS (0.290s) [437.825209] [102/155] (586s left) gem_mmap_wc (read-write) [437.886077] Subtest read-write: SKIP (0.000s) [437.959923] [103/155] (586s left) gem_exec_params (rsvd2-dirt) [438.009702] Starting subtest: rsvd2-dirt [438.014115] Subtest rsvd2-dirt: SKIP (0.000s) [438.106445] [104/155] (586s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt) [438.199441] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt [438.203508] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [438.315737] [105/155] (586s left) kms_big_fb (linear-64bpp-rotate-270) [438.410358] Starting subtest: linear-64bpp-rotate-270 [438.430794] Subtest linear-64bpp-rotate-270: SKIP (0.020s) [438.536265] [106/155] (585s left) vgem_basic (dmabuf-mmap) [438.576312] Starting subtest: dmabuf-mmap [438.626040] Subtest dmabuf-mmap: SUCCESS (0.052s) [438.691392] [107/155] (585s left) gem_create (create-ext-set-pat) [438.854036] Starting subtest: create-ext-set-pat [438.856688] Subtest create-ext-set-pat: SUCCESS (0.000s) [438.948976] [108/155] (585s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [439.055031] Starting subtest: pr-overlay-primary-update-sf-dmg-area [439.059257] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [439.125942] [109/155] (585s left) kms_psr (psr-cursor-plane-onoff) [439.231853] Starting subtest: psr-cursor-plane-onoff [439.234335] Starting dynamic subtest: eDP-1 [440.933853] Dynamic subtest eDP-1: SUCCESS (1.703s) [440.936172] Subtest psr-cursor-plane-onoff: SUCCESS (1.704s) [441.825117] [110/155] (582s left) i915_module_load (reload) [441.861308] Starting subtest: reload [448.059392] Subtest reload: SUCCESS (6.199s) [448.103268] [111/155] (576s left) gem_spin_batch (spin-all-new) [449.231413] Starting subtest: spin-all-new [449.248018] Subtest spin-all-new: SUCCESS (0.014s) [451.336614] [112/155] (573s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [451.389002] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [451.393369] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [451.576051] [113/155] (573s left) kms_vblank (wait-idle) [451.670821] Starting subtest: wait-idle [451.673054] Starting dynamic subtest: pipe-A-eDP-1 [453.461941] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.790s) [453.477651] Starting dynamic subtest: pipe-D-eDP-1 [455.946125] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.484s) [455.948442] Subtest wait-idle: SUCCESS (4.278s) [456.781324] [114/155] (568s left) gem_exec_fence (concurrent) [456.964542] Starting subtest: concurrent [456.969315] Subtest concurrent: SKIP (0.000s) [458.366973] [115/155] (566s left) gem_exec_async (concurrent-writes) [458.427167] Starting subtest: concurrent-writes [458.429583] Starting dynamic subtest: rcs0 [458.446404] Dynamic subtest rcs0: SUCCESS (0.019s) [458.461653] Starting dynamic subtest: bcs0 [458.463903] Dynamic subtest bcs0: SUCCESS (0.012s) [458.475886] Starting dynamic subtest: vcs0 [458.478775] Dynamic subtest vcs0: SUCCESS (0.005s) [458.489515] Starting dynamic subtest: vcs1 [458.491493] Dynamic subtest vcs1: SUCCESS (0.008s) [458.501189] Starting dynamic subtest: vecs0 [458.503210] Dynamic subtest vecs0: SUCCESS (0.006s) [458.513039] Starting dynamic subtest: ccs0 [458.514966] Dynamic subtest ccs0: SUCCESS (0.006s) [458.516923] Subtest concurrent-writes: SUCCESS (0.060s) [458.713644] [116/155] (566s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [458.806761] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [458.809132] Starting dynamic subtest: pipe-A-eDP-1 [458.832539] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [458.845118] Starting dynamic subtest: pipe-B-eDP-1 [458.866944] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [458.876824] Starting dynamic subtest: pipe-C-eDP-1 [458.898566] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [458.908286] Starting dynamic subtest: pipe-D-eDP-1 [458.930491] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [458.934942] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [461.119688] [117/155] (563s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [461.218946] Starting subtest: plane-upscale-factor-0-25-with-modifiers [461.221193] Starting dynamic subtest: pipe-A [461.554215] Dynamic subtest pipe-A: SUCCESS (0.338s) [461.564898] Starting dynamic subtest: pipe-B [463.014581] Dynamic subtest pipe-B: SUCCESS (1.460s) [463.024799] Starting dynamic subtest: pipe-C [464.453592] Dynamic subtest pipe-C: SUCCESS (1.437s) [464.474651] Starting dynamic subtest: pipe-D [465.881847] Dynamic subtest pipe-D: SUCCESS (1.429s) [465.884058] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.669s) [467.056903] [118/155] (557s left) gem_exec_schedule (u-semaphore-resolve) [467.135637] Starting subtest: u-semaphore-resolve [467.167709] Subtest u-semaphore-resolve: SUCCESS (0.041s) [467.511855] [119/155] (557s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [467.604291] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [467.615384] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [467.730458] [120/155] (557s left) gem_pread (bench) [467.791579] Subtest bench: SKIP (0.000s) [467.851810] [121/155] (557s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [467.957936] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [467.962353] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [468.047876] [122/155] (557s left) gem_eio (wait-immediate) [468.236810] Starting subtest: wait-immediate [468.525543] Subtest wait-immediate: SUCCESS (0.291s) [468.641769] [123/155] (556s left) kms_dp_link_training (non-uhbr-mst) [468.729761] Starting subtest: non-uhbr-mst [468.736916] Subtest non-uhbr-mst: SKIP (0.000s) [468.803164] [124/155] (556s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt) [468.896507] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt [468.899977] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [468.993615] [125/155] (556s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [469.049878] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [469.051947] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [469.185346] [126/155] (556s left) prime_vgem (fence-flip-hang) [469.249481] Subtest fence-flip-hang: SKIP (0.000s) [469.376969] [127/155] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [469.463877] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [469.467502] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [469.577332] [128/155] (555s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt) [469.669826] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt [469.673193] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [469.772638] [129/155] (555s left) gem_partial_pwrite_pread (writes-after-reads) [469.837624] Subtest writes-after-reads: SKIP (0.000s) [469.900817] [130/155] (555s left) gem_sync (basic-many-each) [469.963566] Starting subtest: basic-many-each [472.240558] Subtest basic-many-each: SUCCESS (2.285s) [472.427953] [131/155] (553s left) sw_sync (alloc_fence) [472.460259] Starting subtest: alloc_fence [472.462662] Subtest alloc_fence: SUCCESS (0.000s) [472.515723] [132/155] (553s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-render) [472.619322] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-render [472.623370] Subtest hdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [472.732318] [133/155] (552s left) gem_exec_store (cachelines) [472.784215] Starting subtest: cachelines [472.786170] Starting dynamic subtest: rcs0 [472.839422] Dynamic subtest rcs0: SUCCESS (0.056s) [472.852125] Starting dynamic subtest: bcs0 [472.897638] Dynamic subtest bcs0: SUCCESS (0.056s) [472.911013] Starting dynamic subtest: vcs0 [472.951956] Dynamic subtest vcs0: SUCCESS (0.053s) [472.964475] Starting dynamic subtest: vcs1 [473.008185] Dynamic subtest vcs1: SUCCESS (0.054s) [473.020561] Starting dynamic subtest: vecs0 [473.062726] Dynamic subtest vecs0: SUCCESS (0.052s) [473.075254] Starting dynamic subtest: ccs0 [473.114181] Dynamic subtest ccs0: SUCCESS (0.050s) [473.116579] Subtest cachelines: SUCCESS (0.332s) [473.304035] [134/155] (552s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [473.398309] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [473.402390] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [473.492829] [135/155] (552s left) kms_feature_discovery (display-3x) [473.586904] Starting subtest: display-3x [473.591312] Subtest display-3x: SKIP (0.000s) [473.689226] [136/155] (552s left) kms_chamelium_hpd (dp-hpd-storm) [474.083259] Subtest dp-hpd-storm: SKIP (0.000s) [474.865616] [137/155] (550s left) gem_render_copy (linear-to-vebox-yf-tiled) [474.925662] Starting subtest: linear-to-vebox-yf-tiled [474.930454] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [475.111628] [138/155] (550s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt) [475.202450] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt [475.206497] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [475.295113] [139/155] (550s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [475.391619] Starting subtest: fbc-rgb101010-draw-pwrite [478.695316] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.310s) [479.883768] [140/155] (546s left) kms_flip (wf_vblank-ts-check) [479.985034] Starting subtest: wf_vblank-ts-check [479.986916] Starting dynamic subtest: A-eDP1 [488.921514] Dynamic subtest A-eDP1: SUCCESS (8.939s) [488.934802] Starting dynamic subtest: B-eDP1 [497.846377] Dynamic subtest B-eDP1: SUCCESS (8.925s) [497.865368] Starting dynamic subtest: C-eDP1 [506.760801] Dynamic subtest C-eDP1: SUCCESS (8.912s) [506.772168] Starting dynamic subtest: D-eDP1 [515.696593] Dynamic subtest D-eDP1: SUCCESS (8.934s) [515.699045] Subtest wf_vblank-ts-check: SUCCESS (35.720s) [516.917599] [141/155] (509s left) gem_mmap_gtt (pf-nonblock) [516.974506] Subtest pf-nonblock: SKIP (0.000s) [517.044215] [142/155] (508s left) sriov_basic (enable-vfs-autoprobe-on) [517.100281] Starting subtest: enable-vfs-autoprobe-on [517.102445] Starting dynamic subtest: numvfs-1 [517.106950] Dynamic subtest numvfs-1: SKIP (0.001s) [517.117685] Starting dynamic subtest: numvfs-2 [517.121849] Dynamic subtest numvfs-2: SKIP (0.001s) [517.132116] Starting dynamic subtest: numvfs-3 [517.136294] Dynamic subtest numvfs-3: SKIP (0.001s) [517.146808] Starting dynamic subtest: numvfs-4 [517.150858] Dynamic subtest numvfs-4: SKIP (0.001s) [517.163930] Starting dynamic subtest: numvfs-5 [517.167918] Dynamic subtest numvfs-5: SKIP (0.001s) [517.178543] Starting dynamic subtest: numvfs-6 [517.182779] Dynamic subtest numvfs-6: SKIP (0.001s) [517.192815] Starting dynamic subtest: numvfs-7 [517.196939] Dynamic subtest numvfs-7: SKIP (0.001s) [517.207028] Starting dynamic subtest: numvfs-random [517.211239] Dynamic subtest numvfs-random: SKIP (0.001s) [517.222409] Starting dynamic subtest: numvfs-all [517.226539] Dynamic subtest numvfs-all: SKIP (0.001s) [517.230810] Subtest enable-vfs-autoprobe-on: SKIP (0.012s) [517.270705] [143/155] (508s left) kms_cdclk (mode-transition) [517.370588] Starting subtest: mode-transition [517.373006] Starting dynamic subtest: pipe-A-eDP-1 [517.660086] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s) [517.674194] Starting dynamic subtest: pipe-B-eDP-1 [517.678920] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [517.689411] Starting dynamic subtest: pipe-C-eDP-1 [517.694122] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [517.704973] Starting dynamic subtest: pipe-D-eDP-1 [517.709130] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [517.713336] Subtest mode-transition: SKIP (0.296s) [518.551313] [144/155] (507s left) kms_flip (2x-flip-vs-suspend) [518.653857] Starting subtest: 2x-flip-vs-suspend [518.658309] Subtest 2x-flip-vs-suspend: SKIP (0.002s) [518.764769] [145/155] (507s left) kms_psr (fbc-pr-no-drrs) [518.862798] Starting subtest: fbc-pr-no-drrs [518.866866] Subtest fbc-pr-no-drrs: SKIP (0.000s) [518.937909] [146/155] (507s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt) [519.032152] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt [519.036264] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [519.132462] [147/155] (507s left) gem_userptr_blits (sync-unmap-cycles) [519.207887] Starting subtest: sync-unmap-cycles [524.578694] Subtest sync-unmap-cycles: SUCCESS (5.372s) [524.726928] [148/155] (501s left) kms_frontbuffer_tracking (fbcpsr-suspend) [524.836801] Starting subtest: fbcpsr-suspend [567.066995] Subtest fbcpsr-suspend: SUCCESS (12.532s) [569.229811] [149/155] (459s left) gem_exec_reloc (basic-write-cpu-active) [569.299517] Subtest basic-write-cpu-active: SKIP (0.000s) [569.375324] [150/155] (459s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-gtt) [569.478070] Starting subtest: hdr-rgb565-draw-mmap-gtt [569.483077] Subtest hdr-rgb565-draw-mmap-gtt: SKIP (0.000s) [569.564885] [151/155] (458s left) i915_drm_fdinfo (all-busy-idle-check-all) [569.603934] Starting subtest: all-busy-idle-check-all [569.612739] Subtest all-busy-idle-check-all: SKIP (0.006s) [569.689926] [152/155] (458s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite) [569.810771] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite [569.816039] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [569.897017] [153/155] (458s left) prime_vgem (basic-gtt) [569.967090] Starting subtest: basic-gtt [569.973141] Subtest basic-gtt: SKIP (0.000s) [570.062530] [154/155] (458s left) gem_exec_whisper (basic-queues-forked-all) [570.129692] Starting subtest: basic-queues-forked-all [592.162185] Subtest basic-queues-forked-all: SUCCESS (22.017s) [592.368412] [155/155] (436s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [592.426654] Starting subtest: multi-wait-for-submit-unsubmitted [592.532846] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s) [592.613820] Closing watchdogs results: parsing output: 0/ for test: gem_wait results: parsing output: 1/ for test: kms_content_protection results: parsing output: 2/ for test: kms_cursor_crc results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_vblank results: parsing output: 5/ for test: gem_exec_schedule results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: perf_pmu results: parsing output: 9/ for test: kms_plane results: parsing output: 10/ for test: gem_eio results: parsing output: 11/ for test: kms_cursor_legacy results: parsing output: 12/ for test: gem_exec_parallel results: parsing output: 13/ for test: gem_ccs results: parsing output: 14/ for test: kms_plane_cursor results: parsing output: 15/ for test: kms_multipipe_modeset results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: i915_pm_rps results: parsing output: 19/ for test: gem_exec_balancer results: parsing output: 20/ for test: kms_fbcon_fbt results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: syncobj_timeline results: parsing output: 23/ for test: gem_ctx_isolation results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_plane results: parsing output: 27/ for test: kms_selftest results: parsing output: 28/ for test: api_intel_bb results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_prop_blob results: parsing output: 31/ for test: kms_flip_scaled_crc results: parsing output: 32/ for test: gem_mmap_gtt results: parsing output: 33/ for test: kms_addfb_basic results: parsing output: 34/ for test: gem_fenced_exec_thrash results: parsing output: 35/ for test: kms_psr results: parsing output: 36/ for test: kms_vblank results: parsing output: 37/ for test: api_intel_bb results: parsing output: 38/ for test: kms_atomic results: parsing output: 39/ for test: gem_render_copy results: parsing output: 40/ for test: gem_create results: parsing output: 41/ for test: gem_ctx_persistence results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_cursor_crc results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: perf results: parsing output: 47/ for test: sysfs_timeslice_duration results: parsing output: 48/ for test: i915_pm_rps results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_color results: parsing output: 51/ for test: gem_exec_fence results: parsing output: 52/ for test: kms_cursor_legacy results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_chamelium_frames results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_mmap_gtt results: parsing output: 60/ for test: kms_ccs results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_pm_rpm results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: kms_plane results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_exec_reloc results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gen7_exec_parse results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: kms_cursor_legacy results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: kms_flip_scaled_crc results: parsing output: 84/ for test: gem_ctx_bad_destroy results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: perf_pmu results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_big_fb results: parsing output: 91/ for test: gem_exec_fence results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: prime_mmap results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: kms_pm_rpm results: parsing output: 97/ for test: kms_addfb_basic results: parsing output: 98/ for test: gem_exec_parallel results: parsing output: 99/ for test: core_getversion results: parsing output: 100/ for test: kms_invalid_mode results: parsing output: 101/ for test: gem_mmap_wc results: parsing output: 102/ for test: gem_exec_params results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: vgem_basic results: parsing output: 106/ for test: gem_create results: parsing output: 107/ for test: kms_psr2_sf results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: i915_module_load results: parsing output: 110/ for test: gem_spin_batch results: parsing output: 111/ for test: gem_render_copy results: parsing output: 112/ for test: kms_vblank results: parsing output: 113/ for test: gem_exec_fence results: parsing output: 114/ for test: gem_exec_async results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: kms_plane_scaling results: parsing output: 117/ for test: gem_exec_schedule results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: gem_pread results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_eio results: parsing output: 122/ for test: kms_dp_link_training results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: prime_vgem results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_partial_pwrite_pread results: parsing output: 129/ for test: gem_sync results: parsing output: 130/ for test: sw_sync results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_exec_store results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_feature_discovery results: parsing output: 135/ for test: kms_chamelium_hpd results: parsing output: 136/ for test: gem_render_copy results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_flip results: parsing output: 140/ for test: gem_mmap_gtt results: parsing output: 141/ for test: sriov_basic results: parsing output: 142/ for test: kms_cdclk results: parsing output: 143/ for test: kms_flip results: parsing output: 144/ for test: kms_psr results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: gem_userptr_blits results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: gem_exec_reloc results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: i915_drm_fdinfo results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: prime_vgem results: parsing output: 153/ for test: gem_exec_whisper results: parsing output: 154/ for test: syncobj_wait Done.