[59.111033] Initializing watchdogs [59.111084] /dev/watchdog0 [59.125376] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.129532] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.132411] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.135825] [001/133] (960s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [59.271600] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [59.276121] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [59.411831] [002/133] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [59.502846] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [66.105579] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.597s) [66.229330] [003/133] (953s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [66.327078] Starting subtest: yf-tiled-16bpp-rotate-180 [66.331549] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [66.407208] [004/133] (953s left) i915_drm_fdinfo (memory-info-resident) [66.445640] Starting subtest: memory-info-resident [66.447998] Starting dynamic subtest: smem0 [70.027023] Dynamic subtest smem0: SUCCESS (3.579s) [70.029463] Subtest memory-info-resident: SUCCESS (3.579s) [70.101602] [005/133] (949s left) gem_busy (extended) [70.289712] Starting subtest: extended [70.292509] Starting dynamic subtest: rcs0 [70.384652] Dynamic subtest rcs0: SUCCESS (0.095s) [70.394595] Starting dynamic subtest: bcs0 [70.428597] Dynamic subtest bcs0: SUCCESS (0.043s) [70.437862] Starting dynamic subtest: vcs0 [71.892858] Dynamic subtest vcs0: SUCCESS (1.461s) [71.907920] Starting dynamic subtest: vcs1 [73.941560] Dynamic subtest vcs1: SUCCESS (2.047s) [73.952846] Starting dynamic subtest: vecs0 [75.925620] Dynamic subtest vecs0: SUCCESS (1.982s) [75.938717] Starting dynamic subtest: ccs0 [75.971117] Dynamic subtest ccs0: SUCCESS (0.046s) [75.973610] Subtest extended: SUCCESS (5.681s) [76.201339] [006/133] (943s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [76.299847] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [76.304305] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [77.446995] [007/133] (942s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [77.561234] Starting subtest: 2x-cursor-vs-flip-atomic [77.565815] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s) [77.702083] [008/133] (942s left) kms_flip (modeset-vs-vblank-race) [77.795202] Starting subtest: modeset-vs-vblank-race [77.797642] Starting dynamic subtest: A-eDP1 [82.566481] Dynamic subtest A-eDP1: SUCCESS (4.769s) [82.575831] Starting dynamic subtest: B-eDP1 [87.289352] Dynamic subtest B-eDP1: SUCCESS (4.720s) [87.298776] Starting dynamic subtest: C-eDP1 [91.996705] Dynamic subtest C-eDP1: SUCCESS (4.705s) [92.005861] Starting dynamic subtest: D-eDP1 [96.616253] Dynamic subtest D-eDP1: SUCCESS (4.618s) [96.618551] Subtest modeset-vs-vblank-race: SUCCESS (18.821s) [97.778198] [009/133] (922s left) perf (sysctl-defaults) [97.841086] Starting subtest: sysctl-defaults [97.843561] Subtest sysctl-defaults: SUCCESS (0.000s) [97.954625] [010/133] (922s left) kms_big_fb (x-tiled-16bpp-rotate-180) [98.048922] Starting subtest: x-tiled-16bpp-rotate-180 [99.408284] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.359s) [99.540735] [011/133] (920s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [99.605083] Starting subtest: yf-tiled-to-vebox-x-tiled [99.608875] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [99.783636] [012/133] (920s left) kms_big_fb (y-tiled-32bpp-rotate-0) [99.882259] Starting subtest: y-tiled-32bpp-rotate-0 [99.886603] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [99.971966] [013/133] (920s left) kms_flip (wf_vblank-ts-check) [100.063311] Starting subtest: wf_vblank-ts-check [100.065685] Starting dynamic subtest: A-eDP1 [108.945201] Dynamic subtest A-eDP1: SUCCESS (8.880s) [108.952072] Starting dynamic subtest: B-eDP1 [117.872389] Dynamic subtest B-eDP1: SUCCESS (8.926s) [117.879502] Starting dynamic subtest: C-eDP1 [126.780675] Dynamic subtest C-eDP1: SUCCESS (8.905s) [126.787897] Starting dynamic subtest: D-eDP1 [135.714927] Dynamic subtest D-eDP1: SUCCESS (8.933s) [135.717228] Subtest wf_vblank-ts-check: SUCCESS (35.652s) [136.939432] [014/133] (883s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [137.036218] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [137.040815] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s) [137.109118] [015/133] (883s left) gem_exec_whisper (basic-sync-all) [137.184454] Starting subtest: basic-sync-all [143.868772] Subtest basic-sync-all: SUCCESS (6.682s) [144.053769] [016/133] (876s left) gem_mmap_wc (fault-concurrent) [144.103979] Subtest fault-concurrent: SKIP (0.000s) [144.160769] [017/133] (876s left) kms_psr (fbc-psr2-primary-render) [144.249733] Starting subtest: fbc-psr2-primary-render [144.251825] Starting dynamic subtest: eDP-1 [144.255977] Dynamic subtest eDP-1: SKIP (0.000s) [144.260178] Subtest fbc-psr2-primary-render: SKIP (0.001s) [144.351649] [018/133] (875s left) api_intel_bb (render) [144.399844] Starting subtest: render [144.401736] Starting dynamic subtest: render-none-512 [144.498760] Dynamic subtest render-none-512: SUCCESS (0.100s) [144.508695] Starting dynamic subtest: render-none-1024 [144.874436] Dynamic subtest render-none-1024: SUCCESS (0.374s) [144.884704] Starting dynamic subtest: render-x-512 [144.966780] Dynamic subtest render-x-512: SUCCESS (0.093s) [144.976932] Starting dynamic subtest: render-x-1024 [145.302443] Dynamic subtest render-x-1024: SUCCESS (0.335s) [145.312804] Starting dynamic subtest: render-y-512 [145.388276] Dynamic subtest render-y-512: SUCCESS (0.085s) [145.398499] Starting dynamic subtest: render-y-1024 [145.725109] Dynamic subtest render-y-1024: SUCCESS (0.335s) [145.728060] Subtest render: SUCCESS (1.326s) [145.839894] [019/133] (874s left) gem_close (basic) [145.897747] Starting subtest: basic [145.900189] Subtest basic: SUCCESS (0.000s) [145.986098] [020/133] (874s left) prime_vgem (busy) [146.112281] Starting subtest: busy [146.114591] Starting dynamic subtest: rcs0 [146.155345] Dynamic subtest rcs0: SUCCESS (0.043s) [146.162750] Starting dynamic subtest: bcs0 [146.216402] Dynamic subtest bcs0: SUCCESS (0.060s) [146.223363] Starting dynamic subtest: vcs0 [146.263529] Dynamic subtest vcs0: SUCCESS (0.047s) [146.270626] Starting dynamic subtest: vcs1 [146.308088] Dynamic subtest vcs1: SUCCESS (0.044s) [146.315167] Starting dynamic subtest: vecs0 [146.353783] Dynamic subtest vecs0: SUCCESS (0.045s) [146.360907] Starting dynamic subtest: ccs0 [146.400248] Dynamic subtest ccs0: SUCCESS (0.046s) [146.402373] Subtest busy: SUCCESS (0.289s) [146.514653] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true [146.517683] [021/133] (873s left) kms_chamelium_frames (dp-crc-multiple) [146.915786] Subtest dp-crc-multiple: SKIP (0.000s) [147.760981] [022/133] (872s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [147.840784] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [147.843069] Starting dynamic subtest: pipe-A-eDP-1 [147.865393] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [147.873730] Starting dynamic subtest: pipe-B-eDP-1 [147.894516] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [147.901998] Starting dynamic subtest: pipe-C-eDP-1 [147.922394] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [147.929186] Starting dynamic subtest: pipe-D-eDP-1 [147.950096] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [147.954216] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s) [150.141380] [023/133] (870s left) gem_softpin (allocator-fork) [150.214852] Starting subtest: allocator-fork [152.424608] Subtest allocator-fork: SUCCESS (2.208s) [152.557047] [024/133] (867s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [152.657184] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [152.661173] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [152.727817] [025/133] (867s left) kms_flip_event_leak (basic) [152.817869] Starting subtest: basic [152.820078] Starting dynamic subtest: pipe-A-eDP-1 [153.263073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s) [153.272743] Starting dynamic subtest: pipe-B-eDP-1 [154.373273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.110s) [154.381242] Starting dynamic subtest: pipe-C-eDP-1 [155.470690] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.096s) [155.481692] Starting dynamic subtest: pipe-D-eDP-1 [156.629322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.156s) [156.631522] Subtest basic: SUCCESS (3.811s) [157.463901] [026/133] (863s left) kms_pm_rpm (modeset-non-lpsp-stress) [159.003136] Starting subtest: modeset-non-lpsp-stress [160.161030] Subtest modeset-non-lpsp-stress: SKIP (1.157s) [160.522668] [027/133] (860s left) gem_userptr_blits (vma-merge) [160.598440] Starting subtest: vma-merge [160.636336] Subtest vma-merge: SUCCESS (0.038s) [160.771953] [028/133] (859s left) kms_dsc (dsc-with-bpc) [160.873083] Starting subtest: dsc-with-bpc [160.904057] Subtest dsc-with-bpc: SKIP (0.001s) [160.959167] [029/133] (859s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [161.034430] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [161.036727] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [161.142248] [030/133] (859s left) kms_flip (2x-wf_vblank-ts-check) [161.232065] Starting subtest: 2x-wf_vblank-ts-check [161.240340] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s) [161.319853] [031/133] (859s left) gem_exec_whisper (basic-normal) [161.380290] Starting subtest: basic-normal [164.893052] Subtest basic-normal: SUCCESS (3.512s) [165.079470] [032/133] (855s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [165.173995] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [165.184420] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s) [165.264215] [033/133] (855s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [165.365170] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [165.944180] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.581s) [166.093706] [034/133] (854s left) gem_fenced_exec_thrash (2-spare-fences) [166.141319] Subtest 2-spare-fences: SKIP (0.000s) [166.209185] [035/133] (854s left) kms_prop_blob (invalid-set-prop-any) [166.259106] Starting subtest: invalid-set-prop-any [166.261560] Subtest invalid-set-prop-any: SUCCESS (0.000s) [166.355231] [036/133] (854s left) kms_cursor_crc (cursor-rapid-movement-512x512) [166.618606] Starting subtest: cursor-rapid-movement-512x512 [166.622958] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [166.788406] [037/133] (854s left) gem_mmap_offset (open-flood) [166.838120] Starting subtest: open-flood [188.327673] Subtest open-flood: SUCCESS (21.492s) [188.433808] [038/133] (832s left) kms_plane_multiple (2x-tiling-y) [188.533080] Starting subtest: 2x-tiling-y [188.536482] Subtest 2x-tiling-y: SKIP (0.000s) [188.603764] [039/133] (832s left) sw_sync (sync_merge) [188.638576] Starting subtest: sync_merge [188.640455] Subtest sync_merge: SUCCESS (0.000s) [188.694989] [040/133] (832s left) prime_self_import (basic-llseek-bad) [188.727898] Starting subtest: basic-llseek-bad [188.752714] Subtest basic-llseek-bad: SUCCESS (0.026s) [188.864797] [041/133] (832s left) i915_query (query-topology-kernel-writes) [188.914505] Starting subtest: query-topology-kernel-writes [188.916389] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [189.056976] [042/133] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [189.148272] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [189.151673] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [189.244554] [043/133] (832s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [189.298272] Starting subtest: multi-wait-all-for-submit-available-submitted [189.300187] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [189.399092] [044/133] (831s left) kms_chamelium_audio (hdmi-audio-edid) [189.779269] Subtest hdmi-audio-edid: SKIP (0.000s) [190.622466] [045/133] (830s left) gem_exec_fence (syncobj-channel) [191.073311] Starting subtest: syncobj-channel [192.094989] Subtest syncobj-channel: SUCCESS (1.018s) [192.992478] [046/133] (828s left) gem_exec_flush (basic-uc-rw-default) [193.072527] Starting subtest: basic-uc-rw-default [198.532954] Subtest basic-uc-rw-default: SUCCESS (5.462s) [198.721583] [047/133] (822s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [198.821987] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [205.371092] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.551s) [205.483566] [048/133] (816s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [205.584775] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [205.589046] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [205.687592] [049/133] (815s left) gem_close_race (multigpu-basic-process) [205.745090] Starting subtest: multigpu-basic-process [205.749507] Subtest multigpu-basic-process: SKIP (0.000s) [205.973263] [050/133] (815s left) dumb_buffer (create-clear) [206.025186] Starting subtest: create-clear [240.450943] Subtest create-clear: SUCCESS (34.423s) [240.566751] [051/133] (781s left) gen7_exec_parse (bitmasks) [240.628601] Subtest bitmasks: SKIP (0.000s) [240.702803] [052/133] (780s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [240.812807] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [241.748055] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.934s) [241.870695] [053/133] (779s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [241.960379] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [241.964810] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s) [242.031361] [054/133] (779s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [242.122609] Starting subtest: fbcpsr-farfromfence-mmap-gtt [242.126274] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [242.204932] [055/133] (779s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [242.295619] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [242.297481] Starting dynamic subtest: pipe-A-eDP-1 [242.318142] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [242.327889] Starting dynamic subtest: pipe-B-eDP-1 [242.347357] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [242.358053] Starting dynamic subtest: pipe-C-eDP-1 [242.377334] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [242.384637] Starting dynamic subtest: pipe-D-eDP-1 [242.404491] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [242.407897] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s) [244.524797] [056/133] (777s left) gem_exec_create (forked) [244.582063] Starting subtest: forked [244.584426] Starting dynamic subtest: smem [265.878062] Dynamic subtest smem: SUCCESS (21.296s) [265.880992] Subtest forked: SUCCESS (21.298s) [266.078480] [057/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [266.180708] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [266.184837] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [266.262785] [058/133] (755s left) gem_exec_schedule (manyslice) [266.339620] Starting subtest: manyslice [266.341873] Starting dynamic subtest: rcs0 [270.946526] Dynamic subtest rcs0: SUCCESS (4.615s) [270.957876] Starting dynamic subtest: bcs0 [277.571679] Dynamic subtest bcs0: SUCCESS (6.623s) [277.582078] Starting dynamic subtest: vcs0 [283.656763] Dynamic subtest vcs0: SUCCESS (6.085s) [283.670819] Starting dynamic subtest: vcs1 [289.232099] Dynamic subtest vcs1: SUCCESS (5.573s) [289.244059] Starting dynamic subtest: vecs0 [295.312753] Dynamic subtest vecs0: SUCCESS (6.079s) [295.328556] Starting dynamic subtest: ccs0 [301.475888] Dynamic subtest ccs0: SUCCESS (6.160s) [301.478317] Subtest manyslice: SUCCESS (35.145s) [301.777287] [059/133] (720s left) gem_exec_fence (syncobj-wait) [302.251246] Starting subtest: syncobj-wait [303.932805] Subtest syncobj-wait: SUCCESS (1.680s) [305.915171] [060/133] (716s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [305.968655] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [306.031426] [061/133] (716s left) kms_joiner (invalid-modeset-force-ultra-joiner) [306.121628] Starting subtest: invalid-modeset-force-ultra-joiner [306.125786] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [306.191528] [062/133] (715s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [306.254736] Starting subtest: mixed-tiled-to-y-tiled-ccs [306.258826] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [306.475495] [063/133] (715s left) kms_psr (pr-sprite-render) [306.578093] Starting subtest: pr-sprite-render [306.582297] Subtest pr-sprite-render: SKIP (0.000s) [306.659411] [064/133] (715s left) gem_ctx_isolation (dirty-create) [306.722604] Starting subtest: dirty-create [306.724947] Starting dynamic subtest: rcs0 [306.902518] Dynamic subtest rcs0: SUCCESS (0.179s) [306.913749] Starting dynamic subtest: bcs0 [307.090157] Dynamic subtest bcs0: SUCCESS (0.187s) [307.099633] Starting dynamic subtest: vcs0 [307.285399] Dynamic subtest vcs0: SUCCESS (0.194s) [307.293391] Starting dynamic subtest: vcs1 [309.075122] Dynamic subtest vcs1: SUCCESS (1.789s) [309.083207] Starting dynamic subtest: vecs0 [311.070190] Dynamic subtest vecs0: SUCCESS (1.994s) [311.080077] Starting dynamic subtest: ccs0 [313.154819] Dynamic subtest ccs0: SUCCESS (2.084s) [313.157204] Subtest dirty-create: SUCCESS (6.433s) [313.398238] [065/133] (708s left) kms_color_pipeline (plane-ctm3x4-lut1d) [313.497848] Starting subtest: plane-ctm3x4-lut1d [313.677722] Starting dynamic subtest: pipe-A-plane-0 [314.013791] Dynamic subtest pipe-A-plane-0: FAIL (0.174s) [314.021496] Starting dynamic subtest: pipe-A-plane-1 [314.237552] Dynamic subtest pipe-A-plane-1: FAIL (0.155s) [314.245557] Starting dynamic subtest: pipe-A-plane-2 [314.460864] Dynamic subtest pipe-A-plane-2: FAIL (0.165s) [315.409061] Starting dynamic subtest: pipe-B-plane-0 [315.841245] Dynamic subtest pipe-B-plane-0: FAIL (0.163s) [315.849842] Starting dynamic subtest: pipe-B-plane-1 [316.167346] Dynamic subtest pipe-B-plane-1: FAIL (0.166s) [316.180156] Starting dynamic subtest: pipe-B-plane-2 [316.472058] Dynamic subtest pipe-B-plane-2: FAIL (0.196s) [317.170649] Starting dynamic subtest: pipe-C-plane-0 [317.692663] Dynamic subtest pipe-C-plane-0: FAIL (0.162s) [317.701501] Starting dynamic subtest: pipe-C-plane-1 [318.084473] Dynamic subtest pipe-C-plane-1: FAIL (0.599s) [318.093915] Starting dynamic subtest: pipe-C-plane-2 [318.445692] Dynamic subtest pipe-C-plane-2: FAIL (0.168s) [319.272729] Starting dynamic subtest: pipe-D-plane-0 [319.850734] Dynamic subtest pipe-D-plane-0: FAIL (0.140s) [319.860671] Starting dynamic subtest: pipe-D-plane-1 [320.307220] Dynamic subtest pipe-D-plane-1: FAIL (0.586s) [320.316106] Starting dynamic subtest: pipe-D-plane-2 [320.749221] Dynamic subtest pipe-D-plane-2: FAIL (0.549s) [320.865973] Subtest plane-ctm3x4-lut1d: FAIL (7.368s) [321.685481] [066/133] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [321.791709] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [328.516209] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.726s) [328.649601] [067/133] (693s left) kms_psr (fbc-pr-primary-blt) [328.736960] Starting subtest: fbc-pr-primary-blt [328.741321] Subtest fbc-pr-primary-blt: SKIP (0.000s) [328.807991] [068/133] (693s left) kms_cursor_crc (cursor-offscreen-128x42) [329.038869] Starting subtest: cursor-offscreen-128x42 [329.088715] Subtest cursor-offscreen-128x42: SKIP (0.047s) [329.296435] [069/133] (693s left) gem_exec_schedule (u-semaphore-resolve) [329.360286] Starting subtest: u-semaphore-resolve [329.391065] Subtest u-semaphore-resolve: SUCCESS (0.039s) [329.734458] [070/133] (692s left) kms_plane (pixel-format-x-tiled-modifier) [329.841270] Starting subtest: pixel-format-x-tiled-modifier [329.866687] Starting dynamic subtest: pipe-A-plane-0 [330.533750] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s) [330.547333] Starting dynamic subtest: pipe-A-plane-3 [330.932989] Dynamic subtest pipe-A-plane-3: SUCCESS (0.398s) [330.943908] Starting dynamic subtest: pipe-A-plane-5 [330.947713] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [332.053246] Starting dynamic subtest: pipe-B-plane-0 [332.745120] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s) [332.752840] Starting dynamic subtest: pipe-B-plane-3 [333.200986] Dynamic subtest pipe-B-plane-3: SUCCESS (0.453s) [333.211928] Starting dynamic subtest: pipe-B-plane-5 [333.216731] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [333.520241] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.677s) [334.323787] [071/133] (688s left) gem_mmap_wc (read) [334.399405] Subtest read: SKIP (0.000s) [334.457442] [072/133] (688s left) sw_sync (sync_busy) [334.497961] Starting subtest: sync_busy [334.500170] Subtest sync_busy: SUCCESS (0.002s) [334.574400] [073/133] (688s left) i915_pm_rps (engine-order) [334.636864] Starting subtest: engine-order [340.534119] Subtest engine-order: FAIL (5.839s) [340.597457] [074/133] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [340.717712] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [344.329366] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.615s) [345.561810] [075/133] (677s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [345.651604] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [345.656093] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s) [345.724483] [076/133] (677s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [345.776079] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [345.880619] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s) [345.961308] [077/133] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [346.064642] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [350.539057] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.478s) [351.725987] [078/133] (671s left) gem_exec_fence (basic-busy) [351.907562] Starting subtest: basic-busy [351.910239] Starting dynamic subtest: rcs0 [351.993645] Dynamic subtest rcs0: SUCCESS (0.086s) [352.003725] Starting dynamic subtest: bcs0 [352.045612] Dynamic subtest bcs0: SUCCESS (0.049s) [352.055675] Starting dynamic subtest: vcs0 [352.105049] Dynamic subtest vcs0: SUCCESS (0.057s) [352.116038] Starting dynamic subtest: vcs1 [352.153994] Dynamic subtest vcs1: SUCCESS (0.047s) [352.163554] Starting dynamic subtest: vecs0 [352.203890] Dynamic subtest vecs0: SUCCESS (0.048s) [352.212669] Starting dynamic subtest: ccs0 [352.258662] Dynamic subtest ccs0: SUCCESS (0.052s) [352.261427] Subtest basic-busy: SUCCESS (0.353s) [353.955837] [079/133] (668s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [354.044130] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [358.419901] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.379s) [359.617071] [080/133] (663s left) i915_pm_freq_api (freq-basic-api) [359.679948] Starting subtest: freq-basic-api [359.682345] Starting dynamic subtest: gt0 [359.684816] Dynamic subtest gt0: SUCCESS (0.002s) [359.695302] Starting dynamic subtest: gt1 [359.697228] Dynamic subtest gt1: SUCCESS (0.002s) [359.699149] Subtest freq-basic-api: SUCCESS (0.006s) [359.763489] [081/133] (663s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [360.142443] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [360.925611] [082/133] (662s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [361.026603] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [361.030816] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [361.128124] [083/133] (661s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [361.234481] Starting subtest: psr-rgb101010-draw-blt [368.505458] Subtest psr-rgb101010-draw-blt: SUCCESS (7.273s) [368.618463] [084/133] (654s left) kms_addfb_basic (bad-pitch-128) [368.687203] Starting subtest: bad-pitch-128 [368.689158] Subtest bad-pitch-128: SUCCESS (0.000s) [368.815407] [085/133] (654s left) perf (global-sseu-config-invalid) [368.904266] Starting subtest: global-sseu-config-invalid [368.908940] Subtest global-sseu-config-invalid: SKIP (0.000s) [368.948430] [086/133] (654s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [368.999361] Starting subtest: legacy-engines-hostile-preempt [369.001760] Starting dynamic subtest: render [369.077232] Dynamic subtest render: SUCCESS (0.077s) [369.090973] Starting dynamic subtest: bsd1 [370.836936] Dynamic subtest bsd1: SUCCESS (1.755s) [370.854820] Starting dynamic subtest: bsd2 [371.915797] Dynamic subtest bsd2: SUCCESS (1.076s) [371.927066] Starting dynamic subtest: blt [371.967533] Dynamic subtest blt: SUCCESS (0.050s) [371.977668] Starting dynamic subtest: vebox [373.909604] Dynamic subtest vebox: SUCCESS (1.938s) [373.912315] Subtest legacy-engines-hostile-preempt: SUCCESS (4.910s) [374.021394] [087/133] (649s left) kms_psr (fbc-psr-basic) [374.123847] Starting subtest: fbc-psr-basic [374.126070] Starting dynamic subtest: eDP-1 [374.130033] Dynamic subtest eDP-1: SKIP (0.000s) [374.134214] Subtest fbc-psr-basic: SKIP (0.001s) [374.195771] [088/133] (649s left) kms_async_flips (test-time-stamp) [374.290627] Starting subtest: test-time-stamp [374.668580] Starting dynamic subtest: pipe-A-eDP-1 [375.462249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s) [375.829197] Starting dynamic subtest: pipe-B-eDP-1 [376.587830] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s) [376.961697] Starting dynamic subtest: pipe-C-eDP-1 [377.724404] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s) [378.085635] Starting dynamic subtest: pipe-D-eDP-1 [378.857168] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s) [378.859459] Subtest test-time-stamp: SUCCESS (4.568s) [380.022858] [089/133] (643s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [380.114355] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [380.118147] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [380.206514] [090/133] (643s left) kms_getfb (getfb-handle-not-fb) [380.341412] Starting subtest: getfb-handle-not-fb [380.343740] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [380.435264] [091/133] (642s left) kms_content_protection (mei-interface) [380.576861] Starting subtest: mei-interface [380.581070] Subtest mei-interface: SKIP (0.001s) [380.694597] [092/133] (642s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [380.776933] Starting subtest: plane-upscale-20x20-with-modifiers [380.779215] Starting dynamic subtest: pipe-A [381.112457] Dynamic subtest pipe-A: SUCCESS (0.338s) [381.120179] Starting dynamic subtest: pipe-B [382.513765] Dynamic subtest pipe-B: SUCCESS (1.399s) [382.527472] Starting dynamic subtest: pipe-C [383.949247] Dynamic subtest pipe-C: SUCCESS (1.433s) [383.958058] Starting dynamic subtest: pipe-D [385.383045] Dynamic subtest pipe-D: SUCCESS (1.433s) [385.385735] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.609s) [386.545058] [093/133] (636s left) prime_mmap (test_forked_cpu_write) [386.623032] Starting subtest: test_forked_cpu_write [386.625056] Starting dynamic subtest: test_forked_cpu_write-smem [386.630540] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [386.632837] Subtest test_forked_cpu_write: SUCCESS (0.009s) [386.752732] [094/133] (636s left) gem_eio (wait-10ms) [386.974710] Starting subtest: wait-10ms [387.332648] Subtest wait-10ms: SUCCESS (0.358s) [387.446880] [095/133] (636s left) gem_tiled_fence_blits (normal) [387.525411] Subtest normal: SKIP (0.000s) [387.609025] [096/133] (635s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [387.712057] Starting subtest: fbcpsr-modesetfrombusy [393.911740] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.203s) [394.051016] [097/133] (629s left) kms_addfb_basic (bo-too-small-due-to-tiling) [394.145221] Starting subtest: bo-too-small-due-to-tiling [394.148653] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [394.241588] [098/133] (629s left) gem_media_vme [394.357443] [099/133] (629s left) kms_psr (psr2-suspend) [394.467206] Starting subtest: psr2-suspend [394.469106] Starting dynamic subtest: eDP-1 [412.626994] Dynamic subtest eDP-1: SUCCESS (2.975s) [412.629339] Subtest psr2-suspend: SUCCESS (2.976s) [413.429802] [100/133] (610s left) prime_mmap (test_correct) [413.504429] Starting subtest: test_correct [413.506698] Starting dynamic subtest: test_correct-smem [413.532188] Dynamic subtest test_correct-smem: SUCCESS (0.030s) [413.534745] Subtest test_correct: SUCCESS (0.031s) [413.641041] [101/133] (610s left) vgem_basic (bad-flag) [413.696251] Starting subtest: bad-flag [413.698485] Subtest bad-flag: SUCCESS (0.000s) [413.753555] [102/133] (610s left) gem_mmap_wc (coherency) [413.812880] Subtest coherency: SKIP (0.000s) [413.873339] [103/133] (609s left) kms_pm_lpsp (screens-disabled) [414.972182] Starting subtest: screens-disabled [414.976705] Subtest screens-disabled: SKIP (0.000s) [415.044420] [104/133] (608s left) gem_create (create-invalid-size) [415.106593] Starting subtest: create-invalid-size [415.108617] Subtest create-invalid-size: SUCCESS (0.000s) [415.295555] [105/133] (608s left) syncobj_timeline (single-wait-available-signaled) [415.346832] Starting subtest: single-wait-available-signaled [415.349163] Subtest single-wait-available-signaled: SUCCESS (0.000s) [415.443940] [106/133] (608s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [415.544252] Starting subtest: psr-2p-primscrn-spr-indfb-move [415.548209] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [415.641744] [107/133] (608s left) i915_selftest (live) [418.963795] Starting subtest: live [418.966150] Starting dynamic subtest: sanitycheck [423.282291] Dynamic subtest sanitycheck: SUCCESS (4.297s) [423.296835] Starting dynamic subtest: uncore [425.937452] Dynamic subtest uncore: SUCCESS (2.644s) [425.947130] Starting dynamic subtest: workarounds [429.017270] Dynamic subtest workarounds: SUCCESS (3.071s) [429.026705] Starting dynamic subtest: gt_engines [432.046353] Dynamic subtest gt_engines: SUCCESS (3.022s) [432.055916] Starting dynamic subtest: gt_timelines [447.754751] Dynamic subtest gt_timelines: SUCCESS (15.698s) [447.769450] Starting dynamic subtest: gt_contexts [452.048644] Dynamic subtest gt_contexts: SUCCESS (4.293s) [452.057426] Starting dynamic subtest: gt_lrc [456.297628] Dynamic subtest gt_lrc: SUCCESS (4.247s) [456.311977] Starting dynamic subtest: gt_mocs [459.143850] Dynamic subtest gt_mocs: SUCCESS (2.845s) [459.153128] Starting dynamic subtest: gt_pm [465.901774] Dynamic subtest gt_pm: SUCCESS (6.754s) [465.910231] Starting dynamic subtest: gt_heartbeat [470.642692] Dynamic subtest gt_heartbeat: SUCCESS (4.739s) [470.664266] Starting dynamic subtest: gt_tlb [479.955823] Dynamic subtest gt_tlb: SUCCESS (9.309s) [479.965583] Starting dynamic subtest: requests [491.370863] Dynamic subtest requests: SUCCESS (11.409s) [491.380839] Starting dynamic subtest: migrate [499.032097] Dynamic subtest migrate: SUCCESS (7.657s) [499.041795] Starting dynamic subtest: active [503.323720] Dynamic subtest active: SUCCESS (4.288s) [503.333208] Starting dynamic subtest: objects [507.847109] Dynamic subtest objects: SUCCESS (4.521s) [507.856611] Starting dynamic subtest: mman [512.526280] Dynamic subtest mman: SUCCESS (4.678s) [512.535347] Starting dynamic subtest: dmabuf [516.792434] Dynamic subtest dmabuf: SUCCESS (4.265s) [516.802097] Starting dynamic subtest: vma [521.067790] Dynamic subtest vma: SUCCESS (4.274s) [521.077199] Starting dynamic subtest: coherency [524.545968] Dynamic subtest coherency: SUCCESS (3.477s) [524.554983] Starting dynamic subtest: gtt [534.252191] Dynamic subtest gtt: SUCCESS (9.705s) [534.262209] Starting dynamic subtest: gem [541.741875] Dynamic subtest gem: SUCCESS (7.488s) [541.751195] Starting dynamic subtest: evict [547.202545] Dynamic subtest evict: SUCCESS (5.457s) [547.212003] Starting dynamic subtest: hugepages [555.990090] Dynamic subtest hugepages: SUCCESS (8.784s) [555.999066] Starting dynamic subtest: gem_contexts [584.985587] Dynamic subtest gem_contexts: SUCCESS (28.988s) [584.995374] Starting dynamic subtest: client [589.234055] Dynamic subtest client: SUCCESS (4.246s) [589.243807] Starting dynamic subtest: gem_migrate [591.892383] Dynamic subtest gem_migrate: SUCCESS (2.656s) [591.902099] Starting dynamic subtest: reset [596.184061] Dynamic subtest reset: SUCCESS (4.288s) [596.193600] Starting dynamic subtest: memory_region [600.539214] Dynamic subtest memory_region: SUCCESS (4.352s) [600.548812] Starting dynamic subtest: hangcheck [613.264930] Dynamic subtest hangcheck: SUCCESS (12.720s) [613.273643] Starting dynamic subtest: execlists [617.544884] Dynamic subtest execlists: SUCCESS (4.277s) [617.554613] Starting dynamic subtest: ring_submission [621.797493] Dynamic subtest ring_submission: SUCCESS (4.250s) [621.805681] Starting dynamic subtest: perf [626.130371] Dynamic subtest perf: SUCCESS (4.330s) [626.139788] Starting dynamic subtest: slpc [640.167396] Dynamic subtest slpc: SUCCESS (14.032s) [640.176077] Starting dynamic subtest: guc [643.990610] Dynamic subtest guc: SUCCESS (3.823s) [644.000703] Starting dynamic subtest: guc_multi_lrc [648.314093] Dynamic subtest guc_multi_lrc: SUCCESS (4.322s) [648.323738] Starting dynamic subtest: guc_hang [653.201602] Dynamic subtest guc_hang: SUCCESS (4.886s) [653.210860] Starting dynamic subtest: late_gt_pm [655.892938] Dynamic subtest late_gt_pm: SUCCESS (2.690s) [655.895733] Subtest live: SUCCESS (236.848s) [655.923447] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [655.924186] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [655.927410] [108/133] (368s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [657.505464] Starting subtest: 2x-flip-vs-cursor-atomic [657.510099] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [657.679748] [FACT kms_cursor_legacy (2x-flip-vs-cursor-atomic)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [657.681077] [FACT kms_cursor_legacy (2x-flip-vs-cursor-atomic)] new: kernel.kmod_is_loaded.i915: true [657.685126] [109/133] (366s left) gem_ctx_shared (single-timeline) [657.765542] Starting subtest: single-timeline [657.791608] Subtest single-timeline: SUCCESS (0.018s) [658.023365] [110/133] (366s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [658.138949] Starting subtest: short-busy-flip-before-cursor-toggle [658.144209] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [658.278720] [111/133] (365s left) perf_pmu (event-wait) [658.319749] Starting subtest: event-wait [658.322264] Starting dynamic subtest: rcs0 [658.326747] Dynamic subtest rcs0: SKIP (0.000s) [658.331268] Subtest event-wait: SKIP (0.001s) [658.411385] [112/133] (365s left) gem_mmap_wc (pf-nonblock) [658.468631] Subtest pf-nonblock: SKIP (0.000s) [658.524073] [113/133] (365s left) gem_eio (reset-stress) [658.662837] Starting subtest: reset-stress [658.665328] Starting dynamic subtest: render [661.927690] Dynamic subtest render: SUCCESS (3.263s) [661.942097] Starting dynamic subtest: bsd1 [679.452279] Dynamic subtest bsd1: SUCCESS (17.525s) [679.468710] Starting dynamic subtest: bsd2 [697.406601] Dynamic subtest bsd2: SUCCESS (17.953s) [697.421999] Starting dynamic subtest: blt [697.426316] Dynamic subtest blt: SKIP (0.000s) [697.434263] Starting dynamic subtest: vebox [715.432708] Dynamic subtest vebox: SUCCESS (18.023s) [715.434775] Subtest reset-stress: SUCCESS (56.769s) [717.129458] [114/133] (307s left) gem_exec_balancer (bonded-true-hang) [717.393277] Starting subtest: bonded-true-hang [717.398369] Subtest bonded-true-hang: SKIP (0.000s) [717.502113] [115/133] (306s left) api_intel_allocator (standalone) [717.552604] Starting subtest: standalone [717.566501] Subtest standalone: SUCCESS (0.016s) [717.693717] [116/133] (306s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [717.791984] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [717.796293] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [717.888853] [117/133] (306s left) kms_vblank (wait-forked-busy-hang) [717.978792] Starting subtest: wait-forked-busy-hang [717.981074] Starting dynamic subtest: pipe-A-eDP-1 [744.874282] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.890s) [744.887184] Starting dynamic subtest: pipe-D-eDP-1 [759.850892] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s) [759.853655] Subtest wait-forked-busy-hang: SUCCESS (41.868s) [760.689940] [118/133] (263s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [760.784979] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [760.787700] Starting dynamic subtest: pipe-A-eDP-1 [760.814750] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [760.823547] Starting dynamic subtest: pipe-B-eDP-1 [760.844097] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [760.852565] Starting dynamic subtest: pipe-C-eDP-1 [760.873927] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [760.881847] Starting dynamic subtest: pipe-D-eDP-1 [760.903736] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [760.907785] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [763.034303] [119/133] (261s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [763.152560] Starting subtest: cursor-tearing-framebuffer-change [763.154742] Starting dynamic subtest: pipe-A-eDP-1 [763.720725] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s) [763.732891] Starting dynamic subtest: pipe-D-eDP-1 [764.972428] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s) [764.974283] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.821s) [765.801245] [120/133] (258s left) gem_exec_params (cliprects_ptr-dirt) [765.866104] Starting subtest: cliprects_ptr-dirt [765.868519] Subtest cliprects_ptr-dirt: SUCCESS (0.001s) [765.965383] [121/133] (258s left) syncobj_timeline (etime-single-wait-all-submitted) [766.011870] Starting subtest: etime-single-wait-all-submitted [766.119813] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s) [766.199417] [122/133] (258s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [766.315674] Starting subtest: cursorB-vs-flipA-toggle [766.320246] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [766.471670] [123/133] (258s left) kms_psr (psr-primary-render) [766.566094] Starting subtest: psr-primary-render [766.568655] Starting dynamic subtest: eDP-1 [768.321010] Dynamic subtest eDP-1: SUCCESS (1.754s) [768.323237] Subtest psr-primary-render: SUCCESS (1.755s) [769.176058] [124/133] (255s left) kms_vblank (query-busy) [769.267506] Starting subtest: query-busy [769.269796] Starting dynamic subtest: pipe-A-eDP-1 [771.154097] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s) [771.168323] Starting dynamic subtest: pipe-D-eDP-1 [773.740732] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.586s) [773.743201] Subtest query-busy: SUCCESS (4.475s) [774.542679] [125/133] (250s left) kms_pipe_crc_basic (read-crc-frame-sequence) [774.645933] Starting subtest: read-crc-frame-sequence [774.647790] Starting dynamic subtest: pipe-A-eDP-1 [775.350680] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s) [775.360043] Starting dynamic subtest: pipe-B-eDP-1 [776.713396] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.360s) [776.726270] Starting dynamic subtest: pipe-C-eDP-1 [778.012215] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s) [778.022336] Starting dynamic subtest: pipe-D-eDP-1 [779.324550] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s) [779.326923] Subtest read-crc-frame-sequence: SUCCESS (4.680s) [780.164267] [126/133] (244s left) i915_query (query-garbage) [780.214261] Starting subtest: query-garbage [780.216149] Subtest query-garbage: SUCCESS (0.000s) [780.305286] [127/133] (244s left) kms_lease (cursor-implicit-plane) [780.393374] Starting subtest: cursor-implicit-plane [780.395594] Starting dynamic subtest: pipe-A-eDP-1 [780.851642] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s) [780.860645] Starting dynamic subtest: pipe-B-eDP-1 [781.973323] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.121s) [781.985186] Starting dynamic subtest: pipe-C-eDP-1 [783.081476] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s) [783.091005] Starting dynamic subtest: pipe-D-eDP-1 [784.222197] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s) [784.224549] Subtest cursor-implicit-plane: SUCCESS (3.830s) [785.084673] [128/133] (239s left) gem_exec_reloc (basic-cpu-noreloc) [785.153356] Subtest basic-cpu-noreloc: SKIP (0.000s) [785.212889] [129/133] (239s left) kms_atomic_interruptible (legacy-setmode) [785.303472] Starting subtest: legacy-setmode [785.305580] Starting dynamic subtest: pipe-A-eDP-1 [792.227150] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.920s) [792.229323] Subtest legacy-setmode: SUCCESS (6.921s) [793.110570] [130/133] (231s left) kms_async_flips (async-flip-with-page-flip-events-linear) [793.204011] Starting subtest: async-flip-with-page-flip-events-linear [793.584453] Starting dynamic subtest: pipe-A-eDP-1 [796.366429] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.781s) [796.731605] Starting dynamic subtest: pipe-B-eDP-1 [799.493298] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s) [799.855265] Starting dynamic subtest: pipe-C-eDP-1 [802.622002] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s) [802.991349] Starting dynamic subtest: pipe-D-eDP-1 [805.761583] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s) [805.764088] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.556s) [806.951973] [131/133] (218s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [807.047759] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [814.905422] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.859s) [815.021556] [132/133] (209s left) kms_flip (basic-plain-flip) [815.122660] Starting subtest: basic-plain-flip [815.124630] Starting dynamic subtest: A-eDP1 [816.773112] Dynamic subtest A-eDP1: SUCCESS (1.652s) [816.785228] Starting dynamic subtest: B-eDP1 [818.410597] Dynamic subtest B-eDP1: SUCCESS (1.634s) [818.421966] Starting dynamic subtest: C-eDP1 [820.051351] Dynamic subtest C-eDP1: SUCCESS (1.628s) [820.063614] Starting dynamic subtest: D-eDP1 [821.672852] Dynamic subtest D-eDP1: SUCCESS (1.631s) [821.675241] Subtest basic-plain-flip: SUCCESS (6.555s) [822.840931] [133/133] (202s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [822.932268] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [822.936163] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [823.051421] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_legacy results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: i915_drm_fdinfo results: parsing output: 4/ for test: gem_busy results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: perf results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: gem_render_copy results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_flip_scaled_crc results: parsing output: 14/ for test: gem_exec_whisper results: parsing output: 15/ for test: gem_mmap_wc results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: api_intel_bb results: parsing output: 18/ for test: gem_close results: parsing output: 19/ for test: prime_vgem results: parsing output: 20/ for test: kms_chamelium_frames results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: gem_softpin results: parsing output: 23/ for test: kms_psr2_sf results: parsing output: 24/ for test: kms_flip_event_leak results: parsing output: 25/ for test: kms_pm_rpm results: parsing output: 26/ for test: gem_userptr_blits results: parsing output: 27/ for test: kms_dsc results: parsing output: 28/ for test: syncobj_timeline results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: gem_exec_whisper results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: gem_fenced_exec_thrash results: parsing output: 34/ for test: kms_prop_blob results: parsing output: 35/ for test: kms_cursor_crc results: parsing output: 36/ for test: gem_mmap_offset results: parsing output: 37/ for test: kms_plane_multiple results: parsing output: 38/ for test: sw_sync results: parsing output: 39/ for test: prime_self_import results: parsing output: 40/ for test: i915_query results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: kms_chamelium_audio results: parsing output: 44/ for test: gem_exec_fence results: parsing output: 45/ for test: gem_exec_flush results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_close_race results: parsing output: 49/ for test: dumb_buffer results: parsing output: 50/ for test: gen7_exec_parse results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: kms_flip_scaled_crc results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: gem_exec_create results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_exec_schedule results: parsing output: 58/ for test: gem_exec_fence results: parsing output: 59/ for test: kms_pipe_b_c_ivb results: parsing output: 60/ for test: kms_joiner results: parsing output: 61/ for test: gem_render_copy results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: gem_ctx_isolation results: parsing output: 64/ for test: kms_color_pipeline results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_psr results: parsing output: 67/ for test: kms_cursor_crc results: parsing output: 68/ for test: gem_exec_schedule results: parsing output: 69/ for test: kms_plane results: parsing output: 70/ for test: gem_mmap_wc results: parsing output: 71/ for test: sw_sync results: parsing output: 72/ for test: i915_pm_rps results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_plane results: parsing output: 75/ for test: syncobj_timeline results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_exec_fence results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: i915_pm_freq_api results: parsing output: 80/ for test: kms_chamelium_hpd results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: perf results: parsing output: 85/ for test: gem_ctx_persistence results: parsing output: 86/ for test: kms_psr results: parsing output: 87/ for test: kms_async_flips results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_getfb results: parsing output: 90/ for test: kms_content_protection results: parsing output: 91/ for test: kms_plane_scaling results: parsing output: 92/ for test: prime_mmap results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_tiled_fence_blits results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_addfb_basic results: parsing output: 97/ for test: gem_media_vme results: parsing output: 98/ for test: kms_psr results: parsing output: 99/ for test: prime_mmap results: parsing output: 100/ for test: vgem_basic results: parsing output: 101/ for test: gem_mmap_wc results: parsing output: 102/ for test: kms_pm_lpsp results: parsing output: 103/ for test: gem_create results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: i915_selftest results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: gem_ctx_shared results: parsing output: 109/ for test: kms_cursor_legacy results: parsing output: 110/ for test: perf_pmu results: parsing output: 111/ for test: gem_mmap_wc results: parsing output: 112/ for test: gem_eio results: parsing output: 113/ for test: gem_exec_balancer results: parsing output: 114/ for test: api_intel_allocator results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: kms_vblank results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: kms_cursor_crc results: parsing output: 119/ for test: gem_exec_params results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: kms_psr results: parsing output: 123/ for test: kms_vblank results: parsing output: 124/ for test: kms_pipe_crc_basic results: parsing output: 125/ for test: i915_query results: parsing output: 126/ for test: kms_lease results: parsing output: 127/ for test: gem_exec_reloc results: parsing output: 128/ for test: kms_atomic_interruptible results: parsing output: 129/ for test: kms_async_flips results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_flip results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.