[68.137331] Initializing watchdogs [68.137374] /dev/watchdog0 [68.151041] [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] [68.155227] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [68.157352] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [68.160534] [001/132] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [68.292032] Starting subtest: psr-rgb565-draw-mmap-wc [75.030813] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.798s) [75.160633] [002/132] (953s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [75.278225] Starting subtest: flip-vs-cursor-atomic-transitions [82.756409] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.500s) [83.596592] [003/132] (945s left) i915_hangman (engine-error-state-capture) [83.688054] Starting subtest: engine-error-state-capture [83.690166] Starting dynamic subtest: rcs0 [86.901697] Dynamic subtest rcs0: SUCCESS (3.217s) [86.911871] Starting dynamic subtest: bcs0 [92.854359] Dynamic subtest bcs0: SUCCESS (5.956s) [92.864533] Starting dynamic subtest: vcs0 [98.869852] Dynamic subtest vcs0: SUCCESS (6.016s) [98.880258] Starting dynamic subtest: vcs1 [104.821851] Dynamic subtest vcs1: SUCCESS (5.949s) [104.832561] Starting dynamic subtest: vecs0 [109.827653] Dynamic subtest vecs0: SUCCESS (4.988s) [109.835690] Starting dynamic subtest: ccs0 [114.807044] Dynamic subtest ccs0: SUCCESS (4.994s) [114.810022] Subtest engine-error-state-capture: SUCCESS (31.126s) [114.909096] [004/132] (913s left) perf_pmu (frequency) [114.948745] Starting subtest: frequency [114.951184] Starting dynamic subtest: gt0 [117.157768] Dynamic subtest gt0: SUCCESS (2.201s) [117.167157] Starting dynamic subtest: idle-gt0 [117.661944] Dynamic subtest idle-gt0: SUCCESS (0.505s) [117.672348] Starting dynamic subtest: gt1 [121.894141] Dynamic subtest gt1: SUCCESS (4.228s) [121.904163] Starting dynamic subtest: idle-gt1 [122.397622] Dynamic subtest idle-gt1: SUCCESS (0.505s) [122.400378] Subtest frequency: SUCCESS (7.450s) [122.540318] [005/132] (906s left) kms_pm_dc (dc5-dpms) [123.647749] Starting subtest: dc5-dpms [125.737409] Subtest dc5-dpms: SUCCESS (2.088s) [125.836170] [006/132] (903s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [125.897942] Starting subtest: multi-wait-all-for-submit-available-submitted [125.900056] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [126.020952] [007/132] (902s left) gen9_exec_parse (basic-rejected) [126.088077] Subtest basic-rejected: SKIP (0.000s) [126.148450] [008/132] (902s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [126.251173] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [126.255314] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [126.368745] [009/132] (902s left) gem_exec_schedule (promotion) [126.453724] Starting subtest: promotion [126.455970] Starting dynamic subtest: rcs0 [126.552870] Dynamic subtest rcs0: SUCCESS (0.105s) [126.562677] Starting dynamic subtest: vcs0 [126.646716] Dynamic subtest vcs0: SUCCESS (0.093s) [126.659295] Starting dynamic subtest: vcs1 [126.728985] Dynamic subtest vcs1: SUCCESS (0.081s) [126.741503] Starting dynamic subtest: vecs0 [126.805144] Dynamic subtest vecs0: SUCCESS (0.077s) [126.816594] Starting dynamic subtest: ccs0 [126.887644] Dynamic subtest ccs0: SUCCESS (0.082s) [126.890106] Subtest promotion: SUCCESS (0.441s) [128.035607] [010/132] (900s left) kms_rotation_crc (exhaust-fences) [128.130843] Starting subtest: exhaust-fences [128.135462] Subtest exhaust-fences: SKIP (0.000s) [128.226243] [011/132] (900s left) syncobj_wait (signal) [128.274512] Starting subtest: signal [128.276433] Subtest signal: SUCCESS (0.000s) [128.405871] [012/132] (900s left) kms_color (deep-color) [128.496475] Starting subtest: deep-color [129.568164] Starting dynamic subtest: pipe-A-eDP-1-gamma [130.290258] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.724s) [130.299071] Starting dynamic subtest: pipe-A-eDP-1-degamma [131.758213] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.465s) [131.767699] Starting dynamic subtest: pipe-A-eDP-1-ctm [133.176720] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.420s) [133.971706] Starting dynamic subtest: pipe-B-eDP-1-gamma [134.682746] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.717s) [134.691011] Starting dynamic subtest: pipe-B-eDP-1-degamma [136.159833] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.477s) [136.169244] Starting dynamic subtest: pipe-B-eDP-1-ctm [137.573956] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.415s) [138.378166] Starting dynamic subtest: pipe-C-eDP-1-gamma [139.091653] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.720s) [139.099554] Starting dynamic subtest: pipe-C-eDP-1-degamma [140.555732] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.464s) [140.564939] Starting dynamic subtest: pipe-C-eDP-1-ctm [141.934648] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.379s) [142.762321] Starting dynamic subtest: pipe-D-eDP-1-gamma [143.420295] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.662s) [143.428839] Starting dynamic subtest: pipe-D-eDP-1-degamma [144.825380] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.404s) [144.834482] Starting dynamic subtest: pipe-D-eDP-1-ctm [146.236466] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.410s) [146.238925] Subtest deep-color: SUCCESS (17.737s) [147.121831] [013/132] (881s left) gem_exec_fence (syncobj-signal) [147.568022] Starting subtest: syncobj-signal [147.573265] Subtest syncobj-signal: SUCCESS (0.004s) [149.010710] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true [149.013789] [014/132] (880s left) gem_exec_balancer (semaphore) [149.084895] Starting subtest: semaphore [150.945611] Subtest semaphore: SUCCESS (1.859s) [151.272736] [015/132] (877s left) gem_workarounds (suspend-resume-context) [151.340723] Starting subtest: suspend-resume-context [167.963229] Subtest suspend-resume-context: SUCCESS (1.290s) [168.116068] [016/132] (861s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [168.230049] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [168.232353] Starting dynamic subtest: pipe-A-eDP-1 [168.262739] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [168.271938] Starting dynamic subtest: pipe-B-eDP-1 [168.293388] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [168.303638] Starting dynamic subtest: pipe-C-eDP-1 [168.324424] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [168.333204] Starting dynamic subtest: pipe-D-eDP-1 [168.355515] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [168.359637] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [170.488290] [017/132] (858s left) gem_spin_batch (resubmit-new) [170.544724] Starting subtest: resubmit-new [170.547005] Starting dynamic subtest: rcs0 [170.551908] Dynamic subtest rcs0: SUCCESS (0.007s) [170.562523] Starting dynamic subtest: bcs0 [170.564674] Dynamic subtest bcs0: SUCCESS (0.004s) [170.573513] Starting dynamic subtest: vcs0 [170.575829] Dynamic subtest vcs0: SUCCESS (0.004s) [170.584012] Starting dynamic subtest: vcs1 [170.586148] Dynamic subtest vcs1: SUCCESS (0.004s) [170.594290] Starting dynamic subtest: vecs0 [170.596501] Dynamic subtest vecs0: SUCCESS (0.004s) [170.604617] Starting dynamic subtest: ccs0 [170.606778] Dynamic subtest ccs0: SUCCESS (0.004s) [170.608980] Subtest resubmit-new: SUCCESS (0.030s) [172.277598] [018/132] (857s left) kms_pm_rpm (i2c) [174.418807] Starting subtest: i2c [179.720517] Subtest i2c: SUCCESS (5.335s) [179.831307] [019/132] (849s left) gem_pxp (display-protected-crc) [179.964562] Starting subtest: display-protected-crc [181.616839] Subtest display-protected-crc: SUCCESS (1.661s) [181.781886] [020/132] (847s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [181.873593] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [181.875922] Starting dynamic subtest: pipe-A-eDP-1 [181.897793] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [181.908909] Starting dynamic subtest: pipe-B-eDP-1 [181.929313] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [181.938022] Starting dynamic subtest: pipe-C-eDP-1 [181.960069] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [181.970267] Starting dynamic subtest: pipe-D-eDP-1 [181.991751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [181.996049] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [184.181433] [021/132] (845s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [184.278588] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [184.283116] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [185.386185] [022/132] (844s left) i915_selftest (live) [187.324237] Starting subtest: live [187.326492] Starting dynamic subtest: sanitycheck [191.803151] Dynamic subtest sanitycheck: SUCCESS (4.482s) [191.812602] Starting dynamic subtest: uncore [196.246734] Dynamic subtest uncore: SUCCESS (4.450s) [196.256312] Starting dynamic subtest: workarounds [199.523701] Dynamic subtest workarounds: SUCCESS (3.278s) [199.533739] Starting dynamic subtest: gt_engines [204.192528] Dynamic subtest gt_engines: SUCCESS (4.670s) [204.202378] Starting dynamic subtest: gt_timelines [219.847576] Dynamic subtest gt_timelines: SUCCESS (15.663s) [219.857164] Starting dynamic subtest: gt_contexts [224.308406] Dynamic subtest gt_contexts: SUCCESS (4.461s) [224.316261] Starting dynamic subtest: gt_lrc [228.770186] Dynamic subtest gt_lrc: SUCCESS (4.463s) [228.779687] Starting dynamic subtest: gt_mocs [231.853790] Dynamic subtest gt_mocs: SUCCESS (3.084s) [231.862474] Starting dynamic subtest: gt_pm [238.715316] Dynamic subtest gt_pm: SUCCESS (6.862s) [238.725549] Starting dynamic subtest: gt_heartbeat [243.146228] Dynamic subtest gt_heartbeat: SUCCESS (4.431s) [243.155820] Starting dynamic subtest: gt_tlb [252.625087] Dynamic subtest gt_tlb: SUCCESS (9.482s) [252.635012] Starting dynamic subtest: requests [266.279293] Dynamic subtest requests: SUCCESS (13.648s) [266.289061] Starting dynamic subtest: migrate [274.384433] Dynamic subtest migrate: SUCCESS (8.083s) [274.394661] Starting dynamic subtest: active [278.860201] Dynamic subtest active: SUCCESS (4.467s) [278.868780] Starting dynamic subtest: objects [283.819247] Dynamic subtest objects: SUCCESS (4.951s) [283.833830] Starting dynamic subtest: mman [288.817226] Dynamic subtest mman: SUCCESS (4.992s) [288.826943] Starting dynamic subtest: dmabuf [293.250191] Dynamic subtest dmabuf: SUCCESS (4.429s) [293.259814] Starting dynamic subtest: vma [297.683755] Dynamic subtest vma: SUCCESS (4.429s) [297.693638] Starting dynamic subtest: coherency [301.700246] Dynamic subtest coherency: SUCCESS (4.013s) [301.709970] Starting dynamic subtest: gtt [311.494412] Dynamic subtest gtt: SUCCESS (9.790s) [311.504329] Starting dynamic subtest: gem [319.061317] Dynamic subtest gem: SUCCESS (7.565s) [319.071148] Starting dynamic subtest: evict [323.107944] Dynamic subtest evict: SUCCESS (4.045s) [323.117534] Starting dynamic subtest: hugepages [334.308103] Dynamic subtest hugepages: SUCCESS (11.196s) [334.317625] Starting dynamic subtest: gem_contexts [363.286329] Dynamic subtest gem_contexts: SUCCESS (28.974s) [363.296485] Starting dynamic subtest: client [367.749286] Dynamic subtest client: SUCCESS (4.461s) [367.759138] Starting dynamic subtest: gem_migrate [372.240240] Dynamic subtest gem_migrate: SUCCESS (4.488s) [372.250417] Starting dynamic subtest: reset [375.141797] Dynamic subtest reset: SUCCESS (2.899s) [375.151314] Starting dynamic subtest: memory_region [379.507474] Dynamic subtest memory_region: SUCCESS (4.364s) [379.517209] Starting dynamic subtest: hangcheck [392.771814] Dynamic subtest hangcheck: SUCCESS (13.260s) [392.781651] Starting dynamic subtest: execlists [397.244355] Dynamic subtest execlists: SUCCESS (4.474s) [397.254274] Starting dynamic subtest: ring_submission [401.711170] Dynamic subtest ring_submission: SUCCESS (4.465s) [401.720964] Starting dynamic subtest: perf [406.231926] Dynamic subtest perf: SUCCESS (4.519s) [406.241303] Starting dynamic subtest: slpc [420.398689] Dynamic subtest slpc: SUCCESS (14.165s) [420.408574] Starting dynamic subtest: guc [424.458026] Dynamic subtest guc: SUCCESS (4.057s) [424.467833] Starting dynamic subtest: guc_multi_lrc [428.916564] Dynamic subtest guc_multi_lrc: SUCCESS (4.457s) [428.925388] Starting dynamic subtest: guc_hang [433.941128] Dynamic subtest guc_hang: SUCCESS (5.022s) [433.950944] Starting dynamic subtest: late_gt_pm [436.804912] Dynamic subtest late_gt_pm: SUCCESS (2.862s) [436.807833] Subtest live: SUCCESS (249.473s) [436.836312] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [436.837110] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [436.840285] [023/132] (592s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [438.398662] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [445.203269] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.806s) [445.370671] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [445.371901] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true [445.375979] [024/132] (584s left) perf (gen12-oa-tlb-invalidate) [445.524826] Starting subtest: gen12-oa-tlb-invalidate [445.527085] Starting dynamic subtest: 0-rcs0 [455.559320] Dynamic subtest 0-rcs0: SUCCESS (10.033s) [455.568672] Starting dynamic subtest: 1-vcs1 [465.610981] Dynamic subtest 1-vcs1: SUCCESS (10.048s) [465.613502] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.084s) [465.650158] [025/132] (563s left) kms_addfb_basic (too-wide) [465.762834] Starting subtest: too-wide [465.764793] Subtest too-wide: SUCCESS (0.000s) [465.894066] [026/132] (563s left) kms_big_fb (linear-8bpp-rotate-180) [465.996247] Starting subtest: linear-8bpp-rotate-180 [467.572043] Subtest linear-8bpp-rotate-180: SUCCESS (1.576s) [467.718478] [027/132] (561s left) kms_getfb (getfb-reject-nv12) [467.818993] Starting subtest: getfb-reject-nv12 [467.821127] Subtest getfb-reject-nv12: SUCCESS (0.001s) [467.947728] [028/132] (561s left) kms_plane (plane-panning-bottom-right) [468.042129] Starting subtest: plane-panning-bottom-right [468.044073] Starting dynamic subtest: pipe-A [469.774251] Dynamic subtest pipe-A: SUCCESS (1.731s) [469.784860] Starting dynamic subtest: pipe-B [472.199388] Dynamic subtest pipe-B: SUCCESS (2.422s) [472.201366] Subtest plane-panning-bottom-right: SUCCESS (4.155s) [473.041075] [029/132] (556s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [473.120022] Starting subtest: map-fixed-invalidate-overlap-busy [473.124668] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [473.273452] [030/132] (556s left) prime_vgem (basic-write) [473.338606] Starting subtest: basic-write [473.348262] Subtest basic-write: SKIP (0.007s) [473.474773] [031/132] (556s left) gem_exec_whisper (basic-contexts-forked-all) [473.537251] Starting subtest: basic-contexts-forked-all [494.213129] Subtest basic-contexts-forked-all: SUCCESS (20.670s) [494.423318] [032/132] (535s left) kms_psr (fbc-pr-cursor-blt) [494.518806] Starting subtest: fbc-pr-cursor-blt [494.523291] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [494.615622] [033/132] (535s left) gen7_exec_parse (basic-allowed) [494.675106] Subtest basic-allowed: SKIP (0.000s) [494.756776] [034/132] (535s left) core_auth (getclient-simple) [494.790106] Starting subtest: getclient-simple [494.802899] Subtest getclient-simple: SUCCESS (0.012s) [494.930398] [035/132] (535s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [495.015709] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [495.018020] Starting dynamic subtest: pipe-A-default-mode [495.303639] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [495.308282] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.288s) [496.173016] [036/132] (533s left) gem_create (create-ext-placement-sanity-check) [496.345732] Starting subtest: create-ext-placement-sanity-check [496.348188] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s) [496.470264] [037/132] (533s left) kms_psr (psr2-sprite-blt) [496.571703] Starting subtest: psr2-sprite-blt [496.574054] Starting dynamic subtest: eDP-1 [498.350999] Dynamic subtest eDP-1: SUCCESS (1.777s) [498.353278] Subtest psr2-sprite-blt: SUCCESS (1.779s) [499.241944] [038/132] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [499.350317] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [499.354649] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [499.489072] [039/132] (530s left) gem_ctx_persistence (engines-hang) [499.544235] Starting subtest: engines-hang [499.546457] Starting dynamic subtest: rcs0 [499.626620] Dynamic subtest rcs0: SUCCESS (0.082s) [499.639068] Starting dynamic subtest: bcs0 [499.747512] Dynamic subtest bcs0: SUCCESS (0.119s) [499.759005] Starting dynamic subtest: vcs0 [499.868755] Dynamic subtest vcs0: SUCCESS (0.119s) [499.880712] Starting dynamic subtest: vcs1 [499.984456] Dynamic subtest vcs1: SUCCESS (0.114s) [499.996342] Starting dynamic subtest: vecs0 [500.085462] Dynamic subtest vecs0: SUCCESS (0.099s) [500.096910] Starting dynamic subtest: ccs0 [500.161151] Dynamic subtest ccs0: SUCCESS (0.074s) [500.163247] Subtest engines-hang: SUCCESS (0.618s) [500.306049] [040/132] (529s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [500.416466] Starting subtest: cursorA-vs-flipB-atomic [500.420358] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [500.591393] [041/132] (529s left) gem_exec_reloc (basic-write-gtt) [500.657061] Subtest basic-write-gtt: SKIP (0.000s) [500.727341] [042/132] (529s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [500.787655] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [500.895904] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s) [500.994872] [043/132] (529s left) gem_render_copy (linear-to-vebox-yf-tiled) [501.057688] Starting subtest: linear-to-vebox-yf-tiled [501.061903] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [501.263763] [044/132] (529s left) kms_addfb_basic (invalid-get-prop-any) [501.326471] Starting subtest: invalid-get-prop-any [501.328650] Subtest invalid-get-prop-any: SUCCESS (0.000s) [501.477089] [045/132] (528s left) kms_flip (busy-flip) [501.568918] Starting subtest: busy-flip [501.577019] Starting dynamic subtest: A-eDP1 [503.233092] Dynamic subtest A-eDP1: SUCCESS (1.665s) [503.244713] Starting dynamic subtest: B-eDP1 [504.967862] Dynamic subtest B-eDP1: SUCCESS (1.733s) [504.987367] Starting dynamic subtest: C-eDP1 [506.678789] Dynamic subtest C-eDP1: SUCCESS (1.708s) [506.692184] Starting dynamic subtest: D-eDP1 [508.319087] Dynamic subtest D-eDP1: SUCCESS (1.639s) [508.321504] Subtest busy-flip: SUCCESS (6.755s) [509.521841] [046/132] (520s left) gem_readwrite (read-bad-handle) [509.587771] Subtest read-bad-handle: SKIP (0.000s) [509.652287] [047/132] (520s left) core_getstats (basic) [509.705993] Starting subtest: basic [509.708311] Subtest basic: SUCCESS (0.000s) [509.837396] [048/132] (520s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [509.954356] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [510.578077] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s) [510.763373] [049/132] (519s left) kms_atomic (plane-invalid-params-fence) [510.867688] Starting subtest: plane-invalid-params-fence [510.869594] Starting dynamic subtest: pipe-A-eDP-1 [511.247352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.379s) [511.249646] Subtest plane-invalid-params-fence: SUCCESS (0.380s) [512.064810] [050/132] (518s left) kms_pm_rpm (pc8-residency) [513.596981] Starting subtest: pc8-residency [513.601783] Subtest pc8-residency: SKIP (0.000s) [514.316095] [051/132] (516s left) kms_psr2_su (frontbuffer-xrgb8888) [514.378585] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [514.453595] [052/132] (516s left) syncobj_timeline (etime-single-wait-submitted) [514.509615] Starting subtest: etime-single-wait-submitted [514.615786] Subtest etime-single-wait-submitted: SUCCESS (0.106s) [514.712580] [053/132] (516s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [514.820126] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [514.824159] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [514.956225] [054/132] (515s left) kms_chamelium_color (ctm-blue-to-red) [515.049576] Subtest ctm-blue-to-red: SKIP (0.000s) [515.093445] [055/132] (515s left) syncobj_wait (multi-wait-all-signaled) [515.152581] Starting subtest: multi-wait-all-signaled [515.154453] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [515.276299] [056/132] (515s left) prime_mmap (test_correct_cpu_write) [515.338667] Starting subtest: test_correct_cpu_write [515.340917] Starting dynamic subtest: test_correct_cpu_write-smem [515.343113] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [515.345178] Subtest test_correct_cpu_write: SUCCESS (0.001s) [515.479392] [057/132] (515s left) gem_exec_reloc (basic-concurrent16) [515.544707] Subtest basic-concurrent16: SKIP (0.000s) [515.639026] [058/132] (515s left) vgem_basic (bad-handle) [515.677527] Starting subtest: bad-handle [515.679215] Subtest bad-handle: SUCCESS (0.000s) [515.761552] [059/132] (515s left) gem_userptr_blits (readonly-pwrite-unsync) [515.830474] Subtest readonly-pwrite-unsync: SKIP (0.000s) [516.000245] [060/132] (515s left) gem_exec_schedule (implicit-read-write) [516.071381] Starting subtest: implicit-read-write [516.073260] Starting dynamic subtest: rcs0 [516.166339] Dynamic subtest rcs0: SUCCESS (0.101s) [516.176499] Starting dynamic subtest: vcs0 [516.247237] Dynamic subtest vcs0: SUCCESS (0.079s) [516.259580] Starting dynamic subtest: vcs1 [516.323728] Dynamic subtest vcs1: SUCCESS (0.076s) [516.337344] Starting dynamic subtest: vecs0 [516.397299] Dynamic subtest vecs0: SUCCESS (0.073s) [516.409247] Starting dynamic subtest: ccs0 [516.475135] Dynamic subtest ccs0: SUCCESS (0.077s) [516.477157] Subtest implicit-read-write: SUCCESS (0.411s) [518.411817] [061/132] (512s left) gem_tiled_fence_blits (normal) [518.478223] Subtest normal: SKIP (0.000s) [518.555750] [062/132] (512s left) i915_pm_rpm (gem-idle) [520.372892] Starting subtest: gem-idle [526.573482] Subtest gem-idle: SUCCESS (6.203s) [526.934958] [063/132] (504s left) kms_content_protection (content-type-change) [528.244767] Starting subtest: content-type-change [528.249157] Subtest content-type-change: SKIP (0.000s) [528.421179] [064/132] (502s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [528.538560] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [532.227218] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.693s) [533.436942] [065/132] (497s left) kms_vblank (ts-continuation-dpms-suspend) [533.539910] Starting subtest: ts-continuation-dpms-suspend [533.542321] Starting dynamic subtest: pipe-A-eDP-1 [550.508570] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.857s) [550.527743] Starting dynamic subtest: pipe-D-eDP-1 [568.518412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.482s) [568.520718] Subtest ts-continuation-dpms-suspend: SUCCESS (4.343s) [569.342979] [066/132] (461s left) perf_pmu (most-busy-idle-check-all) [569.393727] Starting subtest: most-busy-idle-check-all [569.395965] Starting dynamic subtest: rcs0 [570.093532] Dynamic subtest rcs0: FAIL (0.650s) [570.103780] Starting dynamic subtest: bcs0 [570.894886] Dynamic subtest bcs0: SUCCESS (0.868s) [570.907802] Starting dynamic subtest: vcs0 [572.941649] Dynamic subtest vcs0: SUCCESS (2.063s) [572.953913] Starting dynamic subtest: vcs1 [574.927379] Dynamic subtest vcs1: SUCCESS (1.996s) [574.938606] Starting dynamic subtest: vecs0 [576.910250] Dynamic subtest vecs0: SUCCESS (1.993s) [576.921054] Starting dynamic subtest: ccs0 [578.895002] Dynamic subtest ccs0: SUCCESS (1.991s) [578.897783] Subtest most-busy-idle-check-all: FAIL (9.574s) [579.026878] [067/132] (452s left) gem_exec_balancer (full-pulse) [579.099147] Starting subtest: full-pulse [583.780897] Subtest full-pulse: SUCCESS (4.696s) [584.129686] [068/132] (447s left) kms_invalid_mode (bad-hsync-end) [584.235564] Starting subtest: bad-hsync-end [584.237692] Starting dynamic subtest: pipe-A-eDP-1 [584.526084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [584.535976] Starting dynamic subtest: pipe-B-eDP-1 [584.537857] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [584.546345] Starting dynamic subtest: pipe-C-eDP-1 [584.548190] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [584.557210] Starting dynamic subtest: pipe-D-eDP-1 [584.559319] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [584.561579] Subtest bad-hsync-end: SUCCESS (0.300s) [585.377303] [069/132] (446s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [585.438175] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [585.440555] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [585.574119] [070/132] (445s left) kms_draw_crc (fill-fb) [585.676431] Starting subtest: fill-fb [586.095496] Subtest fill-fb: SUCCESS (0.421s) [586.246886] [071/132] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [586.333692] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [586.337009] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [586.463664] [072/132] (445s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [586.564114] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [593.920699] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.366s) [594.081967] [073/132] (437s left) syncobj_timeline (multi-wait-submitted-signaled) [594.152361] Starting subtest: multi-wait-submitted-signaled [594.154689] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [594.276899] [074/132] (437s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [594.362934] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [594.367316] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [594.487633] [075/132] (437s left) kms_lease (invalid-create-leases) [594.584573] Starting subtest: invalid-create-leases [594.589410] Subtest invalid-create-leases: SUCCESS (0.005s) [594.733658] [076/132] (436s left) gem_render_copy (linear) [594.799768] Starting subtest: linear [594.802058] Starting dynamic subtest: smem [594.837764] Dynamic subtest smem: SUCCESS (0.038s) [594.840158] Subtest linear: SUCCESS (0.039s) [595.109927] [077/132] (436s left) gem_mmap_offset (clear-via-pagefault) [595.176058] Starting subtest: clear-via-pagefault [595.178017] Starting dynamic subtest: smem0 [628.930136] Dynamic subtest smem0: SUCCESS (33.752s) [628.932628] Subtest clear-via-pagefault: SUCCESS (33.754s) [629.070225] [078/132] (402s left) i915_query (query-garbage) [629.134281] Starting subtest: query-garbage [629.137158] Subtest query-garbage: SUCCESS (0.000s) [629.274095] [079/132] (402s left) gem_exec_whisper (basic-queues-forked-all) [629.330774] Starting subtest: basic-queues-forked-all [651.089132] Subtest basic-queues-forked-all: SUCCESS (21.762s) [651.298296] [080/132] (380s left) gem_media_fill (media-fill) [651.366021] Subtest media-fill: SKIP (0.000s) [651.519972] [081/132] (380s left) i915_query (query-topology-kernel-writes) [651.574131] Starting subtest: query-topology-kernel-writes [651.576293] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [651.719733] [082/132] (380s left) kms_flip (2x-flip-vs-rmfb) [651.829017] Starting subtest: 2x-flip-vs-rmfb [651.838588] Subtest 2x-flip-vs-rmfb: SKIP (0.010s) [651.978912] [083/132] (380s left) kms_psr (pr-primary-mmap-cpu) [652.066297] Starting subtest: pr-primary-mmap-cpu [652.070619] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [652.163263] [084/132] (379s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [652.266594] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [652.269873] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [652.374595] [085/132] (379s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [652.439797] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [652.443189] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [652.647661] [086/132] (379s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [652.767559] Starting subtest: modeset-atomic-cursor-hotspot [652.772164] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [652.935162] [087/132] (379s left) perf (blocking-parameterized) [653.035257] Starting subtest: blocking-parameterized [673.055873] Subtest blocking-parameterized: SUCCESS (20.018s) [673.105735] [088/132] (359s left) kms_frontbuffer_tracking (psr-1p-rte) [673.207239] Starting subtest: psr-1p-rte [678.649655] Subtest psr-1p-rte: SUCCESS (5.444s) [678.808692] [089/132] (353s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [678.911404] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [678.915650] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [679.043912] [090/132] (353s left) kms_psr2_sf (pr-cursor-plane-update-sf) [684.068686] Starting subtest: pr-cursor-plane-update-sf [684.073113] Subtest pr-cursor-plane-update-sf: SKIP (0.002s) [684.942062] [091/132] (347s left) kms_async_flips (async-flip-suspend-resume) [685.039425] Starting subtest: async-flip-suspend-resume [685.421707] Starting dynamic subtest: pipe-A-eDP-1 [702.974387] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.917s) [703.342703] Starting dynamic subtest: pipe-B-eDP-1 [720.980865] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.910s) [721.329356] Starting dynamic subtest: pipe-C-eDP-1 [738.997195] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.952s) [739.358627] Starting dynamic subtest: pipe-D-eDP-1 [756.983659] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.908s) [756.985916] Subtest async-flip-suspend-resume: SUCCESS (13.145s) [758.178691] [092/132] (274s left) prime_mmap_coherency (ioctl-errors) [758.268404] Starting subtest: ioctl-errors [773.302612] Subtest ioctl-errors: SUCCESS (15.107s) [773.482869] [093/132] (258s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [773.636274] Starting subtest: psr-rgb101010-draw-mmap-cpu [780.634845] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.008s) [780.786535] [094/132] (251s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [780.881762] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [780.885988] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [780.987773] [095/132] (251s left) kms_fb_coherency (memset-crc) [781.084446] Starting subtest: memset-crc [781.086684] Starting dynamic subtest: mmap-offset-wc [781.464252] Dynamic subtest mmap-offset-wc: SUCCESS (0.381s) [781.756367] Starting dynamic subtest: mmap-offset-uc [787.800786] Dynamic subtest mmap-offset-uc: SUCCESS (6.059s) [788.091224] Subtest memset-crc: SUCCESS (7.012s) [788.971231] [096/132] (243s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [789.071984] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [789.074241] Starting dynamic subtest: pipe-A-default-mode [791.804219] Dynamic subtest pipe-A-default-mode: SUCCESS (2.734s) [791.806771] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.735s) [792.660486] [097/132] (239s left) gem_ppgtt (blt-vs-render-ctxn) [792.724124] Starting subtest: blt-vs-render-ctxN [825.458547] Subtest blt-vs-render-ctxN: SUCCESS (32.742s) [825.618614] [098/132] (207s left) i915_drm_fdinfo (busy-idle) [825.694617] Starting subtest: busy-idle [825.696771] Starting dynamic subtest: rcs0 [825.731584] Dynamic subtest rcs0: SKIP (0.036s) [825.743888] Starting dynamic subtest: bcs0 [825.748138] Dynamic subtest bcs0: SKIP (0.000s) [825.758522] Starting dynamic subtest: vcs0 [825.762898] Dynamic subtest vcs0: SKIP (0.000s) [825.772933] Starting dynamic subtest: vcs1 [825.777219] Dynamic subtest vcs1: SKIP (0.000s) [825.787260] Starting dynamic subtest: vecs0 [825.791655] Dynamic subtest vecs0: SKIP (0.000s) [825.801869] Starting dynamic subtest: ccs0 [825.806284] Dynamic subtest ccs0: SKIP (0.000s) [825.810656] Subtest busy-idle: SKIP (0.042s) [825.847933] [099/132] (206s left) kms_frontbuffer_tracking (fbc-1p-rte) [825.973221] Starting subtest: fbc-1p-rte [831.409171] Subtest fbc-1p-rte: SUCCESS (5.438s) [832.647709] [100/132] (200s left) dumb_buffer (map-valid) [832.710296] Starting subtest: map-valid [832.712672] Subtest map-valid: SUCCESS (0.000s) [832.844833] [101/132] (199s left) kms_chamelium_edid (dp-edid-resolution-list) [833.252302] Subtest dp-edid-resolution-list: SKIP (0.000s) [834.027680] [102/132] (198s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [834.126610] Starting subtest: fbc-dirtyfb-ioctl [834.128881] Starting dynamic subtest: A-eDP-1 [836.720652] Dynamic subtest A-eDP-1: SUCCESS (2.594s) [836.722934] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.596s) [837.627431] [103/132] (195s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [837.730971] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [837.735028] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [837.871337] [104/132] (195s left) prime_vgem (fence-wait) [837.954089] Starting subtest: fence-wait [837.956442] Starting dynamic subtest: rcs0 [839.021088] Dynamic subtest rcs0: SUCCESS (1.065s) [839.034187] Starting dynamic subtest: bcs0 [840.093146] Dynamic subtest bcs0: SUCCESS (1.071s) [840.106663] Starting dynamic subtest: vcs0 [841.138337] Dynamic subtest vcs0: SUCCESS (1.043s) [841.151931] Starting dynamic subtest: vcs1 [842.176457] Dynamic subtest vcs1: SUCCESS (1.037s) [842.190193] Starting dynamic subtest: vecs0 [843.218925] Dynamic subtest vecs0: SUCCESS (1.041s) [843.232326] Starting dynamic subtest: ccs0 [844.262890] Dynamic subtest ccs0: SUCCESS (1.041s) [844.265817] Subtest fence-wait: SUCCESS (6.307s) [844.427822] [105/132] (188s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [844.536046] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [844.540507] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [844.670909] [106/132] (188s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [844.779876] Starting subtest: yf-tiled-64bpp-rotate-0 [844.783961] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [844.911812] [107/132] (188s left) gem_ctx_persistence (legacy-engines-mixed) [844.974401] Starting subtest: legacy-engines-mixed [844.976765] Starting dynamic subtest: render [845.092547] Dynamic subtest render: SUCCESS (0.117s) [845.106653] Starting dynamic subtest: bsd1 [845.175577] Dynamic subtest bsd1: SUCCESS (0.080s) [845.188532] Starting dynamic subtest: bsd2 [845.252725] Dynamic subtest bsd2: SUCCESS (0.074s) [845.266544] Starting dynamic subtest: blt [845.336374] Dynamic subtest blt: SUCCESS (0.081s) [845.351923] Starting dynamic subtest: vebox [845.425355] Dynamic subtest vebox: SUCCESS (0.086s) [845.427914] Subtest legacy-engines-mixed: SUCCESS (0.452s) [845.529513] [108/132] (187s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [845.628328] Starting subtest: fbc-2p-pri-indfb-multidraw [845.631836] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [845.759531] [109/132] (187s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [845.855623] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [845.859166] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [845.977728] [110/132] (187s left) syncobj_wait (wait-any-snapshot) [846.039794] Starting subtest: wait-any-snapshot [846.121925] Subtest wait-any-snapshot: SUCCESS (0.081s) [846.223097] [111/132] (186s left) kms_psr (psr-sprite-blt) [846.316945] Starting subtest: psr-sprite-blt [846.318913] Starting dynamic subtest: eDP-1 [848.026963] Dynamic subtest eDP-1: SUCCESS (1.709s) [848.029374] Subtest psr-sprite-blt: SUCCESS (1.710s) [848.890049] [112/132] (184s left) kms_cursor_crc (cursor-onscreen-256x256) [849.144537] Starting subtest: cursor-onscreen-256x256 [849.149710] Starting dynamic subtest: pipe-A-eDP-1 [851.279346] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.127s) [851.309617] Starting dynamic subtest: pipe-D-eDP-1 [854.018226] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.718s) [854.020656] Subtest cursor-onscreen-256x256: SUCCESS (4.873s) [854.849791] [113/132] (178s left) kms_big_fb (x-tiled-64bpp-rotate-90) [854.946713] Starting subtest: x-tiled-64bpp-rotate-90 [854.966570] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [855.116901] [114/132] (178s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [855.243137] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [855.247632] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [855.414337] [115/132] (177s left) gem_ctx_shared (q-in-order) [855.486797] Starting subtest: Q-in-order [855.489194] Starting dynamic subtest: rcs0 [855.596297] Dynamic subtest rcs0: SUCCESS (0.107s) [855.615449] Starting dynamic subtest: vcs0 [855.681916] Dynamic subtest vcs0: SUCCESS (0.086s) [855.701745] Starting dynamic subtest: vcs1 [855.765402] Dynamic subtest vcs1: SUCCESS (0.082s) [855.781799] Starting dynamic subtest: vecs0 [855.838925] Dynamic subtest vecs0: SUCCESS (0.072s) [855.856454] Starting dynamic subtest: ccs0 [855.915175] Dynamic subtest ccs0: SUCCESS (0.075s) [855.917776] Subtest Q-in-order: SUCCESS (0.427s) [856.954368] [116/132] (176s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [857.068207] Starting subtest: fbc-rgb101010-draw-mmap-wc [861.626380] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.561s) [862.784846] [117/132] (170s left) syncobj_wait (invalid-reset-zero-handles) [862.843340] Starting subtest: invalid-reset-zero-handles [862.845777] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [862.987577] [118/132] (170s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [863.071152] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [863.073403] Starting dynamic subtest: pipe-A [863.093034] Dynamic subtest pipe-A: SKIP (0.016s) [863.104906] Starting dynamic subtest: pipe-B [863.122181] Dynamic subtest pipe-B: SKIP (0.030s) [863.133342] Starting dynamic subtest: pipe-C [863.154366] Dynamic subtest pipe-C: SKIP (0.030s) [863.165219] Starting dynamic subtest: pipe-D [863.181928] Dynamic subtest pipe-D: SKIP (0.029s) [863.185658] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.108s) [863.323913] [119/132] (170s left) kms_big_fb (y-tiled-16bpp-rotate-90) [863.421264] Starting subtest: y-tiled-16bpp-rotate-90 [863.425774] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [863.533535] [120/132] (170s left) kms_psr (fbc-psr-cursor-mmap-gtt) [863.621427] Starting subtest: fbc-psr-cursor-mmap-gtt [863.623694] Starting dynamic subtest: eDP-1 [863.627627] Dynamic subtest eDP-1: SKIP (0.000s) [863.631701] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [863.719610] [121/132] (169s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [863.841869] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [863.843416] Starting dynamic subtest: pipe-A-eDP-1 [864.558326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [864.568925] Starting dynamic subtest: pipe-B-eDP-1 [866.348873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.789s) [866.361519] Starting dynamic subtest: pipe-C-eDP-1 [868.101185] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.751s) [868.112811] Starting dynamic subtest: pipe-D-eDP-1 [869.931742] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.829s) [869.933724] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.084s) [871.107584] [122/132] (162s left) kms_busy (basic) [871.208607] Starting subtest: basic [871.210989] Starting dynamic subtest: flip [871.875345] Dynamic subtest flip: SUCCESS (0.667s) [871.886733] Starting dynamic subtest: modeset [875.547968] Dynamic subtest modeset: SUCCESS (3.672s) [875.550434] Subtest basic: SUCCESS (4.342s) [876.383893] [123/132] (157s left) kms_cursor_crc (cursor-rapid-movement-512x170) [876.662612] Starting subtest: cursor-rapid-movement-512x170 [876.666376] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [876.865561] [124/132] (156s left) kms_plane_alpha_blend (constant-alpha-min) [876.962396] Starting subtest: constant-alpha-min [877.240131] Starting dynamic subtest: pipe-A-eDP-1 [877.938226] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s) [877.950022] Starting dynamic subtest: pipe-D-eDP-1 [879.452305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.511s) [879.455207] Subtest constant-alpha-min: SUCCESS (2.491s) [880.343144] [125/132] (153s left) prime_self_import (basic-llseek-bad) [880.379334] Starting subtest: basic-llseek-bad [880.403320] Subtest basic-llseek-bad: SUCCESS (0.024s) [880.528863] [126/132] (153s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [880.906912] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [881.729789] [127/132] (152s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [881.847335] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [881.850545] Starting dynamic subtest: A-eDP1 [890.787881] Dynamic subtest A-eDP1: SUCCESS (8.939s) [890.800945] Starting dynamic subtest: B-eDP1 [899.712005] Dynamic subtest B-eDP1: SUCCESS (8.925s) [899.729029] Starting dynamic subtest: C-eDP1 [908.630191] Dynamic subtest C-eDP1: SUCCESS (8.919s) [908.641502] Starting dynamic subtest: D-eDP1 [917.464314] Dynamic subtest D-eDP1: SUCCESS (8.835s) [917.470341] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.631s) [918.724340] [128/132] (115s left) gem_exec_parallel (fds) [918.790851] Starting subtest: fds [918.793255] Starting dynamic subtest: rcs0 [921.450338] Dynamic subtest rcs0: SUCCESS (2.658s) [921.463984] Starting dynamic subtest: bcs0 [924.974812] Dynamic subtest bcs0: SUCCESS (3.523s) [924.989102] Starting dynamic subtest: vcs0 [929.157066] Dynamic subtest vcs0: SUCCESS (4.183s) [929.169308] Starting dynamic subtest: vcs1 [933.083519] Dynamic subtest vcs1: SUCCESS (3.925s) [933.097403] Starting dynamic subtest: vecs0 [937.123865] Dynamic subtest vecs0: SUCCESS (4.039s) [937.137851] Starting dynamic subtest: ccs0 [940.715699] Dynamic subtest ccs0: SUCCESS (3.590s) [940.718640] Subtest fds: SUCCESS (21.931s) [940.937566] [129/132] ( 93s left) prime_vgem (fence-write-hang) [941.021912] Subtest fence-write-hang: SKIP (0.000s) [941.130712] [130/132] ( 92s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [941.229727] Starting subtest: fbc-modesetfrombusy [945.022594] Subtest fbc-modesetfrombusy: SUCCESS (3.798s) [946.225742] [131/132] ( 87s left) syncobj_timeline (wait-all-for-submit-snapshot) [946.283898] Starting subtest: wait-all-for-submit-snapshot [946.365063] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [946.466058] [132/132] ( 87s left) kms_scaling_modes (scaling-mode-center) [946.564142] Starting subtest: scaling-mode-center [946.566319] Starting dynamic subtest: pipe-A-eDP-1 [946.661960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.100s) [946.673841] Starting dynamic subtest: pipe-B-eDP-1 [947.811019] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s) [947.831860] Starting dynamic subtest: pipe-C-eDP-1 [948.955281] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.140s) [948.969325] Starting dynamic subtest: pipe-D-eDP-1 [950.181040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s) [950.183264] Subtest scaling-mode-center: SUCCESS (3.621s) [951.463988] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: i915_hangman results: parsing output: 3/ for test: perf_pmu results: parsing output: 4/ for test: kms_pm_dc results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: gen9_exec_parse results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: gem_exec_schedule results: parsing output: 9/ for test: kms_rotation_crc results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: kms_color results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: gem_exec_balancer results: parsing output: 14/ for test: gem_workarounds results: parsing output: 15/ for test: kms_ccs results: parsing output: 16/ for test: gem_spin_batch results: parsing output: 17/ for test: kms_pm_rpm results: parsing output: 18/ for test: gem_pxp results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: i915_selftest results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: perf results: parsing output: 24/ for test: kms_addfb_basic results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: kms_getfb results: parsing output: 27/ for test: kms_plane results: parsing output: 28/ for test: gem_userptr_blits results: parsing output: 29/ for test: prime_vgem results: parsing output: 30/ for test: gem_exec_whisper results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: gen7_exec_parse results: parsing output: 33/ for test: core_auth results: parsing output: 34/ for test: kms_flip_scaled_crc results: parsing output: 35/ for test: gem_create results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_ctx_persistence results: parsing output: 39/ for test: kms_cursor_legacy results: parsing output: 40/ for test: gem_exec_reloc results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: gem_render_copy results: parsing output: 43/ for test: kms_addfb_basic results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: gem_readwrite results: parsing output: 46/ for test: core_getstats results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: kms_atomic results: parsing output: 49/ for test: kms_pm_rpm results: parsing output: 50/ for test: kms_psr2_su results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_chamelium_color results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: prime_mmap results: parsing output: 56/ for test: gem_exec_reloc results: parsing output: 57/ for test: vgem_basic results: parsing output: 58/ for test: gem_userptr_blits results: parsing output: 59/ for test: gem_exec_schedule results: parsing output: 60/ for test: gem_tiled_fence_blits results: parsing output: 61/ for test: i915_pm_rpm results: parsing output: 62/ for test: kms_content_protection results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_vblank results: parsing output: 65/ for test: perf_pmu results: parsing output: 66/ for test: gem_exec_balancer results: parsing output: 67/ for test: kms_invalid_mode results: parsing output: 68/ for test: syncobj_wait results: parsing output: 69/ for test: kms_draw_crc results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_lease results: parsing output: 75/ for test: gem_render_copy results: parsing output: 76/ for test: gem_mmap_offset results: parsing output: 77/ for test: i915_query results: parsing output: 78/ for test: gem_exec_whisper results: parsing output: 79/ for test: gem_media_fill results: parsing output: 80/ for test: i915_query results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_render_copy results: parsing output: 85/ for test: kms_cursor_legacy results: parsing output: 86/ for test: perf results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: kms_async_flips results: parsing output: 91/ for test: prime_mmap_coherency results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_fb_coherency results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: gem_ppgtt results: parsing output: 97/ for test: i915_drm_fdinfo results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: dumb_buffer results: parsing output: 100/ for test: kms_chamelium_edid results: parsing output: 101/ for test: kms_dirtyfb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: prime_vgem results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: gem_ctx_persistence results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: kms_cursor_crc results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: gem_ctx_shared results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: syncobj_wait results: parsing output: 117/ for test: kms_plane_scaling results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: kms_busy results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: kms_plane_alpha_blend results: parsing output: 124/ for test: prime_self_import results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: gem_exec_parallel results: parsing output: 128/ for test: prime_vgem results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: syncobj_timeline results: parsing output: 131/ for test: kms_scaling_modes Done.