[59.897043] Initializing watchdogs [59.897154] /dev/watchdog0 [59.913977] [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.918432] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.920849] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.923208] [001/156] (960s left) gem_flink_race (flink_name) [59.960114] Starting subtest: flink_name [65.397321] Subtest flink_name: SUCCESS (5.397s) [65.445788] [002/156] (955s left) gem_exec_async (concurrent-writes) [65.502443] Starting subtest: concurrent-writes [65.503592] Starting dynamic subtest: rcs0 [65.529267] Dynamic subtest rcs0: SUCCESS (0.027s) [65.539469] Starting dynamic subtest: bcs0 [65.540864] Dynamic subtest bcs0: SUCCESS (0.010s) [65.547825] Starting dynamic subtest: vcs0 [65.548972] Dynamic subtest vcs0: SUCCESS (0.008s) [65.555456] Starting dynamic subtest: vcs1 [65.556536] Dynamic subtest vcs1: SUCCESS (0.009s) [65.563073] Starting dynamic subtest: vecs0 [65.565730] Dynamic subtest vecs0: SUCCESS (0.010s) [65.571980] Starting dynamic subtest: ccs0 [65.574528] Dynamic subtest ccs0: SUCCESS (0.008s) [65.575570] Subtest concurrent-writes: SUCCESS (0.072s) [65.808916] [003/156] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [65.923268] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [73.968666] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (8.053s) [74.093476] [004/156] (946s left) gem_lmem_swapping (verify-random) [74.129085] Subtest verify-random: SKIP (0.000s) [74.168242] [005/156] (946s left) gem_exec_reloc (basic-gtt-cpu-active) [74.215796] Subtest basic-gtt-cpu-active: SKIP (0.000s) [74.284237] [006/156] (946s left) gem_ccs (large-ctrl-surf-copy) [74.338743] Starting subtest: large-ctrl-surf-copy [74.341344] Subtest large-ctrl-surf-copy: SKIP (0.000s) [74.443192] [007/156] (946s left) kms_feature_discovery (chamelium) [74.536551] Starting subtest: chamelium [74.538553] Subtest chamelium: SKIP (0.000s) [74.603193] [008/156] (946s left) gem_exec_whisper (basic-fds-priority-all) [74.668962] Starting subtest: basic-fds-priority-all [96.925160] Subtest basic-fds-priority-all: SUCCESS (22.254s) [97.107451] [009/156] (923s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-blt) [97.202610] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-blt [97.204541] Subtest psrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [97.312959] [010/156] (923s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [97.406937] Starting subtest: psr-rgb565-draw-mmap-cpu [104.312276] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.908s) [104.419655] [011/156] (916s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [104.476015] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [104.596963] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.109s) [104.654678] [012/156] (916s left) gem_exec_fence (basic-busy-all) [104.714190] Starting subtest: basic-busy-all [104.813999] Subtest basic-busy-all: SUCCESS (0.099s) [106.414514] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [106.416368] [013/156] (914s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [106.513216] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [106.514904] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [106.613375] [014/156] (914s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [106.700074] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [106.701838] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [106.802614] [015/156] (914s left) gem_exec_schedule (preempt-queue) [106.859671] Subtest preempt-queue: SKIP (0.000s) [107.162836] [016/156] (913s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [107.255219] Starting subtest: yf-tiled-8bpp-rotate-90 [107.257109] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [107.332504] [017/156] (913s left) gem_exec_fence (syncobj-invalid-wait) [107.738317] Starting subtest: syncobj-invalid-wait [107.739368] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [109.423192] [018/156] (911s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary) [109.517270] Starting subtest: fbcpsrhdr-indfb-scaledprimary [109.518908] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s) [109.626697] [019/156] (911s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt) [109.720364] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt [109.722126] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [109.807980] [020/156] (911s left) syncobj_wait (multi-wait-for-submit-signaled) [109.853425] Starting subtest: multi-wait-for-submit-signaled [109.854509] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [109.974841] [021/156] (911s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [110.063107] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [110.065088] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [110.127872] [022/156] (911s left) gem_exec_params (rs-invalid) [110.179565] Starting subtest: rs-invalid [110.183690] Subtest rs-invalid: SUCCESS (0.003s) [110.309744] [023/156] (910s left) gem_flink_basic (basic) [110.369178] Starting subtest: basic [110.371250] Subtest basic: SUCCESS (0.000s) [110.493614] [024/156] (910s left) kms_cursor_crc (cursor-offscreen-256x256) [110.728404] Starting subtest: cursor-offscreen-256x256 [110.731947] Starting dynamic subtest: pipe-A-eDP-1 [112.724464] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.992s) [112.760417] Starting dynamic subtest: pipe-D-eDP-1 [115.373426] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s) [115.374627] Subtest cursor-offscreen-256x256: SUCCESS (4.644s) [116.182308] [025/156] (905s left) gem_render_copy_redux (flink) [116.245173] Starting subtest: flink [117.007762] Subtest flink: SUCCESS (0.762s) [117.119920] [026/156] (904s left) syncobj_wait (reset-unsignaled) [117.175759] Starting subtest: reset-unsignaled [117.176672] Subtest reset-unsignaled: SUCCESS (0.000s) [117.281277] [027/156] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [117.372908] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [117.374605] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [117.486005] [028/156] (903s left) i915_drm_fdinfo (all-busy-idle-check-all) [117.520681] Starting subtest: all-busy-idle-check-all [117.525934] Subtest all-busy-idle-check-all: SKIP (0.004s) [117.586129] [029/156] (903s left) drm_buddy (drm_buddy) [117.618956] Starting subtest: drm_buddy [117.620805] Subtest drm_buddy: SKIP (0.001s) [117.685268] [030/156] (903s left) gem_ctx_param (invalid-get-engines) [117.755307] Starting subtest: invalid-get-engines [117.757791] Subtest invalid-get-engines: SUCCESS (0.002s) [117.843066] [031/156] (903s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [117.943905] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [117.945897] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [118.039908] [032/156] (903s left) kms_psr (fbc-pr-cursor-plane-move) [118.128671] Starting subtest: fbc-pr-cursor-plane-move [118.130681] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [118.198974] [033/156] (903s left) kms_async_flips (alternate-sync-async-flip-atomic) [118.287254] Starting subtest: alternate-sync-async-flip-atomic [118.660321] Starting dynamic subtest: pipe-A-eDP-1 [121.487117] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.827s) [121.868731] Starting dynamic subtest: pipe-B-eDP-1 [124.625248] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s) [125.005076] Starting dynamic subtest: pipe-C-eDP-1 [127.766716] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s) [128.141937] Starting dynamic subtest: pipe-D-eDP-1 [130.909013] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s) [130.910326] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.622s) [132.077122] [034/156] (889s left) kms_frontbuffer_tracking (fbc-tiling-y) [132.169895] Starting subtest: fbc-tiling-y [132.172079] Subtest fbc-tiling-y: SKIP (0.000s) [132.269303] [035/156] (889s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [132.384133] Starting subtest: short-flip-before-cursor-atomic-transitions [133.354347] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.969s) [134.206908] [036/156] (887s left) gem_exec_suspend (basic) [134.260608] Starting subtest: basic [134.261804] Starting dynamic subtest: smem [136.293165] Dynamic subtest smem: SUCCESS (2.023s) [136.294573] Subtest basic: SUCCESS (2.024s) [136.462654] [037/156] (885s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [136.564313] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [143.520390] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.958s) [143.651229] [038/156] (878s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [143.739281] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [151.200030] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.462s) [151.329139] [039/156] (870s left) api_intel_bb (render-ccs) [151.378141] Starting subtest: render-ccs [151.749994] Subtest render-ccs: SUCCESS (0.363s) [151.851563] [040/156] (869s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen) [151.947443] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen [151.949255] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [152.042623] [041/156] (869s left) gem_sync (basic-store-all) [152.101990] Starting subtest: basic-store-all [155.212758] Subtest basic-store-all: SUCCESS (3.111s) [155.395671] [042/156] (866s left) kms_vblank (query-idle-hang) [155.480060] Starting subtest: query-idle-hang [155.480951] Starting dynamic subtest: pipe-A-eDP-1 [182.115394] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.634s) [182.124949] Starting dynamic subtest: pipe-D-eDP-1 [197.086170] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.968s) [197.087042] Subtest query-idle-hang: SUCCESS (41.606s) [197.912442] [043/156] (823s left) kms_vblank (crtc-id) [198.005292] Starting subtest: crtc-id [198.006264] Starting dynamic subtest: pipe-A-eDP-1 [198.459353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s) [198.469100] Starting dynamic subtest: pipe-D-eDP-1 [199.637604] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.177s) [199.638570] Subtest crtc-id: SUCCESS (1.633s) [200.507501] [044/156] (821s left) kms_addfb_basic (unused-modifier) [200.555336] Starting subtest: unused-modifier [200.556271] Subtest unused-modifier: SUCCESS (0.000s) [200.695225] [045/156] (821s left) gem_mmap_gtt (hang) [200.742990] Subtest hang: SKIP (0.000s) [200.797699] [046/156] (821s left) gem_tiled_swapping (non-threaded) [200.844283] Subtest non-threaded: SKIP (0.000s) [200.888996] [047/156] (821s left) kms_psr (fbc-psr2-sprite-render) [200.976399] Starting subtest: fbc-psr2-sprite-render [200.977439] Starting dynamic subtest: eDP-1 [200.979299] Dynamic subtest eDP-1: SKIP (0.000s) [200.980911] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [201.057717] [048/156] (820s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [201.112672] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [201.113709] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [201.212499] [049/156] (820s left) perf (invalid-remove-userspace-config) [201.329040] Starting subtest: invalid-remove-userspace-config [201.339073] Subtest invalid-remove-userspace-config: SUCCESS (0.010s) [201.374931] [050/156] (820s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move) [201.461577] Starting subtest: hdr-1p-primscrn-cur-indfb-move [201.463268] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [201.558826] [051/156] (820s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [201.937037] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [202.781284] [052/156] (819s left) kms_plane_cursor (overlay) [202.861424] Starting subtest: overlay [202.863323] Starting dynamic subtest: pipe-A-eDP-1-size-64 [205.444249] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.583s) [205.505075] Starting dynamic subtest: pipe-A-eDP-1-size-128 [208.067085] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s) [208.129789] Starting dynamic subtest: pipe-A-eDP-1-size-256 [210.724078] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s) [211.076272] Starting dynamic subtest: pipe-B-eDP-1-size-64 [214.404947] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.342s) [214.465952] Starting dynamic subtest: pipe-B-eDP-1-size-128 [217.027769] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s) [217.090330] Starting dynamic subtest: pipe-B-eDP-1-size-256 [219.673729] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.594s) [220.023385] Starting dynamic subtest: pipe-C-eDP-1-size-64 [223.019555] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.995s) [223.051375] Starting dynamic subtest: pipe-C-eDP-1-size-128 [225.279641] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s) [225.317563] Starting dynamic subtest: pipe-C-eDP-1-size-256 [227.568077] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.259s) [227.895900] Starting dynamic subtest: pipe-D-eDP-1-size-64 [230.858718] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.971s) [230.897540] Starting dynamic subtest: pipe-D-eDP-1-size-128 [233.124653] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.237s) [233.162866] Starting dynamic subtest: pipe-D-eDP-1-size-256 [235.391367] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.236s) [235.710281] Subtest overlay: SUCCESS (32.849s) [236.556479] [053/156] (785s left) sysfs_timeslice_duration (timeout) [236.612272] Starting subtest: timeout [236.613427] Starting dynamic subtest: vecs0 [246.305118] Dynamic subtest vecs0: SUCCESS (9.681s) [246.316505] Starting dynamic subtest: ccs0 [247.551576] Dynamic subtest ccs0: SUCCESS (1.254s) [247.561209] Starting dynamic subtest: vcs0 [257.312861] Dynamic subtest vcs0: SUCCESS (9.750s) [257.321499] Starting dynamic subtest: bcs0 [257.953493] Dynamic subtest bcs0: SUCCESS (0.647s) [257.965240] Starting dynamic subtest: rcs0 [259.210548] Dynamic subtest rcs0: SUCCESS (1.255s) [259.220704] Starting dynamic subtest: vcs1 [268.318700] Dynamic subtest vcs1: SUCCESS (9.097s) [268.319844] Subtest timeout: SUCCESS (31.695s) [268.381147] [054/156] (753s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [268.477370] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [273.041151] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.565s) [274.221132] [055/156] (748s left) perf_pmu (enable-race) [274.256876] Starting subtest: enable-race [274.257832] Starting dynamic subtest: rcs0 [287.037482] Dynamic subtest rcs0: SUCCESS (12.767s) [287.046305] Starting dynamic subtest: bcs0 [299.777207] Dynamic subtest bcs0: SUCCESS (12.737s) [299.785141] Starting dynamic subtest: vcs0 [315.302839] Dynamic subtest vcs0: SUCCESS (15.524s) [315.313783] Starting dynamic subtest: vcs1 [331.302807] Dynamic subtest vcs1: SUCCESS (15.996s) [331.313477] Starting dynamic subtest: vecs0 [347.301903] Dynamic subtest vecs0: SUCCESS (15.996s) [347.312254] Starting dynamic subtest: ccs0 [360.042812] Dynamic subtest ccs0: SUCCESS (12.748s) [360.044050] Subtest enable-race: SUCCESS (85.783s) [360.133208] [056/156] (662s left) gen9_exec_parse (cmd-crossing-page) [360.194789] Subtest cmd-crossing-page: SKIP (0.000s) [360.271721] [057/156] (662s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite) [360.377506] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite [360.379058] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [360.484436] [058/156] (661s left) gem_mmap_wc (bad-offset) [360.542122] Subtest bad-offset: SKIP (0.000s) [360.599150] [059/156] (661s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [360.702606] Starting subtest: fbc-rgb565-draw-blt [364.963052] Subtest fbc-rgb565-draw-blt: SUCCESS (4.260s) [366.135744] [060/156] (656s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [366.182324] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [366.290403] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [366.374126] [061/156] (656s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [366.458374] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [366.460240] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [366.556815] [062/156] (656s left) gem_gtt_cpu_tlb [366.667933] [063/156] (655s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [366.783537] Starting subtest: cursorA-vs-flipA-atomic [377.914548] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.130s) [378.749281] [064/156] (643s left) gem_watchdog (default-virtual) [378.815631] Starting subtest: default-virtual [385.105784] Subtest default-virtual: SUCCESS (6.281s) [385.190439] [065/156] (637s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [385.278346] Starting subtest: multiplane-rotation-cropping-bottom [402.750154] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.471s) [402.872139] [066/156] (619s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [403.007811] Starting subtest: basic-flip-before-cursor-atomic [403.948207] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.940s) [404.774996] [067/156] (617s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff) [404.876429] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff [404.878425] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [404.969011] [068/156] (617s left) gem_create (create-ext-placement-sanity-check) [405.134778] Starting subtest: create-ext-placement-sanity-check [405.136391] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s) [405.243242] [069/156] (617s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt) [405.329781] Starting subtest: fbchdr-rgb101010-draw-blt [405.331606] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s) [405.451028] [070/156] (617s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render) [405.538672] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render [405.540464] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [405.627529] [071/156] (617s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [405.726053] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [405.728108] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [405.810052] [072/156] (617s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [405.889803] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [405.890853] Starting dynamic subtest: pipe-A-eDP-1 [405.899963] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [405.908403] Starting dynamic subtest: pipe-B-eDP-1 [405.916992] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [405.925632] Starting dynamic subtest: pipe-C-eDP-1 [405.933679] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [405.941593] Starting dynamic subtest: pipe-D-eDP-1 [405.949814] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [405.951370] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s) [408.137866] [073/156] (614s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [408.189535] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [408.190564] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [408.284377] [074/156] (614s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt) [408.380583] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt [408.382367] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [408.464107] [075/156] (614s left) gem_exec_balancer (invalid-balancer) [408.512269] Starting subtest: invalid-balancer [409.499025] Subtest invalid-balancer: SUCCESS (0.986s) [409.809558] [076/156] (613s left) i915_query (hwconfig_table) [409.850100] Starting subtest: hwconfig_table [409.965942] Subtest hwconfig_table: SUCCESS (0.001s) [409.996357] [077/156] (613s left) gem_mmap_offset (mmap-boundaries) [410.050554] Starting subtest: mmap-boundaries [410.051754] Starting dynamic subtest: smem0 [410.330304] Dynamic subtest smem0: SUCCESS (0.281s) [410.331672] Subtest mmap-boundaries: SUCCESS (0.282s) [410.453222] [078/156] (612s left) kms_flip (flip-vs-panning-vs-hang) [410.542087] Starting subtest: flip-vs-panning-vs-hang [410.542920] Starting dynamic subtest: A-eDP1 [461.832424] Dynamic subtest A-eDP1: SUCCESS (51.288s) [461.842813] Starting dynamic subtest: D-eDP1 [510.861654] Dynamic subtest D-eDP1: SUCCESS (49.027s) [510.864094] Subtest flip-vs-panning-vs-hang: SUCCESS (100.320s) [512.044605] [079/156] (511s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [512.094382] Starting subtest: multi-wait-all-for-submit-available-signaled [512.095387] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [512.183799] [080/156] (510s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [512.270617] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [512.271599] Starting dynamic subtest: pipe-A-eDP-1 [512.281073] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [512.289602] Starting dynamic subtest: pipe-B-eDP-1 [512.298660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [512.306999] Starting dynamic subtest: pipe-C-eDP-1 [512.315087] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [512.322971] Starting dynamic subtest: pipe-D-eDP-1 [512.331412] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [512.332950] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [514.588455] [081/156] (508s left) kms_big_fb (y-tiled-16bpp-rotate-180) [514.687738] Starting subtest: y-tiled-16bpp-rotate-180 [514.689810] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [514.780872] [082/156] (508s left) kms_chamelium_audio (hdmi-audio-edid) [515.152413] Subtest hdmi-audio-edid: SKIP (0.000s) [515.996270] [083/156] (507s left) i915_hangman (engine-engine-error) [516.066097] Starting subtest: engine-engine-error [516.067088] Starting dynamic subtest: rcs0 [517.316076] Dynamic subtest rcs0: SUCCESS (1.241s) [517.329154] Starting dynamic subtest: bcs0 [519.299480] Dynamic subtest bcs0: SUCCESS (1.980s) [519.308976] Starting dynamic subtest: vcs0 [521.283252] Dynamic subtest vcs0: SUCCESS (1.980s) [521.291802] Starting dynamic subtest: vcs1 [523.331881] Dynamic subtest vcs1: SUCCESS (2.045s) [523.341591] Starting dynamic subtest: vecs0 [525.316525] Dynamic subtest vecs0: SUCCESS (1.981s) [525.328456] Starting dynamic subtest: ccs0 [527.300719] Dynamic subtest ccs0: SUCCESS (1.981s) [527.302689] Subtest engine-engine-error: SUCCESS (11.226s) [527.370509] [084/156] (495s left) tools_test (sysfs_l3_parity) [527.410464] Starting subtest: sysfs_l3_parity [527.487483] Subtest sysfs_l3_parity: SKIP (0.080s) [527.539879] [085/156] (495s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt) [527.639912] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt [527.641714] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [527.743818] [086/156] (495s left) gem_spin_batch (resubmit-new-all) [527.808279] Starting subtest: resubmit-new-all [527.809392] Starting dynamic subtest: rcs0 [527.824883] Dynamic subtest rcs0: SUCCESS (0.016s) [527.833749] Starting dynamic subtest: bcs0 [527.834538] Dynamic subtest bcs0: SUCCESS (0.009s) [527.845891] Starting dynamic subtest: vcs0 [527.846866] Dynamic subtest vcs0: SUCCESS (0.011s) [527.855174] Starting dynamic subtest: vcs1 [527.857219] Dynamic subtest vcs1: SUCCESS (0.009s) [527.865214] Starting dynamic subtest: vecs0 [527.866226] Dynamic subtest vecs0: SUCCESS (0.008s) [527.874227] Starting dynamic subtest: ccs0 [527.875263] Dynamic subtest ccs0: SUCCESS (0.008s) [527.876130] Subtest resubmit-new-all: SUCCESS (0.066s) [529.344903] [087/156] (494s left) kms_vblank (query-forked-busy) [529.435059] Starting subtest: query-forked-busy [529.435841] Starting dynamic subtest: pipe-A-eDP-1 [531.322214] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s) [531.332656] Starting dynamic subtest: pipe-D-eDP-1 [533.883665] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.560s) [533.884895] Subtest query-forked-busy: SUCCESS (4.449s) [534.684921] [088/156] (488s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [534.789718] Starting subtest: fbc-1p-pri-indfb-multidraw [547.933987] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.145s) [549.309402] [089/156] (474s left) kms_plane (planar-pixel-format-settings) [549.393050] Starting subtest: planar-pixel-format-settings [549.461906] Subtest planar-pixel-format-settings: SUCCESS (0.069s) [549.572072] [090/156] (473s left) kms_big_fb (linear-32bpp-rotate-180) [549.669064] Starting subtest: linear-32bpp-rotate-180 [551.204287] Subtest linear-32bpp-rotate-180: SUCCESS (1.535s) [551.334985] [091/156] (472s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [551.434612] Starting subtest: psr2-overlay-plane-move-continuous-sf [551.435576] Starting dynamic subtest: pipe-A-eDP-1 [557.402089] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.968s) [557.414165] Starting dynamic subtest: pipe-B-eDP-1 [564.103052] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.698s) [564.103973] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.670s) [564.992271] [092/156] (458s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [565.080953] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [565.082553] Starting dynamic subtest: A-eDP1 [574.026164] Dynamic subtest A-eDP1: SUCCESS (8.943s) [574.036953] Starting dynamic subtest: B-eDP1 [582.962560] Dynamic subtest B-eDP1: SUCCESS (8.934s) [582.975606] Starting dynamic subtest: C-eDP1 [591.926346] Dynamic subtest C-eDP1: SUCCESS (8.923s) [591.934947] Starting dynamic subtest: D-eDP1 [600.866155] Dynamic subtest D-eDP1: SUCCESS (8.937s) [600.867138] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.747s) [602.048396] [093/156] (421s left) gem_exec_create (legacy) [602.101799] Starting subtest: legacy [602.102828] Starting dynamic subtest: smem [605.286675] Dynamic subtest smem: SUCCESS (3.173s) [605.288055] Subtest legacy: SUCCESS (3.175s) [605.456200] [094/156] (418s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [605.548742] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [605.550556] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [605.637731] [095/156] (418s left) kms_cursor_edge_walk (128x128-left-edge) [605.737068] Starting subtest: 128x128-left-edge [605.737923] Starting dynamic subtest: pipe-A-eDP-1 [609.228340] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s) [609.236692] Starting dynamic subtest: pipe-D-eDP-1 [612.440214] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.211s) [612.441103] Subtest 128x128-left-edge: SUCCESS (6.703s) [613.242957] [096/156] (410s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [613.327461] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [613.329498] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [613.422621] [097/156] (410s left) kms_content_protection (lic-type-0) [613.567727] Starting subtest: lic-type-0 [613.569553] Subtest lic-type-0: SKIP (0.000s) [613.680061] [098/156] (410s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt) [613.781273] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt [613.782910] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [613.871817] [099/156] (409s left) kms_pm_rpm (universal-planes) [615.500692] Starting subtest: universal-planes [615.502052] Starting dynamic subtest: plane-35 [623.823501] Dynamic subtest plane-35: SUCCESS (8.323s) [623.837208] Starting dynamic subtest: plane-65 [632.112994] Dynamic subtest plane-65: SUCCESS (8.286s) [632.125332] Starting dynamic subtest: plane-95 [640.577392] Dynamic subtest plane-95: SUCCESS (8.452s) [640.588689] Starting dynamic subtest: plane-125 [648.877033] Dynamic subtest plane-125: SUCCESS (8.306s) [648.889095] Starting dynamic subtest: plane-135 [657.191813] Dynamic subtest plane-135: SUCCESS (8.311s) [657.204514] Starting dynamic subtest: plane-145 [665.525445] Dynamic subtest plane-145: SUCCESS (8.330s) [665.527358] Subtest universal-planes: SUCCESS (50.027s) [665.916803] [100/156] (357s left) gem_pxp (regular-baseline-src-copy-readible) [666.026025] Starting subtest: regular-baseline-src-copy-readible [666.085712] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s) [666.202045] [101/156] (357s left) kms_debugfs (display-on-read-all) [666.284236] Starting subtest: display-on-read-all [666.450056] Subtest display-on-read-all: SUCCESS (0.167s) [666.576640] [102/156] (357s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [666.627712] Starting subtest: etime-multi-wait-all-for-submit-submitted [666.736039] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s) [666.809802] [103/156] (357s left) prime_vgem (fence-wait) [666.880818] Starting subtest: fence-wait [666.881931] Starting dynamic subtest: rcs0 [667.950337] Dynamic subtest rcs0: SUCCESS (1.060s) [667.960769] Starting dynamic subtest: bcs0 [669.020899] Dynamic subtest bcs0: SUCCESS (1.070s) [669.031525] Starting dynamic subtest: vcs0 [670.065378] Dynamic subtest vcs0: SUCCESS (1.043s) [670.076607] Starting dynamic subtest: vcs1 [671.107194] Dynamic subtest vcs1: SUCCESS (1.040s) [671.118507] Starting dynamic subtest: vecs0 [672.149124] Dynamic subtest vecs0: SUCCESS (1.040s) [672.158951] Starting dynamic subtest: ccs0 [673.305125] Dynamic subtest ccs0: SUCCESS (1.153s) [673.306299] Subtest fence-wait: SUCCESS (6.416s) [673.405441] [104/156] (350s left) kms_flip (2x-flip-vs-panning) [673.503066] Starting subtest: 2x-flip-vs-panning [673.514706] Subtest 2x-flip-vs-panning: SKIP (0.011s) [673.590271] [105/156] (350s left) kms_big_fb (x-tiled-8bpp-rotate-90) [673.684992] Starting subtest: x-tiled-8bpp-rotate-90 [673.705496] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s) [673.813848] [106/156] (350s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [673.914941] Starting subtest: yf-tiled-32bpp-rotate-90 [673.916847] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [674.027323] [107/156] (350s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [674.119571] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [674.121396] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [674.185174] [108/156] (349s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt) [674.270459] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt [674.272113] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [674.374443] [109/156] (349s left) gem_gpgpu_fill (basic) [674.431337] Starting subtest: basic [674.432107] Starting dynamic subtest: smem [674.442741] Dynamic subtest smem: SUCCESS (0.011s) [674.443677] Subtest basic: SUCCESS (0.012s) [674.589463] [110/156] (349s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [674.679218] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu [674.680881] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [674.801832] [111/156] (349s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [674.891230] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [674.892067] Starting dynamic subtest: pipe-A-eDP-1 [674.914317] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [674.923924] Starting dynamic subtest: pipe-B-eDP-1 [674.944804] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [674.953266] Starting dynamic subtest: pipe-C-eDP-1 [674.973598] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [674.981380] Starting dynamic subtest: pipe-D-eDP-1 [675.001841] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [675.003422] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s) [677.166154] [112/156] (347s left) core_setmaster_vs_auth [677.299755] [113/156] (347s left) kms_frontbuffer_tracking (psr-suspend) [677.399800] Starting subtest: psr-suspend [716.341557] Subtest psr-suspend: SUCCESS (8.883s) [723.451696] [114/156] (307s left) gem_exec_schedule (semaphore-codependency) [723.516232] Starting subtest: semaphore-codependency [723.530063] Subtest semaphore-codependency: SUCCESS (0.014s) [723.888760] [115/156] (307s left) gem_eio (in-flight-internal-1us) [724.129864] Starting subtest: in-flight-internal-1us [725.482861] Subtest in-flight-internal-1us: SUCCESS (1.357s) [725.802471] [116/156] (305s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [725.941370] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [725.943247] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [726.065884] [117/156] (305s left) kms_big_fb (4-tiled-32bpp-rotate-180) [726.187662] Starting subtest: 4-tiled-32bpp-rotate-180 [727.653149] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.469s) [727.804977] [118/156] (303s left) syncobj_timeline (wait-delayed-signal) [727.862522] Starting subtest: wait-delayed-signal [727.966596] Subtest wait-delayed-signal: SUCCESS (0.103s) [728.052272] [119/156] (303s left) gem_mmap_gtt (medium-copy-xy) [728.102406] Subtest medium-copy-XY: SKIP (0.000s) [728.155606] [120/156] (303s left) kms_plane_scaling (planes-downscale-factor-0-75) [728.236457] Starting subtest: planes-downscale-factor-0-75 [728.237515] Starting dynamic subtest: pipe-A [728.257875] Dynamic subtest pipe-A: SKIP (0.019s) [728.267307] Starting dynamic subtest: pipe-B [728.294213] Dynamic subtest pipe-B: SKIP (0.034s) [728.303456] Starting dynamic subtest: pipe-C [728.328135] Dynamic subtest pipe-C: SKIP (0.034s) [728.338723] Starting dynamic subtest: pipe-D [728.363190] Dynamic subtest pipe-D: SKIP (0.034s) [728.365458] Subtest planes-downscale-factor-0-75: SKIP (0.125s) [728.475786] [121/156] (303s left) kms_lease (empty-lease) [728.571269] Starting subtest: empty-lease [728.572142] Starting dynamic subtest: pipe-A-eDP-1 [728.573110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [728.583880] Starting dynamic subtest: pipe-B-eDP-1 [728.584702] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [728.593934] Starting dynamic subtest: pipe-C-eDP-1 [728.594754] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [728.603747] Starting dynamic subtest: pipe-D-eDP-1 [728.604570] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [728.605382] Subtest empty-lease: SUCCESS (0.009s) [728.678681] [122/156] (303s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite) [728.766680] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite [728.768418] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [728.846828] [123/156] (302s left) kms_flip (absolute-wf_vblank-interruptible) [728.939903] Starting subtest: absolute-wf_vblank-interruptible [728.944414] Starting dynamic subtest: A-eDP1 [737.689159] Dynamic subtest A-eDP1: SUCCESS (8.733s) [737.699000] Starting dynamic subtest: B-eDP1 [746.413221] Dynamic subtest B-eDP1: SUCCESS (8.727s) [746.423358] Starting dynamic subtest: C-eDP1 [755.143609] Dynamic subtest C-eDP1: SUCCESS (8.714s) [755.152910] Starting dynamic subtest: D-eDP1 [763.835226] Dynamic subtest D-eDP1: SUCCESS (8.727s) [763.839817] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.915s) [765.049370] [124/156] (266s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [765.153961] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [765.155663] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [765.249392] [125/156] (266s left) gem_caching (writes) [765.297703] Subtest writes: SKIP (0.000s) [765.372003] [126/156] (266s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [765.456287] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu [765.457913] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [765.549470] [127/156] (266s left) syncobj_wait (wait-all-delayed-signal) [765.599609] Starting subtest: wait-all-delayed-signal [765.702458] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [765.777674] [128/156] (266s left) kms_color_pipeline (plane-lut1d) [765.865567] Starting subtest: plane-lut1d [766.036047] Starting dynamic subtest: pipe-A-plane-0 [766.224722] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [766.235525] Starting dynamic subtest: pipe-A-plane-1 [766.419242] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s) [766.429713] Starting dynamic subtest: pipe-A-plane-2 [766.580269] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [767.778984] Starting dynamic subtest: pipe-B-plane-0 [767.947485] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [767.961254] Starting dynamic subtest: pipe-B-plane-1 [768.136591] Dynamic subtest pipe-B-plane-1: SUCCESS (0.187s) [768.146705] Starting dynamic subtest: pipe-B-plane-2 [768.303247] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [769.511911] Starting dynamic subtest: pipe-C-plane-0 [769.658345] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [769.669162] Starting dynamic subtest: pipe-C-plane-1 [769.813542] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [769.823685] Starting dynamic subtest: pipe-C-plane-2 [769.969511] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [771.224544] Starting dynamic subtest: pipe-D-plane-0 [771.370993] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [771.380958] Starting dynamic subtest: pipe-D-plane-1 [771.537260] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s) [771.549110] Starting dynamic subtest: pipe-D-plane-2 [771.703887] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [772.003579] Subtest plane-lut1d: SUCCESS (6.137s) [772.901832] [129/156] (259s left) kms_hdr (invalid-metadata-sizes) [772.989044] Starting subtest: invalid-metadata-sizes [772.991561] Subtest invalid-metadata-sizes: SKIP (0.000s) [773.059047] [130/156] (258s left) kms_cursor_crc (cursor-random-max-size) [773.362176] Starting subtest: cursor-random-max-size [773.364838] Subtest cursor-random-max-size: SKIP (0.000s) [773.488639] [131/156] (258s left) kms_psr (psr-cursor-plane-move) [773.567699] Starting subtest: psr-cursor-plane-move [773.568668] Starting dynamic subtest: eDP-1 [775.296760] Dynamic subtest eDP-1: SUCCESS (1.729s) [775.297754] Subtest psr-cursor-plane-move: SUCCESS (1.730s) [776.160178] [132/156] (255s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [776.261979] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [799.740413] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.487s) [799.875889] [133/156] (232s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [799.974001] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt [799.975884] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [800.068393] [134/156] (232s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render) [800.159678] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render [800.161315] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [800.246677] [135/156] (231s left) i915_pm_rpm (gem-pread) [802.576721] Starting subtest: gem-pread [804.651536] Subtest gem-pread: SUCCESS (2.077s) [804.737392] [136/156] (227s left) kms_atomic (plane-primary-overlay-mutable-zpos) [804.824699] Starting subtest: plane-primary-overlay-mutable-zpos [808.246522] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.422s) [809.428549] [137/156] (222s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [809.526142] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [809.528355] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [809.622720] [138/156] (222s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [809.708148] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [809.710103] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [809.804766] [139/156] (222s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [809.896755] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [809.898584] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [809.989680] [140/156] (222s left) prime_self_import (basic-llseek-size) [810.016566] Starting subtest: basic-llseek-size [810.039212] Subtest basic-llseek-size: SUCCESS (0.023s) [810.145519] [141/156] (222s left) perf_pmu (busy) [810.182438] Starting subtest: busy [810.183238] Starting dynamic subtest: rcs0 [810.771871] Dynamic subtest rcs0: SUCCESS (0.590s) [810.785109] Starting dynamic subtest: bcs0 [811.331576] Dynamic subtest bcs0: SUCCESS (0.557s) [811.348143] Starting dynamic subtest: vcs0 [813.393512] Dynamic subtest vcs0: SUCCESS (2.049s) [813.405463] Starting dynamic subtest: vcs1 [815.378022] Dynamic subtest vcs1: SUCCESS (1.981s) [815.388838] Starting dynamic subtest: vecs0 [817.361501] Dynamic subtest vecs0: SUCCESS (1.980s) [817.373903] Starting dynamic subtest: ccs0 [817.920510] Dynamic subtest ccs0: SUCCESS (0.565s) [817.924268] Subtest busy: SUCCESS (7.740s) [818.010105] [142/156] (214s left) kms_plane_lowres (tiling-y) [818.102147] Starting subtest: tiling-y [818.104513] Subtest tiling-y: SKIP (0.000s) [818.172596] [143/156] (214s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [818.273573] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [818.274434] Starting dynamic subtest: pipe-A-eDP-1 [852.046114] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.694s) [852.059486] Starting dynamic subtest: pipe-B-eDP-1 [886.965564] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.477s) [886.976895] Starting dynamic subtest: pipe-C-eDP-1 [921.934410] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.415s) [921.945832] Starting dynamic subtest: pipe-D-eDP-1 [956.936033] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.470s) [956.937148] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.061s) [964.135027] [144/156] ( 74s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [964.242358] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [964.244106] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [964.315907] [145/156] ( 74s left) gem_ctx_shared (create-shared-gtt) [964.367734] Starting subtest: create-shared-gtt [966.524808] Subtest create-shared-gtt: SUCCESS (2.151s) [966.834141] [146/156] ( 71s left) kms_psr (pr-suspend) [966.929627] Starting subtest: pr-suspend [966.931471] Subtest pr-suspend: SKIP (0.000s) [967.000784] [147/156] ( 71s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [967.046852] Starting subtest: yf-tiled-to-vebox-yf-tiled [967.049172] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [967.227253] [148/156] ( 71s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [967.314583] Starting subtest: plane-upscale-20x20-with-rotation [967.315456] Starting dynamic subtest: pipe-A [967.540172] Dynamic subtest pipe-A: SUCCESS (0.226s) [967.549975] Starting dynamic subtest: pipe-B [968.876658] Dynamic subtest pipe-B: SUCCESS (1.338s) [968.886837] Starting dynamic subtest: pipe-C [970.218851] Dynamic subtest pipe-C: SUCCESS (1.344s) [970.230157] Starting dynamic subtest: pipe-D [971.554373] Dynamic subtest pipe-D: SUCCESS (1.336s) [971.555365] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.248s) [972.724124] [149/156] ( 65s left) kms_psr (fbc-psr-suspend) [972.811603] Starting subtest: fbc-psr-suspend [972.812600] Starting dynamic subtest: eDP-1 [972.814241] Dynamic subtest eDP-1: SKIP (0.000s) [972.816105] Subtest fbc-psr-suspend: SKIP (0.001s) [972.886244] [150/156] ( 65s left) i915_query (query-garbage) [972.933381] Starting subtest: query-garbage [972.934406] Subtest query-garbage: SUCCESS (0.000s) [973.036175] [151/156] ( 65s left) kms_pm_rpm (dpms-lpsp) [975.164867] Starting subtest: dpms-lpsp [975.487922] Subtest dpms-lpsp: SUCCESS (0.326s) [975.618823] [152/156] ( 63s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [975.706236] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [975.708068] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [975.799532] [153/156] ( 63s left) perf (sysctl-defaults) [975.859358] Starting subtest: sysctl-defaults [975.860454] Subtest sysctl-defaults: SUCCESS (0.000s) [975.915827] [154/156] ( 62s left) kms_chamelium_frames (hdmi-aspect-ratio) [976.295063] Subtest hdmi-aspect-ratio: SKIP (0.000s) [977.138614] [155/156] ( 61s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [977.229571] Starting subtest: basic-max-pipe-crc-check [977.231429] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [977.273493] [156/156] ( 61s left) api_intel_allocator (fork-simple-once) [977.327804] Starting subtest: fork-simple-once [977.343277] Subtest fork-simple-once: SUCCESS (0.017s) [977.461839] Closing watchdogs results: parsing output: 0/ for test: gem_flink_race results: parsing output: 1/ for test: gem_exec_async results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_lmem_swapping results: parsing output: 4/ for test: gem_exec_reloc results: parsing output: 5/ for test: gem_ccs results: parsing output: 6/ for test: kms_feature_discovery results: parsing output: 7/ for test: gem_exec_whisper results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: gem_exec_fence results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_exec_schedule results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: gem_exec_fence results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_psr2_sf results: parsing output: 21/ for test: gem_exec_params results: parsing output: 22/ for test: gem_flink_basic results: parsing output: 23/ for test: kms_cursor_crc results: parsing output: 24/ for test: gem_render_copy_redux results: parsing output: 25/ for test: syncobj_wait results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: i915_drm_fdinfo results: parsing output: 28/ for test: drm_buddy results: parsing output: 29/ for test: gem_ctx_param results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_async_flips results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: gem_exec_suspend results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: api_intel_bb results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_sync results: parsing output: 41/ for test: kms_vblank results: parsing output: 42/ for test: kms_vblank results: parsing output: 43/ for test: kms_addfb_basic results: parsing output: 44/ for test: gem_mmap_gtt results: parsing output: 45/ for test: gem_tiled_swapping results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: perf results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_chamelium_hpd results: parsing output: 51/ for test: kms_plane_cursor results: parsing output: 52/ for test: sysfs_timeslice_duration results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: perf_pmu results: parsing output: 55/ for test: gen9_exec_parse results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_mmap_wc results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_gtt_cpu_tlb results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: gem_watchdog results: parsing output: 64/ for test: kms_rotation_crc results: parsing output: 65/ for test: kms_cursor_legacy results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_create 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_big_fb results: parsing output: 71/ for test: kms_ccs results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_exec_balancer results: parsing output: 75/ for test: i915_query results: parsing output: 76/ for test: gem_mmap_offset results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_chamelium_audio results: parsing output: 82/ for test: i915_hangman results: parsing output: 83/ for test: tools_test results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_spin_batch results: parsing output: 86/ for test: kms_vblank results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_plane results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: kms_psr2_sf results: parsing output: 91/ for test: kms_flip results: parsing output: 92/ for test: gem_exec_create results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_cursor_edge_walk results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_content_protection results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_pm_rpm results: parsing output: 99/ for test: gem_pxp results: parsing output: 100/ for test: kms_debugfs results: parsing output: 101/ for test: syncobj_timeline results: parsing output: 102/ for test: prime_vgem results: parsing output: 103/ for test: kms_flip results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_flip_scaled_crc results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_gpgpu_fill results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: core_setmaster_vs_auth results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_exec_schedule results: parsing output: 114/ for test: gem_eio results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: gem_mmap_gtt results: parsing output: 119/ for test: kms_plane_scaling results: parsing output: 120/ for test: kms_lease results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_flip results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_caching results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: kms_color_pipeline results: parsing output: 128/ for test: kms_hdr results: parsing output: 129/ for test: kms_cursor_crc results: parsing output: 130/ for test: kms_psr results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: i915_pm_rpm results: parsing output: 135/ for test: kms_atomic results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: prime_self_import results: parsing output: 140/ for test: perf_pmu results: parsing output: 141/ for test: kms_plane_lowres results: parsing output: 142/ for test: kms_ccs results: parsing output: 143/ for test: kms_flip_scaled_crc results: parsing output: 144/ for test: gem_ctx_shared results: parsing output: 145/ for test: kms_psr results: parsing output: 146/ for test: gem_render_copy results: parsing output: 147/ for test: kms_plane_scaling results: parsing output: 148/ for test: kms_psr results: parsing output: 149/ for test: i915_query results: parsing output: 150/ for test: kms_pm_rpm results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: perf results: parsing output: 153/ for test: kms_chamelium_frames results: parsing output: 154/ for test: kms_multipipe_modeset results: parsing output: 155/ for test: api_intel_allocator Done.