[61.747389] Initializing watchdogs [61.747458] /dev/watchdog0 [61.752355] [001/171] (960s left) i915_module_load (load) [61.804668] Starting subtest: load [63.680257] Subtest load: SUCCESS (1.875s) [63.693090] [002/171] (958s left) core_auth (basic-auth) [63.777468] Starting subtest: basic-auth [63.778908] Subtest basic-auth: SUCCESS (0.002s) [63.855026] [003/171] (958s left) debugfs_test (read_all_entries) [63.940042] Starting subtest: read_all_entries [64.126302] Subtest read_all_entries: SUCCESS (0.192s) [64.208166] [004/171] (958s left) debugfs_test (basic-hwmon) [64.259779] Starting subtest: basic-hwmon [64.261175] Subtest basic-hwmon: SKIP (0.000s) [64.348017] [005/171] (957s left) fbdev (eof) [64.406929] Starting subtest: eof [64.407805] Subtest eof: SUCCESS (0.000s) [64.462766] [006/171] (957s left) fbdev (info) [64.517447] Starting subtest: info [64.518272] Subtest info: SUCCESS (0.000s) [64.580306] [007/171] (957s left) fbdev (nullptr) [64.640161] Starting subtest: nullptr [64.641212] Subtest nullptr: SUCCESS (0.000s) [64.692104] [008/171] (957s left) fbdev (read) [64.756975] Starting subtest: read [71.780462] Subtest read: SUCCESS (7.014s) [71.839830] [009/171] (950s left) fbdev (write) [71.921339] Starting subtest: write [75.640263] Subtest write: SUCCESS (3.685s) [75.674384] [010/171] (946s left) gem_basic (bad-close) [75.735432] Starting subtest: bad-close [75.737527] Subtest bad-close: SUCCESS (0.000s) [75.808451] [011/171] (946s left) gem_basic (create-close) [75.869825] Starting subtest: create-close [75.871324] Subtest create-close: SUCCESS (0.000s) [75.957636] [012/171] (946s left) gem_basic (create-fd-close) [76.019539] Starting subtest: create-fd-close [76.021112] Subtest create-fd-close: SUCCESS (0.000s) [76.091722] [013/171] (946s left) gem_busy (busy@all-engines) [76.166159] Starting subtest: busy [76.167179] Starting dynamic subtest: all-engines [76.199932] Dynamic subtest all-engines: SUCCESS (0.034s) [76.200728] Subtest busy: SUCCESS (0.034s) [76.535234] [014/171] (945s left) gem_close_race (basic-process) [76.601670] Starting subtest: basic-process [76.620624] Subtest basic-process: SUCCESS (0.019s) [76.807829] [015/171] (945s left) gem_close_race (basic-threads) [76.876065] Starting subtest: basic-threads [78.000680] Subtest basic-threads: SUCCESS (1.124s) [78.195873] [016/171] (944s left) gem_ctx_create (basic) [78.298883] Starting subtest: basic [78.300039] Subtest basic: SUCCESS (0.000s) [78.490499] [017/171] (943s left) gem_ctx_create (basic-files) [78.578483] Starting subtest: basic-files [80.593853] Subtest basic-files: SUCCESS (2.015s) [80.938910] [018/171] (941s left) gem_ctx_exec (basic) [81.025468] Starting subtest: basic [81.029288] Subtest basic: SUCCESS (0.004s) [81.151659] [019/171] (941s left) gem_exec_basic (basic) [81.237422] Starting subtest: basic [81.238398] Starting dynamic subtest: rcs0-smem [81.239400] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [81.246361] Starting dynamic subtest: bcs0-smem [81.247278] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [81.254023] Starting dynamic subtest: vcs0-smem [81.254882] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [81.261334] Starting dynamic subtest: vecs0-smem [81.262243] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [81.263139] Subtest basic: SUCCESS (0.004s) [81.432395] [020/171] (941s left) gem_exec_create (basic) [81.517174] Starting subtest: basic [81.518171] Starting dynamic subtest: smem [83.610410] Dynamic subtest smem: SUCCESS (2.093s) [83.611885] Subtest basic: SUCCESS (2.094s) [83.797699] [021/171] (938s left) gem_exec_fence (basic-busy) [83.996840] Starting subtest: basic-busy [83.997849] Starting dynamic subtest: rcs0 [84.053932] Dynamic subtest rcs0: SUCCESS (0.061s) [84.065446] Starting dynamic subtest: bcs0 [84.099772] Dynamic subtest bcs0: SUCCESS (0.046s) [84.111196] Starting dynamic subtest: vcs0 [84.148851] Dynamic subtest vcs0: SUCCESS (0.048s) [84.159752] Starting dynamic subtest: vecs0 [84.199475] Dynamic subtest vecs0: SUCCESS (0.050s) [84.201220] Subtest basic-busy: SUCCESS (0.207s) [84.737775] [022/171] (937s left) gem_exec_fence (basic-wait) [84.929944] Starting subtest: basic-wait [84.931425] Starting dynamic subtest: rcs0 [84.967130] Dynamic subtest rcs0: SUCCESS (0.050s) [84.977795] Starting dynamic subtest: bcs0 [85.013812] Dynamic subtest bcs0: SUCCESS (0.046s) [85.025555] Starting dynamic subtest: vcs0 [85.063997] Dynamic subtest vcs0: SUCCESS (0.050s) [85.074896] Starting dynamic subtest: vecs0 [85.114819] Dynamic subtest vecs0: SUCCESS (0.050s) [85.116466] Subtest basic-wait: SUCCESS (0.198s) [85.603572] [023/171] (936s left) gem_exec_fence (basic-await) [85.798203] Starting subtest: basic-await [85.808680] Starting dynamic subtest: rcs0 [85.858270] Dynamic subtest rcs0: SUCCESS (0.076s) [85.871443] Starting dynamic subtest: bcs0 [85.943096] Dynamic subtest bcs0: SUCCESS (0.085s) [85.961185] Starting dynamic subtest: vcs0 [86.030541] Dynamic subtest vcs0: SUCCESS (0.087s) [86.046825] Starting dynamic subtest: vecs0 [86.118757] Dynamic subtest vecs0: SUCCESS (0.088s) [86.120487] Subtest basic-await: SUCCESS (0.337s) [86.598518] [024/171] (935s left) gem_exec_fence (nb-await) [86.780497] Starting subtest: nb-await [86.781387] Starting dynamic subtest: rcs0 [86.837218] Dynamic subtest rcs0: SUCCESS (0.064s) [86.850206] Starting dynamic subtest: bcs0 [86.899962] Dynamic subtest bcs0: SUCCESS (0.062s) [86.915050] Starting dynamic subtest: vcs0 [86.966063] Dynamic subtest vcs0: SUCCESS (0.066s) [86.983232] Starting dynamic subtest: vecs0 [87.035615] Dynamic subtest vecs0: SUCCESS (0.069s) [87.037424] Subtest nb-await: SUCCESS (0.263s) [87.545371] [025/171] (935s left) gem_exec_gttfill (basic) [87.607653] Starting subtest: basic [91.715224] Subtest basic: SUCCESS (4.099s) [91.897390] [026/171] (930s left) gem_exec_parallel (engines) [92.041845] Starting subtest: engines [92.042950] Starting dynamic subtest: basic [97.069558] Dynamic subtest basic: SUCCESS (5.027s) [97.081447] Starting dynamic subtest: contexts [101.786292] Dynamic subtest contexts: SUCCESS (4.708s) [101.797422] Starting dynamic subtest: fds [106.491305] Dynamic subtest fds: SUCCESS (4.705s) [106.501054] Starting dynamic subtest: userptr [109.803414] Dynamic subtest userptr: SUCCESS (3.319s) [109.804789] Subtest engines: SUCCESS (17.760s) [109.992629] [027/171] (912s left) gem_exec_store (basic) [110.070183] Starting subtest: basic [110.162816] Subtest basic: SUCCESS (0.092s) [110.351931] [028/171] (912s left) gem_flink_basic (bad-flink) [110.415151] Starting subtest: bad-flink [110.415973] Subtest bad-flink: SUCCESS (0.000s) [110.483102] [029/171] (912s left) gem_flink_basic (bad-open) [110.548722] Starting subtest: bad-open [110.549604] Subtest bad-open: SUCCESS (0.000s) [110.617154] [030/171] (912s left) gem_flink_basic (basic) [110.684295] Starting subtest: basic [110.685106] Subtest basic: SUCCESS (0.000s) [110.767448] [031/171] (911s left) gem_flink_basic (double-flink) [110.835358] Starting subtest: double-flink [110.836186] Subtest double-flink: SUCCESS (0.000s) [110.920792] [032/171] (911s left) gem_flink_basic (flink-lifetime) [110.988305] Starting subtest: flink-lifetime [110.989139] Subtest flink-lifetime: SUCCESS (0.001s) [111.086795] [033/171] (911s left) gem_huc_copy (huc-copy) [111.157395] Starting subtest: huc-copy [111.160324] Subtest huc-copy: SUCCESS (0.003s) [111.264016] [034/171] (911s left) gem_linear_blits (basic) [111.427173] Starting subtest: basic [111.434676] Subtest basic: SUCCESS (0.008s) [111.561345] [035/171] (911s left) gem_mmap (basic) [111.673079] Starting subtest: basic [111.677063] Subtest basic: SUCCESS (0.000s) [111.772720] [036/171] (910s left) gem_mmap_gtt (basic) [111.840207] Starting subtest: basic [111.841157] Subtest basic: SUCCESS (0.001s) [111.914094] [037/171] (910s left) gem_render_linear_blits (basic) [111.986809] Starting subtest: basic [112.025186] Subtest basic: SUCCESS (0.038s) [112.093693] [038/171] (910s left) gem_render_tiled_blits (basic) [112.172219] Starting subtest: basic [112.205635] Subtest basic: SUCCESS (0.038s) [112.297091] [039/171] (910s left) gem_ringfill (basic-all) [112.614504] Starting subtest: basic-all [113.767991] Subtest basic-all: SUCCESS (1.147s) [113.871198] [040/171] (908s left) gem_softpin (allocator-basic) [113.954984] Starting subtest: allocator-basic [114.063339] Subtest allocator-basic: SUCCESS (0.106s) [114.179466] [041/171] (908s left) gem_softpin (allocator-basic-reserve) [114.259694] Starting subtest: allocator-basic-reserve [114.361426] Subtest allocator-basic-reserve: SUCCESS (0.101s) [114.472553] [042/171] (908s left) gem_softpin (safe-alignment) [114.555054] Starting subtest: safe-alignment [114.568422] Subtest safe-alignment: SUCCESS (0.013s) [114.686724] [043/171] (908s left) gem_sync (basic-all) [114.770159] Starting subtest: basic-all [116.955551] Subtest basic-all: SUCCESS (2.185s) [117.144158] [044/171] (905s left) gem_sync (basic-each) [117.212603] Starting subtest: basic-each [119.991895] Subtest basic-each: SUCCESS (2.778s) [120.179799] [045/171] (902s left) gem_tiled_blits (basic) [120.322710] Starting subtest: basic [120.341522] Subtest basic: SUCCESS (0.019s) [120.463499] [046/171] (902s left) gem_tiled_fence_blits (basic) [120.672833] Starting subtest: basic [120.694080] Subtest basic: SUCCESS (0.021s) [120.810272] [047/171] (902s left) gem_tiled_pread_basic [120.954411] [048/171] (901s left) gem_wait (busy@all-engines) [121.034183] Starting subtest: busy [121.035099] Starting dynamic subtest: all-engines [121.577968] Dynamic subtest all-engines: SUCCESS (0.543s) [121.579487] Subtest busy: SUCCESS (0.543s) [121.787095] [049/171] (901s left) gem_wait (wait@all-engines) [121.863420] Starting subtest: wait [121.864471] Starting dynamic subtest: all-engines [122.916432] Dynamic subtest all-engines: SUCCESS (1.052s) [122.917985] Subtest wait: SUCCESS (1.052s) [123.123636] [050/171] (899s left) i915_getparams_basic (basic-eu-total) [123.180017] Starting subtest: basic-eu-total [123.181829] Subtest basic-eu-total: SUCCESS (0.000s) [123.238188] [051/171] (899s left) i915_getparams_basic (basic-subslice-total) [123.292996] Starting subtest: basic-subslice-total [123.294595] Subtest basic-subslice-total: SUCCESS (0.000s) [123.354393] [052/171] (899s left) i915_hangman (error-state-basic) [123.411669] Starting subtest: error-state-basic [123.530889] Subtest error-state-basic: SUCCESS (0.118s) [123.614866] [053/171] (899s left) i915_pciid [123.747425] [054/171] (899s left) kms_addfb_basic (addfb25-bad-modifier) [123.807275] Starting subtest: addfb25-bad-modifier [123.808115] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [123.934932] [055/171] (899s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [123.999090] Starting subtest: addfb25-framebuffer-vs-set-tiling [123.999901] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [124.112899] [056/171] (898s left) kms_addfb_basic (addfb25-modifier-no-flag) [124.178380] Starting subtest: addfb25-modifier-no-flag [124.179257] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [124.299177] [057/171] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy) [124.366467] Starting subtest: addfb25-x-tiled-legacy [124.367291] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [124.478676] [058/171] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [124.548414] Starting subtest: addfb25-x-tiled-mismatch-legacy [124.549424] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [124.670258] [059/171] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [124.757485] Starting subtest: addfb25-yf-tiled-legacy [124.758375] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [124.863608] [060/171] (898s left) kms_addfb_basic (addfb25-y-tiled-legacy) [124.946417] Starting subtest: addfb25-y-tiled-legacy [124.947277] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [125.044737] [061/171] (898s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [125.130150] Starting subtest: addfb25-y-tiled-small-legacy [125.131103] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [125.227969] [062/171] (897s left) kms_addfb_basic (bad-pitch-0) [125.297319] Starting subtest: bad-pitch-0 [125.298192] Subtest bad-pitch-0: SUCCESS (0.000s) [125.421488] [063/171] (897s left) kms_addfb_basic (bad-pitch-1024) [125.490835] Starting subtest: bad-pitch-1024 [125.491656] Subtest bad-pitch-1024: SUCCESS (0.000s) [125.616618] [064/171] (897s left) kms_addfb_basic (bad-pitch-128) [125.687331] Starting subtest: bad-pitch-128 [125.688156] Subtest bad-pitch-128: SUCCESS (0.000s) [125.803968] [065/171] (897s left) kms_addfb_basic (bad-pitch-256) [125.874219] Starting subtest: bad-pitch-256 [125.875037] Subtest bad-pitch-256: SUCCESS (0.000s) [125.992789] [066/171] (897s left) kms_addfb_basic (bad-pitch-32) [126.063446] Starting subtest: bad-pitch-32 [126.064299] Subtest bad-pitch-32: SUCCESS (0.000s) [126.183330] [067/171] (897s left) kms_addfb_basic (bad-pitch-63) [126.255294] Starting subtest: bad-pitch-63 [126.256133] Subtest bad-pitch-63: SUCCESS (0.000s) [126.365861] [068/171] (896s left) kms_addfb_basic (bad-pitch-65536) [126.437474] Starting subtest: bad-pitch-65536 [126.438336] Subtest bad-pitch-65536: SUCCESS (0.000s) [126.553313] [069/171] (896s left) kms_addfb_basic (bad-pitch-999) [126.624316] Starting subtest: bad-pitch-999 [126.625190] Subtest bad-pitch-999: SUCCESS (0.000s) [126.741811] [070/171] (896s left) kms_addfb_basic (basic) [126.814148] Starting subtest: basic [126.814969] Subtest basic: SUCCESS (0.000s) [126.939457] [071/171] (896s left) kms_addfb_basic (basic-x-tiled-legacy) [127.011025] Starting subtest: basic-x-tiled-legacy [127.011846] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [127.126223] [072/171] (896s left) kms_addfb_basic (basic-y-tiled-legacy) [127.197148] Starting subtest: basic-y-tiled-legacy [127.198190] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [127.314769] [073/171] (896s left) kms_addfb_basic (bo-too-small) [127.405823] Starting subtest: bo-too-small [127.406915] Subtest bo-too-small: SUCCESS (0.000s) [127.500843] [074/171] (895s left) kms_addfb_basic (bo-too-small-due-to-tiling) [127.589188] Starting subtest: bo-too-small-due-to-tiling [127.590176] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [127.687646] [075/171] (895s left) kms_addfb_basic (clobberred-modifier) [127.759359] Starting subtest: clobberred-modifier [127.760240] Subtest clobberred-modifier: SUCCESS (0.000s) [127.879522] [076/171] (895s left) kms_addfb_basic (framebuffer-vs-set-tiling) [127.950559] Starting subtest: framebuffer-vs-set-tiling [127.951437] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [128.069540] [077/171] (895s left) kms_addfb_basic (invalid-get-prop) [128.140196] Starting subtest: invalid-get-prop [128.141136] Subtest invalid-get-prop: SUCCESS (0.000s) [128.255515] [078/171] (895s left) kms_addfb_basic (invalid-get-prop-any) [128.327844] Starting subtest: invalid-get-prop-any [128.328675] Subtest invalid-get-prop-any: SUCCESS (0.000s) [128.442538] [079/171] (895s left) kms_addfb_basic (invalid-set-prop) [128.513816] Starting subtest: invalid-set-prop [128.514691] Subtest invalid-set-prop: SUCCESS (0.000s) [128.630579] [080/171] (894s left) kms_addfb_basic (invalid-set-prop-any) [128.702110] Starting subtest: invalid-set-prop-any [128.702974] Subtest invalid-set-prop-any: SUCCESS (0.000s) [128.825150] [081/171] (894s left) kms_addfb_basic (no-handle) [128.900693] Starting subtest: no-handle [128.901836] Subtest no-handle: SUCCESS (0.000s) [129.013914] [082/171] (894s left) kms_addfb_basic (size-max) [129.104204] Starting subtest: size-max [129.105159] Subtest size-max: SUCCESS (0.000s) [129.203357] [083/171] (894s left) kms_addfb_basic (small-bo) [129.292190] Starting subtest: small-bo [129.293062] Subtest small-bo: SUCCESS (0.000s) [129.394867] [084/171] (894s left) kms_addfb_basic (tile-pitch-mismatch) [129.464444] Starting subtest: tile-pitch-mismatch [129.465405] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [129.580896] [085/171] (893s left) kms_addfb_basic (too-high) [129.667962] Starting subtest: too-high [129.668853] Subtest too-high: SUCCESS (0.001s) [129.765553] [086/171] (893s left) kms_addfb_basic (too-wide) [129.856600] Starting subtest: too-wide [129.857504] Subtest too-wide: SUCCESS (0.000s) [129.957350] [087/171] (893s left) kms_addfb_basic (unused-handle) [130.028929] Starting subtest: unused-handle [130.029887] Subtest unused-handle: SUCCESS (0.000s) [130.145665] [088/171] (893s left) kms_addfb_basic (unused-modifier) [130.214414] Starting subtest: unused-modifier [130.215297] Subtest unused-modifier: SUCCESS (0.000s) [130.330481] [089/171] (893s left) kms_addfb_basic (unused-offsets) [130.400149] Starting subtest: unused-offsets [130.401097] Subtest unused-offsets: SUCCESS (0.000s) [130.533781] [090/171] (893s left) kms_addfb_basic (unused-pitches) [130.603337] Starting subtest: unused-pitches [130.604218] Subtest unused-pitches: SUCCESS (0.000s) [130.718973] [091/171] (892s left) kms_busy (basic) [130.813759] Starting subtest: basic [130.815585] Starting dynamic subtest: flip [131.689892] Dynamic subtest flip: SUCCESS (0.874s) [131.706670] Starting dynamic subtest: modeset [135.530558] Dynamic subtest modeset: SUCCESS (3.838s) [135.531893] Subtest basic: SUCCESS (4.713s) [136.482377] [092/171] (887s left) kms_chamelium_hpd (dp-hpd-fast) [136.875361] Subtest dp-hpd-fast: SKIP (0.000s) [137.785290] [093/171] (885s left) kms_chamelium_edid (dp-edid-read) [138.177150] Subtest dp-edid-read: SKIP (0.000s) [139.066643] [094/171] (884s left) kms_chamelium_frames (dp-crc-fast) [139.455363] Subtest dp-crc-fast: SKIP (0.000s) [140.344302] [095/171] (883s left) kms_chamelium_hpd (hdmi-hpd-fast) [140.736529] Subtest hdmi-hpd-fast: SKIP (0.000s) [141.625466] [096/171] (882s left) kms_chamelium_edid (hdmi-edid-read) [142.016198] Subtest hdmi-edid-read: SKIP (0.000s) [142.907482] [097/171] (880s left) kms_chamelium_frames (hdmi-crc-fast) [143.298429] Subtest hdmi-crc-fast: SKIP (0.000s) [144.186093] [098/171] (879s left) kms_chamelium_hpd (vga-hpd-fast) [144.570412] Subtest vga-hpd-fast: SKIP (0.000s) [145.466342] [099/171] (878s left) kms_chamelium_edid (vga-edid-read) [145.858531] Subtest vga-edid-read: SKIP (0.000s) [146.746562] [100/171] (877s left) kms_prop_blob (basic) [146.796365] Starting subtest: basic [146.797217] Subtest basic: SUCCESS (0.000s) [146.868696] [101/171] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [146.980076] Starting subtest: basic-busy-flip-before-cursor-atomic [146.981627] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [147.080405] [102/171] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [147.183101] Starting subtest: basic-busy-flip-before-cursor-legacy [147.184657] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [147.298538] [103/171] (876s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [147.401811] Starting subtest: basic-flip-after-cursor-atomic [148.621488] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.220s) [149.536688] [104/171] (874s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [149.647945] Starting subtest: basic-flip-after-cursor-legacy [150.863273] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.215s) [151.798677] [105/171] (872s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [151.907073] Starting subtest: basic-flip-after-cursor-varying-size [153.130331] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.222s) [154.081774] [106/171] (869s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [154.191332] Starting subtest: basic-flip-before-cursor-atomic [155.410856] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.219s) [156.339782] [107/171] (867s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [156.448112] Starting subtest: basic-flip-before-cursor-legacy [157.667868] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.220s) [158.626886] [108/171] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [158.736299] Starting subtest: basic-flip-before-cursor-varying-size [159.952122] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.216s) [160.883931] [109/171] (863s left) kms_flip (basic-flip-vs-dpms) [160.946481] Starting subtest: basic-flip-vs-dpms [160.948194] Starting dynamic subtest: A-eDP1 [163.750372] Dynamic subtest A-eDP1: SUCCESS (2.801s) [163.762623] Starting dynamic subtest: B-eDP1 [166.192133] Dynamic subtest B-eDP1: SUCCESS (2.441s) [166.210132] Starting dynamic subtest: C-eDP1 [168.570425] Dynamic subtest C-eDP1: SUCCESS (2.378s) [168.572432] Subtest basic-flip-vs-dpms: SUCCESS (7.626s) [169.504802] [110/171] (854s left) kms_flip (basic-flip-vs-modeset) [169.570866] Starting subtest: basic-flip-vs-modeset [169.572664] Starting dynamic subtest: A-eDP1 [172.386842] Dynamic subtest A-eDP1: SUCCESS (2.813s) [172.400610] Starting dynamic subtest: B-eDP1 [174.818854] Dynamic subtest B-eDP1: SUCCESS (2.432s) [174.828993] Starting dynamic subtest: C-eDP1 [177.258116] Dynamic subtest C-eDP1: SUCCESS (2.437s) [177.259237] Subtest basic-flip-vs-modeset: SUCCESS (7.688s) [178.212358] [111/171] (845s left) kms_flip (basic-flip-vs-wf_vblank) [178.279146] Starting subtest: basic-flip-vs-wf_vblank [178.279918] Starting dynamic subtest: A-eDP1 [180.561434] Dynamic subtest A-eDP1: SUCCESS (2.280s) [180.570818] Starting dynamic subtest: B-eDP1 [182.800530] Dynamic subtest B-eDP1: SUCCESS (2.238s) [182.809798] Starting dynamic subtest: C-eDP1 [185.020150] Dynamic subtest C-eDP1: SUCCESS (2.219s) [185.021294] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.743s) [186.340891] [112/171] (837s left) kms_flip (basic-plain-flip) [186.407942] Starting subtest: basic-plain-flip [186.409872] Starting dynamic subtest: A-eDP1 [188.403446] Dynamic subtest A-eDP1: SUCCESS (1.993s) [188.412526] Starting dynamic subtest: B-eDP1 [190.388323] Dynamic subtest B-eDP1: SUCCESS (1.984s) [190.397610] Starting dynamic subtest: C-eDP1 [192.351837] Dynamic subtest C-eDP1: SUCCESS (1.963s) [192.352967] Subtest basic-plain-flip: SUCCESS (5.945s) [193.633766] [113/171] (830s left) kms_force_connector_basic (force-connector-state) [193.689659] Starting subtest: force-connector-state [194.454147] Subtest force-connector-state: SUCCESS (0.764s) [195.297255] [114/171] (828s left) kms_force_connector_basic (force-edid) [195.348993] Starting subtest: force-edid [195.374286] Subtest force-edid: SUCCESS (0.024s) [195.467943] [115/171] (828s left) kms_force_connector_basic (force-load-detect) [195.520017] Starting subtest: force-load-detect [195.521550] Subtest force-load-detect: SKIP (0.000s) [195.601831] [116/171] (828s left) kms_force_connector_basic (prune-stale-modes) [195.652851] Starting subtest: prune-stale-modes [195.674841] Subtest prune-stale-modes: SUCCESS (0.023s) [195.751721] [117/171] (828s left) kms_frontbuffer_tracking (basic) [195.820840] Starting subtest: basic [200.132306] Subtest basic: SUCCESS (4.312s) [200.245061] [118/171] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [200.315803] Starting subtest: compare-crc-sanitycheck [200.316599] Starting dynamic subtest: pipe-A-eDP-1 [200.987346] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.670s) [201.005652] Starting dynamic subtest: pipe-B-eDP-1 [202.415606] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.425s) [202.432976] Starting dynamic subtest: pipe-C-eDP-1 [203.774482] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s) [203.775354] Subtest compare-crc-sanitycheck: SUCCESS (3.459s) [204.707814] [119/171] (819s left) kms_pipe_crc_basic (hang-read-crc) [204.801814] Starting subtest: hang-read-crc [204.802700] Starting dynamic subtest: pipe-A-eDP-1 [207.111465] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.309s) [207.118935] Starting dynamic subtest: pipe-B-eDP-1 [210.163995] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.050s) [210.180474] Starting dynamic subtest: pipe-C-eDP-1 [213.138984] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.974s) [213.140021] Subtest hang-read-crc: SUCCESS (8.338s) [214.045738] [120/171] (810s left) kms_pipe_crc_basic (nonblocking-crc) [214.144684] Starting subtest: nonblocking-crc [214.145653] Starting dynamic subtest: pipe-A-eDP-1 [214.985409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.840s) [214.996995] Starting dynamic subtest: pipe-B-eDP-1 [216.551890] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s) [216.562167] Starting dynamic subtest: pipe-C-eDP-1 [218.099304] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s) [218.100249] Subtest nonblocking-crc: SUCCESS (3.955s) [219.041545] [121/171] (805s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [219.136053] Starting subtest: nonblocking-crc-frame-sequence [219.137115] Starting dynamic subtest: pipe-A-eDP-1 [220.000385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.863s) [220.016335] Starting dynamic subtest: pipe-B-eDP-1 [221.602390] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.599s) [221.617781] Starting dynamic subtest: pipe-C-eDP-1 [223.148368] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.544s) [223.149286] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.013s) [224.099351] [122/171] (800s left) kms_pipe_crc_basic (read-crc) [224.177694] Starting subtest: read-crc [224.178506] Starting dynamic subtest: pipe-A-eDP-1 [224.973602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s) [224.992507] Starting dynamic subtest: pipe-B-eDP-1 [226.476675] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.500s) [226.494080] Starting dynamic subtest: pipe-C-eDP-1 [227.958810] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.479s) [227.959706] Subtest read-crc: SUCCESS (3.781s) [228.897782] [123/171] (795s left) kms_pipe_crc_basic (read-crc-frame-sequence) [228.980006] Starting subtest: read-crc-frame-sequence [228.980871] Starting dynamic subtest: pipe-A-eDP-1 [229.760097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.779s) [229.777867] Starting dynamic subtest: pipe-B-eDP-1 [231.272137] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.509s) [231.280046] Starting dynamic subtest: pipe-C-eDP-1 [232.753905] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.480s) [232.754922] Subtest read-crc-frame-sequence: SUCCESS (3.774s) [233.697453] [124/171] (790s left) kms_psr (primary_page_flip) [233.783065] Starting subtest: primary_page_flip [235.750912] Subtest primary_page_flip: SUCCESS (1.967s) [236.706780] [125/171] (787s left) kms_psr (cursor_plane_move) [236.790288] Starting subtest: cursor_plane_move [238.716503] Subtest cursor_plane_move: SUCCESS (1.925s) [239.650716] [126/171] (784s left) kms_psr (sprite_plane_onoff) [239.743988] Starting subtest: sprite_plane_onoff [241.743838] Subtest sprite_plane_onoff: SUCCESS (1.994s) [242.659224] [127/171] (781s left) kms_psr (primary_mmap_gtt) [242.739667] Starting subtest: primary_mmap_gtt [244.719493] Subtest primary_mmap_gtt: SUCCESS (1.970s) [245.666898] [128/171] (778s left) kms_setmode (basic-clone-single-crtc) [245.730204] Starting subtest: basic-clone-single-crtc [245.732634] Subtest basic-clone-single-crtc: SKIP (0.000s) [245.800654] [129/171] (778s left) i915_pm_backlight (basic-brightness) [245.879287] Starting subtest: basic-brightness [245.961082] Starting dynamic subtest: eDP-1 [246.296595] Dynamic subtest eDP-1: SUCCESS (0.336s) [246.297923] Subtest basic-brightness: SUCCESS (0.416s) [247.203733] [130/171] (777s left) i915_pm_rpm (basic-pci-d3-state) [252.551562] Starting subtest: basic-pci-d3-state [257.230213] Subtest basic-pci-d3-state: SUCCESS (4.677s) [257.403095] [131/171] (766s left) i915_pm_rpm (basic-rte) [257.454252] Starting subtest: basic-rte [267.401795] Subtest basic-rte: SUCCESS (9.946s) [269.501968] [132/171] (754s left) i915_pm_rps (basic-api) [269.561373] Starting subtest: basic-api [269.562931] Subtest basic-api: SKIP (0.000s) [269.635904] [133/171] (754s left) prime_self_import (basic-llseek-bad) [269.689362] Starting subtest: basic-llseek-bad [269.691540] Subtest basic-llseek-bad: SUCCESS (0.001s) [269.784589] [134/171] (754s left) prime_self_import (basic-llseek-size) [269.838793] Starting subtest: basic-llseek-size [269.840960] Subtest basic-llseek-size: SUCCESS (0.002s) [269.933498] [135/171] (754s left) prime_self_import (basic-with_fd_dup) [269.983358] Starting subtest: basic-with_fd_dup [269.985581] Subtest basic-with_fd_dup: SUCCESS (0.002s) [270.083329] [136/171] (754s left) prime_self_import (basic-with_one_bo) [270.131404] Starting subtest: basic-with_one_bo [270.133631] Subtest basic-with_one_bo: SUCCESS (0.002s) [270.186104] [137/171] (754s left) prime_self_import (basic-with_one_bo_two_files) [270.235182] Starting subtest: basic-with_one_bo_two_files [270.237284] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [270.335676] [138/171] (754s left) prime_self_import (basic-with_two_bos) [270.386326] Starting subtest: basic-with_two_bos [270.388537] Subtest basic-with_two_bos: SUCCESS (0.002s) [270.487724] [139/171] (753s left) prime_vgem (basic-fence-flip) [270.577959] Starting subtest: basic-fence-flip [271.025631] Subtest basic-fence-flip: SUCCESS (0.447s) [271.137500] [140/171] (753s left) prime_vgem (basic-fence-mmap) [271.215700] Starting subtest: basic-fence-mmap [271.235669] Subtest basic-fence-mmap: SUCCESS (0.020s) [271.319214] [141/171] (753s left) prime_vgem (basic-fence-read) [271.380098] Starting subtest: basic-fence-read [271.386726] Subtest basic-fence-read: SKIP (0.007s) [271.487418] [142/171] (753s left) prime_vgem (basic-gtt) [271.547099] Starting subtest: basic-gtt [271.557923] Subtest basic-gtt: SUCCESS (0.012s) [271.655065] [143/171] (752s left) prime_vgem (basic-read) [271.712132] Starting subtest: basic-read [271.720363] Subtest basic-read: SKIP (0.008s) [271.821300] [144/171] (752s left) prime_vgem (basic-write) [271.879009] Starting subtest: basic-write [271.887119] Subtest basic-write: SKIP (0.007s) [271.986380] [145/171] (752s left) prime_vgem (basic-userptr) [272.047379] Starting subtest: basic-userptr [272.055961] Subtest basic-userptr: SKIP (0.008s) [272.153978] [146/171] (752s left) vgem_basic (setversion) [272.208440] Starting subtest: setversion [272.209981] Subtest setversion: SUCCESS (0.000s) [272.267753] [147/171] (752s left) vgem_basic (create) [272.325061] Starting subtest: create [272.325978] Subtest create: SUCCESS (0.000s) [272.384400] [148/171] (752s left) vgem_basic (debugfs) [272.441682] Starting subtest: debugfs [272.442555] Subtest debugfs: SUCCESS (0.000s) [272.497993] [149/171] (752s left) vgem_basic (dmabuf-export) [272.558339] Starting subtest: dmabuf-export [272.572281] Subtest dmabuf-export: SUCCESS (0.012s) [272.653978] [150/171] (752s left) vgem_basic (dmabuf-fence) [272.708499] Starting subtest: dmabuf-fence [272.709385] Subtest dmabuf-fence: SUCCESS (0.000s) [272.771543] [151/171] (751s left) vgem_basic (dmabuf-fence-before) [272.841819] Starting subtest: dmabuf-fence-before [272.843349] Subtest dmabuf-fence-before: SUCCESS (0.000s) [272.903135] [152/171] (751s left) vgem_basic (dmabuf-mmap) [272.958349] Starting subtest: dmabuf-mmap [272.972031] Subtest dmabuf-mmap: SUCCESS (0.014s) [273.012949] [153/171] (751s left) vgem_basic (mmap) [273.075209] Starting subtest: mmap [273.085483] Subtest mmap: SUCCESS (0.010s) [273.134209] [154/171] (751s left) vgem_basic (second-client) [273.191839] Starting subtest: second-client [273.242825] Subtest second-client: SUCCESS (0.050s) [273.303623] [155/171] (751s left) vgem_basic (sysfs) [273.358243] Starting subtest: sysfs [273.359162] Subtest sysfs: SUCCESS (0.000s) [273.420351] [156/171] (751s left) core_hotunplug (unbind-rebind) [273.491728] Starting subtest: unbind-rebind [275.643684] Subtest unbind-rebind: SUCCESS (2.152s) [275.659008] [157/171] (749s left) vgem_basic (unload) [275.711503] Starting subtest: unload [304.534762] Subtest unload: SUCCESS (28.788s) [304.619642] [158/171] (720s left) i915_module_load (reload) [304.671094] Starting subtest: reload [307.351908] Subtest reload: SUCCESS (2.681s) [307.364733] [159/171] (717s left) gem_lmem_swapping (basic) [307.421397] Subtest basic: SKIP (0.000s) [307.442273] [160/171] (717s left) gem_lmem_swapping (parallel-random-engines) [307.494179] Subtest parallel-random-engines: SKIP (0.000s) [307.533901] [161/171] (717s left) gem_lmem_swapping (random-engines) [307.622383] Subtest random-engines: SKIP (0.000s) [307.658892] [162/171] (717s left) gem_lmem_swapping (verify-random) [307.709465] Subtest verify-random: SKIP (0.000s) [307.743945] [163/171] (717s left) i915_pm_rpm (module-reload) [314.180066] Starting subtest: module-reload [331.418862] Subtest module-reload: SUCCESS (17.240s) [331.436120] [164/171] (693s left) i915_selftest (live) [331.495383] Starting subtest: live [331.496774] Starting dynamic subtest: sanitycheck [333.012392] Dynamic subtest sanitycheck: SUCCESS (1.508s) [333.017782] Starting dynamic subtest: uncore [334.484496] Dynamic subtest uncore: SUCCESS (1.472s) [334.489929] Starting dynamic subtest: workarounds [336.644449] Dynamic subtest workarounds: SUCCESS (2.159s) [336.649898] Starting dynamic subtest: gt_engines [338.567438] Dynamic subtest gt_engines: SUCCESS (1.922s) [338.573048] Starting dynamic subtest: gt_timelines [347.288472] Dynamic subtest gt_timelines: SUCCESS (8.721s) [347.294164] Starting dynamic subtest: gt_contexts [348.763422] Dynamic subtest gt_contexts: SUCCESS (1.475s) [348.768925] Starting dynamic subtest: gt_lrc [352.658488] Dynamic subtest gt_lrc: SUCCESS (3.895s) [352.664364] Starting dynamic subtest: gt_mocs [354.570343] Dynamic subtest gt_mocs: SUCCESS (1.911s) [354.575764] Starting dynamic subtest: gt_pm [356.940629] Dynamic subtest gt_pm: SUCCESS (2.370s) [356.946264] Starting dynamic subtest: gt_heartbeat [358.562588] Dynamic subtest gt_heartbeat: SUCCESS (1.621s) [358.568404] Starting dynamic subtest: requests [366.289856] Dynamic subtest requests: SUCCESS (7.727s) [366.296175] Starting dynamic subtest: migrate [370.642421] Dynamic subtest migrate: SUCCESS (4.352s) [370.647918] Starting dynamic subtest: active [372.110372] Dynamic subtest active: SUCCESS (1.468s) [372.115759] Starting dynamic subtest: objects [374.228478] Dynamic subtest objects: SUCCESS (2.118s) [374.233984] Starting dynamic subtest: mman [379.239631] Dynamic subtest mman: SUCCESS (5.011s) [379.246122] Starting dynamic subtest: dmabuf [380.828577] Dynamic subtest dmabuf: SUCCESS (1.589s) [380.834399] Starting dynamic subtest: vma [382.362607] Dynamic subtest vma: SUCCESS (1.534s) [382.368352] Starting dynamic subtest: coherency [387.820374] Dynamic subtest coherency: SUCCESS (5.457s) [387.825885] Starting dynamic subtest: gtt [398.006817] Dynamic subtest gtt: SUCCESS (10.186s) [398.013371] Starting dynamic subtest: gem [399.737423] Dynamic subtest gem: SUCCESS (1.730s) [399.743247] Starting dynamic subtest: evict [402.965410] Dynamic subtest evict: SUCCESS (3.227s) [402.970904] Starting dynamic subtest: hugepages [409.545060] Dynamic subtest hugepages: SUCCESS (6.579s) [409.552287] Starting dynamic subtest: gem_contexts [423.613144] Dynamic subtest gem_contexts: SUCCESS (14.067s) [423.620348] Starting dynamic subtest: client [425.190577] Dynamic subtest client: SUCCESS (1.577s) [425.196601] Starting dynamic subtest: gem_migrate [426.628497] Dynamic subtest gem_migrate: SUCCESS (1.437s) [426.634047] Starting dynamic subtest: reset [430.900609] Dynamic subtest reset: SUCCESS (4.272s) [430.906742] Starting dynamic subtest: memory_region [432.420546] Dynamic subtest memory_region: SUCCESS (1.520s) [432.426459] Starting dynamic subtest: hangcheck [448.338125] Dynamic subtest hangcheck: SUCCESS (15.917s) [448.345399] Starting dynamic subtest: execlists [449.880373] Dynamic subtest execlists: SUCCESS (1.542s) [449.886254] Starting dynamic subtest: ring_submission [451.315863] Dynamic subtest ring_submission: SUCCESS (1.435s) [451.321560] Starting dynamic subtest: perf [452.877541] Dynamic subtest perf: SUCCESS (1.561s) [452.883231] Starting dynamic subtest: slpc [459.226379] Dynamic subtest slpc: FAIL (6.302s) [459.231561] Starting dynamic subtest: guc [461.452542] Dynamic subtest guc: SUCCESS (2.271s) [461.458215] Starting dynamic subtest: guc_multi_lrc [462.899470] Dynamic subtest guc_multi_lrc: SUCCESS (1.447s) [462.905424] Starting dynamic subtest: guc_hang [464.963707] Dynamic subtest guc_hang: SUCCESS (2.072s) [464.969201] Starting dynamic subtest: late_gt_pm [466.435064] Dynamic subtest late_gt_pm: SUCCESS (1.462s) [466.435915] Subtest live: FAIL (134.931s) [466.492496] [165/171] (558s left) dmabuf (all-tests) [466.551365] Starting subtest: all-tests [466.553046] Starting dynamic subtest: sanitycheck [466.578827] Dynamic subtest sanitycheck: SUCCESS (0.027s) [466.593486] Starting dynamic subtest: dma_fence [466.709364] Dynamic subtest dma_fence: SUCCESS (0.130s) [466.716788] Starting dynamic subtest: dma_fence_chain [479.376809] Dynamic subtest dma_fence_chain: SUCCESS (12.665s) [479.393972] Starting dynamic subtest: dma_fence_unwrap [479.400796] Dynamic subtest dma_fence_unwrap: SUCCESS (0.025s) [479.418932] Starting dynamic subtest: dma_resv [479.423857] Dynamic subtest dma_resv: SUCCESS (0.022s) [479.425812] Subtest all-tests: SUCCESS (12.872s) [479.443980] [166/171] (545s left) i915_suspend (basic-s2idle-without-i915) [479.505265] Starting subtest: basic-s2idle-without-i915 [498.056251] Subtest basic-s2idle-without-i915: SUCCESS (3.847s) [498.393771] [167/171] (541s left) i915_suspend (basic-s3-without-i915) [498.446323] Starting subtest: basic-s3-without-i915 [518.023484] Subtest basic-s3-without-i915: SUCCESS (2.952s) [518.382624] [168/171] (537s left) gem_exec_suspend (basic-s0) [518.487653] Starting subtest: basic-S0 [518.488684] Starting dynamic subtest: smem [536.209140] Dynamic subtest smem: SUCCESS (3.082s) [536.210780] Subtest basic-S0: SUCCESS (3.083s) [536.364772] [169/171] (534s left) gem_exec_suspend (basic-s3) [536.423223] Starting subtest: basic-S3 [536.424120] Starting dynamic subtest: smem [554.175929] Dynamic subtest smem: SUCCESS (2.834s) [554.177548] Subtest basic-S3: SUCCESS (2.835s) [554.334060] [170/171] (531s left) kms_chamelium_hpd (common-hpd-after-suspend) [554.726609] Subtest common-hpd-after-suspend: SKIP (0.000s) [555.655172] [171/171] (530s left) kms_pipe_crc_basic (suspend-read-crc) [555.729811] Starting subtest: suspend-read-crc [555.732631] Starting dynamic subtest: pipe-A-eDP-1 [573.402586] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.412s) [573.410551] Starting dynamic subtest: pipe-B-eDP-1 [591.405157] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.193s) [591.423880] Starting dynamic subtest: pipe-C-eDP-1 [609.340797] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.089s) [609.342037] Subtest suspend-read-crc: SUCCESS (8.701s) [610.232153] Closing watchdogs Done.