[79.588242] Initializing watchdogs [79.588424] /dev/watchdog0 [79.598243] [001/171] (960s left) i915_module_load (load) [79.729185] Starting subtest: load [82.138048] Subtest load: SUCCESS (2.409s) [82.162781] [002/171] (957s left) core_auth (basic-auth) [82.293743] Starting subtest: basic-auth [82.294892] Subtest basic-auth: SUCCESS (0.002s) [82.367152] [003/171] (957s left) debugfs_test (read_all_entries) [82.506690] Starting subtest: read_all_entries [82.573635] Subtest read_all_entries: SUCCESS (0.066s) [82.683861] [004/171] (957s left) debugfs_test (basic-hwmon) [82.817891] Starting subtest: basic-hwmon [82.819911] Subtest basic-hwmon: SKIP (0.000s) [82.935868] [005/171] (957s left) fbdev (eof) [83.097087] Starting subtest: eof [83.098245] Subtest eof: SUCCESS (0.000s) [83.152462] [006/171] (957s left) fbdev (info) [83.272550] Starting subtest: info [83.273770] Subtest info: SUCCESS (0.000s) [83.352497] [007/171] (956s left) fbdev (nullptr) [83.488604] Starting subtest: nullptr [83.489800] Subtest nullptr: SUCCESS (0.000s) [83.551653] [008/171] (956s left) fbdev (read) [83.688417] Starting subtest: read [90.791731] Subtest read: SUCCESS (7.068s) [90.838636] [009/171] (949s left) fbdev (write) [90.990045] Starting subtest: write [94.764331] Subtest write: SUCCESS (3.740s) [94.801771] [010/171] (945s left) gem_basic (bad-close) [94.927496] Starting subtest: bad-close [94.929577] Subtest bad-close: SUCCESS (0.000s) [95.000704] [011/171] (945s left) gem_basic (create-close) [95.128597] Starting subtest: create-close [95.130645] Subtest create-close: SUCCESS (0.000s) [95.234305] [012/171] (945s left) gem_basic (create-fd-close) [95.360755] Starting subtest: create-fd-close [95.362766] Subtest create-fd-close: SUCCESS (0.000s) [95.450954] [013/171] (944s left) gem_busy (busy@all-engines) [95.594530] Starting subtest: busy [95.595723] Starting dynamic subtest: all-engines [95.648647] Dynamic subtest all-engines: SUCCESS (0.054s) [95.649964] Subtest busy: SUCCESS (0.054s) [96.019581] [014/171] (944s left) gem_close_race (basic-process) [96.167518] Starting subtest: basic-process [96.239933] Subtest basic-process: SUCCESS (0.073s) [96.435616] [015/171] (943s left) gem_close_race (basic-threads) [96.582153] Starting subtest: basic-threads [97.732958] Subtest basic-threads: SUCCESS (1.151s) [97.949804] [016/171] (942s left) gem_ctx_create (basic) [98.091765] Starting subtest: basic [98.092966] Subtest basic: SUCCESS (0.000s) [98.286979] [017/171] (942s left) gem_ctx_create (basic-files) [98.428195] Starting subtest: basic-files [100.447808] Subtest basic-files: SUCCESS (2.020s) [100.657551] [018/171] (939s left) gem_ctx_exec (basic) [100.787969] Starting subtest: basic [100.793109] Subtest basic: SUCCESS (0.005s) [100.903437] [019/171] (939s left) gem_exec_basic (basic) [101.032330] Starting subtest: basic [101.033530] Starting dynamic subtest: rcs0-smem [101.034695] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [101.045863] Starting dynamic subtest: bcs0-smem [101.047092] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [101.056919] Starting dynamic subtest: vcs0-smem [101.058264] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [101.068017] Starting dynamic subtest: vecs0-smem [101.069386] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [101.070773] Subtest basic: SUCCESS (0.006s) [101.235746] [020/171] (939s left) gem_exec_create (basic) [101.376895] Starting subtest: basic [101.378143] Starting dynamic subtest: smem [103.449719] Dynamic subtest smem: SUCCESS (2.047s) [103.451047] Subtest basic: SUCCESS (2.047s) [103.621742] [021/171] (936s left) gem_exec_fence (basic-busy) [103.899639] Starting subtest: basic-busy [103.900990] Starting dynamic subtest: rcs0 [103.917458] Dynamic subtest rcs0: SUCCESS (0.026s) [103.928694] Starting dynamic subtest: bcs0 [103.939555] Dynamic subtest bcs0: SUCCESS (0.022s) [103.949938] Starting dynamic subtest: vcs0 [103.962315] Dynamic subtest vcs0: SUCCESS (0.023s) [103.972712] Starting dynamic subtest: vecs0 [103.990605] Dynamic subtest vecs0: SUCCESS (0.028s) [103.992075] Subtest basic-busy: SUCCESS (0.100s) [104.579517] [022/171] (935s left) gem_exec_fence (basic-wait) [104.863540] Starting subtest: basic-wait [104.865258] Starting dynamic subtest: rcs0 [104.900507] Dynamic subtest rcs0: SUCCESS (0.045s) [104.919802] Starting dynamic subtest: bcs0 [104.922234] Dynamic subtest bcs0: SUCCESS (0.022s) [104.933196] Starting dynamic subtest: vcs0 [104.952741] Dynamic subtest vcs0: SUCCESS (0.030s) [104.965605] Starting dynamic subtest: vecs0 [104.980407] Dynamic subtest vecs0: SUCCESS (0.028s) [104.981889] Subtest basic-wait: SUCCESS (0.126s) [105.519700] [023/171] (935s left) gem_exec_fence (basic-await) [105.805686] Starting subtest: basic-await [105.806868] Starting dynamic subtest: rcs0 [105.886912] Dynamic subtest rcs0: SUCCESS (0.089s) [105.911403] Starting dynamic subtest: bcs0 [105.988073] Dynamic subtest bcs0: SUCCESS (0.101s) [106.014633] Starting dynamic subtest: vcs0 [106.101349] Dynamic subtest vcs0: SUCCESS (0.112s) [106.127278] Starting dynamic subtest: vecs0 [106.221516] Dynamic subtest vecs0: SUCCESS (0.120s) [106.223744] Subtest basic-await: SUCCESS (0.424s) [106.786627] [024/171] (933s left) gem_exec_fence (nb-await) [107.070136] Starting subtest: nb-await [107.071254] Starting dynamic subtest: rcs0 [107.126953] Dynamic subtest rcs0: SUCCESS (0.064s) [107.144742] Starting dynamic subtest: bcs0 [107.195853] Dynamic subtest bcs0: SUCCESS (0.068s) [107.222124] Starting dynamic subtest: vcs0 [107.269691] Dynamic subtest vcs0: SUCCESS (0.074s) [107.296764] Starting dynamic subtest: vecs0 [107.343490] Dynamic subtest vecs0: SUCCESS (0.073s) [107.345382] Subtest nb-await: SUCCESS (0.281s) [107.886883] [025/171] (932s left) gem_exec_gttfill (basic) [108.034601] Starting subtest: basic [115.971294] Subtest basic: SUCCESS (7.928s) [116.155336] [026/171] (924s left) gem_exec_parallel (engines) [116.366684] Starting subtest: engines [116.367879] Starting dynamic subtest: basic [118.786686] Dynamic subtest basic: SUCCESS (2.401s) [118.799174] Starting dynamic subtest: contexts [121.947303] Dynamic subtest contexts: SUCCESS (3.174s) [121.960634] Starting dynamic subtest: fds [125.586561] Dynamic subtest fds: SUCCESS (3.648s) [125.608426] Starting dynamic subtest: userptr [128.093698] Dynamic subtest userptr: SUCCESS (2.480s) [128.095758] Subtest engines: SUCCESS (11.703s) [128.273255] [027/171] (912s left) gem_exec_store (basic) [128.416490] Starting subtest: basic [128.487486] Subtest basic: SUCCESS (0.070s) [128.689312] [028/171] (911s left) gem_flink_basic (bad-flink) [128.814908] Starting subtest: bad-flink [128.816158] Subtest bad-flink: SUCCESS (0.000s) [128.887991] [029/171] (911s left) gem_flink_basic (bad-open) [129.015776] Starting subtest: bad-open [129.016970] Subtest bad-open: SUCCESS (0.000s) [129.087926] [030/171] (911s left) gem_flink_basic (basic) [129.216099] Starting subtest: basic [129.217220] Subtest basic: SUCCESS (0.000s) [129.320893] [031/171] (911s left) gem_flink_basic (double-flink) [129.452281] Starting subtest: double-flink [129.453514] Subtest double-flink: SUCCESS (0.000s) [129.545650] [032/171] (911s left) gem_flink_basic (flink-lifetime) [129.684409] Starting subtest: flink-lifetime [129.685617] Subtest flink-lifetime: SUCCESS (0.002s) [129.787980] [033/171] (911s left) gem_huc_copy (huc-copy) [129.920445] Starting subtest: huc-copy [129.922773] Subtest huc-copy: SKIP (0.000s) [130.022598] [034/171] (910s left) gem_linear_blits (basic) [130.281358] Starting subtest: basic [130.293679] Subtest basic: SUCCESS (0.012s) [130.422244] [035/171] (910s left) gem_mmap (basic) [130.607542] Starting subtest: basic [130.612896] Subtest basic: SUCCESS (0.001s) [130.704884] [036/171] (910s left) gem_mmap_gtt (basic) [130.834617] Starting subtest: basic [130.835835] Subtest basic: SUCCESS (0.001s) [130.922223] [037/171] (909s left) gem_render_linear_blits (basic) [131.047845] Starting subtest: basic [131.097966] Subtest basic: SUCCESS (0.050s) [131.157837] [038/171] (909s left) gem_render_tiled_blits (basic) [131.292660] Starting subtest: basic [131.356531] Subtest basic: SUCCESS (0.062s) [131.422875] [039/171] (909s left) gem_ringfill (basic-all) [131.684678] Starting subtest: basic-all [132.901050] Subtest basic-all: SUCCESS (1.208s) [132.972638] [040/171] (908s left) gem_softpin (allocator-basic) [133.109362] Starting subtest: allocator-basic [133.271915] Subtest allocator-basic: SUCCESS (0.154s) [133.373205] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [133.508138] Starting subtest: allocator-basic-reserve [133.670699] Subtest allocator-basic-reserve: SUCCESS (0.154s) [133.771869] [042/171] (907s left) gem_softpin (safe-alignment) [133.919521] Starting subtest: safe-alignment [133.937683] Subtest safe-alignment: SUCCESS (0.018s) [134.054557] [043/171] (907s left) gem_sync (basic-all) [134.192436] Starting subtest: basic-all [136.703562] Subtest basic-all: SUCCESS (2.483s) [136.872420] [044/171] (904s left) gem_sync (basic-each) [137.014492] Starting subtest: basic-each [139.198573] Subtest basic-each: SUCCESS (2.183s) [139.418443] [045/171] (901s left) gem_tiled_blits (basic) [139.682321] Starting subtest: basic [139.711537] Subtest basic: SUCCESS (0.030s) [139.853856] [046/171] (901s left) gem_tiled_fence_blits (basic) [140.193291] Starting subtest: basic [140.219862] Subtest basic: SUCCESS (0.027s) [140.335394] [047/171] (900s left) gem_tiled_pread_basic [140.855942] [048/171] (900s left) gem_wait (busy@all-engines) [141.005132] Starting subtest: busy [141.006350] Starting dynamic subtest: all-engines [141.542498] Dynamic subtest all-engines: SUCCESS (0.537s) [141.543657] Subtest busy: SUCCESS (0.538s) [141.772881] [049/171] (899s left) gem_wait (wait@all-engines) [141.920379] Starting subtest: wait [141.921572] Starting dynamic subtest: all-engines [142.962132] Dynamic subtest all-engines: SUCCESS (1.041s) [142.963916] Subtest wait: SUCCESS (1.042s) [143.189312] [050/171] (898s left) i915_getparams_basic (basic-eu-total) [143.310273] Starting subtest: basic-eu-total [143.312514] Subtest basic-eu-total: SUCCESS (0.000s) [143.387935] [051/171] (897s left) i915_getparams_basic (basic-subslice-total) [143.517046] Starting subtest: basic-subslice-total [143.519648] Subtest basic-subslice-total: SUCCESS (0.000s) [143.604935] [052/171] (897s left) i915_hangman (error-state-basic) [143.738894] Starting subtest: error-state-basic [143.750622] Subtest error-state-basic: SUCCESS (0.012s) [143.838514] [053/171] (897s left) i915_pciid [144.037942] [054/171] (897s left) kms_addfb_basic (addfb25-bad-modifier) [144.169277] Starting subtest: addfb25-bad-modifier [144.170375] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [144.287603] [055/171] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [144.417973] Starting subtest: addfb25-framebuffer-vs-set-tiling [144.419137] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [144.538945] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [144.660080] Starting subtest: addfb25-modifier-no-flag [144.661224] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [144.771726] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [144.908354] Starting subtest: addfb25-x-tiled-legacy [144.909469] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [145.021144] [058/171] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [145.148931] Starting subtest: addfb25-x-tiled-mismatch-legacy [145.150098] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [145.271059] [059/171] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [145.428367] Starting subtest: addfb25-yf-tiled-legacy [145.429404] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [145.521132] [060/171] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [145.678228] Starting subtest: addfb25-y-tiled-legacy [145.679259] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [145.789102] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [145.945150] Starting subtest: addfb25-y-tiled-small-legacy [145.946351] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [146.056164] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [146.183986] Starting subtest: bad-pitch-0 [146.185150] Subtest bad-pitch-0: SUCCESS (0.000s) [146.304750] [063/171] (895s left) kms_addfb_basic (bad-pitch-1024) [146.432718] Starting subtest: bad-pitch-1024 [146.433898] Subtest bad-pitch-1024: SUCCESS (0.000s) [146.554752] [064/171] (895s left) kms_addfb_basic (bad-pitch-128) [146.682251] Starting subtest: bad-pitch-128 [146.683322] Subtest bad-pitch-128: SUCCESS (0.000s) [146.804831] [065/171] (894s left) kms_addfb_basic (bad-pitch-256) [146.935078] Starting subtest: bad-pitch-256 [146.936141] Subtest bad-pitch-256: SUCCESS (0.000s) [147.054584] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [147.183084] Starting subtest: bad-pitch-32 [147.184208] Subtest bad-pitch-32: SUCCESS (0.000s) [147.304922] [067/171] (894s left) kms_addfb_basic (bad-pitch-63) [147.433123] Starting subtest: bad-pitch-63 [147.434226] Subtest bad-pitch-63: SUCCESS (0.000s) [147.554493] [068/171] (894s left) kms_addfb_basic (bad-pitch-65536) [147.682864] Starting subtest: bad-pitch-65536 [147.684064] Subtest bad-pitch-65536: SUCCESS (0.000s) [147.804673] [069/171] (893s left) kms_addfb_basic (bad-pitch-999) [147.931846] Starting subtest: bad-pitch-999 [147.933333] Subtest bad-pitch-999: SUCCESS (0.000s) [148.054890] [070/171] (893s left) kms_addfb_basic (basic) [148.183210] Starting subtest: basic [148.184271] Subtest basic: SUCCESS (0.000s) [148.306436] [071/171] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [148.434917] Starting subtest: basic-x-tiled-legacy [148.436367] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [148.554476] [072/171] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [148.684135] Starting subtest: basic-y-tiled-legacy [148.685270] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [148.806142] [073/171] (892s left) kms_addfb_basic (bo-too-small) [148.963343] Starting subtest: bo-too-small [148.964458] Subtest bo-too-small: SUCCESS (0.000s) [149.055251] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [149.212786] Starting subtest: bo-too-small-due-to-tiling [149.214108] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [149.304625] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [149.423672] Starting subtest: clobberred-modifier [149.425049] Subtest clobberred-modifier: SUCCESS (0.000s) [149.555220] [076/171] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling) [149.683477] Starting subtest: framebuffer-vs-set-tiling [149.684585] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [149.804606] [077/171] (892s left) kms_addfb_basic (invalid-get-prop) [149.933093] Starting subtest: invalid-get-prop [149.934177] Subtest invalid-get-prop: SUCCESS (0.000s) [150.073645] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any) [150.202170] Starting subtest: invalid-get-prop-any [150.203324] Subtest invalid-get-prop-any: SUCCESS (0.000s) [150.321441] [079/171] (891s left) kms_addfb_basic (invalid-set-prop) [150.449084] Starting subtest: invalid-set-prop [150.450217] Subtest invalid-set-prop: SUCCESS (0.000s) [150.571111] [080/171] (891s left) kms_addfb_basic (invalid-set-prop-any) [150.699828] Starting subtest: invalid-set-prop-any [150.700972] Subtest invalid-set-prop-any: SUCCESS (0.000s) [150.821205] [081/171] (891s left) kms_addfb_basic (no-handle) [150.950049] Starting subtest: no-handle [150.951187] Subtest no-handle: SUCCESS (0.000s) [151.071968] [082/171] (890s left) kms_addfb_basic (size-max) [151.228624] Starting subtest: size-max [151.229913] Subtest size-max: SUCCESS (0.000s) [151.320962] [083/171] (890s left) kms_addfb_basic (small-bo) [151.474525] Starting subtest: small-bo [151.475819] Subtest small-bo: SUCCESS (0.000s) [151.571614] [084/171] (890s left) kms_addfb_basic (tile-pitch-mismatch) [151.701139] Starting subtest: tile-pitch-mismatch [151.702237] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [151.840282] [085/171] (890s left) kms_addfb_basic (too-high) [151.996638] Starting subtest: too-high [151.997871] Subtest too-high: SUCCESS (0.001s) [152.087453] [086/171] (890s left) kms_addfb_basic (too-wide) [152.244418] Starting subtest: too-wide [152.245657] Subtest too-wide: SUCCESS (0.000s) [152.338120] [087/171] (889s left) kms_addfb_basic (unused-handle) [152.465892] Starting subtest: unused-handle [152.467170] Subtest unused-handle: SUCCESS (0.000s) [152.588637] [088/171] (889s left) kms_addfb_basic (unused-modifier) [152.716769] Starting subtest: unused-modifier [152.718102] Subtest unused-modifier: SUCCESS (0.000s) [152.837679] [089/171] (889s left) kms_addfb_basic (unused-offsets) [152.963984] Starting subtest: unused-offsets [152.965220] Subtest unused-offsets: SUCCESS (0.000s) [153.088466] [090/171] (889s left) kms_addfb_basic (unused-pitches) [153.217305] Starting subtest: unused-pitches [153.218383] Subtest unused-pitches: SUCCESS (0.000s) [153.338505] [091/171] (888s left) kms_busy (basic) [153.498472] Starting subtest: basic [153.500906] Starting dynamic subtest: flip [154.475875] Dynamic subtest flip: SUCCESS (0.973s) [154.491645] Starting dynamic subtest: modeset [158.360111] Dynamic subtest modeset: SUCCESS (3.885s) [158.361273] Subtest basic: SUCCESS (4.861s) [159.331871] [092/171] (882s left) kms_chamelium_hpd (dp-hpd-fast) [159.804330] Subtest dp-hpd-fast: SKIP (0.000s) [160.687293] [093/171] (881s left) kms_chamelium_edid (dp-edid-read) [161.168335] Subtest dp-edid-read: SKIP (0.000s) [162.032845] [094/171] (880s left) kms_chamelium_frames (dp-crc-fast) [162.502229] Subtest dp-crc-fast: SKIP (0.000s) [163.374052] [095/171] (878s left) kms_chamelium_hpd (hdmi-hpd-fast) [163.841100] Subtest hdmi-hpd-fast: SKIP (0.000s) [164.718897] [096/171] (877s left) kms_chamelium_edid (hdmi-edid-read) [165.183497] Subtest hdmi-edid-read: SKIP (0.000s) [166.060827] [097/171] (876s left) kms_chamelium_frames (hdmi-crc-fast) [166.526588] Subtest hdmi-crc-fast: SKIP (0.000s) [167.408546] [098/171] (875s left) kms_chamelium_hpd (vga-hpd-fast) [167.874664] Subtest vga-hpd-fast: SKIP (0.000s) [168.752247] [099/171] (873s left) kms_chamelium_edid (vga-edid-read) [169.220470] Subtest vga-edid-read: SKIP (0.000s) [170.096872] [100/171] (872s left) kms_prop_blob (basic) [170.216934] Starting subtest: basic [170.218227] Subtest basic: SUCCESS (0.000s) [170.299447] [101/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [170.446931] Starting subtest: basic-busy-flip-before-cursor-atomic [170.449059] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [170.527077] [102/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [170.681444] Starting subtest: basic-busy-flip-before-cursor-legacy [170.683640] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [170.760916] [103/171] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [170.917611] Starting subtest: basic-flip-after-cursor-atomic [172.194378] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.276s) [173.151013] [104/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [173.307652] Starting subtest: basic-flip-after-cursor-legacy [174.596082] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.289s) [175.525399] [105/171] (867s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [175.680099] Starting subtest: basic-flip-after-cursor-varying-size [176.969282] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.289s) [177.886116] [106/171] (864s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [178.042598] Starting subtest: basic-flip-before-cursor-atomic [179.334110] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.290s) [180.256449] [107/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [180.404871] Starting subtest: basic-flip-before-cursor-legacy [181.704395] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.298s) [182.622554] [108/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [182.771186] Starting subtest: basic-flip-before-cursor-varying-size [184.053416] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.282s) [184.991491] [109/171] (857s left) kms_flip (basic-flip-vs-dpms) [185.120348] Starting subtest: basic-flip-vs-dpms [185.123823] Starting dynamic subtest: A-eDP1 [187.999185] Dynamic subtest A-eDP1: SUCCESS (2.875s) [188.015181] Starting dynamic subtest: B-eDP1 [190.373715] Dynamic subtest B-eDP1: SUCCESS (2.374s) [190.389751] Starting dynamic subtest: C-eDP1 [192.729076] Dynamic subtest C-eDP1: SUCCESS (2.347s) [192.730259] Subtest basic-flip-vs-dpms: SUCCESS (7.604s) [193.631715] [110/171] (849s left) kms_flip (basic-flip-vs-modeset) [193.768570] Starting subtest: basic-flip-vs-modeset [193.771879] Starting dynamic subtest: A-eDP1 [196.632981] Dynamic subtest A-eDP1: SUCCESS (2.860s) [196.648923] Starting dynamic subtest: B-eDP1 [198.988871] Dynamic subtest B-eDP1: SUCCESS (2.355s) [199.005341] Starting dynamic subtest: C-eDP1 [201.375331] Dynamic subtest C-eDP1: SUCCESS (2.383s) [201.376413] Subtest basic-flip-vs-modeset: SUCCESS (7.607s) [202.335871] [111/171] (840s left) kms_flip (basic-flip-vs-wf_vblank) [202.469722] Starting subtest: basic-flip-vs-wf_vblank [202.473338] Starting dynamic subtest: A-eDP1 [204.801869] Dynamic subtest A-eDP1: SUCCESS (2.328s) [204.817743] Starting dynamic subtest: B-eDP1 [207.029850] Dynamic subtest B-eDP1: SUCCESS (2.223s) [207.044998] Starting dynamic subtest: C-eDP1 [209.266805] Dynamic subtest C-eDP1: SUCCESS (2.241s) [209.269222] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.800s) [210.545449] [112/171] (832s left) kms_flip (basic-plain-flip) [210.681927] Starting subtest: basic-plain-flip [210.685317] Starting dynamic subtest: A-eDP1 [212.710514] Dynamic subtest A-eDP1: SUCCESS (2.025s) [212.726397] Starting dynamic subtest: B-eDP1 [214.691509] Dynamic subtest B-eDP1: SUCCESS (1.979s) [214.708449] Starting dynamic subtest: C-eDP1 [216.662879] Dynamic subtest C-eDP1: SUCCESS (1.972s) [216.665347] Subtest basic-plain-flip: SUCCESS (5.984s) [217.950474] [113/171] (824s left) kms_force_connector_basic (force-connector-state) [218.087342] Starting subtest: force-connector-state [219.803314] Subtest force-connector-state: SUCCESS (1.715s) [220.416707] [114/171] (822s left) kms_force_connector_basic (force-edid) [220.550769] Starting subtest: force-edid [220.800411] Subtest force-edid: SUCCESS (0.251s) [220.899326] [115/171] (821s left) kms_force_connector_basic (force-load-detect) [221.032772] Starting subtest: force-load-detect [221.035236] Subtest force-load-detect: SKIP (0.000s) [221.149291] [116/171] (821s left) kms_force_connector_basic (prune-stale-modes) [221.283444] Starting subtest: prune-stale-modes [221.586921] Subtest prune-stale-modes: SUCCESS (0.304s) [221.699423] [117/171] (821s left) kms_frontbuffer_tracking (basic) [221.862267] Starting subtest: basic [225.182527] Subtest basic: SUCCESS (3.321s) [225.300711] [118/171] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [225.461199] Starting subtest: compare-crc-sanitycheck [225.464304] Starting dynamic subtest: pipe-A-eDP-1 [226.151128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s) [226.168505] Starting dynamic subtest: pipe-B-eDP-1 [227.518986] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.364s) [227.537565] Starting dynamic subtest: pipe-C-eDP-1 [229.071674] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.549s) [229.077190] Subtest compare-crc-sanitycheck: SUCCESS (3.611s) [229.994876] [119/171] (812s left) kms_pipe_crc_basic (hang-read-crc) [230.154101] Starting subtest: hang-read-crc [230.157205] Starting dynamic subtest: pipe-A-eDP-1 [232.477198] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.318s) [232.494204] Starting dynamic subtest: pipe-B-eDP-1 [235.419867] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.939s) [235.437324] Starting dynamic subtest: pipe-C-eDP-1 [238.706115] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.282s) [238.707318] Subtest hang-read-crc: SUCCESS (8.551s) [239.642553] [120/171] (803s left) kms_pipe_crc_basic (nonblocking-crc) [239.801148] Starting subtest: nonblocking-crc [239.804261] Starting dynamic subtest: pipe-A-eDP-1 [240.668980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.865s) [240.687869] Starting dynamic subtest: pipe-B-eDP-1 [242.222175] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [242.240940] Starting dynamic subtest: pipe-C-eDP-1 [243.925230] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.697s) [243.926407] Subtest nonblocking-crc: SUCCESS (4.123s) [244.890225] [121/171] (798s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [245.047574] Starting subtest: nonblocking-crc-frame-sequence [245.051231] Starting dynamic subtest: pipe-A-eDP-1 [245.919195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.868s) [245.938965] Starting dynamic subtest: pipe-B-eDP-1 [247.471261] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.547s) [247.488851] Starting dynamic subtest: pipe-C-eDP-1 [249.176427] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.700s) [249.177514] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.128s) [250.143257] [122/171] (792s left) kms_pipe_crc_basic (read-crc) [250.301013] Starting subtest: read-crc [250.304150] Starting dynamic subtest: pipe-A-eDP-1 [251.088529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s) [251.105779] Starting dynamic subtest: pipe-B-eDP-1 [252.571565] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.478s) [252.588986] Starting dynamic subtest: pipe-C-eDP-1 [254.206945] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.633s) [254.208268] Subtest read-crc: SUCCESS (3.907s) [255.130343] [123/171] (787s left) kms_pipe_crc_basic (read-crc-frame-sequence) [255.288624] Starting subtest: read-crc-frame-sequence [255.291807] Starting dynamic subtest: pipe-A-eDP-1 [256.091366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s) [256.108335] Starting dynamic subtest: pipe-B-eDP-1 [257.581906] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s) [257.598682] Starting dynamic subtest: pipe-C-eDP-1 [259.222099] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.636s) [259.223429] Subtest read-crc-frame-sequence: SUCCESS (3.932s) [260.185754] [124/171] (782s left) kms_psr (primary_page_flip) [260.348749] Starting subtest: primary_page_flip [264.568366] Subtest primary_page_flip: SUCCESS (4.204s) [265.498356] [125/171] (777s left) kms_psr (cursor_plane_move) [265.660973] Starting subtest: cursor_plane_move [269.759492] Subtest cursor_plane_move: SUCCESS (4.098s) [270.681928] [126/171] (772s left) kms_psr (sprite_plane_onoff) [270.840668] Starting subtest: sprite_plane_onoff [275.055198] Subtest sprite_plane_onoff: SUCCESS (4.205s) [275.995905] [127/171] (767s left) kms_psr (primary_mmap_gtt) [276.155751] Starting subtest: primary_mmap_gtt [280.355575] Subtest primary_mmap_gtt: SUCCESS (4.200s) [281.305398] [128/171] (761s left) kms_setmode (basic-clone-single-crtc) [281.438681] Starting subtest: basic-clone-single-crtc [281.441774] Subtest basic-clone-single-crtc: SKIP (0.000s) [281.521624] [129/171] (761s left) i915_pm_backlight (basic-brightness) [281.683314] Starting subtest: basic-brightness [281.815212] Starting dynamic subtest: eDP-1 [282.373612] Dynamic subtest eDP-1: SUCCESS (0.561s) [282.374911] Subtest basic-brightness: SUCCESS (0.686s) [283.300638] [130/171] (759s left) i915_pm_rpm (basic-pci-d3-state) [285.177070] Starting subtest: basic-pci-d3-state [289.595667] Subtest basic-pci-d3-state: SUCCESS (4.415s) [289.791762] [131/171] (753s left) i915_pm_rpm (basic-rte) [289.920248] Starting subtest: basic-rte [296.055649] Subtest basic-rte: SUCCESS (6.134s) [301.425755] [132/171] (741s left) i915_pm_rps (basic-api) [301.562980] Starting subtest: basic-api [301.567016] Subtest basic-api: SUCCESS (0.004s) [301.642742] [133/171] (741s left) prime_self_import (basic-llseek-bad) [301.768805] Starting subtest: basic-llseek-bad [301.772412] Subtest basic-llseek-bad: SUCCESS (0.002s) [301.864596] [134/171] (741s left) prime_self_import (basic-llseek-size) [301.989373] Starting subtest: basic-llseek-size [301.993159] Subtest basic-llseek-size: SUCCESS (0.004s) [302.094068] [135/171] (741s left) prime_self_import (basic-with_fd_dup) [302.220480] Starting subtest: basic-with_fd_dup [302.226366] Subtest basic-with_fd_dup: SUCCESS (0.004s) [302.327991] [136/171] (741s left) prime_self_import (basic-with_one_bo) [302.452866] Starting subtest: basic-with_one_bo [302.458514] Subtest basic-with_one_bo: SUCCESS (0.005s) [302.543967] [137/171] (740s left) prime_self_import (basic-with_one_bo_two_files) [302.670521] Starting subtest: basic-with_one_bo_two_files [302.671746] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [302.778984] [138/171] (740s left) prime_self_import (basic-with_two_bos) [302.905734] Starting subtest: basic-with_two_bos [302.911546] Subtest basic-with_two_bos: SUCCESS (0.004s) [303.012425] [139/171] (740s left) prime_vgem (basic-fence-flip) [303.173744] Starting subtest: basic-fence-flip [303.690238] Subtest basic-fence-flip: SUCCESS (0.516s) [303.808582] [140/171] (739s left) prime_vgem (basic-fence-mmap) [303.951785] Starting subtest: basic-fence-mmap [303.993096] Subtest basic-fence-mmap: SUCCESS (0.041s) [304.096327] [141/171] (739s left) prime_vgem (basic-fence-read) [304.251736] Starting subtest: basic-fence-read [304.319801] Subtest basic-fence-read: SUCCESS (0.068s) [304.413868] [142/171] (739s left) prime_vgem (basic-gtt) [304.573741] Starting subtest: basic-gtt [304.595664] Subtest basic-gtt: SUCCESS (0.022s) [304.713508] [143/171] (738s left) prime_vgem (basic-read) [304.878039] Starting subtest: basic-read [304.912038] Subtest basic-read: SUCCESS (0.034s) [305.013585] [144/171] (738s left) prime_vgem (basic-write) [305.151402] Starting subtest: basic-write [305.192200] Subtest basic-write: SUCCESS (0.041s) [305.277782] [145/171] (738s left) prime_vgem (basic-userptr) [305.416125] Starting subtest: basic-userptr [305.429506] Subtest basic-userptr: SKIP (0.014s) [305.554622] [146/171] (738s left) vgem_basic (setversion) [305.689872] Starting subtest: setversion [305.692341] Subtest setversion: SUCCESS (0.000s) [305.762065] [147/171] (737s left) vgem_basic (create) [305.906868] Starting subtest: create [305.908223] Subtest create: SUCCESS (0.000s) [305.978720] [148/171] (737s left) vgem_basic (debugfs) [306.106504] Starting subtest: debugfs [306.107688] Subtest debugfs: SUCCESS (0.001s) [306.184689] [149/171] (737s left) vgem_basic (dmabuf-export) [306.325352] Starting subtest: dmabuf-export [306.343104] Subtest dmabuf-export: SUCCESS (0.018s) [306.442032] [150/171] (737s left) vgem_basic (dmabuf-fence) [306.592183] Starting subtest: dmabuf-fence [306.593335] Subtest dmabuf-fence: SUCCESS (0.001s) [306.659440] [151/171] (737s left) vgem_basic (dmabuf-fence-before) [306.808502] Starting subtest: dmabuf-fence-before [306.809693] Subtest dmabuf-fence-before: SUCCESS (0.000s) [306.875312] [152/171] (736s left) vgem_basic (dmabuf-mmap) [307.025749] Starting subtest: dmabuf-mmap [307.049983] Subtest dmabuf-mmap: SUCCESS (0.026s) [307.125594] [153/171] (736s left) vgem_basic (mmap) [307.275384] Starting subtest: mmap [307.290747] Subtest mmap: SUCCESS (0.016s) [307.359048] [154/171] (736s left) vgem_basic (second-client) [307.508550] Starting subtest: second-client [307.558554] Subtest second-client: SUCCESS (0.049s) [307.626054] [155/171] (736s left) vgem_basic (sysfs) [307.775628] Starting subtest: sysfs [307.776916] Subtest sysfs: SUCCESS (0.001s) [307.841982] [156/171] (736s left) core_hotunplug (unbind-rebind) [308.008264] Starting subtest: unbind-rebind [310.460463] Subtest unbind-rebind: SUCCESS (2.450s) [310.492500] [157/171] (733s left) vgem_basic (unload) [310.618593] Starting subtest: unload [339.476425] Subtest unload: SUCCESS (28.823s) [339.562691] [158/171] (704s left) i915_module_load (reload) [339.691675] Starting subtest: reload [342.881971] Subtest reload: SUCCESS (3.190s) [342.909999] [159/171] (701s left) gem_lmem_swapping (basic) [343.061085] Subtest basic: SKIP (0.000s) [343.099361] [160/171] (700s left) gem_lmem_swapping (parallel-random-engines) [343.233321] Subtest parallel-random-engines: SKIP (0.000s) [343.283260] [161/171] (700s left) gem_lmem_swapping (random-engines) [343.418868] Subtest random-engines: SKIP (0.000s) [343.466297] [162/171] (700s left) gem_lmem_swapping (verify-random) [343.601092] Subtest verify-random: SKIP (0.000s) [343.649799] [163/171] (700s left) i915_pm_rpm (module-reload) [356.153514] Starting subtest: module-reload [390.401174] Subtest module-reload: SUCCESS (34.240s) [390.420459] [164/171] (653s left) i915_selftest (live) [390.554354] Starting subtest: live [390.555826] Starting dynamic subtest: sanitycheck [392.325722] Dynamic subtest sanitycheck: SUCCESS (1.762s) [392.340125] Starting dynamic subtest: uncore [394.133620] Dynamic subtest uncore: SUCCESS (1.807s) [394.148097] Starting dynamic subtest: workarounds [396.148545] Dynamic subtest workarounds: SUCCESS (2.014s) [396.162958] Starting dynamic subtest: gt_engines [398.428523] Dynamic subtest gt_engines: SUCCESS (2.279s) [398.443047] Starting dynamic subtest: gt_timelines [410.419802] Dynamic subtest gt_timelines: SUCCESS (11.990s) [410.433920] Starting dynamic subtest: gt_contexts [412.324734] Dynamic subtest gt_contexts: SUCCESS (1.904s) [412.339164] Starting dynamic subtest: gt_lrc [416.611593] Dynamic subtest gt_lrc: SUCCESS (4.286s) [416.626080] Starting dynamic subtest: gt_mocs [418.455657] Dynamic subtest gt_mocs: SUCCESS (1.843s) [418.470285] Starting dynamic subtest: gt_pm [423.501659] Dynamic subtest gt_pm: SUCCESS (5.045s) [423.516339] Starting dynamic subtest: gt_heartbeat [425.380625] Dynamic subtest gt_heartbeat: SUCCESS (1.878s) [425.395109] Starting dynamic subtest: requests [432.952032] Dynamic subtest requests: SUCCESS (7.570s) [432.966488] Starting dynamic subtest: migrate [437.466652] Dynamic subtest migrate: SUCCESS (4.514s) [437.481187] Starting dynamic subtest: active [439.256611] Dynamic subtest active: SUCCESS (1.789s) [439.271232] Starting dynamic subtest: objects [442.645490] Dynamic subtest objects: SUCCESS (3.388s) [442.660065] Starting dynamic subtest: mman [449.513533] Dynamic subtest mman: SUCCESS (6.867s) [449.530514] Starting dynamic subtest: dmabuf [451.360717] Dynamic subtest dmabuf: SUCCESS (1.846s) [451.375562] Starting dynamic subtest: vma [453.134517] Dynamic subtest vma: SUCCESS (1.773s) [453.149302] Starting dynamic subtest: coherency [457.570801] Dynamic subtest coherency: SUCCESS (4.435s) [457.585770] Starting dynamic subtest: gtt [468.800858] Dynamic subtest gtt: SUCCESS (11.229s) [468.817129] Starting dynamic subtest: gem [470.689891] Dynamic subtest gem: SUCCESS (1.888s) [470.704806] Starting dynamic subtest: evict [474.399714] Dynamic subtest evict: SUCCESS (3.709s) [474.414573] Starting dynamic subtest: hugepages [481.214846] Dynamic subtest hugepages: SUCCESS (6.814s) [481.230022] Starting dynamic subtest: gem_contexts [496.127762] Dynamic subtest gem_contexts: SUCCESS (14.912s) [496.142874] Starting dynamic subtest: client [497.954697] Dynamic subtest client: SUCCESS (1.826s) [497.969898] Starting dynamic subtest: gem_migrate [499.725525] Dynamic subtest gem_migrate: SUCCESS (1.770s) [499.740829] Starting dynamic subtest: reset [505.085789] Dynamic subtest reset: SUCCESS (5.359s) [505.101141] Starting dynamic subtest: memory_region [506.842635] Dynamic subtest memory_region: SUCCESS (1.756s) [506.857967] Starting dynamic subtest: hangcheck [531.151779] Dynamic subtest hangcheck: SUCCESS (24.308s) [531.167072] Starting dynamic subtest: execlists [541.107734] Dynamic subtest execlists: SUCCESS (9.955s) [541.122889] Starting dynamic subtest: ring_submission [542.937649] Dynamic subtest ring_submission: SUCCESS (1.829s) [542.952877] Starting dynamic subtest: perf [544.799920] Dynamic subtest perf: SUCCESS (1.861s) [544.815142] Starting dynamic subtest: slpc [546.583573] Dynamic subtest slpc: SUCCESS (1.783s) [546.598697] Starting dynamic subtest: guc [548.382547] Dynamic subtest guc: SUCCESS (1.798s) [548.397748] Starting dynamic subtest: guc_multi_lrc [550.157736] Dynamic subtest guc_multi_lrc: SUCCESS (1.774s) [550.173997] Starting dynamic subtest: guc_hang [551.956689] Dynamic subtest guc_hang: SUCCESS (1.798s) [551.971971] Starting dynamic subtest: late_gt_pm [553.755656] Dynamic subtest late_gt_pm: SUCCESS (1.798s) [553.757035] Subtest live: SUCCESS (163.193s) [553.836289] [165/171] (490s left) dmabuf (all-tests) [553.966698] Starting subtest: all-tests [553.968792] Starting dynamic subtest: sanitycheck [553.999215] Dynamic subtest sanitycheck: SUCCESS (0.031s) [554.014640] Starting dynamic subtest: dma_fence [554.138942] Dynamic subtest dma_fence: SUCCESS (0.139s) [554.150737] Starting dynamic subtest: dma_fence_chain [571.943821] Dynamic subtest dma_fence_chain: SUCCESS (17.795s) [571.955487] Starting dynamic subtest: dma_fence_unwrap [571.973653] Dynamic subtest dma_fence_unwrap: SUCCESS (0.037s) [571.988068] Starting dynamic subtest: dma_resv [571.998411] Dynamic subtest dma_resv: SUCCESS (0.024s) [571.999528] Subtest all-tests: SUCCESS (18.032s) [572.023463] [166/171] (472s left) i915_suspend (basic-s2idle-without-i915) [572.151035] Starting subtest: basic-s2idle-without-i915 [595.512276] Subtest basic-s2idle-without-i915: SUCCESS (8.167s) [595.766602] [167/171] (463s left) i915_suspend (basic-s3-without-i915) [595.900201] Starting subtest: basic-s3-without-i915 [619.502850] Subtest basic-s3-without-i915: SUCCESS (6.891s) [619.817949] [168/171] (456s left) gem_exec_suspend (basic-s0) [619.962641] Starting subtest: basic-S0 [619.964020] Starting dynamic subtest: smem [639.591600] Dynamic subtest smem: SUCCESS (3.653s) [639.592685] Subtest basic-S0: SUCCESS (3.654s) [639.743906] [169/171] (452s left) gem_exec_suspend (basic-s3) [639.880320] Starting subtest: basic-S3 [639.881461] Starting dynamic subtest: smem [658.639115] Dynamic subtest smem: SUCCESS (3.585s) [658.640292] Subtest basic-S3: SUCCESS (3.586s) [658.794918] [170/171] (448s left) kms_chamelium_hpd (common-hpd-after-suspend) [659.267004] Subtest common-hpd-after-suspend: SKIP (0.000s) [660.159855] [171/171] (447s left) kms_pipe_crc_basic (suspend-read-crc) [660.310874] Starting subtest: suspend-read-crc [660.314362] Starting dynamic subtest: pipe-A-eDP-1 [678.493194] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.387s) [678.515474] Starting dynamic subtest: pipe-B-eDP-1 [696.505548] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.119s) [696.526486] Starting dynamic subtest: pipe-C-eDP-1 [715.471381] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.227s) [715.472472] Subtest suspend-read-crc: SUCCESS (8.748s) [716.364055] Closing watchdogs Done.