[71.819137] Initializing watchdogs [71.819203] /dev/watchdog0 [71.839850] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [71.851075] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [71.855088] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [71.857495] [001/131] (960s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [71.932482] Starting subtest: etime-multi-wait-all-for-submit-submitted [72.040225] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s) [72.174607] [002/131] (960s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [72.370504] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [73.532075] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.162s) [73.733160] [003/131] (958s left) kms_hdr (invalid-hdr) [73.910770] Starting subtest: invalid-hdr [73.913298] Subtest invalid-hdr: SKIP (0.000s) [73.993612] [004/131] (958s left) kms_pm_dc (dc5-psr) [75.183977] Starting subtest: dc5-psr [75.185925] Subtest dc5-psr: SKIP (0.000s) [75.285560] [005/131] (957s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [75.464209] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [75.465143] Starting dynamic subtest: pipe-A-DP-3 [75.468520] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [75.476332] Starting dynamic subtest: pipe-B-DP-3 [75.479837] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [75.487466] Starting dynamic subtest: pipe-C-DP-3 [75.490962] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [75.498531] Starting dynamic subtest: pipe-D-DP-3 [75.501992] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [75.503742] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s) [75.965437] [006/131] (956s left) i915_query (test-query-geometry-subslices) [76.039978] Starting subtest: test-query-geometry-subslices [76.040931] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [76.194550] [007/131] (956s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [76.379455] Starting subtest: fbc-rgb565-draw-mmap-wc [76.381193] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s) [76.581854] [008/131] (956s left) gem_create (create-invalid-size) [76.652952] Starting subtest: create-invalid-size [76.653894] Subtest create-invalid-size: SUCCESS (0.000s) [76.908923] [009/131] (956s left) kms_fb_coherency (memset-crc) [77.094917] Starting subtest: memset-crc [77.095832] Starting dynamic subtest: mmap-offset-fixed [77.632773] Dynamic subtest mmap-offset-fixed: SUCCESS (0.537s) [77.731149] Subtest memset-crc: SUCCESS (0.636s) [77.989928] [010/131] (955s left) kms_psr2_su (frontbuffer-xrgb8888) [78.059995] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [78.128014] [011/131] (954s left) kms_properties (connector-properties-atomic) [78.306389] Starting subtest: connector-properties-atomic [78.308426] Starting dynamic subtest: pipe-A-DP-3 [79.888079] Dynamic subtest pipe-A-DP-3: SUCCESS (1.580s) [79.899390] Starting dynamic subtest: pipe-None-DP-1 [79.901331] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s) [79.912193] Starting dynamic subtest: pipe-None-DP-2 [79.914536] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s) [79.924532] Starting dynamic subtest: pipe-None-HDMI-A-1 [79.926803] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s) [79.936793] Starting dynamic subtest: pipe-None-HDMI-A-2 [79.939122] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.002s) [79.947438] Starting dynamic subtest: pipe-None-DP-4 [79.949197] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s) [79.957275] Starting dynamic subtest: pipe-None-HDMI-A-3 [79.959055] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.002s) [79.959994] Subtest connector-properties-atomic: SUCCESS (1.599s) [80.153774] [012/131] (952s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [80.336759] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [80.337609] Starting dynamic subtest: pipe-A-DP-3 [80.358994] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [80.366875] Starting dynamic subtest: pipe-B-DP-3 [80.388915] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [80.396929] Starting dynamic subtest: pipe-C-DP-3 [80.422323] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [80.430369] Starting dynamic subtest: pipe-D-DP-3 [80.455733] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [80.457293] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.011s) [80.808494] [013/131] (952s left) kms_flip (flip-vs-modeset-vs-hang) [80.988365] Starting subtest: flip-vs-modeset-vs-hang [80.990273] Starting dynamic subtest: A-DP3 [132.464494] Dynamic subtest A-DP3: SUCCESS (51.474s) [132.472710] Starting dynamic subtest: D-DP3 [182.512454] Dynamic subtest D-DP3: SUCCESS (50.046s) [182.513450] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.524s) [182.749647] [014/131] (850s left) gem_exec_reloc (basic-cpu-read) [182.830430] Subtest basic-cpu-read: SKIP (0.000s) [182.903919] [015/131] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [183.085758] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [183.087341] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [183.281789] [016/131] (850s left) kms_async_flips (async-flip-hang) [183.461965] Starting subtest: async-flip-hang [183.680995] Starting dynamic subtest: pipe-A-DP-3 [198.506218] Dynamic subtest pipe-A-DP-3: SUCCESS (14.824s) [198.750256] Starting dynamic subtest: pipe-B-DP-3 [213.479217] Dynamic subtest pipe-B-DP-3: SUCCESS (14.735s) [213.676600] Starting dynamic subtest: pipe-C-DP-3 [238.502275] Dynamic subtest pipe-C-DP-3: SUCCESS (24.833s) [238.678535] Starting dynamic subtest: pipe-D-DP-3 [253.491208] Dynamic subtest pipe-D-DP-3: SUCCESS (14.819s) [253.492189] Subtest async-flip-hang: SUCCESS (70.028s) [253.897787] [017/131] (779s left) api_intel_bb (simple-bb-ctx) [253.966200] Starting subtest: simple-bb-ctx [254.001755] Subtest simple-bb-ctx: SUCCESS (0.036s) [254.206178] [018/131] (779s left) kms_cursor_crc (cursor-offscreen-64x21) [254.546928] Starting subtest: cursor-offscreen-64x21 [254.551242] Starting dynamic subtest: pipe-A-DP-3 [257.148987] Dynamic subtest pipe-A-DP-3: SUCCESS (2.596s) [257.195589] Starting dynamic subtest: pipe-D-DP-3 [259.700702] Dynamic subtest pipe-D-DP-3: SUCCESS (2.513s) [259.701876] Subtest cursor-offscreen-64x21: SUCCESS (5.154s) [260.151549] [019/131] (773s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [260.330409] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s) [260.383598] [020/131] (773s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [260.563212] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [260.564036] Starting dynamic subtest: pipe-A [262.527055] Dynamic subtest pipe-A: SUCCESS (1.964s) [262.536996] Starting dynamic subtest: pipe-B [264.674132] Dynamic subtest pipe-B: SUCCESS (2.146s) [264.685251] Starting dynamic subtest: pipe-C [264.970819] Dynamic subtest pipe-C: SUCCESS (0.296s) [264.984030] Starting dynamic subtest: pipe-D [265.282816] Dynamic subtest pipe-D: SUCCESS (0.311s) [265.283730] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (4.720s) [265.606368] [021/131] (768s left) kms_big_fb (yf-tiled-addfb-size-overflow) [265.801376] Starting subtest: yf-tiled-addfb-size-overflow [265.803146] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [265.932926] [022/131] (767s left) perf_pmu (invalid-init) [265.997502] Starting subtest: invalid-init [265.998419] Subtest invalid-init: SUCCESS (0.000s) [266.115282] [023/131] (767s left) perf (stress-open-close) [266.480514] Starting subtest: stress-open-close [266.481378] Starting dynamic subtest: 0-rcs0 [268.744176] Dynamic subtest 0-rcs0: SUCCESS (2.263s) [268.745525] Subtest stress-open-close: SUCCESS (2.264s) [268.841474] [024/131] (765s left) kms_prime (d3hot) [269.019268] Subtest D3hot: SKIP (0.000s) [269.270730] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true [269.272555] [025/131] (764s left) kms_vblank (wait-forked) [269.464946] Starting subtest: wait-forked [269.466997] Starting dynamic subtest: pipe-A-DP-3 [271.842486] Dynamic subtest pipe-A-DP-3: SUCCESS (2.376s) [271.852226] Starting dynamic subtest: pipe-D-DP-3 [274.149981] Dynamic subtest pipe-D-DP-3: SUCCESS (2.305s) [274.150933] Subtest wait-forked: SUCCESS (4.685s) [274.371774] [026/131] (759s left) kms_atomic_interruptible (universal-setplane-cursor) [274.566102] Starting subtest: universal-setplane-cursor [274.568166] Starting dynamic subtest: pipe-A-DP-3 [280.862098] Dynamic subtest pipe-A-DP-3: SUCCESS (6.294s) [280.863399] Subtest universal-setplane-cursor: SUCCESS (6.296s) [281.100231] [027/131] (753s left) i915_drm_fdinfo (idle) [281.172550] Starting subtest: idle [281.173585] Starting dynamic subtest: rcs0 [281.753562] Dynamic subtest rcs0: SUCCESS (0.581s) [281.764542] Starting dynamic subtest: bcs0 [282.256969] Dynamic subtest bcs0: SUCCESS (0.502s) [282.266477] Starting dynamic subtest: vcs0 [282.762171] Dynamic subtest vcs0: SUCCESS (0.503s) [282.772552] Starting dynamic subtest: vcs1 [283.268265] Dynamic subtest vcs1: SUCCESS (0.504s) [283.276617] Starting dynamic subtest: vecs0 [283.773263] Dynamic subtest vecs0: SUCCESS (0.503s) [283.783720] Starting dynamic subtest: vecs1 [284.281333] Dynamic subtest vecs1: SUCCESS (0.503s) [284.289976] Starting dynamic subtest: ccs0 [284.785486] Dynamic subtest ccs0: SUCCESS (0.503s) [284.787055] Subtest idle: SUCCESS (3.613s) [284.894610] [028/131] (749s left) prime_mmap (test_reprime) [284.974445] Starting subtest: test_reprime [284.975362] Starting dynamic subtest: test_reprime-smem [285.024317] Dynamic subtest test_reprime-smem: SUCCESS (0.050s) [285.032936] Starting dynamic subtest: test_reprime-lmem0 [285.227410] Dynamic subtest test_reprime-lmem0: SUCCESS (0.202s) [285.228382] Subtest test_reprime: SUCCESS (0.253s) [285.385639] [029/131] (748s left) gem_exec_balancer (bonded-dual) [285.476185] Starting subtest: bonded-dual [285.478072] Subtest bonded-dual: SKIP (0.000s) [285.867557] [030/131] (748s left) kms_cursor_crc (cursor-sliding-512x512) [286.333747] Starting subtest: cursor-sliding-512x512 [286.335456] Subtest cursor-sliding-512x512: SKIP (0.001s) [286.607461] [031/131] (747s left) api_intel_allocator (two-level-inception) [286.687177] Starting subtest: two-level-inception [292.135921] Subtest two-level-inception: SUCCESS (5.443s) [292.351696] [032/131] (742s left) perf_pmu (all-busy-idle-check-all) [292.426998] Starting subtest: all-busy-idle-check-all [293.126429] Subtest all-busy-idle-check-all: SUCCESS (0.699s) [293.344067] [033/131] (741s left) gem_exec_reloc (basic-gtt-wc-noreloc) [293.431194] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [293.526669] [034/131] (741s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [293.720518] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [293.722211] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [293.867186] [035/131] (740s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [294.050935] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [294.051909] Starting dynamic subtest: pipe-A-valid-mode [295.802711] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.750s) [295.804496] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.753s) [296.067323] [036/131] (738s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [296.258658] Starting subtest: psr-rgb565-draw-render [296.260393] Subtest psr-rgb565-draw-render: SKIP (0.000s) [296.385996] [037/131] (738s left) gem_softpin (overlap) [296.474551] Starting subtest: overlap [299.570406] Subtest overlap: SUCCESS (3.095s) [299.702482] [038/131] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [299.893610] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [299.895221] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [300.044856] [039/131] (735s left) gem_caching (writes) [300.133296] Starting subtest: writes [304.352929] Subtest writes: SUCCESS (4.219s) [304.521724] [040/131] (730s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [304.599168] Starting subtest: multi-wait-for-submit-submitted-signaled [304.600112] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [304.728344] [041/131] (730s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [304.921831] Starting subtest: psr-rgb565-draw-blt [304.923420] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [305.052231] [042/131] (730s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [305.245883] Starting subtest: fbcpsr-shrfb-scaledprimary [305.247527] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [305.363434] [043/131] (730s left) gem_ctx_isolation (nonpriv-switch) [305.454968] Starting subtest: nonpriv-switch [305.455868] Starting dynamic subtest: rcs0 [306.312932] Dynamic subtest rcs0: SUCCESS (0.858s) [306.323112] Starting dynamic subtest: bcs0 [307.221563] Dynamic subtest bcs0: SUCCESS (0.908s) [307.231370] Starting dynamic subtest: vcs0 [308.126235] Dynamic subtest vcs0: SUCCESS (0.904s) [308.136126] Starting dynamic subtest: vcs1 [309.013383] Dynamic subtest vcs1: SUCCESS (0.886s) [309.023195] Starting dynamic subtest: vecs0 [309.936216] Dynamic subtest vecs0: SUCCESS (0.922s) [309.946038] Starting dynamic subtest: vecs1 [310.834865] Dynamic subtest vecs1: SUCCESS (0.898s) [310.845353] Starting dynamic subtest: ccs0 [311.724125] Dynamic subtest ccs0: SUCCESS (0.888s) [311.724982] Subtest nonpriv-switch: SUCCESS (6.269s) [311.998735] [044/131] (723s left) kms_plane_lowres (tiling-none) [312.192445] Starting subtest: tiling-none [312.194448] Starting dynamic subtest: pipe-A-DP-3 [323.028268] Dynamic subtest pipe-A-DP-3: SUCCESS (10.833s) [323.129558] Starting dynamic subtest: pipe-B-DP-3 [333.750112] Dynamic subtest pipe-B-DP-3: SUCCESS (10.631s) [333.867153] Starting dynamic subtest: pipe-C-DP-3 [344.506109] Dynamic subtest pipe-C-DP-3: SUCCESS (10.647s) [344.622684] Starting dynamic subtest: pipe-D-DP-3 [355.140074] Dynamic subtest pipe-D-DP-3: SUCCESS (10.525s) [355.263189] Subtest tiling-none: SUCCESS (43.069s) [355.511924] [045/131] (680s left) kms_big_fb (x-tiled-addfb) [355.716200] Starting subtest: x-tiled-addfb [355.717155] Subtest x-tiled-addfb: SUCCESS (0.000s) [355.881669] [046/131] (679s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [356.075270] Starting subtest: bad-rotation-90-yf-tiled-ccs [356.076172] Starting dynamic subtest: pipe-A-DP-3 [356.084415] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [356.094228] Starting dynamic subtest: pipe-B-DP-3 [356.102575] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [356.112240] Starting dynamic subtest: pipe-C-DP-3 [356.120391] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [356.129979] Starting dynamic subtest: pipe-D-DP-3 [356.140847] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [356.143155] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s) [356.599273] [047/131] (679s left) kms_atomic (plane-invalid-params) [356.787890] Starting subtest: plane-invalid-params [356.790431] Starting dynamic subtest: pipe-A-DP-3 [357.662694] Dynamic subtest pipe-A-DP-3: SUCCESS (0.873s) [357.663808] Subtest plane-invalid-params: SUCCESS (0.876s) [357.943389] [048/131] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [358.136293] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [358.138008] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [358.271012] [049/131] (677s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [358.463252] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [358.464969] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [358.606649] [050/131] (677s left) gem_ctx_persistence (legacy-engines-hostile) [358.692548] Starting subtest: legacy-engines-hostile [358.693464] Starting dynamic subtest: render [358.794406] Dynamic subtest render: SUCCESS (0.101s) [358.809269] Starting dynamic subtest: bsd1 [358.890425] Dynamic subtest bsd1: SUCCESS (0.094s) [358.914346] Starting dynamic subtest: bsd2 [358.935652] Dynamic subtest bsd2: SUCCESS (0.043s) [358.961648] Starting dynamic subtest: blt [358.990220] Dynamic subtest blt: SUCCESS (0.051s) [359.012218] Starting dynamic subtest: vebox [359.044581] Dynamic subtest vebox: SUCCESS (0.051s) [359.048688] Subtest legacy-engines-hostile: SUCCESS (0.353s) [359.231409] [051/131] (676s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [359.420394] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [359.422155] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [359.520476] [052/131] (676s left) gem_exec_schedule (submit-early-slice) [359.617211] Starting subtest: submit-early-slice [359.618166] Starting dynamic subtest: rcs0 [359.696611] Dynamic subtest rcs0: SUCCESS (0.079s) [359.708503] Starting dynamic subtest: bcs0 [359.749259] Dynamic subtest bcs0: SUCCESS (0.052s) [359.760572] Starting dynamic subtest: vcs0 [359.806342] Dynamic subtest vcs0: SUCCESS (0.056s) [359.817640] Starting dynamic subtest: vcs1 [359.862649] Dynamic subtest vcs1: SUCCESS (0.055s) [359.874243] Starting dynamic subtest: vecs0 [359.920619] Dynamic subtest vecs0: SUCCESS (0.057s) [359.932288] Starting dynamic subtest: vecs1 [359.974977] Dynamic subtest vecs1: SUCCESS (0.053s) [359.986497] Starting dynamic subtest: ccs0 [360.032455] Dynamic subtest ccs0: SUCCESS (0.056s) [360.033390] Subtest submit-early-slice: SUCCESS (0.416s) [360.483843] [053/131] (675s left) kms_psr (pr-primary-blt) [360.672421] Subtest pr-primary-blt: SKIP (0.000s) [360.725052] [054/131] (675s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [360.912294] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [360.913090] Starting dynamic subtest: pipe-A [360.996785] Dynamic subtest pipe-A: SUCCESS (0.085s) [361.010342] Starting dynamic subtest: pipe-B [361.194044] Dynamic subtest pipe-B: SUCCESS (0.196s) [361.212501] Starting dynamic subtest: pipe-C [361.424296] Dynamic subtest pipe-C: SUCCESS (0.229s) [361.436992] Starting dynamic subtest: pipe-D [361.620914] Dynamic subtest pipe-D: SUCCESS (0.195s) [361.622032] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.710s) [361.972926] [055/131] (674s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [362.170979] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [362.172655] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [362.369375] [056/131] (674s left) gem_pwrite (basic-exhaustion) [362.451232] Subtest basic-exhaustion: SKIP (0.000s) [362.528825] [057/131] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [362.727397] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [365.651246] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.924s) [365.939528] [058/131] (670s left) perf_pmu (busy) [366.011044] Starting subtest: busy [366.012078] Starting dynamic subtest: rcs0 [366.617847] Dynamic subtest rcs0: SUCCESS (0.605s) [366.632054] Starting dynamic subtest: bcs0 [367.176167] Dynamic subtest bcs0: SUCCESS (0.554s) [367.189836] Starting dynamic subtest: vcs0 [367.738760] Dynamic subtest vcs0: SUCCESS (0.560s) [367.753188] Starting dynamic subtest: vcs1 [368.301905] Dynamic subtest vcs1: SUCCESS (0.558s) [368.315565] Starting dynamic subtest: vecs0 [368.863688] Dynamic subtest vecs0: SUCCESS (0.556s) [368.878544] Starting dynamic subtest: vecs1 [369.429551] Dynamic subtest vecs1: SUCCESS (0.560s) [369.443526] Starting dynamic subtest: ccs0 [369.991549] Dynamic subtest ccs0: SUCCESS (0.556s) [369.994699] Subtest busy: SUCCESS (3.983s) [370.172944] [059/131] (666s left) gem_create (create-ext-placement-each) [370.360523] Starting subtest: create-ext-placement-each [370.361501] Subtest create-ext-placement-each: SUCCESS (0.000s) [370.530134] [060/131] (666s left) kms_getfb (getfb-handle-zero) [370.716809] Starting subtest: getfb-handle-zero [370.717678] Subtest getfb-handle-zero: SUCCESS (0.000s) [370.940924] [061/131] (665s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [371.213185] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [371.367722] [062/131] (665s left) gem_mmap_gtt (ptrace) [371.448562] Subtest ptrace: SKIP (0.000s) [371.520576] [063/131] (665s left) kms_cursor_crc (cursor-rapid-movement-256x256) [371.932375] Starting subtest: cursor-rapid-movement-256x256 [371.938027] Starting dynamic subtest: pipe-A-DP-3 [372.388067] Dynamic subtest pipe-A-DP-3: SUCCESS (0.451s) [372.437461] Starting dynamic subtest: pipe-D-DP-3 [372.804963] Dynamic subtest pipe-D-DP-3: SUCCESS (0.376s) [372.805934] Subtest cursor-rapid-movement-256x256: SUCCESS (0.872s) [373.155661] [064/131] (663s left) i915_pm_rc6_residency (rc6-accuracy) [373.242669] Starting subtest: rc6-accuracy [373.243806] Starting dynamic subtest: gt0 [376.459975] Dynamic subtest gt0: FAIL (3.198s) [376.461011] Subtest rc6-accuracy: FAIL (3.200s) [376.590997] [065/131] (660s left) kms_chamelium_edid (dp-edid-read) [376.893710] Subtest dp-edid-read: SKIP (0.000s) [377.052964] [066/131] (660s left) prime_self_import (export-vs-gem_close-race) [377.102662] Starting subtest: export-vs-gem_close-race [382.195328] Subtest export-vs-gem_close-race: SUCCESS (5.092s) [382.331676] [067/131] (654s left) syncobj_timeline (etime-multi-wait-all-submitted) [382.448638] Starting subtest: etime-multi-wait-all-submitted [382.550745] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s) [382.689915] [068/131] (654s left) kms_content_protection (atomic-hdcp14) [382.939341] Starting subtest: atomic-hdcp14 [382.960414] Starting dynamic subtest: pipe-A-DP-3 [506.141037] Dynamic subtest pipe-A-DP-3: FAIL (123.012s) [506.141820] Subtest atomic-hdcp14: FAIL (123.120s) [506.294914] [069/131] (531s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [506.380501] Starting subtest: multi-wait-for-submit-submitted-signaled [506.381389] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [506.495327] [070/131] (530s left) kms_chamelium_color (ctm-0-25) [506.684219] Subtest ctm-0-25: SKIP (0.000s) [506.740103] [071/131] (530s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [506.932146] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [506.933906] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [507.072186] [072/131] (530s left) gem_exec_suspend (basic-s3-devices) [507.160490] Starting subtest: basic-S3-devices [507.161479] Starting dynamic subtest: smem [517.037487] Dynamic subtest smem: SUCCESS (9.876s) [517.049927] Starting dynamic subtest: lmem0 [526.649999] Dynamic subtest lmem0: SUCCESS (9.611s) [526.651159] Subtest basic-S3-devices: SUCCESS (19.490s) [547.921602] [073/131] (510s left) kms_addfb_basic (bad-pitch-65536) [548.005629] Starting subtest: bad-pitch-65536 [548.006505] Subtest bad-pitch-65536: SUCCESS (0.000s) [548.245603] [074/131] (510s left) gem_partial_pwrite_pread (reads-display) [548.331187] Subtest reads-display: SKIP (0.000s) [548.420961] [075/131] (510s left) syncobj_basic (test-valid-cycle) [548.502793] Starting subtest: test-valid-cycle [548.503701] Subtest test-valid-cycle: SUCCESS (0.000s) [548.668255] [076/131] (510s left) kms_big_fb (y-tiled-8bpp-rotate-0) [548.865297] Starting subtest: y-tiled-8bpp-rotate-0 [548.867067] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [549.048243] [077/131] (509s left) kms_flip (2x-flip-vs-dpms-on-nop) [549.235174] Starting subtest: 2x-flip-vs-dpms-on-nop [549.250516] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.015s) [549.432139] [078/131] (509s left) gem_exec_reloc (basic-active) [549.519709] Subtest basic-active: SKIP (0.000s) [549.611869] [079/131] (509s left) gem_ctx_shared (exec-single-timeline) [549.704515] Starting subtest: exec-single-timeline [549.705445] Starting dynamic subtest: rcs0 [550.808522] Dynamic subtest rcs0: SUCCESS (1.102s) [550.822955] Starting dynamic subtest: bcs0 [551.832180] Dynamic subtest bcs0: SUCCESS (1.019s) [551.847157] Starting dynamic subtest: vcs0 [552.856360] Dynamic subtest vcs0: SUCCESS (1.019s) [552.871057] Starting dynamic subtest: vcs1 [553.880111] Dynamic subtest vcs1: SUCCESS (1.019s) [553.894788] Starting dynamic subtest: vecs0 [554.903589] Dynamic subtest vecs0: SUCCESS (1.019s) [554.918528] Starting dynamic subtest: vecs1 [555.928433] Dynamic subtest vecs1: SUCCESS (1.021s) [555.942498] Starting dynamic subtest: ccs0 [556.952183] Dynamic subtest ccs0: SUCCESS (1.019s) [556.956368] Subtest exec-single-timeline: SUCCESS (7.250s) [557.210929] [080/131] (501s left) kms_lease (master-vs-lease) [557.401779] Starting subtest: master-vs-lease [557.404235] Subtest master-vs-lease: SUCCESS (0.002s) [557.614640] [081/131] (501s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [560.221901] Starting subtest: verify-pxp-stale-buf-optout-execution [560.223866] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s) [560.309793] [082/131] (498s left) gem_userptr_blits (readonly-pwrite-unsync) [560.401016] Subtest readonly-pwrite-unsync: SKIP (0.000s) [560.615046] [083/131] (498s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [560.804139] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [560.870721] [084/131] (498s left) syncobj_timeline (signal-point-0) [560.952452] Starting subtest: signal-point-0 [560.953522] Subtest signal-point-0: SUCCESS (0.000s) [561.165108] [085/131] (498s left) core_sysfs (read-all-entries) [561.241464] Starting subtest: read-all-entries [561.297801] Subtest read-all-entries: SUCCESS (0.056s) [561.392968] [086/131] (498s left) syncobj_wait (wait-all-delayed-signal) [561.473499] Starting subtest: wait-all-delayed-signal [561.575033] Subtest wait-all-delayed-signal: SUCCESS (0.101s) [561.749824] [087/131] (497s left) gem_lmem_swapping (heavy-verify-multi-ccs) [564.440247] Starting subtest: heavy-verify-multi-ccs [564.441255] Starting dynamic subtest: lmem0 [572.956257] Dynamic subtest lmem0: SUCCESS (8.515s) [572.957202] Subtest heavy-verify-multi-ccs: SUCCESS (8.517s) [574.223537] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [574.225018] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true [574.227031] [088/131] (485s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [575.992479] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [575.994269] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [576.181808] [FACT kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [576.184584] [FACT kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true [576.187442] [089/131] (483s left) gem_spin_batch (resubmit) [576.283137] Starting subtest: resubmit [576.284101] Starting dynamic subtest: rcs0 [576.323287] Dynamic subtest rcs0: SUCCESS (0.040s) [576.336147] Starting dynamic subtest: bcs0 [576.337050] Dynamic subtest bcs0: SUCCESS (0.004s) [576.347862] Starting dynamic subtest: vcs0 [576.348916] Dynamic subtest vcs0: SUCCESS (0.003s) [576.359383] Starting dynamic subtest: vcs1 [576.360323] Dynamic subtest vcs1: SUCCESS (0.002s) [576.370032] Starting dynamic subtest: vecs0 [576.371164] Dynamic subtest vecs0: SUCCESS (0.002s) [576.381362] Starting dynamic subtest: vecs1 [576.382216] Dynamic subtest vecs1: SUCCESS (0.002s) [576.392038] Starting dynamic subtest: ccs0 [576.392912] Dynamic subtest ccs0: SUCCESS (0.002s) [576.393763] Subtest resubmit: SUCCESS (0.063s) [576.657024] [090/131] (483s left) gem_exec_create (legacy) [576.746531] Starting subtest: legacy [576.747443] Starting dynamic subtest: smem [578.844515] Dynamic subtest smem: SUCCESS (2.097s) [578.857352] Starting dynamic subtest: lmem0 [580.941565] Dynamic subtest lmem0: SUCCESS (2.096s) [580.942489] Subtest legacy: SUCCESS (4.196s) [581.173545] [091/131] (478s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [581.366126] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [581.367861] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [581.552419] [092/131] (478s left) kms_flip (blocking-wf_vblank) [581.742236] Starting subtest: blocking-wf_vblank [581.746986] Starting dynamic subtest: A-DP3 [589.868058] Dynamic subtest A-DP3: SUCCESS (8.121s) [589.881291] Starting dynamic subtest: B-DP3 [597.923107] Dynamic subtest B-DP3: SUCCESS (8.053s) [597.935468] Starting dynamic subtest: C-DP3 [605.975100] Dynamic subtest C-DP3: SUCCESS (8.050s) [605.987842] Starting dynamic subtest: D-DP3 [614.029783] Dynamic subtest D-DP3: SUCCESS (8.053s) [614.032165] Subtest blocking-wf_vblank: SUCCESS (32.289s) [614.383974] [093/131] (445s left) kms_psr (fbc-pr-sprite-plane-move) [614.572036] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [614.638547] [094/131] (445s left) gem_partial_pwrite_pread (writes-after-reads) [614.729582] Subtest writes-after-reads: SKIP (0.000s) [614.830983] [095/131] (445s left) kms_joiner (basic-force-ultra-joiner) [615.021548] Starting subtest: basic-force-ultra-joiner [615.023235] Subtest basic-force-ultra-joiner: SKIP (0.000s) [615.113926] [096/131] (445s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [615.304885] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [615.306513] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [615.431939] [097/131] (444s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [615.616419] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [628.986351] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (13.369s) [629.229645] [098/131] (431s left) gem_exec_create (basic) [629.321531] Starting subtest: basic [629.322476] Starting dynamic subtest: smem [631.416829] Dynamic subtest smem: SUCCESS (2.095s) [631.429304] Starting dynamic subtest: lmem0 [633.516258] Dynamic subtest lmem0: SUCCESS (2.098s) [633.517203] Subtest basic: SUCCESS (4.195s) [633.731512] [099/131] (426s left) gem_exec_reloc (basic-write-gtt-noreloc) [633.819598] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [633.886492] [100/131] (426s left) kms_psr (psr-sprite-mmap-cpu) [634.073749] Subtest psr-sprite-mmap-cpu: SKIP (0.000s) [634.136267] [101/131] (426s left) kms_prop_blob (blob-prop-lifetime) [634.216561] Starting subtest: blob-prop-lifetime [634.232376] Subtest blob-prop-lifetime: SUCCESS (0.016s) [634.364763] [102/131] (426s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [634.557194] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [634.558908] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [634.669989] [103/131] (426s left) perf_pmu (most-busy-idle-check-all) [634.742449] Starting subtest: most-busy-idle-check-all [634.743368] Starting dynamic subtest: rcs0 [635.435238] Dynamic subtest rcs0: SUCCESS (0.692s) [635.447586] Starting dynamic subtest: bcs0 [636.088709] Dynamic subtest bcs0: SUCCESS (0.651s) [636.105550] Starting dynamic subtest: vcs0 [636.752179] Dynamic subtest vcs0: SUCCESS (0.658s) [636.768733] Starting dynamic subtest: vcs1 [637.410649] Dynamic subtest vcs1: SUCCESS (0.654s) [637.423175] Starting dynamic subtest: vecs0 [638.062408] Dynamic subtest vecs0: SUCCESS (0.650s) [638.074994] Starting dynamic subtest: vecs1 [638.718700] Dynamic subtest vecs1: SUCCESS (0.655s) [638.734171] Starting dynamic subtest: ccs0 [639.374637] Dynamic subtest ccs0: SUCCESS (0.654s) [639.375523] Subtest most-busy-idle-check-all: SUCCESS (4.633s) [639.527264] [104/131] (421s left) kms_sequence (get-busy) [639.714416] Starting subtest: get-busy [639.715328] Starting dynamic subtest: pipe-A-DP-3 [642.297552] Dynamic subtest pipe-A-DP-3: SUCCESS (2.583s) [642.311379] Starting dynamic subtest: pipe-B-DP-3 [644.784973] Dynamic subtest pipe-B-DP-3: SUCCESS (2.485s) [644.797232] Starting dynamic subtest: pipe-C-DP-3 [647.262264] Dynamic subtest pipe-C-DP-3: SUCCESS (2.474s) [647.275610] Starting dynamic subtest: pipe-D-DP-3 [649.741759] Dynamic subtest pipe-D-DP-3: SUCCESS (2.477s) [649.742728] Subtest get-busy: SUCCESS (10.028s) [649.991688] [105/131] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [650.182272] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [650.184053] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [650.321367] [106/131] (410s left) kms_psr (psr-cursor-plane-onoff) [650.510238] Subtest psr-cursor-plane-onoff: SKIP (0.000s) [650.576397] [107/131] (410s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [650.769058] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [650.770661] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [650.968510] [108/131] (410s left) gem_watchdog (default-physical) [651.059457] Starting subtest: default-physical [652.108639] Subtest default-physical: SUCCESS (1.048s) [652.208674] [109/131] (408s left) kms_big_fb (4-tiled-64bpp-rotate-90) [652.410129] Starting subtest: 4-tiled-64bpp-rotate-90 [652.464574] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.054s) [652.649954] [110/131] (408s left) kms_plane_alpha_blend (alpha-opaque-fb) [652.840434] Starting subtest: alpha-opaque-fb [653.086204] Starting dynamic subtest: pipe-A-DP-3 [653.620972] Dynamic subtest pipe-A-DP-3: SUCCESS (0.535s) [653.633227] Starting dynamic subtest: pipe-D-DP-3 [654.185335] Dynamic subtest pipe-D-DP-3: SUCCESS (0.561s) [654.186285] Subtest alpha-opaque-fb: SUCCESS (1.345s) [654.453223] [111/131] (406s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [654.646709] Starting subtest: drrs-dirtyfb-ioctl [654.651662] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [654.790921] [112/131] (406s left) syncobj_wait (single-wait-for-submit-signaled) [654.871522] Starting subtest: single-wait-for-submit-signaled [654.872471] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [655.026873] [113/131] (406s left) kms_big_fb (linear-32bpp-rotate-0) [655.231416] Starting subtest: linear-32bpp-rotate-0 [657.250692] Subtest linear-32bpp-rotate-0: SUCCESS (2.018s) [657.464949] [114/131] (404s left) gem_mmap_wc (write) [657.547063] Subtest write: SKIP (0.000s) [657.611826] [115/131] (404s left) gem_mmap_gtt (fault-concurrent-x) [657.692234] Subtest fault-concurrent-X: SKIP (0.000s) [657.763464] [116/131] (403s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [657.953280] Starting subtest: cursorB-vs-flipA-legacy [657.956365] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s) [658.053915] [117/131] (403s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [658.143191] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [658.145160] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [658.404677] [118/131] (403s left) gem_exec_whisper (basic-fds-forked) [658.495496] Starting subtest: basic-fds-forked [681.029553] Subtest basic-fds-forked: SUCCESS (22.532s) [681.276300] [119/131] (380s left) sw_sync (sync_merge_invalid) [681.325663] Starting subtest: sync_merge_invalid [681.372439] Subtest sync_merge_invalid: SUCCESS (0.046s) [681.464218] [120/131] (380s left) gem_exec_schedule (noreorder-priority) [681.681160] Starting subtest: noreorder-priority [681.685310] Starting dynamic subtest: rcs0 [682.857412] Dynamic subtest rcs0: SUCCESS (1.175s) [682.870454] Starting dynamic subtest: bcs0 [683.983397] Dynamic subtest bcs0: SUCCESS (1.125s) [683.996139] Starting dynamic subtest: vcs0 [685.113425] Dynamic subtest vcs0: SUCCESS (1.129s) [685.126356] Starting dynamic subtest: vcs1 [686.241460] Dynamic subtest vcs1: SUCCESS (1.127s) [686.253990] Starting dynamic subtest: vecs0 [687.373368] Dynamic subtest vecs0: SUCCESS (1.131s) [687.386758] Starting dynamic subtest: vecs1 [688.505463] Dynamic subtest vecs1: SUCCESS (1.131s) [688.518357] Starting dynamic subtest: ccs0 [689.633251] Dynamic subtest ccs0: SUCCESS (1.127s) [689.634322] Subtest noreorder-priority: SUCCESS (7.953s) [689.870443] [121/131] (372s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [690.059773] Starting subtest: plane-lut1d-pre-ctm3x4 [690.253487] Starting dynamic subtest: pipe-A-plane-0 [690.468228] Dynamic subtest pipe-A-plane-0: SUCCESS (0.215s) [690.515575] Starting dynamic subtest: pipe-A-plane-1 [690.666649] Dynamic subtest pipe-A-plane-1: SUCCESS (0.194s) [690.680766] Starting dynamic subtest: pipe-A-plane-2 [690.834719] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [691.230574] Starting dynamic subtest: pipe-B-plane-0 [691.390673] Dynamic subtest pipe-B-plane-0: SUCCESS (0.197s) [691.404370] Starting dynamic subtest: pipe-B-plane-1 [691.557368] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s) [691.570493] Starting dynamic subtest: pipe-B-plane-2 [691.725357] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [692.123206] Starting dynamic subtest: pipe-C-plane-0 [692.289225] Dynamic subtest pipe-C-plane-0: SUCCESS (0.198s) [692.325122] Starting dynamic subtest: pipe-C-plane-1 [692.487737] Dynamic subtest pipe-C-plane-1: SUCCESS (0.194s) [692.500508] Starting dynamic subtest: pipe-C-plane-2 [692.672685] Dynamic subtest pipe-C-plane-2: SUCCESS (0.183s) [693.042734] Starting dynamic subtest: pipe-D-plane-0 [693.226495] Dynamic subtest pipe-D-plane-0: SUCCESS (0.198s) [693.257226] Starting dynamic subtest: pipe-D-plane-1 [693.408216] Dynamic subtest pipe-D-plane-1: SUCCESS (0.177s) [693.421193] Starting dynamic subtest: pipe-D-plane-2 [693.574769] Dynamic subtest pipe-D-plane-2: SUCCESS (0.165s) [693.631830] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.572s) [694.153616] [122/131] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [694.538007] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [694.539956] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [694.781072] [123/131] (367s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [695.456814] Starting subtest: syncobj-backward-timeline-chain-engines [695.616247] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.160s) [695.973953] [124/131] (366s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [696.161447] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [696.162340] Starting dynamic subtest: pipe-A-DP-3 [696.170962] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [696.182055] Starting dynamic subtest: pipe-B-DP-3 [696.190264] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [696.201078] Starting dynamic subtest: pipe-C-DP-3 [696.209259] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [696.220103] Starting dynamic subtest: pipe-D-DP-3 [696.230167] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [696.232474] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.009s) [696.619297] [125/131] (365s left) i915_hangman (engine-engine-error) [696.716645] Starting subtest: engine-engine-error [696.717503] Starting dynamic subtest: rcs0 [697.509372] Dynamic subtest rcs0: SUCCESS (0.793s) [697.524065] Starting dynamic subtest: bcs0 [698.276511] Dynamic subtest bcs0: SUCCESS (0.766s) [698.290251] Starting dynamic subtest: vcs0 [699.027317] Dynamic subtest vcs0: SUCCESS (0.749s) [699.040081] Starting dynamic subtest: vcs1 [699.759415] Dynamic subtest vcs1: SUCCESS (0.731s) [699.773145] Starting dynamic subtest: vecs0 [700.508368] Dynamic subtest vecs0: SUCCESS (0.748s) [700.521124] Starting dynamic subtest: vecs1 [701.241523] Dynamic subtest vecs1: SUCCESS (0.732s) [701.255791] Starting dynamic subtest: ccs0 [701.994367] Dynamic subtest ccs0: SUCCESS (0.751s) [701.995269] Subtest engine-engine-error: SUCCESS (5.279s) [702.154299] [126/131] (360s left) syncobj_timeline (multi-wait-all-available-submitted) [702.234472] Starting subtest: multi-wait-all-available-submitted [702.235406] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s) [702.439757] [127/131] (359s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [702.636531] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [702.638282] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [702.771307] [128/131] (359s left) sysfs_timeslice_duration (invalid) [702.856381] Starting subtest: invalid [702.858588] Starting dynamic subtest: vecs0 [702.859458] Dynamic subtest vecs0: SUCCESS (0.000s) [702.871073] Starting dynamic subtest: ccs0 [702.872182] Dynamic subtest ccs0: SUCCESS (0.000s) [702.883400] Starting dynamic subtest: vcs0 [702.884617] Dynamic subtest vcs0: SUCCESS (0.000s) [702.895800] Starting dynamic subtest: bcs0 [702.896972] Dynamic subtest bcs0: SUCCESS (0.000s) [702.908183] Starting dynamic subtest: vecs1 [702.909399] Dynamic subtest vecs1: SUCCESS (0.000s) [702.921391] Starting dynamic subtest: rcs0 [702.922627] Dynamic subtest rcs0: SUCCESS (0.000s) [702.933486] Starting dynamic subtest: vcs1 [702.934623] Dynamic subtest vcs1: SUCCESS (0.000s) [702.935760] Subtest invalid: SUCCESS (0.011s) [702.983799] [129/131] (359s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [703.175256] Starting subtest: psr-2p-primscrn-spr-indfb-move [703.176994] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [703.306827] [130/131] (359s left) gem_busy (extended) [703.540280] Starting subtest: extended [703.541208] Starting dynamic subtest: rcs0 [703.634927] Dynamic subtest rcs0: SUCCESS (0.093s) [703.652234] Starting dynamic subtest: bcs0 [703.681558] Dynamic subtest bcs0: SUCCESS (0.042s) [703.699026] Starting dynamic subtest: vcs0 [703.724391] Dynamic subtest vcs0: SUCCESS (0.041s) [703.749914] Starting dynamic subtest: vcs1 [703.769735] Dynamic subtest vcs1: SUCCESS (0.043s) [703.795585] Starting dynamic subtest: vecs0 [703.816887] Dynamic subtest vecs0: SUCCESS (0.045s) [703.842560] Starting dynamic subtest: vecs1 [703.861311] Dynamic subtest vecs1: SUCCESS (0.042s) [703.882772] Starting dynamic subtest: ccs0 [703.904412] Dynamic subtest ccs0: SUCCESS (0.041s) [703.905313] Subtest extended: SUCCESS (0.365s) [704.237971] [131/131] (358s left) gen9_exec_parse (allowed-single) [704.322444] Subtest allowed-single: SKIP (0.000s) [704.393378] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: kms_hdr results: parsing output: 3/ for test: kms_pm_dc results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: i915_query results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: gem_create results: parsing output: 8/ for test: kms_fb_coherency results: parsing output: 9/ for test: kms_psr2_su results: parsing output: 10/ for test: kms_properties results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: gem_exec_reloc results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_async_flips results: parsing output: 16/ for test: api_intel_bb results: parsing output: 17/ for test: kms_cursor_crc results: parsing output: 18/ for test: kms_psr results: parsing output: 19/ for test: kms_plane_scaling results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: perf_pmu results: parsing output: 22/ for test: perf results: parsing output: 23/ for test: kms_prime results: parsing output: 24/ for test: kms_vblank results: parsing output: 25/ for test: kms_atomic_interruptible results: parsing output: 26/ for test: i915_drm_fdinfo results: parsing output: 27/ for test: prime_mmap results: parsing output: 28/ for test: gem_exec_balancer results: parsing output: 29/ for test: kms_cursor_crc results: parsing output: 30/ for test: api_intel_allocator results: parsing output: 31/ for test: perf_pmu results: parsing output: 32/ for test: gem_exec_reloc results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_flip_scaled_crc results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_softpin results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_caching results: parsing output: 39/ for test: syncobj_wait results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_ctx_isolation results: parsing output: 43/ for test: kms_plane_lowres results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_atomic results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_ctx_persistence results: parsing output: 50/ for test: kms_plane results: parsing output: 51/ for test: gem_exec_schedule results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: kms_plane_scaling results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_pwrite results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: perf_pmu results: parsing output: 58/ for test: gem_create results: parsing output: 59/ for test: kms_getfb results: parsing output: 60/ for test: kms_chamelium_hpd results: parsing output: 61/ for test: gem_mmap_gtt results: parsing output: 62/ for test: kms_cursor_crc results: parsing output: 63/ for test: i915_pm_rc6_residency results: parsing output: 64/ for test: kms_chamelium_edid results: parsing output: 65/ for test: prime_self_import results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: kms_content_protection results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_chamelium_color results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: gem_exec_suspend results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: gem_partial_pwrite_pread results: parsing output: 74/ for test: syncobj_basic results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: gem_exec_reloc results: parsing output: 78/ for test: gem_ctx_shared results: parsing output: 79/ for test: kms_lease results: parsing output: 80/ for test: gem_pxp results: parsing output: 81/ for test: gem_userptr_blits results: parsing output: 82/ for test: kms_psr2_sf results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: core_sysfs results: parsing output: 85/ for test: syncobj_wait results: parsing output: 86/ for test: gem_lmem_swapping results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_spin_batch results: parsing output: 89/ for test: gem_exec_create results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_flip results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: gem_partial_pwrite_pread results: parsing output: 94/ for test: kms_joiner results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: gem_exec_create results: parsing output: 98/ for test: gem_exec_reloc results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: kms_prop_blob results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: perf_pmu results: parsing output: 103/ for test: kms_sequence results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_watchdog results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_plane_alpha_blend results: parsing output: 110/ for test: kms_dirtyfb results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: gem_mmap_wc results: parsing output: 114/ for test: gem_mmap_gtt results: parsing output: 115/ for test: kms_cursor_legacy results: parsing output: 116/ for test: gem_render_copy results: parsing output: 117/ for test: gem_exec_whisper results: parsing output: 118/ for test: sw_sync results: parsing output: 119/ for test: gem_exec_schedule results: parsing output: 120/ for test: kms_color_pipeline results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_exec_fence results: parsing output: 123/ for test: kms_ccs results: parsing output: 124/ for test: i915_hangman results: parsing output: 125/ for test: syncobj_timeline results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: sysfs_timeslice_duration results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_busy results: parsing output: 130/ for test: gen9_exec_parse Done.