Closed Bug 1503092 Opened 6 years ago Closed 6 years ago

Intermittent toolkit/mozapps/update/tests/unit_base_updater/marAppApplyUpdateStageSuccess.js | checkUpdateLogContents - [checkUpdateLogContents : 3207] the update log contents should equal the expected value - "rename_file: failed to rename file - src

Categories

(Toolkit :: Application Update, defect, P5)

defect

Tracking

()

RESOLVED FIXED

People

(Reporter: intermittent-bug-filer, Assigned: robert.strong.bugs)

References

Details

(Keywords: intermittent-failure)

Filed by: rgurzau [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=208521076&repo=mozilla-central

https://queue.taskcluster.net/v1/task/RCq0AxGjR3qImP5DUIlqWw/runs/0/artifacts/public/logs/live_backing.log

01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [checkUpdateLogContents : 3205] the first incorrect line in the update log is: rename_file: failed to rename file - src: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app, dst:<test_dir_path>/marAppApplyUpdateStageSuccess/dir.app.bak"
01:09:05  WARNING -  TEST-UNEXPECTED-FAIL | toolkit/mozapps/update/tests/unit_base_updater/marAppApplyUpdateStageSuccess.js | checkUpdateLogContents - [checkUpdateLogContents : 3207] the update log contents should equal the expected value - "rename_file: failed to rename file - src: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app, dst:<test_dir_path>/marAppApplyUpdateStageSuccess/dir.app.bak" == "rename_file: proceeding to rename the directory"
01:09:05     INFO -  ../data/xpcshellUtilsAUS.js:checkUpdateLogContents:3207
01:09:05     INFO -  Z:/task_1540859678/build/tests/xpcshell/tests/toolkit/mozapps/update/tests/unit_base_updater/marAppApplyUpdateStageSuccess.js:checkPostUpdateAppLogFinished:55
01:09:05     INFO -  Z:\task_1540859678\build\tests\xpcshell\head.js:run:693
01:09:05     INFO -  Z:\task_1540859678\build\tests\xpcshell\head.js:_do_main:220
01:09:05     INFO -  Z:\task_1540859678\build\tests\xpcshell\head.js:_execute_test:534
01:09:05     INFO -  -e:null:1
01:09:05     INFO -  exiting test
01:09:05     INFO -  TEST-PASS | toolkit/mozapps/update/tests/unit_base_updater/marAppApplyUpdateStageSuccess.js | checkForBackupFiles - [checkForBackupFiles : 3661] the file's extension should not equal moz-backup, path: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app/xul.dll - "dll" != "moz-backup"
01:09:05     INFO -  "01:09:05:373 | TEST-INFO | ../data/xpcshellUtilsAUS.js -> file:///Z:/task_1540859678/build/tests/xpcshell/tests/toolkit/mozapps/update/tests/data/shared.js | [readFileBytes : 356] attempting to read file, path: C:\\ProgramData\\Mozilla\\updates\\marAppApplyUpdateStageSuccess\\updates\\last-update.log"
01:09:05     INFO -  "01:09:05:374 | TEST-INFO | ../data/xpcshellUtilsAUS.js -> file:///Z:/task_1540859678/build/tests/xpcshell/tests/toolkit/mozapps/update/tests/data/shared.js | [readFileBytes : 356] attempting to read file, path: Z:\\task_1540859678\\build\\tests\\xpcshell\\tests\\toolkit\\mozapps\\update\\tests\\data\\replace_log_success"
01:09:05     INFO -  "01:09:05:375 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [checkUpdateLogContents : 3193] the update log contents are not correct"
01:09:05     INFO -  "01:09:05:375 | TEST-INFO | ../data/xpcshellUtilsAUS.js -> file:///Z:/task_1540859678/build/tests/xpcshell/tests/toolkit/mozapps/update/tests/data/shared.js | [readFileBytes : 356] attempting to read file, path: C:\\ProgramData\\Mozilla\\updates\\marAppApplyUpdateStageSuccess\\updates\\last-update.log"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [logUpdateLog : 1843] contents of C:\\ProgramData\\Mozilla\\updates\\marAppApplyUpdateStageSuccess\\updates\\last-update.log:"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] Performing a replace request"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] PATCH DIRECTORY <update_dir_path>/marAppApplyUpdateStageSuccess/updates/0"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] INSTALLATION DIRECTORY <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] WORKING DIRECTORY <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app/updated"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] Begin moving destDir (<test_dir_path>/marAppApplyUpdateStageSuccess/dir.app) to tmpDir (<test_dir_path>/marAppApplyUpdateStageSuccess/dir.app.bak)"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] rename_file: proceeding to rename the directory"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] rename_file: failed to rename file - src: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app, dst:<test_dir_path>/marAppApplyUpdateStageSuccess/dir.app.bak, err: 13"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] PerformReplaceRequest: destDir rename attempt 1 failed. File: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app. Last error: 32, err: 7"
01:09:05     INFO -  "01:09:05:376 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] rename_file: proceeding to rename the directory"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] Begin moving newDir (<test_dir_path>/marAppApplyUpdateStageSuccess/dir.app.bak/updated) to destDir (<test_dir_path>/marAppApplyUpdateStageSuccess/dir.app)"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] rename_file: proceeding to rename the directory"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] Now, remove the tmpDir"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] ensure_remove: failed to remove file: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app.bak/updater.exe, rv: -1, err: 13"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] ensure_remove_recursive: unable to remove directory: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app.bak, rv: -1, err: 41"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] Removing tmpDir failed, err: -1"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] remove_recursive_on_reboot: failed to schedule OS reboot removal of file: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app/tobedeleted/repdf392862-50f6-4472-a8c9-e060231beacc"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] succeeded"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] calling QuitProgressUI"
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [RU_LC_FE : 1845] "
01:09:05     INFO -  "01:09:05:377 | TEST-INFO | ../data/xpcshellUtilsAUS.js | [checkUpdateLogContents : 3205] the first incorrect line in the update log is: rename_file: failed to rename file - src: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app, dst:<test_dir_path>/marAppApplyUpdateStageSuccess/dir.app.bak"
01:09:05  WARNING -  TEST-UNEXPECTED-FAIL | toolkit/mozapps/update/tests/unit_base_updater/marAppApplyUpdateStageSuccess.js | checkUpdateLogContents - [checkUpdateLogContents : 3207] the update log contents should equal the expected value - "rename_file: failed to rename file - src: <test_dir_path>/marAppApplyUpdateStageSuccess/dir.app, dst:<test_dir_path>/marAppApplyUpdateStageSuccess/dir.app.bak" == "rename_file: proceeding to rename the directory"
The patch in bug 1500095 should also fix this bug
Assignee: nobody → robert.strong.bugs
Status: NEW → ASSIGNED
Depends on: 1500095
This should also be fixed by the landing of the patch in bug 1500095
Status: ASSIGNED → RESOLVED
Closed: 6 years ago
Resolution: --- → FIXED
You need to log in before you can comment on or make changes to this bug.