builder: release-mozilla-release-firefox_schedule_publishing_in_balrog slave: bld-linux64-spot-039 starttime: 1515101859.68 results: success (0) revision: afa87f9be3a8852da3a30f286b15ae599c7874f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:39.680740) ========= master: http://buildbot-master77.bb.releng.use1.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:39.968193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:39.968604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:40.126761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:40.127179) ========= rm -rf scripts properties in dir /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/. (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-039.build.releng.use1.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-rel-fx_sc_p_in_balrog-00 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.004121 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:40.182570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2018-01-04 13:37:40.183046) ========= bash -c 'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-release --rev afa87f9be3a8852da3a30f286b15ae599c7874f6 --destination scripts --debug' in dir /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-release --rev afa87f9be3a8852da3a30f286b15ae599c7874f6 --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-039.build.releng.use1.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-rel-fx_sc_p_in_balrog-00 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2018-01-04 13:37:40,234 truncating revision to first 12 chars 2018-01-04 13:37:40,234 Setting DEBUG logging. 2018-01-04 13:37:40,234 attempt 1/10 2018-01-04 13:37:40,235 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-release/afa87f9be3a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2018-01-04 13:37:41,459 unpacking tar archive at: mozilla-release-afa87f9be3a8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.719143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2018-01-04 13:37:42.920970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:42.921344) ========= script_repo_revision: afa87f9be3a8852da3a30f286b15ae599c7874f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:42.921765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:42.922057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:42.982389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/release/publish_balrog.py ...' (results: 0, elapsed: 9 secs) (at 2018-01-04 13:37:42.982782) ========= /tools/buildbot/bin/python scripts/scripts/release/publish_balrog.py -c releases/updates_firefox_release.py in dir /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/. (timeout 3600 secs) (maxTime 14400 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/release/publish_balrog.py', '-c', 'releases/updates_firefox_release.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-039.build.releng.use1.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-rel-fx_sc_p_in_balrog-00/buildprops.json PWD=/builds/slave/rel-m-rel-fx_sc_p_in_balrog-00 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 13:37:43 INFO - MultiFileLogger online at 20180104 13:37:43 in /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00 13:37:43 INFO - Using buildbot properties: 13:37:43 INFO - { 13:37:43 INFO - "channels": "release", 13:37:43 INFO - "product": "firefox", 13:37:43 INFO - "build_number": 1, 13:37:43 INFO - "taskId": "QcDRJXC3Rbut0sJH1aI7bg", 13:37:43 INFO - "repository": "", 13:37:43 INFO - "buildername": "release-mozilla-release-firefox_schedule_publishing_in_balrog", 13:37:43 INFO - "buildnumber": 6, 13:37:43 INFO - "balrog_api_root": "https://aus4-admin.mozilla.org/api", 13:37:43 INFO - "basedir": "/builds/slave/rel-m-rel-fx_sc_p_in_balrog-00", 13:37:43 INFO - "publish_bz2_blob": true, 13:37:43 INFO - "project": "", 13:37:43 INFO - "platform": null, 13:37:43 INFO - "version": "57.0.4", 13:37:43 INFO - "release_promotion": true, 13:37:43 INFO - "script_repo_revision": "afa87f9be3a8852da3a30f286b15ae599c7874f6", 13:37:43 INFO - "branch": "mozilla-release", 13:37:43 INFO - "master": "http://buildbot-master77.bb.releng.use1.mozilla.com:8001/", 13:37:43 INFO - "schedule_at": "2018-01-04T16:00:00+00:00", 13:37:43 INFO - "revision": "afa87f9be3a8852da3a30f286b15ae599c7874f6", 13:37:43 INFO - "slavename": "bld-linux64-spot-039", 13:37:43 INFO - "repo_path": "releases/mozilla-release" 13:37:43 INFO - } 13:37:43 INFO - Overriding product with firefox 13:37:43 INFO - Overriding version with 57.0.4 13:37:43 INFO - Overriding build_number with 1 13:37:43 INFO - Overriding channels with release 13:37:43 INFO - Overriding balrog_api_root with https://aus4-admin.mozilla.org/api 13:37:43 INFO - Overriding schedule_at with 2018-01-04T16:00:00+00:00 13:37:43 INFO - Overriding publish_bz2_blob with True 13:37:43 INFO - Run as scripts/scripts/release/publish_balrog.py -c releases/updates_firefox_release.py 13:37:43 INFO - Dumping config to /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/logs/localconfig.json. 13:37:43 INFO - {'append_to_log': False, 13:37:43 INFO - 'archive_domain': 'archive.mozilla.org', 13:37:43 INFO - 'archive_prefix': 'https://archive.mozilla.org/pub', 13:37:43 INFO - 'balrog_api_root': u'https://aus4-admin.mozilla.org/api', 13:37:43 INFO - 'balrog_url': 'https://aus5.mozilla.org', 13:37:43 INFO - 'balrog_use_dummy_suffix': False, 13:37:43 INFO - 'balrog_username': 'balrog-ffxbld', 13:37:43 INFO - 'base_work_dir': '/builds/slave/rel-m-rel-fx_sc_p_in_balrog-00', 13:37:43 INFO - 'build_number': 1, 13:37:43 INFO - 'buildbot_json_path': 'buildprops.json', 13:37:43 INFO - 'channels': u'release', 13:37:43 INFO - 'config_files': ('releases/updates_firefox_release.py',), 13:37:43 INFO - 'credentials_file': 'oauth.txt', 13:37:43 INFO - 'download_domain': 'download.mozilla.org', 13:37:43 INFO - 'ignore_no_changes': True, 13:37:43 INFO - 'log_level': 'info', 13:37:43 INFO - 'log_name': 'updates_release', 13:37:43 INFO - 'log_to_console': True, 13:37:43 INFO - 'opt_config_files': (), 13:37:43 INFO - 'previous_archive_prefix': 'https://archive.mozilla.org/pub', 13:37:43 INFO - 'product': u'firefox', 13:37:43 INFO - 'publish_bz2_blob': True, 13:37:43 INFO - 'push_dest': 'ssh://hg.mozilla.org/build/tools', 13:37:43 INFO - 'repo': {'branch': 'default', 13:37:43 INFO - 'dest': 'tools', 13:37:43 INFO - 'repo': 'https://hg.mozilla.org/build/tools', 13:37:43 INFO - 'vcs': 'hg'}, 13:37:43 INFO - 'schedule_at': u'2018-01-04T16:00:00+00:00', 13:37:43 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/releases/mozilla-release/raw-file/{revision}/browser/locales/shipped-locales', 13:37:43 INFO - 'ssh_key': '~/.ssh/ffxbld_rsa', 13:37:43 INFO - 'ssh_user': 'ffxbld', 13:37:43 INFO - 'update_channels': {'beta': {'channel_names': ('beta', 13:37:43 INFO - 'beta-localtest', 13:37:43 INFO - 'beta-cdntest'), 13:37:43 INFO - 'mar_channel_ids': ('firefox-mozilla-beta', 13:37:43 INFO - 'firefox-mozilla-release'), 13:37:43 INFO - 'patcher_config': 'mozBeta-branch-patcher2.cfg', 13:37:43 INFO - 'publish_rules': (32,), 13:37:43 INFO - 'requires_mirrors': False, 13:37:43 INFO - 'rules_to_update': ('firefox-beta-cdntest', 13:37:43 INFO - 'firefox-beta-localtest'), 13:37:43 INFO - 'schedule_asap': True, 13:37:43 INFO - 'update_verify_channel': 'beta-localtest', 13:37:43 INFO - 'version_regex': '^(\\d+\\.\\d+(b\\d+)?)$'}, 13:37:43 INFO - 'release': {'bz2_blob_suffix': '-bz2', 13:37:43 INFO - 'bz2_publish_rules': (624,), 13:37:43 INFO - 'bz2_rules_to_update': ('firefox-release-cdntest-bz2', 13:37:43 INFO - 'firefox-release-localtest-bz2'), 13:37:43 INFO - 'channel_names': ('release', 13:37:43 INFO - 'release-localtest', 13:37:43 INFO - 'release-cdntest'), 13:37:43 INFO - 'complete_mar_bouncer_product_pattern': '%s-%s-complete-bz2', 13:37:43 INFO - 'complete_mar_filename_pattern': '%s-%s.bz2.complete.mar', 13:37:43 INFO - 'mar_channel_ids': (), 13:37:43 INFO - 'patcher_config': 'mozRelease-branch-patcher2.cfg', 13:37:43 INFO - 'publish_rules': (145,), 13:37:43 INFO - 'requires_mirrors': True, 13:37:43 INFO - 'rules_to_update': ('firefox-release-cdntest', 13:37:43 INFO - 'firefox-release-localtest'), 13:37:43 INFO - 'update_verify_channel': 'release-localtest', 13:37:43 INFO - 'version_regex': '^\\d+\\.\\d+(\\.\\d+)?$'}}, 13:37:43 INFO - 'vcs_share_base': '/builds/hg-shared', 13:37:43 INFO - 'version': u'57.0.4', 13:37:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:37:43 INFO - 'work_dir': 'build'} 13:37:43 INFO - [mozharness: 2018-01-04 21:37:43.139869Z] Running clobber step. 13:37:43 INFO - Running main action method: clobber 13:37:43 INFO - rmtree: /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/build 13:37:43 INFO - [mozharness: 2018-01-04 21:37:43.143543Z] Finished clobber step (success) 13:37:43 INFO - [mozharness: 2018-01-04 21:37:43.143854Z] Running pull step. 13:37:43 INFO - Running main action method: pull 13:37:43 INFO - mkdir: /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/build 13:37:43 INFO - Changing directory to /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/build. 13:37:43 INFO - retry: Calling _get_revision with args: (, 'tools'), kwargs: {}, attempt #1 13:37:43 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--version'] 13:37:43 INFO - Copy/paste: hg --config ui.merge=internal:merge --version 13:37:43 INFO - Mercurial Distributed SCM (version 3.9.1) 13:37:43 INFO - (see https://mercurial-scm.org for more information) 13:37:43 INFO - Copyright (C) 2005-2016 Matt Mackall and others 13:37:43 INFO - This is free software; see the source for copying conditions. There is NO 13:37:43 INFO - warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. 13:37:43 INFO - Return code: 0 13:37:43 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', 'debuginstall', '--config=ui.username=worker'] 13:37:43 INFO - Copy/paste: hg --config ui.merge=internal:merge debuginstall --config=ui.username=worker 13:37:43 INFO - checking encoding (ascii)... 13:37:43 INFO - checking Python executable (/tools/python27/bin/python2.7) 13:37:43 INFO - checking Python version (2.7.3) 13:37:43 INFO - checking Python lib (/tools/python27/lib/python2.7)... 13:37:43 INFO - checking Mercurial version (3.9.1) 13:37:43 INFO - checking Mercurial custom build () 13:37:43 INFO - checking module policy (c) 13:37:43 INFO - checking installed modules (/tools/python27-mercurial/lib/python2.7/site-packages/mercurial)... 13:37:43 INFO - checking templates (/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/templates)... 13:37:43 INFO - checking default template (/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/templates/map-cmdline.default) 13:37:43 INFO - checking commit editor... (vi) 13:37:43 INFO - checking username (worker) 13:37:43 INFO - no problems detected 13:37:43 INFO - Return code: 0 13:37:43 INFO - Running command: ['hg', '--config', 'ui.merge=internal:merge', '--config', 'extensions.robustcheckout=/builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/scripts/external_tools/robustcheckout.py', 'robustcheckout', 'https://hg.mozilla.org/build/tools', 'tools', '--sharebase', '/builds/hg-shared', '--branch', 'default'] 13:37:43 INFO - Copy/paste: hg --config ui.merge=internal:merge --config extensions.robustcheckout=/builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/scripts/external_tools/robustcheckout.py robustcheckout https://hg.mozilla.org/build/tools tools --sharebase /builds/hg-shared --branch default 13:37:44 INFO - (using Mercurial 3.9.1) 13:37:44 INFO - ensuring https://hg.mozilla.org/build/tools@default is available at tools 13:37:44 INFO - warning: connecting to hg.mozilla.org using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info 13:37:44 INFO - (shared store missing requirements: dotencode; deleting store and destination to ensure optimal behavior) 13:37:45 INFO - (sharing from new pooled repository 7ae7fb134bf7aec6ec96a062ff47a69053dd2973) 13:37:45 INFO - warning: connecting to hg.mozilla.org using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info 13:37:46 INFO - applying clone bundle from https://s3-external-1.amazonaws.com/moz-hg-bundles-us-east-1/build/tools/801485fa899c236830bd6cfe52012163903ccdc7.packed1.hg 13:37:46 INFO - warning: connecting to s3-external-1.amazonaws.com using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info 13:37:48 INFO - 2196 files to transfer, 30.5 MB of data 13:37:48 INFO - transferred 30.5 MB in 0.7 seconds (41.9 MB/sec) 13:37:48 INFO - finished applying clone bundle 13:37:48 INFO - searching for changes 13:37:48 INFO - adding changesets 13:37:48 INFO - adding manifests 13:37:48 INFO - adding file changes 13:37:48 INFO - added 24 changesets with 80 changes to 25 files 13:37:48 INFO - searching for changes 13:37:48 INFO - no changes found 13:37:48 INFO - (pulling to obtain default) 13:37: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 13:37:49 INFO - (remote resolved default to da83cee2f2cf19ef1e223d3bbff2192cc0197042; result is not deterministic) 13:37:49 INFO - (revision already present locally; not pulling) 13:37:49 INFO - 13:37:49 INFO - updating [====> ] 100/1058 13:37:49 INFO - 13:37:49 INFO - 1058 files updated, 0 files merged, 0 files removed, 0 files unresolved 13:37:49 INFO - updated to da83cee2f2cf19ef1e223d3bbff2192cc0197042 13:37:49 INFO - Return code: 0 13:37:49 INFO - Changing directory to /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00. 13:37:49 INFO - [mozharness: 2018-01-04 21:37:49.492522Z] Finished pull step (success) 13:37:49 INFO - [mozharness: 2018-01-04 21:37:49.492756Z] Running submit-to-balrog step. 13:37:49 INFO - Running main action method: submit_to_balrog 13:37:49 INFO - retry: Calling with args: (), kwargs: {}, attempt #1 13:37:49 INFO - Running command: ['/tools/buildbot/bin/python', '/builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/build/tools/scripts/build-promotion/balrog-release-shipper.py', '--api-root', u'https://aus4-admin.mozilla.org/api', '--credentials-file', '/builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/oauth.txt', '--username', 'balrog-ffxbld', '--version', u'57.0.4', '--product', u'firefox', '--build-number', '1', '--verbose', '--rules', '145', '--schedule-at', u'2018-01-04T16:00:00+00:00'] 13:37:49 INFO - Copy/paste: /tools/buildbot/bin/python /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/build/tools/scripts/build-promotion/balrog-release-shipper.py --api-root https://aus4-admin.mozilla.org/api --credentials-file /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/oauth.txt --username balrog-ffxbld --version 57.0.4 --product firefox --build-number 1 --verbose --rules 145 --schedule-at 2018-01-04T16:00:00+00:00 13:37:49 INFO - Balrog request to https://aus4-admin.mozilla.org/api/rules/145 13:37:49 INFO - Data sent: None 13:37:49 INFO - Starting new HTTPS connection (1): aus4-admin.mozilla.org 13:37:49 INFO - /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/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. 13:37:49 INFO - InsecurePlatformWarning 13:37:50 INFO - "GET /api/rules/145 HTTP/1.1" 200 687 13:37:50 INFO - REQUEST STATS: {"url": "https://aus4-admin.mozilla.org/api/rules/145", "timestamp": 1515101870.275888, "method": "GET", "elapsed_secs": 0.49497389793395996, "status_code": 200} 13:37:50 INFO - Balrog request to https://aus4-admin.mozilla.org/api/rules/145 13:37:50 INFO - Data sent: None 13:37:50 INFO - Starting new HTTPS connection (1): aus4-admin.mozilla.org 13:37:50 INFO - /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/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. 13:37:50 INFO - InsecurePlatformWarning 13:37:50 INFO - "HEAD /api/rules/145 HTTP/1.1" 200 0 13:37:50 INFO - REQUEST STATS: {"url": "https://aus4-admin.mozilla.org/api/rules/145", "timestamp": 1515101870.766029, "method": "HEAD", "elapsed_secs": 0.487415075302124, "status_code": 200} 13:37:50 INFO - Balrog request to https://aus4-admin.mozilla.org/api/scheduled_changes/rules 13:37:50 INFO - Data sent: {u'comment': u'default release rule updated by buildbot, DO NOT DELETE. Temp: be explicit and ensure only linux, darwin are updating to 57.0.1. Remove OS version field when we ship 57.0.2 to all platforms.', 'change_type': 'update', u'fallbackMapping': u'Firefox-57.0.3-build1', u'buildID': None, u'jaws': None, u'product': u'Firefox', u'instructionSet': None, u'mapping': 'Firefox-57.0.4-build1', u'alias': u'firefox-release', u'headerArchitecture': None, u'buildTarget': None, 'data_verison': 173, u'osVersion': None, u'distVersion': None, u'mig64': None, u'data_version': 173, 'when': 1515101989000, u'backgroundRate': 100, u'priority': 90, u'locale': None, u'version': None, u'update_type': u'minor', u'memory': None, u'distribution': None, u'rule_id': '145', u'channel': u'release'} 13:37:50 INFO - "POST /api/scheduled_changes/rules HTTP/1.1" 200 38 13:37:50 INFO - REQUEST STATS: {"url": "https://aus4-admin.mozilla.org/api/scheduled_changes/rules", "timestamp": 1515101870.968153, "method": "POST", "elapsed_secs": 0.20169305801391602, "status_code": 200} 13:37:50 INFO - Return code: 0 13:37:50 INFO - retry: Calling with args: (), kwargs: {}, attempt #1 13:37:50 INFO - Running command: ['/tools/buildbot/bin/python', '/builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/build/tools/scripts/build-promotion/balrog-release-shipper.py', '--api-root', u'https://aus4-admin.mozilla.org/api', '--credentials-file', '/builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/oauth.txt', '--username', 'balrog-ffxbld', '--version', u'57.0.4', '--product', u'firefox', '--build-number', '1', '--verbose', '--rules', '624', '--schedule-at', u'2018-01-04T16:00:00+00:00'] 13:37:50 INFO - Copy/paste: /tools/buildbot/bin/python /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/build/tools/scripts/build-promotion/balrog-release-shipper.py --api-root https://aus4-admin.mozilla.org/api --credentials-file /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/oauth.txt --username balrog-ffxbld --version 57.0.4 --product firefox --build-number 1 --verbose --rules 624 --schedule-at 2018-01-04T16:00:00+00:00 13:37:50 INFO - Using env: {'BALROG_BLOB_SUFFIX': '-bz2'} 13:37:51 INFO - Balrog request to https://aus4-admin.mozilla.org/api/rules/624 13:37:51 INFO - Data sent: None 13:37:51 INFO - Starting new HTTPS connection (1): aus4-admin.mozilla.org 13:37:51 INFO - /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/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. 13:37:51 INFO - InsecurePlatformWarning 13:37:51 INFO - "GET /api/rules/624 HTTP/1.1" 200 639 13:37:51 INFO - REQUEST STATS: {"url": "https://aus4-admin.mozilla.org/api/rules/624", "timestamp": 1515101871.643502, "method": "GET", "elapsed_secs": 0.49245786666870117, "status_code": 200} 13:37:51 INFO - Balrog request to https://aus4-admin.mozilla.org/api/rules/624 13:37:51 INFO - Data sent: None 13:37:51 INFO - Starting new HTTPS connection (1): aus4-admin.mozilla.org 13:37:51 INFO - /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/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. 13:37:51 INFO - InsecurePlatformWarning 13:37:52 INFO - "HEAD /api/rules/624 HTTP/1.1" 200 0 13:37:52 INFO - REQUEST STATS: {"url": "https://aus4-admin.mozilla.org/api/rules/624", "timestamp": 1515101872.136472, "method": "HEAD", "elapsed_secs": 0.49031591415405273, "status_code": 200} 13:37:52 INFO - Balrog request to https://aus4-admin.mozilla.org/api/scheduled_changes/rules 13:37:52 INFO - Data sent: {u'comment': u'Linux and macos users coming from <56.0 bz2 because they possibly skip the windows only 56.0 bz2 watershed (rule 685)', 'change_type': 'update', u'fallbackMapping': u'Firefox-57.0.3-build1-bz2', u'buildID': None, u'jaws': None, u'product': u'Firefox', u'instructionSet': None, u'mapping': 'Firefox-57.0.4-build1-bz2', u'alias': u'firefox-release-bz2', u'headerArchitecture': None, u'buildTarget': None, 'data_verison': 26, u'osVersion': u'Linux,Darwin', u'distVersion': None, u'mig64': None, u'data_version': 26, 'when': 1515101991000, u'backgroundRate': 100, u'priority': 100, u'locale': None, u'version': u'<56.0', u'update_type': u'minor', u'memory': None, u'distribution': None, u'rule_id': '624', u'channel': u'release'} 13:37:52 INFO - "POST /api/scheduled_changes/rules HTTP/1.1" 200 38 13:37:52 INFO - REQUEST STATS: {"url": "https://aus4-admin.mozilla.org/api/scheduled_changes/rules", "timestamp": 1515101872.296032, "method": "POST", "elapsed_secs": 0.15917301177978516, "status_code": 200} 13:37:52 INFO - Return code: 0 13:37:52 INFO - [mozharness: 2018-01-04 21:37:52.310898Z] Finished submit-to-balrog step (success) 13:37:52 INFO - Running post-run listener: copy_logs_to_upload_dir 13:37:52 INFO - Copying logs to upload dir... 13:37:52 INFO - mkdir: /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/build/upload/logs 13:37:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=9.334068 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/release/publish_balrog.py ...' (results: 0, elapsed: 9 secs) (at 2018-01-04 13:37:52.333175) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:52.334871) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/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-039.build.releng.use1.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-rel-fx_sc_p_in_balrog-00/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.006062 ========= master_lag: 0.05 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:52.388622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:52.388960) ========= rm -f oauth.txt in dir /builds/slave/rel-m-rel-fx_sc_p_in_balrog-00/. (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-039.build.releng.use1.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-rel-fx_sc_p_in_balrog-00 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.003870 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2018-01-04 13:37:52.446763) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2018-01-04 13:37:52.447196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2018-01-04 13:37:52.447553) ========= ========= Total master_lag: 0.19 =========