builder: release-mozilla-esr45-firefox_publish_balrog slave: bld-linux64-spot-310 starttime: 1479219586.36 results: success (0) revision: 32ce7be985433fd0b3da7ed275ecd5cf29c91587 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:46.363160) ========= master: http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:46.363577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:46.363877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:46.437677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:46.437995) ========= rm -rf scripts properties in dir /builds/slave/rel-m-esr45-fx_publish_balrog-/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-310.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-esr45-fx_publish_balrog- SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003325 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:46.488943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 06:19:46.489297) ========= bash -c 'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-esr45 --rev 32ce7be985433fd0b3da7ed275ecd5cf29c91587 --destination scripts --debug' in dir /builds/slave/rel-m-esr45-fx_publish_balrog-/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-esr45 --rev 32ce7be985433fd0b3da7ed275ecd5cf29c91587 --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-310.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-esr45-fx_publish_balrog- SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2016-11-15 06:19:46,531 truncating revision to first 12 chars 2016-11-15 06:19:46,532 Setting DEBUG logging. 2016-11-15 06:19:46,532 attempt 1/10 2016-11-15 06:19:46,532 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-esr45/32ce7be98543?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 06:19:47,999 unpacking tar archive at: mozilla-esr45-32ce7be98543/testing/mozharness/ program finished with exit code 0 elapsedTime=1.632071 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 06:19:48.131581) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:48.131921) ========= script_repo_revision: 32ce7be985433fd0b3da7ed275ecd5cf29c91587 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:48.132283) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:48.132552) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:48.142877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/release/publish_balrog.py ...' (results: 0, elapsed: 5 secs) (at 2016-11-15 06:19:48.143140) ========= /tools/buildbot/bin/python scripts/scripts/release/publish_balrog.py -c releases/updates_firefox_esr45.py in dir /builds/slave/rel-m-esr45-fx_publish_balrog-/. (timeout 3600 secs) (maxTime 14400 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/release/publish_balrog.py', '-c', 'releases/updates_firefox_esr45.py'] environment: CCACHE_COMPRESS=1 CCACHE_DIR=/builds/ccache CCACHE_HASHDIR= CCACHE_UMASK=002 DISPLAY=:2 G_BROKEN_FILENAMES=1 HG_SHARE_BASE_DIR=/builds/hg-shared HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-310.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LC_ALL=C LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld MOZ_AUTOMATION=1 MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_OBJDIR=obj-firefox PATH=/tools/buildbot/bin:/usr/local/bin:/usr/lib64/ccache:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/tools/git/bin:/tools/python27/bin:/tools/python27-mercurial/bin:/home/cltbld/bin PROPERTIES_FILE=/builds/slave/rel-m-esr45-fx_publish_balrog-/buildprops.json PWD=/builds/slave/rel-m-esr45-fx_publish_balrog- SHELL=/bin/bash SHLVL=1 TERM=linux TINDERBOX_OUTPUT=1 TMOUT=86400 TOOLTOOL_CACHE=/builds/tooltool_cache TOOLTOOL_HOME=/builds USER=cltbld _=/tools/buildbot/bin/python using PTY: False 06:19:48 INFO - MultiFileLogger online at 20161115 06:19:48 in /builds/slave/rel-m-esr45-fx_publish_balrog- 06:19:48 INFO - Using buildbot properties: 06:19:48 INFO - { 06:19:48 INFO - "properties": { 06:19:48 INFO - "project": "", 06:19:48 INFO - "product": "firefox", 06:19:48 INFO - "build_number": 1, 06:19:48 INFO - "branch": "mozilla-esr45", 06:19:48 INFO - "repository": "", 06:19:48 INFO - "buildername": "release-mozilla-esr45-firefox_publish_balrog", 06:19:48 INFO - "release_promotion": true, 06:19:48 INFO - "balrog_api_root": "https://aus4-admin.mozilla.org/api", 06:19:48 INFO - "basedir": "/builds/slave/rel-m-esr45-fx_publish_balrog-", 06:19:48 INFO - "channels": "esr", 06:19:48 INFO - "platform": null, 06:19:48 INFO - "version": "45.5.0esr", 06:19:48 INFO - "master": "http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/", 06:19:48 INFO - "script_repo_revision": "32ce7be985433fd0b3da7ed275ecd5cf29c91587", 06:19:48 INFO - "taskId": "8j-gJkbfSLuOlAaavHdt_w", 06:19:48 INFO - "buildnumber": 2, 06:19:48 INFO - "repo_path": "releases/mozilla-esr45", 06:19:48 INFO - "slavename": "bld-linux64-spot-310", 06:19:48 INFO - "revision": "32ce7be985433fd0b3da7ed275ecd5cf29c91587" 06:19:48 INFO - }, 06:19:48 INFO - "sourcestamp": { 06:19:48 INFO - "repository": "", 06:19:48 INFO - "hasPatch": false, 06:19:48 INFO - "project": "", 06:19:48 INFO - "branch": "releases/mozilla-esr45", 06:19:48 INFO - "changes": [], 06:19:48 INFO - "revision": "32ce7be985433fd0b3da7ed275ecd5cf29c91587" 06:19:48 INFO - } 06:19:48 INFO - } 06:19:48 INFO - Overriding product with firefox 06:19:48 INFO - Overriding version with 45.5.0esr 06:19:48 INFO - Overriding build_number with 1 06:19:48 INFO - Overriding channels with esr 06:19:48 INFO - Overriding balrog_api_root with https://aus4-admin.mozilla.org/api 06:19:48 INFO - Run as scripts/scripts/release/publish_balrog.py -c releases/updates_firefox_esr45.py 06:19:48 INFO - Dumping config to /builds/slave/rel-m-esr45-fx_publish_balrog-/logs/localconfig.json. 06:19:48 INFO - {'append_to_log': False, 06:19:48 INFO - 'archive_domain': 'archive.mozilla.org', 06:19:48 INFO - 'archive_prefix': 'https://archive.mozilla.org/pub', 06:19:48 INFO - 'balrog_api_root': u'https://aus4-admin.mozilla.org/api', 06:19:48 INFO - 'balrog_url': 'https://aus5.mozilla.org', 06:19:48 INFO - 'balrog_use_dummy_suffix': False, 06:19:48 INFO - 'balrog_username': 'ffxbld', 06:19:48 INFO - 'base_work_dir': '/builds/slave/rel-m-esr45-fx_publish_balrog-', 06:19:48 INFO - 'build_number': 1, 06:19:48 INFO - 'buildbot_json_path': 'buildprops.json', 06:19:48 INFO - 'channels': u'esr', 06:19:48 INFO - 'config_files': ('releases/updates_firefox_esr45.py',), 06:19:48 INFO - 'credentials_file': 'oauth.txt', 06:19:48 INFO - 'download_domain': 'download.mozilla.org', 06:19:48 INFO - 'ignore_no_changes': True, 06:19:48 INFO - 'log_level': 'info', 06:19:48 INFO - 'log_name': 'updates_esr45', 06:19:48 INFO - 'log_to_console': True, 06:19:48 INFO - 'opt_config_files': (), 06:19:48 INFO - 'previous_archive_prefix': 'https://archive.mozilla.org/pub', 06:19:48 INFO - 'product': u'firefox', 06:19:48 INFO - 'push_dest': 'ssh://hg.mozilla.org/build/tools', 06:19:48 INFO - 'repo': {'dest': 'tools', 06:19:48 INFO - 'repo': 'https://hg.mozilla.org/build/tools', 06:19:48 INFO - 'revision': 'default', 06:19:48 INFO - 'vcs': 'hg'}, 06:19:48 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/releases/mozilla-esr45/raw-file/{revision}/browser/locales/shipped-locales', 06:19:48 INFO - 'ssh_key': '~/.ssh/ffxbld_rsa', 06:19:48 INFO - 'ssh_user': 'ffxbld', 06:19:48 INFO - 'update_channels': {'esr': {'channel_names': ('esr', 06:19:48 INFO - 'esr-localtest', 06:19:48 INFO - 'esr-cdntest'), 06:19:48 INFO - 'mar_channel_ids': (), 06:19:48 INFO - 'patcher_config': 'mozEsr45-branch-patcher2.cfg', 06:19:48 INFO - 'publish_rules': ('esr45',), 06:19:48 INFO - 'requires_mirrors': True, 06:19:48 INFO - 'rules_to_update': ('esr45-cdntest', 06:19:48 INFO - 'esr45-localtest'), 06:19:48 INFO - 'update_verify_channel': 'esr-localtest', 06:19:48 INFO - 'version_regex': '.*'}}, 06:19:48 INFO - 'version': u'45.5.0esr', 06:19:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:19:48 INFO - 'work_dir': 'build'} 06:19:48 INFO - ##### 06:19:48 INFO - ##### Running clobber step. 06:19:48 INFO - ##### 06:19:48 INFO - Running main action method: clobber 06:19:48 INFO - rmtree: /builds/slave/rel-m-esr45-fx_publish_balrog-/build 06:19:48 INFO - ##### 06:19:48 INFO - ##### Running pull step. 06:19:48 INFO - ##### 06:19:48 INFO - Running main action method: pull 06:19:48 INFO - mkdir: /builds/slave/rel-m-esr45-fx_publish_balrog-/build 06:19:48 INFO - Changing directory to /builds/slave/rel-m-esr45-fx_publish_balrog-/build. 06:19:48 INFO - retry: Calling _get_revision with args: (, 'tools'), kwargs: {}, attempt #1 06:19:48 INFO - Setting /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools to https://hg.mozilla.org/build/tools revision default. 06:19:48 INFO - Cloning https://hg.mozilla.org/build/tools to /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools. 06:19:48 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'clone', 'https://hg.mozilla.org/build/tools', '/builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools'] 06:19:48 INFO - Copy/paste: hg --config ui.merge=internal:merge clone https://hg.mozilla.org/build/tools /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools 06:19:48 INFO - warning: connecting to hg.mozilla.org using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info 06:19:48 INFO - applying clone bundle from https://s3-us-west-2.amazonaws.com/moz-hg-bundles-us-west-2/build/tools/1b7a3206147c32808200dd6aa34f7a10c98b70f1.packed1.hg 06:19:48 INFO - warning: connecting to s3-us-west-2.amazonaws.com using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info 06:19:50 INFO - 2047 files to transfer, 27.9 MB of data 06:19:50 INFO - transferred 27.9 MB in 0.6 seconds (50.4 MB/sec) 06:19:50 INFO - finished applying clone bundle 06:19:50 INFO - searching for changes 06:19:50 INFO - no changes found 06:19:50 INFO - updating to branch default 06:19:50 INFO - 941 files updated, 0 files merged, 0 files removed, 0 files unresolved 06:19:50 INFO - Return code: 0 06:19:50 INFO - Updating /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools. 06:19:50 INFO - Getting output from command: ['hg', '--config', 'ui.merge=internal:merge', 'branch'] in /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools 06:19:50 INFO - Copy/paste: hg --config ui.merge=internal:merge branch 06:19:51 INFO - Reading from file tmpfile_stdout 06:19:51 INFO - Output received: 06:19:51 INFO - default 06:19:51 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'update', '-C'] in /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools 06:19:51 INFO - Copy/paste: hg --config ui.merge=internal:merge update -C 06:19:51 INFO - 0 files updated, 0 files merged, 0 files removed, 0 files unresolved 06:19:51 INFO - Return code: 0 06:19:51 INFO - Getting output from command: ['hg', '--config', 'ui.merge=internal:merge', 'parent', '--template', '{node}'] in /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools 06:19:51 INFO - Copy/paste: hg --config ui.merge=internal:merge parent --template {node} 06:19:52 INFO - Reading from file tmpfile_stdout 06:19:52 INFO - Output received: 06:19:52 INFO - 1b7a3206147c32808200dd6aa34f7a10c98b70f1 06:19:52 INFO - Updating /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools revision default. 06:19:52 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'update', '-C', '-r', 'default'] in /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools 06:19:52 INFO - Copy/paste: hg --config ui.merge=internal:merge update -C -r default 06:19:52 INFO - 0 files updated, 0 files merged, 0 files removed, 0 files unresolved 06:19:52 INFO - Return code: 0 06:19:52 INFO - Getting output from command: ['hg', '--config', 'ui.merge=internal:merge', 'parent', '--template', '{node}'] in /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools 06:19:52 INFO - Copy/paste: hg --config ui.merge=internal:merge parent --template {node} 06:19:53 INFO - Reading from file tmpfile_stdout 06:19:53 INFO - Output received: 06:19:53 INFO - 1b7a3206147c32808200dd6aa34f7a10c98b70f1 06:19:53 INFO - Changing directory to /builds/slave/rel-m-esr45-fx_publish_balrog-. 06:19:53 INFO - ##### 06:19:53 INFO - ##### Running submit-to-balrog step. 06:19:53 INFO - ##### 06:19:53 INFO - Running main action method: submit_to_balrog 06:19:53 INFO - retry: Calling with args: (), kwargs: {}, attempt #1 06:19:53 INFO - Running command: ['python', '/builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools/scripts/build-promotion/balrog-release-shipper.py', '--api-root', u'https://aus4-admin.mozilla.org/api', '--credentials-file', '/builds/slave/rel-m-esr45-fx_publish_balrog-/oauth.txt', '--username', 'ffxbld', '--version', u'45.5.0esr', '--product', u'firefox', '--build-number', '1', '--verbose', '--rules', 'esr45'] 06:19:53 INFO - Copy/paste: python /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools/scripts/build-promotion/balrog-release-shipper.py --api-root https://aus4-admin.mozilla.org/api --credentials-file /builds/slave/rel-m-esr45-fx_publish_balrog-/oauth.txt --username ffxbld --version 45.5.0esr --product firefox --build-number 1 --verbose --rules esr45 06:19:53 INFO - Balrog request to https://aus4-admin.mozilla.org/api/rules/esr45 06:19:53 INFO - Data sent: None 06:19:53 INFO - Starting new HTTPS connection (1): aus4-admin.mozilla.org 06:19:53 INFO - /builds/slave/rel-m-esr45-fx_publish_balrog-/build/tools/scripts/build-promotion/../../lib/python/vendor/requests-2.7.0/requests/packages/urllib3/util/ssl_.py:90: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. For more information, see https://urllib3.readthedocs.org/en/latest/security.html#insecureplatformwarning. 06:19:53 INFO - InsecurePlatformWarning 06:19:53 INFO - "HEAD /api/rules/esr45 HTTP/1.1" 200 0 06:19:53 INFO - REQUEST STATS: {"url": "https://aus4-admin.mozilla.org/api/rules/esr45", "timestamp": 1479219593.684963, "method": "HEAD", "elapsed_secs": 0.3297140598297119, "status_code": 200} 06:19:53 INFO - Balrog request to https://aus4-admin.mozilla.org/api/rules/esr45 06:19:53 INFO - Data sent: {'data_version': '11', 'mapping': 'Firefox-45.5.0esr-build1'} 06:19:53 INFO - "POST /api/rules/esr45 HTTP/1.1" 200 28 06:19:53 INFO - REQUEST STATS: {"url": "https://aus4-admin.mozilla.org/api/rules/esr45", "timestamp": 1479219593.806252, "method": "POST", "elapsed_secs": 0.12101292610168457, "status_code": 200} 06:19:53 INFO - Return code: 0 06:19:53 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:53 INFO - Copying logs to upload dir... 06:19:53 INFO - mkdir: /builds/slave/rel-m-esr45-fx_publish_balrog-/build/upload/logs 06:19:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=5.683672 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/release/publish_balrog.py ...' (results: 0, elapsed: 5 secs) (at 2016-11-15 06:19:53.837799) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:53.838975) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-m-esr45-fx_publish_balrog-/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-310.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-esr45-fx_publish_balrog-/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.04 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:53.888308) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:53.888616) ========= rm -f oauth.txt in dir /builds/slave/rel-m-esr45-fx_publish_balrog-/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-310.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/rel-m-esr45-fx_publish_balrog- SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002536 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 06:19:53.936778) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 06:19:53.937063) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 06:19:53.937315) ========= ========= Total master_lag: 0.16 =========