builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1470247568.5 results: success (0) buildid: 20160803073720 builduid: 64045580859f457b8afe5bc150d1b777 revision: 7ecbc0f93ff4b7954185ced028a34f7aaa44992d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:08.503288) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:08.503764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:08.504058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:08.519265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:08.519656) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 11:06:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-03 11:06:08 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075138 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:08.608793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:08.609113) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018502 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:08.658258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:08.658625) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ecbc0f93ff4b7954185ced028a34f7aaa44992d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ecbc0f93ff4b7954185ced028a34f7aaa44992d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 11:06:08,688 truncating revision to first 12 chars 2016-08-03 11:06:08,688 Setting DEBUG logging. 2016-08-03 11:06:08,688 attempt 1/10 2016-08-03 11:06:08,688 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7ecbc0f93ff4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 11:06:09,037 unpacking tar archive at: mozilla-aurora-7ecbc0f93ff4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676145 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:09.451764) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:09.452204) ========= script_repo_revision: 7ecbc0f93ff4b7954185ced028a34f7aaa44992d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:09.452635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:09.452970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 11:06:09.463736) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-03 11:06:09.464198) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:09 INFO - MultiFileLogger online at 20160803 11:06:09 in /builds/slave/test 11:06:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:06:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:09 INFO - {'append_to_log': False, 11:06:09 INFO - 'base_work_dir': '/builds/slave/test', 11:06:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:06:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:09 INFO - 'branch': 'Mozilla-Aurora', 11:06:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:09 INFO - 'config_files': ('talos/linux_config.py',), 11:06:09 INFO - 'default_actions': ('clobber', 11:06:09 INFO - 'read-buildbot-config', 11:06:09 INFO - 'download-and-extract', 11:06:09 INFO - 'populate-webroot', 11:06:09 INFO - 'create-virtualenv', 11:06:09 INFO - 'install', 11:06:09 INFO - 'run-tests'), 11:06:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:09 INFO - 'download_minidump_stackwalk': True, 11:06:09 INFO - 'download_symbols': 'ondemand', 11:06:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:09 INFO - 'installer_path': 'installer.exe', 11:06:09 INFO - 'log_level': 'info', 11:06:09 INFO - 'log_name': 'talos', 11:06:09 INFO - 'log_to_console': True, 11:06:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:09 INFO - 'opt_config_files': (), 11:06:09 INFO - 'pip_index': False, 11:06:09 INFO - 'sps_profile': False, 11:06:09 INFO - 'sps_profile_interval': 0, 11:06:09 INFO - 'suite': 'dromaeojs', 11:06:09 INFO - 'system_bits': '32', 11:06:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:09 INFO - 'title': 'talos-linux64-ix-062', 11:06:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:09 INFO - 'use_talos_json': True, 11:06:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:09 INFO - 'work_dir': 'build'} 11:06:09 INFO - [mozharness: 2016-08-03 18:06:09.588253Z] Running clobber step. 11:06:09 INFO - Running pre-action listener: _resource_record_pre_action 11:06:09 INFO - Running main action method: clobber 11:06:09 INFO - rmtree: /builds/slave/test/build 11:06:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:10 INFO - Running post-action listener: _resource_record_post_action 11:06:10 INFO - [mozharness: 2016-08-03 18:06:10.045141Z] Finished clobber step (success) 11:06:10 INFO - [mozharness: 2016-08-03 18:06:10.045242Z] Running read-buildbot-config step. 11:06:10 INFO - Running pre-action listener: _resource_record_pre_action 11:06:10 INFO - Running main action method: read_buildbot_config 11:06:10 INFO - Using buildbot properties: 11:06:10 INFO - { 11:06:10 INFO - "project": "", 11:06:10 INFO - "product": "firefox", 11:06:10 INFO - "script_repo_revision": "production", 11:06:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:06:10 INFO - "repository": "", 11:06:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:06:10 INFO - "buildid": "20160803073720", 11:06:10 INFO - "pgo_build": "True", 11:06:10 INFO - "basedir": "/builds/slave/test", 11:06:10 INFO - "buildnumber": 659, 11:06:10 INFO - "slavename": "talos-linux64-ix-062", 11:06:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:06:10 INFO - "platform": "ubuntu64_hw", 11:06:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:06:10 INFO - "branch": "mozilla-aurora", 11:06:10 INFO - "repo_path": "releases/mozilla-aurora", 11:06:10 INFO - "revision": "7ecbc0f93ff4b7954185ced028a34f7aaa44992d", 11:06:10 INFO - "stage_platform": "linux64-pgo", 11:06:10 INFO - "builduid": "64045580859f457b8afe5bc150d1b777", 11:06:10 INFO - "slavebuilddir": "test" 11:06:10 INFO - } 11:06:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 11:06:10 INFO - Running post-action listener: _resource_record_post_action 11:06:10 INFO - [mozharness: 2016-08-03 18:06:10.047689Z] Finished read-buildbot-config step (success) 11:06:10 INFO - [mozharness: 2016-08-03 18:06:10.047779Z] Running download-and-extract step. 11:06:10 INFO - Running pre-action listener: _resource_record_pre_action 11:06:10 INFO - Running main action method: download_and_extract 11:06:10 INFO - mkdir: /builds/slave/test/build/tests 11:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:10 INFO - https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:06:10 INFO - Downloaded 1361 bytes. 11:06:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:06:10 INFO - Using the following test package requirements: 11:06:10 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:06:10 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:06:10 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:06:10 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:10 INFO - u'jsshell-linux-x86_64.zip'], 11:06:10 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:06:10 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:06:10 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:06:10 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:06:10 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:06:10 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:06:10 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:10 INFO - https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:06:12 INFO - Downloaded 21767235 bytes. 11:06:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:06:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:06:13 INFO - Return code: 0 11:06:13 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:13 INFO - https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:06:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:06:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:06:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:06:14 INFO - Downloaded 21767235 bytes. 11:06:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:06:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:06:16 INFO - Return code: 0 11:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:16 INFO - https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:06:16 INFO - Downloaded 14413723 bytes. 11:06:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:06:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:06:17 INFO - Return code: 0 11:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:17 INFO - https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:06:19 INFO - Downloaded 63762619 bytes. 11:06:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:06:19 INFO - mkdir: /builds/slave/test/properties 11:06:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:19 INFO - Contents: 11:06:19 INFO - build_url:https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:06:20 INFO - Running post-action listener: _resource_record_post_action 11:06:20 INFO - Running post-action listener: set_extra_try_arguments 11:06:20 INFO - [mozharness: 2016-08-03 18:06:20.250132Z] Finished download-and-extract step (success) 11:06:20 INFO - [mozharness: 2016-08-03 18:06:20.250364Z] Running populate-webroot step. 11:06:20 INFO - Running pre-action listener: _resource_record_pre_action 11:06:20 INFO - Running main action method: populate_webroot 11:06:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:06:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:06:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:06:20 INFO - '--tppagecycles', 11:06:20 INFO - '7'], 11:06:20 INFO - 'tests': ['tsvgm']}}, 11:06:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:06:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:06:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:20 INFO - 'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:20 INFO - 'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['damp', 'tps']}, 11:06:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:20 INFO - 'tests': ['damp', 'tps']}, 11:06:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['dromaeo_dom']}, 11:06:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['basic_compositor_video']}, 11:06:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:06:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['a11yr', 11:06:20 INFO - 'ts_paint', 11:06:20 INFO - 'tpaint', 11:06:20 INFO - 'sessionrestore', 11:06:20 INFO - 'sessionrestore_no_auto_restore', 11:06:20 INFO - 'tabpaint']}, 11:06:20 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:20 INFO - 'ts_paint', 11:06:20 INFO - 'tpaint', 11:06:20 INFO - 'sessionrestore', 11:06:20 INFO - 'sessionrestore_no_auto_restore', 11:06:20 INFO - 'tabpaint']}, 11:06:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:06:20 INFO - 'ts_paint', 11:06:20 INFO - 'tpaint', 11:06:20 INFO - 'sessionrestore', 11:06:20 INFO - 'sessionrestore_no_auto_restore', 11:06:20 INFO - 'tabpaint']}, 11:06:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:06:20 INFO - 'ts_paint', 11:06:20 INFO - 'tpaint', 11:06:20 INFO - 'sessionrestore', 11:06:20 INFO - 'sessionrestore_no_auto_restore', 11:06:20 INFO - 'tabpaint']}, 11:06:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['a11yr', 11:06:20 INFO - 'ts_paint', 11:06:20 INFO - 'tpaint', 11:06:20 INFO - 'sessionrestore', 11:06:20 INFO - 'sessionrestore_no_auto_restore', 11:06:20 INFO - 'tabpaint']}, 11:06:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['a11yr', 11:06:20 INFO - 'ts_paint', 11:06:20 INFO - 'tpaint', 11:06:20 INFO - 'sessionrestore', 11:06:20 INFO - 'sessionrestore_no_auto_restore', 11:06:20 INFO - 'tabpaint']}, 11:06:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['tsvgx', 11:06:20 INFO - 'tsvgr_opacity', 11:06:20 INFO - 'tart', 11:06:20 INFO - 'tscrollx', 11:06:20 INFO - 'cart']}, 11:06:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:20 INFO - 'tsvgr_opacity', 11:06:20 INFO - 'tart', 11:06:20 INFO - 'tscrollx', 11:06:20 INFO - 'cart']}, 11:06:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:20 INFO - 'talos_options': ['--disable-e10s'], 11:06:20 INFO - 'tests': ['tp5o']}, 11:06:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:20 INFO - 'tests': ['tp5o']}, 11:06:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:20 INFO - 'talos_options': ['--disable-e10s', 11:06:20 INFO - '--xperf_path', 11:06:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:20 INFO - 'tests': ['tp5n']}, 11:06:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:20 INFO - 'talos_options': ['--xperf_path', 11:06:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:20 INFO - 'tests': ['tp5n']}}, 11:06:20 INFO - 'talos.zip': {'path': '', 11:06:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:06:20 INFO - Running post-action listener: _resource_record_post_action 11:06:20 INFO - [mozharness: 2016-08-03 18:06:20.267858Z] Finished populate-webroot step (success) 11:06:20 INFO - [mozharness: 2016-08-03 18:06:20.267946Z] Running create-virtualenv step. 11:06:20 INFO - Running pre-action listener: _resource_record_pre_action 11:06:20 INFO - Running main action method: create_virtualenv 11:06:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:06:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:06:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:20 INFO - Using real prefix '/usr' 11:06:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:22 INFO - Installing pip.................done. 11:06:22 INFO - Return code: 0 11:06:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:06:22 INFO - Using env: {'DISPLAY': ':0', 11:06:22 INFO - 'HOME': '/home/cltbld', 11:06:22 INFO - 'LANG': 'en_US.UTF-8', 11:06:22 INFO - 'LANGUAGE': 'en_US:en', 11:06:22 INFO - 'LOGNAME': 'cltbld', 11:06:22 INFO - 'MAIL': '/var/mail/cltbld', 11:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:22 INFO - 'MOZ_NO_REMOTE': '1', 11:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:22 INFO - 'NO_EM_RESTART': '1', 11:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:22 INFO - 'PWD': '/builds/slave/test', 11:06:22 INFO - 'SHELL': '/bin/bash', 11:06:22 INFO - 'SHLVL': '1', 11:06:22 INFO - 'TERM': 'linux', 11:06:22 INFO - 'TMOUT': '86400', 11:06:22 INFO - 'USER': 'cltbld', 11:06:22 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:22 INFO - '_': '/tools/buildbot/bin/python'} 11:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:06:23 INFO - Cleaning up... 11:06:23 INFO - Return code: 0 11:06:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:06:23 INFO - Using env: {'DISPLAY': ':0', 11:06:23 INFO - 'HOME': '/home/cltbld', 11:06:23 INFO - 'LANG': 'en_US.UTF-8', 11:06:23 INFO - 'LANGUAGE': 'en_US:en', 11:06:23 INFO - 'LOGNAME': 'cltbld', 11:06:23 INFO - 'MAIL': '/var/mail/cltbld', 11:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:23 INFO - 'MOZ_NO_REMOTE': '1', 11:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:23 INFO - 'NO_EM_RESTART': '1', 11:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:23 INFO - 'PWD': '/builds/slave/test', 11:06:23 INFO - 'SHELL': '/bin/bash', 11:06:23 INFO - 'SHLVL': '1', 11:06:23 INFO - 'TERM': 'linux', 11:06:23 INFO - 'TMOUT': '86400', 11:06:23 INFO - 'USER': 'cltbld', 11:06:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:23 INFO - '_': '/tools/buildbot/bin/python'} 11:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:23 INFO - Downloading/unpacking psutil>=3.1.1 11:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:25 INFO - Installing collected packages: psutil 11:06:25 INFO - Running setup.py install for psutil 11:06:25 INFO - building 'psutil._psutil_linux' extension 11:06:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:06:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:06:25 INFO - building 'psutil._psutil_posix' extension 11:06:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:06:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:06:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:25 INFO - Successfully installed psutil 11:06:25 INFO - Cleaning up... 11:06:25 INFO - Return code: 0 11:06:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:06:25 INFO - Using env: {'DISPLAY': ':0', 11:06:25 INFO - 'HOME': '/home/cltbld', 11:06:25 INFO - 'LANG': 'en_US.UTF-8', 11:06:25 INFO - 'LANGUAGE': 'en_US:en', 11:06:25 INFO - 'LOGNAME': 'cltbld', 11:06:25 INFO - 'MAIL': '/var/mail/cltbld', 11:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:25 INFO - 'MOZ_NO_REMOTE': '1', 11:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:25 INFO - 'NO_EM_RESTART': '1', 11:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:25 INFO - 'PWD': '/builds/slave/test', 11:06:25 INFO - 'SHELL': '/bin/bash', 11:06:25 INFO - 'SHLVL': '1', 11:06:25 INFO - 'TERM': 'linux', 11:06:25 INFO - 'TMOUT': '86400', 11:06:25 INFO - 'USER': 'cltbld', 11:06:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:25 INFO - '_': '/tools/buildbot/bin/python'} 11:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:28 INFO - Installing collected packages: mozsystemmonitor 11:06:28 INFO - Running setup.py install for mozsystemmonitor 11:06:28 INFO - Successfully installed mozsystemmonitor 11:06:28 INFO - Cleaning up... 11:06:28 INFO - Return code: 0 11:06:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:06:28 INFO - Using env: {'DISPLAY': ':0', 11:06:28 INFO - 'HOME': '/home/cltbld', 11:06:28 INFO - 'LANG': 'en_US.UTF-8', 11:06:28 INFO - 'LANGUAGE': 'en_US:en', 11:06:28 INFO - 'LOGNAME': 'cltbld', 11:06:28 INFO - 'MAIL': '/var/mail/cltbld', 11:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:28 INFO - 'MOZ_NO_REMOTE': '1', 11:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:28 INFO - 'NO_EM_RESTART': '1', 11:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:28 INFO - 'PWD': '/builds/slave/test', 11:06:28 INFO - 'SHELL': '/bin/bash', 11:06:28 INFO - 'SHLVL': '1', 11:06:28 INFO - 'TERM': 'linux', 11:06:28 INFO - 'TMOUT': '86400', 11:06:28 INFO - 'USER': 'cltbld', 11:06:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:28 INFO - '_': '/tools/buildbot/bin/python'} 11:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:28 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:30 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:30 INFO - warning: no files found matching '*.txt' 11:06:30 INFO - no previously-included directories found matching 'build' 11:06:30 INFO - no previously-included directories found matching 'dist' 11:06:30 INFO - no previously-included directories found matching '.git*' 11:06:30 INFO - Installing collected packages: jsonschema, functools32 11:06:30 INFO - Running setup.py install for functools32 11:06:30 INFO - warning: no files found matching '*.txt' 11:06:30 INFO - no previously-included directories found matching 'build' 11:06:30 INFO - no previously-included directories found matching 'dist' 11:06:30 INFO - no previously-included directories found matching '.git*' 11:06:30 INFO - Successfully installed jsonschema functools32 11:06:30 INFO - Cleaning up... 11:06:30 INFO - Return code: 0 11:06:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:06:30 INFO - Using env: {'DISPLAY': ':0', 11:06:30 INFO - 'HOME': '/home/cltbld', 11:06:30 INFO - 'LANG': 'en_US.UTF-8', 11:06:30 INFO - 'LANGUAGE': 'en_US:en', 11:06:30 INFO - 'LOGNAME': 'cltbld', 11:06:30 INFO - 'MAIL': '/var/mail/cltbld', 11:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:30 INFO - 'MOZ_NO_REMOTE': '1', 11:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:30 INFO - 'NO_EM_RESTART': '1', 11:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:30 INFO - 'PWD': '/builds/slave/test', 11:06:30 INFO - 'SHELL': '/bin/bash', 11:06:30 INFO - 'SHLVL': '1', 11:06:30 INFO - 'TERM': 'linux', 11:06:30 INFO - 'TMOUT': '86400', 11:06:30 INFO - 'USER': 'cltbld', 11:06:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:30 INFO - '_': '/tools/buildbot/bin/python'} 11:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:30 INFO - Cleaning up... 11:06:30 INFO - Return code: 0 11:06:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:06:30 INFO - Using env: {'DISPLAY': ':0', 11:06:30 INFO - 'HOME': '/home/cltbld', 11:06:30 INFO - 'LANG': 'en_US.UTF-8', 11:06:30 INFO - 'LANGUAGE': 'en_US:en', 11:06:30 INFO - 'LOGNAME': 'cltbld', 11:06:30 INFO - 'MAIL': '/var/mail/cltbld', 11:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:30 INFO - 'MOZ_NO_REMOTE': '1', 11:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:30 INFO - 'NO_EM_RESTART': '1', 11:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:30 INFO - 'PWD': '/builds/slave/test', 11:06:30 INFO - 'SHELL': '/bin/bash', 11:06:30 INFO - 'SHLVL': '1', 11:06:30 INFO - 'TERM': 'linux', 11:06:30 INFO - 'TMOUT': '86400', 11:06:30 INFO - 'USER': 'cltbld', 11:06:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:30 INFO - '_': '/tools/buildbot/bin/python'} 11:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:31 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:33 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:33 INFO - Downloading docopt-0.6.1.tar.gz 11:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:33 INFO - Running setup.py install for blobuploader 11:06:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:33 INFO - Running setup.py install for requests 11:06:34 INFO - Running setup.py install for docopt 11:06:34 INFO - Successfully installed blobuploader requests docopt 11:06:34 INFO - Cleaning up... 11:06:34 INFO - Return code: 0 11:06:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:34 INFO - Using env: {'DISPLAY': ':0', 11:06:34 INFO - 'HOME': '/home/cltbld', 11:06:34 INFO - 'LANG': 'en_US.UTF-8', 11:06:34 INFO - 'LANGUAGE': 'en_US:en', 11:06:34 INFO - 'LOGNAME': 'cltbld', 11:06:34 INFO - 'MAIL': '/var/mail/cltbld', 11:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:34 INFO - 'MOZ_NO_REMOTE': '1', 11:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:34 INFO - 'NO_EM_RESTART': '1', 11:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:34 INFO - 'PWD': '/builds/slave/test', 11:06:34 INFO - 'SHELL': '/bin/bash', 11:06:34 INFO - 'SHLVL': '1', 11:06:34 INFO - 'TERM': 'linux', 11:06:34 INFO - 'TMOUT': '86400', 11:06:34 INFO - 'USER': 'cltbld', 11:06:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:34 INFO - '_': '/tools/buildbot/bin/python'} 11:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:34 INFO - Running setup.py (path:/tmp/pip-1aWBk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:34 INFO - Running setup.py (path:/tmp/pip-bVAdlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:34 INFO - Running setup.py (path:/tmp/pip-fz6mL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:34 INFO - Running setup.py (path:/tmp/pip-6l0P80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:34 INFO - Running setup.py (path:/tmp/pip-4tzWpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:35 INFO - Running setup.py (path:/tmp/pip-3flWcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:35 INFO - Running setup.py (path:/tmp/pip-u73fAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:35 INFO - Running setup.py (path:/tmp/pip-Oj7E7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:35 INFO - Running setup.py (path:/tmp/pip-D6h63c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:35 INFO - Running setup.py (path:/tmp/pip-IfLcPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:35 INFO - Running setup.py (path:/tmp/pip-r1gx4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:35 INFO - Running setup.py (path:/tmp/pip-hl9OoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:35 INFO - Running setup.py (path:/tmp/pip-DW_0sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:35 INFO - Running setup.py (path:/tmp/pip-bBBy2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:35 INFO - Running setup.py (path:/tmp/pip-ktoHtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:35 INFO - Running setup.py (path:/tmp/pip-WArFMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:35 INFO - Running setup.py (path:/tmp/pip-JpllBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:35 INFO - Running setup.py install for manifestparser 11:06:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Running setup.py install for mozcrash 11:06:36 INFO - Running setup.py install for mozdebug 11:06:36 INFO - Running setup.py install for mozdevice 11:06:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Running setup.py install for mozfile 11:06:36 INFO - Running setup.py install for mozhttpd 11:06:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Running setup.py install for mozinfo 11:06:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Running setup.py install for mozInstall 11:06:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Running setup.py install for mozleak 11:06:36 INFO - Running setup.py install for mozlog 11:06:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:36 INFO - Running setup.py install for moznetwork 11:06:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:37 INFO - Running setup.py install for mozprocess 11:06:37 INFO - Running setup.py install for mozprofile 11:06:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:37 INFO - Running setup.py install for mozrunner 11:06:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:37 INFO - Running setup.py install for mozscreenshot 11:06:37 INFO - Running setup.py install for moztest 11:06:37 INFO - Running setup.py install for mozversion 11:06:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:37 INFO - Cleaning up... 11:06:37 INFO - Return code: 0 11:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:37 INFO - Using env: {'DISPLAY': ':0', 11:06:37 INFO - 'HOME': '/home/cltbld', 11:06:37 INFO - 'LANG': 'en_US.UTF-8', 11:06:37 INFO - 'LANGUAGE': 'en_US:en', 11:06:37 INFO - 'LOGNAME': 'cltbld', 11:06:37 INFO - 'MAIL': '/var/mail/cltbld', 11:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:37 INFO - 'MOZ_NO_REMOTE': '1', 11:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:37 INFO - 'NO_EM_RESTART': '1', 11:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:37 INFO - 'PWD': '/builds/slave/test', 11:06:37 INFO - 'SHELL': '/bin/bash', 11:06:37 INFO - 'SHLVL': '1', 11:06:37 INFO - 'TERM': 'linux', 11:06:37 INFO - 'TMOUT': '86400', 11:06:37 INFO - 'USER': 'cltbld', 11:06:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:37 INFO - '_': '/tools/buildbot/bin/python'} 11:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:37 INFO - Running setup.py (path:/tmp/pip-cnCGnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:38 INFO - Running setup.py (path:/tmp/pip-DqBjw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:38 INFO - Running setup.py (path:/tmp/pip-hbodZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:38 INFO - Running setup.py (path:/tmp/pip-vw0DVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:38 INFO - Running setup.py (path:/tmp/pip-H4L4R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:38 INFO - Running setup.py (path:/tmp/pip-INZUE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:38 INFO - Running setup.py (path:/tmp/pip-eeJF0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:38 INFO - Running setup.py (path:/tmp/pip-LppJU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:38 INFO - Running setup.py (path:/tmp/pip-JhSQsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:38 INFO - Running setup.py (path:/tmp/pip-RIZUo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:38 INFO - Running setup.py (path:/tmp/pip-0gbxt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:38 INFO - Running setup.py (path:/tmp/pip-GMmY0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:38 INFO - Running setup.py (path:/tmp/pip-n5Uv0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:38 INFO - Running setup.py (path:/tmp/pip-7pyn8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:38 INFO - Running setup.py (path:/tmp/pip-te1yR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:39 INFO - Running setup.py (path:/tmp/pip-U7lJiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:39 INFO - Running setup.py (path:/tmp/pip-lkZkGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:41 INFO - Downloading blessings-1.6.tar.gz 11:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:41 INFO - Installing collected packages: blessings 11:06:41 INFO - Running setup.py install for blessings 11:06:41 INFO - Successfully installed blessings 11:06:41 INFO - Cleaning up... 11:06:41 INFO - Return code: 0 11:06:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:41 INFO - Reading from file tmpfile_stdout 11:06:41 INFO - Current package versions: 11:06:41 INFO - argparse == 1.2.1 11:06:41 INFO - blessings == 1.6 11:06:41 INFO - blobuploader == 1.2.4 11:06:41 INFO - docopt == 0.6.1 11:06:41 INFO - functools32 == 3.2.3-2 11:06:41 INFO - jsonschema == 2.5.1 11:06:41 INFO - manifestparser == 1.1 11:06:41 INFO - mozInstall == 1.12 11:06:41 INFO - mozcrash == 0.17 11:06:41 INFO - mozdebug == 0.1 11:06:41 INFO - mozdevice == 0.48 11:06:41 INFO - mozfile == 1.2 11:06:41 INFO - mozhttpd == 0.7 11:06:41 INFO - mozinfo == 0.9 11:06:41 INFO - mozleak == 0.1 11:06:41 INFO - mozlog == 3.3 11:06:41 INFO - moznetwork == 0.27 11:06:41 INFO - mozprocess == 0.23 11:06:41 INFO - mozprofile == 0.28 11:06:41 INFO - mozrunner == 6.12 11:06:41 INFO - mozscreenshot == 0.1 11:06:41 INFO - mozsystemmonitor == 0.3 11:06:41 INFO - moztest == 0.7 11:06:41 INFO - mozversion == 1.4 11:06:41 INFO - psutil == 3.1.1 11:06:41 INFO - requests == 1.2.3 11:06:41 INFO - wsgiref == 0.1.2 11:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:41 INFO - Using env: {'DISPLAY': ':0', 11:06:41 INFO - 'HOME': '/home/cltbld', 11:06:41 INFO - 'LANG': 'en_US.UTF-8', 11:06:41 INFO - 'LANGUAGE': 'en_US:en', 11:06:41 INFO - 'LOGNAME': 'cltbld', 11:06:41 INFO - 'MAIL': '/var/mail/cltbld', 11:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:41 INFO - 'MOZ_NO_REMOTE': '1', 11:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:41 INFO - 'NO_EM_RESTART': '1', 11:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:41 INFO - 'PWD': '/builds/slave/test', 11:06:41 INFO - 'SHELL': '/bin/bash', 11:06:41 INFO - 'SHLVL': '1', 11:06:41 INFO - 'TERM': 'linux', 11:06:41 INFO - 'TMOUT': '86400', 11:06:41 INFO - 'USER': 'cltbld', 11:06:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:41 INFO - '_': '/tools/buildbot/bin/python'} 11:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:06:41 INFO - Cleaning up... 11:06:41 INFO - Return code: 0 11:06:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1206180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:06:41 INFO - Using env: {'DISPLAY': ':0', 11:06:41 INFO - 'HOME': '/home/cltbld', 11:06:41 INFO - 'LANG': 'en_US.UTF-8', 11:06:41 INFO - 'LANGUAGE': 'en_US:en', 11:06:41 INFO - 'LOGNAME': 'cltbld', 11:06:41 INFO - 'MAIL': '/var/mail/cltbld', 11:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:41 INFO - 'MOZ_NO_REMOTE': '1', 11:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:41 INFO - 'NO_EM_RESTART': '1', 11:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:41 INFO - 'PWD': '/builds/slave/test', 11:06:41 INFO - 'SHELL': '/bin/bash', 11:06:41 INFO - 'SHLVL': '1', 11:06:41 INFO - 'TERM': 'linux', 11:06:41 INFO - 'TMOUT': '86400', 11:06:41 INFO - 'USER': 'cltbld', 11:06:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:41 INFO - '_': '/tools/buildbot/bin/python'} 11:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:06:41 INFO - Cleaning up... 11:06:41 INFO - Return code: 0 11:06:41 INFO - Running post-action listener: _resource_record_post_action 11:06:41 INFO - Running post-action listener: _start_resource_monitoring 11:06:41 INFO - Starting resource monitoring. 11:06:41 INFO - [mozharness: 2016-08-03 18:06:41.995364Z] Finished create-virtualenv step (success) 11:06:41 INFO - [mozharness: 2016-08-03 18:06:41.995794Z] Running install step. 11:06:41 INFO - Running pre-action listener: _resource_record_pre_action 11:06:41 INFO - Running main action method: install 11:06:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:42 INFO - Reading from file tmpfile_stdout 11:06:42 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:42 INFO - Reading from file tmpfile_stdout 11:06:42 INFO - Output received: 11:06:42 INFO - Usage: mozinstall [options] installer 11:06:42 INFO - Options: 11:06:42 INFO - -h, --help show this help message and exit 11:06:42 INFO - -d DEST, --destination=DEST 11:06:42 INFO - Directory to install application into. [default: 11:06:42 INFO - "/builds/slave/test"] 11:06:42 INFO - --app=APP Application being installed. [default: firefox] 11:06:42 INFO - mkdir: /builds/slave/test/build/application 11:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:06:58 INFO - Reading from file tmpfile_stdout 11:06:58 INFO - Output received: 11:06:58 INFO - /builds/slave/test/build/application/firefox/firefox 11:06:58 INFO - Running post-action listener: _resource_record_post_action 11:06:58 INFO - [mozharness: 2016-08-03 18:06:58.293806Z] Finished install step (success) 11:06:58 INFO - [mozharness: 2016-08-03 18:06:58.294080Z] Running run-tests step. 11:06:58 INFO - Running pre-action listener: _resource_record_pre_action 11:06:58 INFO - Running main action method: run_tests 11:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:58 INFO - Python 2.7.3 11:06:58 INFO - Return code: 0 11:06:58 INFO - grabbing minidump binary from tooltool 11:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12043b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1205740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:06:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:06:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:06:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:58 INFO - Return code: 0 11:06:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:06:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:06:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:06:58 INFO - Using env: {'DISPLAY': ':0', 11:06:58 INFO - 'HOME': '/home/cltbld', 11:06:58 INFO - 'LANG': 'en_US.UTF-8', 11:06:58 INFO - 'LANGUAGE': 'en_US:en', 11:06:58 INFO - 'LOGNAME': 'cltbld', 11:06:58 INFO - 'MAIL': '/var/mail/cltbld', 11:06:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:58 INFO - 'MOZ_NO_REMOTE': '1', 11:06:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:58 INFO - 'NO_EM_RESTART': '1', 11:06:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:58 INFO - 'PWD': '/builds/slave/test', 11:06:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:58 INFO - 'SHELL': '/bin/bash', 11:06:58 INFO - 'SHLVL': '1', 11:06:58 INFO - 'TERM': 'linux', 11:06:58 INFO - 'TMOUT': '86400', 11:06:58 INFO - 'USER': 'cltbld', 11:06:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762', 11:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:58 INFO - '_': '/tools/buildbot/bin/python'} 11:06:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:06:58 INFO - mozversion application_buildid: 20160803073720 11:06:58 INFO - mozversion application_changeset: 7ecbc0f93ff4b7954185ced028a34f7aaa44992d 11:06:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:06:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:58 INFO - mozversion application_name: Firefox 11:06:58 INFO - mozversion application_remotingname: firefox-dev 11:06:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:06:58 INFO - mozversion application_vendor: Mozilla 11:06:58 INFO - mozversion application_version: 50.0a2 11:06:58 INFO - mozversion platform_buildid: 20160803073720 11:06:58 INFO - mozversion platform_changeset: 7ecbc0f93ff4b7954185ced028a34f7aaa44992d 11:06:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:06:58 INFO - mozversion platform_version: 50.0a2 11:06:58 INFO - using testdate: 1470247618 11:06:58 INFO - actual date: 1470247618 11:06:58 INFO - starting webserver on 'localhost:39359' 11:06:58 INFO - SUITE-START | Running 2 tests 11:06:58 INFO - TEST-START | dromaeo_css 11:06:58 INFO - operating with platform_type : linux_ 11:06:58 INFO - Initialising browser for dromaeo_css test... 11:06:58 INFO - TEST-INFO | started process 14104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9E7IA/profile http://localhost:39359/getInfo.html) 11:07:02 INFO - PROCESS | 14104 | __metrics Screen width/height:1600/1200 11:07:02 INFO - PROCESS | 14104 | colorDepth:24 11:07:02 INFO - PROCESS | 14104 | Browser inner width/height: 1024/697 11:07:02 INFO - PROCESS | 14104 | __metrics 11:07:03 INFO - PROCESS | 14104 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:07:03 INFO - PROCESS | 14104 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:07:04 INFO - TEST-INFO | 14104: exit 0 11:07:04 INFO - Browser initialized. 11:07:04 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:04 INFO - TEST-INFO | started process 14193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9E7IA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:16 INFO - PROCESS | 14193 | RSS: Main: 145141760 11:07:16 INFO - PROCESS | 14193 | 11:08:06 INFO - PROCESS | 14193 | 1470247686860 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:10:15 INFO - PROCESS | 14193 | Cycle 1(1): loaded http://localhost:39359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39359/tests/dromaeo/cssquery-ext.html) 11:10:16 INFO - PROCESS | 14193 | RSS: Main: 269680640 11:10:16 INFO - PROCESS | 14193 | 11:13:19 INFO - PROCESS | 14193 | Cycle 1(1): loaded http://localhost:39359/tests/dromaeo/cssquery-ext.html (next: http://localhost:39359/tests/dromaeo/cssquery-jquery.html) 11:13:19 INFO - PROCESS | 14193 | RSS: Main: 231641088 11:13:19 INFO - PROCESS | 14193 | 11:16:21 INFO - PROCESS | 14193 | Cycle 1(1): loaded http://localhost:39359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39359/tests/dromaeo/cssquery-mootools.html) 11:16:22 INFO - PROCESS | 14193 | RSS: Main: 174284800 11:16:22 INFO - PROCESS | 14193 | 11:19:24 INFO - PROCESS | 14193 | Cycle 1(1): loaded http://localhost:39359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39359/tests/dromaeo/cssquery-prototype.html) 11:19:25 INFO - PROCESS | 14193 | RSS: Main: 171970560 11:19:25 INFO - PROCESS | 14193 | 11:22:27 INFO - PROCESS | 14193 | Cycle 1(1): loaded http://localhost:39359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39359/tests/dromaeo/cssquery-yui.html) 11:22:28 INFO - PROCESS | 14193 | RSS: Main: 172113920 11:22:28 INFO - PROCESS | 14193 | 11:25:30 INFO - PROCESS | 14193 | Cycle 1(1): loaded http://localhost:39359/tests/dromaeo/cssquery-yui.html (next: http://localhost:39359/tests/dromaeo/cssquery-dojo.html) 11:25:31 INFO - PROCESS | 14193 | RSS: Main: 264314880 11:25:31 INFO - PROCESS | 14193 | 11:25:31 INFO - PROCESS | 14193 | __start_tp_report 11:25:31 INFO - PROCESS | 14193 | _x_x_mozilla_page_load 11:25:31 INFO - PROCESS | 14193 | _x_x_mozilla_page_load_details 11:25:31 INFO - PROCESS | 14193 | |i|pagename|runs| 11:25:31 INFO - PROCESS | 14193 | |0;dojo.html;3155.4162479941215;3190.154609028608;3197.4884018557027;3217.099212220579;3249.366373557157;5477.917831232535;5541.669999200199;5567.972160139194;5591.30108736408;5596.524295434893;5553.7778488860495;5610.747516361764;5616.241807356006;5622.353429355625;5648.068068768648;4940.8517744467545;4953.4303555091265;5037.068142393659;5062.493750624926;5126.41046279677;5002.749862506878;5005.474425185358;5032.6477146599755;5064.063148317555;5137.383513978328;5054.9241761373605;5055.595552355821;5058.165402708549;5079.060373830835;5168.870778230536;5117.104506711311;5128.205128205134;5130.97434512825;5148.794048238066;5174.844754657366;4862.222044472867;4953.90092198154;5007.37407824022;5052.898942021176;5069.670471419383;5551.1118221084835;5599.608027438081;5615.382307946123;5617.494425501724;5628.04323265046;6018.548608854309;6025.216721826178;6057.818265452043;6058.363871793443;6061.090836374535;5783.9710801446145;5912.586118971631;5929.436703513159;5932.555058370639;6042.244719410074;5575.498205161555;5641.971790141023;5645.633033852869;5648.548116150698;5649.576281778842;6086.393303771593;6097.17688112108;6132.662703551258;6133.202683651186;6135.0797380392405;5606.6916319602;5773.624714393551;5806.361300256968;5832.62087964281;5932.3177834548715;5996.820095397145;6026.306974697878;6047;6054.788082417094;6063.029915213545;5913.586048976616;5918.940810591925;5975.910361344583;5978.133170690226;5980.820575382745;5735.225744524436;5768.250127483484;5897.587168898136;5969.015112506388;5977.133315669291;4618.49196588375;4619.769011549409;4622.67641265115;4641.280601506772;4650.37219975299;4105.158442519277;4110.609492098246;4115.156392939441;4120.958790412117;4121.443605113332;5500.3949565547755;5600.355959064678;5742.7415766290615;5743.2246646703;5753.194552762617;5926.2888453385;5996.5202783777195;6001.039833626599;6006.729697163638;6022.36765139654;5606.271184745957;5613.635113717595;5631.042722737145;5683.9715801420725;5686.658800471985;5001.324821149171;5086.618503612244;5101.056304583664;5102.4897510248675;5103.464136265638;6132.508481341068;6185.288691800411;6189.473894718999;6192.907106393408;6232.75068997235;5888.499477544286;5952.375000625046;5959.642421454727;5988.520918326436;6005.699715014144;6006.699665016819;6096.9390306096375;6102.4812890902995;6162.784302549389;6180.598261113013;5821.388754180919;5893.351731309638;5897.292324921037;5940.46535811779;5948.583599148018;5937.406259374028;5974.462298393166;5989.760409583742;5994.970025149846;5997.70011499432;5597.160425935979;5840.831833633205;5859.707014649336;5861.736221869941;5869.35437101927;5866.765329386777;5902.822915312548;5918.852028699317;5926.555508336805;5952.166696662557;5832.096025116114;5832.912506312324;5847.327557330791;5851.297844258716;5859.091840764689;5648.181013753065;5790.305163380422;5878;5904.261967254093;5950.464458198783;5670.631408958405;5721.828345149652;5738.081906894877;5778.855528611818;5782.421757824184 11:25:31 INFO - PROCESS | 14193 | |1;ext.html;610.7862248213125;656.6224420957948;662.0830150241915;664.3423011218891;674.2818897873761;34361.31277374451;46227;47735;47791;47926.76036619812;47655.761721191346;47818.76090619551;47913;48355.758221208845;48560.75719621406;9145.496997665143;9412.858807117864;9419.434833909952;9424.717258482222;9426.717198484057;8406.159384061606;10778.946105269462;11055.668329950115;11063.557457701681;11431.885681143165;11360.943195284053;11440.713982150472;11448.141389395829;11475.254108482965;11495.367754773484;11046.613368532104;11117.277376970553;11132.721681957975;11134;11137.220394572383;10917.799042105362;10948.069414099811;10976.451177441097;10994.560217591286;11001.339919604849;45478;45697.08605827898;45763.542364576264;45816;45846.31230531545;3930.233604447134;3931.410288456726;3965.0087478130467;3998.8800335989968;4096.262672718909;34385.65614343849;34631.48052779185;35136.47295290573;35539.64460355415;35552.111197220016;4679;4680.461746899116;4767.308740232682;4812.566868981773;4832.661713680044;373987;374601;374979;375388;376375;61995;62315;62347.376526234155;62405;62528.374716252256;41239;42262.57737422586;42511.36232956508;42582.36126458106;66379.33620663731;19365.903170484056;19468.22127114928;19490.220391184477;19495.902520487307;19511.707324390147;12990.740185196431;13042.673933151558;14761.77857332141;14882.92558537222;14903.552893413214;19786.90106549487;20731.8963405182;20732.792672073087;20899.268525601532;20947.68578471324;7590.316871481593;7606.543607383574;7726.806829829299;7858.803529911684;7969.246765711534;1082.718493191776;1128.9209755317213;1142.223124817351;1168.9415529223504;1189.0071790055401;34106.82946585301;34553.654463455045;34584.13539661529;35205.82397087998;35366.46950295748;1196.6350263169816;1206.3666575047994;1220.3349174699633;1227.8526576810661;1288.4974859804684;18325.63348733018;18352.81647183511;18353.17410716521;18564.350247741266;18584.535386615444;604592;606357;607407;611189;612850;64734;64988;65016;65327.673361632886;65529;1347.7910923806826;1452.6077958951234;1472.6612879037666;1518.582389842802;1524.481676230087;33628.831855840566;36116.63883361238;36425;36647.08382290464;36770;53652.463475366305;54019;55651.16523252073;55711.72144139253;60613.393866062535;550510;556297;556945;557793;557880;29820.403591927607;30217.697823021488;31155.844220778752;32729.836350818092;33229.83385083156;52289;52644.21033684575;52769;52845;52888.735556321975;42440.787796060824;43487.56512434835;44625.776871115435;44789.32816007828;45792;44388.7780561108;44846.3273050898;45729.085418290786;45770;46570.534294656616;45389.31916021329;45490;46460;46665;48542;39228.41157382698;40593.59406405898;41286.38070428886;41378.586214137475;41427.79286103671;30641.233969150948;30697.386052279275;30903.2274193147;30905.53641695421;30979 11:25:31 INFO - PROCESS | 14193 | |2;jquery.html;387.38599320077674;396.55387688850027;410.5935124227015;411.19816358101707;427.13718289056106;14125.858741412583;19931;20139.29512467064;20209.29267475637;20681.896590517063;20204;20268;20318.288859889908;20354.69467957978;20529.384118476468;5680.233168522259;5807.186993820868;5881.941180588204;5936.465718085371;5950.494207992304;5957.582969192158;5986.07215881539;5992.7902523411685;6011.428914253139;6024.307204671453;5973.432523910222;6034.06471996839;6036.728347224385;6050;6067.696615169246;6103.481204097657;6173.629582225059;6220.595661282002;6222.875542489125;6225.47083497901;5913.497352725023;6026.457618814327;6031.909521357183;6049.939500604982;6058.757649694007;14424.134551926812;14741;18356.724649130272;23554.175603853782;24120.396990075213;2545.7963362930923;2552.885120169597;2680.973190268092;2721.8911243550233;2950.616419865425;10443.373397596168;10617.362958222531;10740.785184296348;10830.72923176919;10888.564457421693;2015.9193632254692;2033.4814622271374;2069.9172033118807;2138.2302371146375;2169.8264138869013;65114.67442662804;68384.3161568383;78405.60797195978;79216.20783792203;83135;9861.457619830835;10287.794244115075;11291.967445859824;11390.487428065757;11421.486033128529;16223.26995285215;16269.430569930233;16299.511014669579;16305.918470407572;16310.184490775413;8229.177082291842;8326.375521835887;8388.748337549883;8515.19105684959;8524.190201930807;7961.761147165595;7967.322777563856;8018.438709290293;8155.877661835078;8198.754037378889;5034.496550344937;5042.142835717937;5049.6212784041345;5077.26379674945;5107.540321371094;2029.1376165129761;2042.428120126367;2046.2633451957283;2081.198738485664;2082.7292451981148;972.295086062599;1024.36489376587;1041.5989843909997;1087.7226307291749;1140.7262257058412;20520.179192832118;20681.586368272852;20770.48073798137;20835.79164208369;21095.367138985854;1059.8145324568325;1071.3786004117594;1075.1076606416655;1087.2497976396262;1131.4116659337099;11044.447777611087;11331;11678.6496405108;11836.82244766312;12255.754884902251;589202;602055;603293;613688;632958;56018.439815602134;76218;94657.526712366;96037;96096.51951740196;1105.1821651977639;1119.5521791283552;1136.1478890831877;1144.8111061674897;1148.7300484386162;18238.90880545589;18418.17118229656;18642;19184;19214.903925480285;43303.35044974265;43834.56165438305;44818.55181448144;45373.31940020836;45408.772956135006;61419.38580614315;62380;62579.37420625735;63195;65343.34656653373;7291.270872912666;7561.432892532972;8039.919600804151;8118.472299300763;8282.420230584043;11710.238834475731;12008.63974080779;12537.185082969578;12540.122191446511;12710.618681439571;10500.829484822572;10710.625128120479;10990.340579565252;11066.889331106908;11254.774904502028;10449.68650940473;10591.629292974709;10905.727356816144;11124.777504449703;11178.776424471627;10748.623798167027;11176.329420234812;11182.496787644739;11182.720431989266;11216.775664486502;7677.539347639159;7857.05715314166;7863.135055144044;7931.762047138595;7964.840703185788;9931.255155863195;10727;11067.72330691739;11118.777624447304;11611.6516504505 11:25:31 INFO - PROCESS | 14193 | |3;mootools.html;1480.0083943757681;1552.2394026926806;1608.8069431668198;1796.910154492275;1927.7493925789645;9218.492982885939;9678.661246856362;9746.122848943585;9930.304878658497;9937.801243975116;9736.902630973687;9859.457729824857;9862.063104005108;9866.260030497706;9870.605175792978;2541.974580254197;2544.5419824431597;2546.7835234005133;2565.12785652878;2565.884535195911;2433.3916520869784;2504.6618706474574;2513.0199222303318;2517.559427100259;2520.2943175910773;2476.4675594747127;2480.1815400917744;2511;2512.748725127491;2523.2934778262115;2355.458244603742;2375.406148462884;2383.07060246504;2395.137750409851;2397.640353946922;2377.916772912957;2407.7110746710505;2408.446057406806;2408.6025805742206;2438.317271164077;9489.810203795954;9792.412455252708;9841.90158098417;9856.260780441495;9863.506824658738;5254.737263136828;5382.434844341327;5439.700816455093;5447.809326673587;5459.890802183934;3441.5181874537334;3446.2418267981;3521.9823900880588;3545.840437180307;3548.591911930135;1075.102289588187;1101.438266484091;1115.7935781880378;1145.2956431794469;1150.384544268812;13897.930510347383;14085.366158522891;14133.78799318011;14154.079984801057;14191.57425277233;4832.178529649968;4913.828016019422;4945.802167913315;4980.800767969313;5101;11755.177137600456;11764.411779410995;11784.764304713857;11863.88136118645;11876.643700688994;5570.303712035996;5584.106542953108;5596.608237423341;5600.943990560124;5611.6071874969175;4557.248054071108;4775.856724298276;5126.615503837227;5147.6911385317;5155.9742201288755;4261.552536983572;4277.721948073366;4292.613664770186;4365.869023929287;4456.442944631921;1279.936003199855;1294.695746499572;1311.3181145804128;1337.9331033448289;1343.1068339554088;1017.0744622393586;1024.3393011507685;1031.2471895516314;1037.1288117980932;1066.2482949520725;6162.352952939967;6218.160548326008;6220.34686357935;6315.084312774714;6632.1709786276715;469.9694519856267;483.5599604360016;485.18731125365576;486.63259239274123;489.76980819015006;4337.934930976038;4455.1312494064;4481.462224533077;4586.495485496593;4719.882002949954;12130.211536250115;12315.384230788424;12431.12982091263;12444.81332779991;12455.750884982432;11571.363575003455;12132.818007729891;12142.757144857052;12248.632541023784;12345.814812777815;8763.780905477413;9189.770255743526;9195.218406435528;9203.217726493323;9213.539323033956;6425.485961123192;6441.323661015525;6519.445847103049;6623.768168114286;6759.121314229119;10927.125829933746;11284.32294062359;11290.548378064785;11419.771604568028;11451.59919402817;10465.790684186426;10754.354738715701;11650.126240532163;11670.533178672758;11672.358020308964;8217.342612590859;8393.832123357377;8502.064772874855;8753.343499237455;8879.33404994615;9453.574589143642;9455.19630831387;9490;9490.715278541655;9601.759956001157;8149.307308878811;8580.699675511327;8647.308215342631;8771.868421973802;8859;8455.196756308142;8518.659253629785;8533.74398768038;8649.740507784776;8751.081136480578;7378.262173782793;7638.541687498768;7968.601569921365;8059.637316320663;8074;5553.500184983371;5598.972005139948;5749.453801888814;5762.798302059407;5907.232059832194;5751.051076572486;5761.452661997104;5768.769249229984;5787.421257874179;5822.94177058224 11:25:31 INFO - PROCESS | 14193 | |4;prototype.html;342.5700745564317;351.8276044738079;353.74176850898846;354.9006278242093;361.3008827917981;5427.15476737909;5462.235287059815;5467.933752918178;5479.2602998595175;5539.25220095287;5406.83779486616;5417.510184699209;5456.427075157101;5461.2147804619635;5510.752016159272;3789.9242015159816;4063.4311196432523;4233.322668373061;4240.088380998085;4253.617174454314;4220.978895105535;4230.323148296273;4230.788460576974;4232.3916911573715;4265.864589526695;4041.2321658884866;4201.873943781691;4227.809748561307;4238.724482908617;4244.299690551055;4100.507939047318;4201.369794530814;4218.451601291843;4223.873283801491;4233.343831706091;3759.473673685686;3763.41667041609;3777.867774627875;3780.300644380771;3780.319542482352;5203.401608814959;5266.235811003318;5278.392984806758;5287.365516138088;5292.841214763564;4616.376789133491;4835.5889749371345;4847.466778654345;4848.200046992278;4881.194602890519;5614.971925140389;5623.453550273666;5632.46491583303;5637.492625663669;5657.12314591239;4082.6121518455698;4101.487314085739;4102.138550904314;4119.8352065917325;4121.9381709274385;5566.721663916788;5579.804706835282;5697.6011679182475;5866.600049962485;5889.234399528077;4144.896377590584;4161.396597493407;4167.395727619539;4221.514525829508;4253.2769429197115;4275;4289.463817022872;4293.463317085364;4299.828006879689;4304;4584.4498660160325;4873.634477414137;4878.170710979142;4886.315915771795;4899.779509922062;5655.632383895034;5671.234383358276;5687.51656109227;5716.256886604715;5721.284839395075;1476.970460590782;1488.1071357185601;1488.3971991343524;1491.2618253964356;1494.9551513454614;928.6239073175375;949.2832911152174;950.8716323296405;952.9285303602257;965.4207475514635;4916.237983112624;4931.876703082452;4955.108080545464;4956.603471722254;4987.725675087832;5163.251328557338;5163.793448262028;5164.457731938092;5187.299714538564;5188.481151884781;4628;4913.557779799835;4987.002599480046;4995.351533993846;4997.9750101249265;2743.492453896036;2748.491529067129;2758.4896794093156;2767.3081729567607;2767.533207400081;5274.7626356814035;5312.389075256395;5322.92015619766;5346.679199248058;5348.572114230852;5254.842354729288;5256.739601971112;5557.944420555743;5944.673042982591;6029.155918171459;6055.878882422415;6062.666553339609;6079.604825686316;6086.543509236825;6095.817125486243;5563.499285064364;5884.852453771474;5901.793437229677;5909.52723782105;5918.467337939606;5719.656820590778;5786.685325869686;5844.883102338014;5850.23946886902;5862.677552734641;5832.795852145325;5924.644521328734;5930.733117009659;5939.7921072763975;6097.146399504161;4078.184363127327;4098.73358231714;4214.873553793391;4224.619784219435;4234.851780187679;5701.686407247641;5906.511051600728;5919.200907877554;5929.466348028698;5933.940660593512;5619.297587801525;5660.801871934463;5662.2639056922335;5681.914771278517;5719.714014299185;5630.380658127685;5634.52106570946;5690.203371527907;5705.172749951151;5722.512146841768;5378.811741589026;5563.972180139073;5585.972070139624;5621.80323688669;5630.8029218977135;5670.092785154356;5674.233978412862;5698.54411647059;5699.401562836008;5702.576405027764;5604.495595396434;5609.747561359667;5624.690642014729;5626.634268772516;5653.689047102449 11:25:31 INFO - PROCESS | 14193 | |5;yui.html;843.1357858195345;851.3487182305533;876.7720392697898;879.5250564695065;922.916937475627;15864.127472988981;15961.441349552768;17784.199711013003;17813.198406071726;17827;16297.429589964353;17415.651686966285;17423;17434.82565174348;17482.300707971666;737.7971057959078;862.8188080503102;873.2577309287119;880.7665968518347;903.0247332880506;864.6887120636598;877.7893305606673;877.8112705768259;877.9648814047431;878.0253918150847;909.6816114359954;909.7134402663173;909.9135582119688;911.1844898815556;911.4850109688005;749.6102026945985;879.5558243087264;902.9864552031725;903.3902116071658;904.6969265296134;667.3460009190972;667.8297034256234;668.348360348661;668.4485299627827;668.6489592963684;16730.74903876443;16732.414365497272;16766.161691915357;16810;16826.158692065346;14754.26228688572;14795.33420996047;14842.109473431628;14912.478063267841;15379.846201537954;13713.45146194161;13765.518206862711;13842.86157138436;13909.721805563933;14253.50112746049;4675.88310292242;4843.467218605951;4917.901641967176;4938.950610493885;5048.343715317022;89007;89192;90494;91619;92011.53994230053;11684.649460516199;12042.578509752117;12205.20666156697;12267.325297108566;12429.813552796715;22959.19642812527;23037.539249215257;23050.884745576164;23078.192263270706;23133.88433057824;9037;9046.321525885585;9167.541622918827;9282.211012063915;9394.624215031323;5116;5225.268462415265;5346.893062138735;5395.136778115482;5469.371022332403;3576.266865292661;3691.298653255873;3691.9077023074638;3692.243090166563;3703.3148867459604;687.2131409536054;704.2359040441077;708.3483195460086;717.1322699533623;721.3868212019742;682.5802131688976;689.5724650716487;722.0937723157404;729.7810656803044;757.2427572427572;9251.67619133327;9342.159205671522;9729.221662267002;9931.354461959949;9944.900550994542;725.1298441869777;741.6884908338511;743.9404847612178;747.316205671815;750.5271678842295;4798.424189097261;4812.494688057774;4852.587530059914;4933.584441924458;4983.202687570044;123068.38465807613;126027.73972260344;127274;127452.36273818572;128841;111232.44383778029;112554.43722781497;114457;114564;116451.41774291074;93641.5317923406;94820.52589737007;95577;97692.51153744185;98830.50584747174;9080.500572468578;9096;9193.540322983958;9256.72229833106;9299.72100836976;57123.714381427824;58040.70979645075;58199.4180058194;59100.11349829842;60349.39650603614;82232.58883705543;85744.57127714322;87347.56326218328;88118.55940720512;91253;11867.76264474723;12050.698732531757;12119.636410907688;12184.75630487403;12670.328745003355;13010.414531345923;13075.869241307846;13246.933765331498;13449.193048417126;13728;15068.773968390702;15264.618384540476;15281.6179595511;15369.385224590891;15867.127307998171;14923.701525969203;14969.476068337555;15273.312700928707;15553;16244.187790610658;14965.551033469013;15223.543293701206;15810.446634367741;15976.360945562048;16369.67260654804;12242.204256723284;12252.203606765532;12544.310062946626;12680.6829829255;13323.267220302589;12148.574799881962;12327.876721233031;12548.937255313665;12602.054845886412;12820 11:25:31 INFO - PROCESS | 14193 | __end_tp_report 11:25:31 INFO - PROCESS | 14193 | __start_cc_report 11:25:31 INFO - PROCESS | 14193 | _x_x_mozilla_cycle_collect,1080 11:25:31 INFO - PROCESS | 14193 | __end_cc_report 11:25:31 INFO - PROCESS | 14193 | __startTimestamp1470248731157__endTimestamp 11:25:31 INFO - PROCESS | 14193 | 11:25:31 INFO - PROCESS | 14193 | ------- Summary: start ------- 11:25:31 INFO - PROCESS | 14193 | Number of tests: 6 11:25:31 INFO - PROCESS | 14193 | 11:25:31 INFO - PROCESS | 14193 | [#0] dojo.html Cycles:165 Average:5545.96 Median:5768.25 stddev:630.87 (10.9%) stddev-sans-first:604.29 11:25:31 INFO - PROCESS | 14193 | Values: 3155.4 3190.2 3197.5 3217.1 3249.4 5477.9 5541.7 5568.0 5591.3 5596.5 5553.8 5610.7 5616.2 5622.4 5648.1 4940.9 4953.4 5037.1 5062.5 5126.4 5002.7 5005.5 5032.6 5064.1 5137.4 5054.9 5055.6 5058.2 5079.1 5168.9 5117.1 5128.2 5131.0 5148.8 5174.8 4862.2 4953.9 5007.4 5052.9 5069.7 5551.1 5599.6 5615.4 5617.5 5628.0 6018.5 6025.2 6057.8 6058.4 6061.1 5784.0 5912.6 5929.4 5932.6 6042.2 5575.5 5642.0 5645.6 5648.5 5649.6 6086.4 6097.2 6132.7 6133.2 6135.1 5606.7 5773.6 5806.4 5832.6 5932.3 5996.8 6026.3 6047.0 6054.8 6063.0 5913.6 5918.9 5975.9 5978.1 5980.8 5735.2 5768.3 5897.6 5969.0 5977.1 4618.5 4619.8 4622.7 4641.3 4650.4 4105.2 4110.6 4115.2 4121.0 4121.4 5500.4 5600.4 5742.7 5743.2 5753.2 5926.3 5996.5 6001.0 6006.7 6022.4 5606.3 5613.6 5631.0 5684.0 5686.7 5001.3 5086.6 5101.1 5102.5 5103.5 6132.5 6185.3 6189.5 6192.9 6232.8 5888.5 5952.4 5959.6 5988.5 6005.7 6006.7 6096.9 6102.5 6162.8 6180.6 5821.4 5893.4 5897.3 5940.5 5948.6 5937.4 5974.5 5989.8 5995.0 5997.7 5597.2 5840.8 5859.7 5861.7 5869.4 5866.8 5902.8 5918.9 5926.6 5952.2 5832.1 5832.9 5847.3 5851.3 5859.1 5648.2 5790.3 5878.0 5904.3 5950.5 5670.6 5721.8 5738.1 5778.9 5782.4 11:25:31 INFO - PROCESS | 14193 | 11:25:31 INFO - PROCESS | 14193 | [#1] ext.html Cycles:180 Average:68141.32 Median:22344.93 stddev:138941.34 (621.8%) stddev-sans-first:139238.60 11:25:31 INFO - PROCESS | 14193 | Values: 610.8 656.6 662.1 664.3 674.3 34361.3 46227.0 47735.0 47791.0 47926.8 47655.8 47818.8 47913.0 48355.8 48560.8 9145.5 9412.9 9419.4 9424.7 9426.7 8406.2 10778.9 11055.7 11063.6 11431.9 11360.9 11440.7 11448.1 11475.3 11495.4 11046.6 11117.3 11132.7 11134.0 11137.2 10917.8 10948.1 10976.5 10994.6 11001.3 45478.0 45697.1 45763.5 45816.0 45846.3 3930.2 3931.4 3965.0 3998.9 4096.3 34385.7 34631.5 35136.5 35539.6 35552.1 4679.0 4680.5 4767.3 4812.6 4832.7 373987.0 374601.0 374979.0 375388.0 376375.0 61995.0 62315.0 62347.4 62405.0 62528.4 41239.0 42262.6 42511.4 42582.4 66379.3 19365.9 19468.2 19490.2 19495.9 19511.7 12990.7 13042.7 14761.8 14882.9 14903.6 19786.9 20731.9 20732.8 20899.3 20947.7 7590.3 7606.5 7726.8 7858.8 7969.2 1082.7 1128.9 1142.2 1168.9 1189.0 34106.8 34553.7 34584.1 35205.8 35366.5 1196.6 1206.4 1220.3 1227.9 1288.5 18325.6 18352.8 18353.2 18564.4 18584.5 604592.0 606357.0 607407.0 611189.0 612850.0 64734.0 64988.0 65016.0 65327.7 65529.0 1347.8 1452.6 1472.7 1518.6 1524.5 33628.8 36116.6 36425.0 36647.1 36770.0 53652.5 54019.0 55651.2 55711.7 60613.4 550510.0 556297.0 556945.0 557793.0 557880.0 29820.4 30217.7 31155.8 32729.8 33229.8 52289.0 52644.2 52769.0 52845.0 52888.7 42440.8 43487.6 44625.8 44789.3 45792.0 44388.8 44846.3 45729.1 45770.0 46570.5 45389.3 45490.0 46460.0 46665.0 48542.0 39228.4 40593.6 41286.4 41378.6 41427.8 30641.2 30697.4 30903.2 30905.5 30979.0 11:25:31 INFO - PROCESS | 14193 | 11:25:31 INFO - PROCESS | 14193 | [#2] jquery.html Cycles:180 Average:32102.28 Median:23837.29 stddev:99669.62 (418.1%) stddev-sans-first:99920.77 11:25:31 INFO - PROCESS | 14193 | Values: 387.4 396.6 410.6 411.2 427.1 14125.9 19931.0 20139.3 20209.3 20681.9 20204.0 20268.0 20318.3 20354.7 20529.4 5680.2 5807.2 5881.9 5936.5 5950.5 5957.6 5986.1 5992.8 6011.4 6024.3 5973.4 6034.1 6036.7 6050.0 6067.7 6103.5 6173.6 6220.6 6222.9 6225.5 5913.5 6026.5 6031.9 6049.9 6058.8 14424.1 14741.0 18356.7 23554.2 24120.4 2545.8 2552.9 2681.0 2721.9 2950.6 10443.4 10617.4 10740.8 10830.7 10888.6 2015.9 2033.5 2069.9 2138.2 2169.8 65114.7 68384.3 78405.6 79216.2 83135.0 9861.5 10287.8 11292.0 11390.5 11421.5 16223.3 16269.4 16299.5 16305.9 16310.2 8229.2 8326.4 8388.7 8515.2 8524.2 7961.8 7967.3 8018.4 8155.9 8198.8 5034.5 5042.1 5049.6 5077.3 5107.5 2029.1 2042.4 2046.3 2081.2 2082.7 972.3 1024.4 1041.6 1087.7 1140.7 20520.2 20681.6 20770.5 20835.8 21095.4 1059.8 1071.4 1075.1 1087.2 1131.4 11044.4 11331.0 11678.6 11836.8 12255.8 589202.0 602055.0 603293.0 613688.0 632958.0 56018.4 76218.0 94657.5 96037.0 96096.5 1105.2 1119.6 1136.1 1144.8 1148.7 18238.9 18418.2 18642.0 19184.0 19214.9 43303.4 43834.6 44818.6 45373.3 45408.8 61419.4 62380.0 62579.4 63195.0 65343.3 7291.3 7561.4 8039.9 8118.5 8282.4 11710.2 12008.6 12537.2 12540.1 12710.6 10500.8 10710.6 10990.3 11066.9 11254.8 10449.7 10591.6 10905.7 11124.8 11178.8 10748.6 11176.3 11182.5 11182.7 11216.8 7677.5 7857.1 7863.1 7931.8 7964.8 9931.3 10727.0 11067.7 11118.8 11611.7 11:25:31 INFO - PROCESS | 14193 | 11:25:31 INFO - PROCESS | 14193 | [#3] mootools.html Cycles:180 Average:6386.24 Median:2594.93 stddev:3781.31 (145.7%) stddev-sans-first:3773.94 11:25:31 INFO - PROCESS | 14193 | Values: 1480.0 1552.2 1608.8 1796.9 1927.7 9218.5 9678.7 9746.1 9930.3 9937.8 9736.9 9859.5 9862.1 9866.3 9870.6 2542.0 2544.5 2546.8 2565.1 2565.9 2433.4 2504.7 2513.0 2517.6 2520.3 2476.5 2480.2 2511.0 2512.7 2523.3 2355.5 2375.4 2383.1 2395.1 2397.6 2377.9 2407.7 2408.4 2408.6 2438.3 9489.8 9792.4 9841.9 9856.3 9863.5 5254.7 5382.4 5439.7 5447.8 5459.9 3441.5 3446.2 3522.0 3545.8 3548.6 1075.1 1101.4 1115.8 1145.3 1150.4 13897.9 14085.4 14133.8 14154.1 14191.6 4832.2 4913.8 4945.8 4980.8 5101.0 11755.2 11764.4 11784.8 11863.9 11876.6 5570.3 5584.1 5596.6 5600.9 5611.6 4557.2 4775.9 5126.6 5147.7 5156.0 4261.6 4277.7 4292.6 4365.9 4456.4 1279.9 1294.7 1311.3 1337.9 1343.1 1017.1 1024.3 1031.2 1037.1 1066.2 6162.4 6218.2 6220.3 6315.1 6632.2 470.0 483.6 485.2 486.6 489.8 4337.9 4455.1 4481.5 4586.5 4719.9 12130.2 12315.4 12431.1 12444.8 12455.8 11571.4 12132.8 12142.8 12248.6 12345.8 8763.8 9189.8 9195.2 9203.2 9213.5 6425.5 6441.3 6519.4 6623.8 6759.1 10927.1 11284.3 11290.5 11419.8 11451.6 10465.8 10754.4 11650.1 11670.5 11672.4 8217.3 8393.8 8502.1 8753.3 8879.3 9453.6 9455.2 9490.0 9490.7 9601.8 8149.3 8580.7 8647.3 8771.9 8859.0 8455.2 8518.7 8533.7 8649.7 8751.1 7378.3 7638.5 7968.6 8059.6 8074.0 5553.5 5599.0 5749.5 5762.8 5907.2 5751.1 5761.5 5768.8 5787.4 5822.9 11:25:31 INFO - PROCESS | 14193 | 11:25:31 INFO - PROCESS | 14193 | [#4] prototype.html Cycles:180 Average:4705.56 Median:5282.88 stddev:1378.99 (26.1%) stddev-sans-first:1343.41 11:25:31 INFO - PROCESS | 14193 | Values: 342.6 351.8 353.7 354.9 361.3 5427.2 5462.2 5467.9 5479.3 5539.3 5406.8 5417.5 5456.4 5461.2 5510.8 3789.9 4063.4 4233.3 4240.1 4253.6 4221.0 4230.3 4230.8 4232.4 4265.9 4041.2 4201.9 4227.8 4238.7 4244.3 4100.5 4201.4 4218.5 4223.9 4233.3 3759.5 3763.4 3777.9 3780.3 3780.3 5203.4 5266.2 5278.4 5287.4 5292.8 4616.4 4835.6 4847.5 4848.2 4881.2 5615.0 5623.5 5632.5 5637.5 5657.1 4082.6 4101.5 4102.1 4119.8 4121.9 5566.7 5579.8 5697.6 5866.6 5889.2 4144.9 4161.4 4167.4 4221.5 4253.3 4275.0 4289.5 4293.5 4299.8 4304.0 4584.4 4873.6 4878.2 4886.3 4899.8 5655.6 5671.2 5687.5 5716.3 5721.3 1477.0 1488.1 1488.4 1491.3 1495.0 928.6 949.3 950.9 952.9 965.4 4916.2 4931.9 4955.1 4956.6 4987.7 5163.3 5163.8 5164.5 5187.3 5188.5 4628.0 4913.6 4987.0 4995.4 4998.0 2743.5 2748.5 2758.5 2767.3 2767.5 5274.8 5312.4 5322.9 5346.7 5348.6 5254.8 5256.7 5557.9 5944.7 6029.2 6055.9 6062.7 6079.6 6086.5 6095.8 5563.5 5884.9 5901.8 5909.5 5918.5 5719.7 5786.7 5844.9 5850.2 5862.7 5832.8 5924.6 5930.7 5939.8 6097.1 4078.2 4098.7 4214.9 4224.6 4234.9 5701.7 5906.5 5919.2 5929.5 5933.9 5619.3 5660.8 5662.3 5681.9 5719.7 5630.4 5634.5 5690.2 5705.2 5722.5 5378.8 5564.0 5586.0 5621.8 5630.8 5670.1 5674.2 5698.5 5699.4 5702.6 5604.5 5609.7 5624.7 5626.6 5653.7 11:25:31 INFO - PROCESS | 14193 | 11:25:31 INFO - PROCESS | 14193 | [#5] yui.html Cycles:180 Average:23291.30 Median:4925.74 stddev:34070.18 (691.7%) stddev-sans-first:34124.07 11:25:31 INFO - PROCESS | 14193 | Values: 843.1 851.3 876.8 879.5 922.9 15864.1 15961.4 17784.2 17813.2 17827.0 16297.4 17415.7 17423.0 17434.8 17482.3 737.8 862.8 873.3 880.8 903.0 864.7 877.8 877.8 878.0 878.0 909.7 909.7 909.9 911.2 911.5 749.6 879.6 903.0 903.4 904.7 667.3 667.8 668.3 668.4 668.6 16730.7 16732.4 16766.2 16810.0 16826.2 14754.3 14795.3 14842.1 14912.5 15379.8 13713.5 13765.5 13842.9 13909.7 14253.5 4675.9 4843.5 4917.9 4939.0 5048.3 89007.0 89192.0 90494.0 91619.0 92011.5 11684.6 12042.6 12205.2 12267.3 12429.8 22959.2 23037.5 23050.9 23078.2 23133.9 9037.0 9046.3 9167.5 9282.2 9394.6 5116.0 5225.3 5346.9 5395.1 5469.4 3576.3 3691.3 3691.9 3692.2 3703.3 687.2 704.2 708.3 717.1 721.4 682.6 689.6 722.1 729.8 757.2 9251.7 9342.2 9729.2 9931.4 9944.9 725.1 741.7 743.9 747.3 750.5 4798.4 4812.5 4852.6 4933.6 4983.2 123068.4 126027.7 127274.0 127452.4 128841.0 111232.4 112554.4 114457.0 114564.0 116451.4 93641.5 94820.5 95577.0 97692.5 98830.5 9080.5 9096.0 9193.5 9256.7 9299.7 57123.7 58040.7 58199.4 59100.1 60349.4 82232.6 85744.6 87347.6 88118.6 91253.0 11867.8 12050.7 12119.6 12184.8 12670.3 13010.4 13075.9 13246.9 13449.2 13728.0 15068.8 15264.6 15281.6 15369.4 15867.1 14923.7 14969.5 15273.3 15553.0 16244.2 14965.6 15223.5 15810.4 15976.4 16369.7 12242.2 12252.2 12544.3 12680.7 13323.3 12148.6 12327.9 12548.9 12602.1 12820.0 11:25:31 INFO - PROCESS | 14193 | -------- Summary: end -------- 11:25:31 INFO - PROCESS | 14193 | 11:25:31 INFO - TEST-INFO | 14193: exit 0 11:25:31 INFO - TEST-OK | dromaeo_css | took 1113341ms 11:25:31 INFO - TEST-START | kraken 11:25:31 INFO - operating with platform_type : linux_ 11:25:31 INFO - Initialising browser for kraken test... 11:25:31 INFO - TEST-INFO | started process 14399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpllfTSn/profile http://localhost:39359/getInfo.html) 11:25:35 INFO - PROCESS | 14399 | __metrics Screen width/height:1600/1200 11:25:35 INFO - PROCESS | 14399 | colorDepth:24 11:25:35 INFO - PROCESS | 14399 | Browser inner width/height: 1024/697 11:25:35 INFO - PROCESS | 14399 | __metrics 11:25:36 INFO - PROCESS | 14399 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:36 INFO - PROCESS | 14399 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:37 INFO - TEST-INFO | 14399: exit 0 11:25:37 INFO - Browser initialized. 11:25:37 INFO - Running cycle 1/1 for kraken test... 11:25:37 INFO - TEST-INFO | started process 14490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpllfTSn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:49 INFO - PROCESS | 14490 | RSS: Main: 145432576 11:25:49 INFO - PROCESS | 14490 | 11:25:51 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39359/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:52 INFO - PROCESS | 14490 | RSS: Main: 191881216 11:25:52 INFO - PROCESS | 14490 | 11:25:55 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39359/tests/kraken/driver.html?testName=audio-dft) 11:25:55 INFO - PROCESS | 14490 | RSS: Main: 181264384 11:25:55 INFO - PROCESS | 14490 | 11:25:58 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39359/tests/kraken/driver.html?testName=audio-fft) 11:25:59 INFO - PROCESS | 14490 | RSS: Main: 270462976 11:25:59 INFO - PROCESS | 14490 | 11:26:01 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39359/tests/kraken/driver.html?testName=audio-oscillator) 11:26:01 INFO - PROCESS | 14490 | RSS: Main: 176091136 11:26:01 INFO - PROCESS | 14490 | 11:26:03 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:04 INFO - PROCESS | 14490 | RSS: Main: 178139136 11:26:04 INFO - PROCESS | 14490 | 11:26:07 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39359/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:08 INFO - PROCESS | 14490 | RSS: Main: 213659648 11:26:08 INFO - PROCESS | 14490 | 11:26:11 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39359/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:12 INFO - PROCESS | 14490 | RSS: Main: 212148224 11:26:12 INFO - PROCESS | 14490 | 11:26:14 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39359/tests/kraken/driver.html?testName=json-parse-financial) 11:26:15 INFO - PROCESS | 14490 | RSS: Main: 211595264 11:26:15 INFO - PROCESS | 14490 | 11:26:16 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:17 INFO - PROCESS | 14490 | RSS: Main: 176377856 11:26:17 INFO - PROCESS | 14490 | 11:26:19 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39359/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:19 INFO - PROCESS | 14490 | RSS: Main: 180666368 11:26:19 INFO - PROCESS | 14490 | 11:26:21 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:22 INFO - PROCESS | 14490 | RSS: Main: 186703872 11:26:22 INFO - PROCESS | 14490 | 11:26:25 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:25 INFO - PROCESS | 14490 | RSS: Main: 187023360 11:26:25 INFO - PROCESS | 14490 | 11:26:28 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:28 INFO - PROCESS | 14490 | RSS: Main: 184864768 11:26:28 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | Cycle 1(1): loaded http://localhost:39359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39359/tests/kraken/driver.html?testName=ai-astar) 11:26:30 INFO - PROCESS | 14490 | RSS: Main: 236756992 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | __start_tp_report 11:26:30 INFO - PROCESS | 14490 | _x_x_mozilla_page_load 11:26:30 INFO - PROCESS | 14490 | _x_x_mozilla_page_load_details 11:26:30 INFO - PROCESS | 14490 | |i|pagename|runs| 11:26:30 INFO - PROCESS | 14490 | |0;ai-astar;101;110;112;109;113;111;108;109;108;109 11:26:30 INFO - PROCESS | 14490 | |1;audio-beat-detection;143;115;115;178;117;120;144;117;150;116 11:26:30 INFO - PROCESS | 14490 | |2;audio-dft;163;161;161;161;166;161;161;162;163;161 11:26:30 INFO - PROCESS | 14490 | |3;audio-fft;75;77;75;119;76;76;74;76;108;76 11:26:30 INFO - PROCESS | 14490 | |4;audio-oscillator;83;84;129;85;84;83;111;83;83;128 11:26:30 INFO - PROCESS | 14490 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;117;116 11:26:30 INFO - PROCESS | 14490 | |6;imaging-darkroom;146;146;146;147;148;146;146;149;147;146 11:26:30 INFO - PROCESS | 14490 | |7;imaging-desaturate;96;95;95;96;95;96;95;95;94;95 11:26:30 INFO - PROCESS | 14490 | |8;json-parse-financial;50;51;52;51;51;60;51;50;50;51 11:26:30 INFO - PROCESS | 14490 | |9;json-stringify-tinderbox;62;61;61;61;61;60;61;60;61;61 11:26:30 INFO - PROCESS | 14490 | |10;stanford-crypto-aes;73;73;74;73;81;72;73;72;72;72 11:26:30 INFO - PROCESS | 14490 | |11;stanford-crypto-ccm;124;117;117;119;115;131;123;117;160;127 11:26:30 INFO - PROCESS | 14490 | |12;stanford-crypto-pbkdf2;158;157;152;155;159;153;153;158;151;151 11:26:30 INFO - PROCESS | 14490 | |13;stanford-crypto-sha256-iterative;63;70;62;63;62;67;62;63;64;61 11:26:30 INFO - PROCESS | 14490 | __end_tp_report 11:26:30 INFO - PROCESS | 14490 | __start_cc_report 11:26:30 INFO - PROCESS | 14490 | _x_x_mozilla_cycle_collect,1657 11:26:30 INFO - PROCESS | 14490 | __end_cc_report 11:26:30 INFO - PROCESS | 14490 | __startTimestamp1470248790754__endTimestamp 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | ------- Summary: start ------- 11:26:30 INFO - PROCESS | 14490 | Number of tests: 14 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:3.27 (3.0%) stddev-sans-first:1.76 11:26:30 INFO - PROCESS | 14490 | Values: 101.0 110.0 112.0 109.0 113.0 111.0 108.0 109.0 108.0 109.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:131.50 stddev:21.42 (16.3%) stddev-sans-first:22.31 11:26:30 INFO - PROCESS | 14490 | Values: 143.0 115.0 115.0 178.0 117.0 120.0 144.0 117.0 150.0 116.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:1.63 (1.0%) stddev-sans-first:1.69 11:26:30 INFO - PROCESS | 14490 | Values: 163.0 161.0 161.0 161.0 166.0 161.0 161.0 162.0 163.0 161.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:16.20 (21.3%) stddev-sans-first:16.91 11:26:30 INFO - PROCESS | 14490 | Values: 75.0 77.0 75.0 119.0 76.0 76.0 74.0 76.0 108.0 76.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:83.00 stddev:19.49 (23.5%) stddev-sans-first:20.16 11:26:30 INFO - PROCESS | 14490 | Values: 83.0 84.0 129.0 85.0 84.0 83.0 111.0 83.0 83.0 128.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:26:30 INFO - PROCESS | 14490 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 11:26:30 INFO - PROCESS | 14490 | Values: 146.0 146.0 146.0 147.0 148.0 146.0 146.0 149.0 147.0 146.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 11:26:30 INFO - PROCESS | 14490 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 94.0 95.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:51.00 stddev:2.98 (5.8%) stddev-sans-first:3.10 11:26:30 INFO - PROCESS | 14490 | Values: 50.0 51.0 52.0 51.0 51.0 60.0 51.0 50.0 50.0 51.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 11:26:30 INFO - PROCESS | 14490 | Values: 62.0 61.0 61.0 61.0 61.0 60.0 61.0 60.0 61.0 61.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:73.00 stddev:2.72 (3.7%) stddev-sans-first:2.88 11:26:30 INFO - PROCESS | 14490 | Values: 73.0 73.0 74.0 73.0 81.0 72.0 73.0 72.0 72.0 72.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:123.50 stddev:13.32 (10.8%) stddev-sans-first:14.13 11:26:30 INFO - PROCESS | 14490 | Values: 124.0 117.0 117.0 119.0 115.0 131.0 123.0 117.0 160.0 127.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:156.00 stddev:3.09 (2.0%) stddev-sans-first:3.04 11:26:30 INFO - PROCESS | 14490 | Values: 158.0 157.0 152.0 155.0 159.0 153.0 153.0 158.0 151.0 151.0 11:26:30 INFO - PROCESS | 14490 | 11:26:30 INFO - PROCESS | 14490 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.00 stddev:2.75 (4.4%) stddev-sans-first:2.91 11:26:30 INFO - PROCESS | 14490 | Values: 63.0 70.0 62.0 63.0 62.0 67.0 62.0 63.0 64.0 61.0 11:26:30 INFO - PROCESS | 14490 | -------- Summary: end -------- 11:26:30 INFO - PROCESS | 14490 | 11:26:31 INFO - TEST-INFO | 14490: exit 0 11:26:31 INFO - TEST-OK | kraken | took 59903ms 11:26:31 INFO - SUITE-END | took 1173s 11:26:31 INFO - Completed test suite (00:19:33) 11:26:31 INFO - javascript benchmark 11:26:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.4162479941215, 3190.154609028608, 3197.4884018557027, 3217.099212220579, 3249.366373557157, 5477.917831232535, 5541.669999200199, 5567.972160139194, 5591.30108736408, 5596.524295434893, 5553.7778488860495, 5610.747516361764, 5616.241807356006, 5622.353429355625, 5648.068068768648, 4940.8517744467545, 4953.4303555091265, 5037.068142393659, 5062.493750624926, 5126.41046279677, 5002.749862506878, 5005.474425185358, 5032.6477146599755, 5064.063148317555, 5137.383513978328, 5054.9241761373605, 5055.595552355821, 5058.165402708549, 5079.060373830835, 5168.870778230536, 5117.104506711311, 5128.205128205134, 5130.97434512825, 5148.794048238066, 5174.844754657366, 4862.222044472867, 4953.90092198154, 5007.37407824022, 5052.898942021176, 5069.670471419383, 5551.1118221084835, 5599.608027438081, 5615.382307946123, 5617.494425501724, 5628.04323265046, 6018.548608854309, 6025.216721826178, 6057.818265452043, 6058.363871793443, 6061.090836374535, 5783.9710801446145, 5912.586118971631, 5929.436703513159, 5932.555058370639, 6042.244719410074, 5575.498205161555, 5641.971790141023, 5645.633033852869, 5648.548116150698, 5649.576281778842, 6086.393303771593, 6097.17688112108, 6132.662703551258, 6133.202683651186, 6135.0797380392405, 5606.6916319602, 5773.624714393551, 5806.361300256968, 5832.62087964281, 5932.3177834548715, 5996.820095397145, 6026.306974697878, 6047.0, 6054.788082417094, 6063.029915213545, 5913.586048976616, 5918.940810591925, 5975.910361344583, 5978.133170690226, 5980.820575382745, 5735.225744524436, 5768.250127483484, 5897.587168898136, 5969.015112506388, 5977.133315669291, 4618.49196588375, 4619.769011549409, 4622.67641265115, 4641.280601506772, 4650.37219975299, 4105.158442519277, 4110.609492098246, 4115.156392939441, 4120.958790412117, 4121.443605113332, 5500.3949565547755, 5600.355959064678, 5742.7415766290615, 5743.2246646703, 5753.194552762617, 5926.2888453385, 5996.5202783777195, 6001.039833626599, 6006.729697163638, 6022.36765139654, 5606.271184745957, 5613.635113717595, 5631.042722737145, 5683.9715801420725, 5686.658800471985, 5001.324821149171, 5086.618503612244, 5101.056304583664, 5102.4897510248675, 5103.464136265638, 6132.508481341068, 6185.288691800411, 6189.473894718999, 6192.907106393408, 6232.75068997235, 5888.499477544286, 5952.375000625046, 5959.642421454727, 5988.520918326436, 6005.699715014144, 6006.699665016819, 6096.9390306096375, 6102.4812890902995, 6162.784302549389, 6180.598261113013, 5821.388754180919, 5893.351731309638, 5897.292324921037, 5940.46535811779, 5948.583599148018, 5937.406259374028, 5974.462298393166, 5989.760409583742, 5994.970025149846, 5997.70011499432, 5597.160425935979, 5840.831833633205, 5859.707014649336, 5861.736221869941, 5869.35437101927, 5866.765329386777, 5902.822915312548, 5918.852028699317, 5926.555508336805, 5952.166696662557, 5832.096025116114, 5832.912506312324, 5847.327557330791, 5851.297844258716, 5859.091840764689, 5648.181013753065, 5790.305163380422, 5878.0, 5904.261967254093, 5950.464458198783, 5670.631408958405, 5721.828345149652, 5738.081906894877, 5778.855528611818, 5782.421757824184], "value": 5503.183542374042, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.7862248213125, 656.6224420957948, 662.0830150241915, 664.3423011218891, 674.2818897873761, 34361.31277374451, 46227.0, 47735.0, 47791.0, 47926.76036619812, 47655.761721191346, 47818.76090619551, 47913.0, 48355.758221208845, 48560.75719621406, 9145.496997665143, 9412.858807117864, 9419.434833909952, 9424.717258482222, 9426.717198484057, 8406.159384061606, 10778.946105269462, 11055.668329950115, 11063.557457701681, 11431.885681143165, 11360.943195284053, 11440.713982150472, 11448.141389395829, 11475.254108482965, 11495.367754773484, 11046.613368532104, 11117.277376970553, 11132.721681957975, 11134.0, 11137.220394572383, 10917.799042105362, 10948.069414099811, 10976.451177441097, 10994.560217591286, 11001.339919604849, 45478.0, 45697.08605827898, 45763.542364576264, 45816.0, 45846.31230531545, 3930.233604447134, 3931.410288456726, 3965.0087478130467, 3998.8800335989968, 4096.262672718909, 34385.65614343849, 34631.48052779185, 35136.47295290573, 35539.64460355415, 35552.111197220016, 4679.0, 4680.461746899116, 4767.308740232682, 4812.566868981773, 4832.661713680044, 373987.0, 374601.0, 374979.0, 375388.0, 376375.0, 61995.0, 62315.0, 62347.376526234155, 62405.0, 62528.374716252256, 41239.0, 42262.57737422586, 42511.36232956508, 42582.36126458106, 66379.33620663731, 19365.903170484056, 19468.22127114928, 19490.220391184477, 19495.902520487307, 19511.707324390147, 12990.740185196431, 13042.673933151558, 14761.77857332141, 14882.92558537222, 14903.552893413214, 19786.90106549487, 20731.8963405182, 20732.792672073087, 20899.268525601532, 20947.68578471324, 7590.316871481593, 7606.543607383574, 7726.806829829299, 7858.803529911684, 7969.246765711534, 1082.718493191776, 1128.9209755317213, 1142.223124817351, 1168.9415529223504, 1189.0071790055401, 34106.82946585301, 34553.654463455045, 34584.13539661529, 35205.82397087998, 35366.46950295748, 1196.6350263169816, 1206.3666575047994, 1220.3349174699633, 1227.8526576810661, 1288.4974859804684, 18325.63348733018, 18352.81647183511, 18353.17410716521, 18564.350247741266, 18584.535386615444, 604592.0, 606357.0, 607407.0, 611189.0, 612850.0, 64734.0, 64988.0, 65016.0, 65327.673361632886, 65529.0, 1347.7910923806826, 1452.6077958951234, 1472.6612879037666, 1518.582389842802, 1524.481676230087, 33628.831855840566, 36116.63883361238, 36425.0, 36647.08382290464, 36770.0, 53652.463475366305, 54019.0, 55651.16523252073, 55711.72144139253, 60613.393866062535, 550510.0, 556297.0, 556945.0, 557793.0, 557880.0, 29820.403591927607, 30217.697823021488, 31155.844220778752, 32729.836350818092, 33229.83385083156, 52289.0, 52644.21033684575, 52769.0, 52845.0, 52888.735556321975, 42440.787796060824, 43487.56512434835, 44625.776871115435, 44789.32816007828, 45792.0, 44388.7780561108, 44846.3273050898, 45729.085418290786, 45770.0, 46570.534294656616, 45389.31916021329, 45490.0, 46460.0, 46665.0, 48542.0, 39228.41157382698, 40593.59406405898, 41286.38070428886, 41378.586214137475, 41427.79286103671, 30641.233969150948, 30697.386052279275, 30903.2274193147, 30905.53641695421, 30979.0], "value": 22257.764719941213, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.38599320077674, 396.55387688850027, 410.5935124227015, 411.19816358101707, 427.13718289056106, 14125.858741412583, 19931.0, 20139.29512467064, 20209.29267475637, 20681.896590517063, 20204.0, 20268.0, 20318.288859889908, 20354.69467957978, 20529.384118476468, 5680.233168522259, 5807.186993820868, 5881.941180588204, 5936.465718085371, 5950.494207992304, 5957.582969192158, 5986.07215881539, 5992.7902523411685, 6011.428914253139, 6024.307204671453, 5973.432523910222, 6034.06471996839, 6036.728347224385, 6050.0, 6067.696615169246, 6103.481204097657, 6173.629582225059, 6220.595661282002, 6222.875542489125, 6225.47083497901, 5913.497352725023, 6026.457618814327, 6031.909521357183, 6049.939500604982, 6058.757649694007, 14424.134551926812, 14741.0, 18356.724649130272, 23554.175603853782, 24120.396990075213, 2545.7963362930923, 2552.885120169597, 2680.973190268092, 2721.8911243550233, 2950.616419865425, 10443.373397596168, 10617.362958222531, 10740.785184296348, 10830.72923176919, 10888.564457421693, 2015.9193632254692, 2033.4814622271374, 2069.9172033118807, 2138.2302371146375, 2169.8264138869013, 65114.67442662804, 68384.3161568383, 78405.60797195978, 79216.20783792203, 83135.0, 9861.457619830835, 10287.794244115075, 11291.967445859824, 11390.487428065757, 11421.486033128529, 16223.26995285215, 16269.430569930233, 16299.511014669579, 16305.918470407572, 16310.184490775413, 8229.177082291842, 8326.375521835887, 8388.748337549883, 8515.19105684959, 8524.190201930807, 7961.761147165595, 7967.322777563856, 8018.438709290293, 8155.877661835078, 8198.754037378889, 5034.496550344937, 5042.142835717937, 5049.6212784041345, 5077.26379674945, 5107.540321371094, 2029.1376165129761, 2042.428120126367, 2046.2633451957283, 2081.198738485664, 2082.7292451981148, 972.295086062599, 1024.36489376587, 1041.5989843909997, 1087.7226307291749, 1140.7262257058412, 20520.179192832118, 20681.586368272852, 20770.48073798137, 20835.79164208369, 21095.367138985854, 1059.8145324568325, 1071.3786004117594, 1075.1076606416655, 1087.2497976396262, 1131.4116659337099, 11044.447777611087, 11331.0, 11678.6496405108, 11836.82244766312, 12255.754884902251, 589202.0, 602055.0, 603293.0, 613688.0, 632958.0, 56018.439815602134, 76218.0, 94657.526712366, 96037.0, 96096.51951740196, 1105.1821651977639, 1119.5521791283552, 1136.1478890831877, 1144.8111061674897, 1148.7300484386162, 18238.90880545589, 18418.17118229656, 18642.0, 19184.0, 19214.903925480285, 43303.35044974265, 43834.56165438305, 44818.55181448144, 45373.31940020836, 45408.772956135006, 61419.38580614315, 62380.0, 62579.37420625735, 63195.0, 65343.34656653373, 7291.270872912666, 7561.432892532972, 8039.919600804151, 8118.472299300763, 8282.420230584043, 11710.238834475731, 12008.63974080779, 12537.185082969578, 12540.122191446511, 12710.618681439571, 10500.829484822572, 10710.625128120479, 10990.340579565252, 11066.889331106908, 11254.774904502028, 10449.68650940473, 10591.629292974709, 10905.727356816144, 11124.777504449703, 11178.776424471627, 10748.623798167027, 11176.329420234812, 11182.496787644739, 11182.720431989266, 11216.775664486502, 7677.539347639159, 7857.05715314166, 7863.135055144044, 7931.762047138595, 7964.840703185788, 9931.255155863195, 10727.0, 11067.72330691739, 11118.777624447304, 11611.6516504505], "value": 9429.591743645638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.0083943757681, 1552.2394026926806, 1608.8069431668198, 1796.910154492275, 1927.7493925789645, 9218.492982885939, 9678.661246856362, 9746.122848943585, 9930.304878658497, 9937.801243975116, 9736.902630973687, 9859.457729824857, 9862.063104005108, 9866.260030497706, 9870.605175792978, 2541.974580254197, 2544.5419824431597, 2546.7835234005133, 2565.12785652878, 2565.884535195911, 2433.3916520869784, 2504.6618706474574, 2513.0199222303318, 2517.559427100259, 2520.2943175910773, 2476.4675594747127, 2480.1815400917744, 2511.0, 2512.748725127491, 2523.2934778262115, 2355.458244603742, 2375.406148462884, 2383.07060246504, 2395.137750409851, 2397.640353946922, 2377.916772912957, 2407.7110746710505, 2408.446057406806, 2408.6025805742206, 2438.317271164077, 9489.810203795954, 9792.412455252708, 9841.90158098417, 9856.260780441495, 9863.506824658738, 5254.737263136828, 5382.434844341327, 5439.700816455093, 5447.809326673587, 5459.890802183934, 3441.5181874537334, 3446.2418267981, 3521.9823900880588, 3545.840437180307, 3548.591911930135, 1075.102289588187, 1101.438266484091, 1115.7935781880378, 1145.2956431794469, 1150.384544268812, 13897.930510347383, 14085.366158522891, 14133.78799318011, 14154.079984801057, 14191.57425277233, 4832.178529649968, 4913.828016019422, 4945.802167913315, 4980.800767969313, 5101.0, 11755.177137600456, 11764.411779410995, 11784.764304713857, 11863.88136118645, 11876.643700688994, 5570.303712035996, 5584.106542953108, 5596.608237423341, 5600.943990560124, 5611.6071874969175, 4557.248054071108, 4775.856724298276, 5126.615503837227, 5147.6911385317, 5155.9742201288755, 4261.552536983572, 4277.721948073366, 4292.613664770186, 4365.869023929287, 4456.442944631921, 1279.936003199855, 1294.695746499572, 1311.3181145804128, 1337.9331033448289, 1343.1068339554088, 1017.0744622393586, 1024.3393011507685, 1031.2471895516314, 1037.1288117980932, 1066.2482949520725, 6162.352952939967, 6218.160548326008, 6220.34686357935, 6315.084312774714, 6632.1709786276715, 469.9694519856267, 483.5599604360016, 485.18731125365576, 486.63259239274123, 489.76980819015006, 4337.934930976038, 4455.1312494064, 4481.462224533077, 4586.495485496593, 4719.882002949954, 12130.211536250115, 12315.384230788424, 12431.12982091263, 12444.81332779991, 12455.750884982432, 11571.363575003455, 12132.818007729891, 12142.757144857052, 12248.632541023784, 12345.814812777815, 8763.780905477413, 9189.770255743526, 9195.218406435528, 9203.217726493323, 9213.539323033956, 6425.485961123192, 6441.323661015525, 6519.445847103049, 6623.768168114286, 6759.121314229119, 10927.125829933746, 11284.32294062359, 11290.548378064785, 11419.771604568028, 11451.59919402817, 10465.790684186426, 10754.354738715701, 11650.126240532163, 11670.533178672758, 11672.358020308964, 8217.342612590859, 8393.832123357377, 8502.064772874855, 8753.343499237455, 8879.33404994615, 9453.574589143642, 9455.19630831387, 9490.0, 9490.715278541655, 9601.759956001157, 8149.307308878811, 8580.699675511327, 8647.308215342631, 8771.868421973802, 8859.0, 8455.196756308142, 8518.659253629785, 8533.74398768038, 8649.740507784776, 8751.081136480578, 7378.262173782793, 7638.541687498768, 7968.601569921365, 8059.637316320663, 8074.0, 5553.500184983371, 5598.972005139948, 5749.453801888814, 5762.798302059407, 5907.232059832194, 5751.051076572486, 5761.452661997104, 5768.769249229984, 5787.421257874179, 5822.94177058224], "value": 4945.404981346657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5700745564317, 351.8276044738079, 353.74176850898846, 354.9006278242093, 361.3008827917981, 5427.15476737909, 5462.235287059815, 5467.933752918178, 5479.2602998595175, 5539.25220095287, 5406.83779486616, 5417.510184699209, 5456.427075157101, 5461.2147804619635, 5510.752016159272, 3789.9242015159816, 4063.4311196432523, 4233.322668373061, 4240.088380998085, 4253.617174454314, 4220.978895105535, 4230.323148296273, 4230.788460576974, 4232.3916911573715, 4265.864589526695, 4041.2321658884866, 4201.873943781691, 4227.809748561307, 4238.724482908617, 4244.299690551055, 4100.507939047318, 4201.369794530814, 4218.451601291843, 4223.873283801491, 4233.343831706091, 3759.473673685686, 3763.41667041609, 3777.867774627875, 3780.300644380771, 3780.319542482352, 5203.401608814959, 5266.235811003318, 5278.392984806758, 5287.365516138088, 5292.841214763564, 4616.376789133491, 4835.5889749371345, 4847.466778654345, 4848.200046992278, 4881.194602890519, 5614.971925140389, 5623.453550273666, 5632.46491583303, 5637.492625663669, 5657.12314591239, 4082.6121518455698, 4101.487314085739, 4102.138550904314, 4119.8352065917325, 4121.9381709274385, 5566.721663916788, 5579.804706835282, 5697.6011679182475, 5866.600049962485, 5889.234399528077, 4144.896377590584, 4161.396597493407, 4167.395727619539, 4221.514525829508, 4253.2769429197115, 4275.0, 4289.463817022872, 4293.463317085364, 4299.828006879689, 4304.0, 4584.4498660160325, 4873.634477414137, 4878.170710979142, 4886.315915771795, 4899.779509922062, 5655.632383895034, 5671.234383358276, 5687.51656109227, 5716.256886604715, 5721.284839395075, 1476.970460590782, 1488.1071357185601, 1488.3971991343524, 1491.2618253964356, 1494.9551513454614, 928.6239073175375, 949.2832911152174, 950.8716323296405, 952.9285303602257, 965.4207475514635, 4916.237983112624, 4931.876703082452, 4955.108080545464, 4956.603471722254, 4987.725675087832, 5163.251328557338, 5163.793448262028, 5164.457731938092, 5187.299714538564, 5188.481151884781, 4628.0, 4913.557779799835, 4987.002599480046, 4995.351533993846, 4997.9750101249265, 2743.492453896036, 2748.491529067129, 2758.4896794093156, 2767.3081729567607, 2767.533207400081, 5274.7626356814035, 5312.389075256395, 5322.92015619766, 5346.679199248058, 5348.572114230852, 5254.842354729288, 5256.739601971112, 5557.944420555743, 5944.673042982591, 6029.155918171459, 6055.878882422415, 6062.666553339609, 6079.604825686316, 6086.543509236825, 6095.817125486243, 5563.499285064364, 5884.852453771474, 5901.793437229677, 5909.52723782105, 5918.467337939606, 5719.656820590778, 5786.685325869686, 5844.883102338014, 5850.23946886902, 5862.677552734641, 5832.795852145325, 5924.644521328734, 5930.733117009659, 5939.7921072763975, 6097.146399504161, 4078.184363127327, 4098.73358231714, 4214.873553793391, 4224.619784219435, 4234.851780187679, 5701.686407247641, 5906.511051600728, 5919.200907877554, 5929.466348028698, 5933.940660593512, 5619.297587801525, 5660.801871934463, 5662.2639056922335, 5681.914771278517, 5719.714014299185, 5630.380658127685, 5634.52106570946, 5690.203371527907, 5705.172749951151, 5722.512146841768, 5378.811741589026, 5563.972180139073, 5585.972070139624, 5621.80323688669, 5630.8029218977135, 5670.092785154356, 5674.233978412862, 5698.54411647059, 5699.401562836008, 5702.576405027764, 5604.495595396434, 5609.747561359667, 5624.690642014729, 5626.634268772516, 5653.689047102449], "value": 4272.455158095202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.1357858195345, 851.3487182305533, 876.7720392697898, 879.5250564695065, 922.916937475627, 15864.127472988981, 15961.441349552768, 17784.199711013003, 17813.198406071726, 17827.0, 16297.429589964353, 17415.651686966285, 17423.0, 17434.82565174348, 17482.300707971666, 737.7971057959078, 862.8188080503102, 873.2577309287119, 880.7665968518347, 903.0247332880506, 864.6887120636598, 877.7893305606673, 877.8112705768259, 877.9648814047431, 878.0253918150847, 909.6816114359954, 909.7134402663173, 909.9135582119688, 911.1844898815556, 911.4850109688005, 749.6102026945985, 879.5558243087264, 902.9864552031725, 903.3902116071658, 904.6969265296134, 667.3460009190972, 667.8297034256234, 668.348360348661, 668.4485299627827, 668.6489592963684, 16730.74903876443, 16732.414365497272, 16766.161691915357, 16810.0, 16826.158692065346, 14754.26228688572, 14795.33420996047, 14842.109473431628, 14912.478063267841, 15379.846201537954, 13713.45146194161, 13765.518206862711, 13842.86157138436, 13909.721805563933, 14253.50112746049, 4675.88310292242, 4843.467218605951, 4917.901641967176, 4938.950610493885, 5048.343715317022, 89007.0, 89192.0, 90494.0, 91619.0, 92011.53994230053, 11684.649460516199, 12042.578509752117, 12205.20666156697, 12267.325297108566, 12429.813552796715, 22959.19642812527, 23037.539249215257, 23050.884745576164, 23078.192263270706, 23133.88433057824, 9037.0, 9046.321525885585, 9167.541622918827, 9282.211012063915, 9394.624215031323, 5116.0, 5225.268462415265, 5346.893062138735, 5395.136778115482, 5469.371022332403, 3576.266865292661, 3691.298653255873, 3691.9077023074638, 3692.243090166563, 3703.3148867459604, 687.2131409536054, 704.2359040441077, 708.3483195460086, 717.1322699533623, 721.3868212019742, 682.5802131688976, 689.5724650716487, 722.0937723157404, 729.7810656803044, 757.2427572427572, 9251.67619133327, 9342.159205671522, 9729.221662267002, 9931.354461959949, 9944.900550994542, 725.1298441869777, 741.6884908338511, 743.9404847612178, 747.316205671815, 750.5271678842295, 4798.424189097261, 4812.494688057774, 4852.587530059914, 4933.584441924458, 4983.202687570044, 123068.38465807613, 126027.73972260344, 127274.0, 127452.36273818572, 128841.0, 111232.44383778029, 112554.43722781497, 114457.0, 114564.0, 116451.41774291074, 93641.5317923406, 94820.52589737007, 95577.0, 97692.51153744185, 98830.50584747174, 9080.500572468578, 9096.0, 9193.540322983958, 9256.72229833106, 9299.72100836976, 57123.714381427824, 58040.70979645075, 58199.4180058194, 59100.11349829842, 60349.39650603614, 82232.58883705543, 85744.57127714322, 87347.56326218328, 88118.55940720512, 91253.0, 11867.76264474723, 12050.698732531757, 12119.636410907688, 12184.75630487403, 12670.328745003355, 13010.414531345923, 13075.869241307846, 13246.933765331498, 13449.193048417126, 13728.0, 15068.773968390702, 15264.618384540476, 15281.6179595511, 15369.385224590891, 15867.127307998171, 14923.701525969203, 14969.476068337555, 15273.312700928707, 15553.0, 16244.187790610658, 14965.551033469013, 15223.543293701206, 15810.446634367741, 15976.360945562048, 16369.67260654804, 12242.204256723284, 12252.203606765532, 12544.310062946626, 12680.6829829255, 13323.267220302589, 12148.574799881962, 12327.876721233031, 12548.937255313665, 12602.054845886412, 12820.0], "value": 8216.765403727646, "unit": "score"}], "name": "dromaeo_css", "value": 7650.72309812298, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 112.0, 109.0, 113.0, 111.0, 108.0, 109.0, 108.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 115.0, 178.0, 117.0, 120.0, 144.0, 117.0, 150.0, 116.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 161.0, 166.0, 161.0, 161.0, 162.0, 163.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 119.0, 76.0, 76.0, 74.0, 76.0, 108.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 129.0, 85.0, 84.0, 83.0, 111.0, 83.0, 83.0, 128.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 149.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 51.0, 51.0, 60.0, 51.0, 50.0, 50.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 73.0, 81.0, 72.0, 73.0, 72.0, 72.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 117.0, 117.0, 119.0, 115.0, 131.0, 123.0, 117.0, 160.0, 127.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 152.0, 155.0, 159.0, 153.0, 153.0, 158.0, 151.0, 151.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 62.0, 63.0, 62.0, 67.0, 62.0, 63.0, 64.0, 61.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1469.0000000000002, "alertThreshold": 2.0}]} 11:26:31 INFO - Return code: 0 11:26:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:26:32 INFO - # TBPL SUCCESS # 11:26:32 INFO - Running post-action listener: _resource_record_post_action 11:26:32 INFO - [mozharness: 2016-08-03 18:26:32.053280Z] Finished run-tests step (success) 11:26:32 INFO - Running post-run listener: _resource_record_post_run 11:26:32 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 40960; Write bytes: 511791104; Read time: 52; Write time: 524812 11:26:32 INFO - TinderboxPrint: CPU usage
13.0% 11:26:32 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 52 11:26:32 INFO - TinderboxPrint: I/O write bytes / time
511,791,104 / 524,812 11:26:32 INFO - TinderboxPrint: CPU idle
8,253.8 (87.0%) 11:26:32 INFO - TinderboxPrint: CPU user
1,185.8 (12.5%) 11:26:32 INFO - TinderboxPrint: Swap in / out
0 / 0 11:26:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251531264; Read time: 0; Write time: 310608 11:26:32 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 36864; Write bytes: 256372736; Read time: 44; Write time: 213588 11:26:32 INFO - Running post-run listener: _upload_blobber_files 11:26:32 INFO - Blob upload gear active. 11:26:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:26:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:26:33 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:40 INFO - (blobuploader) - INFO - Done attempting. 11:26:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:26:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:26:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:41 INFO - (blobuploader) - INFO - Done attempting. 11:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:42 INFO - (blobuploader) - INFO - Done attempting. 11:26:42 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:42 INFO - Return code: 0 11:26:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7782da080086abb934ea4e02020c24747c60f3506d6b5749293ee622db032306818fef01e17a06c2b219120da03cd7af0452752efbb83f12ed374334b0b5e11f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6b1e7ad490ceaf70ab4b628cad8ecce46ec37978808bdfaced8596878a45d6cf85dfe50a87eb2c6de97cc9a4ece3d77f7431ea174410379f973f5de9c97116f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eda97904432fddb17d291292cc8ed9dc5ddffc1e1ba101d99fc1b2799946262f37e34918d19621dd20c90741068644e59738352fe991f9c5d8da5b8c10c3598e"} 11:26:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:42 INFO - Contents: 11:26:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7782da080086abb934ea4e02020c24747c60f3506d6b5749293ee622db032306818fef01e17a06c2b219120da03cd7af0452752efbb83f12ed374334b0b5e11f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6b1e7ad490ceaf70ab4b628cad8ecce46ec37978808bdfaced8596878a45d6cf85dfe50a87eb2c6de97cc9a4ece3d77f7431ea174410379f973f5de9c97116f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eda97904432fddb17d291292cc8ed9dc5ddffc1e1ba101d99fc1b2799946262f37e34918d19621dd20c90741068644e59738352fe991f9c5d8da5b8c10c3598e"} 11:26:42 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:42 INFO - Copying logs to upload dir... 11:26:42 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.777616 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-03 11:26:42.257617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 11:26:42.260818) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7782da080086abb934ea4e02020c24747c60f3506d6b5749293ee622db032306818fef01e17a06c2b219120da03cd7af0452752efbb83f12ed374334b0b5e11f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6b1e7ad490ceaf70ab4b628cad8ecce46ec37978808bdfaced8596878a45d6cf85dfe50a87eb2c6de97cc9a4ece3d77f7431ea174410379f973f5de9c97116f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eda97904432fddb17d291292cc8ed9dc5ddffc1e1ba101d99fc1b2799946262f37e34918d19621dd20c90741068644e59738352fe991f9c5d8da5b8c10c3598e"} build_url:https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/US-y2HcNSti6jIrn3cFUbw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7782da080086abb934ea4e02020c24747c60f3506d6b5749293ee622db032306818fef01e17a06c2b219120da03cd7af0452752efbb83f12ed374334b0b5e11f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6b1e7ad490ceaf70ab4b628cad8ecce46ec37978808bdfaced8596878a45d6cf85dfe50a87eb2c6de97cc9a4ece3d77f7431ea174410379f973f5de9c97116f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eda97904432fddb17d291292cc8ed9dc5ddffc1e1ba101d99fc1b2799946262f37e34918d19621dd20c90741068644e59738352fe991f9c5d8da5b8c10c3598e"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 11:26:42.309383) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:26:42.309783) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1470247567.683235-856987762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:26:42.394632) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 11:26:42.394974) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 11:26:42.395307) ========= ========= Total master_lag: 0.30 =========