[45.983955] Initializing watchdogs [45.984296] /dev/watchdog0 [46.019695] [001/171] (960s left) i915_module_load (load) [46.318788] Starting subtest: load [48.862674] Subtest load: SUCCESS (2.543s) [48.975180] [002/171] (957s left) core_auth (basic-auth) [49.314294] Starting subtest: basic-auth [49.336088] Subtest basic-auth: SUCCESS (0.002s) [49.440566] [003/171] (957s left) debugfs_test (read_all_entries) [49.748366] Starting subtest: read_all_entries [50.151976] Subtest read_all_entries: SUCCESS (0.406s) [50.366943] [004/171] (956s left) debugfs_test (basic-hwmon) [50.660827] Starting subtest: basic-hwmon [50.706811] Subtest basic-hwmon: SKIP (0.000s) [50.881545] [005/171] (956s left) fbdev (eof) [51.183740] Starting subtest: eof [51.205095] Subtest eof: SUCCESS (0.001s) [51.333179] [006/171] (955s left) fbdev (info) [51.602110] Starting subtest: info [51.624602] Subtest info: SUCCESS (0.000s) [51.751595] [007/171] (955s left) fbdev (nullptr) [52.023511] Starting subtest: nullptr [52.044877] Subtest nullptr: SUCCESS (0.000s) [52.175820] [008/171] (955s left) fbdev (read) [52.427617] Starting subtest: read [53.901163] Subtest read: SUCCESS (1.486s) [54.012719] [009/171] (953s left) fbdev (write) [54.270897] Starting subtest: write [55.027066] Subtest write: SUCCESS (0.761s) [55.134446] [010/171] (952s left) gem_basic (bad-close) [55.434825] Starting subtest: bad-close [55.479160] Subtest bad-close: SUCCESS (0.000s) [55.566405] [011/171] (951s left) gem_basic (create-close) [55.863804] Starting subtest: create-close [55.908139] Subtest create-close: SUCCESS (0.000s) [55.994606] [012/171] (951s left) gem_basic (create-fd-close) [56.294768] Starting subtest: create-fd-close [56.336340] Subtest create-fd-close: SUCCESS (0.000s) [56.423338] [013/171] (951s left) gem_busy (busy@all-engines) [56.735628] Starting subtest: busy [56.756958] Starting dynamic subtest: all-engines [56.813174] Dynamic subtest all-engines: SUCCESS (0.090s) [56.835750] Subtest busy: SUCCESS (0.091s) [57.210650] [014/171] (950s left) gem_close_race (basic-process) [57.540410] Starting subtest: basic-process [57.627980] Subtest basic-process: SUCCESS (0.106s) [57.881566] [015/171] (949s left) gem_close_race (basic-threads) [58.216418] Starting subtest: basic-threads [59.417468] Subtest basic-threads: SUCCESS (1.221s) [59.645248] [016/171] (948s left) gem_ctx_create (basic) [59.951087] Starting subtest: basic [59.971434] Subtest basic: SUCCESS (0.000s) [60.167075] [017/171] (947s left) gem_ctx_create (basic-files) [60.468771] Starting subtest: basic-files [62.512891] Subtest basic-files: SUCCESS (2.037s) [62.762785] [018/171] (945s left) gem_ctx_exec (basic) [63.073469] Starting subtest: basic [63.093363] Subtest basic: SUCCESS (0.010s) [63.181416] [019/171] (944s left) gem_exec_basic (basic) [63.484276] Starting subtest: basic [63.508239] Starting dynamic subtest: rcs0-smem [63.531160] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [63.564875] Starting dynamic subtest: bcs0-smem [63.585093] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [63.621093] Starting dynamic subtest: vcs0-smem [63.642983] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [63.676934] Starting dynamic subtest: vecs0-smem [63.697199] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [63.720221] Subtest basic: SUCCESS (0.010s) [63.806530] [020/171] (944s left) gem_exec_create (basic) [64.112520] Starting subtest: basic [64.132473] Starting dynamic subtest: smem [66.187116] Dynamic subtest smem: SUCCESS (2.071s) [66.207668] Subtest basic: SUCCESS (2.071s) [66.398741] [021/171] (941s left) gem_exec_fence (basic-busy) [66.827676] Starting subtest: basic-busy [66.847819] Starting dynamic subtest: rcs0 [66.892304] Dynamic subtest rcs0: SUCCESS (0.024s) [66.928296] Starting dynamic subtest: bcs0 [66.978372] Dynamic subtest bcs0: SUCCESS (0.028s) [67.013418] Starting dynamic subtest: vcs0 [67.054068] Dynamic subtest vcs0: SUCCESS (0.029s) [67.089175] Starting dynamic subtest: vecs0 [67.129734] Dynamic subtest vecs0: SUCCESS (0.021s) [67.149937] Subtest basic-busy: SUCCESS (0.103s) [67.746925] [022/171] (940s left) gem_exec_fence (basic-wait) [68.168823] Starting subtest: basic-wait [68.189478] Starting dynamic subtest: rcs0 [68.213050] Dynamic subtest rcs0: SUCCESS (0.030s) [68.264362] Starting dynamic subtest: bcs0 [68.290477] Dynamic subtest bcs0: SUCCESS (0.038s) [68.331076] Starting dynamic subtest: vcs0 [68.355655] Dynamic subtest vcs0: SUCCESS (0.033s) [68.396436] Starting dynamic subtest: vecs0 [68.420533] Dynamic subtest vecs0: SUCCESS (0.024s) [68.446171] Subtest basic-wait: SUCCESS (0.126s) [69.013437] [023/171] (939s left) gem_exec_fence (basic-await) [69.454198] Starting subtest: basic-await [69.481344] Starting dynamic subtest: rcs0 [69.597448] Dynamic subtest rcs0: SUCCESS (0.141s) [69.645656] Starting dynamic subtest: bcs0 [69.726550] Dynamic subtest bcs0: SUCCESS (0.131s) [69.774066] Starting dynamic subtest: vcs0 [69.861283] Dynamic subtest vcs0: SUCCESS (0.133s) [69.908294] Starting dynamic subtest: vecs0 [69.989599] Dynamic subtest vecs0: SUCCESS (0.130s) [70.011784] Subtest basic-await: SUCCESS (0.540s) [70.679892] [024/171] (937s left) gem_exec_fence (nb-await) [71.100882] Starting subtest: nb-await [71.124892] Starting dynamic subtest: rcs0 [71.178684] Dynamic subtest rcs0: SUCCESS (0.077s) [71.216369] Starting dynamic subtest: bcs0 [71.266887] Dynamic subtest bcs0: SUCCESS (0.071s) [71.303737] Starting dynamic subtest: vcs0 [71.327447] Dynamic subtest vcs0: SUCCESS (0.071s) [71.367552] Starting dynamic subtest: vecs0 [71.409966] Dynamic subtest vecs0: SUCCESS (0.072s) [71.433829] Subtest nb-await: SUCCESS (0.294s) [72.097283] [025/171] (936s left) gem_exec_gttfill (basic) [72.407293] Starting subtest: basic [94.630126] Subtest basic: SUCCESS (22.063s) [94.721874] [026/171] (914s left) gem_exec_parallel (engines) [95.183531] Starting subtest: engines [95.205946] Starting dynamic subtest: basic [99.231492] Dynamic subtest basic: SUCCESS (3.875s) [99.270784] Starting dynamic subtest: contexts [103.784246] Dynamic subtest contexts: SUCCESS (4.577s) [103.823115] Starting dynamic subtest: fds [109.049121] Dynamic subtest fds: SUCCESS (5.255s) [109.087789] Starting dynamic subtest: userptr [112.912328] Dynamic subtest userptr: SUCCESS (3.847s) [112.934374] Subtest engines: SUCCESS (17.554s) [113.040473] [027/171] (895s left) gem_exec_store (basic) [113.410472] Starting subtest: basic [113.430750] Subtest basic: SUCCESS (0.069s) [113.633563] [028/171] (895s left) gem_flink_basic (bad-flink) [113.950911] Starting subtest: bad-flink [113.971033] Subtest bad-flink: SUCCESS (0.000s) [114.063590] [029/171] (894s left) gem_flink_basic (bad-open) [114.339954] Starting subtest: bad-open [114.362652] Subtest bad-open: SUCCESS (0.000s) [114.451845] [030/171] (894s left) gem_flink_basic (basic) [114.748074] Starting subtest: basic [114.768952] Subtest basic: SUCCESS (0.000s) [114.860614] [031/171] (894s left) gem_flink_basic (double-flink) [115.171848] Starting subtest: double-flink [115.199812] Subtest double-flink: SUCCESS (0.000s) [115.310389] [032/171] (893s left) gem_flink_basic (flink-lifetime) [115.641346] Starting subtest: flink-lifetime [115.667576] Subtest flink-lifetime: SUCCESS (0.003s) [115.783490] [033/171] (893s left) gem_huc_copy (huc-copy) [116.109284] Starting subtest: huc-copy [116.138394] Subtest huc-copy: SUCCESS (0.005s) [116.251700] [034/171] (893s left) gem_linear_blits (basic) [116.705504] Starting subtest: basic [116.728357] Subtest basic: SUCCESS (0.019s) [116.891403] [035/171] (892s left) gem_mmap (basic) [117.344662] Starting subtest: basic [117.449748] Subtest basic: SUCCESS (0.001s) [117.541970] [036/171] (892s left) gem_mmap_gtt (basic) [117.859548] Starting subtest: basic [117.885583] Subtest basic: SUCCESS (0.002s) [117.978122] [037/171] (891s left) gem_render_linear_blits (basic) [118.273615] Starting subtest: basic [118.381305] Subtest basic: SUCCESS (0.086s) [118.469785] [038/171] (891s left) gem_render_tiled_blits (basic) [118.749636] Starting subtest: basic [118.871643] Subtest basic: SUCCESS (0.121s) [118.970235] [039/171] (890s left) gem_ringfill (basic-all) [119.554404] Starting subtest: basic-all [120.734092] Subtest basic-all: SUCCESS (1.203s) [120.885564] [040/171] (889s left) gem_softpin (allocator-basic) [121.194853] Starting subtest: allocator-basic [121.413186] Subtest allocator-basic: SUCCESS (0.246s) [121.563596] [041/171] (888s left) gem_softpin (allocator-basic-reserve) [121.860660] Starting subtest: allocator-basic-reserve [122.077613] Subtest allocator-basic-reserve: SUCCESS (0.242s) [122.245626] [042/171] (887s left) gem_softpin (safe-alignment) [122.547113] Starting subtest: safe-alignment [122.567937] Subtest safe-alignment: SUCCESS (0.032s) [122.716782] [043/171] (887s left) gem_sync (basic-all) [123.187912] Starting subtest: basic-all [125.099288] Subtest basic-all: SUCCESS (2.068s) [125.317147] [044/171] (884s left) gem_sync (basic-each) [125.783117] Starting subtest: basic-each [127.886869] Subtest basic-each: SUCCESS (2.248s) [128.084333] [045/171] (882s left) gem_tiled_blits (basic) [128.538155] Starting subtest: basic [128.588399] Subtest basic: SUCCESS (0.050s) [128.785704] [046/171] (881s left) gem_tiled_fence_blits (basic) [129.427044] Starting subtest: basic [129.473258] Subtest basic: SUCCESS (0.044s) [129.696498] [047/171] (880s left) gem_tiled_pread_basic [130.480999] [048/171] (880s left) gem_wait (busy@all-engines) [130.807346] Starting subtest: busy [130.829171] Starting dynamic subtest: all-engines [131.336898] Dynamic subtest all-engines: SUCCESS (0.527s) [131.360240] Subtest busy: SUCCESS (0.528s) [131.622376] [049/171] (879s left) gem_wait (wait@all-engines) [131.951691] Starting subtest: wait [131.979581] Starting dynamic subtest: all-engines [133.131404] Dynamic subtest all-engines: SUCCESS (1.042s) [133.157457] Subtest wait: SUCCESS (1.043s) [133.276130] [050/171] (877s left) i915_getparams_basic (basic-eu-total) [133.608602] Starting subtest: basic-eu-total [133.665421] Subtest basic-eu-total: SUCCESS (0.000s) [133.783346] [051/171] (877s left) i915_getparams_basic (basic-subslice-total) [134.115368] Starting subtest: basic-subslice-total [134.178117] Subtest basic-subslice-total: SUCCESS (0.000s) [134.283148] [052/171] (876s left) i915_hangman (error-state-basic) [134.587657] Starting subtest: error-state-basic [134.887201] Subtest error-state-basic: SUCCESS (0.296s) [134.982140] [053/171] (876s left) i915_pciid [135.400574] [054/171] (875s left) kms_addfb_basic (addfb25-bad-modifier) [135.709119] Starting subtest: addfb25-bad-modifier [135.735759] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [136.004646] [055/171] (875s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [136.288912] Starting subtest: addfb25-framebuffer-vs-set-tiling [136.310056] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [136.500707] [056/171] (874s left) kms_addfb_basic (addfb25-modifier-no-flag) [136.793618] Starting subtest: addfb25-modifier-no-flag [136.812903] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [137.020934] [057/171] (874s left) kms_addfb_basic (addfb25-x-tiled-legacy) [137.316132] Starting subtest: addfb25-x-tiled-legacy [137.337548] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [137.534755] [058/171] (874s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [137.827975] Starting subtest: addfb25-x-tiled-mismatch-legacy [137.847835] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [138.054980] [059/171] (873s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [138.439698] Starting subtest: addfb25-yf-tiled-legacy [138.460733] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [138.573345] [060/171] (873s left) kms_addfb_basic (addfb25-y-tiled-legacy) [138.959339] Starting subtest: addfb25-y-tiled-legacy [138.982235] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [139.098445] [061/171] (872s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [139.484341] Starting subtest: addfb25-y-tiled-small-legacy [139.504118] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [139.641596] [062/171] (872s left) kms_addfb_basic (bad-pitch-0) [139.933449] Starting subtest: bad-pitch-0 [139.952912] Subtest bad-pitch-0: SUCCESS (0.000s) [140.154757] [063/171] (872s left) kms_addfb_basic (bad-pitch-1024) [140.450890] Starting subtest: bad-pitch-1024 [140.472355] Subtest bad-pitch-1024: SUCCESS (0.000s) [140.677066] [064/171] (871s left) kms_addfb_basic (bad-pitch-128) [140.968648] Starting subtest: bad-pitch-128 [140.990710] Subtest bad-pitch-128: SUCCESS (0.000s) [141.202069] [065/171] (871s left) kms_addfb_basic (bad-pitch-256) [141.501779] Starting subtest: bad-pitch-256 [141.521211] Subtest bad-pitch-256: SUCCESS (0.000s) [141.721568] [066/171] (870s left) kms_addfb_basic (bad-pitch-32) [142.023463] Starting subtest: bad-pitch-32 [142.044643] Subtest bad-pitch-32: SUCCESS (0.000s) [142.233207] [067/171] (870s left) kms_addfb_basic (bad-pitch-63) [142.563858] Starting subtest: bad-pitch-63 [142.589353] Subtest bad-pitch-63: SUCCESS (0.000s) [142.794134] [068/171] (869s left) kms_addfb_basic (bad-pitch-65536) [143.122341] Starting subtest: bad-pitch-65536 [143.151362] Subtest bad-pitch-65536: SUCCESS (0.001s) [143.355166] [069/171] (869s left) kms_addfb_basic (bad-pitch-999) [143.678692] Starting subtest: bad-pitch-999 [143.703874] Subtest bad-pitch-999: SUCCESS (0.000s) [143.890830] [070/171] (869s left) kms_addfb_basic (basic) [144.184729] Starting subtest: basic [144.206765] Subtest basic: SUCCESS (0.000s) [144.403849] [071/171] (868s left) kms_addfb_basic (basic-x-tiled-legacy) [144.699033] Starting subtest: basic-x-tiled-legacy [144.718708] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [144.919170] [072/171] (868s left) kms_addfb_basic (basic-y-tiled-legacy) [145.211926] Starting subtest: basic-y-tiled-legacy [145.233121] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [145.437484] [073/171] (867s left) kms_addfb_basic (bo-too-small) [145.817252] Starting subtest: bo-too-small [145.837182] Subtest bo-too-small: SUCCESS (0.001s) [145.952476] [074/171] (867s left) kms_addfb_basic (bo-too-small-due-to-tiling) [146.336908] Starting subtest: bo-too-small-due-to-tiling [146.357163] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [146.472181] [075/171] (867s left) kms_addfb_basic (clobberred-modifier) [146.766301] Starting subtest: clobberred-modifier [146.786518] Subtest clobberred-modifier: SUCCESS (0.000s) [146.988671] [076/171] (866s left) kms_addfb_basic (framebuffer-vs-set-tiling) [147.280314] Starting subtest: framebuffer-vs-set-tiling [147.302537] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [147.501147] [077/171] (866s left) kms_addfb_basic (invalid-get-prop) [147.795153] Starting subtest: invalid-get-prop [147.814720] Subtest invalid-get-prop: SUCCESS (0.000s) [148.019244] [078/171] (865s left) kms_addfb_basic (invalid-get-prop-any) [148.312217] Starting subtest: invalid-get-prop-any [148.334321] Subtest invalid-get-prop-any: SUCCESS (0.000s) [148.533343] [079/171] (865s left) kms_addfb_basic (invalid-set-prop) [148.825606] Starting subtest: invalid-set-prop [148.844907] Subtest invalid-set-prop: SUCCESS (0.000s) [149.038294] [080/171] (864s left) kms_addfb_basic (invalid-set-prop-any) [149.331119] Starting subtest: invalid-set-prop-any [149.353114] Subtest invalid-set-prop-any: SUCCESS (0.000s) [149.569123] [081/171] (864s left) kms_addfb_basic (no-handle) [149.866739] Starting subtest: no-handle [149.886389] Subtest no-handle: SUCCESS (0.000s) [150.087554] [082/171] (864s left) kms_addfb_basic (size-max) [150.465616] Starting subtest: size-max [150.493350] Subtest size-max: SUCCESS (0.000s) [150.608868] [083/171] (863s left) kms_addfb_basic (small-bo) [150.992702] Starting subtest: small-bo [151.014929] Subtest small-bo: SUCCESS (0.000s) [151.136290] [084/171] (863s left) kms_addfb_basic (tile-pitch-mismatch) [151.426352] Starting subtest: tile-pitch-mismatch [151.446597] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [151.643247] [085/171] (862s left) kms_addfb_basic (too-high) [152.010710] Starting subtest: too-high [152.035027] Subtest too-high: SUCCESS (0.002s) [152.184123] [086/171] (862s left) kms_addfb_basic (too-wide) [152.558569] Starting subtest: too-wide [152.581454] Subtest too-wide: SUCCESS (0.000s) [152.710340] [087/171] (862s left) kms_addfb_basic (unused-handle) [153.022333] Starting subtest: unused-handle [153.045221] Subtest unused-handle: SUCCESS (0.000s) [153.246753] [088/171] (861s left) kms_addfb_basic (unused-modifier) [153.551233] Starting subtest: unused-modifier [153.577569] Subtest unused-modifier: SUCCESS (0.000s) [153.774497] [089/171] (861s left) kms_addfb_basic (unused-offsets) [154.080042] Starting subtest: unused-offsets [154.099502] Subtest unused-offsets: SUCCESS (0.000s) [154.304426] [090/171] (860s left) kms_addfb_basic (unused-pitches) [154.595321] Starting subtest: unused-pitches [154.617183] Subtest unused-pitches: SUCCESS (0.000s) [154.818077] [091/171] (860s left) kms_busy (basic) [155.203157] Starting subtest: basic [155.222621] Starting dynamic subtest: flip [156.249296] Dynamic subtest flip: SUCCESS (1.037s) [156.288163] Starting dynamic subtest: modeset [157.743254] Dynamic subtest modeset: SUCCESS (1.493s) [157.762612] Subtest basic: SUCCESS (2.534s) [158.145311] [092/171] (857s left) kms_chamelium_hpd (dp-hpd-fast) [158.646118] Subtest dp-hpd-fast: SKIP (0.000s) [158.973248] [093/171] (856s left) kms_chamelium_edid (dp-edid-read) [159.473716] Subtest dp-edid-read: SKIP (0.000s) [159.809896] [094/171] (855s left) kms_chamelium_frames (dp-crc-fast) [160.310642] Subtest dp-crc-fast: SKIP (0.000s) [160.687112] [095/171] (855s left) kms_chamelium_hpd (hdmi-hpd-fast) [161.196246] Subtest hdmi-hpd-fast: SKIP (0.000s) [161.538462] [096/171] (854s left) kms_chamelium_edid (hdmi-edid-read) [162.014100] Subtest hdmi-edid-read: SKIP (0.000s) [162.365346] [097/171] (853s left) kms_chamelium_frames (hdmi-crc-fast) [162.847497] Subtest hdmi-crc-fast: SKIP (0.000s) [163.188860] [098/171] (852s left) kms_chamelium_hpd (vga-hpd-fast) [163.685224] Subtest vga-hpd-fast: SKIP (0.000s) [164.034960] [099/171] (852s left) kms_chamelium_edid (vga-edid-read) [164.530208] Subtest vga-edid-read: SKIP (0.000s) [164.870240] [100/171] (851s left) kms_prop_blob (basic) [165.168640] Starting subtest: basic [165.191798] Subtest basic: SUCCESS (0.000s) [165.305894] [101/171] (851s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [165.696965] Starting subtest: basic-busy-flip-before-cursor-atomic [165.739245] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [165.854202] [102/171] (850s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [166.237461] Starting subtest: basic-busy-flip-before-cursor-legacy [166.279203] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [166.392258] [103/171] (850s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [166.754805] Starting subtest: basic-flip-after-cursor-atomic [167.839124] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.072s) [168.213330] [104/171] (848s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [168.596546] Starting subtest: basic-flip-after-cursor-legacy [169.652915] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.060s) [170.036785] [105/171] (846s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [170.409088] Starting subtest: basic-flip-after-cursor-varying-size [171.473785] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.064s) [171.858705] [106/171] (845s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [172.236104] Starting subtest: basic-flip-before-cursor-atomic [173.314486] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.075s) [173.702449] [107/171] (843s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [174.087452] Starting subtest: basic-flip-before-cursor-legacy [175.145604] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.074s) [175.534948] [108/171] (841s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [175.922121] Starting subtest: basic-flip-before-cursor-varying-size [176.992939] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.066s) [177.366759] [109/171] (839s left) kms_flip (basic-flip-vs-dpms) [177.756027] Starting subtest: basic-flip-vs-dpms [177.775628] Starting dynamic subtest: A-DP1 [179.036098] Dynamic subtest A-DP1: SUCCESS (1.310s) [179.077374] Starting dynamic subtest: B-DP1 [180.194513] Dynamic subtest B-DP1: SUCCESS (1.155s) [180.237224] Starting dynamic subtest: C-DP1 [181.369538] Dynamic subtest C-DP1: SUCCESS (1.170s) [181.390743] Subtest basic-flip-vs-dpms: SUCCESS (3.647s) [181.804089] [110/171] (835s left) kms_flip (basic-flip-vs-modeset) [182.185722] Starting subtest: basic-flip-vs-modeset [182.205234] Starting dynamic subtest: A-DP1 [183.453907] Dynamic subtest A-DP1: SUCCESS (1.295s) [183.494621] Starting dynamic subtest: B-DP1 [184.598028] Dynamic subtest B-DP1: SUCCESS (1.143s) [184.636381] Starting dynamic subtest: C-DP1 [185.757477] Dynamic subtest C-DP1: SUCCESS (1.141s) [185.780769] Subtest basic-flip-vs-modeset: SUCCESS (3.589s) [186.161157] [111/171] (831s left) kms_flip (basic-flip-vs-wf_vblank) [186.549540] Starting subtest: basic-flip-vs-wf_vblank [186.572128] Starting dynamic subtest: A-DP1 [187.985036] Dynamic subtest A-DP1: SUCCESS (1.453s) [188.025540] Starting dynamic subtest: B-DP1 [189.396996] Dynamic subtest B-DP1: SUCCESS (1.403s) [189.440705] Starting dynamic subtest: C-DP1 [190.803220] Dynamic subtest C-DP1: SUCCESS (1.401s) [190.831328] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.269s) [191.276604] [112/171] (826s left) kms_flip (basic-plain-flip) [191.661688] Starting subtest: basic-plain-flip [191.682614] Starting dynamic subtest: A-DP1 [192.823040] Dynamic subtest A-DP1: SUCCESS (1.187s) [192.864384] Starting dynamic subtest: B-DP1 [193.943287] Dynamic subtest B-DP1: SUCCESS (1.115s) [193.981503] Starting dynamic subtest: C-DP1 [195.060167] Dynamic subtest C-DP1: SUCCESS (1.118s) [195.082363] Subtest basic-plain-flip: SUCCESS (3.432s) [195.560545] [113/171] (822s left) kms_force_connector_basic (force-connector-state) [195.890166] Subtest force-connector-state: SKIP (0.000s) [196.005799] [114/171] (821s left) kms_force_connector_basic (force-edid) [196.325063] Subtest force-edid: SKIP (0.000s) [196.440558] [115/171] (821s left) kms_force_connector_basic (force-load-detect) [196.754120] Subtest force-load-detect: SKIP (0.000s) [196.868465] [116/171] (821s left) kms_force_connector_basic (prune-stale-modes) [197.178597] Subtest prune-stale-modes: SKIP (0.000s) [197.293382] [117/171] (820s left) kms_frontbuffer_tracking (basic) [197.750145] Starting subtest: basic [200.689452] Subtest basic: SUCCESS (3.008s) [200.859390] [118/171] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [201.253854] Starting subtest: compare-crc-sanitycheck-xr24 [201.275802] Starting dynamic subtest: pipe-A-DP-1 [201.674357] Dynamic subtest pipe-A-DP-1: SUCCESS (0.430s) [201.717777] Starting dynamic subtest: pipe-B-DP-1 [202.391758] Dynamic subtest pipe-B-DP-1: SUCCESS (0.715s) [202.442479] Starting dynamic subtest: pipe-C-DP-1 [203.253797] Dynamic subtest pipe-C-DP-1: SUCCESS (0.855s) [203.276820] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.015s) [203.650477] [119/171] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [204.040238] Starting subtest: compare-crc-sanitycheck-nv12 [204.062691] Starting dynamic subtest: pipe-A-DP-1 [204.103671] Dynamic subtest pipe-A-DP-1: SKIP (0.001s) [204.141580] Starting dynamic subtest: pipe-B-DP-1 [204.185396] Dynamic subtest pipe-B-DP-1: SKIP (0.001s) [204.224203] Starting dynamic subtest: pipe-C-DP-1 [204.265819] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [204.307092] Subtest compare-crc-sanitycheck-nv12: SKIP (0.018s) [204.422063] [120/171] (814s left) kms_pipe_crc_basic (hang-read-crc) [204.811483] Starting subtest: hang-read-crc [204.833566] Starting dynamic subtest: pipe-A-DP-1 [206.293407] Dynamic subtest pipe-A-DP-1: SUCCESS (1.482s) [206.332836] Starting dynamic subtest: pipe-B-DP-1 [208.183209] Dynamic subtest pipe-B-DP-1: SUCCESS (1.883s) [208.223685] Starting dynamic subtest: pipe-C-DP-1 [210.323656] Dynamic subtest pipe-C-DP-1: SUCCESS (2.145s) [210.346307] Subtest hang-read-crc: SUCCESS (5.524s) [210.712858] [121/171] (808s left) kms_pipe_crc_basic (nonblocking-crc) [211.119297] Starting subtest: nonblocking-crc [211.145425] Starting dynamic subtest: pipe-A-DP-1 [211.695648] Dynamic subtest pipe-A-DP-1: SUCCESS (0.593s) [211.750610] Starting dynamic subtest: pipe-B-DP-1 [212.578832] Dynamic subtest pipe-B-DP-1: SUCCESS (0.870s) [212.621550] Starting dynamic subtest: pipe-C-DP-1 [213.598883] Dynamic subtest pipe-C-DP-1: SUCCESS (1.011s) [213.618367] Subtest nonblocking-crc: SUCCESS (2.488s) [213.954739] [122/171] (804s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [214.318449] Starting subtest: nonblocking-crc-frame-sequence [214.338355] Starting dynamic subtest: pipe-A-DP-1 [214.931814] Dynamic subtest pipe-A-DP-1: SUCCESS (0.592s) [214.978075] Starting dynamic subtest: pipe-B-DP-1 [215.801083] Dynamic subtest pipe-B-DP-1: SUCCESS (0.877s) [215.842928] Starting dynamic subtest: pipe-C-DP-1 [216.813808] Dynamic subtest pipe-C-DP-1: SUCCESS (0.996s) [216.834611] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.480s) [217.180177] [123/171] (801s left) kms_pipe_crc_basic (read-crc) [217.571520] Starting subtest: read-crc [217.593293] Starting dynamic subtest: pipe-A-DP-1 [218.072124] Dynamic subtest pipe-A-DP-1: SUCCESS (0.497s) [218.116245] Starting dynamic subtest: pipe-B-DP-1 [218.868408] Dynamic subtest pipe-B-DP-1: SUCCESS (0.794s) [218.907021] Starting dynamic subtest: pipe-C-DP-1 [219.814633] Dynamic subtest pipe-C-DP-1: SUCCESS (0.934s) [219.845432] Subtest read-crc: SUCCESS (2.241s) [220.199478] [124/171] (798s left) kms_pipe_crc_basic (read-crc-frame-sequence) [220.603112] Starting subtest: read-crc-frame-sequence [220.627393] Starting dynamic subtest: pipe-A-DP-1 [221.117232] Dynamic subtest pipe-A-DP-1: SUCCESS (0.519s) [221.173955] Starting dynamic subtest: pipe-B-DP-1 [221.919261] Dynamic subtest pipe-B-DP-1: SUCCESS (0.814s) [221.958957] Starting dynamic subtest: pipe-C-DP-1 [222.896624] Dynamic subtest pipe-C-DP-1: SUCCESS (0.952s) [222.916126] Subtest read-crc-frame-sequence: SUCCESS (2.300s) [223.256657] [125/171] (795s left) kms_psr (primary_page_flip) [223.583104] Subtest primary_page_flip: SKIP (0.000s) [223.700198] [126/171] (795s left) kms_psr (cursor_plane_move) [224.016241] Subtest cursor_plane_move: SKIP (0.000s) [224.132436] [127/171] (795s left) kms_psr (sprite_plane_onoff) [224.446936] Subtest sprite_plane_onoff: SKIP (0.000s) [224.563676] [128/171] (794s left) kms_psr (primary_mmap_gtt) [224.878671] Subtest primary_mmap_gtt: SKIP (0.000s) [224.996929] [129/171] (794s left) kms_setmode (basic-clone-single-crtc) [225.303847] Starting subtest: basic-clone-single-crtc [225.367065] Subtest basic-clone-single-crtc: SKIP (0.000s) [225.483695] [130/171] (794s left) i915_pm_backlight (basic-brightness) [225.896663] Subtest basic-brightness: SKIP (0.000s) [226.015718] [131/171] (793s left) i915_pm_rpm (basic-pci-d3-state) [227.970721] Starting subtest: basic-pci-d3-state [228.696333] Subtest basic-pci-d3-state: SUCCESS (0.722s) [228.984358] [132/171] (791s left) i915_pm_rpm (basic-rte) [229.264130] Starting subtest: basic-rte [231.713198] Subtest basic-rte: SUCCESS (2.461s) [232.827313] [133/171] (787s left) i915_pm_rps (basic-api) [233.138059] Starting subtest: basic-api [233.157947] Subtest basic-api: SUCCESS (0.007s) [233.304640] [134/171] (786s left) prime_self_import (basic-llseek-bad) [233.588241] Starting subtest: basic-llseek-bad [233.629042] Subtest basic-llseek-bad: SUCCESS (0.004s) [233.746953] [135/171] (786s left) prime_self_import (basic-llseek-size) [234.025435] Starting subtest: basic-llseek-size [234.068989] Subtest basic-llseek-size: SUCCESS (0.006s) [234.186133] [136/171] (786s left) prime_self_import (basic-with_fd_dup) [234.459693] Starting subtest: basic-with_fd_dup [234.503139] Subtest basic-with_fd_dup: SUCCESS (0.007s) [234.620973] [137/171] (786s left) prime_self_import (basic-with_one_bo) [234.895565] Starting subtest: basic-with_one_bo [234.936275] Subtest basic-with_one_bo: SUCCESS (0.008s) [235.053546] [138/171] (785s left) prime_self_import (basic-with_one_bo_two_files) [235.330639] Starting subtest: basic-with_one_bo_two_files [235.371758] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s) [235.488565] [139/171] (785s left) prime_self_import (basic-with_two_bos) [235.766604] Starting subtest: basic-with_two_bos [235.809558] Subtest basic-with_two_bos: SUCCESS (0.007s) [235.926269] [140/171] (785s left) prime_vgem (basic-fence-flip) [236.249651] Starting subtest: basic-fence-flip [236.819924] Subtest basic-fence-flip: SUCCESS (0.603s) [236.972516] [141/171] (784s left) prime_vgem (basic-fence-mmap) [237.295127] Starting subtest: basic-fence-mmap [237.315421] Subtest basic-fence-mmap: SUCCESS (0.069s) [237.454458] [142/171] (783s left) prime_vgem (basic-fence-read) [237.792256] Starting subtest: basic-fence-read [237.855388] Subtest basic-fence-read: SUCCESS (0.111s) [238.007817] [143/171] (783s left) prime_vgem (basic-gtt) [238.326847] Starting subtest: basic-gtt [238.347192] Subtest basic-gtt: SUCCESS (0.032s) [238.486525] [144/171] (782s left) prime_vgem (basic-read) [238.805211] Starting subtest: basic-read [238.831567] Subtest basic-read: SUCCESS (0.050s) [239.000067] [145/171] (782s left) prime_vgem (basic-write) [239.357209] Starting subtest: basic-write [239.385099] Subtest basic-write: SUCCESS (0.063s) [239.551994] [146/171] (782s left) vgem_basic (setversion) [239.889714] Starting subtest: setversion [239.929406] Subtest setversion: SUCCESS (0.000s) [240.045115] [147/171] (781s left) vgem_basic (create) [240.340410] Starting subtest: create [240.361306] Subtest create: SUCCESS (0.000s) [240.478068] [148/171] (781s left) vgem_basic (debugfs) [240.777713] Starting subtest: debugfs [240.799540] Subtest debugfs: SUCCESS (0.001s) [240.916440] [149/171] (781s left) vgem_basic (dmabuf-export) [241.211810] Starting subtest: dmabuf-export [241.256811] Subtest dmabuf-export: SUCCESS (0.008s) [241.381054] [150/171] (780s left) vgem_basic (dmabuf-fence) [241.674965] Starting subtest: dmabuf-fence [241.698182] Subtest dmabuf-fence: SUCCESS (0.001s) [241.814927] [151/171] (780s left) vgem_basic (dmabuf-fence-before) [242.110819] Starting subtest: dmabuf-fence-before [242.130989] Subtest dmabuf-fence-before: SUCCESS (0.001s) [242.250725] [152/171] (780s left) vgem_basic (dmabuf-mmap) [242.545282] Starting subtest: dmabuf-mmap [242.565383] Subtest dmabuf-mmap: SUCCESS (0.043s) [242.689076] [153/171] (779s left) vgem_basic (mmap) [243.006994] Starting subtest: mmap [243.027329] Subtest mmap: SUCCESS (0.026s) [243.144909] [154/171] (779s left) vgem_basic (second-client) [243.440039] Starting subtest: second-client [243.480886] Subtest second-client: SUCCESS (0.032s) [243.600252] [155/171] (779s left) vgem_basic (sysfs) [243.898443] Starting subtest: sysfs [243.919067] Subtest sysfs: SUCCESS (0.001s) [244.036074] [156/171] (778s left) core_hotunplug (unbind-rebind) [244.424504] Starting subtest: unbind-rebind [246.550130] Subtest unbind-rebind: SUCCESS (2.121s) [246.681632] [157/171] (776s left) vgem_basic (unload) [246.965541] Starting subtest: unload [276.156746] Subtest unload: SUCCESS (29.016s) [276.251706] [158/171] (746s left) i915_module_load (reload) [276.531349] Starting subtest: reload [280.328857] Subtest reload: SUCCESS (3.817s) [280.448988] [159/171] (742s left) gem_lmem_swapping (basic) [280.815336] Subtest basic: SKIP (0.000s) [280.928876] [160/171] (742s left) gem_lmem_swapping (parallel-random-engines) [281.245149] Subtest parallel-random-engines: SKIP (0.000s) [281.360046] [161/171] (742s left) gem_lmem_swapping (random-engines) [281.678033] Subtest random-engines: SKIP (0.000s) [281.792229] [162/171] (741s left) gem_lmem_swapping (verify-random) [282.106641] Subtest verify-random: SKIP (0.000s) [282.221610] [163/171] (741s left) i915_pm_rpm (module-reload) [284.563425] Starting subtest: module-reload [295.832887] Subtest module-reload: SUCCESS (11.274s) [295.945732] [164/171] (727s left) i915_selftest (live) [296.246082] Starting subtest: live [296.268310] Starting dynamic subtest: sanitycheck [297.753132] Dynamic subtest sanitycheck: SUCCESS (1.505s) [297.790272] Starting dynamic subtest: uncore [299.267235] Dynamic subtest uncore: SUCCESS (1.511s) [299.315496] Starting dynamic subtest: workarounds [301.122402] Dynamic subtest workarounds: SUCCESS (1.850s) [301.156563] Starting dynamic subtest: gt_engines [303.120137] Dynamic subtest gt_engines: SUCCESS (1.995s) [303.154262] Starting dynamic subtest: gt_timelines [326.523509] Dynamic subtest gt_timelines: SUCCESS (23.402s) [326.568893] Starting dynamic subtest: gt_contexts [328.216908] Dynamic subtest gt_contexts: SUCCESS (1.683s) [328.255647] Starting dynamic subtest: gt_lrc [332.622212] Dynamic subtest gt_lrc: SUCCESS (4.407s) [332.657738] Starting dynamic subtest: gt_mocs [334.342440] Dynamic subtest gt_mocs: SUCCESS (1.717s) [334.387768] Starting dynamic subtest: gt_pm [343.119659] Dynamic subtest gt_pm: SUCCESS (8.773s) [343.154574] Starting dynamic subtest: gt_heartbeat [344.799320] Dynamic subtest gt_heartbeat: SUCCESS (1.670s) [344.846565] Starting dynamic subtest: gt_tlb [347.176470] Dynamic subtest gt_tlb: SUCCESS (2.377s) [347.213475] Starting dynamic subtest: requests [355.179408] Dynamic subtest requests: SUCCESS (8.002s) [355.226725] Starting dynamic subtest: migrate [359.970047] Dynamic subtest migrate: SUCCESS (4.786s) [360.016992] Starting dynamic subtest: active [361.585167] Dynamic subtest active: SUCCESS (1.612s) [361.620536] Starting dynamic subtest: objects [366.108683] Dynamic subtest objects: SUCCESS (4.521s) [366.146495] Starting dynamic subtest: mman [375.194418] Dynamic subtest mman: SUCCESS (9.080s) [375.229981] Starting dynamic subtest: dmabuf [376.796756] Dynamic subtest dmabuf: SUCCESS (1.601s) [376.831603] Starting dynamic subtest: vma [378.356097] Dynamic subtest vma: SUCCESS (1.555s) [378.402907] Starting dynamic subtest: coherency [382.573891] Dynamic subtest coherency: SUCCESS (4.208s) [382.626634] Starting dynamic subtest: gtt [391.975601] Dynamic subtest gtt: SUCCESS (9.407s) [392.010492] Starting dynamic subtest: gem [394.991716] Dynamic subtest gem: SUCCESS (3.010s) [395.027324] Starting dynamic subtest: evict [401.176617] Dynamic subtest evict: SUCCESS (6.182s) [401.213818] Starting dynamic subtest: hugepages [409.539794] Dynamic subtest hugepages: SUCCESS (8.360s) [409.587289] Starting dynamic subtest: gem_contexts [434.672761] Dynamic subtest gem_contexts: SUCCESS (24.943s) [434.715159] Starting dynamic subtest: client [436.119824] Dynamic subtest client: SUCCESS (1.626s) [436.164496] Starting dynamic subtest: gem_migrate [437.661687] Dynamic subtest gem_migrate: SUCCESS (1.544s) [437.710972] Starting dynamic subtest: reset [451.176678] Dynamic subtest reset: SUCCESS (13.513s) [451.212293] Starting dynamic subtest: memory_region [452.720656] Dynamic subtest memory_region: SUCCESS (1.538s) [452.765535] Starting dynamic subtest: hangcheck [477.571806] Dynamic subtest hangcheck: SUCCESS (24.850s) [477.610653] Starting dynamic subtest: execlists [489.952587] Dynamic subtest execlists: SUCCESS (12.376s) [489.988520] Starting dynamic subtest: ring_submission [491.552236] Dynamic subtest ring_submission: SUCCESS (1.598s) [491.598651] Starting dynamic subtest: perf [493.190971] Dynamic subtest perf: SUCCESS (1.629s) [493.226873] Starting dynamic subtest: slpc [494.702959] Dynamic subtest slpc: SUCCESS (1.516s) [494.739371] Starting dynamic subtest: guc [496.295243] Dynamic subtest guc: SUCCESS (1.589s) [496.344540] Starting dynamic subtest: guc_multi_lrc [497.855058] Dynamic subtest guc_multi_lrc: SUCCESS (1.552s) [497.898971] Starting dynamic subtest: guc_hang [499.405171] Dynamic subtest guc_hang: SUCCESS (1.551s) [499.452920] Starting dynamic subtest: late_gt_pm [501.082125] Dynamic subtest late_gt_pm: SUCCESS (1.675s) [501.114698] Subtest live: SUCCESS (204.835s) [501.333239] [165/171] (522s left) dmabuf (all-tests) [501.602399] Starting subtest: all-tests [501.622069] Starting dynamic subtest: sanitycheck [501.691174] Dynamic subtest sanitycheck: SUCCESS (0.088s) [501.725957] Starting dynamic subtest: dma_fence [501.882588] Dynamic subtest dma_fence: SUCCESS (0.188s) [501.917707] Starting dynamic subtest: dma_fence_chain [525.219180] Dynamic subtest dma_fence_chain: SUCCESS (23.333s) [525.260424] Starting dynamic subtest: dma_fence_unwrap [525.306333] Dynamic subtest dma_fence_unwrap: SUCCESS (0.074s) [525.341470] Starting dynamic subtest: dma_resv [525.388626] Dynamic subtest dma_resv: SUCCESS (0.067s) [525.408937] Subtest all-tests: SUCCESS (23.768s) [525.500644] [166/171] (498s left) i915_suspend (basic-s2idle-without-i915) [525.784373] Starting subtest: basic-s2idle-without-i915 [546.783459] Subtest basic-s2idle-without-i915: SUCCESS (5.996s) [549.517394] [167/171] (491s left) i915_suspend (basic-s3-without-i915) [549.799845] Starting subtest: basic-s3-without-i915 [568.487422] Subtest basic-s3-without-i915: SUCCESS (4.097s) [573.251101] [168/171] (487s left) gem_exec_suspend (basic-s0) [573.592598] Starting subtest: basic-S0 [573.615523] Starting dynamic subtest: smem [595.298911] Dynamic subtest smem: SUCCESS (6.017s) [595.318898] Subtest basic-S0: SUCCESS (6.020s) [597.019229] [169/171] (480s left) gem_exec_suspend (basic-s3) [597.324868] Starting subtest: basic-S3 [597.344386] Starting dynamic subtest: smem [618.105233] Dynamic subtest smem: SUCCESS (5.807s) [618.124784] Subtest basic-S3: SUCCESS (5.810s) [621.488592] [170/171] (474s left) kms_chamelium_hpd (common-hpd-after-suspend) [621.987882] Subtest common-hpd-after-suspend: SKIP (0.000s) [622.328375] [171/171] (473s left) kms_pipe_crc_basic (suspend-read-crc) [622.713008] Starting subtest: suspend-read-crc [622.732482] Starting dynamic subtest: pipe-A-DP-1 [642.235388] Dynamic subtest pipe-A-DP-1: SUCCESS (2.629s) [642.380844] Starting dynamic subtest: pipe-B-DP-1 [660.325911] Dynamic subtest pipe-B-DP-1: SUCCESS (2.911s) [660.441618] Starting dynamic subtest: pipe-C-DP-1 [679.469447] Dynamic subtest pipe-C-DP-1: SUCCESS (3.137s) [679.490753] Subtest suspend-read-crc: SUCCESS (8.886s) [681.910239] Closing watchdogs Done.