[149.631430] Initializing watchdogs [149.631478] /dev/watchdog0 [149.646807] [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] [149.651172] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [149.653792] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [149.657362] [001/132] (960s left) gem_mmap_gtt (hang-user) [149.731023] Subtest hang-user: SKIP (0.000s) [149.782347] [002/132] (960s left) gem_exec_whisper (basic-queues-priority-all) [149.844556] Starting subtest: basic-queues-priority-all [173.529735] Subtest basic-queues-priority-all: SUCCESS (23.678s) [173.711370] [003/132] (936s left) i915_drm_fdinfo (virtual-busy) [173.752799] Starting subtest: virtual-busy [173.758727] Subtest virtual-busy: SKIP (0.000s) [173.809885] [004/132] (936s left) syncobj_timeline (invalid-signal-illegal-point) [173.865678] Starting subtest: invalid-signal-illegal-point [173.868092] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [173.967548] [005/132] (936s left) gem_madvise (dontneed-after-mmap) [174.008064] Starting subtest: dontneed-after-mmap [174.032594] Subtest dontneed-after-mmap: SUCCESS (0.023s) [174.145214] [006/132] (936s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [174.248300] Starting subtest: psr-rgb101010-draw-pwrite [182.037747] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.792s) [182.174417] [007/132] (928s left) gem_exec_balancer (invalid-balancer) [182.240033] Starting subtest: invalid-balancer [183.166273] Subtest invalid-balancer: SUCCESS (0.924s) [183.454939] [008/132] (926s left) kms_content_protection (legacy) [183.596544] Starting subtest: legacy [183.601323] Subtest legacy: SKIP (0.000s) [183.712308] [009/132] (926s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [183.804973] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [187.558188] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.759s) [188.726889] [010/132] (921s left) gem_exec_await (wide-contexts) [188.952989] Starting subtest: wide-contexts [212.185722] Subtest wide-contexts: SUCCESS (23.234s) [212.385349] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true [212.389605] [011/132] (898s left) gem_exec_schedule (pi-shared-iova) [212.622253] Starting subtest: pi-shared-iova [212.624594] Starting dynamic subtest: rcs0 [212.775361] Dynamic subtest rcs0: SUCCESS (0.154s) [212.788534] Starting dynamic subtest: vcs0 [212.855061] Dynamic subtest vcs0: SUCCESS (0.080s) [212.865701] Starting dynamic subtest: vcs1 [212.938555] Dynamic subtest vcs1: SUCCESS (0.082s) [212.948555] Starting dynamic subtest: vecs0 [213.027130] Dynamic subtest vecs0: SUCCESS (0.088s) [213.039036] Starting dynamic subtest: ccs0 [213.151351] Dynamic subtest ccs0: SUCCESS (0.122s) [213.154059] Subtest pi-shared-iova: SUCCESS (0.530s) [214.410077] [012/132] (896s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [214.512188] Starting subtest: plane-upscale-20x20-with-modifiers [214.514497] Starting dynamic subtest: pipe-A [214.849429] Dynamic subtest pipe-A: SUCCESS (0.338s) [214.858610] Starting dynamic subtest: pipe-B [216.307262] Dynamic subtest pipe-B: SUCCESS (1.457s) [216.318098] Starting dynamic subtest: pipe-C [217.744427] Dynamic subtest pipe-C: SUCCESS (1.436s) [217.755148] Starting dynamic subtest: pipe-D [219.166346] Dynamic subtest pipe-D: SUCCESS (1.422s) [219.168614] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.656s) [220.335388] [013/132] (890s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [220.447167] Starting subtest: psr2-primary-plane-update-sf-dmg-area [220.449568] Starting dynamic subtest: pipe-A-eDP-1 [226.327575] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.885s) [226.337852] Starting dynamic subtest: pipe-B-eDP-1 [232.978401] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.651s) [232.980668] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.538s) [233.875679] [014/132] (876s left) gem_busy (semaphore) [234.061743] Subtest semaphore: SKIP (0.000s) [234.295497] [015/132] (876s left) perf (buffer-fill) [234.434056] Starting subtest: buffer-fill [234.436270] Starting dynamic subtest: 0-rcs0 [236.706442] Dynamic subtest 0-rcs0: SUCCESS (2.271s) [236.717300] Starting dynamic subtest: 1-vcs0 [241.151076] Dynamic subtest 1-vcs0: SUCCESS (4.443s) [241.153910] Subtest buffer-fill: SUCCESS (6.716s) [241.201411] [016/132] (869s left) syncobj_timeline (reset-during-wait-for-submit) [241.253720] Starting subtest: reset-during-wait-for-submit [241.359409] Subtest reset-during-wait-for-submit: SUCCESS (0.104s) [241.451962] [017/132] (869s left) gem_mmap_gtt (basic-read-write) [241.501348] Subtest basic-read-write: SKIP (0.000s) [241.557745] [018/132] (869s left) gem_workarounds (reset-context) [241.630842] Starting subtest: reset-context [241.842287] Subtest reset-context: SUCCESS (0.212s) [241.985743] [019/132] (868s left) kms_plane_multiple (2x-tiling-none) [242.081856] Starting subtest: 2x-tiling-none [242.086054] Subtest 2x-tiling-none: SKIP (0.000s) [242.170645] [020/132] (868s left) core_getstats (basic) [242.219956] Starting subtest: basic [242.222283] Subtest basic: SUCCESS (0.000s) [242.327241] [021/132] (868s left) gem_flink_basic (flink-lifetime) [242.376518] Starting subtest: flink-lifetime [242.378600] Subtest flink-lifetime: SUCCESS (0.002s) [242.491589] [022/132] (868s left) kms_big_fb (4-tiled-8bpp-rotate-0) [242.586682] Starting subtest: 4-tiled-8bpp-rotate-0 [243.844384] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.258s) [243.980893] [023/132] (867s left) perf_pmu (most-busy-check-all) [244.018363] Starting subtest: most-busy-check-all [244.020674] Starting dynamic subtest: rcs0 [245.344444] Dynamic subtest rcs0: SUCCESS (1.324s) [245.357803] Starting dynamic subtest: bcs0 [247.328429] Dynamic subtest bcs0: SUCCESS (1.982s) [247.340072] Starting dynamic subtest: vcs0 [249.312223] Dynamic subtest vcs0: SUCCESS (1.982s) [249.325523] Starting dynamic subtest: vcs1 [251.295884] Dynamic subtest vcs1: SUCCESS (1.982s) [251.308649] Starting dynamic subtest: vecs0 [253.344888] Dynamic subtest vecs0: SUCCESS (2.046s) [253.355637] Starting dynamic subtest: ccs0 [255.328500] Dynamic subtest ccs0: SUCCESS (1.983s) [255.331134] Subtest most-busy-check-all: SUCCESS (11.309s) [255.447947] [024/132] (855s left) kms_rotation_crc (primary-rotation-90) [255.548919] Starting subtest: primary-rotation-90 [255.553453] Subtest primary-rotation-90: SKIP (0.001s) [255.624949] [025/132] (855s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [255.735459] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [256.868678] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.134s) [257.003268] [026/132] (854s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [257.092278] Starting subtest: modeset-transition-nonblocking-fencing [257.093861] Starting dynamic subtest: 1x-outputs [267.927783] Dynamic subtest 1x-outputs: SUCCESS (10.836s) [267.930505] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.837s) [268.793201] [027/132] (842s left) gem_ctx_shared (detached-shared-gtt) [268.856455] Starting subtest: detached-shared-gtt [271.006567] Subtest detached-shared-gtt: SUCCESS (2.150s) [271.326857] [028/132] (839s left) kms_psr (pr-basic) [271.417815] Starting subtest: pr-basic [271.422074] Subtest pr-basic: SKIP (0.000s) [271.490256] [029/132] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [271.574286] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [271.578259] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [271.693762] [030/132] (839s left) kms_pm_rpm (basic-pci-d3-state) [273.424178] Starting subtest: basic-pci-d3-state [274.924687] Subtest basic-pci-d3-state: SUCCESS (1.500s) [275.016285] [031/132] (836s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [275.133850] Starting subtest: cursorA-vs-flipB-atomic-transitions [275.138331] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [275.289963] [032/132] (836s left) gem_ctx_engines (execute-oneforall) [275.342527] Starting subtest: execute-oneforall [275.990879] Subtest execute-oneforall: SUCCESS (0.646s) [277.455130] [033/132] (834s left) gem_mmap_gtt (medium-copy-odd) [277.509586] Subtest medium-copy-odd: SKIP (0.000s) [277.579229] [034/132] (833s left) kms_cursor_crc (cursor-rapid-movement-128x42) [277.819814] Starting subtest: cursor-rapid-movement-128x42 [277.873387] Subtest cursor-rapid-movement-128x42: SKIP (0.048s) [278.078078] [035/132] (833s left) kms_vblank (ts-continuation-dpms-rpm) [278.169554] Starting subtest: ts-continuation-dpms-rpm [278.171745] Starting dynamic subtest: pipe-A-eDP-1 [280.676797] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s) [280.692179] Starting dynamic subtest: pipe-D-eDP-1 [282.922221] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.243s) [282.924567] Subtest ts-continuation-dpms-rpm: SUCCESS (4.752s) [283.800875] [036/132] (827s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [283.920014] Starting subtest: cursorB-vs-flipA-atomic-transitions [283.924576] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s) [284.063268] [037/132] (827s left) gem_exec_fence (syncobj-timeline-repeat) [284.604707] Starting subtest: syncobj-timeline-repeat [284.840951] Subtest syncobj-timeline-repeat: SUCCESS (0.239s) [286.398069] [038/132] (825s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [286.453385] Starting subtest: x-tiled-to-vebox-y-tiled [286.459148] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [286.643725] [039/132] (825s left) kms_atomic_transition (plane-all-transition-nonblocking) [286.750292] Starting subtest: plane-all-transition-nonblocking [286.753059] Starting dynamic subtest: pipe-A-eDP-1 [289.243503] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [289.553889] Starting dynamic subtest: pipe-B-eDP-1 [292.750590] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.207s) [293.051697] Subtest plane-all-transition-nonblocking: SUCCESS (6.302s) [293.896356] [040/132] (817s left) kms_lease (lease-unleased-connector) [293.993010] Starting subtest: lease-unleased-connector [293.995289] Starting dynamic subtest: pipe-A-eDP-1 [293.999917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s) [294.011738] Starting dynamic subtest: pipe-B-eDP-1 [294.013927] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [294.024317] Starting dynamic subtest: pipe-C-eDP-1 [294.026750] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s) [294.036306] Starting dynamic subtest: pipe-D-eDP-1 [294.038460] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [294.040590] Subtest lease-unleased-connector: SUCCESS (0.034s) [294.142456] [041/132] (817s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [294.245712] Starting subtest: fbc-rgb101010-draw-pwrite [299.688226] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.445s) [300.900901] [042/132] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [301.004521] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [301.008709] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [301.106921] [043/132] (810s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [301.204188] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [301.208510] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [301.328868] [044/132] (810s left) kms_psr (psr2-primary-page-flip) [301.427751] Starting subtest: psr2-primary-page-flip [301.430033] Starting dynamic subtest: eDP-1 [303.181375] Dynamic subtest eDP-1: SUCCESS (1.750s) [303.183318] Subtest psr2-primary-page-flip: SUCCESS (1.751s) [304.053585] [045/132] (807s left) gem_pxp (display-protected-crc) [304.172852] Starting subtest: display-protected-crc [306.021038] Subtest display-protected-crc: SUCCESS (1.850s) [306.142347] [046/132] (805s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [306.262473] Starting subtest: cursorB-vs-flipA-atomic [306.267075] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [306.411871] [047/132] (805s left) syncobj_wait (wait-for-submit-snapshot) [306.461404] Starting subtest: wait-for-submit-snapshot [306.542859] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [306.618955] [048/132] (805s left) gen9_exec_parse (cmd-crossing-page) [306.680760] Subtest cmd-crossing-page: SKIP (0.000s) [306.763854] [049/132] (805s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [306.861988] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [310.758876] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.898s) [311.973067] [050/132] (800s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [312.099607] Starting subtest: cursorB-vs-flipA-toggle [312.103955] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s) [312.258324] [051/132] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [312.349699] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [319.408198] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.062s) [319.536725] [052/132] (792s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [319.634067] Starting subtest: plane-downscale-factor-0-75-with-rotation [319.636316] Starting dynamic subtest: pipe-A [319.863158] Dynamic subtest pipe-A: SUCCESS (0.231s) [319.875782] Starting dynamic subtest: pipe-B [321.177110] Dynamic subtest pipe-B: SUCCESS (1.313s) [321.192462] Starting dynamic subtest: pipe-C [322.503299] Dynamic subtest pipe-C: SUCCESS (1.325s) [322.513967] Starting dynamic subtest: pipe-D [323.829920] Dynamic subtest pipe-D: SUCCESS (1.326s) [323.832375] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.198s) [325.017590] [053/132] (787s left) prime_busy (after-wait) [325.077588] Starting subtest: after-wait [325.079986] Starting dynamic subtest: rcs0 [325.127221] Dynamic subtest rcs0: SUCCESS (0.050s) [325.137968] Starting dynamic subtest: bcs0 [325.169811] Dynamic subtest bcs0: SUCCESS (0.042s) [325.180587] Starting dynamic subtest: vcs0 [325.211854] Dynamic subtest vcs0: SUCCESS (0.041s) [325.222330] Starting dynamic subtest: vcs1 [325.252580] Dynamic subtest vcs1: SUCCESS (0.039s) [325.262961] Starting dynamic subtest: vecs0 [325.294056] Dynamic subtest vecs0: SUCCESS (0.041s) [325.304360] Starting dynamic subtest: ccs0 [325.335663] Dynamic subtest ccs0: SUCCESS (0.041s) [325.444482] Subtest after-wait: SUCCESS (0.368s) [325.537462] [054/132] (786s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [325.634166] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [325.638429] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [325.741978] [055/132] (786s left) gem_exec_schedule (promotion) [325.804419] Starting subtest: promotion [325.806669] Starting dynamic subtest: rcs0 [325.903795] Dynamic subtest rcs0: SUCCESS (0.106s) [325.914226] Starting dynamic subtest: vcs0 [325.997055] Dynamic subtest vcs0: SUCCESS (0.093s) [326.008365] Starting dynamic subtest: vcs1 [326.081990] Dynamic subtest vcs1: SUCCESS (0.084s) [326.093074] Starting dynamic subtest: vecs0 [326.163573] Dynamic subtest vecs0: SUCCESS (0.081s) [326.173717] Starting dynamic subtest: ccs0 [326.269386] Dynamic subtest ccs0: SUCCESS (0.105s) [326.271801] Subtest promotion: SUCCESS (0.473s) [327.448883] [056/132] (785s left) perf (unprivileged-single-ctx-counters) [327.545890] Starting subtest: unprivileged-single-ctx-counters [327.550633] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [327.590429] [057/132] (784s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [327.646238] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [327.746647] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s) [327.827788] [058/132] (784s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [327.915184] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [327.919149] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [327.983198] [059/132] (784s left) api_intel_bb (add-remove-objects) [328.049832] Starting subtest: add-remove-objects [328.057859] Subtest add-remove-objects: SUCCESS (0.008s) [328.184589] [060/132] (784s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [328.286677] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [328.291154] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [328.387542] [061/132] (784s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping) [328.469338] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping [328.473788] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s) [328.543339] [062/132] (784s left) gem_readwrite (beyond-eob) [328.606215] Subtest beyond-EOB: SKIP (0.000s) [328.668167] [063/132] (784s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [328.761461] Starting subtest: primary-y-tiled-reflect-x-90 [328.765240] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [328.847940] [064/132] (784s left) kms_psr (fbc-psr2-sprite-plane-onoff) [328.935540] Starting subtest: fbc-psr2-sprite-plane-onoff [328.937542] Starting dynamic subtest: eDP-1 [328.941194] Dynamic subtest eDP-1: SKIP (0.000s) [328.944809] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [329.010775] [065/132] (783s left) gem_eio (in-flight-contexts-1us) [329.245290] Starting subtest: in-flight-contexts-1us [343.337645] Subtest in-flight-contexts-1us: SUCCESS (14.092s) [343.517582] [066/132] (769s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [343.607543] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [350.704096] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.099s) [350.817786] [067/132] (762s left) kms_chamelium_frames (hdmi-frame-dump) [351.193713] Subtest hdmi-frame-dump: SKIP (0.000s) [352.058434] [068/132] (760s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [352.169592] Starting subtest: 2x-long-cursor-vs-flip-atomic [352.173995] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [352.332283] [069/132] (760s left) kms_properties (connector-properties-atomic) [352.425930] Starting subtest: connector-properties-atomic [352.427866] Starting dynamic subtest: pipe-A-eDP-1 [360.391755] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.963s) [360.405026] Starting dynamic subtest: pipe-None-DP-1 [360.409638] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [360.419498] Starting dynamic subtest: pipe-None-HDMI-A-1 [360.424213] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [360.434161] Starting dynamic subtest: pipe-None-DP-2 [360.438723] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [360.448809] Starting dynamic subtest: pipe-None-HDMI-A-2 [360.453413] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [360.463472] Starting dynamic subtest: pipe-None-DP-3 [360.468147] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [360.478128] Starting dynamic subtest: pipe-None-DP-4 [360.482257] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [360.484162] Subtest connector-properties-atomic: SUCCESS (7.976s) [361.278993] [070/132] (751s left) kms_pipe_crc_basic (nonblocking-crc) [361.381366] Starting subtest: nonblocking-crc [361.383724] Starting dynamic subtest: pipe-A-eDP-1 [362.160723] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.780s) [362.172048] Starting dynamic subtest: pipe-B-eDP-1 [363.570747] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s) [363.581926] Starting dynamic subtest: pipe-C-eDP-1 [364.951964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s) [364.963300] Starting dynamic subtest: pipe-D-eDP-1 [366.303672] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.348s) [366.305577] Subtest nonblocking-crc: SUCCESS (4.923s) [367.101272] [071/132] (746s left) i915_query (hwconfig_table) [367.151447] Starting subtest: hwconfig_table [367.453287] Subtest hwconfig_table: SUCCESS (0.002s) [367.497688] [072/132] (745s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [367.607771] Starting subtest: short-flip-before-cursor-toggle [368.532781] Subtest short-flip-before-cursor-toggle: SUCCESS (0.924s) [369.344836] [073/132] (743s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [369.405279] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [369.409393] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [369.588760] [074/132] (743s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [369.681743] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [369.684538] Starting dynamic subtest: pipe-A-eDP-1 [369.711852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [369.724834] Starting dynamic subtest: pipe-B-eDP-1 [369.745106] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [369.755233] Starting dynamic subtest: pipe-C-eDP-1 [369.774077] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [369.783767] Starting dynamic subtest: pipe-D-eDP-1 [369.802690] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [369.804891] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [372.006930] [075/132] (741s left) gem_exec_store (dword) [372.066339] Starting subtest: dword [372.068229] Starting dynamic subtest: rcs0 [372.148027] Dynamic subtest rcs0: SUCCESS (0.083s) [372.161219] Starting dynamic subtest: bcs0 [372.189733] Dynamic subtest bcs0: SUCCESS (0.040s) [372.200956] Starting dynamic subtest: vcs0 [372.232390] Dynamic subtest vcs0: SUCCESS (0.040s) [372.243783] Starting dynamic subtest: vcs1 [372.275358] Dynamic subtest vcs1: SUCCESS (0.041s) [372.286616] Starting dynamic subtest: vecs0 [372.317356] Dynamic subtest vecs0: SUCCESS (0.040s) [372.328680] Starting dynamic subtest: ccs0 [372.359622] Dynamic subtest ccs0: SUCCESS (0.040s) [372.362040] Subtest dword: SUCCESS (0.297s) [372.544141] [076/132] (740s left) kms_addfb_basic (unused-handle) [372.587851] Starting subtest: unused-handle [372.590120] Subtest unused-handle: SUCCESS (0.000s) [372.752991] [077/132] (740s left) perf (invalid-create-userspace-config) [372.862658] Starting subtest: invalid-create-userspace-config [372.865111] Subtest invalid-create-userspace-config: SUCCESS (0.002s) [372.909651] [078/132] (740s left) perf (oa-exponents) [372.994840] Starting subtest: oa-exponents [372.997461] Starting dynamic subtest: 0-rcs0 [374.768442] Dynamic subtest 0-rcs0: SUCCESS (1.772s) [374.779608] Starting dynamic subtest: 1-vcs0 [376.599379] Dynamic subtest 1-vcs0: SUCCESS (1.829s) [376.601817] Subtest oa-exponents: SUCCESS (3.603s) [376.649395] [079/132] (736s left) gem_close_race (basic-process) [376.704613] Starting subtest: basic-process [376.756457] Subtest basic-process: SUCCESS (0.051s) [376.942471] [080/132] (736s left) vgem_basic (bad-flag) [376.984484] Starting subtest: bad-flag [376.986618] Subtest bad-flag: SUCCESS (0.000s) [377.041679] [081/132] (736s left) perf_pmu (rc6) [377.082153] Starting subtest: rc6 [377.084277] Starting dynamic subtest: gt0 [383.446446] Dynamic subtest gt0: SUCCESS (6.363s) [383.459621] Starting dynamic subtest: runtime-pm-gt0 [391.161077] Dynamic subtest runtime-pm-gt0: SUCCESS (7.712s) [391.171946] Starting dynamic subtest: runtime-pm-long-gt0 [403.658330] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.495s) [403.670782] Starting dynamic subtest: other-idle-gt0 [410.002558] Dynamic subtest other-idle-gt0: SUCCESS (6.341s) [410.014094] Starting dynamic subtest: gt1 [416.344916] Dynamic subtest gt1: SUCCESS (6.339s) [416.359327] Starting dynamic subtest: runtime-pm-gt1 [423.843683] Dynamic subtest runtime-pm-gt1: SUCCESS (7.496s) [423.856639] Starting dynamic subtest: runtime-pm-long-gt1 [436.269552] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.423s) [436.280620] Starting dynamic subtest: other-idle-gt1 [442.613238] Dynamic subtest other-idle-gt1: SUCCESS (6.341s) [442.615898] Subtest rc6: SUCCESS (65.531s) [443.744708] [082/132] (669s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [443.845549] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [443.849545] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [443.893561] [083/132] (669s left) gem_ctx_persistence (engines-queued) [443.939102] Starting subtest: engines-queued [443.940986] Starting dynamic subtest: rcs0 [444.010261] Dynamic subtest rcs0: SUCCESS (0.071s) [444.020851] Starting dynamic subtest: bcs0 [444.034915] Dynamic subtest bcs0: SUCCESS (0.023s) [444.044746] Starting dynamic subtest: vcs0 [445.311166] Dynamic subtest vcs0: SUCCESS (1.273s) [445.323168] Starting dynamic subtest: vcs1 [447.293252] Dynamic subtest vcs1: SUCCESS (1.979s) [447.307366] Starting dynamic subtest: vecs0 [449.277444] Dynamic subtest vecs0: SUCCESS (1.981s) [449.290040] Starting dynamic subtest: ccs0 [449.449287] Dynamic subtest ccs0: SUCCESS (0.171s) [449.451691] Subtest engines-queued: SUCCESS (5.511s) [449.543315] [084/132] (664s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [449.634113] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [449.636346] Starting dynamic subtest: pipe-A-eDP-1 [451.908323] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.274s) [451.918790] Starting dynamic subtest: pipe-B-eDP-1 [454.418026] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.508s) [454.428563] Starting dynamic subtest: pipe-C-eDP-1 [456.621449] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.203s) [456.632502] Starting dynamic subtest: pipe-D-eDP-1 [458.825270] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.203s) [458.827260] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.194s) [459.980854] [085/132] (653s left) kms_rotation_crc (exhaust-fences) [460.078758] Starting subtest: exhaust-fences [460.083209] Subtest exhaust-fences: SKIP (0.000s) [460.129155] [086/132] (653s left) syncobj_timeline (32bits-limit) [460.186660] Starting subtest: 32bits-limit [460.189112] Subtest 32bits-limit: SUCCESS (0.001s) [460.270693] [087/132] (653s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [460.372717] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [460.385608] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s) [460.441791] [088/132] (653s left) kms_psr (fbc-pr-primary-render) [460.540989] Starting subtest: fbc-pr-primary-render [460.545493] Subtest fbc-pr-primary-render: SKIP (0.000s) [460.595421] [089/132] (653s left) kms_chamelium_hpd (common-hpd-after-suspend) [460.978035] Subtest common-hpd-after-suspend: SKIP (0.000s) [461.802093] [090/132] (652s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [461.908515] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [468.677609] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.772s) [468.771315] [091/132] (645s left) gem_softpin (allocator-nopin) [468.833181] Starting subtest: allocator-nopin [468.920089] Subtest allocator-nopin: SUCCESS (0.089s) [469.037072] [092/132] (645s left) kms_big_fb (linear-32bpp-rotate-90) [469.133453] Starting subtest: linear-32bpp-rotate-90 [469.152923] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [469.248667] [093/132] (644s left) kms_busy (basic) [469.342599] Starting subtest: basic [469.344840] Starting dynamic subtest: flip [469.945191] Dynamic subtest flip: SUCCESS (0.602s) [469.961036] Starting dynamic subtest: modeset [473.382379] Dynamic subtest modeset: SUCCESS (3.437s) [473.384797] Subtest basic: SUCCESS (4.042s) [474.172415] [094/132] (640s left) i915_pm_rpm (system-suspend-execbuf) [476.506532] Starting subtest: system-suspend-execbuf [534.614897] Subtest system-suspend-execbuf: SUCCESS (42.949s) [534.994206] [095/132] (579s left) kms_flip (flip-vs-panning) [535.092525] Starting subtest: flip-vs-panning [535.094705] Starting dynamic subtest: A-eDP1 [543.802857] Dynamic subtest A-eDP1: SUCCESS (8.710s) [543.815619] Starting dynamic subtest: B-eDP1 [552.539240] Dynamic subtest B-eDP1: SUCCESS (8.733s) [552.551678] Starting dynamic subtest: C-eDP1 [561.274116] Dynamic subtest C-eDP1: SUCCESS (8.731s) [561.289099] Starting dynamic subtest: D-eDP1 [570.005939] Dynamic subtest D-eDP1: SUCCESS (8.728s) [570.010175] Subtest flip-vs-panning: SUCCESS (34.913s) [571.150344] [096/132] (543s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [571.250543] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [571.252774] Starting dynamic subtest: pipe-A-eDP-1 [572.177164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s) [572.189549] Starting dynamic subtest: pipe-B-eDP-1 [573.819396] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.638s) [573.832054] Starting dynamic subtest: pipe-C-eDP-1 [575.312298] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.493s) [575.323632] Starting dynamic subtest: pipe-D-eDP-1 [576.882267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.568s) [576.884138] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.624s) [578.078970] [097/132] (536s left) gen7_exec_parse (basic-allocation) [578.134685] Subtest basic-allocation: SKIP (0.000s) [578.211080] [098/132] (536s left) kms_addfb_basic (bo-too-small) [578.296478] Starting subtest: bo-too-small [578.298736] Subtest bo-too-small: SUCCESS (0.000s) [578.376225] [099/132] (536s left) dmabuf_sync_file (import-basic) [578.423915] Starting subtest: import-basic [578.426178] Subtest import-basic: SUCCESS (0.002s) [578.466575] [100/132] (535s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [578.557089] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [582.665104] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.110s) [583.794267] [101/132] (530s left) kms_frontbuffer_tracking (fbc-tiling-4) [583.887460] Starting subtest: fbc-tiling-4 [588.097553] Subtest fbc-tiling-4: SUCCESS (4.212s) [589.279979] [102/132] (525s left) kms_debugfs (display-off-read-all) [589.366569] Starting subtest: display-off-read-all [589.655570] Subtest display-off-read-all: SUCCESS (0.290s) [590.505791] [103/132] (524s left) i915_hangman (engine-engine-hang) [590.574478] Starting subtest: engine-engine-hang [590.576687] Starting dynamic subtest: rcs0 [592.420157] Dynamic subtest rcs0: SUCCESS (1.845s) [592.441572] Starting dynamic subtest: bcs0 [594.466952] Dynamic subtest bcs0: SUCCESS (2.045s) [594.481551] Starting dynamic subtest: vcs0 [596.451209] Dynamic subtest vcs0: SUCCESS (1.982s) [596.465220] Starting dynamic subtest: vcs1 [598.435864] Dynamic subtest vcs1: SUCCESS (1.983s) [598.449682] Starting dynamic subtest: vecs0 [600.419102] Dynamic subtest vecs0: SUCCESS (1.981s) [600.436047] Starting dynamic subtest: ccs0 [602.403458] Dynamic subtest ccs0: SUCCESS (1.982s) [602.406329] Subtest engine-engine-hang: SUCCESS (11.833s) [602.513194] [104/132] (512s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [602.619879] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [602.624453] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [602.683178] [105/132] (511s left) perf (non-zero-reason) [602.741357] Starting subtest: non-zero-reason [602.743709] Starting dynamic subtest: 0-rcs0 [608.154840] Dynamic subtest 0-rcs0: SUCCESS (5.416s) [608.168025] Starting dynamic subtest: 1-vecs0 [612.084733] Dynamic subtest 1-vecs0: SUCCESS (3.928s) [612.087193] Subtest non-zero-reason: SUCCESS (9.347s) [612.139063] [106/132] (502s left) gem_fenced_exec_thrash (no-spare-fences-busy) [612.203898] Subtest no-spare-fences-busy: SKIP (0.000s) [612.294588] [107/132] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [612.387197] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [612.391400] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [612.462956] [108/132] (502s left) kms_rotation_crc (multiplane-rotation) [612.558942] Starting subtest: multiplane-rotation [629.994539] Subtest multiplane-rotation: SUCCESS (17.438s) [630.092246] [109/132] (484s left) syncobj_timeline (wait-any-complex) [630.151302] Starting subtest: wait-any-complex [630.210860] Subtest wait-any-complex: SUCCESS (0.061s) [630.268274] [110/132] (484s left) kms_hdr (brightness-with-hdr) [630.355449] Starting subtest: brightness-with-hdr [630.360799] Subtest brightness-with-hdr: SKIP (0.000s) [630.405239] [111/132] (484s left) syncobj_basic (bad-create-flags) [630.453583] Starting subtest: bad-create-flags [630.455267] Subtest bad-create-flags: SUCCESS (0.000s) [630.526007] [112/132] (484s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [630.622050] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [630.624005] Starting dynamic subtest: pipe-A-eDP-1 [630.672849] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [630.683589] Starting dynamic subtest: pipe-B-eDP-1 [630.730105] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [630.741764] Starting dynamic subtest: pipe-C-eDP-1 [630.788096] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [630.799633] Starting dynamic subtest: pipe-D-eDP-1 [630.847007] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [630.850561] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s) [632.846769] [113/132] (482s left) kms_cursor_crc (cursor-offscreen-max-size) [633.141096] Starting subtest: cursor-offscreen-max-size [633.147339] Subtest cursor-offscreen-max-size: SKIP (0.000s) [633.239054] [114/132] (481s left) kms_sequence (get-forked) [633.327088] Starting subtest: get-forked [633.329081] Starting dynamic subtest: pipe-A-eDP-1 [635.210073] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s) [635.221900] Starting dynamic subtest: pipe-B-eDP-1 [637.707089] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.498s) [637.720403] Starting dynamic subtest: pipe-C-eDP-1 [640.224111] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.515s) [640.235949] Starting dynamic subtest: pipe-D-eDP-1 [642.748279] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.519s) [642.750548] Subtest get-forked: SUCCESS (9.421s) [643.566167] [115/132] (471s left) kms_color_pipeline (plane-ctm3x4-lut1d) [643.662622] Starting subtest: plane-ctm3x4-lut1d [643.853041] Starting dynamic subtest: pipe-A-plane-0 [644.030130] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s) [644.042140] Starting dynamic subtest: pipe-A-plane-1 [644.208152] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s) [644.219828] Starting dynamic subtest: pipe-A-plane-2 [644.375260] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [645.631750] Starting dynamic subtest: pipe-B-plane-0 [645.799705] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [645.811564] Starting dynamic subtest: pipe-B-plane-1 [645.966791] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [645.979033] Starting dynamic subtest: pipe-B-plane-2 [646.133277] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s) [647.330001] Starting dynamic subtest: pipe-C-plane-0 [647.475760] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [647.487533] Starting dynamic subtest: pipe-C-plane-1 [647.631547] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s) [647.643228] Starting dynamic subtest: pipe-C-plane-2 [647.786592] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [648.946157] Starting dynamic subtest: pipe-D-plane-0 [649.080814] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [649.092750] Starting dynamic subtest: pipe-D-plane-1 [649.248045] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [649.259579] Starting dynamic subtest: pipe-D-plane-2 [649.403464] Dynamic subtest pipe-D-plane-2: SUCCESS (0.154s) [649.700998] Subtest plane-ctm3x4-lut1d: SUCCESS (6.040s) [650.517239] [116/132] (464s left) gem_exec_params (no-vebox) [650.574204] Starting subtest: no-vebox [650.576579] Subtest no-vebox: SUCCESS (0.002s) [652.513540] [117/132] (462s left) gem_eio (kms) [652.773289] Starting subtest: kms [673.461700] Subtest kms: SUCCESS (20.686s) [674.635140] [118/132] (440s left) gem_mmap_gtt (cpuset-big-copy) [674.693482] Subtest cpuset-big-copy: SKIP (0.000s) [674.762125] [119/132] (440s left) kms_cursor_edge_walk (64x64-left-edge) [674.862223] Starting subtest: 64x64-left-edge [674.864511] Starting dynamic subtest: pipe-A-eDP-1 [678.291029] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s) [678.302930] Starting dynamic subtest: pipe-D-eDP-1 [681.432275] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s) [681.434608] Subtest 64x64-left-edge: SUCCESS (6.570s) [682.230710] [120/132] (433s left) kms_invalid_mode (bad-vsync-start) [682.322831] Starting subtest: bad-vsync-start [682.325078] Starting dynamic subtest: pipe-A-eDP-1 [682.624506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.300s) [682.636376] Starting dynamic subtest: pipe-B-eDP-1 [682.638621] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [682.649822] Starting dynamic subtest: pipe-C-eDP-1 [682.652149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [682.665759] Starting dynamic subtest: pipe-D-eDP-1 [682.668081] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [682.670333] Subtest bad-vsync-start: SUCCESS (0.306s) [683.468869] [121/132] (431s left) gem_readwrite (read-write) [683.533051] Subtest read-write: SKIP (0.000s) [683.603685] [122/132] (431s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [683.696050] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [683.700583] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [683.783653] [123/132] (431s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [683.868958] Starting subtest: async-flip-with-page-flip-events-tiled [684.252031] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [687.065191] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.811s) [687.077226] Starting dynamic subtest: pipe-A-eDP-1-4 [689.250584] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s) [689.261943] Starting dynamic subtest: pipe-A-eDP-1-4 [691.260685] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [691.272036] Starting dynamic subtest: pipe-A-eDP-1-x [693.451229] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s) [693.834549] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [696.601884] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.775s) [696.614408] Starting dynamic subtest: pipe-B-eDP-1-4 [698.798387] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s) [698.812213] Starting dynamic subtest: pipe-B-eDP-1-4 [700.807868] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [700.819014] Starting dynamic subtest: pipe-B-eDP-1-x [702.998471] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [703.370705] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [706.136873] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s) [706.149428] Starting dynamic subtest: pipe-C-eDP-1-4 [708.312047] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [708.326288] Starting dynamic subtest: pipe-C-eDP-1-4 [710.324281] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [710.337554] Starting dynamic subtest: pipe-C-eDP-1-x [712.545819] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.221s) [712.910723] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [715.679255] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.777s) [715.691279] Starting dynamic subtest: pipe-D-eDP-1-4 [717.854560] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s) [717.868709] Starting dynamic subtest: pipe-D-eDP-1-4 [719.864237] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s) [719.876280] Starting dynamic subtest: pipe-D-eDP-1-x [722.065551] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s) [722.068227] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.193s) [723.258909] [124/132] (392s left) kms_feature_discovery (psr2) [723.347855] Starting subtest: psr2 [723.350098] Subtest psr2: SUCCESS (0.000s) [723.400963] [125/132] (392s left) gem_exec_gttfill (multigpu-basic) [723.574084] Starting subtest: multigpu-basic [734.702527] Subtest multigpu-basic: SUCCESS (11.133s) [734.761754] [126/132] (380s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [734.916868] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [735.619462] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.704s) [735.774966] [127/132] (379s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [735.868507] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [735.872908] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [735.922353] [128/132] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [736.020802] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [736.025157] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [736.100972] [129/132] (379s left) gem_exec_fence (basic-wait) [736.281264] Starting subtest: basic-wait [736.284275] Starting dynamic subtest: rcs0 [736.363659] Dynamic subtest rcs0: SUCCESS (0.086s) [736.376453] Starting dynamic subtest: bcs0 [736.432738] Dynamic subtest bcs0: SUCCESS (0.067s) [736.446240] Starting dynamic subtest: vcs0 [736.501667] Dynamic subtest vcs0: SUCCESS (0.066s) [736.515370] Starting dynamic subtest: vcs1 [736.562037] Dynamic subtest vcs1: SUCCESS (0.058s) [736.574309] Starting dynamic subtest: vecs0 [736.620709] Dynamic subtest vecs0: SUCCESS (0.057s) [736.633813] Starting dynamic subtest: ccs0 [736.684336] Dynamic subtest ccs0: SUCCESS (0.061s) [736.687206] Subtest basic-wait: SUCCESS (0.407s) [738.489965] [130/132] (377s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [738.581686] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [738.586010] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [738.670655] [131/132] (377s left) gem_exec_reloc (basic-write-gtt-noreloc) [738.731444] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [738.801219] [132/132] (377s left) kms_chamelium_color (ctm-green-to-red) [738.899758] Subtest ctm-green-to-red: SKIP (0.000s) [738.946920] Closing watchdogs results: parsing output: 0/ for test: gem_mmap_gtt results: parsing output: 1/ for test: gem_exec_whisper results: parsing output: 2/ for test: i915_drm_fdinfo results: parsing output: 3/ for test: syncobj_timeline results: parsing output: 4/ for test: gem_madvise results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_balancer results: parsing output: 7/ for test: kms_content_protection results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_exec_await results: parsing output: 10/ for test: gem_exec_schedule results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: kms_psr2_sf results: parsing output: 13/ for test: gem_busy results: parsing output: 14/ for test: perf results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: gem_mmap_gtt results: parsing output: 17/ for test: gem_workarounds results: parsing output: 18/ for test: kms_plane_multiple results: parsing output: 19/ for test: core_getstats results: parsing output: 20/ for test: gem_flink_basic results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: perf_pmu results: parsing output: 23/ for test: kms_rotation_crc results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: kms_atomic_transition results: parsing output: 26/ for test: gem_ctx_shared results: parsing output: 27/ for test: kms_psr results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_pm_rpm results: parsing output: 30/ for test: kms_cursor_legacy results: parsing output: 31/ for test: gem_ctx_engines results: parsing output: 32/ for test: gem_mmap_gtt results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: kms_vblank results: parsing output: 35/ for test: kms_cursor_legacy results: parsing output: 36/ for test: gem_exec_fence results: parsing output: 37/ for test: gem_render_copy results: parsing output: 38/ for test: kms_atomic_transition results: parsing output: 39/ for test: kms_lease results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: gem_pxp results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: syncobj_wait results: parsing output: 47/ for test: gen9_exec_parse results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_cursor_legacy results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_plane_scaling results: parsing output: 52/ for test: prime_busy results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_exec_schedule results: parsing output: 55/ for test: perf results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: kms_psr2_sf results: parsing output: 58/ for test: api_intel_bb results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: kms_plane results: parsing output: 61/ for test: gem_readwrite results: parsing output: 62/ for test: kms_rotation_crc results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: gem_eio results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_chamelium_frames results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: kms_properties results: parsing output: 69/ for test: kms_pipe_crc_basic results: parsing output: 70/ for test: i915_query results: parsing output: 71/ for test: kms_cursor_legacy results: parsing output: 72/ for test: gem_render_copy results: parsing output: 73/ for test: kms_ccs results: parsing output: 74/ for test: gem_exec_store results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: perf results: parsing output: 77/ for test: perf results: parsing output: 78/ for test: gem_close_race results: parsing output: 79/ for test: vgem_basic results: parsing output: 80/ for test: perf_pmu results: parsing output: 81/ for test: kms_psr2_sf results: parsing output: 82/ for test: gem_ctx_persistence results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_rotation_crc results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_chamelium_hpd results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_softpin results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_busy results: parsing output: 93/ for test: i915_pm_rpm results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: gen7_exec_parse results: parsing output: 97/ for test: kms_addfb_basic results: parsing output: 98/ for test: dmabuf_sync_file results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_debugfs results: parsing output: 102/ for test: i915_hangman results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: perf results: parsing output: 105/ for test: gem_fenced_exec_thrash results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_rotation_crc results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: kms_hdr results: parsing output: 110/ for test: syncobj_basic results: parsing output: 111/ for test: kms_ccs results: parsing output: 112/ for test: kms_cursor_crc results: parsing output: 113/ for test: kms_sequence results: parsing output: 114/ for test: kms_color_pipeline results: parsing output: 115/ for test: gem_exec_params results: parsing output: 116/ for test: gem_eio results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: kms_cursor_edge_walk results: parsing output: 119/ for test: kms_invalid_mode results: parsing output: 120/ for test: gem_readwrite results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_async_flips results: parsing output: 123/ for test: kms_feature_discovery results: parsing output: 124/ for test: gem_exec_gttfill results: parsing output: 125/ for test: kms_big_fb results: parsing output: 126/ for test: kms_flip_scaled_crc results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_exec_fence results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_exec_reloc results: parsing output: 131/ for test: kms_chamelium_color Done.