[57.470949] Initializing watchdogs [57.470995] /dev/watchdog0 [57.486068] [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] [57.490436] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.492754] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.496202] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [57.620957] Starting subtest: addfb25-y-tiled-small-legacy [57.625377] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [57.741495] [002/134] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [57.839901] Starting subtest: plane-downscale-factor-0-75-with-modifiers [57.842293] Starting dynamic subtest: pipe-A [58.196083] Dynamic subtest pipe-A: SUCCESS (0.358s) [58.205403] Starting dynamic subtest: pipe-B [59.648132] Dynamic subtest pipe-B: SUCCESS (1.449s) [59.659711] Starting dynamic subtest: pipe-C [61.132944] Dynamic subtest pipe-C: SUCCESS (1.483s) [61.141928] Starting dynamic subtest: pipe-D [62.583194] Dynamic subtest pipe-D: SUCCESS (1.448s) [62.585449] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.739s) [63.772312] [003/134] (954s left) i915_drm_fdinfo (virtual-idle) [63.816326] Starting subtest: virtual-idle [66.901936] Subtest virtual-idle: SUCCESS (3.081s) [67.083887] [004/134] (951s left) gem_userptr_blits (huge-split) [67.329457] Starting subtest: huge-split [67.340160] Subtest huge-split: SUCCESS (0.014s) [67.780439] [005/134] (950s left) kms_psr (fbc-pr-no-drrs) [67.894195] Starting subtest: fbc-pr-no-drrs [67.898486] Subtest fbc-pr-no-drrs: SKIP (0.000s) [68.083318] [006/134] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [68.185210] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [75.144909] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.961s) [75.281194] [007/134] (943s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [75.415134] Starting subtest: cursorA-vs-flipA-legacy [86.568450] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.152s) [87.439362] [008/134] (930s left) kms_psr (psr2-primary-page-flip) [87.539974] Starting subtest: psr2-primary-page-flip [87.542307] Starting dynamic subtest: eDP-1 [90.104255] Dynamic subtest eDP-1: SUCCESS (2.564s) [90.106699] Subtest psr2-primary-page-flip: SUCCESS (2.565s) [90.521019] [009/134] (927s left) i915_pm_rc6_residency (rc6-accuracy) [90.578052] Starting subtest: rc6-accuracy [90.580442] Starting dynamic subtest: gt0 [93.750260] Dynamic subtest gt0: SUCCESS (3.169s) [93.760603] Starting dynamic subtest: gt1 [96.920075] Dynamic subtest gt1: SUCCESS (3.168s) [96.922695] Subtest rc6-accuracy: SUCCESS (6.340s) [97.016719] [010/134] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [97.122249] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [104.459155] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.339s) [104.651062] [011/134] (913s left) kms_feature_discovery (psr2) [104.766911] Starting subtest: psr2 [104.769227] Subtest psr2: SUCCESS (0.000s) [104.862894] [012/134] (913s left) syncobj_wait (single-wait-all-for-submit-submitted) [104.931075] Starting subtest: single-wait-all-for-submit-submitted [105.033236] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.102s) [105.127824] [013/134] (913s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [105.232117] Starting subtest: 2x-wf_vblank-ts-check-interruptible [105.244293] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [105.364844] [014/134] (913s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [105.470519] Starting subtest: flip-primary-invalidate-overlay [117.079163] Subtest flip-primary-invalidate-overlay: SUCCESS (11.609s) [117.271278] [015/134] (901s left) i915_drm_fdinfo (busy-idle) [117.311586] Starting subtest: busy-idle [117.313813] Starting dynamic subtest: rcs0 [117.348132] Dynamic subtest rcs0: SKIP (0.035s) [117.358451] Starting dynamic subtest: bcs0 [117.361930] Dynamic subtest bcs0: SKIP (0.001s) [117.369407] Starting dynamic subtest: vcs0 [117.372808] Dynamic subtest vcs0: SKIP (0.001s) [117.379733] Starting dynamic subtest: vcs1 [117.383184] Dynamic subtest vcs1: SKIP (0.001s) [117.390274] Starting dynamic subtest: vecs0 [117.394045] Dynamic subtest vecs0: SKIP (0.000s) [117.403793] Starting dynamic subtest: ccs0 [117.407644] Dynamic subtest ccs0: SKIP (0.000s) [117.411363] Subtest busy-idle: SKIP (0.041s) [117.443836] [016/134] (901s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [117.505160] Starting subtest: invalid-bsd2-flag-on-vebox [117.507149] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [117.635841] [017/134] (901s left) syncobj_wait (single-wait-all-for-submit-signaled) [117.702080] Starting subtest: single-wait-all-for-submit-signaled [117.704375] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [117.840968] [018/134] (900s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [117.955561] Starting subtest: fbcpsr-rgb101010-draw-blt [124.719062] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.766s) [124.888245] [019/134] (893s left) kms_pm_rpm (modeset-lpsp) [127.128087] Starting subtest: modeset-lpsp [128.609762] Subtest modeset-lpsp: SUCCESS (1.484s) [128.721362] [020/134] (890s left) i915_suspend (sysfs-reader) [128.789222] Starting subtest: sysfs-reader [147.634943] Subtest sysfs-reader: SUCCESS (3.642s) [158.722175] [021/134] (871s left) prime_vgem (sync) [158.892736] Starting subtest: sync [158.894766] Starting dynamic subtest: rcs0 [158.947671] Dynamic subtest rcs0: SUCCESS (0.057s) [158.955970] Starting dynamic subtest: bcs0 [159.018897] Dynamic subtest bcs0: SUCCESS (0.070s) [159.027945] Starting dynamic subtest: vcs0 [159.071122] Dynamic subtest vcs0: SUCCESS (0.051s) [159.079906] Starting dynamic subtest: vcs1 [159.115191] Dynamic subtest vcs1: SUCCESS (0.043s) [159.124590] Starting dynamic subtest: vecs0 [159.164217] Dynamic subtest vecs0: SUCCESS (0.048s) [159.172867] Starting dynamic subtest: ccs0 [159.213204] Dynamic subtest ccs0: SUCCESS (0.048s) [159.215578] Subtest sync: SUCCESS (0.320s) [159.389229] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [159.392464] [022/134] (870s left) api_intel_allocator (two-level-inception) [159.453186] Starting subtest: two-level-inception [164.897400] Subtest two-level-inception: SUCCESS (5.403s) [165.084875] [023/134] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [165.212027] Starting subtest: psr-2p-primscrn-cur-indfb-move [165.216004] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [165.373608] [024/134] (864s left) sriov_basic (bind-unbind-vf) [165.441595] Starting subtest: bind-unbind-vf [165.443979] Starting dynamic subtest: vf-1 [165.524023] Dynamic subtest vf-1: FAIL (0.035s) [165.535265] Starting dynamic subtest: vf-2 [165.607697] Dynamic subtest vf-2: FAIL (0.004s) [165.617090] Starting dynamic subtest: vf-3 [165.687573] Dynamic subtest vf-3: FAIL (0.004s) [165.696955] Starting dynamic subtest: vf-4 [165.765969] Dynamic subtest vf-4: FAIL (0.004s) [165.775360] Starting dynamic subtest: vf-5 [165.845340] Dynamic subtest vf-5: FAIL (0.004s) [165.855160] Starting dynamic subtest: vf-6 [165.925331] Dynamic subtest vf-6: FAIL (0.004s) [165.935683] Starting dynamic subtest: vf-7 [165.995545] Dynamic subtest vf-7: FAIL (0.004s) [166.004992] Starting dynamic subtest: vf-random [166.065115] Dynamic subtest vf-random: FAIL (0.004s) [166.074722] Starting dynamic subtest: vf-last [166.135193] Dynamic subtest vf-last: FAIL (0.004s) [166.137199] Subtest bind-unbind-vf: FAIL (0.551s) [166.176248] [025/134] (863s left) gem_eio (hibernate) [166.433748] Starting subtest: hibernate [181.080239] Subtest hibernate: SUCCESS (14.614s) [192.236984] [026/134] (848s left) kms_vrr (seamless-rr-switch-virtual) [192.362459] Starting subtest: seamless-rr-switch-virtual [192.369319] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [192.460468] [027/134] (848s left) api_intel_bb (render) [192.522409] Starting subtest: render [192.524779] Starting dynamic subtest: render-none-512 [192.626355] Dynamic subtest render-none-512: SUCCESS (0.104s) [192.639144] Starting dynamic subtest: render-none-1024 [193.008256] Dynamic subtest render-none-1024: SUCCESS (0.380s) [193.021457] Starting dynamic subtest: render-x-512 [193.092731] Dynamic subtest render-x-512: SUCCESS (0.085s) [193.104842] Starting dynamic subtest: render-x-1024 [193.482541] Dynamic subtest render-x-1024: SUCCESS (0.388s) [193.495086] Starting dynamic subtest: render-y-512 [193.568663] Dynamic subtest render-y-512: SUCCESS (0.086s) [193.580614] Starting dynamic subtest: render-y-1024 [193.920373] Dynamic subtest render-y-1024: SUCCESS (0.350s) [193.923274] Subtest render: SUCCESS (1.397s) [194.075177] [028/134] (847s left) kms_cursor_legacy (torture-bo) [194.192419] Starting subtest: torture-bo [194.194698] Starting dynamic subtest: pipe-A [200.448127] Dynamic subtest pipe-A: SUCCESS (6.248s) [200.460370] Starting dynamic subtest: pipe-B [206.013363] Dynamic subtest pipe-B: SUCCESS (5.563s) [206.024183] Starting dynamic subtest: pipe-C [212.380866] Dynamic subtest pipe-C: SUCCESS (6.361s) [212.393505] Starting dynamic subtest: pipe-D [218.579840] Dynamic subtest pipe-D: SUCCESS (6.195s) [218.591365] Starting dynamic subtest: all-pipes [225.152966] Dynamic subtest all-pipes: SUCCESS (6.567s) [225.155525] Subtest torture-bo: SUCCESS (30.941s) [225.333827] [029/134] (815s left) kms_rotation_crc (sprite-rotation-270) [225.436702] Starting subtest: sprite-rotation-270 [225.441162] Subtest sprite-rotation-270: SKIP (0.001s) [225.537465] [030/134] (815s left) kms_prime (basic-modeset-hybrid) [225.631699] Subtest basic-modeset-hybrid: SKIP (0.000s) [225.747889] [031/134] (815s left) gem_ctx_persistence (many-contexts) [225.810249] Starting subtest: many-contexts [271.058125] Subtest many-contexts: SUCCESS (45.225s) [271.159703] [032/134] (770s left) gem_create (busy-create) [271.230097] Starting subtest: busy-create [271.232438] Starting dynamic subtest: smem0 [305.188747] Dynamic subtest smem0: SUCCESS (33.940s) [305.191288] Subtest busy-create: SUCCESS (33.941s) [305.401153] [033/134] (736s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [305.510617] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [305.514999] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [305.654844] [034/134] (735s left) kms_psr (fbc-psr-cursor-blt) [305.758265] Starting subtest: fbc-psr-cursor-blt [305.760574] Starting dynamic subtest: eDP-1 [305.764943] Dynamic subtest eDP-1: SKIP (0.000s) [305.769342] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [305.865644] [035/134] (735s left) gem_sync (basic-store-each) [305.937805] Starting subtest: basic-store-each [308.610688] Subtest basic-store-each: SUCCESS (2.682s) [308.822982] [036/134] (732s left) prime_mmap (test_userptr) [308.886898] Starting subtest: test_userptr [308.889394] Starting dynamic subtest: test_userptr-smem [308.891772] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [308.894147] Subtest test_userptr: SUCCESS (0.001s) [309.012411] [037/134] (732s left) kms_pipe_crc_basic (nonblocking-crc) [309.121261] Starting subtest: nonblocking-crc [309.123613] Starting dynamic subtest: pipe-A-eDP-1 [309.878622] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s) [309.889505] Starting dynamic subtest: pipe-B-eDP-1 [311.294361] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s) [311.305052] Starting dynamic subtest: pipe-C-eDP-1 [312.639363] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s) [312.650800] Starting dynamic subtest: pipe-D-eDP-1 [313.974517] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s) [313.976856] Subtest nonblocking-crc: SUCCESS (4.851s) [314.808098] [038/134] (726s left) perf (unprivileged-single-ctx-counters) [314.950730] Starting subtest: unprivileged-single-ctx-counters [314.955128] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [314.995203] [039/134] (726s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [319.978049] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [319.980224] Starting dynamic subtest: pipe-A-eDP-1 [326.540410] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.557s) [326.551019] Starting dynamic subtest: pipe-B-eDP-1 [333.209665] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.664s) [333.211889] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.225s) [334.105756] [040/134] (707s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [339.156938] Starting subtest: pr-overlay-plane-move-continuous-sf [339.161461] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [340.025676] [041/134] (701s left) kms_psr (fbc-psr-sprite-blt) [340.141709] Starting subtest: fbc-psr-sprite-blt [340.143936] Starting dynamic subtest: eDP-1 [340.148065] Dynamic subtest eDP-1: SKIP (0.000s) [340.152329] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [340.244229] [042/134] (701s left) sysfs_timeslice_duration (invalid) [340.313908] Starting subtest: invalid [340.316232] Starting dynamic subtest: vecs0 [340.318618] Dynamic subtest vecs0: SUCCESS (0.000s) [340.333343] Starting dynamic subtest: ccs0 [340.335665] Dynamic subtest ccs0: SUCCESS (0.000s) [340.347513] Starting dynamic subtest: vcs0 [340.349640] Dynamic subtest vcs0: SUCCESS (0.000s) [340.359056] Starting dynamic subtest: bcs0 [340.361260] Dynamic subtest bcs0: SUCCESS (0.000s) [340.370807] Starting dynamic subtest: rcs0 [340.373008] Dynamic subtest rcs0: SUCCESS (0.000s) [340.382279] Starting dynamic subtest: vcs1 [340.384205] Dynamic subtest vcs1: SUCCESS (0.000s) [340.386092] Subtest invalid: SUCCESS (0.005s) [340.464270] [043/134] (701s left) gem_barrier_race (remote-request) [340.536717] Starting subtest: remote-request [340.538973] Starting dynamic subtest: rcs0 [345.690486] Dynamic subtest rcs0: SUCCESS (5.153s) [345.692453] Subtest remote-request: SUCCESS (5.154s) [345.906782] [044/134] (696s left) kms_big_fb (yf-tiled-addfb-size-overflow) [346.022159] Starting subtest: yf-tiled-addfb-size-overflow [346.025969] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [346.160009] [045/134] (695s left) vgem_basic (busy-fence) [346.198274] Starting subtest: busy-fence [346.200133] Subtest busy-fence: SUCCESS (0.000s) [346.280474] [046/134] (695s left) gem_mmap (bad-object) [346.327086] Subtest bad-object: SKIP (0.000s) [346.384192] [047/134] (695s left) kms_big_fb (x-tiled-64bpp-rotate-180) [346.479749] Starting subtest: x-tiled-64bpp-rotate-180 [348.027088] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.546s) [348.277548] [048/134] (693s left) syncobj_timeline (etime-multi-wait-submitted) [348.337983] Starting subtest: etime-multi-wait-submitted [348.446299] Subtest etime-multi-wait-submitted: SUCCESS (0.108s) [348.549366] [049/134] (693s left) gem_readwrite (read-write) [348.611713] Subtest read-write: SKIP (0.000s) [348.679440] [050/134] (693s left) kms_content_protection (mei-interface) [348.826018] Starting subtest: mei-interface [348.830374] Subtest mei-interface: SKIP (0.001s) [348.990808] [051/134] (693s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [349.090054] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [349.759497] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s) [349.967876] [052/134] (692s left) gem_mmap_gtt (isolation) [350.030170] Subtest isolation: SKIP (0.000s) [350.089126] [053/134] (692s left) kms_cursor_edge_walk (64x64-top-edge) [350.183350] Starting subtest: 64x64-top-edge [350.185635] Starting dynamic subtest: pipe-A-eDP-1 [353.675495] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s) [353.685798] Starting dynamic subtest: pipe-D-eDP-1 [356.792812] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s) [356.794930] Subtest 64x64-top-edge: SUCCESS (6.608s) [357.623723] [054/134] (684s left) syncobj_wait (wait-all-snapshot) [357.682579] Starting subtest: wait-all-snapshot [357.762864] Subtest wait-all-snapshot: SUCCESS (0.081s) [357.868387] [055/134] (684s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu) [357.985665] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu [357.989852] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s) [358.096910] [056/134] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [358.198112] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [358.202362] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [358.334622] [057/134] (684s left) gem_create (create-invalid-size) [358.381250] Starting subtest: create-invalid-size [358.383395] Subtest create-invalid-size: SUCCESS (0.000s) [358.596916] [058/134] (683s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [358.658514] Starting subtest: y-tiled-ccs-to-yf-tiled [358.662945] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [358.884046] [059/134] (683s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-wc) [358.972785] Starting subtest: psr-argb161616f-draw-mmap-wc [358.976946] Subtest psr-argb161616f-draw-mmap-wc: SKIP (0.000s) [359.104721] [060/134] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [359.206171] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [359.210377] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [359.320109] [061/134] (683s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [359.431619] Starting subtest: switch-modeset-ultra-joiner-big-joiner [359.435763] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [359.521047] [062/134] (683s left) sw_sync (sync_merge_same) [359.562821] Starting subtest: sync_merge_same [359.565006] Subtest sync_merge_same: SUCCESS (0.000s) [359.641808] [063/134] (683s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [359.739127] Starting subtest: planes-downscale-factor-0-75-unity-scaling [359.741321] Starting dynamic subtest: pipe-A [359.802191] Dynamic subtest pipe-A: SUCCESS (0.065s) [359.813638] Starting dynamic subtest: pipe-B [360.915101] Dynamic subtest pipe-B: SUCCESS (1.111s) [360.927355] Starting dynamic subtest: pipe-C [362.040575] Dynamic subtest pipe-C: SUCCESS (1.124s) [362.051143] Starting dynamic subtest: pipe-D [363.159418] Dynamic subtest pipe-D: SUCCESS (1.116s) [363.161781] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.421s) [364.353865] [064/134] (678s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [364.409081] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [364.411451] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [364.541797] [065/134] (678s left) gem_render_copy (linear-to-vebox-yf-tiled) [364.612949] Starting subtest: linear-to-vebox-yf-tiled [364.617904] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [364.820310] [066/134] (678s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [364.926758] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [364.929002] Starting dynamic subtest: A-eDP1 [368.556281] Dynamic subtest A-eDP1: SUCCESS (3.624s) [368.566799] Starting dynamic subtest: B-eDP1 [371.752343] Dynamic subtest B-eDP1: SUCCESS (3.193s) [371.762976] Starting dynamic subtest: C-eDP1 [374.880754] Dynamic subtest C-eDP1: SUCCESS (3.124s) [374.891729] Starting dynamic subtest: D-eDP1 [378.009172] Dynamic subtest D-eDP1: SUCCESS (3.126s) [378.011382] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.075s) [378.830319] [067/134] (664s left) kms_chamelium_color (ctm-limited-range) [378.933205] Subtest ctm-limited-range: SKIP (0.000s) [378.981252] [068/134] (664s left) gem_mmap_wc (write) [379.042762] Subtest write: SKIP (0.000s) [379.112411] [069/134] (663s left) prime_mmap (test_correct) [379.166043] Starting subtest: test_correct [379.168394] Starting dynamic subtest: test_correct-smem [379.223143] Dynamic subtest test_correct-smem: SUCCESS (0.058s) [379.225640] Subtest test_correct: SUCCESS (0.059s) [379.353220] [070/134] (663s left) device_reset (cold-reset-bound) [379.398925] Starting subtest: cold-reset-bound [379.403557] Subtest cold-reset-bound: SKIP (0.000s) [379.484023] [071/134] (663s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [379.583425] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [386.583639] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.996s) [386.780497] [072/134] (656s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [386.894973] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [391.176052] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.284s) [392.348763] [073/134] (650s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [392.443901] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [392.446370] Starting dynamic subtest: pipe-A-eDP-1 [392.469731] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [392.482172] Starting dynamic subtest: pipe-B-eDP-1 [392.503393] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [392.512680] Starting dynamic subtest: pipe-C-eDP-1 [392.533904] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [392.543193] Starting dynamic subtest: pipe-D-eDP-1 [392.565355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [392.569658] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [394.810783] [074/134] (648s left) gem_exec_fence (syncobj-channel) [395.253741] Starting subtest: syncobj-channel [396.270886] Subtest syncobj-channel: SUCCESS (1.017s) [397.247854] [075/134] (646s left) gem_exec_reloc (basic-gtt-noreloc) [397.309928] Subtest basic-gtt-noreloc: SKIP (0.000s) [397.391992] [076/134] (645s left) kms_flip (dpms-off-confusion-interruptible) [397.496119] Starting subtest: dpms-off-confusion-interruptible [397.501195] Starting dynamic subtest: A-eDP1 [406.184163] Dynamic subtest A-eDP1: SUCCESS (8.681s) [406.198910] Starting dynamic subtest: B-eDP1 [414.825414] Dynamic subtest B-eDP1: SUCCESS (8.634s) [414.837806] Starting dynamic subtest: C-eDP1 [423.449853] Dynamic subtest C-eDP1: SUCCESS (8.616s) [423.474850] Starting dynamic subtest: D-eDP1 [432.078787] Dynamic subtest D-eDP1: SUCCESS (8.622s) [432.081237] Subtest dpms-off-confusion-interruptible: SUCCESS (34.568s) [433.380270] [077/134] (610s left) kms_vblank (wait-forked-busy) [433.473155] Starting subtest: wait-forked-busy [433.475473] Starting dynamic subtest: pipe-A-eDP-1 [435.359886] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s) [435.375389] Starting dynamic subtest: pipe-D-eDP-1 [437.911007] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s) [437.913365] Subtest wait-forked-busy: SUCCESS (4.438s) [438.741327] [078/134] (604s left) kms_chamelium_frames (dp-frame-dump) [439.142950] Subtest dp-frame-dump: SKIP (0.000s) [439.935734] [079/134] (603s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [440.029246] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [440.031544] Starting dynamic subtest: pipe-A-eDP-1 [440.091652] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [440.103556] Starting dynamic subtest: pipe-B-eDP-1 [440.161415] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [440.173300] Starting dynamic subtest: pipe-C-eDP-1 [440.230254] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [440.241274] Starting dynamic subtest: pipe-D-eDP-1 [440.298718] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [440.302841] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [442.343751] [080/134] (601s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [442.440493] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [442.444467] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [442.582972] [081/134] (600s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [442.687041] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [442.691673] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [442.802485] [082/134] (600s left) gen7_exec_parse (cmd-crossing-page) [442.865869] Subtest cmd-crossing-page: SKIP (0.000s) [442.951462] [083/134] (600s left) kms_atomic_transition (modeset-transition-nonblocking) [443.041121] Starting subtest: modeset-transition-nonblocking [443.043426] Starting dynamic subtest: 1x-outputs [454.105808] Dynamic subtest 1x-outputs: SUCCESS (11.073s) [454.108271] Subtest modeset-transition-nonblocking: SUCCESS (11.074s) [454.980454] [084/134] (588s left) kms_draw_crc (draw-method-mmap-cpu) [455.078275] Starting subtest: draw-method-mmap-cpu [455.080573] Starting dynamic subtest: xrgb8888-untiled [455.309165] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s) [455.319738] Starting dynamic subtest: rgb565-untiled [455.542145] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [455.553399] Starting dynamic subtest: xrgb2101010-untiled [455.763933] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [455.777957] Starting dynamic subtest: xbgr16161616f-untiled [455.985556] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [455.997841] Starting dynamic subtest: xrgb8888-xtiled [456.130132] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.142s) [456.140441] Starting dynamic subtest: rgb565-xtiled [456.262499] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [456.272635] Starting dynamic subtest: xrgb2101010-xtiled [456.384689] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [456.394438] Starting dynamic subtest: xbgr16161616f-xtiled [456.517682] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [456.530020] Starting dynamic subtest: xrgb8888-4tiled [456.673136] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s) [456.682995] Starting dynamic subtest: rgb565-4tiled [456.817479] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [456.827643] Starting dynamic subtest: xrgb2101010-4tiled [456.950261] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s) [456.960351] Starting dynamic subtest: xbgr16161616f-4tiled [457.083859] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s) [457.085791] Subtest draw-method-mmap-cpu: SUCCESS (2.011s) [457.226721] [085/134] (586s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [457.330430] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [457.332271] Starting dynamic subtest: pipe-A-eDP-1 [457.482228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s) [457.494015] Starting dynamic subtest: pipe-B-eDP-1 [457.510104] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [457.519798] Starting dynamic subtest: pipe-C-eDP-1 [457.537144] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [457.546684] Starting dynamic subtest: pipe-D-eDP-1 [457.562527] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [457.564056] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.180s) [459.822211] [086/134] (583s left) gem_exec_schedule (u-semaphore-user) [459.896749] Starting subtest: u-semaphore-user [459.946790] Subtest u-semaphore-user: SUCCESS (0.058s) [461.182484] [087/134] (582s left) gem_exec_fence (basic-await) [461.350640] Starting subtest: basic-await [461.353221] Starting dynamic subtest: rcs0 [461.430438] Dynamic subtest rcs0: SUCCESS (0.080s) [461.443222] Starting dynamic subtest: bcs0 [461.505566] Dynamic subtest bcs0: SUCCESS (0.073s) [461.518781] Starting dynamic subtest: vcs0 [461.579949] Dynamic subtest vcs0: SUCCESS (0.072s) [461.593294] Starting dynamic subtest: vcs1 [461.651375] Dynamic subtest vcs1: SUCCESS (0.070s) [461.663224] Starting dynamic subtest: vecs0 [461.723886] Dynamic subtest vecs0: SUCCESS (0.071s) [461.736694] Starting dynamic subtest: ccs0 [461.796423] Dynamic subtest ccs0: SUCCESS (0.071s) [461.799132] Subtest basic-await: SUCCESS (0.449s) [463.207520] [088/134] (580s left) kms_rotation_crc (cursor-rotation-180) [463.313062] Starting subtest: cursor-rotation-180 [464.849750] Subtest cursor-rotation-180: SUCCESS (1.539s) [466.086453] [089/134] (577s left) kms_cursor_crc (cursor-onscreen-512x170) [466.400101] Starting subtest: cursor-onscreen-512x170 [466.405250] Subtest cursor-onscreen-512x170: SKIP (0.001s) [466.596412] [090/134] (577s left) kms_big_fb (linear-addfb) [466.706092] Starting subtest: linear-addfb [466.708443] Subtest linear-addfb: SUCCESS (0.000s) [466.848736] [091/134] (577s left) gem_exec_whisper (basic-queues) [466.920628] Starting subtest: basic-queues [473.349795] Subtest basic-queues: SUCCESS (6.437s) [473.562150] [092/134] (570s left) gem_exec_reloc (basic-scanout) [473.637736] Subtest basic-scanout: SKIP (0.000s) [473.729995] [093/134] (570s left) kms_plane_lowres (tiling-4) [473.833029] Starting subtest: tiling-4 [473.835121] Starting dynamic subtest: pipe-A-eDP-1 [473.839565] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [474.138832] Starting dynamic subtest: pipe-B-eDP-1 [474.143590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [474.154371] Starting dynamic subtest: pipe-C-eDP-1 [474.159331] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [474.169856] Starting dynamic subtest: pipe-D-eDP-1 [474.174339] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [474.178630] Subtest tiling-4: SKIP (0.304s) [475.009649] [094/134] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [475.120459] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [482.230242] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.120s) [482.412647] [095/134] (561s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [482.524370] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [486.106080] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.588s) [487.325948] [096/134] (556s left) gem_ctx_create (basic) [487.389977] Starting subtest: basic [487.391984] Subtest basic: SUCCESS (0.000s) [487.596096] [097/134] (556s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [487.687382] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [487.689704] Starting dynamic subtest: pipe-A-default-mode [488.851261] Dynamic subtest pipe-A-default-mode: SKIP (1.164s) [488.855676] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.165s) [489.042393] [098/134] (555s left) gem_pwrite (basic-exhaustion) [489.109838] Subtest basic-exhaustion: SKIP (0.000s) [489.181593] [099/134] (555s left) kms_atomic_transition (plane-all-transition-nonblocking) [489.293464] Starting subtest: plane-all-transition-nonblocking [489.295874] Starting dynamic subtest: pipe-A-eDP-1 [491.785970] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [492.098493] Starting dynamic subtest: pipe-B-eDP-1 [495.340373] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.255s) [495.650649] Subtest plane-all-transition-nonblocking: SUCCESS (6.362s) [496.508341] [100/134] (547s left) kms_color_pipeline (plane-lut1d-lut1d) [496.619214] Starting subtest: plane-lut1d-lut1d [496.632038] Starting dynamic subtest: pipe-A-eDP-1 [497.372432] Dynamic subtest pipe-A-eDP-1: FAIL (0.342s) [498.048814] Starting dynamic subtest: pipe-B-eDP-1 [498.893021] Dynamic subtest pipe-B-eDP-1: FAIL (0.336s) [499.473517] Starting dynamic subtest: pipe-C-eDP-1 [500.304238] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s) [500.803383] Starting dynamic subtest: pipe-D-eDP-1 [501.637547] Dynamic subtest pipe-D-eDP-1: FAIL (0.245s) [501.639862] Subtest plane-lut1d-lut1d: FAIL (4.703s) [502.209519] [101/134] (542s left) gem_lmem_swapping (verify-random) [502.255408] Subtest verify-random: SKIP (0.000s) [502.301131] [102/134] (542s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [502.400589] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [502.405001] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [502.520433] [103/134] (542s left) sw_sync (sync_random_merge) [502.559290] Starting subtest: sync_random_merge [502.596523] Subtest sync_random_merge: SUCCESS (0.039s) [502.683893] [104/134] (541s left) syncobj_timeline (invalid-signal-bad-pad) [502.735669] Starting subtest: invalid-signal-bad-pad [502.737596] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [502.883654] [105/134] (541s left) gem_mmap_gtt (basic) [502.943062] Subtest basic: SKIP (0.000s) [503.013307] [106/134] (541s left) gem_exec_balancer (invalid-balancer) [503.076512] Starting subtest: invalid-balancer [503.975975] Subtest invalid-balancer: SUCCESS (0.901s) [504.309054] [107/134] (540s left) kms_big_fb (y-tiled-8bpp-rotate-90) [504.404057] Starting subtest: y-tiled-8bpp-rotate-90 [504.408476] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [504.562081] [108/134] (540s left) gem_render_linear_blits (basic) [504.620552] Starting subtest: basic [504.645100] Subtest basic: SUCCESS (0.027s) [504.736458] [109/134] (540s left) gem_ctx_shared (q-promotion) [504.792147] Starting subtest: Q-promotion [504.794378] Starting dynamic subtest: rcs0 [504.901173] Dynamic subtest rcs0: SUCCESS (0.106s) [504.920152] Starting dynamic subtest: vcs0 [504.986196] Dynamic subtest vcs0: SUCCESS (0.086s) [505.005541] Starting dynamic subtest: vcs1 [505.065234] Dynamic subtest vcs1: SUCCESS (0.078s) [505.082881] Starting dynamic subtest: vecs0 [505.144049] Dynamic subtest vecs0: SUCCESS (0.078s) [505.162105] Starting dynamic subtest: ccs0 [505.236823] Dynamic subtest ccs0: SUCCESS (0.091s) [505.239234] Subtest Q-promotion: SUCCESS (0.445s) [506.234676] [110/134] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [506.321982] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [506.326553] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [506.446262] [111/134] (538s left) syncobj_timeline (single-wait-for-submit-available-submitted) [506.497467] Starting subtest: single-wait-for-submit-available-submitted [506.499727] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [506.640420] [112/134] (538s left) gem_flink_basic (bad-open) [506.693090] Starting subtest: bad-open [506.695364] Subtest bad-open: SUCCESS (0.000s) [506.834418] [113/134] (538s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [506.934097] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [506.936403] Starting dynamic subtest: pipe-A-eDP-1 [507.814862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s) [507.826202] Starting dynamic subtest: pipe-B-eDP-1 [509.465011] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.647s) [509.481271] Starting dynamic subtest: pipe-C-eDP-1 [511.014732] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.551s) [511.026619] Starting dynamic subtest: pipe-D-eDP-1 [512.533487] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.519s) [512.535907] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.596s) [513.731963] [114/134] (531s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [513.835033] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [513.839190] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [513.948395] [115/134] (531s left) kms_hdr (bpc-switch-dpms) [514.044962] Starting subtest: bpc-switch-dpms [515.081973] Starting dynamic subtest: pipe-A-eDP-1 [519.610764] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.530s) [519.613110] Subtest bpc-switch-dpms: SUCCESS (5.570s) [519.771708] [116/134] (525s left) kms_chamelium_hpd (hdmi-hpd) [520.160517] Subtest hdmi-hpd: SKIP (0.000s) [520.975626] [117/134] (524s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [521.076135] Starting subtest: primary-yf-tiled-reflect-x-270 [521.080746] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [521.174796] [118/134] (524s left) prime_vgem (basic-write) [521.266838] Starting subtest: basic-write [521.274930] Subtest basic-write: SKIP (0.006s) [521.426050] [119/134] (523s left) gem_ctx_freq (sysfs) [521.491593] Starting subtest: sysfs [521.493920] Starting dynamic subtest: gt0 [527.028342] Dynamic subtest gt0: SUCCESS (5.539s) [527.039027] Starting dynamic subtest: gt1 [569.146364] Dynamic subtest gt1: SUCCESS (42.125s) [569.149391] Subtest sysfs: SUCCESS (47.667s) [569.307124] [120/134] (475s left) kms_cursor_crc (cursor-onscreen-max-size) [569.623706] Starting subtest: cursor-onscreen-max-size [569.630504] Subtest cursor-onscreen-max-size: SKIP (0.000s) [569.795051] [121/134] (475s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [569.904928] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [569.909859] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [570.051491] [122/134] (475s left) perf (per-context-mode-unprivileged) [570.158870] Starting subtest: per-context-mode-unprivileged [570.162826] Subtest per-context-mode-unprivileged: SKIP (0.000s) [570.203714] [123/134] (475s left) kms_setmode (basic) [570.257520] Starting subtest: basic [570.590713] Starting dynamic subtest: pipe-A-eDP-1 [572.693215] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s) [573.035389] Starting dynamic subtest: pipe-B-eDP-1 [575.124396] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.094s) [575.433697] Subtest basic: SUCCESS (5.173s) [576.301639] [124/134] (469s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [576.398052] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [577.066739] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s) [577.279043] [125/134] (468s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [577.372086] Starting subtest: plane-use-after-nonblocking-unbind [577.374294] Starting dynamic subtest: pipe-A-eDP-1 [577.432898] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [577.727918] Starting dynamic subtest: pipe-B-eDP-1 [578.565999] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.847s) [578.875698] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.503s) [579.763075] [126/134] (465s left) kms_atomic_interruptible (universal-setplane-primary) [579.862499] Starting subtest: universal-setplane-primary [579.864774] Starting dynamic subtest: pipe-A-eDP-1 [587.280769] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.418s) [587.283045] Subtest universal-setplane-primary: SUCCESS (7.420s) [588.137891] [127/134] (457s left) kms_pm_backlight (fade-with-dpms) [588.241170] Starting subtest: fade-with-dpms [590.598140] Starting dynamic subtest: eDP-1 [593.291261] Dynamic subtest eDP-1: SUCCESS (2.692s) [593.293567] Subtest fade-with-dpms: SUCCESS (5.049s) [594.128237] [128/134] (451s left) perf_pmu (event-wait) [594.170291] Starting subtest: event-wait [594.172546] Starting dynamic subtest: rcs0 [594.176880] Dynamic subtest rcs0: SKIP (0.000s) [594.180907] Subtest event-wait: SKIP (0.001s) [594.296347] [129/134] (451s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [594.406541] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [594.410536] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [594.541270] [130/134] (451s left) gem_exec_whisper (basic-contexts-all) [594.598021] Starting subtest: basic-contexts-all [603.461824] Subtest basic-contexts-all: SUCCESS (8.859s) [603.671124] [131/134] (442s left) gem_spin_batch (spin-each) [603.735640] Starting subtest: spin-each [607.101383] Subtest spin-each: SUCCESS (3.363s) [609.213538] [132/134] (436s left) kms_universal_plane (disable-primary-vs-flip) [609.318468] Starting subtest: disable-primary-vs-flip [609.320425] Starting dynamic subtest: pipe-A-eDP-1 [610.878557] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.561s) [610.890191] Starting dynamic subtest: pipe-B-eDP-1 [613.134656] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.252s) [613.145936] Starting dynamic subtest: pipe-C-eDP-1 [615.384650] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.250s) [615.395649] Starting dynamic subtest: pipe-D-eDP-1 [617.562041] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.176s) [617.564499] Subtest disable-primary-vs-flip: SUCCESS (8.244s) [618.458859] [133/134] (427s left) gem_exec_schedule (preemptive-hang) [618.636849] Starting subtest: preemptive-hang [618.639452] Starting dynamic subtest: rcs0 [628.261830] Dynamic subtest rcs0: SUCCESS (9.622s) [628.275430] Starting dynamic subtest: bcs0 [637.283203] Dynamic subtest bcs0: SUCCESS (9.020s) [637.296252] Starting dynamic subtest: vcs0 [646.245089] Dynamic subtest vcs0: SUCCESS (8.959s) [646.257755] Starting dynamic subtest: vcs1 [655.209663] Dynamic subtest vcs1: SUCCESS (8.959s) [655.220054] Starting dynamic subtest: vecs0 [664.288014] Dynamic subtest vecs0: SUCCESS (9.077s) [664.298366] Starting dynamic subtest: ccs0 [673.256979] Dynamic subtest ccs0: SUCCESS (8.963s) [673.259521] Subtest preemptive-hang: SUCCESS (54.612s) [673.558908] [134/134] (372s left) syncobj_wait (invalid-signal-bad-pad) [673.624854] Starting subtest: invalid-signal-bad-pad [673.627255] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [673.766439] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: kms_plane_scaling results: parsing output: 2/ for test: i915_drm_fdinfo results: parsing output: 3/ for test: gem_userptr_blits results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: i915_pm_rc6_residency results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_feature_discovery results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_psr_stress_test results: parsing output: 14/ for test: i915_drm_fdinfo results: parsing output: 15/ for test: gem_exec_params results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_pm_rpm results: parsing output: 19/ for test: i915_suspend results: parsing output: 20/ for test: prime_vgem results: parsing output: 21/ for test: api_intel_allocator results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: sriov_basic results: parsing output: 24/ for test: gem_eio results: parsing output: 25/ for test: kms_vrr results: parsing output: 26/ for test: api_intel_bb results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_rotation_crc results: parsing output: 29/ for test: kms_prime results: parsing output: 30/ for test: gem_ctx_persistence results: parsing output: 31/ for test: gem_create results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: gem_sync results: parsing output: 35/ for test: prime_mmap results: parsing output: 36/ for test: kms_pipe_crc_basic results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_psr2_sf results: parsing output: 39/ for test: kms_psr2_sf results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: sysfs_timeslice_duration results: parsing output: 42/ for test: gem_barrier_race results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: vgem_basic results: parsing output: 45/ for test: gem_mmap results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: gem_readwrite results: parsing output: 49/ for test: kms_content_protection results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_mmap_gtt results: parsing output: 52/ for test: kms_cursor_edge_walk results: parsing output: 53/ for test: syncobj_wait results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_create results: parsing output: 57/ for test: gem_render_copy results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_joiner results: parsing output: 61/ for test: sw_sync results: parsing output: 62/ for test: kms_plane_scaling results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: kms_chamelium_color results: parsing output: 67/ for test: gem_mmap_wc results: parsing output: 68/ for test: prime_mmap results: parsing output: 69/ for test: device_reset results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: gem_exec_reloc results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_vblank results: parsing output: 77/ for test: kms_chamelium_frames results: parsing output: 78/ for test: kms_ccs results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: gen7_exec_parse results: parsing output: 82/ for test: kms_atomic_transition results: parsing output: 83/ for test: kms_draw_crc results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: gem_exec_fence results: parsing output: 87/ for test: kms_rotation_crc results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: gem_exec_whisper results: parsing output: 91/ for test: gem_exec_reloc results: parsing output: 92/ for test: kms_plane_lowres results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_ctx_create results: parsing output: 96/ for test: kms_flip_scaled_crc results: parsing output: 97/ for test: gem_pwrite results: parsing output: 98/ for test: kms_atomic_transition results: parsing output: 99/ for test: kms_color_pipeline results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: sw_sync results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: gem_mmap_gtt results: parsing output: 105/ for test: gem_exec_balancer results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_render_linear_blits results: parsing output: 108/ for test: gem_ctx_shared results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: gem_flink_basic results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_hdr results: parsing output: 115/ for test: kms_chamelium_hpd results: parsing output: 116/ for test: kms_rotation_crc results: parsing output: 117/ for test: prime_vgem results: parsing output: 118/ for test: gem_ctx_freq results: parsing output: 119/ for test: kms_cursor_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: perf results: parsing output: 122/ for test: kms_setmode results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_atomic_transition results: parsing output: 125/ for test: kms_atomic_interruptible results: parsing output: 126/ for test: kms_pm_backlight results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_exec_whisper results: parsing output: 130/ for test: gem_spin_batch results: parsing output: 131/ for test: kms_universal_plane results: parsing output: 132/ for test: gem_exec_schedule results: parsing output: 133/ for test: syncobj_wait Done.