[50.997328] Initializing watchdogs [50.997499] /dev/watchdog0 [51.007495] [001/171] (960s left) i915_module_load (load) [51.295977] Starting subtest: load [53.742022] Subtest load: SUCCESS (2.446s) [53.766620] [002/171] (957s left) core_auth (basic-auth) [53.901596] Starting subtest: basic-auth [53.902754] Subtest basic-auth: SUCCESS (0.001s) [54.000836] [003/171] (957s left) debugfs_test (read_all_entries) [54.144500] Starting subtest: read_all_entries [54.210487] Subtest read_all_entries: SUCCESS (0.066s) [54.322889] [004/171] (957s left) debugfs_test (basic-hwmon) [54.463375] Starting subtest: basic-hwmon [54.465468] Subtest basic-hwmon: SKIP (0.000s) [54.579291] [005/171] (957s left) fbdev (eof) [54.743973] Starting subtest: eof [54.745151] Subtest eof: SUCCESS (0.000s) [54.807633] [006/171] (956s left) fbdev (info) [54.941556] Starting subtest: info [54.942713] Subtest info: SUCCESS (0.000s) [55.029364] [007/171] (956s left) fbdev (nullptr) [55.177581] Starting subtest: nullptr [55.178709] Subtest nullptr: SUCCESS (0.000s) [55.242391] [008/171] (956s left) fbdev (read) [55.393994] Starting subtest: read [62.493613] Subtest read: SUCCESS (7.066s) [62.540734] [009/171] (949s left) fbdev (write) [62.693486] Starting subtest: write [66.450543] Subtest write: SUCCESS (3.747s) [66.507601] [010/171] (945s left) gem_basic (bad-close) [66.645486] Starting subtest: bad-close [66.647602] Subtest bad-close: SUCCESS (0.000s) [66.725985] [011/171] (945s left) gem_basic (create-close) [66.863102] Starting subtest: create-close [66.865160] Subtest create-close: SUCCESS (0.000s) [66.940829] [012/171] (944s left) gem_basic (create-fd-close) [67.070655] Starting subtest: create-fd-close [67.072692] Subtest create-fd-close: SUCCESS (0.000s) [67.174244] [013/171] (944s left) gem_busy (busy@all-engines) [67.327830] Starting subtest: busy [67.329118] Starting dynamic subtest: all-engines [67.397713] Dynamic subtest all-engines: SUCCESS (0.069s) [67.399098] Subtest busy: SUCCESS (0.070s) [67.774866] [014/171] (944s left) gem_close_race (basic-process) [67.930907] Starting subtest: basic-process [68.004233] Subtest basic-process: SUCCESS (0.073s) [68.208863] [015/171] (943s left) gem_close_race (basic-threads) [68.366414] Starting subtest: basic-threads [69.525733] Subtest basic-threads: SUCCESS (1.159s) [69.741573] [016/171] (942s left) gem_ctx_create (basic) [69.909977] Starting subtest: basic [69.911292] Subtest basic: SUCCESS (0.000s) [70.109301] [017/171] (941s left) gem_ctx_create (basic-files) [70.262407] Starting subtest: basic-files [72.287906] Subtest basic-files: SUCCESS (2.025s) [72.517530] [018/171] (939s left) gem_ctx_exec (basic) [72.673623] Starting subtest: basic [72.678207] Subtest basic: SUCCESS (0.005s) [72.791099] [019/171] (939s left) gem_exec_basic (basic) [72.937303] Starting subtest: basic [72.938425] Starting dynamic subtest: rcs0-smem [72.939467] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [72.950689] Starting dynamic subtest: bcs0-smem [72.952014] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [72.961948] Starting dynamic subtest: vcs0-smem [72.963301] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [72.973360] Starting dynamic subtest: vecs0-smem [72.974619] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [72.975931] Subtest basic: SUCCESS (0.005s) [73.142031] [020/171] (938s left) gem_exec_create (basic) [73.293598] Starting subtest: basic [73.294830] Starting dynamic subtest: smem [75.338166] Dynamic subtest smem: SUCCESS (2.044s) [75.339228] Subtest basic: SUCCESS (2.045s) [75.557085] [021/171] (936s left) gem_exec_fence (basic-busy) [75.859611] Starting subtest: basic-busy [75.860875] Starting dynamic subtest: rcs0 [75.888962] Dynamic subtest rcs0: SUCCESS (0.037s) [75.905689] Starting dynamic subtest: bcs0 [75.916518] Dynamic subtest bcs0: SUCCESS (0.028s) [75.927147] Starting dynamic subtest: vcs0 [75.941523] Dynamic subtest vcs0: SUCCESS (0.025s) [75.952276] Starting dynamic subtest: vecs0 [75.969830] Dynamic subtest vecs0: SUCCESS (0.028s) [75.971296] Subtest basic-busy: SUCCESS (0.119s) [76.559751] [022/171] (935s left) gem_exec_fence (basic-wait) [76.860581] Starting subtest: basic-wait [76.862235] Starting dynamic subtest: rcs0 [76.882297] Dynamic subtest rcs0: SUCCESS (0.030s) [76.894624] Starting dynamic subtest: bcs0 [76.907529] Dynamic subtest bcs0: SUCCESS (0.025s) [76.919431] Starting dynamic subtest: vcs0 [76.936050] Dynamic subtest vcs0: SUCCESS (0.028s) [76.947544] Starting dynamic subtest: vecs0 [76.979512] Dynamic subtest vecs0: SUCCESS (0.043s) [76.981490] Subtest basic-wait: SUCCESS (0.127s) [77.509749] [023/171] (934s left) gem_exec_fence (basic-await) [77.808863] Starting subtest: basic-await [77.810069] Starting dynamic subtest: rcs0 [77.900451] Dynamic subtest rcs0: SUCCESS (0.099s) [77.926989] Starting dynamic subtest: bcs0 [78.023517] Dynamic subtest bcs0: SUCCESS (0.123s) [78.049906] Starting dynamic subtest: vcs0 [78.147344] Dynamic subtest vcs0: SUCCESS (0.123s) [78.173626] Starting dynamic subtest: vecs0 [78.274993] Dynamic subtest vecs0: SUCCESS (0.127s) [78.276823] Subtest basic-await: SUCCESS (0.474s) [78.827189] [024/171] (933s left) gem_exec_fence (nb-await) [79.129833] Starting subtest: nb-await [79.131111] Starting dynamic subtest: rcs0 [79.186161] Dynamic subtest rcs0: SUCCESS (0.066s) [79.204300] Starting dynamic subtest: bcs0 [79.254879] Dynamic subtest bcs0: SUCCESS (0.069s) [79.282289] Starting dynamic subtest: vcs0 [79.328848] Dynamic subtest vcs0: SUCCESS (0.074s) [79.356667] Starting dynamic subtest: vecs0 [79.403815] Dynamic subtest vecs0: SUCCESS (0.075s) [79.407194] Subtest nb-await: SUCCESS (0.284s) [79.944655] [025/171] (932s left) gem_exec_gttfill (basic) [80.098666] Starting subtest: basic [87.954496] Subtest basic: SUCCESS (7.847s) [88.145912] [026/171] (923s left) gem_exec_parallel (engines) [88.362839] Starting subtest: engines [88.365124] Starting dynamic subtest: basic [90.740676] Dynamic subtest basic: SUCCESS (2.355s) [90.753431] Starting dynamic subtest: contexts [94.089810] Dynamic subtest contexts: SUCCESS (3.372s) [94.128708] Starting dynamic subtest: fds [97.912267] Dynamic subtest fds: SUCCESS (3.822s) [97.926901] Starting dynamic subtest: userptr [100.434241] Dynamic subtest userptr: SUCCESS (2.508s) [100.436081] Subtest engines: SUCCESS (12.058s) [100.633061] [027/171] (911s left) gem_exec_store (basic) [100.778703] Starting subtest: basic [100.834505] Subtest basic: SUCCESS (0.055s) [101.045237] [028/171] (911s left) gem_flink_basic (bad-flink) [101.178193] Starting subtest: bad-flink [101.179368] Subtest bad-flink: SUCCESS (0.000s) [101.262580] [029/171] (910s left) gem_flink_basic (bad-open) [101.397853] Starting subtest: bad-open [101.399082] Subtest bad-open: SUCCESS (0.000s) [101.477711] [030/171] (910s left) gem_flink_basic (basic) [101.612334] Starting subtest: basic [101.613390] Subtest basic: SUCCESS (0.000s) [101.711555] [031/171] (910s left) gem_flink_basic (double-flink) [101.837641] Starting subtest: double-flink [101.839123] Subtest double-flink: SUCCESS (0.000s) [101.944480] [032/171] (910s left) gem_flink_basic (flink-lifetime) [102.078282] Starting subtest: flink-lifetime [102.080818] Subtest flink-lifetime: SUCCESS (0.002s) [102.177793] [033/171] (910s left) gem_huc_copy (huc-copy) [102.316495] Starting subtest: huc-copy [102.318681] Subtest huc-copy: SKIP (0.000s) [102.427730] [034/171] (909s left) gem_linear_blits (basic) [102.722096] Starting subtest: basic [102.733976] Subtest basic: SUCCESS (0.012s) [102.861462] [035/171] (909s left) gem_mmap (basic) [103.056516] Starting subtest: basic [103.061583] Subtest basic: SUCCESS (0.001s) [103.161277] [036/171] (909s left) gem_mmap_gtt (basic) [103.290085] Starting subtest: basic [103.291359] Subtest basic: SUCCESS (0.001s) [103.376726] [037/171] (909s left) gem_render_linear_blits (basic) [103.516102] Starting subtest: basic [103.564325] Subtest basic: SUCCESS (0.048s) [103.629771] [038/171] (908s left) gem_render_tiled_blits (basic) [103.763335] Starting subtest: basic [103.822609] Subtest basic: SUCCESS (0.059s) [103.893797] [039/171] (908s left) gem_ringfill (basic-all) [104.174858] Starting subtest: basic-all [105.403615] Subtest basic-all: SUCCESS (1.221s) [105.481867] [040/171] (907s left) gem_softpin (allocator-basic) [105.615880] Starting subtest: allocator-basic [105.783357] Subtest allocator-basic: SUCCESS (0.159s) [105.896520] [041/171] (906s left) gem_softpin (allocator-basic-reserve) [106.043868] Starting subtest: allocator-basic-reserve [106.210798] Subtest allocator-basic-reserve: SUCCESS (0.158s) [106.329863] [042/171] (906s left) gem_softpin (safe-alignment) [106.479788] Starting subtest: safe-alignment [106.497776] Subtest safe-alignment: SUCCESS (0.018s) [106.610985] [043/171] (905s left) gem_sync (basic-all) [106.755386] Starting subtest: basic-all [109.207780] Subtest basic-all: SUCCESS (2.452s) [109.412580] [044/171] (903s left) gem_sync (basic-each) [109.564396] Starting subtest: basic-each [111.733571] Subtest basic-each: SUCCESS (2.168s) [111.949311] [045/171] (900s left) gem_tiled_blits (basic) [112.250148] Starting subtest: basic [112.278988] Subtest basic: SUCCESS (0.029s) [112.394981] [046/171] (900s left) gem_tiled_fence_blits (basic) [112.774834] Starting subtest: basic [112.802019] Subtest basic: SUCCESS (0.027s) [112.924755] [047/171] (899s left) gem_tiled_pread_basic [113.462595] [048/171] (899s left) gem_wait (busy@all-engines) [113.614730] Starting subtest: busy [113.615911] Starting dynamic subtest: all-engines [114.148306] Dynamic subtest all-engines: SUCCESS (0.534s) [114.149366] Subtest busy: SUCCESS (0.534s) [114.397275] [049/171] (898s left) gem_wait (wait@all-engines) [114.556992] Starting subtest: wait [114.558188] Starting dynamic subtest: all-engines [115.599782] Dynamic subtest all-engines: SUCCESS (1.041s) [115.601772] Subtest wait: SUCCESS (1.042s) [115.829613] [050/171] (896s left) i915_getparams_basic (basic-eu-total) [115.962784] Starting subtest: basic-eu-total [115.965210] Subtest basic-eu-total: SUCCESS (0.000s) [116.044992] [051/171] (896s left) i915_getparams_basic (basic-subslice-total) [116.183873] Starting subtest: basic-subslice-total [116.186122] Subtest basic-subslice-total: SUCCESS (0.000s) [116.261555] [052/171] (896s left) i915_hangman (error-state-basic) [116.402930] Starting subtest: error-state-basic [116.417336] Subtest error-state-basic: SUCCESS (0.013s) [116.495306] [053/171] (896s left) i915_pciid [116.711650] [054/171] (896s left) kms_addfb_basic (addfb25-bad-modifier) [116.841352] Starting subtest: addfb25-bad-modifier [116.842435] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [116.977698] [055/171] (895s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [117.114618] Starting subtest: addfb25-framebuffer-vs-set-tiling [117.115710] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [117.245204] [056/171] (895s left) kms_addfb_basic (addfb25-modifier-no-flag) [117.381507] Starting subtest: addfb25-modifier-no-flag [117.382698] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [117.511479] [057/171] (895s left) kms_addfb_basic (addfb25-x-tiled-legacy) [117.648887] Starting subtest: addfb25-x-tiled-legacy [117.649999] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [117.778162] [058/171] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [117.915208] Starting subtest: addfb25-x-tiled-mismatch-legacy [117.916377] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [118.027833] [059/171] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [118.194472] Starting subtest: addfb25-yf-tiled-legacy [118.195671] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [118.295399] [060/171] (894s left) kms_addfb_basic (addfb25-y-tiled-legacy) [118.461840] Starting subtest: addfb25-y-tiled-legacy [118.463065] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [118.561376] [061/171] (894s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [118.727460] Starting subtest: addfb25-y-tiled-small-legacy [118.728643] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [118.811406] [062/171] (894s left) kms_addfb_basic (bad-pitch-0) [118.947547] Starting subtest: bad-pitch-0 [118.948701] Subtest bad-pitch-0: SUCCESS (0.000s) [119.078579] [063/171] (894s left) kms_addfb_basic (bad-pitch-1024) [119.212918] Starting subtest: bad-pitch-1024 [119.214076] Subtest bad-pitch-1024: SUCCESS (0.000s) [119.344787] [064/171] (893s left) kms_addfb_basic (bad-pitch-128) [119.479221] Starting subtest: bad-pitch-128 [119.480302] Subtest bad-pitch-128: SUCCESS (0.000s) [119.594625] [065/171] (893s left) kms_addfb_basic (bad-pitch-256) [119.731083] Starting subtest: bad-pitch-256 [119.732223] Subtest bad-pitch-256: SUCCESS (0.000s) [119.844658] [066/171] (893s left) kms_addfb_basic (bad-pitch-32) [119.978670] Starting subtest: bad-pitch-32 [119.980034] Subtest bad-pitch-32: SUCCESS (0.000s) [120.111984] [067/171] (893s left) kms_addfb_basic (bad-pitch-63) [120.246606] Starting subtest: bad-pitch-63 [120.247819] Subtest bad-pitch-63: SUCCESS (0.000s) [120.378671] [068/171] (892s left) kms_addfb_basic (bad-pitch-65536) [120.512624] Starting subtest: bad-pitch-65536 [120.513812] Subtest bad-pitch-65536: SUCCESS (0.000s) [120.644947] [069/171] (892s left) kms_addfb_basic (bad-pitch-999) [120.779113] Starting subtest: bad-pitch-999 [120.780216] Subtest bad-pitch-999: SUCCESS (0.000s) [120.911755] [070/171] (892s left) kms_addfb_basic (basic) [121.047232] Starting subtest: basic [121.048310] Subtest basic: SUCCESS (0.000s) [121.178557] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [121.314480] Starting subtest: basic-x-tiled-legacy [121.315540] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [121.450239] [072/171] (891s left) kms_addfb_basic (basic-y-tiled-legacy) [121.586153] Starting subtest: basic-y-tiled-legacy [121.587241] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [121.712551] [073/171] (891s left) kms_addfb_basic (bo-too-small) [121.876402] Starting subtest: bo-too-small [121.877553] Subtest bo-too-small: SUCCESS (0.000s) [121.978267] [074/171] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [122.142440] Starting subtest: bo-too-small-due-to-tiling [122.143535] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [122.244299] [075/171] (891s left) kms_addfb_basic (clobberred-modifier) [122.379510] Starting subtest: clobberred-modifier [122.380840] Subtest clobberred-modifier: SUCCESS (0.000s) [122.511965] [076/171] (890s left) kms_addfb_basic (framebuffer-vs-set-tiling) [122.647615] Starting subtest: framebuffer-vs-set-tiling [122.648710] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [122.778737] [077/171] (890s left) kms_addfb_basic (invalid-get-prop) [122.914111] Starting subtest: invalid-get-prop [122.915197] Subtest invalid-get-prop: SUCCESS (0.000s) [123.027616] [078/171] (890s left) kms_addfb_basic (invalid-get-prop-any) [123.169395] Starting subtest: invalid-get-prop-any [123.170469] Subtest invalid-get-prop-any: SUCCESS (0.000s) [123.278432] [079/171] (890s left) kms_addfb_basic (invalid-set-prop) [123.412886] Starting subtest: invalid-set-prop [123.414259] Subtest invalid-set-prop: SUCCESS (0.000s) [123.545205] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [123.679245] Starting subtest: invalid-set-prop-any [123.680318] Subtest invalid-set-prop-any: SUCCESS (0.000s) [123.811883] [081/171] (889s left) kms_addfb_basic (no-handle) [123.947834] Starting subtest: no-handle [123.949080] Subtest no-handle: SUCCESS (0.000s) [124.078336] [082/171] (889s left) kms_addfb_basic (size-max) [124.241812] Starting subtest: size-max [124.243020] Subtest size-max: SUCCESS (0.000s) [124.327693] [083/171] (889s left) kms_addfb_basic (small-bo) [124.492226] Starting subtest: small-bo [124.493435] Subtest small-bo: SUCCESS (0.000s) [124.595274] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [124.731387] Starting subtest: tile-pitch-mismatch [124.732462] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [124.844771] [085/171] (888s left) kms_addfb_basic (too-high) [125.009789] Starting subtest: too-high [125.011064] Subtest too-high: SUCCESS (0.001s) [125.110804] [086/171] (888s left) kms_addfb_basic (too-wide) [125.274392] Starting subtest: too-wide [125.275519] Subtest too-wide: SUCCESS (0.000s) [125.378180] [087/171] (888s left) kms_addfb_basic (unused-handle) [125.513877] Starting subtest: unused-handle [125.515216] Subtest unused-handle: SUCCESS (0.000s) [125.644812] [088/171] (888s left) kms_addfb_basic (unused-modifier) [125.780213] Starting subtest: unused-modifier [125.781315] Subtest unused-modifier: SUCCESS (0.000s) [125.912053] [089/171] (887s left) kms_addfb_basic (unused-offsets) [126.047152] Starting subtest: unused-offsets [126.048226] Subtest unused-offsets: SUCCESS (0.000s) [126.178500] [090/171] (887s left) kms_addfb_basic (unused-pitches) [126.313808] Starting subtest: unused-pitches [126.315073] Subtest unused-pitches: SUCCESS (0.000s) [126.444784] [091/171] (887s left) kms_busy (basic) [126.614566] Starting subtest: basic [126.618444] Starting dynamic subtest: flip [127.596180] Dynamic subtest flip: SUCCESS (0.976s) [127.612252] Starting dynamic subtest: modeset [131.432804] Dynamic subtest modeset: SUCCESS (3.839s) [131.433946] Subtest basic: SUCCESS (4.818s) [132.406695] [092/171] (881s left) kms_chamelium_hpd (dp-hpd-fast) [132.890348] Subtest dp-hpd-fast: SKIP (0.000s) [133.760762] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [134.226758] Subtest dp-edid-read: SKIP (0.000s) [135.104225] [094/171] (878s left) kms_chamelium_frames (dp-crc-fast) [135.575395] Subtest dp-crc-fast: SKIP (0.000s) [136.448146] [095/171] (877s left) kms_chamelium_hpd (hdmi-hpd-fast) [136.933525] Subtest hdmi-hpd-fast: SKIP (0.000s) [137.791444] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [138.273598] Subtest hdmi-edid-read: SKIP (0.000s) [139.155453] [097/171] (874s left) kms_chamelium_frames (hdmi-crc-fast) [139.623495] Subtest hdmi-crc-fast: SKIP (0.000s) [140.480121] [098/171] (873s left) kms_chamelium_hpd (vga-hpd-fast) [140.963016] Subtest vga-hpd-fast: SKIP (0.000s) [141.831780] [099/171] (872s left) kms_chamelium_edid (vga-edid-read) [142.312348] Subtest vga-edid-read: SKIP (0.000s) [143.233914] [100/171] (870s left) kms_prop_blob (basic) [143.363631] Starting subtest: basic [143.364715] Subtest basic: SUCCESS (0.000s) [143.454967] [101/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [143.611500] Starting subtest: basic-busy-flip-before-cursor-atomic [143.613741] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [143.699393] [102/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [143.861510] Starting subtest: basic-busy-flip-before-cursor-legacy [143.863612] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [143.949515] [103/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [144.112104] Starting subtest: basic-flip-after-cursor-atomic [145.399906] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.288s) [146.356730] [104/171] (867s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [146.520057] Starting subtest: basic-flip-after-cursor-legacy [147.816892] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.297s) [148.786949] [105/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [148.951667] Starting subtest: basic-flip-after-cursor-varying-size [150.246912] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.296s) [151.216403] [106/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [151.379883] Starting subtest: basic-flip-before-cursor-atomic [152.675314] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.296s) [153.652476] [107/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [153.815727] Starting subtest: basic-flip-before-cursor-legacy [155.113154] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.298s) [156.082986] [108/171] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [156.245673] Starting subtest: basic-flip-before-cursor-varying-size [157.530850] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.284s) [158.451664] [109/171] (855s left) kms_flip (basic-flip-vs-dpms) [158.599895] Starting subtest: basic-flip-vs-dpms [158.602804] Starting dynamic subtest: A-eDP1 [161.459186] Dynamic subtest A-eDP1: SUCCESS (2.856s) [161.475552] Starting dynamic subtest: B-eDP1 [163.809137] Dynamic subtest B-eDP1: SUCCESS (2.349s) [163.827069] Starting dynamic subtest: C-eDP1 [166.183104] Dynamic subtest C-eDP1: SUCCESS (2.374s) [166.187742] Subtest basic-flip-vs-dpms: SUCCESS (7.587s) [167.090826] [110/171] (847s left) kms_flip (basic-flip-vs-modeset) [167.233398] Starting subtest: basic-flip-vs-modeset [167.236514] Starting dynamic subtest: A-eDP1 [170.091694] Dynamic subtest A-eDP1: SUCCESS (2.854s) [170.107753] Starting dynamic subtest: B-eDP1 [172.466088] Dynamic subtest B-eDP1: SUCCESS (2.368s) [172.481223] Starting dynamic subtest: C-eDP1 [174.833076] Dynamic subtest C-eDP1: SUCCESS (2.366s) [174.834269] Subtest basic-flip-vs-modeset: SUCCESS (7.596s) [175.797233] [111/171] (838s left) kms_flip (basic-flip-vs-wf_vblank) [175.941394] Starting subtest: basic-flip-vs-wf_vblank [175.944449] Starting dynamic subtest: A-eDP1 [178.260250] Dynamic subtest A-eDP1: SUCCESS (2.316s) [178.276686] Starting dynamic subtest: B-eDP1 [180.547176] Dynamic subtest B-eDP1: SUCCESS (2.286s) [180.563858] Starting dynamic subtest: C-eDP1 [182.791521] Dynamic subtest C-eDP1: SUCCESS (2.243s) [182.793974] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.854s) [184.116069] [112/171] (830s left) kms_flip (basic-plain-flip) [184.251811] Starting subtest: basic-plain-flip [184.254679] Starting dynamic subtest: A-eDP1 [186.296983] Dynamic subtest A-eDP1: SUCCESS (2.043s) [186.313222] Starting dynamic subtest: B-eDP1 [188.266377] Dynamic subtest B-eDP1: SUCCESS (1.969s) [188.283024] Starting dynamic subtest: C-eDP1 [190.248851] Dynamic subtest C-eDP1: SUCCESS (1.981s) [190.251324] Subtest basic-plain-flip: SUCCESS (6.002s) [191.539546] [113/171] (822s left) kms_force_connector_basic (force-connector-state) [191.673420] Starting subtest: force-connector-state [193.388550] Subtest force-connector-state: SUCCESS (1.716s) [194.004101] [114/171] (820s left) kms_force_connector_basic (force-edid) [194.142732] Starting subtest: force-edid [194.397858] Subtest force-edid: SUCCESS (0.251s) [194.520436] [115/171] (820s left) kms_force_connector_basic (force-load-detect) [194.659684] Starting subtest: force-load-detect [194.661952] Subtest force-load-detect: SKIP (0.000s) [194.770980] [116/171] (819s left) kms_force_connector_basic (prune-stale-modes) [194.911988] Starting subtest: prune-stale-modes [195.217364] Subtest prune-stale-modes: SUCCESS (0.306s) [195.337364] [117/171] (819s left) kms_frontbuffer_tracking (basic) [195.502539] Starting subtest: basic [198.803319] Subtest basic: SUCCESS (3.302s) [198.921832] [118/171] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [199.083195] Starting subtest: compare-crc-sanitycheck [199.086179] Starting dynamic subtest: pipe-A-eDP-1 [199.772715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s) [199.793423] Starting dynamic subtest: pipe-B-eDP-1 [201.137438] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.359s) [201.155899] Starting dynamic subtest: pipe-C-eDP-1 [202.683941] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.537s) [202.685276] Subtest compare-crc-sanitycheck: SUCCESS (3.595s) [203.630051] [119/171] (811s left) kms_pipe_crc_basic (hang-read-crc) [203.794363] Starting subtest: hang-read-crc [203.797508] Starting dynamic subtest: pipe-A-eDP-1 [206.109853] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.313s) [206.128369] Starting dynamic subtest: pipe-B-eDP-1 [209.085551] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.970s) [209.103505] Starting dynamic subtest: pipe-C-eDP-1 [212.371193] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.281s) [212.372385] Subtest hang-read-crc: SUCCESS (8.576s) [213.295907] [120/171] (801s left) kms_pipe_crc_basic (nonblocking-crc) [213.464810] Starting subtest: nonblocking-crc [213.468208] Starting dynamic subtest: pipe-A-eDP-1 [214.320686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s) [214.339630] Starting dynamic subtest: pipe-B-eDP-1 [215.874939] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [215.891888] Starting dynamic subtest: pipe-C-eDP-1 [217.579184] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.702s) [217.580369] Subtest nonblocking-crc: SUCCESS (4.115s) [218.542250] [121/171] (796s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [218.709657] Starting subtest: nonblocking-crc-frame-sequence [218.713215] Starting dynamic subtest: pipe-A-eDP-1 [219.567408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.855s) [219.586713] Starting dynamic subtest: pipe-B-eDP-1 [221.138164] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s) [221.155658] Starting dynamic subtest: pipe-C-eDP-1 [222.852609] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.709s) [222.853982] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.141s) [223.788963] [122/171] (790s left) kms_pipe_crc_basic (read-crc) [223.957441] Starting subtest: read-crc [223.960514] Starting dynamic subtest: pipe-A-eDP-1 [224.750398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.789s) [224.769204] Starting dynamic subtest: pipe-B-eDP-1 [226.240731] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s) [226.260268] Starting dynamic subtest: pipe-C-eDP-1 [227.889022] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.645s) [227.890236] Subtest read-crc: SUCCESS (3.932s) [228.845816] [123/171] (785s left) kms_pipe_crc_basic (read-crc-frame-sequence) [229.013347] Starting subtest: read-crc-frame-sequence [229.016699] Starting dynamic subtest: pipe-A-eDP-1 [229.807246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s) [229.824854] Starting dynamic subtest: pipe-B-eDP-1 [231.293298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.482s) [231.312106] Starting dynamic subtest: pipe-C-eDP-1 [232.931750] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.634s) [232.932859] Subtest read-crc-frame-sequence: SUCCESS (3.920s) [233.901206] [124/171] (780s left) kms_psr (primary_page_flip) [234.061714] Starting subtest: primary_page_flip [238.337473] Subtest primary_page_flip: SUCCESS (4.263s) [239.277956] [125/171] (775s left) kms_psr (cursor_plane_move) [239.448886] Starting subtest: cursor_plane_move [243.577426] Subtest cursor_plane_move: SUCCESS (4.127s) [244.526069] [126/171] (770s left) kms_psr (sprite_plane_onoff) [244.692932] Starting subtest: sprite_plane_onoff [248.978907] Subtest sprite_plane_onoff: SUCCESS (4.284s) [249.901393] [127/171] (764s left) kms_psr (primary_mmap_gtt) [250.068215] Starting subtest: primary_mmap_gtt [254.319059] Subtest primary_mmap_gtt: SUCCESS (4.249s) [255.278139] [128/171] (759s left) kms_setmode (basic-clone-single-crtc) [255.409827] Starting subtest: basic-clone-single-crtc [255.413052] Subtest basic-clone-single-crtc: SKIP (0.000s) [255.494847] [129/171] (759s left) i915_pm_backlight (basic-brightness) [255.654121] Starting subtest: basic-brightness [255.771216] Starting dynamic subtest: eDP-1 [256.309394] Dynamic subtest eDP-1: SUCCESS (0.545s) [256.310621] Subtest basic-brightness: SUCCESS (0.653s) [257.262990] [130/171] (757s left) i915_pm_rpm (basic-pci-d3-state) [259.152146] Starting subtest: basic-pci-d3-state [263.561850] Subtest basic-pci-d3-state: SUCCESS (4.409s) [263.763447] [131/171] (751s left) i915_pm_rpm (basic-rte) [263.896946] Starting subtest: basic-rte [270.025737] Subtest basic-rte: SUCCESS (6.128s) [271.493545] [132/171] (743s left) i915_pm_rps (basic-api) [271.629761] Starting subtest: basic-api [271.634223] Subtest basic-api: SUCCESS (0.004s) [271.726134] [133/171] (743s left) prime_self_import (basic-llseek-bad) [271.851709] Starting subtest: basic-llseek-bad [271.855370] Subtest basic-llseek-bad: SUCCESS (0.002s) [271.942068] [134/171] (743s left) prime_self_import (basic-llseek-size) [272.075682] Starting subtest: basic-llseek-size [272.079322] Subtest basic-llseek-size: SUCCESS (0.004s) [272.175576] [135/171] (742s left) prime_self_import (basic-with_fd_dup) [272.308539] Starting subtest: basic-with_fd_dup [272.312530] Subtest basic-with_fd_dup: SUCCESS (0.004s) [272.408684] [136/171] (742s left) prime_self_import (basic-with_one_bo) [272.542843] Starting subtest: basic-with_one_bo [272.548454] Subtest basic-with_one_bo: SUCCESS (0.005s) [272.624291] [137/171] (742s left) prime_self_import (basic-with_one_bo_two_files) [272.758447] Starting subtest: basic-with_one_bo_two_files [272.761830] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [272.858603] [138/171] (742s left) prime_self_import (basic-with_two_bos) [272.994345] Starting subtest: basic-with_two_bos [272.997775] Subtest basic-with_two_bos: SUCCESS (0.004s) [273.091787] [139/171] (742s left) prime_vgem (basic-fence-flip) [273.246789] Starting subtest: basic-fence-flip [273.721327] Subtest basic-fence-flip: SUCCESS (0.474s) [273.843513] [140/171] (741s left) prime_vgem (basic-fence-mmap) [274.009751] Starting subtest: basic-fence-mmap [274.057549] Subtest basic-fence-mmap: SUCCESS (0.048s) [274.159382] [141/171] (741s left) prime_vgem (basic-fence-read) [274.319467] Starting subtest: basic-fence-read [274.392255] Subtest basic-fence-read: SUCCESS (0.073s) [274.475953] [142/171] (740s left) prime_vgem (basic-gtt) [274.636382] Starting subtest: basic-gtt [274.659322] Subtest basic-gtt: SUCCESS (0.025s) [274.765322] [143/171] (740s left) prime_vgem (basic-read) [274.913325] Starting subtest: basic-read [274.948914] Subtest basic-read: SUCCESS (0.035s) [275.047744] [144/171] (740s left) prime_vgem (basic-write) [275.196508] Starting subtest: basic-write [275.238655] Subtest basic-write: SUCCESS (0.042s) [275.330612] [145/171] (740s left) prime_vgem (basic-userptr) [275.493257] Starting subtest: basic-userptr [275.508589] Subtest basic-userptr: SKIP (0.014s) [275.619843] [146/171] (739s left) vgem_basic (setversion) [275.756042] Starting subtest: setversion [275.758614] Subtest setversion: SUCCESS (0.000s) [275.830056] [147/171] (739s left) vgem_basic (create) [275.972686] Starting subtest: create [275.973850] Subtest create: SUCCESS (0.000s) [276.047852] [148/171] (739s left) vgem_basic (debugfs) [276.189537] Starting subtest: debugfs [276.190830] Subtest debugfs: SUCCESS (0.001s) [276.266217] [149/171] (739s left) vgem_basic (dmabuf-export) [276.405572] Starting subtest: dmabuf-export [276.409137] Subtest dmabuf-export: SUCCESS (0.003s) [276.515688] [150/171] (739s left) vgem_basic (dmabuf-fence) [276.674757] Starting subtest: dmabuf-fence [276.676063] Subtest dmabuf-fence: SUCCESS (0.001s) [276.744268] [151/171] (738s left) vgem_basic (dmabuf-fence-before) [276.890805] Starting subtest: dmabuf-fence-before [276.892153] Subtest dmabuf-fence-before: SUCCESS (0.001s) [276.960176] [152/171] (738s left) vgem_basic (dmabuf-mmap) [277.107196] Starting subtest: dmabuf-mmap [277.132523] Subtest dmabuf-mmap: SUCCESS (0.026s) [277.210761] [153/171] (738s left) vgem_basic (mmap) [277.357403] Starting subtest: mmap [277.373079] Subtest mmap: SUCCESS (0.016s) [277.443850] [154/171] (738s left) vgem_basic (second-client) [277.591073] Starting subtest: second-client [277.640583] Subtest second-client: SUCCESS (0.049s) [277.709813] [155/171] (738s left) vgem_basic (sysfs) [277.857422] Starting subtest: sysfs [277.858538] Subtest sysfs: SUCCESS (0.001s) [277.927095] [156/171] (737s left) core_hotunplug (unbind-rebind) [278.107533] Starting subtest: unbind-rebind [280.512419] Subtest unbind-rebind: SUCCESS (2.402s) [280.544175] [157/171] (735s left) vgem_basic (unload) [280.683097] Starting subtest: unload [309.684237] Subtest unload: SUCCESS (28.967s) [309.799472] [158/171] (706s left) i915_module_load (reload) [309.930759] Starting subtest: reload [313.346596] Subtest reload: SUCCESS (3.415s) [313.375385] [159/171] (702s left) gem_lmem_swapping (basic) [313.532704] Subtest basic: SKIP (0.000s) [313.578699] [160/171] (702s left) gem_lmem_swapping (parallel-random-engines) [313.722067] Subtest parallel-random-engines: SKIP (0.000s) [313.764505] [161/171] (702s left) gem_lmem_swapping (random-engines) [313.908266] Subtest random-engines: SKIP (0.000s) [313.963459] [162/171] (701s left) gem_lmem_swapping (verify-random) [314.104240] Subtest verify-random: SKIP (0.000s) [314.146218] [163/171] (701s left) i915_pm_rpm (module-reload) [326.652754] Starting subtest: module-reload [361.528759] Subtest module-reload: SUCCESS (34.870s) [361.553974] [164/171] (654s left) i915_selftest (live) [361.700202] Starting subtest: live [361.701518] Starting dynamic subtest: sanitycheck [363.534355] Dynamic subtest sanitycheck: SUCCESS (1.824s) [363.548715] Starting dynamic subtest: uncore [365.327525] Dynamic subtest uncore: SUCCESS (1.791s) [365.341934] Starting dynamic subtest: workarounds [367.327419] Dynamic subtest workarounds: SUCCESS (1.998s) [367.341948] Starting dynamic subtest: gt_engines [369.563445] Dynamic subtest gt_engines: SUCCESS (2.234s) [369.577835] Starting dynamic subtest: gt_timelines [381.572403] Dynamic subtest gt_timelines: SUCCESS (12.007s) [381.586869] Starting dynamic subtest: gt_contexts [383.502240] Dynamic subtest gt_contexts: SUCCESS (1.928s) [383.516722] Starting dynamic subtest: gt_lrc [387.818494] Dynamic subtest gt_lrc: SUCCESS (4.315s) [387.832931] Starting dynamic subtest: gt_mocs [389.790442] Dynamic subtest gt_mocs: SUCCESS (1.970s) [389.805156] Starting dynamic subtest: gt_pm [394.848524] Dynamic subtest gt_pm: SUCCESS (5.056s) [394.863385] Starting dynamic subtest: gt_heartbeat [396.762558] Dynamic subtest gt_heartbeat: SUCCESS (1.912s) [396.777029] Starting dynamic subtest: gt_tlb [399.841561] Dynamic subtest gt_tlb: SUCCESS (3.077s) [399.856067] Starting dynamic subtest: requests [407.435595] Dynamic subtest requests: SUCCESS (7.592s) [407.450276] Starting dynamic subtest: migrate [411.969493] Dynamic subtest migrate: SUCCESS (4.532s) [411.984136] Starting dynamic subtest: active [413.774458] Dynamic subtest active: SUCCESS (1.803s) [413.789097] Starting dynamic subtest: objects [417.172393] Dynamic subtest objects: SUCCESS (3.396s) [417.187310] Starting dynamic subtest: mman [424.075930] Dynamic subtest mman: SUCCESS (6.901s) [424.090868] Starting dynamic subtest: dmabuf [425.893807] Dynamic subtest dmabuf: SUCCESS (1.816s) [425.908786] Starting dynamic subtest: vma [427.725465] Dynamic subtest vma: SUCCESS (1.830s) [427.740221] Starting dynamic subtest: coherency [433.524477] Dynamic subtest coherency: SUCCESS (5.797s) [433.539533] Starting dynamic subtest: gtt [442.779522] Dynamic subtest gtt: SUCCESS (9.253s) [442.794307] Starting dynamic subtest: gem [444.714406] Dynamic subtest gem: SUCCESS (1.933s) [444.729117] Starting dynamic subtest: evict [448.402502] Dynamic subtest evict: SUCCESS (3.686s) [448.417055] Starting dynamic subtest: hugepages [455.276439] Dynamic subtest hugepages: SUCCESS (6.872s) [455.291832] Starting dynamic subtest: gem_contexts [470.236492] Dynamic subtest gem_contexts: SUCCESS (14.958s) [470.251735] Starting dynamic subtest: client [472.099435] Dynamic subtest client: SUCCESS (1.861s) [472.114526] Starting dynamic subtest: gem_migrate [473.942889] Dynamic subtest gem_migrate: SUCCESS (1.841s) [473.958326] Starting dynamic subtest: reset [479.303484] Dynamic subtest reset: SUCCESS (5.359s) [479.318712] Starting dynamic subtest: memory_region [481.108914] Dynamic subtest memory_region: SUCCESS (1.804s) [481.124334] Starting dynamic subtest: hangcheck [505.515551] Dynamic subtest hangcheck: SUCCESS (24.404s) [505.530832] Starting dynamic subtest: execlists [515.562600] Dynamic subtest execlists: SUCCESS (10.046s) [515.579505] Starting dynamic subtest: ring_submission [517.398325] Dynamic subtest ring_submission: SUCCESS (1.834s) [517.413591] Starting dynamic subtest: perf [519.330531] Dynamic subtest perf: SUCCESS (1.930s) [519.345837] Starting dynamic subtest: slpc [521.174352] Dynamic subtest slpc: SUCCESS (1.842s) [521.189573] Starting dynamic subtest: guc [523.039457] Dynamic subtest guc: SUCCESS (1.863s) [523.054591] Starting dynamic subtest: guc_multi_lrc [524.886207] Dynamic subtest guc_multi_lrc: SUCCESS (1.845s) [524.901481] Starting dynamic subtest: guc_hang [526.730268] Dynamic subtest guc_hang: SUCCESS (1.842s) [526.745983] Starting dynamic subtest: late_gt_pm [528.585272] Dynamic subtest late_gt_pm: SUCCESS (1.853s) [528.586516] Subtest live: SUCCESS (166.876s) [528.775044] [165/171] (487s left) dmabuf (all-tests) [528.913373] Starting subtest: all-tests [528.914981] Starting dynamic subtest: sanitycheck [528.975706] Dynamic subtest sanitycheck: SUCCESS (0.061s) [528.993140] Starting dynamic subtest: dma_fence [529.167057] Dynamic subtest dma_fence: SUCCESS (0.189s) [529.184531] Starting dynamic subtest: dma_fence_chain [546.975455] Dynamic subtest dma_fence_chain: SUCCESS (17.798s) [546.987722] Starting dynamic subtest: dma_fence_unwrap [547.050922] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s) [547.068815] Starting dynamic subtest: dma_resv [547.120709] Dynamic subtest dma_resv: SUCCESS (0.068s) [547.123165] Subtest all-tests: SUCCESS (18.207s) [547.153346] [166/171] (468s left) i915_suspend (basic-s2idle-without-i915) [547.279348] Starting subtest: basic-s2idle-without-i915 [571.140349] Subtest basic-s2idle-without-i915: SUCCESS (8.303s) [571.453585] [167/171] (460s left) i915_suspend (basic-s3-without-i915) [571.590993] Starting subtest: basic-s3-without-i915 [595.232364] Subtest basic-s3-without-i915: SUCCESS (7.082s) [595.560065] [168/171] (452s left) gem_exec_suspend (basic-s0) [595.713664] Starting subtest: basic-S0 [595.714852] Starting dynamic subtest: smem [615.352176] Dynamic subtest smem: SUCCESS (3.827s) [615.353262] Subtest basic-S0: SUCCESS (3.828s) [615.560918] [169/171] (448s left) gem_exec_suspend (basic-s3) [615.707998] Starting subtest: basic-S3 [615.709192] Starting dynamic subtest: smem [634.271447] Dynamic subtest smem: SUCCESS (3.596s) [634.272541] Subtest basic-S3: SUCCESS (3.597s) [634.430560] [170/171] (444s left) kms_chamelium_hpd (common-hpd-after-suspend) [634.908002] Subtest common-hpd-after-suspend: SKIP (0.000s) [635.826741] [171/171] (443s left) kms_pipe_crc_basic (suspend-read-crc) [635.986673] Starting subtest: suspend-read-crc [635.993739] Starting dynamic subtest: pipe-A-eDP-1 [654.282386] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s) [654.303380] Starting dynamic subtest: pipe-B-eDP-1 [672.233024] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.110s) [672.254971] Starting dynamic subtest: pipe-C-eDP-1 [691.200882] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.237s) [691.201990] Subtest suspend-read-crc: SUCCESS (8.856s) [692.102530] Closing watchdogs Done.