[45.524152] Initializing watchdogs [45.524328] /dev/watchdog0 [45.534478] [001/170] (960s left) i915_module_load (load) [45.676110] Starting subtest: load [48.194151] Subtest load: SUCCESS (2.517s) [48.240174] [002/170] (957s left) core_auth (basic-auth) [48.430533] Starting subtest: basic-auth [48.433249] Subtest basic-auth: SUCCESS (0.002s) [48.512797] [003/170] (957s left) debugfs_test (read_all_entries) [48.695468] Starting subtest: read_all_entries [48.774564] Subtest read_all_entries: SUCCESS (0.078s) [48.887808] [004/170] (957s left) debugfs_test (basic-hwmon) [49.032873] Starting subtest: basic-hwmon [49.035087] Subtest basic-hwmon: SKIP (0.000s) [49.137368] [005/170] (957s left) fbdev (eof) [49.290803] Starting subtest: eof [49.292165] Subtest eof: SUCCESS (0.000s) [49.355483] [006/170] (956s left) fbdev (info) [49.494021] Starting subtest: info [49.495425] Subtest info: SUCCESS (0.000s) [49.571288] [007/170] (956s left) fbdev (nullptr) [49.725286] Starting subtest: nullptr [49.727176] Subtest nullptr: SUCCESS (0.000s) [49.791511] [008/170] (956s left) fbdev (read) [49.939836] Starting subtest: read [57.050538] Subtest read: SUCCESS (7.076s) [57.088787] [009/170] (949s left) fbdev (write) [57.240902] Starting subtest: write [60.991247] Subtest write: SUCCESS (3.741s) [61.054233] [010/170] (945s left) gem_basic (bad-close) [61.190537] Starting subtest: bad-close [61.192698] Subtest bad-close: SUCCESS (0.000s) [61.271109] [011/170] (945s left) gem_basic (create-close) [61.411682] Starting subtest: create-close [61.413827] Subtest create-close: SUCCESS (0.000s) [61.506580] [012/170] (944s left) gem_basic (create-fd-close) [61.650193] Starting subtest: create-fd-close [61.652403] Subtest create-fd-close: SUCCESS (0.000s) [61.738128] [013/170] (944s left) gem_busy (busy@all-engines) [61.896143] Starting subtest: busy [61.897322] Starting dynamic subtest: all-engines [61.965442] Dynamic subtest all-engines: SUCCESS (0.069s) [61.966773] Subtest busy: SUCCESS (0.069s) [62.356759] [014/170] (944s left) gem_close_race (basic-process) [62.509423] Starting subtest: basic-process [62.580696] Subtest basic-process: SUCCESS (0.071s) [62.790050] [015/170] (943s left) gem_close_race (basic-threads) [62.949340] Starting subtest: basic-threads [64.114853] Subtest basic-threads: SUCCESS (1.165s) [64.336332] [016/170] (942s left) gem_ctx_create (basic) [64.489973] Starting subtest: basic [64.491551] Subtest basic: SUCCESS (0.000s) [64.689211] [017/170] (941s left) gem_ctx_create (basic-files) [64.839846] Starting subtest: basic-files [66.864887] Subtest basic-files: SUCCESS (2.025s) [67.117062] [018/170] (939s left) gem_ctx_exec (basic) [67.271661] Starting subtest: basic [67.275495] Subtest basic: SUCCESS (0.005s) [67.387569] [019/170] (939s left) gem_exec_basic (basic) [67.527296] Starting subtest: basic [67.528436] Starting dynamic subtest: rcs0-smem [67.529449] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [67.541523] Starting dynamic subtest: bcs0-smem [67.542759] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [67.552729] Starting dynamic subtest: vcs0-smem [67.553886] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [67.563700] Starting dynamic subtest: vecs0-smem [67.564876] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [67.566184] Subtest basic: SUCCESS (0.005s) [67.739142] [020/170] (938s left) gem_exec_create (basic) [67.893321] Starting subtest: basic [67.894392] Starting dynamic subtest: smem [69.934798] Dynamic subtest smem: SUCCESS (2.042s) [69.936204] Subtest basic: SUCCESS (2.042s) [70.157190] [021/170] (936s left) gem_exec_fence (basic-busy) [70.453335] Starting subtest: basic-busy [70.454648] Starting dynamic subtest: rcs0 [70.479697] Dynamic subtest rcs0: SUCCESS (0.035s) [70.491275] Starting dynamic subtest: bcs0 [70.509234] Dynamic subtest bcs0: SUCCESS (0.029s) [70.520346] Starting dynamic subtest: vcs0 [70.535787] Dynamic subtest vcs0: SUCCESS (0.027s) [70.546741] Starting dynamic subtest: vecs0 [70.559049] Dynamic subtest vecs0: SUCCESS (0.023s) [70.560504] Subtest basic-busy: SUCCESS (0.114s) [71.157153] [022/170] (935s left) gem_exec_fence (basic-wait) [71.459831] Starting subtest: basic-wait [71.461310] Starting dynamic subtest: rcs0 [71.481225] Dynamic subtest rcs0: SUCCESS (0.029s) [71.495560] Starting dynamic subtest: bcs0 [71.521781] Dynamic subtest bcs0: SUCCESS (0.040s) [71.535571] Starting dynamic subtest: vcs0 [71.557459] Dynamic subtest vcs0: SUCCESS (0.035s) [71.569885] Starting dynamic subtest: vecs0 [71.577504] Dynamic subtest vecs0: SUCCESS (0.020s) [71.579084] Subtest basic-wait: SUCCESS (0.126s) [72.123585] [023/170] (934s left) gem_exec_fence (basic-await) [72.423936] Starting subtest: basic-await [72.425164] Starting dynamic subtest: rcs0 [72.513338] Dynamic subtest rcs0: SUCCESS (0.097s) [72.537484] Starting dynamic subtest: bcs0 [72.626038] Dynamic subtest bcs0: SUCCESS (0.111s) [72.652550] Starting dynamic subtest: vcs0 [72.753632] Dynamic subtest vcs0: SUCCESS (0.128s) [72.780610] Starting dynamic subtest: vecs0 [72.883319] Dynamic subtest vecs0: SUCCESS (0.129s) [72.885278] Subtest basic-await: SUCCESS (0.467s) [73.474747] [024/170] (933s left) gem_exec_fence (nb-await) [73.772904] Starting subtest: nb-await [73.774089] Starting dynamic subtest: rcs0 [73.830932] Dynamic subtest rcs0: SUCCESS (0.066s) [73.849374] Starting dynamic subtest: bcs0 [73.900307] Dynamic subtest bcs0: SUCCESS (0.069s) [73.927539] Starting dynamic subtest: vcs0 [73.974808] Dynamic subtest vcs0: SUCCESS (0.074s) [74.001293] Starting dynamic subtest: vecs0 [74.049571] Dynamic subtest vecs0: SUCCESS (0.074s) [74.051617] Subtest nb-await: SUCCESS (0.285s) [74.606992] [025/170] (932s left) gem_exec_gttfill (basic) [74.764371] Starting subtest: basic [82.655230] Subtest basic: SUCCESS (7.882s) [82.842438] [026/170] (923s left) gem_exec_parallel (engines) [83.065782] Starting subtest: engines [83.066973] Starting dynamic subtest: basic [85.554323] Dynamic subtest basic: SUCCESS (2.472s) [85.567075] Starting dynamic subtest: contexts [88.985675] Dynamic subtest contexts: SUCCESS (3.438s) [88.998662] Starting dynamic subtest: fds [93.465348] Dynamic subtest fds: SUCCESS (4.462s) [93.478281] Starting dynamic subtest: userptr [96.020214] Dynamic subtest userptr: SUCCESS (2.557s) [96.022198] Subtest engines: SUCCESS (12.931s) [96.196128] [027/170] (910s left) gem_exec_store (basic) [96.352580] Starting subtest: basic [96.416926] Subtest basic: SUCCESS (0.065s) [96.625653] [028/170] (910s left) gem_flink_basic (bad-flink) [96.761896] Starting subtest: bad-flink [96.763234] Subtest bad-flink: SUCCESS (0.000s) [96.841119] [029/170] (909s left) gem_flink_basic (bad-open) [96.979911] Starting subtest: bad-open [96.981264] Subtest bad-open: SUCCESS (0.000s) [97.058273] [030/170] (909s left) gem_flink_basic (basic) [97.201658] Starting subtest: basic [97.202828] Subtest basic: SUCCESS (0.000s) [97.307963] [031/170] (909s left) gem_flink_basic (double-flink) [97.460655] Starting subtest: double-flink [97.461748] Subtest double-flink: SUCCESS (0.000s) [97.558178] [032/170] (909s left) gem_flink_basic (flink-lifetime) [97.707566] Starting subtest: flink-lifetime [97.710191] Subtest flink-lifetime: SUCCESS (0.002s) [97.807906] [033/170] (909s left) gem_huc_copy (huc-copy) [97.951986] Starting subtest: huc-copy [97.954386] Subtest huc-copy: SKIP (0.000s) [98.074591] [034/170] (908s left) gem_linear_blits (basic) [98.355039] Starting subtest: basic [98.367131] Subtest basic: SUCCESS (0.012s) [98.492246] [035/170] (908s left) gem_mmap (basic) [98.693511] Starting subtest: basic [98.698666] Subtest basic: SUCCESS (0.001s) [98.791888] [036/170] (908s left) gem_mmap_gtt (basic) [98.939536] Starting subtest: basic [98.940664] Subtest basic: SUCCESS (0.001s) [99.023503] [037/170] (907s left) gem_render_linear_blits (basic) [99.165842] Starting subtest: basic [99.216929] Subtest basic: SUCCESS (0.051s) [99.296162] [038/170] (907s left) gem_render_tiled_blits (basic) [99.441540] Starting subtest: basic [99.503394] Subtest basic: SUCCESS (0.061s) [99.577808] [039/170] (907s left) gem_ringfill (basic-all) [99.868931] Starting subtest: basic-all [101.107450] Subtest basic-all: SUCCESS (1.231s) [101.176594] [040/170] (905s left) gem_softpin (allocator-basic) [101.328069] Starting subtest: allocator-basic [101.496881] Subtest allocator-basic: SUCCESS (0.160s) [101.609129] [041/170] (905s left) gem_softpin (allocator-basic-reserve) [101.770324] Starting subtest: allocator-basic-reserve [101.938530] Subtest allocator-basic-reserve: SUCCESS (0.161s) [102.063107] [042/170] (905s left) gem_softpin (safe-alignment) [102.219542] Starting subtest: safe-alignment [102.237809] Subtest safe-alignment: SUCCESS (0.018s) [102.341808] [043/170] (904s left) gem_sync (basic-all) [102.489936] Starting subtest: basic-all [104.740614] Subtest basic-all: SUCCESS (2.227s) [104.925169] [044/170] (902s left) gem_sync (basic-each) [105.080391] Starting subtest: basic-each [107.255197] Subtest basic-each: SUCCESS (2.175s) [107.478863] [045/170] (899s left) gem_tiled_blits (basic) [107.754749] Starting subtest: basic [107.782654] Subtest basic: SUCCESS (0.028s) [107.927544] [046/170] (899s left) gem_tiled_fence_blits (basic) [108.284572] Starting subtest: basic [108.311909] Subtest basic: SUCCESS (0.027s) [108.438679] [047/170] (898s left) gem_tiled_pread_basic [108.976575] [048/170] (898s left) gem_wait (busy@all-engines) [109.130875] Starting subtest: busy [109.132126] Starting dynamic subtest: all-engines [109.671637] Dynamic subtest all-engines: SUCCESS (0.541s) [109.672713] Subtest busy: SUCCESS (0.541s) [109.910069] [049/170] (897s left) gem_wait (wait@all-engines) [110.073369] Starting subtest: wait [110.074454] Starting dynamic subtest: all-engines [111.111279] Dynamic subtest all-engines: SUCCESS (1.037s) [111.113116] Subtest wait: SUCCESS (1.038s) [111.360116] [050/170] (895s left) i915_getparams_basic (basic-eu-total) [111.495741] Starting subtest: basic-eu-total [111.498257] Subtest basic-eu-total: SUCCESS (0.000s) [111.575074] [051/170] (895s left) i915_getparams_basic (basic-subslice-total) [111.712468] Starting subtest: basic-subslice-total [111.714551] Subtest basic-subslice-total: SUCCESS (0.000s) [111.791638] [052/170] (895s left) i915_hangman (error-state-basic) [111.935478] Starting subtest: error-state-basic [111.948095] Subtest error-state-basic: SUCCESS (0.013s) [112.042273] [053/170] (895s left) i915_pciid [112.258665] [054/170] (895s left) kms_addfb_basic (addfb25-bad-modifier) [112.388844] Starting subtest: addfb25-bad-modifier [112.390305] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [112.524251] [055/170] (894s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [112.664084] Starting subtest: addfb25-framebuffer-vs-set-tiling [112.665158] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [112.794245] [056/170] (894s left) kms_addfb_basic (addfb25-modifier-no-flag) [112.934056] Starting subtest: addfb25-modifier-no-flag [112.935103] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [113.059588] [057/170] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy) [113.208372] Starting subtest: addfb25-x-tiled-legacy [113.209445] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [113.324751] [058/170] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [113.463927] Starting subtest: addfb25-x-tiled-mismatch-legacy [113.465131] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [113.591514] [059/170] (893s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [113.758376] Starting subtest: addfb25-yf-tiled-legacy [113.760972] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [113.858334] [060/170] (893s left) kms_addfb_basic (addfb25-y-tiled-legacy) [114.025490] Starting subtest: addfb25-y-tiled-legacy [114.026770] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [114.124652] [061/170] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [114.292418] Starting subtest: addfb25-y-tiled-small-legacy [114.293726] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [114.391343] [062/170] (893s left) kms_addfb_basic (bad-pitch-0) [114.531418] Starting subtest: bad-pitch-0 [114.532452] Subtest bad-pitch-0: SUCCESS (0.000s) [114.658840] [063/170] (893s left) kms_addfb_basic (bad-pitch-1024) [114.796664] Starting subtest: bad-pitch-1024 [114.797772] Subtest bad-pitch-1024: SUCCESS (0.000s) [114.924774] [064/170] (892s left) kms_addfb_basic (bad-pitch-128) [115.064622] Starting subtest: bad-pitch-128 [115.065744] Subtest bad-pitch-128: SUCCESS (0.000s) [115.191746] [065/170] (892s left) kms_addfb_basic (bad-pitch-256) [115.331749] Starting subtest: bad-pitch-256 [115.333035] Subtest bad-pitch-256: SUCCESS (0.000s) [115.458624] [066/170] (892s left) kms_addfb_basic (bad-pitch-32) [115.596426] Starting subtest: bad-pitch-32 [115.597460] Subtest bad-pitch-32: SUCCESS (0.000s) [115.725352] [067/170] (892s left) kms_addfb_basic (bad-pitch-63) [115.861821] Starting subtest: bad-pitch-63 [115.863188] Subtest bad-pitch-63: SUCCESS (0.000s) [115.991557] [068/170] (891s left) kms_addfb_basic (bad-pitch-65536) [116.128566] Starting subtest: bad-pitch-65536 [116.129709] Subtest bad-pitch-65536: SUCCESS (0.000s) [116.258469] [069/170] (891s left) kms_addfb_basic (bad-pitch-999) [116.394678] Starting subtest: bad-pitch-999 [116.395786] Subtest bad-pitch-999: SUCCESS (0.000s) [116.525391] [070/170] (891s left) kms_addfb_basic (basic) [116.669066] Starting subtest: basic [116.670143] Subtest basic: SUCCESS (0.000s) [116.791762] [071/170] (891s left) kms_addfb_basic (basic-x-tiled-legacy) [116.930707] Starting subtest: basic-x-tiled-legacy [116.931820] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [117.041454] [072/170] (890s left) kms_addfb_basic (basic-y-tiled-legacy) [117.181161] Starting subtest: basic-y-tiled-legacy [117.182201] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [117.308244] [073/170] (890s left) kms_addfb_basic (bo-too-small) [117.475257] Starting subtest: bo-too-small [117.476336] Subtest bo-too-small: SUCCESS (0.000s) [117.575253] [074/170] (890s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.742192] Starting subtest: bo-too-small-due-to-tiling [117.743312] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [117.841595] [075/170] (890s left) kms_addfb_basic (clobberred-modifier) [117.978459] Starting subtest: clobberred-modifier [117.979571] Subtest clobberred-modifier: SUCCESS (0.000s) [118.108571] [076/170] (889s left) kms_addfb_basic (framebuffer-vs-set-tiling) [118.245487] Starting subtest: framebuffer-vs-set-tiling [118.246591] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [118.375326] [077/170] (889s left) kms_addfb_basic (invalid-get-prop) [118.513825] Starting subtest: invalid-get-prop [118.514955] Subtest invalid-get-prop: SUCCESS (0.000s) [118.641497] [078/170] (889s left) kms_addfb_basic (invalid-get-prop-any) [118.779543] Starting subtest: invalid-get-prop-any [118.780646] Subtest invalid-get-prop-any: SUCCESS (0.000s) [118.908734] [079/170] (889s left) kms_addfb_basic (invalid-set-prop) [119.045584] Starting subtest: invalid-set-prop [119.046736] Subtest invalid-set-prop: SUCCESS (0.000s) [119.175176] [080/170] (888s left) kms_addfb_basic (invalid-set-prop-any) [119.312512] Starting subtest: invalid-set-prop-any [119.313620] Subtest invalid-set-prop-any: SUCCESS (0.000s) [119.441582] [081/170] (888s left) kms_addfb_basic (no-handle) [119.579396] Starting subtest: no-handle [119.580493] Subtest no-handle: SUCCESS (0.000s) [119.708789] [082/170] (888s left) kms_addfb_basic (size-max) [119.875969] Starting subtest: size-max [119.877158] Subtest size-max: SUCCESS (0.000s) [119.975305] [083/170] (888s left) kms_addfb_basic (small-bo) [120.143121] Starting subtest: small-bo [120.144171] Subtest small-bo: SUCCESS (0.000s) [120.241992] [084/170] (888s left) kms_addfb_basic (tile-pitch-mismatch) [120.380733] Starting subtest: tile-pitch-mismatch [120.381834] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [120.508324] [085/170] (887s left) kms_addfb_basic (too-high) [120.676242] Starting subtest: too-high [120.677474] Subtest too-high: SUCCESS (0.001s) [120.780393] [086/170] (887s left) kms_addfb_basic (too-wide) [120.948168] Starting subtest: too-wide [120.949273] Subtest too-wide: SUCCESS (0.000s) [121.041608] [087/170] (887s left) kms_addfb_basic (unused-handle) [121.178430] Starting subtest: unused-handle [121.179525] Subtest unused-handle: SUCCESS (0.000s) [121.314268] [088/170] (887s left) kms_addfb_basic (unused-modifier) [121.451499] Starting subtest: unused-modifier [121.452715] Subtest unused-modifier: SUCCESS (0.000s) [121.574759] [089/170] (886s left) kms_addfb_basic (unused-offsets) [121.713508] Starting subtest: unused-offsets [121.714581] Subtest unused-offsets: SUCCESS (0.000s) [121.841912] [090/170] (886s left) kms_addfb_basic (unused-pitches) [121.978424] Starting subtest: unused-pitches [121.979565] Subtest unused-pitches: SUCCESS (0.000s) [122.107845] [091/170] (886s left) kms_busy (basic) [122.277490] Starting subtest: basic [122.279655] Starting dynamic subtest: flip [123.266129] Dynamic subtest flip: SUCCESS (0.980s) [123.281418] Starting dynamic subtest: modeset [127.158526] Dynamic subtest modeset: SUCCESS (3.899s) [127.159736] Subtest basic: SUCCESS (4.881s) [128.129706] [092/170] (880s left) kms_chamelium_hpd (dp-hpd-fast) [128.617129] Subtest dp-hpd-fast: SKIP (0.000s) [129.489147] [093/170] (879s left) kms_chamelium_edid (dp-edid-read) [129.971285] Subtest dp-edid-read: SKIP (0.000s) [130.832929] [094/170] (877s left) kms_chamelium_frames (dp-crc-fast) [131.299874] Subtest dp-crc-fast: SKIP (0.000s) [132.175350] [095/170] (876s left) kms_chamelium_hpd (hdmi-hpd-fast) [132.658102] Subtest hdmi-hpd-fast: SKIP (0.000s) [133.518790] [096/170] (875s left) kms_chamelium_edid (hdmi-edid-read) [134.001050] Subtest hdmi-edid-read: SKIP (0.000s) [134.862299] [097/170] (873s left) kms_chamelium_frames (hdmi-crc-fast) [135.344632] Subtest hdmi-crc-fast: SKIP (0.000s) [136.207095] [098/170] (872s left) kms_chamelium_hpd (vga-hpd-fast) [136.691295] Subtest vga-hpd-fast: SKIP (0.000s) [137.547912] [099/170] (871s left) kms_chamelium_edid (vga-edid-read) [138.030339] Subtest vga-edid-read: SKIP (0.000s) [138.895754] [100/170] (869s left) kms_prop_blob (basic) [139.028608] Starting subtest: basic [139.029716] Subtest basic: SUCCESS (0.000s) [139.116969] [101/170] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [139.275622] Starting subtest: basic-busy-flip-before-cursor-atomic [139.277764] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [139.361408] [102/170] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [139.527200] Starting subtest: basic-busy-flip-before-cursor-legacy [139.529163] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [139.611226] [103/170] (869s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [139.777813] Starting subtest: basic-flip-after-cursor-atomic [141.063231] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.285s) [142.018790] [104/170] (866s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [142.185578] Starting subtest: basic-flip-after-cursor-legacy [143.478204] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.292s) [144.449309] [105/170] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [144.615065] Starting subtest: basic-flip-after-cursor-varying-size [145.908460] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.293s) [146.882358] [106/170] (861s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [147.049134] Starting subtest: basic-flip-before-cursor-atomic [148.346488] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.292s) [149.314492] [107/170] (859s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [149.482059] Starting subtest: basic-flip-before-cursor-legacy [150.775423] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.293s) [151.745592] [108/170] (857s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [151.912333] Starting subtest: basic-flip-before-cursor-varying-size [153.192351] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.280s) [154.113624] [109/170] (854s left) kms_flip (basic-flip-vs-dpms) [154.251448] Starting subtest: basic-flip-vs-dpms [154.254218] Starting dynamic subtest: A-eDP1 [157.117996] Dynamic subtest A-eDP1: SUCCESS (2.864s) [157.134265] Starting dynamic subtest: B-eDP1 [159.494737] Dynamic subtest B-eDP1: SUCCESS (2.368s) [159.509218] Starting dynamic subtest: C-eDP1 [161.857254] Dynamic subtest C-eDP1: SUCCESS (2.368s) [161.858324] Subtest basic-flip-vs-dpms: SUCCESS (7.608s) [162.818707] [110/170] (846s left) kms_flip (basic-flip-vs-modeset) [162.964747] Starting subtest: basic-flip-vs-modeset [162.967919] Starting dynamic subtest: A-eDP1 [165.818115] Dynamic subtest A-eDP1: SUCCESS (2.844s) [165.833233] Starting dynamic subtest: B-eDP1 [168.168521] Dynamic subtest B-eDP1: SUCCESS (2.354s) [168.187118] Starting dynamic subtest: C-eDP1 [170.552564] Dynamic subtest C-eDP1: SUCCESS (2.383s) [170.554099] Subtest basic-flip-vs-modeset: SUCCESS (7.590s) [171.522227] [111/170] (837s left) kms_flip (basic-flip-vs-wf_vblank) [171.669115] Starting subtest: basic-flip-vs-wf_vblank [171.672158] Starting dynamic subtest: A-eDP1 [173.987273] Dynamic subtest A-eDP1: SUCCESS (2.315s) [174.003235] Starting dynamic subtest: B-eDP1 [176.271214] Dynamic subtest B-eDP1: SUCCESS (2.283s) [176.287331] Starting dynamic subtest: C-eDP1 [178.524217] Dynamic subtest C-eDP1: SUCCESS (2.252s) [178.526846] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.859s) [179.841783] [112/170] (829s left) kms_flip (basic-plain-flip) [179.987938] Starting subtest: basic-plain-flip [179.991526] Starting dynamic subtest: A-eDP1 [182.023785] Dynamic subtest A-eDP1: SUCCESS (2.032s) [182.039849] Starting dynamic subtest: B-eDP1 [183.990611] Dynamic subtest B-eDP1: SUCCESS (1.966s) [184.006919] Starting dynamic subtest: C-eDP1 [185.973339] Dynamic subtest C-eDP1: SUCCESS (1.982s) [185.975936] Subtest basic-plain-flip: SUCCESS (5.988s) [187.264679] [113/170] (821s left) kms_force_connector_basic (force-connector-state) [187.409580] Starting subtest: force-connector-state [189.109424] Subtest force-connector-state: SUCCESS (1.698s) [189.717440] [114/170] (819s left) kms_force_connector_basic (force-edid) [189.858252] Starting subtest: force-edid [190.115616] Subtest force-edid: SUCCESS (0.255s) [190.247999] [115/170] (818s left) kms_force_connector_basic (force-load-detect) [190.386862] Starting subtest: force-load-detect [190.389618] Subtest force-load-detect: SKIP (0.000s) [190.507632] [116/170] (818s left) kms_force_connector_basic (prune-stale-modes) [190.645718] Starting subtest: prune-stale-modes [190.964841] Subtest prune-stale-modes: SUCCESS (0.309s) [191.097908] [117/170] (818s left) kms_frontbuffer_tracking (basic) [191.272988] Starting subtest: basic [194.601193] Subtest basic: SUCCESS (3.324s) [194.699219] [118/170] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [194.875226] Starting subtest: compare-crc-sanitycheck [194.876651] Starting dynamic subtest: pipe-A-eDP-1 [195.563787] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s) [195.583347] Starting dynamic subtest: pipe-B-eDP-1 [196.936445] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s) [196.954655] Starting dynamic subtest: pipe-C-eDP-1 [198.479198] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.538s) [198.480318] Subtest compare-crc-sanitycheck: SUCCESS (3.604s) [199.418270] [119/170] (809s left) kms_pipe_crc_basic (hang-read-crc) [199.591364] Starting subtest: hang-read-crc [199.593036] Starting dynamic subtest: pipe-A-eDP-1 [201.900218] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.307s) [201.918939] Starting dynamic subtest: pipe-B-eDP-1 [204.895593] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.991s) [204.913787] Starting dynamic subtest: pipe-C-eDP-1 [208.190494] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.288s) [208.197263] Subtest hang-read-crc: SUCCESS (8.597s) [209.148150] [120/170] (800s left) kms_pipe_crc_basic (nonblocking-crc) [209.317355] Starting subtest: nonblocking-crc [209.320418] Starting dynamic subtest: pipe-A-eDP-1 [210.174014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s) [210.193027] Starting dynamic subtest: pipe-B-eDP-1 [211.727320] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [211.745188] Starting dynamic subtest: pipe-C-eDP-1 [213.436527] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.704s) [213.437639] Subtest nonblocking-crc: SUCCESS (4.118s) [214.395988] [121/170] (794s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [214.564059] Starting subtest: nonblocking-crc-frame-sequence [214.567073] Starting dynamic subtest: pipe-A-eDP-1 [215.421838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.855s) [215.440857] Starting dynamic subtest: pipe-B-eDP-1 [216.974961] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s) [216.993789] Starting dynamic subtest: pipe-C-eDP-1 [218.702398] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.723s) [218.703503] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.138s) [219.644046] [122/170] (789s left) kms_pipe_crc_basic (read-crc) [219.815601] Starting subtest: read-crc [219.818691] Starting dynamic subtest: pipe-A-eDP-1 [220.603245] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s) [220.621768] Starting dynamic subtest: pipe-B-eDP-1 [222.090392] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s) [222.108953] Starting dynamic subtest: pipe-C-eDP-1 [223.733899] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.639s) [223.735127] Subtest read-crc: SUCCESS (3.918s) [224.700053] [123/170] (784s left) kms_pipe_crc_basic (read-crc-frame-sequence) [224.879599] Starting subtest: read-crc-frame-sequence [224.882954] Starting dynamic subtest: pipe-A-eDP-1 [225.675702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s) [225.694383] Starting dynamic subtest: pipe-B-eDP-1 [227.164902] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s) [227.183921] Starting dynamic subtest: pipe-C-eDP-1 [228.814948] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.646s) [228.816327] Subtest read-crc-frame-sequence: SUCCESS (3.935s) [229.755753] [124/170] (779s left) kms_psr (primary_page_flip) [229.926833] Starting subtest: primary_page_flip [234.194527] Subtest primary_page_flip: SUCCESS (4.253s) [235.132249] [125/170] (774s left) kms_psr (cursor_plane_move) [235.304356] Starting subtest: cursor_plane_move [239.497228] Subtest cursor_plane_move: SUCCESS (4.191s) [240.444382] [126/170] (768s left) kms_psr (sprite_plane_onoff) [240.618451] Starting subtest: sprite_plane_onoff [244.896103] Subtest sprite_plane_onoff: SUCCESS (4.278s) [245.820076] [127/170] (763s left) kms_psr (primary_mmap_gtt) [245.991250] Starting subtest: primary_mmap_gtt [250.223861] Subtest primary_mmap_gtt: SUCCESS (4.232s) [251.137956] [128/170] (758s left) kms_setmode (basic-clone-single-crtc) [251.279647] Starting subtest: basic-clone-single-crtc [251.282710] Subtest basic-clone-single-crtc: SKIP (0.000s) [251.354329] [129/170] (758s left) i915_pm_backlight (basic-brightness) [251.523622] Starting subtest: basic-brightness [251.646075] Starting dynamic subtest: eDP-1 [252.181909] Dynamic subtest eDP-1: SUCCESS (0.544s) [252.183057] Subtest basic-brightness: SUCCESS (0.659s) [253.117152] [130/170] (756s left) i915_pm_rpm (basic-pci-d3-state) [255.007258] Starting subtest: basic-pci-d3-state [259.423145] Subtest basic-pci-d3-state: SUCCESS (4.410s) [260.284410] [131/170] (749s left) i915_pm_rpm (basic-rte) [260.421586] Starting subtest: basic-rte [266.583484] Subtest basic-rte: SUCCESS (6.161s) [268.325571] [132/170] (741s left) i915_pm_rps (basic-api) [268.472661] Starting subtest: basic-api [268.476780] Subtest basic-api: SUCCESS (0.004s) [268.557683] [133/170] (741s left) prime_self_import (basic-llseek-bad) [268.695811] Starting subtest: basic-llseek-bad [268.700372] Subtest basic-llseek-bad: SUCCESS (0.003s) [268.807674] [134/170] (740s left) prime_self_import (basic-llseek-size) [268.943168] Starting subtest: basic-llseek-size [268.947765] Subtest basic-llseek-size: SUCCESS (0.004s) [269.041435] [135/170] (740s left) prime_self_import (basic-with_fd_dup) [269.177617] Starting subtest: basic-with_fd_dup [269.182206] Subtest basic-with_fd_dup: SUCCESS (0.004s) [269.296553] [136/170] (740s left) prime_self_import (basic-with_one_bo) [269.433612] Starting subtest: basic-with_one_bo [269.438518] Subtest basic-with_one_bo: SUCCESS (0.005s) [269.523300] [137/170] (740s left) prime_self_import (basic-with_one_bo_two_files) [269.660184] Starting subtest: basic-with_one_bo_two_files [269.664857] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [269.762296] [138/170] (740s left) prime_self_import (basic-with_two_bos) [269.898702] Starting subtest: basic-with_two_bos [269.903462] Subtest basic-with_two_bos: SUCCESS (0.004s) [270.013287] [139/170] (739s left) prime_vgem (basic-fence-flip) [270.170819] Starting subtest: basic-fence-flip [270.688503] Subtest basic-fence-flip: SUCCESS (0.516s) [270.813215] [140/170] (739s left) prime_vgem (basic-fence-mmap) [270.962365] Starting subtest: basic-fence-mmap [271.010270] Subtest basic-fence-mmap: SUCCESS (0.048s) [271.096931] [141/170] (738s left) prime_vgem (basic-fence-read) [271.245422] Starting subtest: basic-fence-read [271.318678] Subtest basic-fence-read: SUCCESS (0.073s) [271.413641] [142/170] (738s left) prime_vgem (basic-gtt) [271.561891] Starting subtest: basic-gtt [271.585020] Subtest basic-gtt: SUCCESS (0.023s) [271.694951] [143/170] (738s left) prime_vgem (basic-read) [271.859140] Starting subtest: basic-read [271.894449] Subtest basic-read: SUCCESS (0.035s) [272.013327] [144/170] (737s left) prime_vgem (basic-write) [272.178864] Starting subtest: basic-write [272.220480] Subtest basic-write: SUCCESS (0.041s) [272.312460] [145/170] (737s left) vgem_basic (setversion) [272.454544] Starting subtest: setversion [272.456805] Subtest setversion: SUCCESS (0.000s) [272.530106] [146/170] (737s left) vgem_basic (create) [272.671254] Starting subtest: create [272.672353] Subtest create: SUCCESS (0.000s) [272.745207] [147/170] (737s left) vgem_basic (debugfs) [272.887746] Starting subtest: debugfs [272.888996] Subtest debugfs: SUCCESS (0.001s) [272.962729] [148/170] (737s left) vgem_basic (dmabuf-export) [273.104503] Starting subtest: dmabuf-export [273.109066] Subtest dmabuf-export: SUCCESS (0.003s) [273.213031] [149/170] (736s left) vgem_basic (dmabuf-fence) [273.374140] Starting subtest: dmabuf-fence [273.375253] Subtest dmabuf-fence: SUCCESS (0.001s) [273.442331] [150/170] (736s left) vgem_basic (dmabuf-fence-before) [273.590397] Starting subtest: dmabuf-fence-before [273.591458] Subtest dmabuf-fence-before: SUCCESS (0.001s) [273.658929] [151/170] (736s left) vgem_basic (dmabuf-mmap) [273.807251] Starting subtest: dmabuf-mmap [273.831569] Subtest dmabuf-mmap: SUCCESS (0.026s) [273.909492] [152/170] (736s left) vgem_basic (mmap) [274.057443] Starting subtest: mmap [274.072227] Subtest mmap: SUCCESS (0.017s) [274.142443] [153/170] (736s left) vgem_basic (second-client) [274.290627] Starting subtest: second-client [274.339498] Subtest second-client: SUCCESS (0.049s) [274.409332] [154/170] (735s left) vgem_basic (sysfs) [274.556455] Starting subtest: sysfs [274.557516] Subtest sysfs: SUCCESS (0.001s) [274.625867] [155/170] (735s left) core_hotunplug (unbind-rebind) [274.805808] Starting subtest: unbind-rebind [277.287822] Subtest unbind-rebind: SUCCESS (2.482s) [277.323351] [156/170] (732s left) vgem_basic (unload) [277.461327] Starting subtest: unload [306.508423] Subtest unload: SUCCESS (29.011s) [306.612667] [157/170] (703s left) i915_module_load (reload) [306.752222] Starting subtest: reload [310.237685] Subtest reload: SUCCESS (3.486s) [310.268534] [158/170] (700s left) gem_lmem_swapping (basic) [310.426964] Subtest basic: SKIP (0.000s) [310.472112] [159/170] (699s left) gem_lmem_swapping (parallel-random-engines) [310.618544] Subtest parallel-random-engines: SKIP (0.000s) [310.675883] [160/170] (699s left) gem_lmem_swapping (random-engines) [310.821605] Subtest random-engines: SKIP (0.000s) [310.870728] [161/170] (699s left) gem_lmem_swapping (verify-random) [311.017213] Subtest verify-random: SKIP (0.000s) [311.071102] [162/170] (699s left) i915_pm_rpm (module-reload) [323.595162] Starting subtest: module-reload [358.394742] Subtest module-reload: SUCCESS (34.791s) [358.419310] [163/170] (652s left) i915_selftest (live) [358.562848] Starting subtest: live [358.564176] Starting dynamic subtest: sanitycheck [360.407287] Dynamic subtest sanitycheck: SUCCESS (1.835s) [360.421379] Starting dynamic subtest: uncore [362.189362] Dynamic subtest uncore: SUCCESS (1.780s) [362.203407] Starting dynamic subtest: workarounds [364.286344] Dynamic subtest workarounds: SUCCESS (2.095s) [364.300525] Starting dynamic subtest: gt_engines [366.561490] Dynamic subtest gt_engines: SUCCESS (2.273s) [366.575535] Starting dynamic subtest: gt_timelines [379.019669] Dynamic subtest gt_timelines: SUCCESS (12.456s) [379.033848] Starting dynamic subtest: gt_contexts [380.982248] Dynamic subtest gt_contexts: SUCCESS (1.961s) [380.996381] Starting dynamic subtest: gt_lrc [385.386331] Dynamic subtest gt_lrc: SUCCESS (4.402s) [385.400544] Starting dynamic subtest: gt_mocs [387.281628] Dynamic subtest gt_mocs: SUCCESS (1.893s) [387.295835] Starting dynamic subtest: gt_pm [392.383369] Dynamic subtest gt_pm: SUCCESS (5.100s) [392.397726] Starting dynamic subtest: gt_heartbeat [394.282595] Dynamic subtest gt_heartbeat: SUCCESS (1.897s) [394.296751] Starting dynamic subtest: gt_tlb [397.426438] Dynamic subtest gt_tlb: SUCCESS (3.142s) [397.440847] Starting dynamic subtest: requests [404.974088] Dynamic subtest requests: SUCCESS (7.546s) [404.988434] Starting dynamic subtest: migrate [409.573206] Dynamic subtest migrate: SUCCESS (4.598s) [409.587410] Starting dynamic subtest: active [411.368476] Dynamic subtest active: SUCCESS (1.793s) [411.382765] Starting dynamic subtest: objects [414.689377] Dynamic subtest objects: SUCCESS (3.319s) [414.703738] Starting dynamic subtest: mman [421.663679] Dynamic subtest mman: SUCCESS (6.972s) [421.678125] Starting dynamic subtest: dmabuf [423.540456] Dynamic subtest dmabuf: SUCCESS (1.875s) [423.554870] Starting dynamic subtest: vma [425.372510] Dynamic subtest vma: SUCCESS (1.830s) [425.387040] Starting dynamic subtest: coherency [431.557578] Dynamic subtest coherency: SUCCESS (6.183s) [431.571965] Starting dynamic subtest: gtt [440.882451] Dynamic subtest gtt: SUCCESS (9.331s) [440.896777] Starting dynamic subtest: gem [442.872147] Dynamic subtest gem: SUCCESS (1.980s) [442.886570] Starting dynamic subtest: evict [446.698292] Dynamic subtest evict: SUCCESS (3.824s) [446.712609] Starting dynamic subtest: hugepages [453.586532] Dynamic subtest hugepages: SUCCESS (6.886s) [453.601249] Starting dynamic subtest: gem_contexts [468.942436] Dynamic subtest gem_contexts: SUCCESS (15.354s) [468.957332] Starting dynamic subtest: client [470.765480] Dynamic subtest client: SUCCESS (1.821s) [470.780251] Starting dynamic subtest: gem_migrate [472.608411] Dynamic subtest gem_migrate: SUCCESS (1.841s) [472.623187] Starting dynamic subtest: reset [477.957330] Dynamic subtest reset: SUCCESS (5.347s) [477.972353] Starting dynamic subtest: memory_region [479.773438] Dynamic subtest memory_region: SUCCESS (1.814s) [479.788298] Starting dynamic subtest: hangcheck [504.203443] Dynamic subtest hangcheck: SUCCESS (24.428s) [504.218152] Starting dynamic subtest: execlists [514.251215] Dynamic subtest execlists: SUCCESS (10.046s) [514.266080] Starting dynamic subtest: ring_submission [516.058082] Dynamic subtest ring_submission: SUCCESS (1.805s) [516.073031] Starting dynamic subtest: perf [517.989915] Dynamic subtest perf: SUCCESS (1.930s) [518.005083] Starting dynamic subtest: slpc [519.771265] Dynamic subtest slpc: SUCCESS (1.780s) [519.786138] Starting dynamic subtest: guc [521.567487] Dynamic subtest guc: SUCCESS (1.794s) [521.582374] Starting dynamic subtest: guc_multi_lrc [523.368307] Dynamic subtest guc_multi_lrc: SUCCESS (1.799s) [523.383228] Starting dynamic subtest: guc_hang [525.141292] Dynamic subtest guc_hang: SUCCESS (1.771s) [525.156173] Starting dynamic subtest: late_gt_pm [526.961357] Dynamic subtest late_gt_pm: SUCCESS (1.818s) [526.962662] Subtest live: SUCCESS (168.390s) [527.164421] [164/170] (483s left) dmabuf (all-tests) [527.302494] Starting subtest: all-tests [527.303878] Starting dynamic subtest: sanitycheck [527.365957] Dynamic subtest sanitycheck: SUCCESS (0.062s) [527.382951] Starting dynamic subtest: dma_fence [527.545920] Dynamic subtest dma_fence: SUCCESS (0.178s) [527.562174] Starting dynamic subtest: dma_fence_chain [545.400320] Dynamic subtest dma_fence_chain: SUCCESS (17.844s) [545.413858] Starting dynamic subtest: dma_fence_unwrap [545.470679] Dynamic subtest dma_fence_unwrap: SUCCESS (0.077s) [545.487751] Starting dynamic subtest: dma_resv [545.547705] Dynamic subtest dma_resv: SUCCESS (0.075s) [545.549885] Subtest all-tests: SUCCESS (18.245s) [545.578947] [165/170] (464s left) i915_suspend (basic-s2idle-without-i915) [545.706998] Starting subtest: basic-s2idle-without-i915 [568.595578] Subtest basic-s2idle-without-i915: SUCCESS (8.358s) [568.879791] [166/170] (456s left) i915_suspend (basic-s3-without-i915) [569.020678] Starting subtest: basic-s3-without-i915 [592.643284] Subtest basic-s3-without-i915: SUCCESS (7.090s) [592.945916] [167/170] (448s left) gem_exec_suspend (basic-s0) [593.101195] Starting subtest: basic-S0 [593.102339] Starting dynamic subtest: smem [612.873278] Dynamic subtest smem: SUCCESS (3.931s) [612.874347] Subtest basic-S0: SUCCESS (3.932s) [613.035080] [168/170] (444s left) gem_exec_suspend (basic-s3) [613.183868] Starting subtest: basic-S3 [613.185067] Starting dynamic subtest: smem [631.789673] Dynamic subtest smem: SUCCESS (3.827s) [631.790670] Subtest basic-S3: SUCCESS (3.828s) [631.997662] [169/170] (440s left) kms_chamelium_hpd (common-hpd-after-suspend) [632.482133] Subtest common-hpd-after-suspend: SKIP (0.000s) [633.364864] [170/170] (439s left) kms_pipe_crc_basic (suspend-read-crc) [633.525024] Starting subtest: suspend-read-crc [633.529408] Starting dynamic subtest: pipe-A-eDP-1 [651.678177] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.459s) [651.705092] Starting dynamic subtest: pipe-B-eDP-1 [669.651217] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.115s) [669.673147] Starting dynamic subtest: pipe-C-eDP-1 [688.652798] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.305s) [688.654151] Subtest suspend-read-crc: SUCCESS (8.894s) [689.563372] Closing watchdogs Done.