[40.800674] Initializing watchdogs [40.800738] /dev/watchdog0 [40.809236] [001/171] (960s left) i915_module_load (load) [40.868672] Starting subtest: load [41.888921] Subtest load: SUCCESS (1.020s) [41.915422] [002/171] (959s left) core_auth (basic-auth) [42.034711] Starting subtest: basic-auth [42.037913] Subtest basic-auth: SUCCESS (0.000s) [42.087092] [003/171] (959s left) debugfs_test (read_all_entries) [42.143678] Starting subtest: read_all_entries [42.272466] Subtest read_all_entries: SUCCESS (0.130s) [42.369873] [004/171] (958s left) debugfs_test (basic-hwmon) [42.422456] Starting subtest: basic-hwmon [42.428653] Subtest basic-hwmon: SKIP (0.000s) [42.519729] [005/171] (958s left) fbdev (eof) [42.588608] Starting subtest: eof [42.592030] Subtest eof: SUCCESS (0.000s) [42.640368] [006/171] (958s left) fbdev (info) [42.700894] Starting subtest: info [42.704089] Subtest info: SUCCESS (0.000s) [42.753794] [007/171] (958s left) fbdev (nullptr) [42.821838] Starting subtest: nullptr [42.825192] Subtest nullptr: SUCCESS (0.000s) [42.872469] [008/171] (958s left) fbdev (read) [42.971739] Starting subtest: read [43.187108] Subtest read: SUCCESS (0.215s) [43.238627] [009/171] (958s left) fbdev (write) [43.289940] Starting subtest: write [43.397970] Subtest write: SUCCESS (0.110s) [43.451060] [010/171] (958s left) gem_basic (bad-close) [43.556909] Starting subtest: bad-close [43.563190] Subtest bad-close: SUCCESS (0.000s) [43.636138] [011/171] (957s left) gem_basic (create-close) [43.700598] Starting subtest: create-close [43.706980] Subtest create-close: SUCCESS (0.000s) [43.775066] [012/171] (957s left) gem_basic (create-fd-close) [43.832770] Starting subtest: create-fd-close [43.839447] Subtest create-fd-close: SUCCESS (0.000s) [43.907919] [013/171] (957s left) gem_busy (busy@all-engines) [43.974566] Starting subtest: busy [43.977862] Starting dynamic subtest: all-engines [43.991406] Dynamic subtest all-engines: SUCCESS (0.017s) [43.994650] Subtest busy: SUCCESS (0.017s) [44.358828] [014/171] (957s left) gem_close_race (basic-process) [44.411847] Starting subtest: basic-process [44.459760] Subtest basic-process: SUCCESS (0.047s) [44.662403] [015/171] (956s left) gem_close_race (basic-threads) [44.750999] Starting subtest: basic-threads [45.943278] Subtest basic-threads: SUCCESS (1.192s) [46.150310] [016/171] (955s left) gem_ctx_create (basic) [46.253556] Starting subtest: basic [46.256963] Subtest basic: SUCCESS (0.000s) [46.429740] [017/171] (955s left) gem_ctx_create (basic-files) [46.493584] Starting subtest: basic-files [48.503986] Subtest basic-files: SUCCESS (2.008s) [48.742828] [018/171] (952s left) gem_ctx_exec (basic) [48.855493] Starting subtest: basic [48.859897] Subtest basic: SUCCESS (0.007s) [48.985417] [019/171] (952s left) gem_exec_basic (basic) [49.084698] Starting subtest: basic [49.088482] Starting dynamic subtest: rcs0-smem [49.092206] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [49.098832] Starting dynamic subtest: bcs0-smem [49.102448] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [49.108706] Starting dynamic subtest: vcs0-smem [49.111990] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [49.118343] Starting dynamic subtest: vecs0-smem [49.121700] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [49.125206] Subtest basic: SUCCESS (0.002s) [49.321881] [020/171] (952s left) gem_exec_create (basic) [49.394789] Starting subtest: basic [49.398203] Starting dynamic subtest: smem [51.551878] Dynamic subtest smem: SUCCESS (2.042s) [51.621969] Subtest basic: SUCCESS (2.043s) [51.859683] [021/171] (950s left) gem_exec_fence (basic-busy) [52.458952] Starting subtest: basic-busy [52.463437] Starting dynamic subtest: rcs0 [52.471690] Dynamic subtest rcs0: SUCCESS (0.027s) [52.482360] Starting dynamic subtest: bcs0 [52.489207] Dynamic subtest bcs0: SUCCESS (0.037s) [52.496201] Starting dynamic subtest: vcs0 [52.502601] Dynamic subtest vcs0: SUCCESS (0.036s) [52.510571] Starting dynamic subtest: vecs0 [52.516956] Dynamic subtest vecs0: SUCCESS (0.044s) [52.520525] Subtest basic-busy: SUCCESS (0.144s) [52.973470] [022/171] (949s left) gem_exec_fence (basic-wait) [53.180207] Starting subtest: basic-wait [53.183615] Starting dynamic subtest: rcs0 [53.209429] Dynamic subtest rcs0: SUCCESS (0.029s) [53.218740] Starting dynamic subtest: bcs0 [53.235340] Dynamic subtest bcs0: SUCCESS (0.026s) [53.243502] Starting dynamic subtest: vcs0 [53.266080] Dynamic subtest vcs0: SUCCESS (0.030s) [53.285618] Starting dynamic subtest: vecs0 [53.298300] Dynamic subtest vecs0: SUCCESS (0.032s) [53.302386] Subtest basic-wait: SUCCESS (0.117s) [53.814273] [023/171] (948s left) gem_exec_fence (basic-await) [53.991131] Starting subtest: basic-await [53.994273] Starting dynamic subtest: rcs0 [54.055904] Dynamic subtest rcs0: SUCCESS (0.064s) [54.070031] Starting dynamic subtest: bcs0 [54.143173] Dynamic subtest bcs0: SUCCESS (0.086s) [54.166174] Starting dynamic subtest: vcs0 [54.237363] Dynamic subtest vcs0: SUCCESS (0.095s) [54.252228] Starting dynamic subtest: vecs0 [54.322428] Dynamic subtest vecs0: SUCCESS (0.085s) [54.326054] Subtest basic-await: SUCCESS (0.331s) [54.850647] [024/171] (947s left) gem_exec_fence (nb-await) [55.014526] Starting subtest: nb-await [55.017640] Starting dynamic subtest: rcs0 [55.076226] Dynamic subtest rcs0: SUCCESS (0.059s) [55.085965] Starting dynamic subtest: bcs0 [55.136353] Dynamic subtest bcs0: SUCCESS (0.062s) [55.158446] Starting dynamic subtest: vcs0 [55.203059] Dynamic subtest vcs0: SUCCESS (0.066s) [55.225465] Starting dynamic subtest: vecs0 [55.271283] Dynamic subtest vecs0: SUCCESS (0.068s) [55.275579] Subtest nb-await: SUCCESS (0.256s) [55.734668] [025/171] (946s left) gem_exec_gttfill (basic) [55.792181] Starting subtest: basic [60.329431] Subtest basic: SUCCESS (4.537s) [60.487794] [026/171] (941s left) gem_exec_parallel (engines) [60.606892] Starting subtest: engines [60.609899] Starting dynamic subtest: basic [62.041565] Dynamic subtest basic: SUCCESS (1.435s) [62.050085] Starting dynamic subtest: contexts [64.402166] Dynamic subtest contexts: SUCCESS (2.360s) [64.409658] Starting dynamic subtest: fds [66.616424] Dynamic subtest fds: SUCCESS (2.214s) [66.624371] Starting dynamic subtest: userptr [68.245190] Dynamic subtest userptr: SUCCESS (1.629s) [68.248757] Subtest engines: SUCCESS (7.638s) [68.439323] [027/171] (933s left) gem_exec_store (basic) [68.546430] Starting subtest: basic [68.587378] Subtest basic: SUCCESS (0.045s) [68.764731] [028/171] (933s left) gem_flink_basic (bad-flink) [68.820505] Starting subtest: bad-flink [68.823739] Subtest bad-flink: SUCCESS (0.000s) [68.870380] [029/171] (933s left) gem_flink_basic (bad-open) [68.951210] Starting subtest: bad-open [68.954772] Subtest bad-open: SUCCESS (0.000s) [69.003902] [030/171] (933s left) gem_flink_basic (basic) [69.060688] Starting subtest: basic [69.063983] Subtest basic: SUCCESS (0.000s) [69.155872] [031/171] (933s left) gem_flink_basic (double-flink) [69.252322] Starting subtest: double-flink [69.255930] Subtest double-flink: SUCCESS (0.000s) [69.357842] [032/171] (932s left) gem_flink_basic (flink-lifetime) [69.422727] Starting subtest: flink-lifetime [69.426092] Subtest flink-lifetime: SUCCESS (0.001s) [69.519933] [033/171] (932s left) gem_huc_copy (huc-copy) [69.618739] Starting subtest: huc-copy [69.622057] Subtest huc-copy: SUCCESS (0.002s) [69.757522] [034/171] (932s left) gem_linear_blits (basic) [69.918165] Starting subtest: basic [69.925147] Subtest basic: SUCCESS (0.005s) [70.067364] [035/171] (932s left) gem_mmap (basic) [70.255161] Starting subtest: basic [70.272009] Subtest basic: SUCCESS (0.000s) [70.355811] [036/171] (932s left) gem_mmap_gtt (basic) [70.409529] Starting subtest: basic [70.412702] Subtest basic: SUCCESS (0.000s) [70.467240] [037/171] (931s left) gem_render_linear_blits (basic) [70.528204] Starting subtest: basic [70.547271] Subtest basic: SUCCESS (0.018s) [70.619706] [038/171] (931s left) gem_render_tiled_blits (basic) [70.683882] Starting subtest: basic [70.704573] Subtest basic: SUCCESS (0.021s) [70.747885] [039/171] (931s left) gem_ringfill (basic-all) [71.005934] Starting subtest: basic-all [72.160250] Subtest basic-all: SUCCESS (1.160s) [72.256539] [040/171] (930s left) gem_softpin (allocator-basic) [72.326319] Starting subtest: allocator-basic [72.377553] Subtest allocator-basic: SUCCESS (0.054s) [72.479540] [041/171] (930s left) gem_softpin (allocator-basic-reserve) [72.541851] Starting subtest: allocator-basic-reserve [72.593541] Subtest allocator-basic-reserve: SUCCESS (0.055s) [72.706256] [042/171] (929s left) gem_softpin (safe-alignment) [72.775425] Starting subtest: safe-alignment [72.782101] Subtest safe-alignment: SUCCESS (0.008s) [72.907784] [043/171] (929s left) gem_sync (basic-all) [73.023391] Starting subtest: basic-all [75.083630] Subtest basic-all: SUCCESS (2.080s) [75.266509] [044/171] (927s left) gem_sync (basic-each) [75.404568] Starting subtest: basic-each [77.446217] Subtest basic-each: SUCCESS (2.060s) [77.660626] [045/171] (925s left) gem_tiled_blits (basic) [77.796810] Starting subtest: basic [77.810637] Subtest basic: SUCCESS (0.014s) [77.949955] [046/171] (924s left) gem_tiled_fence_blits (basic) [78.162009] Starting subtest: basic [78.169245] Subtest basic: SUCCESS (0.006s) [78.296812] [047/171] (924s left) gem_tiled_pread_basic [78.624786] [048/171] (924s left) gem_wait (busy@all-engines) [78.701246] Starting subtest: busy [78.704581] Starting dynamic subtest: all-engines [79.213182] Dynamic subtest all-engines: SUCCESS (0.512s) [79.216821] Subtest busy: SUCCESS (0.512s) [79.410289] [049/171] (923s left) gem_wait (wait@all-engines) [79.465713] Starting subtest: wait [79.468891] Starting dynamic subtest: all-engines [80.506511] Dynamic subtest all-engines: SUCCESS (1.040s) [80.510733] Subtest wait: SUCCESS (1.040s) [80.688777] [050/171] (922s left) i915_getparams_basic (basic-eu-total) [80.756528] Starting subtest: basic-eu-total [80.763624] Subtest basic-eu-total: SUCCESS (0.000s) [80.825990] [051/171] (922s left) i915_getparams_basic (basic-subslice-total) [80.889290] Starting subtest: basic-subslice-total [80.896560] Subtest basic-subslice-total: SUCCESS (0.000s) [80.993256] [052/171] (921s left) i915_hangman (error-state-basic) [81.103014] Starting subtest: error-state-basic [81.164046] Subtest error-state-basic: SUCCESS (0.060s) [81.223340] [053/171] (921s left) i915_pciid [81.375261] [054/171] (921s left) kms_addfb_basic (addfb25-bad-modifier) [81.489694] Starting subtest: addfb25-bad-modifier [81.492715] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [81.655364] [055/171] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [81.755666] Starting subtest: addfb25-framebuffer-vs-set-tiling [81.758868] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [81.937671] [056/171] (921s left) kms_addfb_basic (addfb25-modifier-no-flag) [82.038963] Starting subtest: addfb25-modifier-no-flag [82.042132] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [82.221025] [057/171] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy) [82.320624] Starting subtest: addfb25-x-tiled-legacy [82.323805] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [82.487537] [058/171] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [82.588939] Starting subtest: addfb25-x-tiled-mismatch-legacy [82.592198] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [82.754329] [059/171] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [82.902607] Starting subtest: addfb25-yf-tiled-legacy [82.905684] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [83.020753] [060/171] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy) [83.166709] Starting subtest: addfb25-y-tiled-legacy [83.169512] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [83.303728] [061/171] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [83.451039] Starting subtest: addfb25-y-tiled-small-legacy [83.453984] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [83.570324] [062/171] (919s left) kms_addfb_basic (bad-pitch-0) [83.623849] Starting subtest: bad-pitch-0 [83.627044] Subtest bad-pitch-0: SUCCESS (0.000s) [83.838023] [063/171] (919s left) kms_addfb_basic (bad-pitch-1024) [83.891135] Starting subtest: bad-pitch-1024 [83.894356] Subtest bad-pitch-1024: SUCCESS (0.000s) [84.104301] [064/171] (919s left) kms_addfb_basic (bad-pitch-128) [84.158243] Starting subtest: bad-pitch-128 [84.161341] Subtest bad-pitch-128: SUCCESS (0.000s) [84.371772] [065/171] (918s left) kms_addfb_basic (bad-pitch-256) [84.450680] Starting subtest: bad-pitch-256 [84.453774] Subtest bad-pitch-256: SUCCESS (0.000s) [84.671569] [066/171] (918s left) kms_addfb_basic (bad-pitch-32) [84.725697] Starting subtest: bad-pitch-32 [84.729011] Subtest bad-pitch-32: SUCCESS (0.000s) [84.937675] [067/171] (918s left) kms_addfb_basic (bad-pitch-63) [84.991743] Starting subtest: bad-pitch-63 [84.994937] Subtest bad-pitch-63: SUCCESS (0.000s) [85.204538] [068/171] (918s left) kms_addfb_basic (bad-pitch-65536) [85.257562] Starting subtest: bad-pitch-65536 [85.260804] Subtest bad-pitch-65536: SUCCESS (0.000s) [85.471416] [069/171] (917s left) kms_addfb_basic (bad-pitch-999) [85.525057] Starting subtest: bad-pitch-999 [85.528161] Subtest bad-pitch-999: SUCCESS (0.000s) [85.737701] [070/171] (917s left) kms_addfb_basic (basic) [85.790198] Starting subtest: basic [85.793483] Subtest basic: SUCCESS (0.000s) [86.004053] [071/171] (917s left) kms_addfb_basic (basic-x-tiled-legacy) [86.198863] Starting subtest: basic-x-tiled-legacy [86.202040] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [86.271229] [072/171] (917s left) kms_addfb_basic (basic-y-tiled-legacy) [86.461601] Starting subtest: basic-y-tiled-legacy [86.464316] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [86.536590] [073/171] (916s left) kms_addfb_basic (bo-too-small) [86.636705] Starting subtest: bo-too-small [86.639471] Subtest bo-too-small: SUCCESS (0.000s) [86.804054] [074/171] (916s left) kms_addfb_basic (bo-too-small-due-to-tiling) [86.905183] Starting subtest: bo-too-small-due-to-tiling [86.908030] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [87.070119] [075/171] (916s left) kms_addfb_basic (clobberred-modifier) [87.125483] Starting subtest: clobberred-modifier [87.128273] Subtest clobberred-modifier: SUCCESS (0.000s) [87.348289] [076/171] (916s left) kms_addfb_basic (framebuffer-vs-set-tiling) [87.540698] Starting subtest: framebuffer-vs-set-tiling [87.543287] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [87.621212] [077/171] (915s left) kms_addfb_basic (invalid-get-prop) [87.816470] Starting subtest: invalid-get-prop [87.819488] Subtest invalid-get-prop: SUCCESS (0.000s) [87.887805] [078/171] (915s left) kms_addfb_basic (invalid-get-prop-any) [88.079887] Starting subtest: invalid-get-prop-any [88.082571] Subtest invalid-get-prop-any: SUCCESS (0.000s) [88.153474] [079/171] (915s left) kms_addfb_basic (invalid-set-prop) [88.347220] Starting subtest: invalid-set-prop [88.350384] Subtest invalid-set-prop: SUCCESS (0.000s) [88.404200] [080/171] (915s left) kms_addfb_basic (invalid-set-prop-any) [88.597418] Starting subtest: invalid-set-prop-any [88.600277] Subtest invalid-set-prop-any: SUCCESS (0.000s) [88.670259] [081/171] (914s left) kms_addfb_basic (no-handle) [88.724422] Starting subtest: no-handle [88.727604] Subtest no-handle: SUCCESS (0.000s) [88.937738] [082/171] (914s left) kms_addfb_basic (size-max) [89.036749] Starting subtest: size-max [89.039475] Subtest size-max: SUCCESS (0.000s) [89.204151] [083/171] (914s left) kms_addfb_basic (small-bo) [89.304028] Starting subtest: small-bo [89.306786] Subtest small-bo: SUCCESS (0.000s) [89.471066] [084/171] (914s left) kms_addfb_basic (tile-pitch-mismatch) [89.664875] Starting subtest: tile-pitch-mismatch [89.668095] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [89.737700] [085/171] (913s left) kms_addfb_basic (too-high) [89.836918] Starting subtest: too-high [89.839737] Subtest too-high: SUCCESS (0.000s) [90.004088] [086/171] (913s left) kms_addfb_basic (too-wide) [90.104798] Starting subtest: too-wide [90.118123] Subtest too-wide: SUCCESS (0.000s) [90.272188] [087/171] (913s left) kms_addfb_basic (unused-handle) [90.325747] Starting subtest: unused-handle [90.328814] Subtest unused-handle: SUCCESS (0.000s) [90.537771] [088/171] (913s left) kms_addfb_basic (unused-modifier) [90.590200] Starting subtest: unused-modifier [90.593223] Subtest unused-modifier: SUCCESS (0.000s) [90.804558] [089/171] (912s left) kms_addfb_basic (unused-offsets) [90.857228] Starting subtest: unused-offsets [90.860086] Subtest unused-offsets: SUCCESS (0.000s) [91.070790] [090/171] (912s left) kms_addfb_basic (unused-pitches) [91.124323] Starting subtest: unused-pitches [91.127369] Subtest unused-pitches: SUCCESS (0.000s) [91.339650] [091/171] (912s left) kms_busy (basic) [91.447929] Starting subtest: basic [91.451056] Starting dynamic subtest: flip [91.972484] Dynamic subtest flip: SUCCESS (0.460s) [92.036810] Starting dynamic subtest: modeset [92.559754] Dynamic subtest modeset: SUCCESS (0.549s) [92.625333] Subtest basic: SUCCESS (1.011s) [92.920523] [092/171] (910s left) kms_chamelium_hpd (dp-hpd-fast) [93.320088] Subtest dp-hpd-fast: SKIP (0.000s) [93.362583] [093/171] (910s left) kms_chamelium_edid (dp-edid-read) [93.811096] Subtest dp-edid-read: SKIP (0.000s) [94.114314] [094/171] (910s left) kms_chamelium_frames (dp-crc-fast) [94.658323] Subtest dp-crc-fast: SKIP (0.000s) [94.926615] [095/171] (909s left) kms_chamelium_hpd (hdmi-hpd-fast) [95.086539] Subtest hdmi-hpd-fast: SKIP (0.000s) [95.152644] [096/171] (909s left) kms_chamelium_edid (hdmi-edid-read) [95.310612] Subtest hdmi-edid-read: SKIP (0.000s) [95.378511] [097/171] (908s left) kms_chamelium_frames (hdmi-crc-fast) [95.536417] Subtest hdmi-crc-fast: SKIP (0.000s) [95.603358] [098/171] (908s left) kms_chamelium_hpd (vga-hpd-fast) [95.762167] Subtest vga-hpd-fast: SKIP (0.000s) [95.827231] [099/171] (908s left) kms_chamelium_edid (vga-edid-read) [95.986331] Subtest vga-edid-read: SKIP (0.000s) [96.052029] [100/171] (908s left) kms_prop_blob (basic) [96.104621] Starting subtest: basic [96.107545] Subtest basic: SUCCESS (0.000s) [96.169321] [101/171] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [96.269226] Starting subtest: basic-busy-flip-before-cursor-atomic [96.274641] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [96.319076] [102/171] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [96.418430] Starting subtest: basic-busy-flip-before-cursor-legacy [96.424011] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [96.469121] [103/171] (907s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [96.569223] Starting subtest: basic-flip-after-cursor-atomic [97.524815] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.955s) [97.649602] [104/171] (906s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [97.751384] Starting subtest: basic-flip-after-cursor-legacy [98.688374] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.937s) [98.816475] [105/171] (905s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [98.917803] Starting subtest: basic-flip-after-cursor-varying-size [99.853992] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.936s) [99.973619] [106/171] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [100.074116] Starting subtest: basic-flip-before-cursor-atomic [101.028064] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.954s) [101.146980] [107/171] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [101.248172] Starting subtest: basic-flip-before-cursor-legacy [102.184960] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.937s) [102.309319] [108/171] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [102.410391] Starting subtest: basic-flip-before-cursor-varying-size [103.363858] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.953s) [103.488485] [109/171] (901s left) kms_flip (basic-flip-vs-dpms) [103.581429] Starting subtest: basic-flip-vs-dpms [103.584420] Starting dynamic subtest: A-HDMI-A1 [104.539693] Dynamic subtest A-HDMI-A1: SUCCESS (0.957s) [104.547519] Starting dynamic subtest: B-HDMI-A1 [105.428880] Dynamic subtest B-HDMI-A1: SUCCESS (0.889s) [105.437617] Starting dynamic subtest: C-HDMI-A1 [106.315292] Dynamic subtest C-HDMI-A1: SUCCESS (0.885s) [106.318508] Subtest basic-flip-vs-dpms: SUCCESS (2.736s) [106.447825] [110/171] (898s left) kms_flip (basic-flip-vs-modeset) [106.546565] Starting subtest: basic-flip-vs-modeset [106.549617] Starting dynamic subtest: A-HDMI-A1 [107.402742] Dynamic subtest A-HDMI-A1: SUCCESS (0.858s) [107.410434] Starting dynamic subtest: B-HDMI-A1 [108.194244] Dynamic subtest B-HDMI-A1: SUCCESS (0.791s) [108.202041] Starting dynamic subtest: C-HDMI-A1 [108.989408] Dynamic subtest C-HDMI-A1: SUCCESS (0.795s) [108.992381] Subtest basic-flip-vs-modeset: SUCCESS (2.448s) [109.118458] [111/171] (895s left) kms_flip (basic-flip-vs-wf_vblank) [109.215526] Starting subtest: basic-flip-vs-wf_vblank [109.218619] Starting dynamic subtest: A-HDMI-A1 [110.453468] Dynamic subtest A-HDMI-A1: SUCCESS (1.145s) [110.518890] Starting dynamic subtest: B-HDMI-A1 [111.603140] Dynamic subtest B-HDMI-A1: SUCCESS (1.124s) [111.670912] Starting dynamic subtest: C-HDMI-A1 [112.604612] Dynamic subtest C-HDMI-A1: SUCCESS (1.122s) [112.607724] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.395s) [112.775214] [112/171] (891s left) kms_flip (basic-plain-flip) [112.868461] Starting subtest: basic-plain-flip [112.871611] Starting dynamic subtest: A-HDMI-A1 [113.732357] Dynamic subtest A-HDMI-A1: SUCCESS (0.867s) [113.740220] Starting dynamic subtest: B-HDMI-A1 [114.573530] Dynamic subtest B-HDMI-A1: SUCCESS (0.841s) [114.582334] Starting dynamic subtest: C-HDMI-A1 [115.415639] Dynamic subtest C-HDMI-A1: SUCCESS (0.840s) [115.418850] Subtest basic-plain-flip: SUCCESS (2.552s) [115.601972] [113/171] (889s left) kms_force_connector_basic (force-connector-state) [115.757915] Starting subtest: force-connector-state [116.144703] Subtest force-connector-state: SUCCESS (0.388s) [116.556654] [114/171] (888s left) kms_force_connector_basic (force-edid) [116.708825] Starting subtest: force-edid [116.851621] Subtest force-edid: SUCCESS (0.143s) [117.056390] [115/171] (887s left) kms_force_connector_basic (force-load-detect) [117.207571] Starting subtest: force-load-detect [117.213312] Subtest force-load-detect: SKIP (0.000s) [117.406578] [116/171] (887s left) kms_force_connector_basic (prune-stale-modes) [117.557636] Starting subtest: prune-stale-modes [117.693498] Subtest prune-stale-modes: SUCCESS (0.135s) [117.889737] [117/171] (886s left) kms_frontbuffer_tracking (basic) [118.001218] Starting subtest: basic [120.307818] Subtest basic: SUCCESS (2.314s) [120.391123] [118/171] (884s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [120.503074] Starting subtest: compare-crc-sanitycheck [120.506321] Starting dynamic subtest: pipe-A-HDMI-A-1 [120.912671] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.409s) [120.920425] Starting dynamic subtest: pipe-B-HDMI-A-1 [121.287908] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.373s) [121.296191] Starting dynamic subtest: pipe-C-HDMI-A-1 [121.777360] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.399s) [121.842266] Subtest compare-crc-sanitycheck: SUCCESS (1.184s) [122.070211] [119/171] (882s left) kms_pipe_crc_basic (hang-read-crc) [122.397866] Starting subtest: hang-read-crc [122.463240] Starting dynamic subtest: pipe-A-HDMI-A-1 [123.365198] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.955s) [123.433245] Starting dynamic subtest: pipe-B-HDMI-A-1 [124.354729] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.995s) [124.422564] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.373439] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.028s) [125.440230] Subtest hang-read-crc: SUCCESS (2.981s) [125.676710] [120/171] (879s left) kms_pipe_crc_basic (nonblocking-crc) [126.086482] Starting subtest: nonblocking-crc [126.155558] Starting dynamic subtest: pipe-A-HDMI-A-1 [126.518673] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.517s) [126.528727] Starting dynamic subtest: pipe-B-HDMI-A-1 [127.046795] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.527s) [127.054953] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.627507] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.580s) [127.630405] Subtest nonblocking-crc: SUCCESS (1.627s) [127.778305] [121/171] (877s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [127.881009] Starting subtest: nonblocking-crc-frame-sequence [127.883945] Starting dynamic subtest: pipe-A-HDMI-A-1 [128.399831] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.518s) [128.409312] Starting dynamic subtest: pipe-B-HDMI-A-1 [128.927744] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.528s) [128.936286] Starting dynamic subtest: pipe-C-HDMI-A-1 [129.489540] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.561s) [129.492479] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.609s) [129.589278] [122/171] (875s left) kms_pipe_crc_basic (read-crc) [129.690361] Starting subtest: read-crc [129.693352] Starting dynamic subtest: pipe-A-HDMI-A-1 [130.144182] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.453s) [130.153009] Starting dynamic subtest: pipe-B-HDMI-A-1 [130.605125] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.460s) [130.613284] Starting dynamic subtest: pipe-C-HDMI-A-1 [131.101301] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.494s) [131.104345] Subtest read-crc: SUCCESS (1.410s) [131.199621] [123/171] (873s left) kms_pipe_crc_basic (read-crc-frame-sequence) [131.303245] Starting subtest: read-crc-frame-sequence [131.306392] Starting dynamic subtest: pipe-A-HDMI-A-1 [131.755835] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.452s) [131.764494] Starting dynamic subtest: pipe-B-HDMI-A-1 [132.215910] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.460s) [132.225481] Starting dynamic subtest: pipe-C-HDMI-A-1 [132.710151] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.494s) [132.712993] Subtest read-crc-frame-sequence: SUCCESS (1.408s) [132.810278] [124/171] (872s left) kms_psr (primary_page_flip) [132.871989] Subtest primary_page_flip: SKIP (0.000s) [132.890253] [125/171] (872s left) kms_psr (cursor_plane_move) [132.944611] Subtest cursor_plane_move: SKIP (0.000s) [132.973701] [126/171] (872s left) kms_psr (sprite_plane_onoff) [133.041848] Subtest sprite_plane_onoff: SKIP (0.000s) [133.057824] [127/171] (872s left) kms_psr (primary_mmap_gtt) [133.114278] Subtest primary_mmap_gtt: SKIP (0.000s) [133.138111] [128/171] (872s left) kms_setmode (basic-clone-single-crtc) [133.202044] Starting subtest: basic-clone-single-crtc [133.211885] Subtest basic-clone-single-crtc: SKIP (0.000s) [133.264533] [129/171] (871s left) i915_pm_backlight (basic-brightness) [133.393286] Subtest basic-brightness: SKIP (0.000s) [133.423455] [130/171] (871s left) i915_pm_rpm (basic-pci-d3-state) [134.951464] Starting subtest: basic-pci-d3-state [135.300490] Subtest basic-pci-d3-state: SUCCESS (0.347s) [135.794580] [131/171] (869s left) i915_pm_rpm (basic-rte) [135.852097] Starting subtest: basic-rte [137.788826] Subtest basic-rte: SUCCESS (1.837s) [138.790820] [132/171] (866s left) i915_pm_rps (basic-api) [139.069460] Starting subtest: basic-api [139.079380] Subtest basic-api: SUCCESS (0.011s) [139.357450] [133/171] (866s left) prime_self_import (basic-llseek-bad) [139.759461] Starting subtest: basic-llseek-bad [139.826962] Subtest basic-llseek-bad: SUCCESS (0.006s) [140.064074] [134/171] (865s left) prime_self_import (basic-llseek-size) [140.334134] Starting subtest: basic-llseek-size [140.401802] Subtest basic-llseek-size: SUCCESS (0.003s) [140.646073] [135/171] (865s left) prime_self_import (basic-with_fd_dup) [140.699212] Starting subtest: basic-with_fd_dup [140.702840] Subtest basic-with_fd_dup: SUCCESS (0.001s) [140.797139] [136/171] (865s left) prime_self_import (basic-with_one_bo) [140.848606] Starting subtest: basic-with_one_bo [140.852126] Subtest basic-with_one_bo: SUCCESS (0.002s) [140.898173] [137/171] (865s left) prime_self_import (basic-with_one_bo_two_files) [140.968738] Starting subtest: basic-with_one_bo_two_files [140.972231] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [141.079914] [138/171] (865s left) prime_self_import (basic-with_two_bos) [141.145153] Starting subtest: basic-with_two_bos [141.148783] Subtest basic-with_two_bos: SUCCESS (0.005s) [141.277399] [139/171] (864s left) prime_vgem (basic-fence-flip) [141.398165] Starting subtest: basic-fence-flip [141.784806] Subtest basic-fence-flip: SUCCESS (0.386s) [141.868062] [140/171] (864s left) prime_vgem (basic-fence-mmap) [141.937485] Starting subtest: basic-fence-mmap [141.950328] Subtest basic-fence-mmap: SUCCESS (0.013s) [142.045407] [141/171] (864s left) prime_vgem (basic-fence-read) [142.104595] Starting subtest: basic-fence-read [142.126382] Subtest basic-fence-read: SUCCESS (0.022s) [142.222920] [142/171] (864s left) prime_vgem (basic-gtt) [142.300586] Starting subtest: basic-gtt [142.307445] Subtest basic-gtt: SUCCESS (0.006s) [142.408295] [143/171] (863s left) prime_vgem (basic-read) [142.530755] Starting subtest: basic-read [142.539927] Subtest basic-read: SUCCESS (0.011s) [142.659387] [144/171] (863s left) prime_vgem (basic-write) [142.752726] Starting subtest: basic-write [142.764418] Subtest basic-write: SUCCESS (0.013s) [142.894220] [145/171] (863s left) prime_vgem (basic-userptr) [142.978045] Starting subtest: basic-userptr [142.983953] Subtest basic-userptr: SKIP (0.004s) [143.098521] [146/171] (863s left) vgem_basic (setversion) [143.201037] Starting subtest: setversion [143.206902] Subtest setversion: SUCCESS (0.000s) [143.275537] [147/171] (863s left) vgem_basic (create) [143.351009] Starting subtest: create [143.354205] Subtest create: SUCCESS (0.000s) [143.405068] [148/171] (863s left) vgem_basic (debugfs) [143.467472] Starting subtest: debugfs [143.470564] Subtest debugfs: SUCCESS (0.000s) [143.517381] [149/171] (863s left) vgem_basic (dmabuf-export) [143.601194] Starting subtest: dmabuf-export [143.610192] Subtest dmabuf-export: SUCCESS (0.009s) [143.724137] [150/171] (862s left) vgem_basic (dmabuf-fence) [143.820472] Starting subtest: dmabuf-fence [143.824655] Subtest dmabuf-fence: SUCCESS (0.002s) [143.899819] [151/171] (862s left) vgem_basic (dmabuf-fence-before) [144.001252] Starting subtest: dmabuf-fence-before [144.004572] Subtest dmabuf-fence-before: SUCCESS (0.000s) [144.050726] [152/171] (862s left) vgem_basic (dmabuf-mmap) [144.134140] Starting subtest: dmabuf-mmap [144.142750] Subtest dmabuf-mmap: SUCCESS (0.008s) [144.181458] [153/171] (862s left) vgem_basic (mmap) [144.250785] Starting subtest: mmap [144.257778] Subtest mmap: SUCCESS (0.005s) [144.299840] [154/171] (862s left) vgem_basic (second-client) [144.384186] Starting subtest: second-client [144.434344] Subtest second-client: SUCCESS (0.050s) [144.526925] [155/171] (862s left) vgem_basic (sysfs) [144.601208] Starting subtest: sysfs [144.604690] Subtest sysfs: SUCCESS (0.000s) [144.657791] [156/171] (862s left) core_hotunplug (unbind-rebind) [144.768360] Starting subtest: unbind-rebind [145.683899] Subtest unbind-rebind: SUCCESS (0.916s) [145.705120] [157/171] (861s left) vgem_basic (unload) [145.764934] Starting subtest: unload [174.446239] Subtest unload: SUCCESS (28.682s) [174.522313] [158/171] (832s left) i915_module_load (reload) [174.576186] Starting subtest: reload [176.217798] Subtest reload: SUCCESS (1.643s) [176.238752] [159/171] (830s left) gem_lmem_swapping (basic) [176.307076] Subtest basic: SKIP (0.000s) [176.328658] [160/171] (830s left) gem_lmem_swapping (parallel-random-engines) [176.385740] Subtest parallel-random-engines: SKIP (0.000s) [176.411796] [161/171] (830s left) gem_lmem_swapping (random-engines) [176.472039] Subtest random-engines: SKIP (0.000s) [176.493209] [162/171] (830s left) gem_lmem_swapping (verify-random) [176.560262] Subtest verify-random: SKIP (0.000s) [176.596314] [163/171] (830s left) i915_pm_rpm (module-reload) [178.351202] Starting subtest: module-reload [185.975188] Subtest module-reload: SUCCESS (7.574s) [186.215508] [164/171] (820s left) i915_selftest (live) [186.612767] Starting subtest: live [186.616036] Starting dynamic subtest: sanitycheck [186.958366] Dynamic subtest sanitycheck: SUCCESS (0.474s) [187.025433] Starting dynamic subtest: uncore [187.462268] Dynamic subtest uncore: SUCCESS (0.481s) [187.531419] Starting dynamic subtest: workarounds [188.041533] Dynamic subtest workarounds: SUCCESS (0.597s) [188.109632] Starting dynamic subtest: gt_engines [189.008393] Dynamic subtest gt_engines: SUCCESS (0.962s) [189.076802] Starting dynamic subtest: gt_timelines [194.312391] Dynamic subtest gt_timelines: SUCCESS (5.350s) [194.319239] Starting dynamic subtest: gt_contexts [194.849475] Dynamic subtest gt_contexts: SUCCESS (0.537s) [194.856363] Starting dynamic subtest: gt_lrc [197.590369] Dynamic subtest gt_lrc: SUCCESS (2.741s) [197.597282] Starting dynamic subtest: gt_mocs [198.134241] Dynamic subtest gt_mocs: SUCCESS (0.544s) [198.141017] Starting dynamic subtest: gt_pm [200.595625] Dynamic subtest gt_pm: SUCCESS (2.461s) [200.602457] Starting dynamic subtest: gt_heartbeat [201.184350] Dynamic subtest gt_heartbeat: SUCCESS (0.589s) [201.191360] Starting dynamic subtest: requests [207.878309] Dynamic subtest requests: SUCCESS (6.694s) [207.885175] Starting dynamic subtest: migrate [211.181213] Dynamic subtest migrate: SUCCESS (3.303s) [211.188071] Starting dynamic subtest: active [211.675396] Dynamic subtest active: SUCCESS (0.494s) [211.682390] Starting dynamic subtest: objects [212.688442] Dynamic subtest objects: SUCCESS (1.012s) [212.697804] Starting dynamic subtest: mman [216.473266] Dynamic subtest mman: SUCCESS (3.784s) [216.482666] Starting dynamic subtest: dmabuf [216.979494] Dynamic subtest dmabuf: SUCCESS (0.506s) [216.986358] Starting dynamic subtest: vma [217.427305] Dynamic subtest vma: SUCCESS (0.448s) [217.434137] Starting dynamic subtest: coherency [218.357624] Dynamic subtest coherency: SUCCESS (0.930s) [218.364697] Starting dynamic subtest: gtt [228.429447] Dynamic subtest gtt: SUCCESS (10.072s) [228.436371] Starting dynamic subtest: gem [228.983585] Dynamic subtest gem: SUCCESS (0.554s) [228.994680] Starting dynamic subtest: evict [230.159321] Dynamic subtest evict: SUCCESS (1.175s) [230.166305] Starting dynamic subtest: hugepages [235.765265] Dynamic subtest hugepages: SUCCESS (5.606s) [235.774388] Starting dynamic subtest: gem_contexts [247.668366] Dynamic subtest gem_contexts: SUCCESS (11.903s) [247.675296] Starting dynamic subtest: client [248.160239] Dynamic subtest client: SUCCESS (0.492s) [248.169860] Starting dynamic subtest: gem_migrate [248.622404] Dynamic subtest gem_migrate: SUCCESS (0.462s) [248.629367] Starting dynamic subtest: reset [249.433366] Dynamic subtest reset: SUCCESS (0.811s) [249.440053] Starting dynamic subtest: memory_region [249.910177] Dynamic subtest memory_region: SUCCESS (0.477s) [249.919252] Starting dynamic subtest: hangcheck [273.461844] Dynamic subtest hangcheck: SUCCESS (23.551s) [273.468996] Starting dynamic subtest: execlists [281.626453] Dynamic subtest execlists: SUCCESS (8.165s) [281.635631] Starting dynamic subtest: ring_submission [282.091264] Dynamic subtest ring_submission: SUCCESS (0.465s) [282.098062] Starting dynamic subtest: perf [282.715397] Dynamic subtest perf: SUCCESS (0.624s) [282.724860] Starting dynamic subtest: slpc [283.151401] Dynamic subtest slpc: SUCCESS (0.436s) [283.158331] Starting dynamic subtest: guc [283.622312] Dynamic subtest guc: SUCCESS (0.471s) [283.631656] Starting dynamic subtest: guc_multi_lrc [284.070370] Dynamic subtest guc_multi_lrc: SUCCESS (0.448s) [284.077270] Starting dynamic subtest: guc_hang [284.533234] Dynamic subtest guc_hang: SUCCESS (0.463s) [284.539995] Starting dynamic subtest: late_gt_pm [285.003458] Dynamic subtest late_gt_pm: SUCCESS (0.470s) [285.006760] Subtest live: SUCCESS (98.556s) [285.115822] [165/171] (722s left) dmabuf (all-tests) [285.185685] Starting subtest: all-tests [285.193336] Starting dynamic subtest: sanitycheck [285.228921] Dynamic subtest sanitycheck: SUCCESS (0.042s) [285.250424] Starting dynamic subtest: dma_fence [285.367207] Dynamic subtest dma_fence: SUCCESS (0.138s) [285.373726] Starting dynamic subtest: dma_fence_chain [295.754308] Dynamic subtest dma_fence_chain: SUCCESS (10.387s) [295.761219] Starting dynamic subtest: dma_fence_unwrap [295.776216] Dynamic subtest dma_fence_unwrap: SUCCESS (0.022s) [295.782864] Starting dynamic subtest: dma_resv [295.800118] Dynamic subtest dma_resv: SUCCESS (0.024s) [295.803425] Subtest all-tests: SUCCESS (10.616s) [295.821639] [166/171] (711s left) i915_suspend (basic-s2idle-without-i915) [295.876345] Starting subtest: basic-s2idle-without-i915 [313.285218] Subtest basic-s2idle-without-i915: SUCCESS (2.105s) [318.447552] [167/171] (709s left) i915_suspend (basic-s3-without-i915) [318.501511] Starting subtest: basic-s3-without-i915 [336.475869] Subtest basic-s3-without-i915: SUCCESS (1.999s) [342.631829] [168/171] (706s left) gem_exec_suspend (basic-s0) [342.698433] Starting subtest: basic-S0 [342.701563] Starting dynamic subtest: smem [360.331356] Dynamic subtest smem: SUCCESS (1.777s) [360.334455] Subtest basic-S0: SUCCESS (1.778s) [365.518507] [169/171] (704s left) gem_exec_suspend (basic-s3) [365.602108] Starting subtest: basic-S3 [365.605411] Starting dynamic subtest: smem [383.489247] Dynamic subtest smem: SUCCESS (1.931s) [383.492459] Subtest basic-S3: SUCCESS (1.932s) [391.678455] [170/171] (702s left) kms_chamelium_hpd (common-hpd-after-suspend) [391.858403] Subtest common-hpd-after-suspend: SKIP (0.000s) [391.924830] [171/171] (702s left) kms_pipe_crc_basic (suspend-read-crc) [392.026636] Starting subtest: suspend-read-crc [392.029799] Starting dynamic subtest: pipe-A-HDMI-A-1 [410.610877] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.849s) [410.622258] Starting dynamic subtest: pipe-B-HDMI-A-1 [429.769541] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.884s) [429.837149] Starting dynamic subtest: pipe-C-HDMI-A-1 [448.691558] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.359s) [448.694506] Subtest suspend-read-crc: SUCCESS (6.094s) [453.759877] Closing watchdogs Done.