[72.338346] Initializing watchdogs [72.338413] /dev/watchdog0 [72.359251] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [72.370507] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [72.374571] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [72.376934] [001/133] (960s left) prime_busy (before) [72.462747] Starting subtest: before [72.467587] Starting dynamic subtest: rcs0 [72.521669] Dynamic subtest rcs0: SUCCESS (0.053s) [72.530293] Starting dynamic subtest: bcs0 [72.570979] Dynamic subtest bcs0: SUCCESS (0.048s) [72.581687] Starting dynamic subtest: vcs0 [72.614205] Dynamic subtest vcs0: SUCCESS (0.042s) [72.629599] Starting dynamic subtest: vcs1 [72.660647] Dynamic subtest vcs1: SUCCESS (0.045s) [72.672450] Starting dynamic subtest: vecs0 [72.701085] Dynamic subtest vecs0: SUCCESS (0.039s) [72.710197] Starting dynamic subtest: vecs1 [72.744085] Dynamic subtest vecs1: SUCCESS (0.042s) [72.758606] Starting dynamic subtest: ccs0 [72.788477] Dynamic subtest ccs0: SUCCESS (0.043s) [72.903118] Subtest before: SUCCESS (0.430s) [73.092641] [002/133] (959s left) vgem_basic (debugfs) [73.180624] Starting subtest: debugfs [73.181522] Subtest debugfs: SUCCESS (0.000s) [73.298582] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true [73.300506] [003/133] (959s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [74.844215] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [74.846147] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [75.026541] [004/133] (958s left) gem_partial_pwrite_pread (write-display) [75.122452] Subtest write-display: SKIP (0.000s) [75.187121] [005/133] (957s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [76.734556] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [78.050347] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.300s) [78.243104] [006/133] (954s left) api_intel_bb (lot-of-buffers) [78.326262] Starting subtest: lot-of-buffers [81.705419] Subtest lot-of-buffers: SUCCESS (3.352s) [81.949804] [007/133] (951s left) kms_color_pipeline (plane-lut1d-post-ctm3x4) [83.475289] Starting subtest: plane-lut1d-post-ctm3x4 [83.699726] Starting dynamic subtest: pipe-A-plane-0 [83.942109] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s) [83.971597] Starting dynamic subtest: pipe-A-plane-1 [84.141591] Dynamic subtest pipe-A-plane-1: SUCCESS (0.198s) [84.149602] Starting dynamic subtest: pipe-A-plane-2 [84.310466] Dynamic subtest pipe-A-plane-2: SUCCESS (0.167s) [84.597001] Starting dynamic subtest: pipe-B-plane-0 [84.768916] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s) [84.799057] Starting dynamic subtest: pipe-B-plane-1 [84.968560] Dynamic subtest pipe-B-plane-1: SUCCESS (0.198s) [84.976507] Starting dynamic subtest: pipe-B-plane-2 [85.137289] Dynamic subtest pipe-B-plane-2: SUCCESS (0.167s) [85.413536] Starting dynamic subtest: pipe-C-plane-0 [85.570524] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s) [85.599979] Starting dynamic subtest: pipe-C-plane-1 [85.771120] Dynamic subtest pipe-C-plane-1: SUCCESS (0.199s) [85.782802] Starting dynamic subtest: pipe-C-plane-2 [85.955137] Dynamic subtest pipe-C-plane-2: SUCCESS (0.182s) [86.274982] Starting dynamic subtest: pipe-D-plane-0 [86.464080] Dynamic subtest pipe-D-plane-0: SUCCESS (0.216s) [86.493001] Starting dynamic subtest: pipe-D-plane-1 [86.681111] Dynamic subtest pipe-D-plane-1: SUCCESS (0.215s) [86.693429] Starting dynamic subtest: pipe-D-plane-2 [86.866353] Dynamic subtest pipe-D-plane-2: SUCCESS (0.182s) [86.922314] Subtest plane-lut1d-post-ctm3x4: SUCCESS (3.434s) [87.086584] [008/133] (946s left) gen9_exec_parse (unaligned-access) [87.176171] Subtest unaligned-access: SKIP (0.000s) [87.261814] [009/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [88.783232] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [88.784969] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [88.893097] [010/133] (944s left) gem_pxp (create-regular-context-2) [91.564838] Starting subtest: create-regular-context-2 [91.566895] Subtest create-regular-context-2: SKIP (0.000s) [91.661700] [011/133] (941s left) gem_exec_params (sol-reset-invalid) [91.746259] Starting subtest: sol-reset-invalid [91.748183] Subtest sol-reset-invalid: SUCCESS (0.002s) [91.916808] [012/133] (941s left) kms_dsc (dsc-fractional-bpp-with-bpc) [93.429347] Starting subtest: dsc-fractional-bpp-with-bpc [93.442211] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [93.528048] [013/133] (940s left) syncobj_basic (bad-fd-to-handle) [93.630677] Starting subtest: bad-fd-to-handle [93.631673] Subtest bad-fd-to-handle: SUCCESS (0.000s) [93.806532] [014/133] (939s left) kms_pm_rpm (pc8-residency) [98.049245] Starting subtest: pc8-residency [98.052689] Subtest pc8-residency: SKIP (0.000s) [98.919573] [015/133] (934s left) gem_exec_flush (basic-wb-set-default) [99.003808] Subtest basic-wb-set-default: SKIP (0.000s) [99.080487] [016/133] (934s left) syncobj_timeline (wait-all-for-submit-complex) [99.158249] Starting subtest: wait-all-for-submit-complex [99.378366] Subtest wait-all-for-submit-complex: SUCCESS (0.219s) [99.511219] [017/133] (934s left) gem_exec_schedule (fifo) [99.602084] Starting subtest: fifo [99.602981] Starting dynamic subtest: rcs0 [99.883390] Dynamic subtest rcs0: SUCCESS (0.282s) [99.891386] Starting dynamic subtest: bcs0 [100.086216] Dynamic subtest bcs0: SUCCESS (0.202s) [100.094115] Starting dynamic subtest: vcs0 [100.295122] Dynamic subtest vcs0: SUCCESS (0.208s) [100.303221] Starting dynamic subtest: vcs1 [100.506825] Dynamic subtest vcs1: SUCCESS (0.211s) [100.514672] Starting dynamic subtest: vecs0 [100.722207] Dynamic subtest vecs0: SUCCESS (0.215s) [100.730033] Starting dynamic subtest: vecs1 [100.952537] Dynamic subtest vecs1: SUCCESS (0.230s) [100.961246] Starting dynamic subtest: ccs0 [101.173207] Dynamic subtest ccs0: SUCCESS (0.220s) [101.174232] Subtest fifo: SUCCESS (1.571s) [101.572536] [018/133] (932s left) gem_exec_params (no-vebox) [101.654985] Starting subtest: no-vebox [101.656633] Subtest no-vebox: SUCCESS (0.003s) [101.867540] [019/133] (932s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [103.375015] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [103.375972] Starting dynamic subtest: pipe-A-HDMI-A-3 [103.384116] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [103.392194] Starting dynamic subtest: pipe-B-HDMI-A-3 [103.400729] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [103.408587] Starting dynamic subtest: pipe-C-HDMI-A-3 [103.416858] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [103.424719] Starting dynamic subtest: pipe-D-HDMI-A-3 [103.434540] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [103.436482] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.007s) [103.613490] [020/133] (930s left) kms_rotation_crc (exhaust-fences) [105.124142] Starting subtest: exhaust-fences [105.125971] Subtest exhaust-fences: SKIP (0.000s) [105.219637] [021/133] (928s left) gem_pxp (verify-pxp-stale-ctx-execution) [107.836129] Starting subtest: verify-pxp-stale-ctx-execution [107.839138] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s) [107.984472] [022/133] (926s left) prime_mmap_coherency (read) [108.065365] Starting subtest: read [113.465585] Subtest read: SUCCESS (5.397s) [113.595707] [023/133] (920s left) kms_getfb (getfb-addfb-different-handles) [115.107109] Starting subtest: getfb-addfb-different-handles [115.108037] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [115.349602] [024/133] (919s left) kms_psr (fbc-psr2-suspend) [116.864839] Subtest fbc-psr2-suspend: SKIP (0.000s) [116.916554] [025/133] (917s left) gem_exec_balancer (indices) [117.005924] Starting subtest: indices [118.620184] Subtest indices: SUCCESS (1.614s) [119.025099] [026/133] (915s left) gem_exec_fence (basic-busy-all) [119.115055] Starting subtest: basic-busy-all [119.223595] Subtest basic-busy-all: SUCCESS (0.109s) [120.089913] [027/133] (914s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [120.174463] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [120.176405] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [120.456473] [028/133] (914s left) kms_pm_dc (dc5-dpms-negative) [122.974277] Starting subtest: dc5-dpms-negative [127.203265] Subtest dc5-dpms-negative: SUCCESS (4.227s) [127.296956] [029/133] (907s left) gem_exec_fence (expired-history) [127.825641] Starting subtest: expired-history [134.192399] Subtest expired-history: SUCCESS (6.366s) [135.439185] [030/133] (899s left) kms_addfb_basic (unused-offsets) [135.514009] Starting subtest: unused-offsets [135.514956] Subtest unused-offsets: SUCCESS (0.000s) [137.087804] [031/133] (897s left) kms_vrr (seamless-rr-switch-vrr) [138.638416] Starting subtest: seamless-rr-switch-vrr [138.641045] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [138.729085] [032/133] (896s left) gem_vm_create (invalid-destroy) [138.828707] Starting subtest: invalid-destroy [138.833574] Subtest invalid-destroy: SUCCESS (0.005s) [138.967358] [033/133] (895s left) kms_vblank (wait-busy) [140.482984] Starting subtest: wait-busy [140.483952] Starting dynamic subtest: pipe-A-HDMI-A-3 [142.953273] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.469s) [142.963293] Starting dynamic subtest: pipe-D-HDMI-A-3 [145.304155] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.348s) [145.304977] Subtest wait-busy: SUCCESS (4.821s) [145.450362] [034/133] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [146.965555] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [146.967215] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [147.145513] [035/133] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [148.682441] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [148.684115] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [148.837713] [036/133] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [150.386213] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [150.387927] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [150.558598] [037/133] (884s left) kms_psr (fbc-psr2-cursor-blt) [152.095251] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [152.143771] [038/133] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [153.658535] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [153.660232] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [153.806794] [039/133] (881s left) kms_joiner (invalid-modeset-ultra-joiner) [155.370871] Starting subtest: invalid-modeset-ultra-joiner [155.372464] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [155.550895] [040/133] (879s left) kms_frontbuffer_tracking (psr-1p-rte) [157.088347] Starting subtest: psr-1p-rte [157.090133] Subtest psr-1p-rte: SKIP (0.000s) [157.223037] [041/133] (878s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [158.767382] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [158.769143] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s) [158.918279] [042/133] (876s left) perf_pmu (init-sema) [159.022483] Starting subtest: init-sema [159.023461] Starting dynamic subtest: rcs0 [159.025740] Dynamic subtest rcs0: SUCCESS (0.003s) [159.034033] Starting dynamic subtest: bcs0 [159.034947] Dynamic subtest bcs0: SUCCESS (0.001s) [159.042961] Starting dynamic subtest: vcs0 [159.043905] Dynamic subtest vcs0: SUCCESS (0.000s) [159.052427] Starting dynamic subtest: vcs1 [159.053574] Dynamic subtest vcs1: SUCCESS (0.000s) [159.061530] Starting dynamic subtest: vecs0 [159.062527] Dynamic subtest vecs0: SUCCESS (0.001s) [159.070404] Starting dynamic subtest: vecs1 [159.071484] Dynamic subtest vecs1: SUCCESS (0.001s) [159.079793] Starting dynamic subtest: ccs0 [159.080959] Dynamic subtest ccs0: SUCCESS (0.000s) [159.082163] Subtest init-sema: SUCCESS (0.008s) [159.150369] [043/133] (876s left) kms_cursor_crc (cursor-offscreen-128x42) [160.864212] Starting subtest: cursor-offscreen-128x42 [160.867978] Starting dynamic subtest: pipe-A-HDMI-A-3 [163.377489] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.509s) [163.408668] Starting dynamic subtest: pipe-D-HDMI-A-3 [165.799560] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.398s) [165.800455] Subtest cursor-offscreen-128x42: SUCCESS (4.935s) [166.094683] [044/133] (869s left) gem_eio (create) [166.384795] Starting subtest: create [166.846911] Subtest create: SUCCESS (0.462s) [168.425980] [045/133] (867s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [169.979251] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [171.252704] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.273s) [171.501921] [046/133] (864s left) gem_exec_fence (keep-in-fence) [171.712028] Starting subtest: keep-in-fence [171.713529] Starting dynamic subtest: rcs0 [171.819281] Dynamic subtest rcs0: SUCCESS (0.107s) [171.828839] Starting dynamic subtest: bcs0 [171.871594] Dynamic subtest bcs0: SUCCESS (0.052s) [171.895667] Starting dynamic subtest: vcs0 [171.941512] Dynamic subtest vcs0: SUCCESS (0.069s) [171.953939] Starting dynamic subtest: vcs1 [171.997408] Dynamic subtest vcs1: SUCCESS (0.055s) [172.010787] Starting dynamic subtest: vecs0 [172.050039] Dynamic subtest vecs0: SUCCESS (0.052s) [172.081073] Starting dynamic subtest: vecs1 [172.123590] Dynamic subtest vecs1: SUCCESS (0.073s) [172.144597] Starting dynamic subtest: ccs0 [172.359239] Dynamic subtest ccs0: SUCCESS (0.235s) [172.360388] Subtest keep-in-fence: SUCCESS (0.648s) [173.082207] [047/133] (862s left) gem_exec_reloc (basic-cpu-gtt) [173.165467] Subtest basic-cpu-gtt: SKIP (0.000s) [173.226750] [048/133] (862s left) kms_cursor_crc (cursor-sliding-128x42) [174.942953] Starting subtest: cursor-sliding-128x42 [174.947060] Starting dynamic subtest: pipe-A-HDMI-A-3 [179.059182] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.112s) [179.094168] Starting dynamic subtest: pipe-D-HDMI-A-3 [183.385364] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.299s) [183.386352] Subtest cursor-sliding-128x42: SUCCESS (8.443s) [183.730648] [049/133] (852s left) kms_flip (nonexisting-fb) [185.239937] Starting subtest: nonexisting-fb [185.245175] Starting dynamic subtest: A-HDMI-A3 [185.488584] Dynamic subtest A-HDMI-A3: SUCCESS (0.243s) [185.502292] Starting dynamic subtest: B-HDMI-A3 [185.668576] Dynamic subtest B-HDMI-A3: SUCCESS (0.179s) [185.678545] Starting dynamic subtest: C-HDMI-A3 [185.850352] Dynamic subtest C-HDMI-A3: SUCCESS (0.181s) [185.860981] Starting dynamic subtest: D-HDMI-A3 [186.032409] Dynamic subtest D-HDMI-A3: SUCCESS (0.181s) [186.033386] Subtest nonexisting-fb: SUCCESS (0.793s) [186.260188] [050/133] (849s left) kms_cursor_crc (cursor-sliding-256x256) [188.004306] Starting subtest: cursor-sliding-256x256 [188.008995] Starting dynamic subtest: pipe-A-HDMI-A-3 [192.364953] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.355s) [192.402035] Starting dynamic subtest: pipe-D-HDMI-A-3 [196.677546] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.284s) [196.678568] Subtest cursor-sliding-256x256: SUCCESS (8.673s) [196.965105] [051/133] (839s left) syncobj_eventfd (invalid-bad-flags) [197.040194] Starting subtest: invalid-bad-flags [197.041397] Subtest invalid-bad-flags: SUCCESS (0.000s) [197.188676] [052/133] (839s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [198.699321] Starting subtest: planes-downscale-factor-0-5-unity-scaling [198.700236] Starting dynamic subtest: pipe-A [198.789481] Dynamic subtest pipe-A: SUCCESS (0.090s) [198.800303] Starting dynamic subtest: pipe-B [198.917608] Dynamic subtest pipe-B: SUCCESS (0.127s) [198.930237] Starting dynamic subtest: pipe-C [199.058459] Dynamic subtest pipe-C: SUCCESS (0.140s) [199.067473] Starting dynamic subtest: pipe-D [199.183239] Dynamic subtest pipe-D: SUCCESS (0.124s) [199.184198] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.485s) [199.452622] [053/133] (837s left) syncobj_timeline (etime-single-wait-submitted) [199.530235] Starting subtest: etime-single-wait-submitted [199.631565] Subtest etime-single-wait-submitted: SUCCESS (0.101s) [199.775148] [054/133] (836s left) kms_legacy_colorkey (invalid-plane) [201.284663] Starting subtest: invalid-plane [201.285547] Starting dynamic subtest: zero-id [201.286425] Dynamic subtest zero-id: SUCCESS (0.000s) [201.295451] Starting dynamic subtest: outrange-id [201.296513] Dynamic subtest outrange-id: SUCCESS (0.000s) [201.297579] Subtest invalid-plane: SUCCESS (0.001s) [201.400483] [055/133] (835s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [202.932201] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [202.934043] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [203.024156] [056/133] (833s left) kms_big_fb (x-tiled-64bpp-rotate-0) [204.561811] Starting subtest: x-tiled-64bpp-rotate-0 [206.491870] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.929s) [206.658531] [057/133] (830s left) sysfs_timeslice_duration (timeout) [206.742561] Starting subtest: timeout [206.743424] Starting dynamic subtest: vecs0 [208.618107] Dynamic subtest vecs0: SUCCESS (1.874s) [208.627227] Starting dynamic subtest: ccs0 [210.408367] Dynamic subtest ccs0: SUCCESS (1.789s) [210.417364] Starting dynamic subtest: vcs0 [212.078294] Dynamic subtest vcs0: SUCCESS (1.669s) [212.087194] Starting dynamic subtest: bcs0 [213.230272] Dynamic subtest bcs0: SUCCESS (1.151s) [213.239133] Starting dynamic subtest: vecs1 [214.995889] Dynamic subtest vecs1: SUCCESS (1.765s) [215.004924] Starting dynamic subtest: rcs0 [216.680280] Dynamic subtest rcs0: SUCCESS (1.684s) [216.689259] Starting dynamic subtest: vcs1 [218.350240] Dynamic subtest vcs1: SUCCESS (1.669s) [218.351267] Subtest timeout: SUCCESS (11.607s) [218.510525] [058/133] (818s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [218.594175] Starting subtest: multi-wait-for-submit-available-signaled [218.595122] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s) [218.691436] [059/133] (818s left) gem_exec_whisper (basic-fds-priority-all) [218.784348] Starting subtest: basic-fds-priority-all [241.553368] Subtest basic-fds-priority-all: SUCCESS (22.766s) [241.761096] [060/133] (795s left) gem_exec_schedule (semaphore-resolve) [241.853393] Starting subtest: semaphore-resolve [241.931495] Subtest semaphore-resolve: SUCCESS (0.078s) [242.329687] [061/133] (794s left) gem_mmap_offset (blt-coherency) [242.408077] Starting subtest: blt-coherency [242.441012] Subtest blt-coherency: SUCCESS (0.033s) [242.638815] [062/133] (794s left) gem_spin_batch (engines) [242.725873] Starting subtest: engines [242.726843] Starting dynamic subtest: rcs0 [245.989877] Dynamic subtest rcs0: SUCCESS (3.261s) [245.999678] Starting dynamic subtest: bcs0 [249.221153] Dynamic subtest bcs0: SUCCESS (3.229s) [249.233226] Starting dynamic subtest: vcs0 [252.460353] Dynamic subtest vcs0: SUCCESS (3.236s) [252.472570] Starting dynamic subtest: vcs1 [255.699238] Dynamic subtest vcs1: SUCCESS (3.236s) [255.711570] Starting dynamic subtest: vecs0 [258.937304] Dynamic subtest vecs0: SUCCESS (3.236s) [258.947168] Starting dynamic subtest: vecs1 [262.173801] Dynamic subtest vecs1: SUCCESS (3.234s) [262.184338] Starting dynamic subtest: ccs0 [265.411200] Dynamic subtest ccs0: SUCCESS (3.234s) [265.413095] Subtest engines: SUCCESS (22.683s) [265.678352] [063/133] (771s left) syncobj_wait (multi-wait-signaled) [265.755446] Starting subtest: multi-wait-signaled [265.756359] Subtest multi-wait-signaled: SUCCESS (0.000s) [265.902747] [064/133] (771s left) kms_content_protection (atomic-dpms-hdcp14) [267.474994] Starting subtest: atomic-dpms-hdcp14 [267.481329] Subtest atomic-dpms-hdcp14: SKIP (0.005s) [267.666840] [065/133] (769s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [269.184246] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [273.362580] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.178s) [273.564598] [066/133] (763s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [275.075095] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [275.088373] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.013s) [275.211896] [067/133] (762s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [276.758087] Starting subtest: yf-tiled-8bpp-rotate-90 [276.760054] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [276.986069] [068/133] (760s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [278.503532] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [278.505202] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [278.630666] [069/133] (758s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [280.170434] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [280.172137] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [280.291269] [070/133] (757s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [281.822525] Starting subtest: cursorA-vs-flipA-toggle [292.738060] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.915s) [292.924443] [071/133] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [294.447941] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [294.449659] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [294.595347] [072/133] (743s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [296.138708] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [296.140392] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [296.272591] [073/133] (741s left) gem_eio (in-flight-external) [296.602961] Starting subtest: in-flight-external [297.919747] Subtest in-flight-external: SUCCESS (1.318s) [299.464686] [074/133] (738s left) dmabuf (all-tests) [299.542543] Starting subtest: all-tests [299.543485] Starting dynamic subtest: sanitycheck [299.651542] Dynamic subtest sanitycheck: SUCCESS (0.115s) [299.667526] Starting dynamic subtest: dma_fence [299.815501] Dynamic subtest dma_fence: SUCCESS (0.163s) [299.825486] Starting dynamic subtest: dma_fence_chain [310.585167] Dynamic subtest dma_fence_chain: SUCCESS (10.768s) [310.600985] Starting dynamic subtest: dma_fence_unwrap [310.652713] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s) [310.670642] Starting dynamic subtest: dma_resv [310.723830] Dynamic subtest dma_resv: SUCCESS (0.069s) [310.725177] Subtest all-tests: SUCCESS (11.189s) [310.808294] [075/133] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [312.323876] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [312.325520] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [312.450192] [076/133] (725s left) kms_prop_blob (blob-prop-validate) [312.552454] Starting subtest: blob-prop-validate [312.553425] Subtest blob-prop-validate: SUCCESS (0.000s) [312.701588] [077/133] (725s left) kms_flip (2x-absolute-wf_vblank) [314.211924] Starting subtest: 2x-absolute-wf_vblank [314.224055] Subtest 2x-absolute-wf_vblank: SKIP (0.013s) [314.319215] [078/133] (723s left) kms_big_fb (linear-16bpp-rotate-0) [315.854487] Starting subtest: linear-16bpp-rotate-0 [317.769935] Subtest linear-16bpp-rotate-0: SUCCESS (1.914s) [317.952774] [079/133] (720s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [319.459899] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [319.461600] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s) [319.552625] [080/133] (718s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [321.077777] Starting subtest: plane-downscale-factor-0-75-with-rotation [321.078588] Starting dynamic subtest: pipe-A [321.451667] Dynamic subtest pipe-A: SUCCESS (0.375s) [321.468684] Starting dynamic subtest: pipe-B [321.860061] Dynamic subtest pipe-B: SUCCESS (0.407s) [321.884525] Starting dynamic subtest: pipe-C [322.268553] Dynamic subtest pipe-C: SUCCESS (0.407s) [322.295216] Starting dynamic subtest: pipe-D [322.677444] Dynamic subtest pipe-D: SUCCESS (0.407s) [322.678644] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.602s) [322.980800] [081/133] (715s left) gem_ctx_shared (create-shared-gtt) [323.071948] Starting subtest: create-shared-gtt [325.222491] Subtest create-shared-gtt: SUCCESS (2.150s) [327.744777] [082/133] (710s left) kms_cdclk (mode-transition) [329.255989] Starting subtest: mode-transition [329.256929] Starting dynamic subtest: pipe-A-HDMI-A-3 [329.309842] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.053s) [329.319048] Starting dynamic subtest: pipe-B-HDMI-A-3 [329.320906] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s) [329.330315] Starting dynamic subtest: pipe-C-HDMI-A-3 [329.332157] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s) [329.341458] Starting dynamic subtest: pipe-D-HDMI-A-3 [329.343280] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s) [329.345055] Subtest mode-transition: SKIP (0.065s) [329.537839] [083/133] (709s left) kms_setmode (invalid-clone-single-crtc) [329.622490] Starting subtest: invalid-clone-single-crtc [329.625503] Subtest invalid-clone-single-crtc: SKIP (0.000s) [329.759913] [084/133] (708s left) kms_addfb_basic (basic-x-tiled-legacy) [329.837509] Starting subtest: basic-x-tiled-legacy [329.839235] Subtest basic-x-tiled-legacy: SKIP (0.000s) [331.410176] [085/133] (707s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [332.957148] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [332.971095] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.013s) [333.158300] [086/133] (705s left) kms_chamelium_hpd (dp-hpd-fast) [334.723685] Subtest dp-hpd-fast: SKIP (0.000s) [334.823986] [087/133] (704s left) template (b) [334.912478] Starting subtest: B [334.913500] Subtest B: SUCCESS (0.000s) [335.052928] [088/133] (703s left) gem_ctx_persistence (engines-mixed-process) [335.138460] Starting subtest: engines-mixed-process [335.139426] Starting dynamic subtest: rcs0 [336.896402] Dynamic subtest rcs0: SUCCESS (1.757s) [336.908070] Starting dynamic subtest: bcs0 [338.880247] Dynamic subtest bcs0: SUCCESS (1.982s) [338.891981] Starting dynamic subtest: vcs0 [340.929393] Dynamic subtest vcs0: SUCCESS (2.048s) [340.941504] Starting dynamic subtest: vcs1 [342.916510] Dynamic subtest vcs1: SUCCESS (1.985s) [342.928408] Starting dynamic subtest: vecs0 [344.901637] Dynamic subtest vecs0: SUCCESS (1.983s) [344.913621] Starting dynamic subtest: vecs1 [346.883115] Dynamic subtest vecs1: SUCCESS (1.980s) [346.893676] Starting dynamic subtest: ccs0 [348.867536] Dynamic subtest ccs0: SUCCESS (1.983s) [348.868574] Subtest engines-mixed-process: SUCCESS (13.730s) [349.032177] [089/133] (690s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [350.547817] Starting subtest: psr-rgb565-draw-mmap-gtt [350.549473] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [350.711495] [090/133] (688s left) kms_psr (fbc-pr-primary-mmap-cpu) [352.261614] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [352.316130] [091/133] (686s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [353.867760] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [353.870328] Starting dynamic subtest: pipe-A-HDMI-A-3 [353.878558] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [353.887967] Starting dynamic subtest: pipe-B-HDMI-A-3 [353.896201] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [353.905374] Starting dynamic subtest: pipe-C-HDMI-A-3 [353.913669] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [353.922599] Starting dynamic subtest: pipe-D-HDMI-A-3 [353.931513] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [353.933577] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s) [354.130186] [092/133] (685s left) kms_busy (extended-modeset-hang-oldfb) [355.650190] Starting subtest: extended-modeset-hang-oldfb [355.651128] Starting dynamic subtest: pipe-A [363.569331] Dynamic subtest pipe-A: SUCCESS (7.918s) [363.580985] Starting dynamic subtest: pipe-D [371.460351] Dynamic subtest pipe-D: SUCCESS (7.888s) [371.462537] Subtest extended-modeset-hang-oldfb: SUCCESS (15.812s) [371.693713] [093/133] (667s left) i915_getparams_basic (basic-eu-total) [371.771302] Starting subtest: basic-eu-total [371.773380] Subtest basic-eu-total: SUCCESS (0.000s) [371.900999] [094/133] (667s left) kms_psr (psr-cursor-mmap-gtt) [373.411495] Subtest psr-cursor-mmap-gtt: SKIP (0.000s) [373.472553] [095/133] (665s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [374.985334] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [375.039153] [096/133] (664s left) gem_exec_schedule (pi-ringfull) [375.270402] Starting subtest: pi-ringfull [375.271967] Starting dynamic subtest: rcs0 [375.318455] Dynamic subtest rcs0: SUCCESS (0.049s) [375.328131] Starting dynamic subtest: bcs0 [375.355168] Dynamic subtest bcs0: SUCCESS (0.036s) [375.364643] Starting dynamic subtest: vcs0 [375.389609] Dynamic subtest vcs0: SUCCESS (0.034s) [375.400595] Starting dynamic subtest: vcs1 [375.422957] Dynamic subtest vcs1: SUCCESS (0.032s) [375.434193] Starting dynamic subtest: vecs0 [375.454016] Dynamic subtest vecs0: SUCCESS (0.030s) [375.465239] Starting dynamic subtest: vecs1 [375.485214] Dynamic subtest vecs1: SUCCESS (0.030s) [375.496490] Starting dynamic subtest: ccs0 [375.516398] Dynamic subtest ccs0: SUCCESS (0.030s) [375.517174] Subtest pi-ringfull: SUCCESS (0.250s) [375.809933] [097/133] (663s left) sw_sync (sync_multi_consumer_producer) [375.857928] Starting subtest: sync_multi_consumer_producer [376.112744] Subtest sync_multi_consumer_producer: SUCCESS (0.246s) [376.176347] [098/133] (663s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [377.691885] Starting subtest: psr-farfromfence-mmap-gtt [377.693558] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [377.878266] [099/133] (661s left) kms_plane_alpha_blend (constant-alpha-min) [379.431113] Starting subtest: constant-alpha-min [379.691172] Starting dynamic subtest: pipe-A-HDMI-A-3 [380.336429] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.644s) [380.346201] Starting dynamic subtest: pipe-D-HDMI-A-3 [381.022074] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.684s) [381.023049] Subtest constant-alpha-min: SUCCESS (1.592s) [381.197885] [100/133] (658s left) gem_madvise (dontneed-after-mmap) [381.245935] Starting subtest: dontneed-after-mmap [381.291281] Subtest dontneed-after-mmap: SUCCESS (0.046s) [381.433356] [101/133] (658s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [382.942127] Starting subtest: primary-y-tiled-reflect-x-90 [382.943998] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [383.113375] [102/133] (656s left) kms_big_fb (y-tiled-addfb) [384.666175] Starting subtest: y-tiled-addfb [384.668237] Subtest y-tiled-addfb: SKIP (0.000s) [384.920424] [103/133] (655s left) gem_lmem_swapping (parallel-random-engines) [389.292113] Starting subtest: parallel-random-engines [389.292924] Starting dynamic subtest: lmem0 [393.153206] Dynamic subtest lmem0: FAIL (3.855s) [393.153988] Subtest parallel-random-engines: FAIL (3.857s) [407.559886] Killing the test because the kernel is tainted. [527.738809] Timeout. Killing the current test with SIGKILL. [528.739682] Warning: kernel log ringbuffer underflow, some records lost. [528.741930] Child refuses to die, tainted 0x40c4. Aborting. [528.756449] Closing watchdogs [538.290679] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [538.290751] [FACT gem_lmem_swapping (parallel-random-engines)] new: kernel.is_tainted.taint_die: true [538.290761] [FACT gem_lmem_swapping (parallel-random-engines)] new: kernel.is_tainted.taint_warn: true [538.291653] Closing watchdogs results: parsing output: 0/ for test: prime_busy results: parsing output: 1/ for test: vgem_basic results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: gem_partial_pwrite_pread results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: api_intel_bb results: parsing output: 6/ for test: kms_color_pipeline results: parsing output: 7/ for test: gen9_exec_parse results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_pxp results: parsing output: 10/ for test: gem_exec_params results: parsing output: 11/ for test: kms_dsc results: parsing output: 12/ for test: syncobj_basic results: parsing output: 13/ for test: kms_pm_rpm results: parsing output: 14/ for test: gem_exec_flush results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: gem_exec_schedule results: parsing output: 17/ for test: gem_exec_params results: parsing output: 18/ for test: kms_ccs results: parsing output: 19/ for test: kms_rotation_crc results: parsing output: 20/ for test: gem_pxp results: parsing output: 21/ for test: prime_mmap_coherency results: parsing output: 22/ for test: kms_getfb results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: gem_exec_balancer results: parsing output: 25/ for test: gem_exec_fence results: parsing output: 26/ for test: gem_render_copy results: parsing output: 27/ for test: kms_pm_dc results: parsing output: 28/ for test: gem_exec_fence results: parsing output: 29/ for test: kms_addfb_basic results: parsing output: 30/ for test: kms_vrr results: parsing output: 31/ for test: gem_vm_create results: parsing output: 32/ for test: kms_vblank results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_joiner results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: perf_pmu results: parsing output: 42/ for test: kms_cursor_crc results: parsing output: 43/ for test: gem_eio results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: gem_exec_fence results: parsing output: 46/ for test: gem_exec_reloc results: parsing output: 47/ for test: kms_cursor_crc results: parsing output: 48/ for test: kms_flip results: parsing output: 49/ for test: kms_cursor_crc results: parsing output: 50/ for test: syncobj_eventfd results: parsing output: 51/ for test: kms_plane_scaling results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: kms_legacy_colorkey results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: sysfs_timeslice_duration results: parsing output: 57/ for test: syncobj_timeline results: parsing output: 58/ for test: gem_exec_whisper results: parsing output: 59/ for test: gem_exec_schedule results: parsing output: 60/ for test: gem_mmap_offset results: parsing output: 61/ for test: gem_spin_batch results: parsing output: 62/ for test: syncobj_wait results: parsing output: 63/ for test: kms_content_protection results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_cursor_legacy results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_eio results: parsing output: 73/ for test: dmabuf results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_prop_blob results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: kms_plane results: parsing output: 79/ for test: kms_plane_scaling results: parsing output: 80/ for test: gem_ctx_shared results: parsing output: 81/ for test: kms_cdclk results: parsing output: 82/ for test: kms_setmode results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_flip results: parsing output: 85/ for test: kms_chamelium_hpd results: parsing output: 86/ for test: template results: parsing output: 87/ for test: gem_ctx_persistence results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: kms_ccs results: parsing output: 91/ for test: kms_busy results: parsing output: 92/ for test: i915_getparams_basic results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: kms_psr2_sf results: parsing output: 95/ for test: gem_exec_schedule results: parsing output: 96/ for test: sw_sync results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_plane_alpha_blend results: parsing output: 99/ for test: gem_madvise results: parsing output: 100/ for test: kms_rotation_crc results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: gem_lmem_swapping results: parsing output: 103/ for test: kms_flip results: no output, setting notrun results: parsing output: 104/ for test: gem_softpin results: no output, setting notrun results: parsing output: 105/ for test: api_intel_allocator results: no output, setting notrun results: parsing output: 106/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 107/ for test: gem_create results: no output, setting notrun results: parsing output: 108/ for test: gem_mmap_wc results: no output, setting notrun results: parsing output: 109/ for test: kms_chamelium_frames results: no output, setting notrun results: parsing output: 110/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 111/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 112/ for test: fbdev results: no output, setting notrun results: parsing output: 113/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 114/ for test: gem_fence_thrash results: no output, setting notrun results: parsing output: 115/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 116/ for test: kms_flip results: no output, setting notrun results: parsing output: 117/ for test: gem_exec_reloc results: no output, setting notrun results: parsing output: 118/ for test: kms_flip results: no output, setting notrun results: parsing output: 119/ for test: gen9_exec_parse results: no output, setting notrun results: parsing output: 120/ for test: i915_suspend results: no output, setting notrun results: parsing output: 121/ for test: kms_psr results: no output, setting notrun results: parsing output: 122/ for test: kms_ccs results: no output, setting notrun results: parsing output: 123/ for test: kms_plane_multiple results: no output, setting notrun results: parsing output: 124/ for test: kms_dp_linktrain_fallback results: no output, setting notrun results: parsing output: 125/ for test: i915_pm_rpm results: no output, setting notrun results: parsing output: 126/ for test: tools_test results: no output, setting notrun results: parsing output: 127/ for test: kms_vblank results: no output, setting notrun results: parsing output: 128/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 129/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 130/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 131/ for test: kms_flip results: no output, setting notrun results: parsing output: 132/ for test: kms_psr results: no output, setting notrun Done.