[44.983488] Initializing watchdogs [44.983597] /dev/watchdog0 [44.989452] [001/171] (960s left) i915_module_load (load) [45.050591] Starting subtest: load [45.946731] Subtest load: SUCCESS (0.896s) [45.968366] [002/171] (959s left) core_auth (basic-auth) [46.070548] Starting subtest: basic-auth [46.071671] Subtest basic-auth: SUCCESS (0.000s) [46.127525] [003/171] (959s left) debugfs_test (read_all_entries) [46.187909] Starting subtest: read_all_entries [46.229907] Subtest read_all_entries: SUCCESS (0.042s) [46.310301] [004/171] (959s left) debugfs_test (basic-hwmon) [46.368357] Starting subtest: basic-hwmon [46.370331] Subtest basic-hwmon: SKIP (0.000s) [46.440304] [005/171] (959s left) fbdev (eof) [46.513243] Starting subtest: eof [46.514493] Subtest eof: SUCCESS (0.000s) [46.556703] [006/171] (958s left) fbdev (info) [46.611696] Starting subtest: info [46.612709] Subtest info: SUCCESS (0.000s) [46.656582] [007/171] (958s left) fbdev (nullptr) [46.713741] Starting subtest: nullptr [46.715064] Subtest nullptr: SUCCESS (0.000s) [46.758955] [008/171] (958s left) fbdev (read) [46.830129] Starting subtest: read [46.911716] Subtest read: SUCCESS (0.081s) [46.956850] [009/171] (958s left) fbdev (write) [47.013132] Starting subtest: write [47.054598] Subtest write: SUCCESS (0.042s) [47.091818] [010/171] (958s left) gem_basic (bad-close) [47.149363] Starting subtest: bad-close [47.151411] Subtest bad-close: SUCCESS (0.000s) [47.206264] [011/171] (958s left) gem_basic (create-close) [47.264226] Starting subtest: create-close [47.266349] Subtest create-close: SUCCESS (0.000s) [47.340427] [012/171] (958s left) gem_basic (create-fd-close) [47.397217] Starting subtest: create-fd-close [47.399346] Subtest create-fd-close: SUCCESS (0.000s) [47.456411] [013/171] (958s left) gem_busy (busy@all-engines) [47.520206] Starting subtest: busy [47.521236] Starting dynamic subtest: all-engines [47.539569] Dynamic subtest all-engines: SUCCESS (0.019s) [47.540562] Subtest busy: SUCCESS (0.019s) [47.840420] [014/171] (957s left) gem_close_race (basic-process) [47.907365] Starting subtest: basic-process [47.939247] Subtest basic-process: SUCCESS (0.031s) [48.110641] [015/171] (957s left) gem_close_race (basic-threads) [48.177668] Starting subtest: basic-threads [49.319983] Subtest basic-threads: SUCCESS (1.141s) [49.475339] [016/171] (956s left) gem_ctx_create (basic) [49.538181] Starting subtest: basic [49.539380] Subtest basic: SUCCESS (0.000s) [49.690352] [017/171] (955s left) gem_ctx_create (basic-files) [49.751677] Starting subtest: basic-files [51.761250] Subtest basic-files: SUCCESS (2.010s) [51.973295] [018/171] (953s left) gem_ctx_exec (basic) [52.033307] Starting subtest: basic [52.036649] Subtest basic: SUCCESS (0.004s) [52.103865] [019/171] (953s left) gem_exec_basic (basic) [52.165539] Starting subtest: basic [52.166526] Starting dynamic subtest: rcs0-smem [52.167674] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [52.172945] Starting dynamic subtest: bcs0-smem [52.174057] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [52.179972] Starting dynamic subtest: vcs0-smem [52.181038] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [52.187043] Starting dynamic subtest: vecs0-smem [52.188218] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [52.189340] Subtest basic: SUCCESS (0.003s) [52.323443] [020/171] (953s left) gem_exec_create (basic) [52.385568] Starting subtest: basic [52.386686] Starting dynamic subtest: smem [54.425048] Dynamic subtest smem: SUCCESS (2.039s) [54.426473] Subtest basic: SUCCESS (2.039s) [54.593898] [021/171] (951s left) gem_exec_fence (basic-busy) [54.767160] Starting subtest: basic-busy [54.768276] Starting dynamic subtest: rcs0 [54.793385] Dynamic subtest rcs0: SUCCESS (0.026s) [54.799101] Starting dynamic subtest: bcs0 [54.817218] Dynamic subtest bcs0: SUCCESS (0.023s) [54.822956] Starting dynamic subtest: vcs0 [54.841302] Dynamic subtest vcs0: SUCCESS (0.024s) [54.847921] Starting dynamic subtest: vecs0 [54.859420] Dynamic subtest vecs0: SUCCESS (0.018s) [54.861189] Subtest basic-busy: SUCCESS (0.092s) [55.289726] [022/171] (950s left) gem_exec_fence (basic-wait) [55.461327] Starting subtest: basic-wait [55.462402] Starting dynamic subtest: rcs0 [55.486053] Dynamic subtest rcs0: SUCCESS (0.024s) [55.491756] Starting dynamic subtest: bcs0 [55.513118] Dynamic subtest bcs0: SUCCESS (0.027s) [55.519164] Starting dynamic subtest: vcs0 [55.536246] Dynamic subtest vcs0: SUCCESS (0.023s) [55.541784] Starting dynamic subtest: vecs0 [55.565547] Dynamic subtest vecs0: SUCCESS (0.029s) [55.566987] Subtest basic-wait: SUCCESS (0.104s) [55.972907] [023/171] (949s left) gem_exec_fence (basic-await) [56.147861] Starting subtest: basic-await [56.148956] Starting dynamic subtest: rcs0 [56.213231] Dynamic subtest rcs0: SUCCESS (0.065s) [56.218357] Starting dynamic subtest: bcs0 [56.277698] Dynamic subtest bcs0: SUCCESS (0.064s) [56.282739] Starting dynamic subtest: vcs0 [56.342640] Dynamic subtest vcs0: SUCCESS (0.065s) [56.347885] Starting dynamic subtest: vecs0 [56.407151] Dynamic subtest vecs0: SUCCESS (0.064s) [56.408266] Subtest basic-await: SUCCESS (0.259s) [56.825302] [024/171] (948s left) gem_exec_fence (nb-await) [56.997559] Starting subtest: nb-await [56.998677] Starting dynamic subtest: rcs0 [57.051184] Dynamic subtest rcs0: SUCCESS (0.054s) [57.056921] Starting dynamic subtest: bcs0 [57.105305] Dynamic subtest bcs0: SUCCESS (0.054s) [57.111098] Starting dynamic subtest: vcs0 [57.158284] Dynamic subtest vcs0: SUCCESS (0.053s) [57.163890] Starting dynamic subtest: vecs0 [57.211869] Dynamic subtest vecs0: SUCCESS (0.053s) [57.213215] Subtest nb-await: SUCCESS (0.214s) [57.623330] [025/171] (948s left) gem_exec_gttfill (basic) [57.687901] Starting subtest: basic [60.672761] Subtest basic: SUCCESS (2.984s) [60.838083] [026/171] (944s left) gem_exec_parallel (engines) [60.963536] Starting subtest: engines [60.964556] Starting dynamic subtest: basic [62.345827] Dynamic subtest basic: SUCCESS (1.382s) [62.352215] Starting dynamic subtest: contexts [63.897832] Dynamic subtest contexts: SUCCESS (1.552s) [63.904400] Starting dynamic subtest: fds [65.628025] Dynamic subtest fds: SUCCESS (1.730s) [65.633971] Starting dynamic subtest: userptr [67.100790] Dynamic subtest userptr: SUCCESS (1.472s) [67.102074] Subtest engines: SUCCESS (6.137s) [67.254710] [027/171] (938s left) gem_exec_store (basic) [67.317947] Starting subtest: basic [67.355201] Subtest basic: SUCCESS (0.037s) [67.522220] [028/171] (938s left) gem_flink_basic (bad-flink) [67.581096] Starting subtest: bad-flink [67.582103] Subtest bad-flink: SUCCESS (0.000s) [67.636795] [029/171] (938s left) gem_flink_basic (bad-open) [67.694163] Starting subtest: bad-open [67.695176] Subtest bad-open: SUCCESS (0.000s) [67.755316] [030/171] (938s left) gem_flink_basic (basic) [67.812770] Starting subtest: basic [67.813855] Subtest basic: SUCCESS (0.000s) [67.886986] [031/171] (937s left) gem_flink_basic (double-flink) [67.942073] Starting subtest: double-flink [67.943184] Subtest double-flink: SUCCESS (0.000s) [68.002433] [032/171] (937s left) gem_flink_basic (flink-lifetime) [68.057827] Starting subtest: flink-lifetime [68.058901] Subtest flink-lifetime: SUCCESS (0.001s) [68.136496] [033/171] (937s left) gem_huc_copy (huc-copy) [68.195718] Subtest huc-copy: SKIP (0.000s) [68.215511] [034/171] (937s left) gem_linear_blits (basic) [68.349539] Starting subtest: basic [68.355708] Subtest basic: SUCCESS (0.006s) [68.445484] [035/171] (937s left) gem_mmap (basic) [68.572241] Starting subtest: basic [68.577479] Subtest basic: SUCCESS (0.000s) [68.635652] [036/171] (937s left) gem_mmap_gtt (basic) [68.692150] Starting subtest: basic [68.693144] Subtest basic: SUCCESS (0.000s) [68.750866] [037/171] (937s left) gem_render_linear_blits (basic) [68.808628] Starting subtest: basic [68.829342] Subtest basic: SUCCESS (0.021s) [68.884336] [038/171] (937s left) gem_render_tiled_blits (basic) [68.942580] Starting subtest: basic [68.966071] Subtest basic: SUCCESS (0.023s) [69.017524] [039/171] (936s left) gem_ringfill (basic-all) [69.192917] Starting subtest: basic-all [70.295347] Subtest basic-all: SUCCESS (1.104s) [70.369363] [040/171] (935s left) gem_softpin (allocator-basic) [70.429928] Subtest allocator-basic: SKIP (0.000s) [70.486062] [041/171] (935s left) gem_softpin (allocator-basic-reserve) [70.546493] Subtest allocator-basic-reserve: SKIP (0.000s) [70.602384] [042/171] (935s left) gem_softpin (safe-alignment) [70.659337] Starting subtest: safe-alignment [70.666822] Subtest safe-alignment: SUCCESS (0.008s) [70.753606] [043/171] (935s left) gem_sync (basic-all) [70.817425] Starting subtest: basic-all [72.935976] Subtest basic-all: SUCCESS (2.118s) [73.103163] [044/171] (932s left) gem_sync (basic-each) [73.165699] Starting subtest: basic-each [75.235685] Subtest basic-each: SUCCESS (2.069s) [75.403317] [045/171] (930s left) gem_tiled_blits (basic) [75.525112] Starting subtest: basic [75.539188] Subtest basic: SUCCESS (0.015s) [75.644393] [046/171] (930s left) gem_tiled_fence_blits (basic) [75.835604] Starting subtest: basic [75.841252] Subtest basic: SUCCESS (0.006s) [75.941944] [047/171] (930s left) gem_tiled_pread_basic [76.217431] [048/171] (929s left) gem_wait (busy@all-engines) [76.282674] Starting subtest: busy [76.283789] Starting dynamic subtest: all-engines [76.795509] Dynamic subtest all-engines: SUCCESS (0.512s) [76.796607] Subtest busy: SUCCESS (0.513s) [76.968201] [049/171] (929s left) gem_wait (wait@all-engines) [77.032558] Starting subtest: wait [77.033710] Starting dynamic subtest: all-engines [78.047117] Dynamic subtest all-engines: SUCCESS (1.014s) [78.048172] Subtest wait: SUCCESS (1.015s) [78.218658] [050/171] (927s left) i915_getparams_basic (basic-eu-total) [78.278994] Starting subtest: basic-eu-total [78.281138] Subtest basic-eu-total: SUCCESS (0.000s) [78.333744] [051/171] (927s left) i915_getparams_basic (basic-subslice-total) [78.391701] Starting subtest: basic-subslice-total [78.393994] Subtest basic-subslice-total: SUCCESS (0.000s) [78.454776] [052/171] (927s left) i915_hangman (error-state-basic) [78.518530] Starting subtest: error-state-basic [78.523433] Subtest error-state-basic: SUCCESS (0.004s) [78.586360] [053/171] (927s left) i915_pciid [78.700551] [054/171] (927s left) kms_addfb_basic (addfb25-bad-modifier) [78.760275] Starting subtest: addfb25-bad-modifier [78.761379] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [78.851844] [055/171] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [78.909526] Starting subtest: addfb25-framebuffer-vs-set-tiling [78.910608] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [79.000385] [056/171] (927s left) kms_addfb_basic (addfb25-modifier-no-flag) [79.058838] Starting subtest: addfb25-modifier-no-flag [79.059928] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [79.149692] [057/171] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy) [79.205179] Starting subtest: addfb25-x-tiled-legacy [79.206277] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [79.283774] [058/171] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [79.339741] Starting subtest: addfb25-x-tiled-mismatch-legacy [79.340919] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [79.416349] [059/171] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [79.495366] Starting subtest: addfb25-yf-tiled-legacy [79.496458] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [79.567991] [060/171] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [79.647244] Starting subtest: addfb25-y-tiled-legacy [79.648355] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [79.716809] [061/171] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [79.797922] Starting subtest: addfb25-y-tiled-small-legacy [79.799907] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [79.866095] [062/171] (926s left) kms_addfb_basic (bad-pitch-0) [79.922038] Starting subtest: bad-pitch-0 [79.923133] Subtest bad-pitch-0: SUCCESS (0.000s) [80.016272] [063/171] (926s left) kms_addfb_basic (bad-pitch-1024) [80.072731] Starting subtest: bad-pitch-1024 [80.073813] Subtest bad-pitch-1024: SUCCESS (0.000s) [80.166234] [064/171] (926s left) kms_addfb_basic (bad-pitch-128) [80.222192] Starting subtest: bad-pitch-128 [80.223261] Subtest bad-pitch-128: SUCCESS (0.000s) [80.316778] [065/171] (925s left) kms_addfb_basic (bad-pitch-256) [80.372622] Starting subtest: bad-pitch-256 [80.373730] Subtest bad-pitch-256: SUCCESS (0.000s) [80.466614] [066/171] (925s left) kms_addfb_basic (bad-pitch-32) [80.524021] Starting subtest: bad-pitch-32 [80.525059] Subtest bad-pitch-32: SUCCESS (0.000s) [80.616313] [067/171] (925s left) kms_addfb_basic (bad-pitch-63) [80.672373] Starting subtest: bad-pitch-63 [80.673550] Subtest bad-pitch-63: SUCCESS (0.000s) [80.767793] [068/171] (925s left) kms_addfb_basic (bad-pitch-65536) [80.825231] Starting subtest: bad-pitch-65536 [80.826432] Subtest bad-pitch-65536: SUCCESS (0.000s) [80.916600] [069/171] (925s left) kms_addfb_basic (bad-pitch-999) [80.974139] Starting subtest: bad-pitch-999 [80.975210] Subtest bad-pitch-999: SUCCESS (0.000s) [81.066214] [070/171] (925s left) kms_addfb_basic (basic) [81.122364] Starting subtest: basic [81.123479] Subtest basic: SUCCESS (0.000s) [81.199137] [071/171] (925s left) kms_addfb_basic (basic-x-tiled-legacy) [81.256536] Starting subtest: basic-x-tiled-legacy [81.257590] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [81.349432] [072/171] (925s left) kms_addfb_basic (basic-y-tiled-legacy) [81.406694] Starting subtest: basic-y-tiled-legacy [81.407766] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [81.501136] [073/171] (924s left) kms_addfb_basic (bo-too-small) [81.581082] Starting subtest: bo-too-small [81.582137] Subtest bo-too-small: SUCCESS (0.000s) [81.649829] [074/171] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling) [81.727916] Starting subtest: bo-too-small-due-to-tiling [81.728959] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [81.799506] [075/171] (924s left) kms_addfb_basic (clobberred-modifier) [81.855630] Starting subtest: clobberred-modifier [81.856708] Subtest clobberred-modifier: SUCCESS (0.000s) [81.949300] [076/171] (924s left) kms_addfb_basic (framebuffer-vs-set-tiling) [82.007193] Starting subtest: framebuffer-vs-set-tiling [82.008194] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [82.099414] [077/171] (924s left) kms_addfb_basic (invalid-get-prop) [82.155255] Starting subtest: invalid-get-prop [82.156231] Subtest invalid-get-prop: SUCCESS (0.000s) [82.249403] [078/171] (924s left) kms_addfb_basic (invalid-get-prop-any) [82.305611] Starting subtest: invalid-get-prop-any [82.306690] Subtest invalid-get-prop-any: SUCCESS (0.000s) [82.399794] [079/171] (924s left) kms_addfb_basic (invalid-set-prop) [82.456923] Starting subtest: invalid-set-prop [82.457932] Subtest invalid-set-prop: SUCCESS (0.000s) [82.549785] [080/171] (923s left) kms_addfb_basic (invalid-set-prop-any) [82.607257] Starting subtest: invalid-set-prop-any [82.608223] Subtest invalid-set-prop-any: SUCCESS (0.000s) [82.699078] [081/171] (923s left) kms_addfb_basic (no-handle) [82.753867] Starting subtest: no-handle [82.755029] Subtest no-handle: SUCCESS (0.000s) [82.850839] [082/171] (923s left) kms_addfb_basic (size-max) [82.929872] Starting subtest: size-max [82.930929] Subtest size-max: SUCCESS (0.000s) [82.999305] [083/171] (923s left) kms_addfb_basic (small-bo) [83.077213] Starting subtest: small-bo [83.078296] Subtest small-bo: SUCCESS (0.000s) [83.149232] [084/171] (923s left) kms_addfb_basic (tile-pitch-mismatch) [83.210427] Starting subtest: tile-pitch-mismatch [83.211419] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [83.299124] [085/171] (923s left) kms_addfb_basic (too-high) [83.376543] Starting subtest: too-high [83.377559] Subtest too-high: SUCCESS (0.001s) [83.450301] [086/171] (923s left) kms_addfb_basic (too-wide) [83.528398] Starting subtest: too-wide [83.529405] Subtest too-wide: SUCCESS (0.000s) [83.598885] [087/171] (922s left) kms_addfb_basic (unused-handle) [83.655393] Starting subtest: unused-handle [83.656490] Subtest unused-handle: SUCCESS (0.000s) [83.749135] [088/171] (922s left) kms_addfb_basic (unused-modifier) [83.806070] Starting subtest: unused-modifier [83.807258] Subtest unused-modifier: SUCCESS (0.000s) [83.899440] [089/171] (922s left) kms_addfb_basic (unused-offsets) [83.955720] Starting subtest: unused-offsets [83.956770] Subtest unused-offsets: SUCCESS (0.000s) [84.048330] [090/171] (922s left) kms_addfb_basic (unused-pitches) [84.104163] Starting subtest: unused-pitches [84.105288] Subtest unused-pitches: SUCCESS (0.000s) [84.198933] [091/171] (922s left) kms_busy (basic) [84.279297] Starting subtest: basic [84.280318] Starting dynamic subtest: flip [84.728762] Dynamic subtest flip: SUCCESS (0.446s) [84.734872] Starting dynamic subtest: modeset [85.223757] Dynamic subtest modeset: SUCCESS (0.499s) [85.224753] Subtest basic: SUCCESS (0.945s) [85.357292] [092/171] (921s left) kms_chamelium_hpd (dp-hpd-fast) [85.485670] Subtest dp-hpd-fast: SKIP (0.000s) [85.567533] [093/171] (921s left) kms_chamelium_edid (dp-edid-read) [85.679732] Subtest dp-edid-read: SKIP (0.000s) [85.762048] [094/171] (920s left) kms_chamelium_frames (dp-crc-fast) [85.892634] Subtest dp-crc-fast: SKIP (0.000s) [85.982698] [095/171] (920s left) kms_chamelium_hpd (hdmi-hpd-fast) [86.112743] Subtest hdmi-hpd-fast: SKIP (0.000s) [86.194129] [096/171] (920s left) kms_chamelium_edid (hdmi-edid-read) [86.307640] Subtest hdmi-edid-read: SKIP (0.000s) [86.388719] [097/171] (920s left) kms_chamelium_frames (hdmi-crc-fast) [86.501559] Subtest hdmi-crc-fast: SKIP (0.000s) [86.581973] [098/171] (920s left) kms_chamelium_hpd (vga-hpd-fast) [86.696056] Subtest vga-hpd-fast: SKIP (0.000s) [86.779165] [099/171] (919s left) kms_chamelium_edid (vga-edid-read) [86.891818] Subtest vga-edid-read: SKIP (0.000s) [86.973315] [100/171] (919s left) kms_prop_blob (basic) [87.031979] Starting subtest: basic [87.033038] Subtest basic: SUCCESS (0.000s) [87.091290] [101/171] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [87.173624] Starting subtest: basic-busy-flip-before-cursor-atomic [88.100814] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.927s) [88.227269] [102/171] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [88.310887] Starting subtest: basic-busy-flip-before-cursor-legacy [89.234719] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.924s) [89.358190] [103/171] (917s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [89.434600] Starting subtest: basic-flip-after-cursor-atomic [90.383627] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.948s) [90.515838] [104/171] (916s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [90.594410] Starting subtest: basic-flip-after-cursor-legacy [91.525367] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.930s) [91.650288] [105/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [91.729116] Starting subtest: basic-flip-after-cursor-varying-size [92.674573] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.946s) [92.804236] [106/171] (914s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [92.885131] Starting subtest: basic-flip-before-cursor-atomic [93.829505] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.944s) [93.953328] [107/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [94.030724] Starting subtest: basic-flip-before-cursor-legacy [94.961375] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.930s) [95.088471] [108/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [95.167559] Starting subtest: basic-flip-before-cursor-varying-size [96.111709] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.943s) [96.237398] [109/171] (910s left) kms_flip (basic-flip-vs-dpms) [96.306823] Starting subtest: basic-flip-vs-dpms [96.308910] Starting dynamic subtest: A-VGA1 [97.241702] Dynamic subtest A-VGA1: SUCCESS (0.934s) [97.248586] Starting dynamic subtest: B-VGA1 [98.128851] Dynamic subtest B-VGA1: SUCCESS (0.886s) [98.135054] Starting dynamic subtest: C-VGA1 [99.016746] Dynamic subtest C-VGA1: SUCCESS (0.888s) [99.017781] Subtest basic-flip-vs-dpms: SUCCESS (2.711s) [99.151663] [110/171] (907s left) kms_flip (basic-flip-vs-modeset) [99.222246] Starting subtest: basic-flip-vs-modeset [99.223352] Starting dynamic subtest: A-VGA1 [100.081248] Dynamic subtest A-VGA1: SUCCESS (0.858s) [100.089209] Starting dynamic subtest: B-VGA1 [100.871863] Dynamic subtest B-VGA1: SUCCESS (0.790s) [100.878417] Starting dynamic subtest: C-VGA1 [101.663776] Dynamic subtest C-VGA1: SUCCESS (0.792s) [101.665851] Subtest basic-flip-vs-modeset: SUCCESS (2.445s) [101.800389] [111/171] (905s left) kms_flip (basic-flip-vs-wf_vblank) [101.874809] Starting subtest: basic-flip-vs-wf_vblank [101.875959] Starting dynamic subtest: A-VGA1 [103.022552] Dynamic subtest A-VGA1: SUCCESS (1.148s) [103.030335] Starting dynamic subtest: B-VGA1 [104.145659] Dynamic subtest B-VGA1: SUCCESS (1.123s) [104.152599] Starting dynamic subtest: C-VGA1 [105.267122] Dynamic subtest C-VGA1: SUCCESS (1.121s) [105.268429] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.396s) [105.441433] [112/171] (901s left) kms_flip (basic-plain-flip) [105.512169] Starting subtest: basic-plain-flip [105.514428] Starting dynamic subtest: A-VGA1 [106.394776] Dynamic subtest A-VGA1: SUCCESS (0.880s) [106.401095] Starting dynamic subtest: B-VGA1 [107.233565] Dynamic subtest B-VGA1: SUCCESS (0.838s) [107.239826] Starting dynamic subtest: C-VGA1 [108.073021] Dynamic subtest C-VGA1: SUCCESS (0.839s) [108.074606] Subtest basic-plain-flip: SUCCESS (2.564s) [108.257562] [113/171] (898s left) kms_force_connector_basic (force-connector-state) [108.326638] Starting subtest: force-connector-state [108.470470] Subtest force-connector-state: SUCCESS (0.144s) [108.648215] [114/171] (898s left) kms_force_connector_basic (force-edid) [108.716639] Starting subtest: force-edid [108.735504] Subtest force-edid: SUCCESS (0.020s) [108.831645] [115/171] (898s left) kms_force_connector_basic (force-load-detect) [108.900737] Starting subtest: force-load-detect [109.046628] Subtest force-load-detect: SUCCESS (0.147s) [109.208693] [116/171] (897s left) kms_force_connector_basic (prune-stale-modes) [109.278115] Starting subtest: prune-stale-modes [109.292888] Subtest prune-stale-modes: SUCCESS (0.016s) [109.392325] [117/171] (897s left) kms_frontbuffer_tracking (basic) [109.477047] Starting subtest: basic [111.296659] Subtest basic: SUCCESS (1.822s) [111.376158] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [111.456584] Starting subtest: compare-crc-sanitycheck [111.457766] Starting dynamic subtest: pipe-A-VGA-1 [111.717100] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.260s) [111.724989] Starting dynamic subtest: pipe-B-VGA-1 [111.981019] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.264s) [111.987722] Starting dynamic subtest: pipe-C-VGA-1 [112.254053] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.273s) [112.255102] Subtest compare-crc-sanitycheck: SUCCESS (0.798s) [112.386356] [119/171] (894s left) kms_pipe_crc_basic (hang-read-crc) [112.465450] Starting subtest: hang-read-crc [112.466497] Starting dynamic subtest: pipe-A-VGA-1 [113.184214] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.718s) [113.190714] Starting dynamic subtest: pipe-B-VGA-1 [113.908205] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.723s) [113.914685] Starting dynamic subtest: pipe-C-VGA-1 [114.648822] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.740s) [114.649885] Subtest hang-read-crc: SUCCESS (2.183s) [114.762326] [120/171] (892s left) kms_pipe_crc_basic (nonblocking-crc) [114.841849] Starting subtest: nonblocking-crc [114.842908] Starting dynamic subtest: pipe-A-VGA-1 [115.270636] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.428s) [115.277047] Starting dynamic subtest: pipe-B-VGA-1 [115.697122] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.425s) [115.703713] Starting dynamic subtest: pipe-C-VGA-1 [116.131810] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.434s) [116.132970] Subtest nonblocking-crc: SUCCESS (1.290s) [116.246459] [121/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [116.326144] Starting subtest: nonblocking-crc-frame-sequence [116.327196] Starting dynamic subtest: pipe-A-VGA-1 [116.756272] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.429s) [116.762750] Starting dynamic subtest: pipe-B-VGA-1 [117.180928] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.425s) [117.187318] Starting dynamic subtest: pipe-C-VGA-1 [117.619403] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.438s) [117.620522] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.294s) [117.737351] [122/171] (889s left) kms_pipe_crc_basic (read-crc) [117.817253] Starting subtest: read-crc [117.818296] Starting dynamic subtest: pipe-A-VGA-1 [118.180021] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.362s) [118.186591] Starting dynamic subtest: pipe-B-VGA-1 [118.540618] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.360s) [118.549083] Starting dynamic subtest: pipe-C-VGA-1 [118.914464] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.372s) [118.915638] Subtest read-crc: SUCCESS (1.097s) [119.044379] [123/171] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence) [119.125325] Starting subtest: read-crc-frame-sequence [119.126388] Starting dynamic subtest: pipe-A-VGA-1 [119.486833] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.360s) [119.495191] Starting dynamic subtest: pipe-B-VGA-1 [119.849369] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.362s) [119.855948] Starting dynamic subtest: pipe-C-VGA-1 [120.220966] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.371s) [120.222171] Subtest read-crc-frame-sequence: SUCCESS (1.096s) [120.336519] [124/171] (886s left) kms_psr (primary_page_flip) [120.396155] Subtest primary_page_flip: SKIP (0.000s) [120.416044] [125/171] (886s left) kms_psr (cursor_plane_move) [120.475358] Subtest cursor_plane_move: SKIP (0.000s) [120.498188] [126/171] (886s left) kms_psr (sprite_plane_onoff) [120.555548] Subtest sprite_plane_onoff: SKIP (0.000s) [120.581597] [127/171] (886s left) kms_psr (primary_mmap_gtt) [120.639586] Subtest primary_mmap_gtt: SKIP (0.000s) [120.665071] [128/171] (886s left) kms_setmode (basic-clone-single-crtc) [120.722667] Starting subtest: basic-clone-single-crtc [120.725853] Subtest basic-clone-single-crtc: SKIP (0.000s) [120.785613] [129/171] (886s left) i915_pm_backlight (basic-brightness) [120.867062] Subtest basic-brightness: SKIP (0.000s) [120.881650] [130/171] (886s left) i915_pm_rpm (basic-pci-d3-state) [122.247714] Starting subtest: basic-pci-d3-state [122.453692] Subtest basic-pci-d3-state: SUCCESS (0.204s) [122.699988] [131/171] (884s left) i915_pm_rpm (basic-rte) [122.756807] Starting subtest: basic-rte [124.248631] Subtest basic-rte: SUCCESS (1.490s) [124.689901] [132/171] (882s left) i915_pm_rps (basic-api) [124.750336] Starting subtest: basic-api [124.752445] Subtest basic-api: SUCCESS (0.002s) [124.806542] [133/171] (882s left) prime_self_import (basic-llseek-bad) [124.863944] Starting subtest: basic-llseek-bad [124.864985] Subtest basic-llseek-bad: SUCCESS (0.001s) [124.938861] [134/171] (882s left) prime_self_import (basic-llseek-size) [124.994058] Starting subtest: basic-llseek-size [124.996358] Subtest basic-llseek-size: SUCCESS (0.002s) [125.075283] [135/171] (882s left) prime_self_import (basic-with_fd_dup) [125.131559] Starting subtest: basic-with_fd_dup [125.133928] Subtest basic-with_fd_dup: SUCCESS (0.003s) [125.205524] [136/171] (882s left) prime_self_import (basic-with_one_bo) [125.260146] Starting subtest: basic-with_one_bo [125.262466] Subtest basic-with_one_bo: SUCCESS (0.002s) [125.319645] [137/171] (881s left) prime_self_import (basic-with_one_bo_two_files) [125.375300] Starting subtest: basic-with_one_bo_two_files [125.377714] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [125.456986] [138/171] (881s left) prime_self_import (basic-with_two_bos) [125.513344] Starting subtest: basic-with_two_bos [125.515788] Subtest basic-with_two_bos: SUCCESS (0.002s) [125.573647] [139/171] (881s left) prime_vgem (basic-fence-flip) [125.646164] Starting subtest: basic-fence-flip [125.976450] Subtest basic-fence-flip: SUCCESS (0.330s) [126.056686] [140/171] (881s left) prime_vgem (basic-fence-mmap) [126.130064] Starting subtest: basic-fence-mmap [126.149530] Subtest basic-fence-mmap: SUCCESS (0.019s) [126.222612] [141/171] (881s left) prime_vgem (basic-fence-read) [126.296370] Starting subtest: basic-fence-read [126.326015] Subtest basic-fence-read: SUCCESS (0.030s) [126.388879] [142/171] (880s left) prime_vgem (basic-gtt) [126.462976] Starting subtest: basic-gtt [126.473893] Subtest basic-gtt: SUCCESS (0.011s) [126.538692] [143/171] (880s left) prime_vgem (basic-read) [126.612350] Starting subtest: basic-read [126.628160] Subtest basic-read: SUCCESS (0.016s) [126.690777] [144/171] (880s left) prime_vgem (basic-write) [126.762754] Starting subtest: basic-write [126.779845] Subtest basic-write: SUCCESS (0.017s) [126.838795] [145/171] (880s left) prime_vgem (basic-userptr) [126.912586] Starting subtest: basic-userptr [126.921517] Subtest basic-userptr: SKIP (0.008s) [126.992090] [146/171] (880s left) vgem_basic (setversion) [127.059573] Starting subtest: setversion [127.062067] Subtest setversion: SUCCESS (0.000s) [127.106714] [147/171] (880s left) vgem_basic (create) [127.177456] Starting subtest: create [127.178467] Subtest create: SUCCESS (0.000s) [127.224165] [148/171] (880s left) vgem_basic (debugfs) [127.292617] Starting subtest: debugfs [127.293809] Subtest debugfs: SUCCESS (0.000s) [127.339114] [149/171] (880s left) vgem_basic (dmabuf-export) [127.410287] Starting subtest: dmabuf-export [127.412819] Subtest dmabuf-export: SUCCESS (0.002s) [127.487834] [150/171] (879s left) vgem_basic (dmabuf-fence) [127.559335] Starting subtest: dmabuf-fence [127.560357] Subtest dmabuf-fence: SUCCESS (0.001s) [127.604723] [151/171] (879s left) vgem_basic (dmabuf-fence-before) [127.676109] Starting subtest: dmabuf-fence-before [127.677302] Subtest dmabuf-fence-before: SUCCESS (0.000s) [127.721963] [152/171] (879s left) vgem_basic (dmabuf-mmap) [127.794859] Starting subtest: dmabuf-mmap [127.810029] Subtest dmabuf-mmap: SUCCESS (0.016s) [127.855811] [153/171] (879s left) vgem_basic (mmap) [127.926606] Starting subtest: mmap [127.936857] Subtest mmap: SUCCESS (0.011s) [127.972325] [154/171] (879s left) vgem_basic (second-client) [128.042628] Starting subtest: second-client [128.092487] Subtest second-client: SUCCESS (0.050s) [128.140361] [155/171] (879s left) vgem_basic (sysfs) [128.209414] Starting subtest: sysfs [128.210827] Subtest sysfs: SUCCESS (0.001s) [128.256036] [156/171] (879s left) core_hotunplug (unbind-rebind) [128.342499] Starting subtest: unbind-rebind [129.175255] Subtest unbind-rebind: SUCCESS (0.833s) [129.195975] [157/171] (878s left) vgem_basic (unload) [129.257588] Starting subtest: unload [158.005861] Subtest unload: SUCCESS (28.747s) [158.084796] [158/171] (849s left) i915_module_load (reload) [158.141430] Starting subtest: reload [159.677474] Subtest reload: SUCCESS (1.536s) [159.697829] [159/171] (847s left) gem_lmem_swapping (basic) [159.767694] Subtest basic: SKIP (0.000s) [159.786101] [160/171] (847s left) gem_lmem_swapping (parallel-random-engines) [159.847467] Subtest parallel-random-engines: SKIP (0.000s) [159.870564] [161/171] (847s left) gem_lmem_swapping (random-engines) [159.930270] Subtest random-engines: SKIP (0.000s) [159.952717] [162/171] (847s left) gem_lmem_swapping (verify-random) [160.013633] Subtest verify-random: SKIP (0.000s) [160.037229] [163/171] (847s left) i915_pm_rpm (module-reload) [161.645745] Starting subtest: module-reload [168.095745] Subtest module-reload: SUCCESS (6.449s) [168.109729] [164/171] (839s left) i915_selftest (live) [168.175947] Starting subtest: live [168.177153] Starting dynamic subtest: sanitycheck [168.661146] Dynamic subtest sanitycheck: SUCCESS (0.484s) [168.666377] Starting dynamic subtest: uncore [169.149202] Dynamic subtest uncore: SUCCESS (0.488s) [169.154349] Starting dynamic subtest: workarounds [169.853528] Dynamic subtest workarounds: SUCCESS (0.704s) [169.859080] Starting dynamic subtest: gt_engines [170.331946] Dynamic subtest gt_engines: SUCCESS (0.478s) [170.337206] Starting dynamic subtest: gt_timelines [175.781031] Dynamic subtest gt_timelines: SUCCESS (5.449s) [175.786239] Starting dynamic subtest: gt_contexts [176.368448] Dynamic subtest gt_contexts: SUCCESS (0.587s) [176.373933] Starting dynamic subtest: gt_lrc [176.829079] Dynamic subtest gt_lrc: SUCCESS (0.460s) [176.834286] Starting dynamic subtest: gt_mocs [177.301026] Dynamic subtest gt_mocs: SUCCESS (0.472s) [177.306260] Starting dynamic subtest: gt_pm [187.653164] Dynamic subtest gt_pm: SUCCESS (10.351s) [187.660272] Starting dynamic subtest: gt_heartbeat [188.377520] Dynamic subtest gt_heartbeat: SUCCESS (0.724s) [188.382477] Starting dynamic subtest: requests [194.537636] Dynamic subtest requests: SUCCESS (6.159s) [194.543168] Starting dynamic subtest: migrate [194.993995] Dynamic subtest migrate: SUCCESS (0.456s) [194.999452] Starting dynamic subtest: active [195.454178] Dynamic subtest active: SUCCESS (0.460s) [195.459433] Starting dynamic subtest: objects [196.408795] Dynamic subtest objects: SUCCESS (0.954s) [196.414065] Starting dynamic subtest: mman [200.324383] Dynamic subtest mman: SUCCESS (3.915s) [200.329793] Starting dynamic subtest: dmabuf [200.953651] Dynamic subtest dmabuf: SUCCESS (0.629s) [200.958969] Starting dynamic subtest: vma [201.598456] Dynamic subtest vma: SUCCESS (0.644s) [201.603617] Starting dynamic subtest: coherency [202.767481] Dynamic subtest coherency: SUCCESS (1.168s) [202.773952] Starting dynamic subtest: gtt [207.258592] Dynamic subtest gtt: SUCCESS (4.491s) [207.263801] Starting dynamic subtest: gem [208.035192] Dynamic subtest gem: SUCCESS (0.775s) [208.041616] Starting dynamic subtest: evict [208.514311] Dynamic subtest evict: SUCCESS (0.479s) [208.520085] Starting dynamic subtest: hugepages [209.613482] Dynamic subtest hugepages: SUCCESS (1.099s) [209.618761] Starting dynamic subtest: gem_contexts [214.390353] Dynamic subtest gem_contexts: SUCCESS (4.776s) [214.395664] Starting dynamic subtest: client [214.883066] Dynamic subtest client: SUCCESS (0.492s) [214.888577] Starting dynamic subtest: gem_migrate [215.482223] Dynamic subtest gem_migrate: SUCCESS (0.599s) [215.487815] Starting dynamic subtest: reset [217.164822] Dynamic subtest reset: SUCCESS (1.682s) [217.170285] Starting dynamic subtest: memory_region [217.795948] Dynamic subtest memory_region: SUCCESS (0.630s) [217.803267] Starting dynamic subtest: hangcheck [235.033909] Dynamic subtest hangcheck: SUCCESS (17.237s) [235.039259] Starting dynamic subtest: execlists [235.524018] Dynamic subtest execlists: SUCCESS (0.489s) [235.529417] Starting dynamic subtest: ring_submission [236.098238] Dynamic subtest ring_submission: SUCCESS (0.574s) [236.107685] Starting dynamic subtest: perf [236.758238] Dynamic subtest perf: SUCCESS (0.659s) [236.763398] Starting dynamic subtest: slpc [237.226994] Dynamic subtest slpc: SUCCESS (0.468s) [237.232244] Starting dynamic subtest: guc [237.696130] Dynamic subtest guc: SUCCESS (0.469s) [237.702529] Starting dynamic subtest: guc_multi_lrc [238.193109] Dynamic subtest guc_multi_lrc: SUCCESS (0.496s) [238.198413] Starting dynamic subtest: guc_hang [238.649031] Dynamic subtest guc_hang: SUCCESS (0.455s) [238.654563] Starting dynamic subtest: late_gt_pm [239.157415] Dynamic subtest late_gt_pm: SUCCESS (0.508s) [239.158500] Subtest live: SUCCESS (70.981s) [239.227108] [165/171] (768s left) dmabuf (all-tests) [239.288759] Starting subtest: all-tests [239.292221] Starting dynamic subtest: sanitycheck [239.320259] Dynamic subtest sanitycheck: SUCCESS (0.031s) [239.326559] Starting dynamic subtest: dma_fence [239.452300] Dynamic subtest dma_fence: SUCCESS (0.131s) [239.459758] Starting dynamic subtest: dma_fence_chain [250.926614] Dynamic subtest dma_fence_chain: SUCCESS (11.473s) [250.933910] Starting dynamic subtest: dma_fence_unwrap [250.951080] Dynamic subtest dma_fence_unwrap: SUCCESS (0.025s) [250.956624] Starting dynamic subtest: dma_resv [250.970084] Dynamic subtest dma_resv: SUCCESS (0.019s) [250.971269] Subtest all-tests: SUCCESS (11.682s) [250.982894] [166/171] (756s left) i915_suspend (basic-s2idle-without-i915) [251.040438] Starting subtest: basic-s2idle-without-i915 [269.112411] Subtest basic-s2idle-without-i915: SUCCESS (1.855s) [275.235056] [167/171] (754s left) i915_suspend (basic-s3-without-i915) [275.296400] Starting subtest: basic-s3-without-i915 [293.390147] Subtest basic-s3-without-i915: SUCCESS (1.975s) [299.514206] [168/171] (752s left) gem_exec_suspend (basic-s0) [299.584231] Starting subtest: basic-S0 [299.585302] Starting dynamic subtest: smem [316.008833] Dynamic subtest smem: SUCCESS (1.217s) [316.009925] Subtest basic-S0: SUCCESS (1.217s) [329.159513] [169/171] (751s left) gem_exec_suspend (basic-s3) [329.225590] Starting subtest: basic-S3 [329.226748] Starting dynamic subtest: smem [347.046035] Dynamic subtest smem: SUCCESS (1.299s) [347.048473] Subtest basic-S3: SUCCESS (1.300s) [353.190601] [170/171] (749s left) kms_chamelium_hpd (common-hpd-after-suspend) [353.306300] Subtest common-hpd-after-suspend: SKIP (0.000s) [353.389224] [171/171] (749s left) kms_pipe_crc_basic (suspend-read-crc) [353.472170] Starting subtest: suspend-read-crc [353.473205] Starting dynamic subtest: pipe-A-VGA-1 [371.211949] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.483s) [371.219837] Starting dynamic subtest: pipe-B-VGA-1 [389.220856] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.465s) [389.230672] Starting dynamic subtest: pipe-C-VGA-1 [407.226147] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.478s) [407.227256] Subtest suspend-read-crc: SUCCESS (4.429s) [410.319801] Closing watchdogs Done.