[58.354731] Initializing watchdogs [58.354776] /dev/watchdog0 [58.369037] [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] [58.373479] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.375837] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.379899] [001/155] (960s left) gem_exec_gttfill (multigpu-basic) [58.590259] Starting subtest: multigpu-basic [72.457524] Subtest multigpu-basic: SUCCESS (13.739s) [72.551343] [002/155] (946s left) gem_ctx_persistence (hang) [72.727646] Starting subtest: hang [72.732666] Subtest hang: SKIP (0.000s) [72.934631] [003/155] (946s left) gem_exec_params (invalid-bsd1-flag-on-blt) [73.015574] Starting subtest: invalid-bsd1-flag-on-blt [73.017991] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [73.249406] [004/155] (945s left) gem_exec_balancer (full) [73.303826] Starting subtest: full [78.167694] Subtest full: SUCCESS (4.853s) [78.487718] [005/155] (940s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [78.595517] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [78.597687] Starting dynamic subtest: pipe-A-eDP-1 [78.709473] Dynamic subtest pipe-A-eDP-1: SKIP (0.116s) [78.720389] Starting dynamic subtest: pipe-B-eDP-1 [79.825075] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s) [79.829823] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.232s) [81.221257] [006/155] (937s left) kms_big_fb (x-tiled-8bpp-rotate-270) [81.332742] Starting subtest: x-tiled-8bpp-rotate-270 [81.355349] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s) [81.454162] [007/155] (937s left) kms_vblank (ts-continuation-idle) [81.559329] Starting subtest: ts-continuation-idle [81.561549] Starting dynamic subtest: pipe-A-eDP-1 [81.957944] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s) [81.972347] Starting dynamic subtest: pipe-D-eDP-1 [83.021440] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.063s) [83.023713] Subtest ts-continuation-idle: SUCCESS (1.462s) [83.886188] [008/155] (935s left) kms_dp_link_training (uhbr-sst) [83.980370] Starting subtest: uhbr-sst [83.989450] Subtest uhbr-sst: SKIP (0.000s) [84.051084] [009/155] (935s left) kms_draw_crc (draw-method-mmap-gtt) [84.143864] Starting subtest: draw-method-mmap-gtt [84.148425] Subtest draw-method-mmap-gtt: SKIP (0.000s) [84.244491] [010/155] (935s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff) [84.350591] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff [84.355085] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [84.446884] [011/155] (934s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [84.498098] Starting subtest: yf-tiled-to-vebox-x-tiled [84.502478] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [84.703916] [012/155] (934s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render) [84.811037] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render [84.815679] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [84.908592] [013/155] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [85.004659] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [85.009238] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [85.089872] [014/155] (934s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move) [85.191737] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move [85.195789] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [85.293105] [015/155] (934s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [85.391550] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [85.393807] Starting dynamic subtest: pipe-A [85.414496] Dynamic subtest pipe-A: SKIP (0.017s) [85.424149] Starting dynamic subtest: pipe-B [85.443700] Dynamic subtest pipe-B: SKIP (0.031s) [85.452127] Starting dynamic subtest: pipe-C [85.478055] Dynamic subtest pipe-C: SKIP (0.034s) [85.486355] Starting dynamic subtest: pipe-D [85.507297] Dynamic subtest pipe-D: SKIP (0.030s) [85.510991] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.112s) [85.600923] [016/155] (933s left) api_intel_allocator (simple-allocator) [85.662242] Starting subtest: simple-allocator [85.664365] Starting dynamic subtest: basic [85.666406] Dynamic subtest basic: SUCCESS (0.004s) [85.675938] Starting dynamic subtest: parallel-one [85.840855] Dynamic subtest parallel-one: SUCCESS (0.175s) [85.849446] Starting dynamic subtest: print [85.851419] Dynamic subtest print: SUCCESS (0.000s) [85.860514] Starting dynamic subtest: reuse [85.862789] Dynamic subtest reuse: SUCCESS (0.000s) [85.870665] Starting dynamic subtest: reserve [85.872960] Dynamic subtest reserve: SUCCESS (0.000s) [85.880796] Starting dynamic subtest: fork-reopen-allocator [85.883114] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [85.885358] Subtest simple-allocator: SUCCESS (0.192s) [85.985207] [017/155] (933s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [86.085042] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [90.359725] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.277s) [91.530629] [018/155] (928s left) kms_flip (2x-flip-vs-suspend-interruptible) [91.625962] Starting subtest: 2x-flip-vs-suspend-interruptible [91.630630] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s) [91.729729] [019/155] (927s left) gem_exec_whisper (basic-normal) [91.789251] Starting subtest: basic-normal [95.507339] Subtest basic-normal: SUCCESS (3.716s) [95.699914] [020/155] (923s left) dumb_buffer (invalid-bpp) [95.752805] Starting subtest: invalid-bpp [95.755283] Subtest invalid-bpp: SUCCESS (0.000s) [95.867988] [021/155] (923s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [95.963191] Starting subtest: pr-cursor-plane-move-continuous-sf [95.967392] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [96.032123] [022/155] (923s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt) [96.133342] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt [96.137476] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [96.216869] [023/155] (923s left) kms_psr (fbc-psr-sprite-blt) [96.306881] Starting subtest: fbc-psr-sprite-blt [96.309248] Starting dynamic subtest: eDP-1 [96.313569] Dynamic subtest eDP-1: SKIP (0.000s) [96.318022] Subtest fbc-psr-sprite-blt: SKIP (0.000s) [96.374159] [024/155] (923s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [96.769829] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [97.584858] [025/155] (922s left) gem_close_race (basic-threads) [97.663643] Starting subtest: basic-threads [99.074981] Subtest basic-threads: SUCCESS (1.410s) [99.259972] [026/155] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [99.366178] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [102.988959] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.628s) [104.211522] [027/155] (915s left) kms_pm_dc (dc5-psr) [105.330132] Starting subtest: dc5-psr [108.217644] Subtest dc5-psr: SUCCESS (2.885s) [109.030676] [028/155] (910s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-render) [109.134485] Starting subtest: fbchdr-rgb565-draw-render [109.143536] Subtest fbchdr-rgb565-draw-render: SKIP (0.000s) [109.251396] [029/155] (910s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt) [109.345572] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt [109.349985] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [109.457034] [030/155] (910s left) gem_exec_whisper (basic-queues-priority-all) [109.519375] Starting subtest: basic-queues-priority-all [131.638203] Subtest basic-queues-priority-all: SUCCESS (22.112s) [131.818124] [031/155] (888s left) syncobj_timeline (wait-any-complex) [131.870336] Starting subtest: wait-any-complex [131.934042] Subtest wait-any-complex: SUCCESS (0.063s) [132.020155] [032/155] (888s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [132.122262] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [132.134690] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [132.203573] [033/155] (887s left) kms_big_fb (linear-32bpp-rotate-90) [132.301759] Starting subtest: linear-32bpp-rotate-90 [132.321483] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [132.429824] [034/155] (887s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [132.533151] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [132.537333] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [132.631604] [035/155] (887s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [132.724152] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [132.726462] Starting dynamic subtest: pipe-A [132.748287] Dynamic subtest pipe-A: SKIP (0.017s) [132.758576] Starting dynamic subtest: pipe-B [132.774549] Dynamic subtest pipe-B: SKIP (0.029s) [132.783163] Starting dynamic subtest: pipe-C [132.809726] Dynamic subtest pipe-C: SKIP (0.034s) [132.818129] Starting dynamic subtest: pipe-D [132.837769] Dynamic subtest pipe-D: SKIP (0.029s) [132.841349] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.110s) [132.944944] [036/155] (887s left) syncobj_basic (bad-destroy) [132.989501] Starting subtest: bad-destroy [132.991219] Subtest bad-destroy: SUCCESS (0.000s) [133.087144] [037/155] (887s left) kms_flip (2x-flip-vs-expired-vblank) [133.183507] Starting subtest: 2x-flip-vs-expired-vblank [133.194895] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s) [133.307506] [038/155] (887s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [133.411843] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [134.225513] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s) [134.396225] [039/155] (886s left) kms_addfb_basic (unused-pitches) [134.450653] Starting subtest: unused-pitches [134.452561] Subtest unused-pitches: SUCCESS (0.000s) [134.605183] [040/155] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [134.713159] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [134.717189] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [134.829317] [041/155] (885s left) kms_chamelium_color (ctm-green-to-red) [134.926079] Subtest ctm-green-to-red: SKIP (0.000s) [134.967330] [042/155] (885s left) perf_pmu (init-busy) [135.003222] Starting subtest: init-busy [135.005512] Starting dynamic subtest: rcs0 [135.008136] Dynamic subtest rcs0: SUCCESS (0.001s) [135.018007] Starting dynamic subtest: bcs0 [135.019904] Dynamic subtest bcs0: SUCCESS (0.000s) [135.028383] Starting dynamic subtest: vcs0 [135.030239] Dynamic subtest vcs0: SUCCESS (0.000s) [135.038375] Starting dynamic subtest: vcs1 [135.040227] Dynamic subtest vcs1: SUCCESS (0.000s) [135.048608] Starting dynamic subtest: vecs0 [135.050802] Dynamic subtest vecs0: SUCCESS (0.001s) [135.059036] Starting dynamic subtest: ccs0 [135.060948] Dynamic subtest ccs0: SUCCESS (0.000s) [135.062916] Subtest init-busy: SUCCESS (0.005s) [135.101261] [043/155] (885s left) i915_suspend (fence-restore-untiled) [135.159635] Starting subtest: fence-restore-untiled [135.163629] Subtest fence-restore-untiled: SKIP (0.000s) [135.276195] [044/155] (885s left) gem_exec_reloc (basic-range-active) [135.335262] Subtest basic-range-active: SKIP (0.000s) [135.409900] [045/155] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [135.502211] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [139.961311] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.463s) [141.133346] [046/155] (879s left) kms_getfb (getfb-addfb-different-handles) [141.232373] Starting subtest: getfb-addfb-different-handles [141.234719] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [141.348944] [047/155] (879s left) dumb_buffer (map-valid) [141.402836] Starting subtest: map-valid [141.405080] Subtest map-valid: SUCCESS (0.000s) [141.527751] [048/155] (879s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [141.621151] Starting subtest: plane-all-transition-nonblocking-fencing [141.623381] Starting dynamic subtest: pipe-A-eDP-1 [144.114333] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [144.440128] Starting dynamic subtest: pipe-B-eDP-1 [147.649374] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.219s) [147.950495] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.331s) [148.793194] [049/155] (872s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [148.853225] Starting subtest: single-wait-all-for-submit-unsubmitted [148.959446] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [149.044645] [050/155] (871s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [149.137266] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [149.141146] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [149.234964] [051/155] (871s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [149.287263] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [149.289550] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [149.404894] [052/155] (871s left) gem_exec_schedule (independent) [149.475546] Starting subtest: independent [149.477621] Starting dynamic subtest: rcs0 [151.299986] Dynamic subtest rcs0: SUCCESS (1.832s) [151.310884] Starting dynamic subtest: vcs0 [153.315984] Dynamic subtest vcs0: SUCCESS (2.015s) [153.329069] Starting dynamic subtest: vcs1 [155.280299] Dynamic subtest vcs1: SUCCESS (1.962s) [155.293039] Starting dynamic subtest: vecs0 [157.326263] Dynamic subtest vecs0: SUCCESS (2.045s) [157.340230] Starting dynamic subtest: ccs0 [159.298265] Dynamic subtest ccs0: SUCCESS (1.970s) [159.300982] Subtest independent: SUCCESS (9.832s) [159.599929] [053/155] (861s left) kms_frontbuffer_tracking (basic) [159.704624] Starting subtest: basic [162.811037] Subtest basic: SUCCESS (3.112s) [162.926849] [054/155] (858s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [163.028514] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [169.660984] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.636s) [169.773582] [055/155] (851s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [169.840399] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [169.894723] [056/155] (851s left) kms_universal_plane (universal-plane-pageflip-windowed) [169.990639] Starting subtest: universal-plane-pageflip-windowed [169.993385] Starting dynamic subtest: pipe-A-eDP-1 [170.532071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s) [170.541312] Starting dynamic subtest: pipe-B-eDP-1 [171.705086] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s) [171.714864] Starting dynamic subtest: pipe-C-eDP-1 [172.913466] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s) [172.923905] Starting dynamic subtest: pipe-D-eDP-1 [174.148075] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s) [174.150480] Subtest universal-plane-pageflip-windowed: SUCCESS (4.161s) [175.029613] [057/155] (846s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [175.085522] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [175.157162] [058/155] (846s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [175.255083] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [182.216137] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.965s) [182.373063] [059/155] (838s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [182.469191] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [182.473828] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [183.598607] [060/155] (837s left) gem_exec_reloc (basic-write-gtt) [183.655725] Subtest basic-write-gtt: SKIP (0.000s) [183.727908] [061/155] (837s left) perf (rc6-disable) [183.864072] Starting subtest: rc6-disable [184.045720] Subtest rc6-disable: SUCCESS (0.183s) [184.085877] [062/155] (837s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [184.188229] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [184.192319] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [184.292764] [063/155] (837s left) prime_mmap_kms (buffer-sharing) [184.387765] Starting subtest: buffer-sharing [184.825785] Subtest buffer-sharing: SUCCESS (0.437s) [185.633206] [064/155] (835s left) kms_busy (extended-pageflip-hang-oldfb) [185.728130] Starting subtest: extended-pageflip-hang-oldfb [185.730504] Starting dynamic subtest: pipe-A [186.127449] Dynamic subtest pipe-A: SUCCESS (0.399s) [186.137071] Starting dynamic subtest: pipe-D [187.250127] Dynamic subtest pipe-D: SUCCESS (1.119s) [187.252452] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.524s) [188.092443] [065/155] (833s left) gem_userptr_blits (invalid-mmap-offset-unsync) [188.148640] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [188.261537] [066/155] (833s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [188.348193] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [188.373860] Starting dynamic subtest: pipe-A-plane-0 [188.653646] Dynamic subtest pipe-A-plane-0: SUCCESS (0.278s) [188.665280] Starting dynamic subtest: pipe-A-plane-3 [188.863505] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s) [188.872865] Starting dynamic subtest: pipe-A-plane-5 [188.877435] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [189.981676] Starting dynamic subtest: pipe-B-plane-0 [190.261597] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s) [190.270739] Starting dynamic subtest: pipe-B-plane-3 [190.472701] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s) [190.484753] Starting dynamic subtest: pipe-B-plane-5 [190.489444] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [190.787516] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.441s) [191.651854] [067/155] (829s left) kms_invalid_mode (clock-too-high) [191.744201] Starting subtest: clock-too-high [191.746592] Starting dynamic subtest: pipe-A-eDP-1 [192.029686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [192.039916] Starting dynamic subtest: pipe-B-eDP-1 [192.044428] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [192.053420] Starting dynamic subtest: pipe-C-eDP-1 [192.057883] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [192.067042] Starting dynamic subtest: pipe-D-eDP-1 [192.071742] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [192.074099] Subtest clock-too-high: SUCCESS (0.289s) [192.876699] [068/155] (828s left) gem_ctx_shared (q-in-order) [192.934203] Starting subtest: Q-in-order [192.936822] Starting dynamic subtest: rcs0 [193.086011] Dynamic subtest rcs0: SUCCESS (0.151s) [193.101624] Starting dynamic subtest: vcs0 [193.170356] Dynamic subtest vcs0: SUCCESS (0.083s) [193.185814] Starting dynamic subtest: vcs1 [193.247285] Dynamic subtest vcs1: SUCCESS (0.076s) [193.263820] Starting dynamic subtest: vecs0 [193.318787] Dynamic subtest vecs0: SUCCESS (0.069s) [193.335108] Starting dynamic subtest: ccs0 [193.399375] Dynamic subtest ccs0: SUCCESS (0.080s) [193.402375] Subtest Q-in-order: SUCCESS (0.465s) [194.401197] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true [194.404716] [069/155] (827s left) gen9_exec_parse (valid-registers) [194.457053] Subtest valid-registers: SKIP (0.000s) [194.518718] [070/155] (827s left) gen7_exec_parse (oacontrol-tracking) [194.580881] Subtest oacontrol-tracking: SKIP (0.000s) [194.662294] [071/155] (827s left) gem_ctx_persistence (file) [194.727701] Starting subtest: file [194.848682] Subtest file: SUCCESS (0.123s) [194.972806] [072/155] (826s left) syncobj_timeline (invalid-query-zero-handles) [195.030256] Starting subtest: invalid-query-zero-handles [195.032532] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [195.134450] [073/155] (826s left) gem_exec_params (dr4-dirt) [195.187771] Starting subtest: DR4-dirt [195.190125] Subtest DR4-dirt: SUCCESS (0.000s) [195.283220] [074/155] (826s left) kms_psr (fbc-psr2-cursor-blt) [195.385224] Starting subtest: fbc-psr2-cursor-blt [195.387116] Starting dynamic subtest: eDP-1 [195.390691] Dynamic subtest eDP-1: SKIP (0.000s) [195.394275] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [195.482711] [075/155] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [195.572663] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [195.576228] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [195.676377] [076/155] (826s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc) [195.775532] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc [195.779112] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [195.891648] [077/155] (826s left) perf (non-system-wide-paranoid) [195.991406] Starting subtest: non-system-wide-paranoid [196.012844] Subtest non-system-wide-paranoid: SUCCESS (0.022s) [196.051902] [078/155] (825s left) perf_pmu (busy-hang) [196.088321] Starting subtest: busy-hang [196.090294] Starting dynamic subtest: rcs0 [197.370027] Dynamic subtest rcs0: SUCCESS (1.278s) [197.379421] Starting dynamic subtest: bcs0 [198.605097] Dynamic subtest bcs0: SUCCESS (1.233s) [198.614762] Starting dynamic subtest: vcs0 [200.833360] Dynamic subtest vcs0: SUCCESS (2.229s) [200.844988] Starting dynamic subtest: vcs1 [202.822047] Dynamic subtest vcs1: SUCCESS (1.987s) [202.833554] Starting dynamic subtest: vecs0 [204.800154] Dynamic subtest vecs0: SUCCESS (1.976s) [204.810812] Starting dynamic subtest: ccs0 [206.039228] Dynamic subtest ccs0: SUCCESS (1.237s) [206.041871] Subtest busy-hang: SUCCESS (9.951s) [206.139764] [079/155] (815s left) gem_partial_pwrite_pread (writes-after-reads) [206.199075] Subtest writes-after-reads: SKIP (0.000s) [206.258386] [080/155] (815s left) gem_exec_reloc (basic-gtt-active) [206.325810] Subtest basic-gtt-active: SKIP (0.000s) [206.406661] [081/155] (815s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt) [206.501538] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt [206.505537] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [206.601700] [082/155] (815s left) gem_mmap_wc (pf-nonblock) [206.653628] Subtest pf-nonblock: SKIP (0.000s) [206.719849] [083/155] (815s left) kms_fbcon_fbt (psr-suspend) [206.781876] Starting subtest: psr-suspend [256.075256] Subtest psr-suspend: SUCCESS (19.428s) [256.149617] [084/155] (766s left) kms_psr (pr-sprite-mmap-gtt) [256.242417] Starting subtest: pr-sprite-mmap-gtt [256.246676] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [256.314930] [085/155] (765s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy) [256.419566] Starting subtest: psrhdr-modesetfrombusy [256.424122] Subtest psrhdr-modesetfrombusy: SKIP (0.000s) [256.510719] [086/155] (765s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-pgflip-blt) [256.611270] Starting subtest: fbchdr-2p-primscrn-indfb-pgflip-blt [256.615814] Subtest fbchdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [256.733213] [087/155] (765s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [256.838936] Starting subtest: yf-tiled-addfb-size-offset-overflow [256.843489] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [256.939594] [088/155] (765s left) i915_pm_rps (engine-order) [256.999262] Starting subtest: engine-order [262.062758] Subtest engine-order: SUCCESS (4.991s) [262.179011] [089/155] (760s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [262.277250] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [262.281945] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [262.383461] [090/155] (760s left) gem_exec_fence (basic-await) [262.558126] Starting subtest: basic-await [262.560745] Starting dynamic subtest: rcs0 [262.634272] Dynamic subtest rcs0: SUCCESS (0.075s) [262.647764] Starting dynamic subtest: bcs0 [262.707348] Dynamic subtest bcs0: SUCCESS (0.071s) [262.722233] Starting dynamic subtest: vcs0 [262.782270] Dynamic subtest vcs0: SUCCESS (0.071s) [262.795925] Starting dynamic subtest: vcs1 [262.854905] Dynamic subtest vcs1: SUCCESS (0.070s) [262.870085] Starting dynamic subtest: vecs0 [262.928245] Dynamic subtest vecs0: SUCCESS (0.070s) [262.941627] Starting dynamic subtest: ccs0 [263.000465] Dynamic subtest ccs0: SUCCESS (0.070s) [263.003141] Subtest basic-await: SUCCESS (0.440s) [264.867983] [091/155] (757s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [264.962943] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [264.965255] Starting dynamic subtest: pipe-A-eDP-1 [264.974543] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [264.986950] Starting dynamic subtest: pipe-B-eDP-1 [264.995534] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [265.005684] Starting dynamic subtest: pipe-C-eDP-1 [265.014185] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [265.024280] Starting dynamic subtest: pipe-D-eDP-1 [265.032848] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [265.037483] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s) [267.257362] [092/155] (755s left) gem_pxp (reject-modify-context-protection-off-3) [267.383609] Starting subtest: reject-modify-context-protection-off-3 [267.386031] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s) [267.502471] [093/155] (755s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [267.599694] Starting subtest: plane-lut1d-ctm3x4-lut1d [267.768488] Starting dynamic subtest: pipe-A-plane-0 [267.913659] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [267.924922] Starting dynamic subtest: pipe-A-plane-1 [268.069508] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s) [268.081260] Starting dynamic subtest: pipe-A-plane-2 [268.247960] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s) [269.482471] Starting dynamic subtest: pipe-B-plane-0 [269.649815] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [269.660931] Starting dynamic subtest: pipe-B-plane-1 [269.828312] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s) [269.840373] Starting dynamic subtest: pipe-B-plane-2 [270.006960] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s) [271.202863] Starting dynamic subtest: pipe-C-plane-0 [271.327099] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [271.338337] Starting dynamic subtest: pipe-C-plane-1 [271.494201] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [271.505394] Starting dynamic subtest: pipe-C-plane-2 [271.640564] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [272.831958] Starting dynamic subtest: pipe-D-plane-0 [272.952668] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [272.965894] Starting dynamic subtest: pipe-D-plane-1 [273.086695] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [273.101561] Starting dynamic subtest: pipe-D-plane-2 [273.219993] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s) [273.507441] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.887s) [274.311608] [094/155] (748s left) kms_psr (psr2-sprite-mmap-cpu) [274.403039] Starting subtest: psr2-sprite-mmap-cpu [274.405384] Starting dynamic subtest: eDP-1 [276.098021] Dynamic subtest eDP-1: SUCCESS (1.691s) [276.100499] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.692s) [276.995401] [095/155] (745s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc) [277.092777] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc [277.097378] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [277.195794] [096/155] (745s left) syncobj_wait (wait-all-for-submit-delayed-submit) [277.248988] Starting subtest: wait-all-for-submit-delayed-submit [277.351138] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [277.446543] [097/155] (745s left) gem_ctx_param (invalid-param-get) [277.506926] Starting subtest: invalid-param-get [277.509403] Subtest invalid-param-get: SUCCESS (0.001s) [277.625382] [098/155] (745s left) kms_big_fb (4-tiled-8bpp-rotate-270) [277.727963] Starting subtest: 4-tiled-8bpp-rotate-270 [277.748044] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.019s) [277.866924] [099/155] (745s left) gem_fenced_exec_thrash (too-many-fences) [277.923941] Subtest too-many-fences: SKIP (0.000s) [278.003139] [100/155] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [278.094316] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [278.098574] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [278.202740] [101/155] (744s left) syncobj_timeline (invalid-query-bad-pad) [278.251057] Starting subtest: invalid-query-bad-pad [278.253264] Subtest invalid-query-bad-pad: SUCCESS (0.000s) [278.338128] [102/155] (744s left) gem_exec_schedule (smoketest) [278.518264] Starting subtest: smoketest [278.521048] Starting dynamic subtest: rcs0 [284.071582] Dynamic subtest rcs0: SUCCESS (5.491s) [284.085052] Starting dynamic subtest: bcs0 [289.615014] Dynamic subtest bcs0: SUCCESS (5.496s) [289.627214] Starting dynamic subtest: vcs0 [295.094955] Dynamic subtest vcs0: SUCCESS (5.478s) [295.106769] Starting dynamic subtest: vcs1 [300.581797] Dynamic subtest vcs1: SUCCESS (5.488s) [300.597719] Starting dynamic subtest: vecs0 [306.073451] Dynamic subtest vecs0: SUCCESS (5.486s) [306.085714] Starting dynamic subtest: ccs0 [311.552850] Dynamic subtest ccs0: SUCCESS (5.479s) [311.555120] Subtest smoketest: SUCCESS (32.925s) [311.684217] [103/155] (711s left) kms_cursor_edge_walk (256x256-right-edge) [311.787728] Starting subtest: 256x256-right-edge [311.790040] Starting dynamic subtest: pipe-A-eDP-1 [315.242488] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s) [315.253324] Starting dynamic subtest: pipe-D-eDP-1 [318.384907] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.140s) [318.387222] Subtest 256x256-right-edge: SUCCESS (6.594s) [319.200273] [104/155] (703s left) syncobj_wait (invalid-reset-one-illegal-handle) [319.253870] Starting subtest: invalid-reset-one-illegal-handle [319.256129] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [319.362991] [105/155] (703s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [319.458741] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [319.470465] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s) [319.570779] [106/155] (703s left) sriov_basic (bind-unbind-vf) [319.620893] Starting subtest: bind-unbind-vf [319.623341] Starting dynamic subtest: vf-1 [319.703824] Dynamic subtest vf-1: FAIL (0.029s) [319.716359] Starting dynamic subtest: vf-2 [319.789994] Dynamic subtest vf-2: FAIL (0.003s) [319.801950] Starting dynamic subtest: vf-3 [319.874807] Dynamic subtest vf-3: FAIL (0.003s) [319.886551] Starting dynamic subtest: vf-4 [319.959591] Dynamic subtest vf-4: FAIL (0.003s) [319.970873] Starting dynamic subtest: vf-5 [320.044317] Dynamic subtest vf-5: FAIL (0.003s) [320.056122] Starting dynamic subtest: vf-6 [320.128163] Dynamic subtest vf-6: FAIL (0.004s) [320.141283] Starting dynamic subtest: vf-7 [320.198235] Dynamic subtest vf-7: FAIL (0.004s) [320.208444] Starting dynamic subtest: vf-random [320.268208] Dynamic subtest vf-random: FAIL (0.004s) [320.279572] Starting dynamic subtest: vf-last [320.339686] Dynamic subtest vf-last: FAIL (0.510s) [320.341458] Subtest bind-unbind-vf: FAIL (0.573s) [320.380982] [107/155] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [320.483728] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [320.487017] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [320.586677] [108/155] (702s left) kms_psr (fbc-pr-sprite-mmap-cpu) [320.682939] Starting subtest: fbc-pr-sprite-mmap-cpu [320.686359] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [320.754644] [109/155] (702s left) gem_mmap_offset (bad-object) [320.820732] Starting subtest: bad-object [320.822783] Subtest bad-object: SUCCESS (0.001s) [320.941483] [110/155] (702s left) kms_async_flips (test-cursor) [321.041509] Starting subtest: test-cursor [321.412043] Starting dynamic subtest: pipe-A-eDP-1 [322.187602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.775s) [322.575513] Starting dynamic subtest: pipe-B-eDP-1 [323.316489] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s) [323.708138] Starting dynamic subtest: pipe-C-eDP-1 [324.447313] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.750s) [324.821826] Starting dynamic subtest: pipe-D-eDP-1 [325.579437] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s) [325.581771] Subtest test-cursor: SUCCESS (4.539s) [326.748491] [111/155] (696s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [326.849725] Starting subtest: async-flip-with-page-flip-events-tiled [327.233412] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [330.091469] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.801s) [330.104740] Starting dynamic subtest: pipe-A-eDP-1-4 [332.263826] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s) [332.276375] Starting dynamic subtest: pipe-A-eDP-1-4 [334.248990] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [334.262778] Starting dynamic subtest: pipe-A-eDP-1-x [336.453797] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [336.785640] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [339.625954] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.796s) [339.640197] Starting dynamic subtest: pipe-B-eDP-1-4 [341.800778] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s) [341.812789] Starting dynamic subtest: pipe-B-eDP-1-4 [343.760294] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [343.770947] Starting dynamic subtest: pipe-B-eDP-1-x [345.951602] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [346.323076] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [349.162498] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.796s) [349.175024] Starting dynamic subtest: pipe-C-eDP-1-4 [351.337424] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [351.348513] Starting dynamic subtest: pipe-C-eDP-1-4 [353.294959] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [353.306290] Starting dynamic subtest: pipe-C-eDP-1-x [355.524863] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [355.839230] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [358.646998] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.818s) [358.660927] Starting dynamic subtest: pipe-D-eDP-1-4 [360.862351] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s) [360.873000] Starting dynamic subtest: pipe-D-eDP-1-4 [362.819354] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [362.832288] Starting dynamic subtest: pipe-D-eDP-1-x [364.997591] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [364.999899] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.146s) [366.231542] [112/155] (657s left) gem_render_copy_redux (interruptible) [366.286444] Starting subtest: interruptible [366.553067] Subtest interruptible: SUCCESS (0.270s) [366.683249] [113/155] (656s left) kms_lease (lease-unleased-connector) [366.779930] Starting subtest: lease-unleased-connector [366.782168] Starting dynamic subtest: pipe-A-eDP-1 [366.787284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [366.798964] Starting dynamic subtest: pipe-B-eDP-1 [366.801072] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [366.812173] Starting dynamic subtest: pipe-C-eDP-1 [366.814266] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [366.824361] Starting dynamic subtest: pipe-D-eDP-1 [366.826452] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [366.828548] Subtest lease-unleased-connector: SUCCESS (0.030s) [366.919219] [114/155] (656s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [367.008659] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [367.013474] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [367.079828] [115/155] (656s left) kms_chamelium_edid (dp-edid-change-during-suspend) [367.465056] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [368.332569] [116/155] (655s left) gem_softpin (allocator-evict) [368.386504] Starting subtest: allocator-evict [368.388919] Starting dynamic subtest: rcs0 [392.043269] Dynamic subtest rcs0: SUCCESS (23.654s) [392.054616] Starting dynamic subtest: bcs0 [415.976508] Dynamic subtest bcs0: SUCCESS (23.927s) [415.988060] Starting dynamic subtest: vcs0 [439.591638] Dynamic subtest vcs0: SUCCESS (23.607s) [439.604698] Starting dynamic subtest: vcs1 [463.340769] Dynamic subtest vcs1: SUCCESS (23.741s) [463.353996] Starting dynamic subtest: vecs0 [487.072305] Dynamic subtest vecs0: SUCCESS (23.729s) [487.086506] Starting dynamic subtest: ccs0 [511.078303] Dynamic subtest ccs0: SUCCESS (24.009s) [511.080655] Subtest allocator-evict: SUCCESS (142.673s) [511.188224] [117/155] (512s left) kms_flip (plain-flip-fb-recreate-interruptible) [511.333711] Starting subtest: plain-flip-fb-recreate-interruptible [511.336042] Starting dynamic subtest: A-eDP1 [520.250050] Dynamic subtest A-eDP1: SUCCESS (8.916s) [520.264488] Starting dynamic subtest: B-eDP1 [529.081022] Dynamic subtest B-eDP1: SUCCESS (8.830s) [529.094683] Starting dynamic subtest: C-eDP1 [537.895133] Dynamic subtest C-eDP1: SUCCESS (8.812s) [537.906418] Starting dynamic subtest: D-eDP1 [546.724685] Dynamic subtest D-eDP1: SUCCESS (8.828s) [546.730459] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.398s) [547.909174] [118/155] (475s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [548.471757] Starting subtest: syncobj-backward-timeline-chain-engines [548.567820] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.097s) [549.924189] [119/155] (473s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [550.026708] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [550.031056] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [550.115087] [120/155] (473s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [550.199788] Starting subtest: bad-rotation-90-y-tiled-ccs [550.202081] Starting dynamic subtest: pipe-A-eDP-1 [550.224941] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [550.237519] Starting dynamic subtest: pipe-B-eDP-1 [550.258574] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [550.269042] Starting dynamic subtest: pipe-C-eDP-1 [550.289700] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [550.299733] Starting dynamic subtest: pipe-D-eDP-1 [550.320492] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [550.324464] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s) [552.467659] [121/155] (471s left) gem_exec_parallel (basic) [552.524284] Starting subtest: basic [552.526697] Starting dynamic subtest: rcs0 [553.964696] Dynamic subtest rcs0: SUCCESS (1.440s) [553.975526] Starting dynamic subtest: bcs0 [555.451641] Dynamic subtest bcs0: SUCCESS (1.486s) [555.465126] Starting dynamic subtest: vcs0 [556.845568] Dynamic subtest vcs0: SUCCESS (1.391s) [556.860178] Starting dynamic subtest: vcs1 [558.798477] Dynamic subtest vcs1: SUCCESS (1.950s) [558.812588] Starting dynamic subtest: vecs0 [560.782324] Dynamic subtest vecs0: SUCCESS (1.981s) [560.795535] Starting dynamic subtest: ccs0 [562.275416] Dynamic subtest ccs0: SUCCESS (1.492s) [562.277782] Subtest basic: SUCCESS (9.751s) [562.473824] [122/155] (461s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [562.573381] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [562.577541] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [562.662617] [123/155] (461s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt) [562.754154] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt [562.758045] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [562.867375] [124/155] (461s left) kms_getfb (getfb-reject-nv12) [562.959523] Starting subtest: getfb-reject-nv12 [562.961507] Subtest getfb-reject-nv12: SUCCESS (0.001s) [563.063213] [125/155] (460s left) kms_content_protection (dp-mst-type-1-suspend-resume) [563.193985] Starting subtest: dp-mst-type-1-suspend-resume [563.198864] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [563.317059] [126/155] (460s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite) [563.418542] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite [563.421794] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [563.514955] [127/155] (460s left) api_intel_bb (render-ccs) [563.571328] Starting subtest: render-ccs [563.923960] Subtest render-ccs: SUCCESS (0.351s) [564.034289] [128/155] (460s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [564.143605] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [564.147992] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [564.244151] [129/155] (459s left) kms_cursor_crc (cursor-random-64x21) [564.429015] Starting subtest: cursor-random-64x21 [564.474578] Subtest cursor-random-64x21: SKIP (0.044s) [564.697772] [130/155] (459s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [564.799273] Starting subtest: fbcpsr-tiling-4 [571.843722] Subtest fbcpsr-tiling-4: SUCCESS (7.049s) [571.992029] [131/155] (452s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [572.089504] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [572.093702] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s) [572.166852] [132/155] (452s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc) [572.261723] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc [572.265897] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [572.362124] [133/155] (451s left) kms_cursor_crc (cursor-size-change) [572.462589] Starting subtest: cursor-size-change [572.464782] Starting dynamic subtest: pipe-A-eDP-1 [573.260934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s) [573.272046] Starting dynamic subtest: pipe-D-eDP-1 [574.741828] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.480s) [574.744204] Subtest cursor-size-change: SUCCESS (2.281s) [575.558925] [134/155] (448s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [575.673181] Starting subtest: short-flip-before-cursor-toggle [576.591914] Subtest short-flip-before-cursor-toggle: SUCCESS (0.917s) [577.478715] [135/155] (446s left) kms_frontbuffer_tracking (psr-suspend) [577.580667] Starting subtest: psr-suspend [615.652947] Subtest psr-suspend: SUCCESS (8.041s) [615.759093] [136/155] (408s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt) [615.866376] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt [615.870835] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [615.961959] [137/155] (408s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt) [616.053313] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt [616.058005] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [616.149577] [138/155] (408s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [616.248594] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [616.250958] Starting dynamic subtest: pipe-A-eDP-1 [616.275364] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [616.289083] Starting dynamic subtest: pipe-B-eDP-1 [616.311379] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [616.322483] Starting dynamic subtest: pipe-C-eDP-1 [616.344874] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [616.355571] Starting dynamic subtest: pipe-D-eDP-1 [616.378414] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [616.382677] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [618.621166] [139/155] (405s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc) [618.722160] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc [618.726670] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [618.840818] [140/155] (405s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [618.901567] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [619.009721] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s) [619.087057] [141/155] (405s left) prime_mmap_coherency (write) [619.156988] Starting subtest: write [624.688718] Subtest write: SUCCESS (5.379s) [624.794227] [142/155] (399s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu) [624.893570] Starting subtest: hdr-rgb565-draw-mmap-cpu [624.897759] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [624.991335] [143/155] (399s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [625.096717] Starting subtest: psr-rgb565-draw-blt [632.317665] Subtest psr-rgb565-draw-blt: SUCCESS (7.169s) [632.443894] [144/155] (392s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [632.554288] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [632.558366] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [632.658414] [145/155] (392s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [632.766020] Starting subtest: invalidate-primary-flip-overlay [643.486412] Subtest invalidate-primary-flip-overlay: SUCCESS (10.694s) [643.593697] [146/155] (381s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [643.689029] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [643.692449] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [643.810035] [147/155] (381s left) prime_mmap (test_map_unmap) [643.864554] Starting subtest: test_map_unmap [643.866388] Starting dynamic subtest: test_map_unmap-smem [643.893320] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s) [643.895242] Subtest test_map_unmap: SUCCESS (0.032s) [643.992233] [148/155] (380s left) gem_create (create-massive) [644.044028] Starting subtest: create-massive [644.045664] Subtest create-massive: SUCCESS (0.000s) [644.243586] [149/155] (380s left) kms_cursor_crc (cursor-random-128x128) [644.444514] Starting subtest: cursor-random-128x128 [644.446855] Starting dynamic subtest: pipe-A-eDP-1 [647.773511] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.331s) [647.802889] Starting dynamic subtest: pipe-D-eDP-1 [651.848077] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.059s) [651.850380] Subtest cursor-random-128x128: SUCCESS (7.413s) [652.692311] [150/155] (372s left) i915_drm_fdinfo (virtual-busy-idle-all) [652.735417] Starting subtest: virtual-busy-idle-all [652.739941] Subtest virtual-busy-idle-all: SKIP (0.000s) [652.800258] [151/155] (372s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [652.904496] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [652.908686] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [652.989952] [152/155] (372s left) gem_exec_flush (basic-wb-rw-before-default) [653.054347] Starting subtest: basic-wb-rw-before-default [658.537029] Subtest basic-wb-rw-before-default: SUCCESS (5.468s) [658.721292] [153/155] (366s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [658.819764] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [658.824274] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [658.896286] [154/155] (366s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [658.993490] Starting subtest: nonblocking-crc-frame-sequence [658.995753] Starting dynamic subtest: pipe-A-eDP-1 [659.722753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s) [659.735578] Starting dynamic subtest: pipe-B-eDP-1 [661.217913] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s) [661.228763] Starting dynamic subtest: pipe-C-eDP-1 [662.604141] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s) [662.615761] Starting dynamic subtest: pipe-D-eDP-1 [664.027195] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.424s) [664.029615] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.037s) [664.850791] [155/155] (360s left) kms_prop_blob (invalid-get-prop-any) [664.905097] Starting subtest: invalid-get-prop-any [664.907036] Subtest invalid-get-prop-any: SUCCESS (0.000s) [664.992350] Closing watchdogs results: parsing output: 0/ for test: gem_exec_gttfill results: parsing output: 1/ for test: gem_ctx_persistence results: parsing output: 2/ for test: gem_exec_params results: parsing output: 3/ for test: gem_exec_balancer results: parsing output: 4/ for test: kms_psr2_sf results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_vblank results: parsing output: 7/ for test: kms_dp_link_training results: parsing output: 8/ for test: kms_draw_crc results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_render_copy results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_plane_scaling results: parsing output: 15/ for test: api_intel_allocator results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_flip results: parsing output: 18/ for test: gem_exec_whisper results: parsing output: 19/ for test: dumb_buffer results: parsing output: 20/ for test: kms_psr2_sf results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_psr results: parsing output: 23/ for test: kms_chamelium_hpd results: parsing output: 24/ for test: gem_close_race results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_pm_dc results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_exec_whisper results: parsing output: 30/ for test: syncobj_timeline results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_plane_scaling results: parsing output: 35/ for test: syncobj_basic results: parsing output: 36/ for test: kms_flip results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_addfb_basic results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_chamelium_color results: parsing output: 41/ for test: perf_pmu results: parsing output: 42/ for test: i915_suspend results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_getfb results: parsing output: 46/ for test: dumb_buffer results: parsing output: 47/ for test: kms_atomic_transition results: parsing output: 48/ for test: syncobj_wait results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: gem_exec_schedule results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_mmap_gtt results: parsing output: 55/ for test: kms_universal_plane results: parsing output: 56/ for test: gem_exec_reloc results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: gem_exec_reloc results: parsing output: 60/ for test: perf results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: prime_mmap_kms results: parsing output: 63/ for test: kms_busy results: parsing output: 64/ for test: gem_userptr_blits results: parsing output: 65/ for test: kms_plane results: parsing output: 66/ for test: kms_invalid_mode results: parsing output: 67/ for test: gem_ctx_shared results: parsing output: 68/ for test: gen9_exec_parse results: parsing output: 69/ for test: gen7_exec_parse results: parsing output: 70/ for test: gem_ctx_persistence results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: gem_exec_params results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: perf results: parsing output: 77/ for test: perf_pmu results: parsing output: 78/ for test: gem_partial_pwrite_pread results: parsing output: 79/ for test: gem_exec_reloc results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_mmap_wc results: parsing output: 82/ for test: kms_fbcon_fbt results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: i915_pm_rps results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: gem_exec_fence results: parsing output: 90/ for test: kms_ccs results: parsing output: 91/ for test: gem_pxp results: parsing output: 92/ for test: kms_color_pipeline results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: gem_ctx_param results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: gem_fenced_exec_thrash results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: syncobj_timeline results: parsing output: 101/ for test: gem_exec_schedule results: parsing output: 102/ for test: kms_cursor_edge_walk results: parsing output: 103/ for test: syncobj_wait results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: sriov_basic results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: gem_mmap_offset results: parsing output: 109/ for test: kms_async_flips results: parsing output: 110/ for test: kms_async_flips results: parsing output: 111/ for test: gem_render_copy_redux results: parsing output: 112/ for test: kms_lease results: parsing output: 113/ for test: kms_plane results: parsing output: 114/ for test: kms_chamelium_edid results: parsing output: 115/ for test: gem_softpin results: parsing output: 116/ for test: kms_flip results: parsing output: 117/ for test: gem_exec_fence results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: gem_exec_parallel results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_getfb results: parsing output: 124/ for test: kms_content_protection results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: api_intel_bb results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_cursor_crc results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_flip_scaled_crc results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_cursor_crc results: parsing output: 133/ for test: kms_cursor_legacy results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_ccs results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: syncobj_timeline results: parsing output: 140/ for test: prime_mmap_coherency results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: kms_psr_stress_test results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: prime_mmap results: parsing output: 147/ for test: gem_create results: parsing output: 148/ for test: kms_cursor_crc results: parsing output: 149/ for test: i915_drm_fdinfo results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: gem_exec_flush results: parsing output: 152/ for test: kms_flip_scaled_crc results: parsing output: 153/ for test: kms_pipe_crc_basic results: parsing output: 154/ for test: kms_prop_blob Done.