[89.645982] Initializing watchdogs
[89.646316]   /dev/watchdog0
[89.683199] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.697025] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.704481] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.712246] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[90.187940] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[90.233399] Starting dynamic subtest: pipe-A-valid-mode
[90.703437] Dynamic subtest pipe-A-valid-mode: SKIP (0.377s)
[90.839063] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.381s)
[91.108490] [002/133] (959s left) gem_exec_schedule (out-order)
[91.967653] Starting subtest: out-order
[91.971854] Starting dynamic subtest: rcs0
[91.976389] Dynamic subtest rcs0: SUCCESS (0.108s)
[91.997195] Starting dynamic subtest: bcs0
[92.000468] Dynamic subtest bcs0: SUCCESS (0.118s)
[92.016783] Starting dynamic subtest: vcs0
[92.020521] Dynamic subtest vcs0: SUCCESS (0.097s)
[92.051182] Starting dynamic subtest: vecs0
[92.055305] Dynamic subtest vecs0: SUCCESS (0.098s)
[92.059482] Subtest out-order: SUCCESS (0.426s)
[92.279322] [003/133] (958s left) kms_flip (dpms-off-confusion)
[92.483445] Starting subtest: dpms-off-confusion
[92.486729] Starting dynamic subtest: A-HDMI-A1
[98.207132] Dynamic subtest A-HDMI-A1: SUCCESS (5.722s)
[98.223965] Starting dynamic subtest: B-HDMI-A1
[103.603496] Dynamic subtest B-HDMI-A1: SUCCESS (5.395s)
[103.624623] Starting dynamic subtest: C-HDMI-A1
[108.988696] Dynamic subtest C-HDMI-A1: SUCCESS (5.383s)
[109.005207] Starting dynamic subtest: A-HDMI-A2
[114.406259] Dynamic subtest A-HDMI-A2: SUCCESS (5.413s)
[114.422639] Starting dynamic subtest: B-HDMI-A2
[119.810127] Dynamic subtest B-HDMI-A2: SUCCESS (5.401s)
[119.826537] Starting dynamic subtest: C-HDMI-A2
[125.219630] Dynamic subtest C-HDMI-A2: SUCCESS (5.408s)
[125.222902] Subtest dpms-off-confusion: SUCCESS (32.737s)
[125.685682] [004/133] (924s left) gem_ctx_engines (execute-allforone)
[125.837411] Starting subtest: execute-allforone
[125.848715] Subtest execute-allforone: SUCCESS (0.013s)
[126.111213] [005/133] (924s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[126.308963] Starting subtest: fb-8bpc-vs-panel-8bpc
[126.312621] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.118438] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.784s)
[127.152394] Starting dynamic subtest: pipe-A-HDMI-A-2
[127.571535] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.472s)
[127.575275] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.264s)
[127.837517] [006/133] (922s left) i915_pm_rc6_residency (rc6-accuracy)
[127.959540] Starting subtest: rc6-accuracy
[127.963083] Starting dynamic subtest: gt0
[131.134670] Dynamic subtest gt0: SUCCESS (3.170s)
[131.139081] Subtest rc6-accuracy: SUCCESS (3.172s)
[131.274163] [007/133] (919s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[131.502786] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[131.577554] [008/133] (919s left) kms_plane_scaling (planes-upscale-20x20)
[131.780428] Starting subtest: planes-upscale-20x20
[131.786244] Starting dynamic subtest: pipe-A
[132.075024] Dynamic subtest pipe-A: SUCCESS (0.298s)
[132.106894] Starting dynamic subtest: pipe-B
[132.452200] Dynamic subtest pipe-B: SUCCESS (0.378s)
[132.476577] Starting dynamic subtest: pipe-C
[132.524614] Dynamic subtest pipe-C: SUCCESS (0.071s)
[132.528543] Subtest planes-upscale-20x20: SUCCESS (0.748s)
[132.962951] [009/133] (918s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[133.200104] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[133.206413] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[133.330658] [010/133] (917s left) kms_chamelium_hpd (hdmi-hpd)
[133.910944] Subtest hdmi-hpd: SKIP (0.000s)
[134.137904] [011/133] (917s left) kms_feature_discovery (display)
[134.336313] Starting subtest: display
[134.340818] Subtest display: SUCCESS (0.000s)
[134.460572] [012/133] (916s left) kms_psr (pr-sprite-blt)
[134.672909] Subtest pr-sprite-blt: SKIP (0.000s)
[134.778832] [013/133] (916s left) gem_exec_whisper (basic-contexts)
[134.929288] Starting subtest: basic-contexts
[141.112030] Subtest basic-contexts: SUCCESS (6.178s)
[141.359615] [014/133] (910s left) gem_exec_schedule (thriceslice)
[141.507794] Starting subtest: thriceslice
[141.511555] Starting dynamic subtest: rcs0
[141.520461] Dynamic subtest rcs0: SUCCESS (0.012s)
[141.543395] Starting dynamic subtest: bcs0
[141.548211] Dynamic subtest bcs0: SUCCESS (0.022s)
[141.568219] Starting dynamic subtest: vcs0
[141.572558] Dynamic subtest vcs0: SUCCESS (0.008s)
[141.603767] Starting dynamic subtest: vecs0
[141.608344] Dynamic subtest vecs0: SUCCESS (0.020s)
[141.612422] Subtest thriceslice: SUCCESS (0.065s)
[141.964236] [015/133] (909s left) gem_exec_gttfill (engines)
[142.110488] Starting subtest: engines
[142.114833] Starting dynamic subtest: rcs0
[176.452762] Dynamic subtest rcs0: SUCCESS (34.342s)
[176.478504] Starting dynamic subtest: bcs0
[212.089438] Dynamic subtest bcs0: SUCCESS (35.635s)
[212.132930] Starting dynamic subtest: vcs0
[246.360265] Dynamic subtest vcs0: SUCCESS (34.271s)
[246.388750] Starting dynamic subtest: vecs0
[280.691340] Dynamic subtest vecs0: SUCCESS (34.332s)
[280.695941] Subtest engines: SUCCESS (138.585s)
[280.953964] [016/133] (770s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[281.307916] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[281.323589] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.008s)
[281.544516] [017/133] (770s left) kms_getfb (getfb-handle-protection)
[281.738075] Starting subtest: getfb-handle-protection
[281.781458] Subtest getfb-handle-protection: SUCCESS (0.049s)
[281.929610] [018/133] (769s left) vkms/vkms_configfs (enable-plane-no-crtcs)
[282.253364] Subtest enable-plane-no-crtcs: SKIP (0.000s)
[282.399138] [019/133] (769s left) syncobj_wait (single-wait-for-submit-submitted)
[282.526545] Starting subtest: single-wait-for-submit-submitted
[282.628404] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[282.777964] [020/133] (769s left) dumb_buffer (map-uaf)
[282.899740] Starting subtest: map-uaf
[282.957046] Subtest map-uaf: SUCCESS (0.059s)
[283.123281] [021/133] (769s left) kms_psr (fbc-psr-sprite-plane-move)
[283.334977] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[283.443635] [022/133] (768s left) perf_pmu (multi-client)
[283.579280] Starting subtest: multi-client
[283.584935] Starting dynamic subtest: rcs0
[284.603714] Dynamic subtest rcs0: SUCCESS (1.023s)
[284.624432] Starting dynamic subtest: bcs0
[285.640912] Dynamic subtest bcs0: SUCCESS (1.035s)
[285.661759] Starting dynamic subtest: vcs0
[286.673840] Dynamic subtest vcs0: SUCCESS (1.031s)
[286.694728] Starting dynamic subtest: vecs0
[287.694307] Dynamic subtest vecs0: SUCCESS (1.021s)
[287.697713] Subtest multi-client: SUCCESS (4.118s)
[287.858306] [023/133] (764s left) kms_psr (psr-cursor-mmap-cpu)
[288.058018] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[288.165338] [024/133] (764s left) gem_basic (create-close)
[288.285632] Starting subtest: create-close
[288.294647] Subtest create-close: SUCCESS (0.000s)
[288.442501] [025/133] (764s left) gem_userptr_blits (readonly-pwrite-unsync)
[288.582492] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[288.785524] [026/133] (763s left) i915_query (hwconfig_table)
[288.908808] Starting subtest: hwconfig_table
[288.916770] Subtest hwconfig_table: SKIP (0.000s)
[289.044854] [027/133] (763s left) gem_userptr_blits (map-fixed-invalidate-busy)
[289.197451] Starting subtest: map-fixed-invalidate-busy
[289.200679] Starting dynamic subtest: gtt
[292.425050] Dynamic subtest gtt: SUCCESS (3.228s)
[292.445379] Starting dynamic subtest: wb
[295.559578] Dynamic subtest wb: SUCCESS (3.134s)
[295.579658] Starting dynamic subtest: wc
[298.709385] Dynamic subtest wc: SUCCESS (3.149s)
[298.729764] Starting dynamic subtest: uc
[301.855686] Dynamic subtest uc: SUCCESS (3.145s)
[301.859277] Subtest map-fixed-invalidate-busy: SUCCESS (12.661s)
[302.044174] [028/133] (750s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[302.269233] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[304.782353] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.514s)
[305.059756] [029/133] (747s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[305.287739] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[305.378480] [030/133] (747s left) kms_flip (plain-flip-interruptible)
[305.602808] Starting subtest: plain-flip-interruptible
[305.605862] Starting dynamic subtest: A-HDMI-A1
[306.777059] Dynamic subtest A-HDMI-A1: SUCCESS (1.171s)
[306.797986] Starting dynamic subtest: B-HDMI-A1
[307.659063] Dynamic subtest B-HDMI-A1: SUCCESS (0.876s)
[307.679382] Starting dynamic subtest: C-HDMI-A1
[308.541269] Dynamic subtest C-HDMI-A1: SUCCESS (0.879s)
[308.561827] Starting dynamic subtest: A-HDMI-A2
[309.428202] Dynamic subtest A-HDMI-A2: SUCCESS (0.882s)
[309.448815] Starting dynamic subtest: B-HDMI-A2
[310.297262] Dynamic subtest B-HDMI-A2: SUCCESS (0.866s)
[310.321819] Starting dynamic subtest: C-HDMI-A2
[311.164381] Dynamic subtest C-HDMI-A2: SUCCESS (0.865s)
[311.167523] Subtest plain-flip-interruptible: SUCCESS (5.566s)
[311.623793] [031/133] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[311.847316] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[311.854412] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[312.000136] [032/133] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[312.210056] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[315.008857] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.802s)
[315.274722] [033/133] (738s left) gem_userptr_blits (coherency-unsync)
[315.418188] Subtest coherency-unsync: SKIP (0.000s)
[315.645486] [034/133] (737s left) gem_madvise (dontneed-before-exec)
[315.761772] Starting subtest: dontneed-before-exec
[315.768912] Subtest dontneed-before-exec: SUCCESS (0.007s)
[315.921416] [035/133] (737s left) syncobj_wait (wait-all-delayed-signal)
[316.044696] Starting subtest: wait-all-delayed-signal
[316.146660] Subtest wait-all-delayed-signal: SUCCESS (0.106s)
[316.290542] [036/133] (737s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[316.490375] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[316.493580] Starting dynamic subtest: pipe-A-HDMI-A-1
[316.611034] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[316.632268] Starting dynamic subtest: pipe-A-HDMI-A-2
[316.667025] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[316.688143] Starting dynamic subtest: pipe-B-HDMI-A-1
[316.722131] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[316.742451] Starting dynamic subtest: pipe-B-HDMI-A-2
[316.775570] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[316.796117] Starting dynamic subtest: pipe-C-HDMI-A-1
[316.828762] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[316.849225] Starting dynamic subtest: pipe-C-HDMI-A-2
[316.881233] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[316.887261] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.025s)
[317.401362] [037/133] (736s left) gem_softpin (evict-snoop-interruptible)
[317.543817] Starting subtest: evict-snoop-interruptible
[317.550813] Subtest evict-snoop-interruptible: SKIP (0.000s)
[317.711336] [038/133] (736s left) kms_chamelium_audio (dp-audio-edid)
[318.294623] Subtest dp-audio-edid: SKIP (0.000s)
[318.607755] [039/133] (735s left) kms_psr (fbc-pr-sprite-blt)
[318.865593] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[319.015883] [040/133] (735s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[319.157366] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[319.165648] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[319.435201] [041/133] (734s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[319.653514] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[319.660105] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[319.802440] [042/133] (734s left) gem_pxp (display-protected-crc)
[322.460316] Starting subtest: display-protected-crc
[322.467662] Subtest display-protected-crc: SKIP (0.000s)
[322.619083] [043/133] (731s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[322.829645] Starting subtest: basic-flip-after-cursor-varying-size
[324.071177] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.242s)
[324.355706] [044/133] (730s left) gem_exec_reloc (basic-wc)
[324.490745] Starting subtest: basic-wc
[324.506058] Subtest basic-wc: SUCCESS (0.014s)
[324.738849] [045/133] (729s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[324.939992] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[324.981455] Starting dynamic subtest: pipe-A-valid-mode
[325.362764] Dynamic subtest pipe-A-valid-mode: SKIP (0.369s)
[325.401030] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.374s)
[325.598697] [046/133] (729s left) kms_plane (plane-position-hole)
[325.809084] Starting subtest: plane-position-hole
[326.554895] Starting dynamic subtest: pipe-A-plane-1
[327.087305] Dynamic subtest pipe-A-plane-1: SUCCESS (0.532s)
[327.111048] Starting dynamic subtest: pipe-A-plane-2
[327.663716] Dynamic subtest pipe-A-plane-2: SUCCESS (0.571s)
[327.696247] Starting dynamic subtest: pipe-A-plane-3
[328.211039] Dynamic subtest pipe-A-plane-3: SUCCESS (0.550s)
[328.232440] Starting dynamic subtest: pipe-A-plane-4
[328.238984] Dynamic subtest pipe-A-plane-4: SUCCESS (0.021s)
[328.719998] Starting dynamic subtest: pipe-B-plane-1
[329.246057] Dynamic subtest pipe-B-plane-1: SUCCESS (0.544s)
[329.271219] Starting dynamic subtest: pipe-B-plane-2
[329.769063] Dynamic subtest pipe-B-plane-2: SUCCESS (0.518s)
[329.807812] Starting dynamic subtest: pipe-B-plane-3
[330.293129] Dynamic subtest pipe-B-plane-3: SUCCESS (0.513s)
[330.315812] Starting dynamic subtest: pipe-B-plane-4
[330.322944] Dynamic subtest pipe-B-plane-4: SUCCESS (0.024s)
[330.326125] Subtest plane-position-hole: SUCCESS (4.506s)
[330.613895] [047/133] (724s left) kms_flip (flip-vs-expired-vblank)
[330.825837] Starting subtest: flip-vs-expired-vblank
[330.828957] Starting dynamic subtest: A-HDMI-A1
[336.465565] Dynamic subtest A-HDMI-A1: SUCCESS (5.640s)
[336.487400] Starting dynamic subtest: B-HDMI-A1
[341.894714] Dynamic subtest B-HDMI-A1: SUCCESS (5.425s)
[341.916492] Starting dynamic subtest: C-HDMI-A1
[347.300176] Dynamic subtest C-HDMI-A1: SUCCESS (5.401s)
[347.320652] Starting dynamic subtest: A-HDMI-A2
[352.730126] Dynamic subtest A-HDMI-A2: SUCCESS (5.422s)
[352.766532] Starting dynamic subtest: B-HDMI-A2
[358.161127] Dynamic subtest B-HDMI-A2: SUCCESS (5.429s)
[358.190321] Starting dynamic subtest: C-HDMI-A2
[363.552482] Dynamic subtest C-HDMI-A2: SUCCESS (5.384s)
[363.558283] Subtest flip-vs-expired-vblank: SUCCESS (32.729s)
[364.060013] [048/133] (690s left) kms_vrr (max-min)
[364.265762] Starting subtest: max-min
[364.280889] Subtest max-min: SKIP (0.001s)
[364.405291] [049/133] (690s left) kms_color (legacy-gamma)
[364.610601] Starting subtest: legacy-gamma
[364.613907] Starting dynamic subtest: pipe-A-HDMI-A-1
[365.615086] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.979s)
[365.653857] Starting dynamic subtest: pipe-A-HDMI-A-2
[366.299277] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.704s)
[366.331333] Starting dynamic subtest: pipe-B-HDMI-A-1
[366.978093] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.677s)
[367.011866] Starting dynamic subtest: pipe-B-HDMI-A-2
[367.673668] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.685s)
[367.695119] Starting dynamic subtest: pipe-C-HDMI-A-1
[368.365425] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.695s)
[368.407511] Starting dynamic subtest: pipe-C-HDMI-A-2
[369.103042] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.691s)
[369.108779] Subtest legacy-gamma: SUCCESS (4.446s)
[369.335347] [050/133] (685s left) kms_psr (fbc-psr-no-drrs)
[369.547313] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[369.660698] [051/133] (685s left) kms_flip (wf_vblank-ts-check)
[369.863546] Starting subtest: wf_vblank-ts-check
[369.866999] Starting dynamic subtest: A-HDMI-A1
[375.952070] Dynamic subtest A-HDMI-A1: SUCCESS (6.084s)
[375.980914] Starting dynamic subtest: B-HDMI-A1
[381.783640] Dynamic subtest B-HDMI-A1: SUCCESS (5.824s)
[381.812530] Starting dynamic subtest: C-HDMI-A1
[387.465263] Dynamic subtest C-HDMI-A1: SUCCESS (5.678s)
[387.495808] Starting dynamic subtest: A-HDMI-A2
[393.152344] Dynamic subtest A-HDMI-A2: SUCCESS (5.681s)
[393.172532] Starting dynamic subtest: B-HDMI-A2
[399.009247] Dynamic subtest B-HDMI-A2: SUCCESS (5.854s)
[399.029939] Starting dynamic subtest: C-HDMI-A2
[404.692704] Dynamic subtest C-HDMI-A2: SUCCESS (5.680s)
[404.696136] Subtest wf_vblank-ts-check: SUCCESS (34.833s)
[405.167431] [052/133] (650s left) gem_exec_fence (basic-wait)
[405.447063] Starting subtest: basic-wait
[405.450942] Starting dynamic subtest: rcs0
[405.467651] Dynamic subtest rcs0: SUCCESS (0.018s)
[405.489443] Starting dynamic subtest: bcs0
[405.494088] Dynamic subtest bcs0: SUCCESS (0.025s)
[405.517279] Starting dynamic subtest: vcs0
[405.528830] Dynamic subtest vcs0: SUCCESS (0.027s)
[405.550208] Starting dynamic subtest: vecs0
[405.553985] Dynamic subtest vecs0: SUCCESS (0.025s)
[405.558625] Subtest basic-wait: SUCCESS (0.108s)
[406.391719] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[406.398982] [053/133] (649s left) gem_userptr_blits (mmap-offset-banned)
[406.558302] Starting subtest: mmap-offset-banned
[406.561738] Starting dynamic subtest: gtt
[406.565199] Dynamic subtest gtt: SUCCESS (0.001s)
[406.585876] Starting dynamic subtest: wb
[406.589256] Dynamic subtest wb: SUCCESS (0.001s)
[406.611662] Starting dynamic subtest: wc
[406.616417] Dynamic subtest wc: SUCCESS (0.000s)
[406.645207] Starting dynamic subtest: uc
[406.649380] Dynamic subtest uc: SUCCESS (0.000s)
[406.653147] Subtest mmap-offset-banned: SUCCESS (0.011s)
[406.781047] [054/133] (648s left) kms_legacy_colorkey (invalid-plane)
[406.982659] Starting subtest: invalid-plane
[406.987361] Starting dynamic subtest: zero-id
[406.991153] Dynamic subtest zero-id: SUCCESS (0.000s)
[407.016227] Starting dynamic subtest: outrange-id
[407.019739] Dynamic subtest outrange-id: SUCCESS (0.000s)
[407.023053] Subtest invalid-plane: SUCCESS (0.005s)
[407.139122] [055/133] (648s left) api_intel_allocator (reopen)
[407.266534] Starting subtest: reopen
[407.271063] Subtest reopen: SUCCESS (0.005s)
[407.424548] [056/133] (648s left) gem_ctx_persistence (engines-mixed)
[407.559875] Starting subtest: engines-mixed
[407.563446] Starting dynamic subtest: rcs0
[407.610060] Dynamic subtest rcs0: SUCCESS (0.044s)
[407.633256] Starting dynamic subtest: bcs0
[407.648051] Dynamic subtest bcs0: SUCCESS (0.034s)
[407.668767] Starting dynamic subtest: vcs0
[407.689214] Dynamic subtest vcs0: SUCCESS (0.038s)
[407.709992] Starting dynamic subtest: vecs0
[407.727911] Dynamic subtest vecs0: SUCCESS (0.036s)
[407.731985] Subtest engines-mixed: SUCCESS (0.170s)
[407.894119] [057/133] (648s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[408.120141] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[410.555599] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.436s)
[410.826624] [058/133] (645s left) kms_big_fb (linear-8bpp-rotate-90)
[411.053124] Starting subtest: linear-8bpp-rotate-90
[411.342549] Subtest linear-8bpp-rotate-90: SKIP (0.284s)
[411.576506] [059/133] (644s left) kms_addfb_basic (basic)
[411.709294] Starting subtest: basic
[411.712368] Subtest basic: SUCCESS (0.000s)
[411.985370] [060/133] (644s left) perf_pmu (busy-start)
[412.120719] Starting subtest: busy-start
[412.124620] Starting dynamic subtest: rcs0
[414.637768] Dynamic subtest rcs0: SUCCESS (2.518s)
[414.662573] Starting dynamic subtest: bcs0
[417.158078] Dynamic subtest bcs0: SUCCESS (2.517s)
[417.179528] Starting dynamic subtest: vcs0
[419.682300] Dynamic subtest vcs0: SUCCESS (2.521s)
[419.704279] Starting dynamic subtest: vecs0
[422.204268] Dynamic subtest vecs0: SUCCESS (2.518s)
[422.207869] Subtest busy-start: SUCCESS (10.085s)
[422.362856] [061/133] (634s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[422.605119] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[422.702089] [062/133] (633s left) gem_mmap_gtt (medium-copy-odd)
[422.829974] Starting subtest: medium-copy-odd
[427.836253] Subtest medium-copy-odd: SUCCESS (5.011s)
[427.994853] [063/133] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[428.398443] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[428.405070] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[428.556598] [064/133] (628s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[428.763229] Starting subtest: addfb25-framebuffer-vs-set-tiling
[428.767421] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[428.923940] [065/133] (627s left) gen9_exec_parse (batch-zero-length)
[429.069358] Starting subtest: batch-zero-length
[429.072842] Subtest batch-zero-length: SUCCESS (0.002s)
[429.364987] [066/133] (627s left) kms_content_protection (uevent)
[429.610046] Starting subtest: uevent
[431.333844] Subtest uevent: SKIP (1.649s)
[431.737832] [067/133] (625s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[431.888240] Starting subtest: etime-single-wait-all-for-submit-submitted
[431.996062] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[432.153946] [068/133] (624s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[432.277739] Starting subtest: etime-multi-wait-all-for-submit-submitted
[432.380055] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[432.539322] [069/133] (624s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[432.747378] Starting subtest: primary-x-tiled-reflect-x-180
[432.754669] Subtest primary-x-tiled-reflect-x-180: SKIP (0.004s)
[432.903860] [070/133] (624s left) vkms/vkms_configfs (encoder-default-files)
[433.065138] Subtest encoder-default-files: SKIP (0.000s)
[433.212227] [071/133] (624s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[433.420071] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[433.423454] Starting dynamic subtest: pipe-A-HDMI-A-1
[433.460484] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[433.534024] Starting dynamic subtest: pipe-A-HDMI-A-2
[433.567361] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[433.587969] Starting dynamic subtest: pipe-B-HDMI-A-1
[433.621479] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[433.642479] Starting dynamic subtest: pipe-B-HDMI-A-2
[433.675218] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[433.696242] Starting dynamic subtest: pipe-C-HDMI-A-1
[433.728735] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[433.749613] Starting dynamic subtest: pipe-C-HDMI-A-2
[433.784406] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[433.791039] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.046s)
[434.399722] [072/133] (623s left) gem_ctx_persistence (legacy-engines-mixed-process)
[434.535764] Starting subtest: legacy-engines-mixed-process
[434.541838] Starting dynamic subtest: render
[434.953985] Dynamic subtest render: SUCCESS (0.407s)
[434.996056] Starting dynamic subtest: bsd
[435.316502] Dynamic subtest bsd: SUCCESS (0.367s)
[435.367853] Starting dynamic subtest: blt
[435.716440] Dynamic subtest blt: SUCCESS (0.395s)
[435.761886] Starting dynamic subtest: vebox
[436.119900] Dynamic subtest vebox: SUCCESS (0.387s)
[436.128200] Subtest legacy-engines-mixed-process: SUCCESS (1.580s)
[436.289975] [073/133] (621s left) gem_mmap_gtt (hang-busy)
[436.416209] Starting subtest: hang-busy
[451.161062] Subtest hang-busy: SUCCESS (14.731s)
[451.318904] [074/133] (606s left) kms_flip (2x-nonexisting-fb)
[451.531439] Starting subtest: 2x-nonexisting-fb
[451.534834] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[452.325275] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (0.790s)
[452.371600] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[453.155182] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (0.714s)
[453.234921] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[453.857784] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (0.678s)
[453.956313] Subtest 2x-nonexisting-fb: SUCCESS (2.215s)
[454.421101] [075/133] (603s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[454.653705] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[454.662077] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[454.810513] [076/133] (603s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[455.029618] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[455.036511] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[455.194329] [077/133] (602s left) i915_query (query-topology-kernel-writes)
[455.322324] Starting subtest: query-topology-kernel-writes
[455.326729] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[455.475601] [078/133] (602s left) gem_eio (wait-immediate)
[455.622034] Starting subtest: wait-immediate
[455.723438] Subtest wait-immediate: SUCCESS (0.098s)
[455.978322] [079/133] (602s left) gem_linear_blits (basic)
[456.238923] Starting subtest: basic
[456.255774] Subtest basic: SUCCESS (0.020s)
[456.464855] [080/133] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[456.886508] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[459.821194] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SUCCESS (2.960s)
[460.053043] [081/133] (598s left) i915_pm_rps (thresholds-idle)
[460.201418] Starting subtest: thresholds-idle
[460.206140] Starting dynamic subtest: gt0
[470.450077] Dynamic subtest gt0: SUCCESS (10.249s)
[470.453387] Subtest thresholds-idle: SUCCESS (10.254s)
[470.630380] [082/133] (588s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[470.854067] Starting subtest: yf-tiled-64bpp-rotate-90
[470.860577] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[471.010775] [083/133] (587s left) kms_chamelium_color (degamma)
[471.220815] Subtest degamma: SKIP (0.000s)
[471.350881] [084/133] (587s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[471.498250] Starting subtest: single-wait-all-for-submit-available-signaled
[471.501600] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[471.665198] [085/133] (587s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[471.941450] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[471.949033] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[472.110965] [086/133] (587s left) gem_lmem_swapping (verify-ccs)
[472.246912] Subtest verify-ccs: SKIP (0.000s)
[472.375362] [087/133] (586s left) kms_vblank (invalid)
[472.583160] Starting subtest: invalid
[472.586785] Starting dynamic subtest: pipe-A-HDMI-A-1
[473.273140] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.687s)
[473.315745] Subtest invalid: SUCCESS (0.695s)
[473.558879] [088/133] (585s left) kms_selftest (drm_cmdline_parser)
[473.692243] Starting subtest: drm_cmdline_parser
[473.726660] Starting dynamic subtest: drm_test_cmdline_force_d_only
[473.775990] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.052s)
[473.799677] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[473.851222] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.069s)
[473.874683] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[473.912531] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.057s)
[473.937618] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[473.976869] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.061s)
[474.001685] Starting dynamic subtest: drm_test_cmdline_force_e_only
[474.043557] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.062s)
[474.072416] Starting dynamic subtest: drm_test_cmdline_res
[474.108670] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.060s)
[474.140129] Starting dynamic subtest: drm_test_cmdline_res_vesa
[474.161543] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.049s)
[474.185546] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[474.216090] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.045s)
[474.244165] Starting dynamic subtest: drm_test_cmdline_res_rblank
[474.273096] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.060s)
[474.297057] Starting dynamic subtest: drm_test_cmdline_res_bpp
[474.338575] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.058s)
[474.361807] Starting dynamic subtest: drm_test_cmdline_res_refresh
[474.402785] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.060s)
[474.425852] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[474.451821] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.045s)
[474.474722] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[474.511623] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.057s)
[474.539208] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[474.578184] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.057s)
[474.603470] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[474.640457] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.067s)
[474.681659] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[474.699992] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.048s)
[474.729182] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[474.758778] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.055s)
[474.781500] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[474.817396] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.057s)
[474.840671] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[474.874052] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.048s)
[474.899434] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[474.930122] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.053s)
[474.953555] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[474.985678] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.058s)
[475.008999] Starting dynamic subtest: drm_test_cmdline_name
[475.050531] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.061s)
[475.073841] Starting dynamic subtest: drm_test_cmdline_name_bpp
[475.104627] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.051s)
[475.127929] Starting dynamic subtest: drm_test_cmdline_name_option
[475.177767] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.067s)
[475.213278] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[475.229217] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.051s)
[475.253198] Starting dynamic subtest: drm_test_cmdline_rotate_0
[475.305265] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.069s)
[475.342299] Starting dynamic subtest: drm_test_cmdline_rotate_90
[475.353539] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.046s)
[475.377123] Starting dynamic subtest: drm_test_cmdline_rotate_180
[475.410635] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.053s)
[475.439968] Starting dynamic subtest: drm_test_cmdline_rotate_270
[475.472233] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.058s)
[475.500049] Starting dynamic subtest: drm_test_cmdline_hmirror
[475.519721] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.046s)
[475.543718] Starting dynamic subtest: drm_test_cmdline_vmirror
[475.589995] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.064s)
[475.617576] Starting dynamic subtest: drm_test_cmdline_margin_options
[475.655476] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.066s)
[475.678618] Starting dynamic subtest: drm_test_cmdline_multiple_options
[475.725155] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.063s)
[475.748811] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[475.771599] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.046s)
[475.795175] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[475.841561] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.063s)
[475.864903] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[475.905136] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.058s)
[475.933562] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[475.957816] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.052s)
[475.981344] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[476.022468] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.061s)
[476.045675] Starting dynamic subtest: drm_test_cmdline_invalid
[476.098809] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.064s)
[476.122374] Starting dynamic subtest: drm_test_cmdline_tv_options
[476.168053] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.063s)
[476.171213] Subtest drm_cmdline_parser: SUCCESS (2.467s)
[476.380661] [089/133] (583s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[476.519387] Starting subtest: basic-cpu-wc-noreloc
[476.528845] Subtest basic-cpu-wc-noreloc: SUCCESS (0.010s)
[476.775628] [090/133] (582s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[476.994345] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[477.002122] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[477.141689] [091/133] (582s left) gem_eio (create)
[477.282862] Starting subtest: create
[477.334180] Subtest create: SUCCESS (0.052s)
[477.591490] [092/133] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[477.814430] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[477.822787] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[477.974809] [093/133] (581s left) kms_cursor_edge_walk (256x256-left-edge)
[478.181659] Starting subtest: 256x256-left-edge
[478.185095] Starting dynamic subtest: pipe-A-HDMI-A-1
[482.105081] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.914s)
[482.136029] Starting dynamic subtest: pipe-C-HDMI-A-1
[485.530642] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.422s)
[485.578813] Subtest 256x256-left-edge: SUCCESS (7.349s)
[485.820536] [094/133] (574s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[486.035544] Starting subtest: flip-vs-cursor-legacy
[502.826139] Subtest flip-vs-cursor-legacy: SUCCESS (16.794s)
[503.135575] [095/133] (557s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[503.361488] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[505.994333] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SUCCESS (2.636s)
[506.237650] [096/133] (554s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[506.466409] Starting subtest: psr-rgb565-draw-blt
[506.473611] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[506.619910] [097/133] (553s left) gem_mmap (pf-nonblock)
[506.746055] Starting subtest: pf-nonblock
[506.750307] Subtest pf-nonblock: SUCCESS (0.005s)
[506.913133] [098/133] (553s left) gem_tiled_partial_pwrite_pread (reads)
[507.048942] Starting subtest: reads
[508.229846] Subtest reads: SUCCESS (1.181s)
[508.404788] [099/133] (552s left) kms_async_flips (test-cursor-atomic)
[508.614365] Starting subtest: test-cursor-atomic
[509.177848] Starting dynamic subtest: pipe-A-HDMI-A-1
[509.366275] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.187s)
[509.762726] Starting dynamic subtest: pipe-A-HDMI-A-2
[509.927307] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.221s)
[510.276561] Starting dynamic subtest: pipe-B-HDMI-A-1
[510.488535] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.226s)
[510.818259] Starting dynamic subtest: pipe-B-HDMI-A-2
[511.017962] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.220s)
[511.356607] Starting dynamic subtest: pipe-C-HDMI-A-1
[511.538123] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.206s)
[511.852310] Starting dynamic subtest: pipe-C-HDMI-A-2
[512.045707] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.211s)
[512.049259] Subtest test-cursor-atomic: SUCCESS (3.431s)
[512.678839] [100/133] (548s left) gem_exec_reloc (basic-wc-cpu-active)
[512.825321] Starting subtest: basic-wc-cpu-active
[512.956066] Subtest basic-wc-cpu-active: SUCCESS (0.134s)
[513.196491] [101/133] (547s left) syncobj_timeline (multi-wait-available-submitted)
[513.324802] Starting subtest: multi-wait-available-submitted
[513.330145] Subtest multi-wait-available-submitted: SUCCESS (0.003s)
[513.481871] [102/133] (547s left) kms_cursor_crc (cursor-random-128x128)
[513.699717] Starting subtest: cursor-random-128x128
[513.741978] Starting dynamic subtest: pipe-A-HDMI-A-1
[517.954038] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.184s)
[518.030789] Starting dynamic subtest: pipe-C-HDMI-A-1
[521.873309] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.875s)
[521.876858] Subtest cursor-random-128x128: SUCCESS (8.171s)
[522.221709] [103/133] (538s left) gem_exec_schedule (implicit-write-read)
[522.382034] Starting subtest: implicit-write-read
[522.385598] Starting dynamic subtest: rcs0
[522.485583] Dynamic subtest rcs0: SUCCESS (0.108s)
[522.515523] Starting dynamic subtest: bcs0
[522.610840] Dynamic subtest bcs0: SUCCESS (0.120s)
[522.649960] Starting dynamic subtest: vcs0
[522.726406] Dynamic subtest vcs0: SUCCESS (0.106s)
[522.751489] Starting dynamic subtest: vecs0
[522.837811] Dynamic subtest vecs0: SUCCESS (0.113s)
[522.843113] Subtest implicit-write-read: SUCCESS (0.465s)
[523.259162] [104/133] (537s left) gem_bad_reloc (negative-reloc-lut)
[523.394179] Starting subtest: negative-reloc-lut
[523.406490] Subtest negative-reloc-lut: SUCCESS (0.002s)
[523.560528] [105/133] (537s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[523.784890] Starting subtest: x-tiled-addfb-size-offset-overflow
[523.789278] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[523.939918] [106/133] (537s left) kms_hdmi_inject (inject-4k)
[524.458196] Starting subtest: inject-4k
[524.819750] Subtest inject-4k: SUCCESS (0.316s)
[525.193825] [107/133] (536s left) kms_pm_backlight (fade)
[525.410335] Subtest fade: SKIP (0.000s)
[525.534901] [108/133] (536s left) prime_vgem (sync)
[525.703852] Starting subtest: sync
[525.707870] Starting dynamic subtest: rcs0
[525.724278] Dynamic subtest rcs0: SUCCESS (0.019s)
[525.748694] Starting dynamic subtest: vcs0
[525.752956] Dynamic subtest vcs0: SUCCESS (0.012s)
[525.777367] Starting dynamic subtest: vecs0
[525.781307] Dynamic subtest vecs0: SUCCESS (0.014s)
[525.784946] Subtest sync: SUCCESS (0.057s)
[525.936826] [109/133] (535s left) kms_pm_rpm (fences)
[527.884241] Starting subtest: fences
[530.837376] Subtest fences: SUCCESS (2.954s)
[531.130990] [110/133] (530s left) sw_sync (sync_busy_fork_unixsocket)
[531.254444] Starting subtest: sync_busy_fork_unixsocket
[531.289521] Subtest sync_busy_fork_unixsocket: SUCCESS (0.031s)
[531.424387] [111/133] (530s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[531.621951] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[531.627865] Starting dynamic subtest: pipe-A-HDMI-A-1
[531.645970] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[531.730484] Starting dynamic subtest: pipe-A-HDMI-A-2
[531.752905] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[531.775493] Starting dynamic subtest: pipe-B-HDMI-A-1
[531.788521] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[531.811217] Starting dynamic subtest: pipe-B-HDMI-A-2
[531.823674] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[531.851066] Starting dynamic subtest: pipe-C-HDMI-A-1
[531.868630] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[531.905863] Starting dynamic subtest: pipe-C-HDMI-A-2
[531.918584] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[531.928110] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.035s)
[532.587140] [112/133] (529s left) device_reset (cold-reset-bound)
[532.744671] Starting subtest: cold-reset-bound
[532.753512] Subtest cold-reset-bound: SKIP (0.000s)
[532.911625] [113/133] (529s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[533.119874] Starting subtest: plane-all-transition-nonblocking-fencing
[533.123359] Starting dynamic subtest: pipe-A-HDMI-A-1
[537.129558] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.005s)
[537.329290] Starting dynamic subtest: pipe-A-HDMI-A-2
[541.188447] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.879s)
[541.402720] Starting dynamic subtest: pipe-B-HDMI-A-1
[545.244583] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.872s)
[545.433408] Starting dynamic subtest: pipe-B-HDMI-A-2
[549.272508] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.871s)
[549.432075] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (16.310s)
[549.726291] [114/133] (512s left) gem_partial_pwrite_pread (write-uncached)
[549.862067] Starting subtest: write-uncached
[563.222713] Subtest write-uncached: SUCCESS (13.362s)
[563.392469] [115/133] (498s left) kms_cursor_crc (cursor-sliding-512x170)
[563.630264] Starting subtest: cursor-sliding-512x170
[563.637521] Subtest cursor-sliding-512x170: SKIP (0.004s)
[563.808761] [116/133] (498s left) kms_invalid_mode (int-max-clock)
[564.047629] Starting subtest: int-max-clock
[564.050863] Starting dynamic subtest: pipe-A-HDMI-A-1
[564.408630] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.391s)
[564.454819] Starting dynamic subtest: pipe-A-HDMI-A-2
[564.459338] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[564.509550] Starting dynamic subtest: pipe-B-HDMI-A-1
[564.512890] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.005s)
[564.545755] Starting dynamic subtest: pipe-B-HDMI-A-2
[564.549071] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[564.573723] Starting dynamic subtest: pipe-C-HDMI-A-1
[564.577073] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[564.605840] Starting dynamic subtest: pipe-C-HDMI-A-2
[564.609222] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[564.612616] Subtest int-max-clock: SUCCESS (0.433s)
[564.734109] [117/133] (497s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[564.947403] Starting subtest: disable-crc-after-crtc
[564.959900] Starting dynamic subtest: pipe-A-HDMI-A-1
[566.047780] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.091s)
[566.113706] Starting dynamic subtest: pipe-B-HDMI-A-2
[566.872060] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.823s)
[566.901897] Starting dynamic subtest: pipe-C-HDMI-A-1
[567.647649] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.767s)
[567.651702] Subtest disable-crc-after-crtc: SUCCESS (2.701s)
[567.926158] [118/133] (494s left) gem_mmap_wc (close)
[568.061294] Starting subtest: close
[568.075329] Subtest close: SUCCESS (0.013s)
[568.232375] [119/133] (494s left) vgem_basic (bad-fence)
[568.396339] Starting subtest: bad-fence
[568.400716] Subtest bad-fence: SUCCESS (0.000s)
[568.546155] [120/133] (494s left) syncobj_timeline (transfer-timeline-point)
[568.671138] Starting subtest: transfer-timeline-point
[568.675194] Subtest transfer-timeline-point: SUCCESS (0.001s)
[568.827288] [121/133] (494s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[568.968543] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[568.972078] Starting dynamic subtest: smem
[569.345942] Dynamic subtest smem: SUCCESS (0.365s)
[569.350226] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.368s)
[569.610196] [122/133] (493s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[569.814213] Starting subtest: flip-vs-cursor-busy-crc-legacy
[570.786490] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.960s)
[571.077861] [123/133] (492s left) gem_wait (busy)
[571.256557] Starting subtest: busy
[571.260282] Starting dynamic subtest: all-engines
[571.781221] Dynamic subtest all-engines: SUCCESS (0.520s)
[571.804865] Starting dynamic subtest: rcs0
[572.300479] Dynamic subtest rcs0: SUCCESS (0.518s)
[572.323647] Starting dynamic subtest: bcs0
[572.821280] Dynamic subtest bcs0: SUCCESS (0.515s)
[572.844138] Starting dynamic subtest: vcs0
[573.339261] Dynamic subtest vcs0: SUCCESS (0.511s)
[573.361814] Starting dynamic subtest: vecs0
[573.852836] Dynamic subtest vecs0: SUCCESS (0.517s)
[573.856465] Subtest busy: SUCCESS (2.597s)
[574.169157] [124/133] (489s left) kms_big_fb (linear-16bpp-rotate-270)
[574.392664] Starting subtest: linear-16bpp-rotate-270
[574.691451] Subtest linear-16bpp-rotate-270: SKIP (0.295s)
[574.945403] [125/133] (488s left) gem_exec_reloc (basic-write-read-noreloc)
[575.090784] Starting subtest: basic-write-read-noreloc
[575.094097] Subtest basic-write-read-noreloc: SUCCESS (0.007s)
[575.343767] [126/133] (488s left) gem_exec_balancer (hang)
[575.611315] Starting subtest: hang
[579.117513] Subtest hang: SUCCESS (3.505s)
[579.282212] [127/133] (484s left) gem_ctx_bad_destroy (invalid-ctx)
[579.405012] Starting subtest: invalid-ctx
[579.408367] Subtest invalid-ctx: SUCCESS (0.000s)
[579.561079] [128/133] (484s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[579.781843] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[579.788892] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[579.944645] [129/133] (483s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[580.176621] Starting subtest: 4-tiled-64bpp-rotate-270
[580.184562] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[580.325322] [130/133] (483s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[580.535900] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[580.541681] Starting dynamic subtest: pipe-A-HDMI-A-1
[580.662304] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[580.685129] Starting dynamic subtest: pipe-A-HDMI-A-2
[580.718538] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[580.741945] Starting dynamic subtest: pipe-B-HDMI-A-1
[580.774872] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[580.798284] Starting dynamic subtest: pipe-B-HDMI-A-2
[580.830974] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[580.856092] Starting dynamic subtest: pipe-C-HDMI-A-1
[580.889327] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[580.912590] Starting dynamic subtest: pipe-C-HDMI-A-2
[580.944594] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[580.951335] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.038s)
[581.505558] [131/133] (482s left) gem_render_copy_redux (flink-interruptible)
[581.652632] Starting subtest: flink-interruptible
[585.176049] Subtest flink-interruptible: SUCCESS (3.530s)
[585.351092] [132/133] (478s left) device_reset (unbind-reset-rebind)
[585.494536] Starting subtest: unbind-reset-rebind
[587.942563] Subtest unbind-reset-rebind: SUCCESS (2.444s)
[588.051157] [133/133] (476s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[588.275120] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[588.281770] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[588.428985] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: gem_ctx_engines
results: parsing output: 4/ for test: kms_dither
results: parsing output: 5/ for test: i915_pm_rc6_residency
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: kms_feature_discovery
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_exec_whisper
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: gem_exec_gttfill
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: vkms/vkms_configfs
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: dumb_buffer
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_basic
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: i915_query
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_madvise
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: kms_chamelium_audio
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: kms_color
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: kms_legacy_colorkey
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: vkms/vkms_configfs
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: gem_eio
results: parsing output: 78/ for test: gem_linear_blits
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: i915_pm_rps
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_chamelium_color
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_selftest
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_edge_walk
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_mmap
results: parsing output: 97/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 98/ for test: kms_async_flips
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: gem_bad_reloc
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_hdmi_inject
results: parsing output: 106/ for test: kms_pm_backlight
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: kms_pm_rpm
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: device_reset
results: parsing output: 112/ for test: kms_atomic_transition
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_invalid_mode
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: gem_mmap_wc
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: gem_wait
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_ctx_bad_destroy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_render_copy_redux
results: parsing output: 131/ for test: device_reset
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.