builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1470077633.66 results: success (0) buildid: 20160801085448 builduid: 8abb7db25ac34ae39552f7ca58ae99d2 revision: 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:53.663142) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:53.663852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:53.664318) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:53.679962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:53.680350) ========= 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=923d835db2ba3686ebe126b700000192-1470077633.144593-957521591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 11:53:54-- 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% 9.89M=0.001s 2016-08-01 11:53:54 (9.89 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134308 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:53.828779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:53.829089) ========= 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=923d835db2ba3686ebe126b700000192-1470077633.144593-957521591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018171 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:53.878391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:53.878775) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 --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 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 --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=923d835db2ba3686ebe126b700000192-1470077633.144593-957521591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 11:53:54,318 truncating revision to first 12 chars 2016-08-01 11:53:54,318 Setting DEBUG logging. 2016-08-01 11:53:54,318 attempt 1/10 2016-08-01 11:53:54,318 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/70ee99f185b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 11:53:54,630 unpacking tar archive at: mozilla-aurora-70ee99f185b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641086 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:54.533609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:54.533951) ========= script_repo_revision: 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:54.534346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:54.534610) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:53:54.543779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-01 11:53:54.544061) ========= /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=923d835db2ba3686ebe126b700000192-1470077633.144593-957521591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:53:55 INFO - MultiFileLogger online at 20160801 11:53:55 in /builds/slave/test 11:53:55 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:53:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:53:55 INFO - {'append_to_log': False, 11:53:55 INFO - 'base_work_dir': '/builds/slave/test', 11:53:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:53:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:53:55 INFO - 'branch': 'Mozilla-Aurora', 11:53:55 INFO - 'buildbot_json_path': 'buildprops.json', 11:53:55 INFO - 'config_files': ('talos/linux_config.py',), 11:53:55 INFO - 'default_actions': ('clobber', 11:53:55 INFO - 'read-buildbot-config', 11:53:55 INFO - 'download-and-extract', 11:53:55 INFO - 'populate-webroot', 11:53:55 INFO - 'create-virtualenv', 11:53:55 INFO - 'install', 11:53:55 INFO - 'run-tests'), 11:53:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:53:55 INFO - 'download_minidump_stackwalk': True, 11:53:55 INFO - 'download_symbols': 'ondemand', 11:53:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:53:55 INFO - 'tooltool.py': '/tools/tooltool.py', 11:53:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:53:55 INFO - '/tools/misc-python/virtualenv.py')}, 11:53:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:53:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:53:55 INFO - 'installer_path': 'installer.exe', 11:53:55 INFO - 'log_level': 'info', 11:53:55 INFO - 'log_name': 'talos', 11:53:55 INFO - 'log_to_console': True, 11:53:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:53:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:53:55 INFO - 'opt_config_files': (), 11:53:55 INFO - 'pip_index': False, 11:53:55 INFO - 'sps_profile': False, 11:53:55 INFO - 'sps_profile_interval': 0, 11:53:55 INFO - 'suite': 'dromaeojs', 11:53:55 INFO - 'system_bits': '32', 11:53:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:53:55 INFO - 'title': 'talos-linux64-ix-007', 11:53:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:53:55 INFO - 'use_talos_json': True, 11:53:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:53:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:53:55 INFO - 'work_dir': 'build'} 11:53:55 INFO - [mozharness: 2016-08-01 18:53:55.068529Z] Running clobber step. 11:53:55 INFO - Running pre-action listener: _resource_record_pre_action 11:53:55 INFO - Running main action method: clobber 11:53:55 INFO - rmtree: /builds/slave/test/build 11:53:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:53:56 INFO - Running post-action listener: _resource_record_post_action 11:53:56 INFO - [mozharness: 2016-08-01 18:53:56.024673Z] Finished clobber step (success) 11:53:56 INFO - [mozharness: 2016-08-01 18:53:56.024774Z] Running read-buildbot-config step. 11:53:56 INFO - Running pre-action listener: _resource_record_pre_action 11:53:56 INFO - Running main action method: read_buildbot_config 11:53:56 INFO - Using buildbot properties: 11:53:56 INFO - { 11:53:56 INFO - "project": "", 11:53:56 INFO - "product": "firefox", 11:53:56 INFO - "script_repo_revision": "production", 11:53:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:53:56 INFO - "repository": "", 11:53:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:53:56 INFO - "buildid": "20160801085448", 11:53:56 INFO - "pgo_build": "True", 11:53:56 INFO - "basedir": "/builds/slave/test", 11:53:56 INFO - "buildnumber": 404, 11:53:56 INFO - "slavename": "talos-linux64-ix-007", 11:53:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:53:56 INFO - "platform": "ubuntu64_hw", 11:53:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:53:56 INFO - "branch": "mozilla-aurora", 11:53:56 INFO - "repo_path": "releases/mozilla-aurora", 11:53:56 INFO - "revision": "70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3", 11:53:56 INFO - "stage_platform": "linux64-pgo", 11:53:56 INFO - "builduid": "8abb7db25ac34ae39552f7ca58ae99d2", 11:53:56 INFO - "slavebuilddir": "test" 11:53:56 INFO - } 11:53:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 11:53:56 INFO - Running post-action listener: _resource_record_post_action 11:53:56 INFO - [mozharness: 2016-08-01 18:53:56.027235Z] Finished read-buildbot-config step (success) 11:53:56 INFO - [mozharness: 2016-08-01 18:53:56.027346Z] Running download-and-extract step. 11:53:56 INFO - Running pre-action listener: _resource_record_pre_action 11:53:56 INFO - Running main action method: download_and_extract 11:53:56 INFO - mkdir: /builds/slave/test/build/tests 11:53:56 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:53:56 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:53:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:53:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:53:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:53:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:53:56 INFO - Downloaded 1361 bytes. 11:53:56 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:53:56 INFO - Using the following test package requirements: 11:53:56 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:53:56 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:53:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:53:56 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:53:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:53:56 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:53:56 INFO - u'jsshell-linux-x86_64.zip'], 11:53:56 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:53:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:53:56 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:53:56 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:53:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:53:56 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:53:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:53:56 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:53:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:53:56 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:53:56 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:53:56 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:53:56 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:53:56 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:53:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:53:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:53:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:53:57 INFO - Downloaded 21766180 bytes. 11:53:57 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:53:57 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:53:58 INFO - Return code: 0 11:53:58 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:53: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:53:58 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:53:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:53:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:53:59 INFO - Downloaded 21766180 bytes. 11:53:59 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:53:59 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:54:01 INFO - Return code: 0 11:54:01 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:54:01 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:54:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:54:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:54:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:54:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:54:02 INFO - Downloaded 14413723 bytes. 11:54:02 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:54:02 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:54:02 INFO - Return code: 0 11:54:02 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:54:02 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:54:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/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:54:03 INFO - Downloaded 63759413 bytes. 11:54:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:03 INFO - mkdir: /builds/slave/test/properties 11:54:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:54:03 INFO - Writing to file /builds/slave/test/properties/build_url 11:54:03 INFO - Contents: 11:54:03 INFO - build_url:https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:04 INFO - Running post-action listener: _resource_record_post_action 11:54:04 INFO - Running post-action listener: set_extra_try_arguments 11:54:04 INFO - [mozharness: 2016-08-01 18:54:04.471341Z] Finished download-and-extract step (success) 11:54:04 INFO - [mozharness: 2016-08-01 18:54:04.471577Z] Running populate-webroot step. 11:54:04 INFO - Running pre-action listener: _resource_record_pre_action 11:54:04 INFO - Running main action method: populate_webroot 11:54:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:54:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:54:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:54:04 INFO - '--tppagecycles', 11:54:04 INFO - '7'], 11:54:04 INFO - 'tests': ['tsvgm']}}, 11:54:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:54:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:54:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:54:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:54:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:04 INFO - 'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:04 INFO - 'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['damp', 'tps']}, 11:54:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:04 INFO - 'tests': ['damp', 'tps']}, 11:54:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['dromaeo_dom']}, 11:54:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:54:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['basic_compositor_video']}, 11:54:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:54:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['a11yr', 11:54:04 INFO - 'ts_paint', 11:54:04 INFO - 'tpaint', 11:54:04 INFO - 'sessionrestore', 11:54:04 INFO - 'sessionrestore_no_auto_restore', 11:54:04 INFO - 'tabpaint']}, 11:54:04 INFO - 'other-e10s': {'tests': ['a11yr', 11:54:04 INFO - 'ts_paint', 11:54:04 INFO - 'tpaint', 11:54:04 INFO - 'sessionrestore', 11:54:04 INFO - 'sessionrestore_no_auto_restore', 11:54:04 INFO - 'tabpaint']}, 11:54:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:54:04 INFO - 'ts_paint', 11:54:04 INFO - 'tpaint', 11:54:04 INFO - 'sessionrestore', 11:54:04 INFO - 'sessionrestore_no_auto_restore', 11:54:04 INFO - 'tabpaint']}, 11:54:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:54:04 INFO - 'ts_paint', 11:54:04 INFO - 'tpaint', 11:54:04 INFO - 'sessionrestore', 11:54:04 INFO - 'sessionrestore_no_auto_restore', 11:54:04 INFO - 'tabpaint']}, 11:54:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['a11yr', 11:54:04 INFO - 'ts_paint', 11:54:04 INFO - 'tpaint', 11:54:04 INFO - 'sessionrestore', 11:54:04 INFO - 'sessionrestore_no_auto_restore', 11:54:04 INFO - 'tabpaint']}, 11:54:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['a11yr', 11:54:04 INFO - 'ts_paint', 11:54:04 INFO - 'tpaint', 11:54:04 INFO - 'sessionrestore', 11:54:04 INFO - 'sessionrestore_no_auto_restore', 11:54:04 INFO - 'tabpaint']}, 11:54:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['tsvgx', 11:54:04 INFO - 'tsvgr_opacity', 11:54:04 INFO - 'tart', 11:54:04 INFO - 'tscrollx', 11:54:04 INFO - 'cart']}, 11:54:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:54:04 INFO - 'tsvgr_opacity', 11:54:04 INFO - 'tart', 11:54:04 INFO - 'tscrollx', 11:54:04 INFO - 'cart']}, 11:54:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:04 INFO - 'talos_options': ['--disable-e10s'], 11:54:04 INFO - 'tests': ['tp5o']}, 11:54:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:04 INFO - 'tests': ['tp5o']}, 11:54:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:04 INFO - 'talos_options': ['--disable-e10s', 11:54:04 INFO - '--xperf_path', 11:54:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:04 INFO - 'tests': ['tp5n']}, 11:54:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:04 INFO - 'talos_options': ['--xperf_path', 11:54:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:04 INFO - 'tests': ['tp5n']}}, 11:54:04 INFO - 'talos.zip': {'path': '', 11:54:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:54:04 INFO - Running post-action listener: _resource_record_post_action 11:54:04 INFO - [mozharness: 2016-08-01 18:54:04.487520Z] Finished populate-webroot step (success) 11:54:04 INFO - [mozharness: 2016-08-01 18:54:04.487610Z] Running create-virtualenv step. 11:54:04 INFO - Running pre-action listener: _resource_record_pre_action 11:54:04 INFO - Running main action method: create_virtualenv 11:54:04 INFO - Creating virtualenv /builds/slave/test/build/venv 11:54:04 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:54:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:54:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:54:04 INFO - Using real prefix '/usr' 11:54:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:54:05 INFO - Installing distribute.............................................................................................................................................................................................done. 11:54:07 INFO - Installing pip.................done. 11:54:07 INFO - Return code: 0 11:54:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:54:07 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:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:07 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:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:07 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54:07 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:54:07 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:54:07 INFO - Using env: {'DISPLAY': ':0', 11:54:07 INFO - 'HOME': '/home/cltbld', 11:54:07 INFO - 'LANG': 'en_US.UTF-8', 11:54:07 INFO - 'LANGUAGE': 'en_US:en', 11:54:07 INFO - 'LOGNAME': 'cltbld', 11:54:07 INFO - 'MAIL': '/var/mail/cltbld', 11:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:07 INFO - 'MOZ_NO_REMOTE': '1', 11:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:07 INFO - 'NO_EM_RESTART': '1', 11:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:07 INFO - 'PWD': '/builds/slave/test', 11:54:07 INFO - 'SHELL': '/bin/bash', 11:54:07 INFO - 'SHLVL': '1', 11:54:07 INFO - 'TERM': 'linux', 11:54:07 INFO - 'TMOUT': '86400', 11:54:07 INFO - 'USER': 'cltbld', 11:54:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:07 INFO - '_': '/tools/buildbot/bin/python'} 11:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:07 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:54:07 INFO - Cleaning up... 11:54:07 INFO - Return code: 0 11:54:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:54:07 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:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:07 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:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:07 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54:07 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:54:07 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:54:07 INFO - Using env: {'DISPLAY': ':0', 11:54:07 INFO - 'HOME': '/home/cltbld', 11:54:07 INFO - 'LANG': 'en_US.UTF-8', 11:54:07 INFO - 'LANGUAGE': 'en_US:en', 11:54:07 INFO - 'LOGNAME': 'cltbld', 11:54:07 INFO - 'MAIL': '/var/mail/cltbld', 11:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:07 INFO - 'MOZ_NO_REMOTE': '1', 11:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:07 INFO - 'NO_EM_RESTART': '1', 11:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:07 INFO - 'PWD': '/builds/slave/test', 11:54:07 INFO - 'SHELL': '/bin/bash', 11:54:07 INFO - 'SHLVL': '1', 11:54:07 INFO - 'TERM': 'linux', 11:54:07 INFO - 'TMOUT': '86400', 11:54:07 INFO - 'USER': 'cltbld', 11:54:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:07 INFO - '_': '/tools/buildbot/bin/python'} 11:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:07 INFO - Downloading/unpacking psutil>=3.1.1 11:54:07 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:54:07 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:54:07 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:54:07 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:54:07 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:54:07 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:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:54:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:09 INFO - Installing collected packages: psutil 11:54:09 INFO - Running setup.py install for psutil 11:54:09 INFO - building 'psutil._psutil_linux' extension 11:54:09 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:54:09 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:54:09 INFO - building 'psutil._psutil_posix' extension 11:54:09 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:54:09 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:54:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:09 INFO - Successfully installed psutil 11:54:09 INFO - Cleaning up... 11:54:10 INFO - Return code: 0 11:54:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:54: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:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:10 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54:10 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:54:10 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:54:10 INFO - Using env: {'DISPLAY': ':0', 11:54:10 INFO - 'HOME': '/home/cltbld', 11:54:10 INFO - 'LANG': 'en_US.UTF-8', 11:54:10 INFO - 'LANGUAGE': 'en_US:en', 11:54:10 INFO - 'LOGNAME': 'cltbld', 11:54:10 INFO - 'MAIL': '/var/mail/cltbld', 11:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:10 INFO - 'MOZ_NO_REMOTE': '1', 11:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:10 INFO - 'NO_EM_RESTART': '1', 11:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:10 INFO - 'PWD': '/builds/slave/test', 11:54:10 INFO - 'SHELL': '/bin/bash', 11:54:10 INFO - 'SHLVL': '1', 11:54:10 INFO - 'TERM': 'linux', 11:54:10 INFO - 'TMOUT': '86400', 11:54:10 INFO - 'USER': 'cltbld', 11:54:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:10 INFO - '_': '/tools/buildbot/bin/python'} 11:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:54:12 INFO - Installing collected packages: mozsystemmonitor 11:54:12 INFO - Running setup.py install for mozsystemmonitor 11:54:12 INFO - Successfully installed mozsystemmonitor 11:54:12 INFO - Cleaning up... 11:54:12 INFO - Return code: 0 11:54:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:54:12 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:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:12 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:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:12 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54:12 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:54:12 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:54:12 INFO - Using env: {'DISPLAY': ':0', 11:54:12 INFO - 'HOME': '/home/cltbld', 11:54:12 INFO - 'LANG': 'en_US.UTF-8', 11:54:12 INFO - 'LANGUAGE': 'en_US:en', 11:54:12 INFO - 'LOGNAME': 'cltbld', 11:54:12 INFO - 'MAIL': '/var/mail/cltbld', 11:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:12 INFO - 'MOZ_NO_REMOTE': '1', 11:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:12 INFO - 'NO_EM_RESTART': '1', 11:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:12 INFO - 'PWD': '/builds/slave/test', 11:54:12 INFO - 'SHELL': '/bin/bash', 11:54:12 INFO - 'SHLVL': '1', 11:54:12 INFO - 'TERM': 'linux', 11:54:12 INFO - 'TMOUT': '86400', 11:54:12 INFO - 'USER': 'cltbld', 11:54:12 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:12 INFO - '_': '/tools/buildbot/bin/python'} 11:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:12 INFO - Downloading/unpacking jsonschema==2.5.1 11:54:12 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:54:12 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:54:12 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:54:12 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:54:12 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:54:12 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:54:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:54:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:54:14 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:54:14 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:54:14 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:54:14 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:54:14 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:54:14 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:54:14 INFO - Downloading functools32-3.2.3-2.tar.gz 11:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:54:14 INFO - warning: no files found matching '*.txt' 11:54:14 INFO - no previously-included directories found matching 'build' 11:54:14 INFO - no previously-included directories found matching 'dist' 11:54:14 INFO - no previously-included directories found matching '.git*' 11:54:14 INFO - Installing collected packages: jsonschema, functools32 11:54:14 INFO - Running setup.py install for functools32 11:54:14 INFO - warning: no files found matching '*.txt' 11:54:14 INFO - no previously-included directories found matching 'build' 11:54:14 INFO - no previously-included directories found matching 'dist' 11:54:14 INFO - no previously-included directories found matching '.git*' 11:54:14 INFO - Successfully installed jsonschema functools32 11:54:14 INFO - Cleaning up... 11:54:14 INFO - Return code: 0 11:54:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:54:14 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:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:14 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:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:14 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54:14 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:54:14 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:54:14 INFO - Using env: {'DISPLAY': ':0', 11:54:14 INFO - 'HOME': '/home/cltbld', 11:54:14 INFO - 'LANG': 'en_US.UTF-8', 11:54:14 INFO - 'LANGUAGE': 'en_US:en', 11:54:14 INFO - 'LOGNAME': 'cltbld', 11:54:14 INFO - 'MAIL': '/var/mail/cltbld', 11:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:14 INFO - 'MOZ_NO_REMOTE': '1', 11:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:14 INFO - 'NO_EM_RESTART': '1', 11:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:14 INFO - 'PWD': '/builds/slave/test', 11:54:14 INFO - 'SHELL': '/bin/bash', 11:54:14 INFO - 'SHLVL': '1', 11:54:14 INFO - 'TERM': 'linux', 11:54:14 INFO - 'TMOUT': '86400', 11:54:14 INFO - 'USER': 'cltbld', 11:54:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:14 INFO - '_': '/tools/buildbot/bin/python'} 11:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:54:15 INFO - Cleaning up... 11:54:15 INFO - Return code: 0 11:54:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:54:15 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:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:15 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:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:15 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54:15 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:54:15 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:54:15 INFO - Using env: {'DISPLAY': ':0', 11:54:15 INFO - 'HOME': '/home/cltbld', 11:54:15 INFO - 'LANG': 'en_US.UTF-8', 11:54:15 INFO - 'LANGUAGE': 'en_US:en', 11:54:15 INFO - 'LOGNAME': 'cltbld', 11:54:15 INFO - 'MAIL': '/var/mail/cltbld', 11:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:15 INFO - 'MOZ_NO_REMOTE': '1', 11:54:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:15 INFO - 'NO_EM_RESTART': '1', 11:54:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:15 INFO - 'PWD': '/builds/slave/test', 11:54:15 INFO - 'SHELL': '/bin/bash', 11:54:15 INFO - 'SHLVL': '1', 11:54:15 INFO - 'TERM': 'linux', 11:54:15 INFO - 'TMOUT': '86400', 11:54:15 INFO - 'USER': 'cltbld', 11:54:15 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:15 INFO - '_': '/tools/buildbot/bin/python'} 11:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:15 INFO - Downloading/unpacking blobuploader==1.2.4 11:54:15 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:54:15 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:54:15 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:54:15 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:54:15 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:54:15 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:54:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:54:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:54:17 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:54:17 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:54:17 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:54:17 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:54:17 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:54:17 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:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:54:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:54:17 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:54:17 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:54:17 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:54:17 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:54:17 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:54:17 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:54:17 INFO - Downloading docopt-0.6.1.tar.gz 11:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:54:17 INFO - Installing collected packages: blobuploader, requests, docopt 11:54:17 INFO - Running setup.py install for blobuploader 11:54:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:54:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:54:18 INFO - Running setup.py install for requests 11:54:18 INFO - Running setup.py install for docopt 11:54:18 INFO - Successfully installed blobuploader requests docopt 11:54:18 INFO - Cleaning up... 11:54:18 INFO - Return code: 0 11:54:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:18 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:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:18 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:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:18 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54:18 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:54:18 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:54:18 INFO - Using env: {'DISPLAY': ':0', 11:54:18 INFO - 'HOME': '/home/cltbld', 11:54:18 INFO - 'LANG': 'en_US.UTF-8', 11:54:18 INFO - 'LANGUAGE': 'en_US:en', 11:54:18 INFO - 'LOGNAME': 'cltbld', 11:54:18 INFO - 'MAIL': '/var/mail/cltbld', 11:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:18 INFO - 'MOZ_NO_REMOTE': '1', 11:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:18 INFO - 'NO_EM_RESTART': '1', 11:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:18 INFO - 'PWD': '/builds/slave/test', 11:54:18 INFO - 'SHELL': '/bin/bash', 11:54:18 INFO - 'SHLVL': '1', 11:54:18 INFO - 'TERM': 'linux', 11:54:18 INFO - 'TMOUT': '86400', 11:54:18 INFO - 'USER': 'cltbld', 11:54:18 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:18 INFO - '_': '/tools/buildbot/bin/python'} 11:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:18 INFO - Running setup.py (path:/tmp/pip-H3VPMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:18 INFO - Running setup.py (path:/tmp/pip-NexSSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:18 INFO - Running setup.py (path:/tmp/pip-cjPWrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:19 INFO - Running setup.py (path:/tmp/pip-JyNb1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:19 INFO - Running setup.py (path:/tmp/pip-2TD5ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:19 INFO - Running setup.py (path:/tmp/pip-eOHzgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:19 INFO - Running setup.py (path:/tmp/pip-BNw6n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:19 INFO - Running setup.py (path:/tmp/pip-GGOctq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:19 INFO - Running setup.py (path:/tmp/pip-IuZeP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:19 INFO - Running setup.py (path:/tmp/pip-A2OgBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:19 INFO - Running setup.py (path:/tmp/pip-HR61Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:19 INFO - Running setup.py (path:/tmp/pip-Tb7a7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:19 INFO - Running setup.py (path:/tmp/pip-nWPRbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:19 INFO - Running setup.py (path:/tmp/pip-V7DAMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:19 INFO - Running setup.py (path:/tmp/pip-kvc01M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:19 INFO - Running setup.py (path:/tmp/pip-Hq0rfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:19 INFO - Running setup.py (path:/tmp/pip-c2smlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:54:20 INFO - Running setup.py install for manifestparser 11:54:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:54:20 INFO - Running setup.py install for mozcrash 11:54:20 INFO - Running setup.py install for mozdebug 11:54:20 INFO - Running setup.py install for mozdevice 11:54:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:54:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:54:20 INFO - Running setup.py install for mozfile 11:54:20 INFO - Running setup.py install for mozhttpd 11:54:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:54:20 INFO - Running setup.py install for mozinfo 11:54:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:54:20 INFO - Running setup.py install for mozInstall 11:54:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:54:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:54:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:54:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:54:20 INFO - Running setup.py install for mozleak 11:54:20 INFO - Running setup.py install for mozlog 11:54:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:54:21 INFO - Running setup.py install for moznetwork 11:54:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:54:21 INFO - Running setup.py install for mozprocess 11:54:21 INFO - Running setup.py install for mozprofile 11:54:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:54:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:54:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:54:21 INFO - Running setup.py install for mozrunner 11:54:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:54:21 INFO - Running setup.py install for mozscreenshot 11:54:21 INFO - Running setup.py install for moztest 11:54:21 INFO - Running setup.py install for mozversion 11:54:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:54:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:54:21 INFO - Cleaning up... 11:54:21 INFO - Return code: 0 11:54:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:21 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:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:21 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:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:21 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54:21 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:54:21 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:54:21 INFO - Using env: {'DISPLAY': ':0', 11:54:21 INFO - 'HOME': '/home/cltbld', 11:54:21 INFO - 'LANG': 'en_US.UTF-8', 11:54:21 INFO - 'LANGUAGE': 'en_US:en', 11:54:21 INFO - 'LOGNAME': 'cltbld', 11:54:21 INFO - 'MAIL': '/var/mail/cltbld', 11:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:21 INFO - 'MOZ_NO_REMOTE': '1', 11:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:21 INFO - 'NO_EM_RESTART': '1', 11:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:21 INFO - 'PWD': '/builds/slave/test', 11:54:21 INFO - 'SHELL': '/bin/bash', 11:54:21 INFO - 'SHLVL': '1', 11:54:21 INFO - 'TERM': 'linux', 11:54:21 INFO - 'TMOUT': '86400', 11:54:21 INFO - 'USER': 'cltbld', 11:54:21 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:21 INFO - '_': '/tools/buildbot/bin/python'} 11:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:22 INFO - Running setup.py (path:/tmp/pip-G_hdpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:22 INFO - Running setup.py (path:/tmp/pip-BTuIzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:22 INFO - Running setup.py (path:/tmp/pip-jG892D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:22 INFO - Running setup.py (path:/tmp/pip-l05Av5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:22 INFO - Running setup.py (path:/tmp/pip-_6HZUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:22 INFO - Running setup.py (path:/tmp/pip-tddw_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:22 INFO - Running setup.py (path:/tmp/pip-cT3Njx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:22 INFO - Running setup.py (path:/tmp/pip-aqc4S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:22 INFO - Running setup.py (path:/tmp/pip-c8ey21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:22 INFO - Running setup.py (path:/tmp/pip-sQDTk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:22 INFO - Running setup.py (path:/tmp/pip-_nZ2ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:22 INFO - Running setup.py (path:/tmp/pip-VDI2qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:22 INFO - Running setup.py (path:/tmp/pip-V30gfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:22 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:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:22 INFO - Running setup.py (path:/tmp/pip-fHQ8tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:23 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:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:23 INFO - Running setup.py (path:/tmp/pip-R5rf6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:23 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:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:23 INFO - Running setup.py (path:/tmp/pip-umhlQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:23 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:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:23 INFO - Running setup.py (path:/tmp/pip-Z9wxJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:23 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:54:23 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:54:23 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:54:23 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:54:23 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:54:23 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:54:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:54: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:54: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:54: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:54: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:54: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:54: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:54:25 INFO - Downloading blessings-1.6.tar.gz 11:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:54:25 INFO - Installing collected packages: blessings 11:54:25 INFO - Running setup.py install for blessings 11:54:25 INFO - Successfully installed blessings 11:54:25 INFO - Cleaning up... 11:54:25 INFO - Return code: 0 11:54:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:25 INFO - Reading from file tmpfile_stdout 11:54:25 INFO - Current package versions: 11:54:25 INFO - argparse == 1.2.1 11:54:25 INFO - blessings == 1.6 11:54:25 INFO - blobuploader == 1.2.4 11:54:25 INFO - docopt == 0.6.1 11:54:25 INFO - functools32 == 3.2.3-2 11:54:25 INFO - jsonschema == 2.5.1 11:54:25 INFO - manifestparser == 1.1 11:54:25 INFO - mozInstall == 1.12 11:54:25 INFO - mozcrash == 0.17 11:54:25 INFO - mozdebug == 0.1 11:54:25 INFO - mozdevice == 0.48 11:54:25 INFO - mozfile == 1.2 11:54:25 INFO - mozhttpd == 0.7 11:54:25 INFO - mozinfo == 0.9 11:54:25 INFO - mozleak == 0.1 11:54:25 INFO - mozlog == 3.3 11:54:25 INFO - moznetwork == 0.27 11:54:25 INFO - mozprocess == 0.23 11:54:25 INFO - mozprofile == 0.28 11:54:25 INFO - mozrunner == 6.12 11:54:25 INFO - mozscreenshot == 0.1 11:54:25 INFO - mozsystemmonitor == 0.3 11:54:25 INFO - moztest == 0.7 11:54:25 INFO - mozversion == 1.4 11:54:25 INFO - psutil == 3.1.1 11:54:25 INFO - requests == 1.2.3 11:54:25 INFO - wsgiref == 0.1.2 11:54:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54: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:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:25 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54:25 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:54:25 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:54:25 INFO - Using env: {'DISPLAY': ':0', 11:54:25 INFO - 'HOME': '/home/cltbld', 11:54:25 INFO - 'LANG': 'en_US.UTF-8', 11:54:25 INFO - 'LANGUAGE': 'en_US:en', 11:54:25 INFO - 'LOGNAME': 'cltbld', 11:54:25 INFO - 'MAIL': '/var/mail/cltbld', 11:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:25 INFO - 'MOZ_NO_REMOTE': '1', 11:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:25 INFO - 'NO_EM_RESTART': '1', 11:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:25 INFO - 'PWD': '/builds/slave/test', 11:54:25 INFO - 'SHELL': '/bin/bash', 11:54:25 INFO - 'SHLVL': '1', 11:54:25 INFO - 'TERM': 'linux', 11:54:25 INFO - 'TMOUT': '86400', 11:54:25 INFO - 'USER': 'cltbld', 11:54:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:25 INFO - '_': '/tools/buildbot/bin/python'} 11:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:25 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:54:25 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:54:25 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:54:25 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:54:25 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:54:25 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:54:25 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:54:25 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:54:25 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:54:25 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:54:25 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:54:25 INFO - Cleaning up... 11:54:25 INFO - Return code: 0 11:54:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:54: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:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', '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:54: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', 'jsonschema'] in /builds/slave/test/build 11:54: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 jsonschema 11:54:25 INFO - Using env: {'DISPLAY': ':0', 11:54:25 INFO - 'HOME': '/home/cltbld', 11:54:25 INFO - 'LANG': 'en_US.UTF-8', 11:54:25 INFO - 'LANGUAGE': 'en_US:en', 11:54:25 INFO - 'LOGNAME': 'cltbld', 11:54:25 INFO - 'MAIL': '/var/mail/cltbld', 11:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:25 INFO - 'MOZ_NO_REMOTE': '1', 11:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:25 INFO - 'NO_EM_RESTART': '1', 11:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:25 INFO - 'PWD': '/builds/slave/test', 11:54:25 INFO - 'SHELL': '/bin/bash', 11:54:25 INFO - 'SHLVL': '1', 11:54:25 INFO - 'TERM': 'linux', 11:54:25 INFO - 'TMOUT': '86400', 11:54:25 INFO - 'USER': 'cltbld', 11:54:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:25 INFO - '_': '/tools/buildbot/bin/python'} 11:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:54:26 INFO - Cleaning up... 11:54:26 INFO - Return code: 0 11:54:26 INFO - Running post-action listener: _resource_record_post_action 11:54:26 INFO - Running post-action listener: _start_resource_monitoring 11:54:26 INFO - Starting resource monitoring. 11:54:26 INFO - [mozharness: 2016-08-01 18:54:26.080248Z] Finished create-virtualenv step (success) 11:54:26 INFO - [mozharness: 2016-08-01 18:54:26.080733Z] Running install step. 11:54:26 INFO - Running pre-action listener: _resource_record_pre_action 11:54:26 INFO - Running main action method: install 11:54:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:26 INFO - Reading from file tmpfile_stdout 11:54:26 INFO - Detecting whether we're running mozinstall >=1.0... 11:54:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:54:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:54:26 INFO - Reading from file tmpfile_stdout 11:54:26 INFO - Output received: 11:54:26 INFO - Usage: mozinstall [options] installer 11:54:26 INFO - Options: 11:54:26 INFO - -h, --help show this help message and exit 11:54:26 INFO - -d DEST, --destination=DEST 11:54:26 INFO - Directory to install application into. [default: 11:54:26 INFO - "/builds/slave/test"] 11:54:26 INFO - --app=APP Application being installed. [default: firefox] 11:54:26 INFO - mkdir: /builds/slave/test/build/application 11:54:26 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:54:26 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:54:42 INFO - Reading from file tmpfile_stdout 11:54:42 INFO - Output received: 11:54:42 INFO - /builds/slave/test/build/application/firefox/firefox 11:54:42 INFO - Running post-action listener: _resource_record_post_action 11:54:42 INFO - [mozharness: 2016-08-01 18:54:42.359506Z] Finished install step (success) 11:54:42 INFO - [mozharness: 2016-08-01 18:54:42.359787Z] Running run-tests step. 11:54:42 INFO - Running pre-action listener: _resource_record_pre_action 11:54:42 INFO - Running main action method: run_tests 11:54:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:54:42 INFO - Python 2.7.3 11:54:42 INFO - Return code: 0 11:54:42 INFO - grabbing minidump binary from tooltool 11:54:42 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:54:42 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 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:54:42 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:54:42 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:54:42 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:54:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:42 INFO - Return code: 0 11:54:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:54:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:54:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:54:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:54:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:54:42 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/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:54:42 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/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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:54:42 INFO - Using env: {'DISPLAY': ':0', 11:54:42 INFO - 'HOME': '/home/cltbld', 11:54:42 INFO - 'LANG': 'en_US.UTF-8', 11:54:42 INFO - 'LANGUAGE': 'en_US:en', 11:54:42 INFO - 'LOGNAME': 'cltbld', 11:54:42 INFO - 'MAIL': '/var/mail/cltbld', 11:54:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:42 INFO - 'MOZ_NO_REMOTE': '1', 11:54:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:42 INFO - 'NO_EM_RESTART': '1', 11:54:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:42 INFO - 'PWD': '/builds/slave/test', 11:54:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:42 INFO - 'SHELL': '/bin/bash', 11:54:42 INFO - 'SHLVL': '1', 11:54:42 INFO - 'TERM': 'linux', 11:54:42 INFO - 'TMOUT': '86400', 11:54:42 INFO - 'USER': 'cltbld', 11:54:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470077633.144593-957521591', 11:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:42 INFO - '_': '/tools/buildbot/bin/python'} 11:54:42 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/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:54:42 INFO - mozversion application_buildid: 20160801085448 11:54:42 INFO - mozversion application_changeset: 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 11:54:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:54:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:42 INFO - mozversion application_name: Firefox 11:54:42 INFO - mozversion application_remotingname: firefox-dev 11:54:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:54:42 INFO - mozversion application_vendor: Mozilla 11:54:42 INFO - mozversion application_version: 50.0a2 11:54:42 INFO - mozversion platform_buildid: 20160801085448 11:54:42 INFO - mozversion platform_changeset: 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 11:54:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:54:42 INFO - mozversion platform_version: 50.0a2 11:54:42 INFO - using testdate: 1470077682 11:54:42 INFO - actual date: 1470077682 11:54:42 INFO - starting webserver on 'localhost:54044' 11:54:42 INFO - SUITE-START | Running 2 tests 11:54:42 INFO - TEST-START | dromaeo_css 11:54:42 INFO - operating with platform_type : linux_ 11:54:42 INFO - Initialising browser for dromaeo_css test... 11:54:42 INFO - TEST-INFO | started process 18119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcFvsF/profile http://localhost:54044/getInfo.html) 11:54:46 INFO - PROCESS | 18119 | __metrics Screen width/height:1600/1200 11:54:46 INFO - PROCESS | 18119 | colorDepth:24 11:54:46 INFO - PROCESS | 18119 | Browser inner width/height: 1024/697 11:54:46 INFO - PROCESS | 18119 | __metrics 11:54:47 INFO - PROCESS | 18119 | 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:54:47 INFO - PROCESS | 18119 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:54:48 INFO - TEST-INFO | 18119: exit 0 11:54:48 INFO - Browser initialized. 11:54:48 INFO - Running cycle 1/1 for dromaeo_css test... 11:54:48 INFO - TEST-INFO | started process 18209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcFvsF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:59 INFO - PROCESS | 18209 | RSS: Main: 145358848 11:54:59 INFO - PROCESS | 18209 | 11:55:50 INFO - PROCESS | 18209 | 1470077750784 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:57:59 INFO - PROCESS | 18209 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54044/tests/dromaeo/cssquery-ext.html) 11:58:01 INFO - PROCESS | 18209 | RSS: Main: 272760832 11:58:01 INFO - PROCESS | 18209 | 12:01:03 INFO - PROCESS | 18209 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-ext.html (next: http://localhost:54044/tests/dromaeo/cssquery-jquery.html) 12:01:04 INFO - PROCESS | 18209 | RSS: Main: 228302848 12:01:04 INFO - PROCESS | 18209 | 12:04:06 INFO - PROCESS | 18209 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54044/tests/dromaeo/cssquery-mootools.html) 12:04:06 INFO - PROCESS | 18209 | RSS: Main: 171999232 12:04:06 INFO - PROCESS | 18209 | 12:07:08 INFO - PROCESS | 18209 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54044/tests/dromaeo/cssquery-prototype.html) 12:07:09 INFO - PROCESS | 18209 | RSS: Main: 175411200 12:07:09 INFO - PROCESS | 18209 | 12:10:11 INFO - PROCESS | 18209 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54044/tests/dromaeo/cssquery-yui.html) 12:10:12 INFO - PROCESS | 18209 | RSS: Main: 174669824 12:10:12 INFO - PROCESS | 18209 | 12:13:15 INFO - PROCESS | 18209 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-yui.html (next: http://localhost:54044/tests/dromaeo/cssquery-dojo.html) 12:13:15 INFO - PROCESS | 18209 | RSS: Main: 261722112 12:13:15 INFO - PROCESS | 18209 | 12:13:15 INFO - PROCESS | 18209 | __start_tp_report 12:13:15 INFO - PROCESS | 18209 | _x_x_mozilla_page_load 12:13:15 INFO - PROCESS | 18209 | _x_x_mozilla_page_load_details 12:13:15 INFO - PROCESS | 18209 | |i|pagename|runs| 12:13:15 INFO - PROCESS | 18209 | |0;dojo.html;3277;3306.6032076150864;3311.917202069949;3332.7500437467165;3361.44536151535;5604.5796565257615;5710.057840456319;5713.571482138836;5718.485336319725;5726.484616384525;5678.43215678433;5726.083826587746;5739.110437882135;5740.741666625001;5745.080787074069;5000.174971129777;5064.468230835764;5166.715830629314;5176.352955880515;5207.505286997729;5122.206058060988;5171.482851714836;5177.042247184264;5181.766820493087;5198.870028249286;5069.290299358093;5131.461196574343;5131.692098474104;5156.793728250866;5177.663451875616;5215.608829337777;5219.086659834533;5225.268462415265;5225.843224703265;5252.606054545924;4972.005598880239;4990.675606085629;5003.5997120230295;5092.949070509321;5109.897802043975;5508.476694713996;5516.255305533742;5522.696251706155;5559.360673522557;5571.415001424833;6040.8187754367;6042.8187154385;6046.244219472566;6050.152978583002;6063.151158837766;5820.476157145835;5984.611000284967;5991.460768530809;6016.458518733335;6068.423499767515;5662.405447428002;5678.318601767773;5692.430756924357;5699.259096317535;5699.8860022800145;6191.535634827406;6192.752289908353;6192.783252586138;6196.597221180609;6214.316425193225;5609.27079479665;5738.426157384228;5773.134029895549;5844.88310233793;5886.735096920649;5940.46535811779;5947.583669143119;5969.074793407029;5980;5980.850478738066;5945.3757355477055;5993.220881285405;5997;6002.189704389939;6005.819825405245;5760.107183386582;5872.765089396462;5966.76132954677;5992.580519363602;6073.240844894388;4645.628349732014;4672.859814205579;4683.437987441461;4684.508126646653;4711.010687755541;4165.375193720966;4173.707840451139;4175.478065241845;4194.727342722775;4212.599803018769;5606.327240731057;5659.971700141556;5750.367459579443;5814.215080964016;5820.068788993741;6085.6348619083;6087.756489740449;6108.3280839107665;6113.480354169857;6127.662978536134;5751.1373294006235;5752.194692743019;5755;5756.222909907109;5757.769689212469;5076.6446348755235;5130.692158470429;5192.394546546439;5241.344831896013;5245.606579506552;6116.388361163937;6193.287771906198;6201.968990155201;6202.379762023852;6210.658413787195;5951.018082016419;5953.553483488669;5981.282246130492;5985.880282394415;5988.431099045583;6117.632942023492;6194.101855230876;6204.224471941007;6213.409726076015;6217.751289948352;5903.2325797647745;5987.251593550806;5988.6706231157705;6023.48800351975;6030.276366836008;6045.667488288011;6088.573799833969;6089.2997305310455;6089.756409743561;6101.7559297627595;5693.28833895763;5880.794172204123;5902.586818922806;5956.612820166675;5960.850978725566;5916.378780228014;5999.160117583455;6001.849953751016;6006.369331220334;6038.969805150946;5895.351511333664;5947.197128387612;5952.702364881825;5956;5957.987142185752;5799.2750906136735;5872.94127058741;6031.969840150771;6069.969650151721;6079.483243924139;5775.768969241183;5776.971115144397;5829.679367634821;5841.912371314519;5859.619124756877 12:13:15 INFO - PROCESS | 18209 | |1;ext.html;599.8650303681669;632.829136133244;641.2721561028235;651.1437459740441;653.506602515101;35870.2825943481;38953.220935581274;39169.60830391695;39334.409983850266;39431;39312.606873931254;40296;48497;49375.25937110946;49381.753091234496;9259.074092590721;9387.57755900986;9393.06069393062;9396.248300135972;9398.34211605188;9181.816363672757;9274.629014839398;9275.768105797375;9281.396709213914;9282.953585232099;8606.827863442728;9315.068493150698;11226.943865280662;11505.137114716388;11505.252158609705;11186.552537898475;11194;11262.943685281522;11269.492872820743;11271.718207044807;11155.498002589902;11232.3260604364;11238.157138214667;11242.606508772154;11246.775064498746;35889.82055089708;46283;46530.53469465296;46724.53275467236;51029;3953.723239373216;4014.2372949139863;4310.870673879788;4382.671299652538;4658.440987081572;35667.464988025204;35745.46381804275;35772.28455430903;35979;36361.63638363609;4767.833125840613;4838.588719958808;4869.5130486951375;4876.853694389174;4951.678140920829;387366.9999999972;387634;388370;389452;392090.99999999715;66921.33078669249;67502.29990800313;67552.32447675559;67558.66220668964;67821.3217867815;59333;60072.098918516254;60296.09555856666;63879.36120638827;71144.2885571148;19424.22303107888;19530;19588.70616940747;19603.901980490005;19618.70571941422;15100.924495377452;15181.16503592313;15219.467318643794;15219.771703424458;15221.31504082319;17975.55061123456;20419.8979005104;20730.378088657366;20861.68707469389;20941.476463088544;5515.338159420895;6517.087607734921;6550.2794692583775;6569.146011018537;6612;957.818014577228;1003.7590978165188;1029.8845990877505;1041.8280983637767;1086.179934149712;33780.49329260063;34302.485462718076;34320.14199644979;34350.65649343475;34693.82653086718;1102.404701461218;1179.7876382251277;1195.3306148556835;1204.2834513464475;1217.0020583121932;18264.726029109574;18400.447986560426;18438.35465758692;18565.16456759449;18592.44222673322;594859;596374;599281;602007;602771;59664.40335596675;64990;65258;65656.99999999904;66668.33331666718;1430.9713805723827;1439.3522914688224;1444.59551325629;1474.078700811971;1480.9333579988927;34751.47872781961;36964.81517592395;37228.81385593163;37270.813645931594;37435.2512949734;58237.12644310424;58730.412695872496;58804;58854.7057264711;58925.70537147287;529933;537128;540614.0785072504;778015;780206;32166.19584510406;32213.677863221066;32294.83852580722;32433.837830810695;32566.674333256364;54244.72877635586;54408;54773;54776;55881.720591396785;44524.777376112914;46796.532034679214;47400.2889956644;47721;49093.75453122712;45443.31835022543;45741.771291143334;46257.537424626666;47029.529704703884;48003.5199647999;45347.31979020251;45659.54340456553;46307.53692463032;46945.765271174794;46993.76503117599;38365.616343836205;41632.375514367915;41872.79063604662;41874.581254188284;42056.369154462096;30090.627796190074;30345;30498.695013049586;30858.845705771328;30939 12:13:15 INFO - PROCESS | 18209 | |2;jquery.html;400.19560683027106;406.82303198108843;420.8674267605704;431.18075656253126;435.54920657119885;17514.386996455127;20003.499912502157;20261.189552417905;20429.284975025876;20907.059182336794;20125.194992200293;20177.19291228349;20331;20470.488237794063;20561.38315850527;5527.2538207342095;5865.530757539386;5903.4686878180955;5903.527717782588;5907.940920590803;4210.852620158295;5843.386444423317;5935.317438494563;6259.843503912393;6512.609243445385;6652.2349929757975;6668.199816022084;6675.299093595151;6677.098591690133;6677.66611669417;6373.298937116913;6586.769463068769;6587.901181482282;6611.140551728293;6611.272759996396;5403.648762830403;5687.573431992617;5874.73563689635;5878.265216847894;5878.5297176225795;14552.272386380639;14723.705525889529;14781.187034713086;14809.555713328617;14837;2401.30362194965;2529.696436427622;3005.654349749785;3077.476828939086;3161.636411812625;14749.631259218499;15358.616034599112;15359.846401535953;15455.381784728597;15622.14078225697;1921.2219051284253;1961.5194277401986;1978.8317992970615;1988.2444671025062;2022.5853699991615;81674;83940.99999999939;84008.57995710043;86099.13900860974;88050;11095.667129986114;11544.365059921616;11690.415479226005;11691.590794322328;11797.410129493492;16519.83480165183;16531.6693666126;16569.25438355277;16592.419265325654;16598;8723.16272642019;9108.908910910939;9127.543622818832;9198;9264.073592640816;8943.105689431004;8996.82006359869;9005.324600654845;9166.175044245916;9204.125608067223;4916;5034.34553508049;5044.498583006045;5092.363454568179;5150.609335479399;2031.7765045844944;2065.824404925568;2066.1528773202913;2103.9263625773024;2124.585705787357;950.5532399772096;975.2831668723483;992.6575331510618;1038.6416686243233;1077.8922107789158;20202;20926.581468370547;21026.47433814167;21190.15239390438;21242.468938276357;1005.5274021210166;1022.601185537641;1065.9893401066045;1089.6186334782763;1173.6303064534645;10784.838227426595;11670.299782012937;11762;11773.234739741889;11866.821997670042;514779;598053;616350;616460.1070876817;621019;85074;86146;89373.55313223392;93702.53148734213;98428;1039.5737747523478;1040.3965699894195;1045.9529321180564;1063.3194755356578;1068.1188019883627;18316.26734930588;18513.44459666212;18724.625507490047;18804.811951880307;18947.0526473673;39791;45265.32102018538;45692;46336.53663463322;46638.76680616575;63110.68444657747;63345;64387;64554;64593.35406646061;8329.833403331779;8850.247728942855;8952.597133128895;9021.819563608822;9134.360594758304;9632.90367096348;12944.223346599234;13723.862761372258;13853.37659805291;14054.227017514135;11535.596254131066;11638.301701897914;11652.126090543074;11969.700757481132;12304.384780760747;10908.34549927007;11116.999470047735;11355.716107097389;11444.82832757526;11949.522019119138;11112.944435278096;12059.15585908978;12416.503339866666;12438.253704777742;12610.810837837624;9115.680951166678;9185.265178785547;9222.538873056454;9315.208207302456;9370;11741.354225517336;12338.198017128858;12656.810147847606;12669.429875655433;12951.352432378155 12:13:15 INFO - PROCESS | 18209 | |3;mootools.html;1505.6913332766783;1559.7660350947356;1723.3192888808921;1861.5067007243092;1865.1513561329596;8551.144885511461;9159.954200228989;9287.117723816235;10019;10020.799584008324;9284.442933424;9713.32006759527;9717.951410242957;9726.756831079227;9761.219102471803;2489.0914816092086;2517.3832411059316;2517.471331020488;2518.282289547479;2518.7355327690602;2180.149741600777;2410.421498840283;2448.338948483908;2472.554940110779;2533.961990570143;2529.5699731045765;2555.080171138389;2556.590945448719;2559.0659409315654;2560.9743902561017;2443.8289319747623;2479.3305807431893;2482.565551028563;2482.900683972648;2483.950320993588;2455.656208130863;2474.134053081425;2483.379155211197;2486.353548077495;2487.2662564543502;9813.852792208123;9872.40765554069;9893.653722119763;9905.702828915144;9909;5623.831285061455;5624.3531993820825;5638.407967163471;5650.858728531778;5759.1937128802;3547.5388199534154;3636.5090712753704;3679.411294192916;3706.777593344381;3707.8887633370773;1266.8986481081492;1304.5825335892519;1304.6412236634906;1331.7669407853587;1336.411978729356;13751.931240343734;13813.861861381358;13827.101238419471;13860.792088118686;13887.027908046543;4904.411470623548;4917.967226882323;4935.728534930541;5031.622628302819;5108.693478391308;11610.477528511237;11611.477483513263;11612;11619.593314233962;11645.417729113511;5778.27771528559;5809.796657116981;5810.041343178413;5810.099434587646;5819.330776960619;5240.213967904769;5305.31030965972;5345.786168553214;5345.946540534623;5346.064438723208;4288.120935208337;4325.113351762881;4335.154644844288;4362.345648152803;4392.582704643054;1206.8551773787026;1232.7534493101416;1233.8519377674556;1234.740704452075;1326.1380102933172;828.842519921213;1017.2014968249888;1057.1225882517492;1062.9946850265853;1081.5998080710187;6261.311255761862;6401.743930242831;6435.452986496107;6532.640704761284;6648.933510664928;1025.3181634213313;1025.8409946458312;1045.7542477517777;1046.4924511611862;1066.088494337346;4322.632576231055;4491.708038977456;4492.528284530143;4507.414036175276;4610.101030299126;12008.699782505333;12277.324747138815;12393.752124957451;12393.876061239453;12469.75060498785;10714.571417143226;12235.938820306019;12242.081843861746;12255.203411778206;12265.325407102695;8641.179087986631;8895.332850036144;9047.68333108338;9073.410228335137;9078.636854525877;6377.330380310001;6452.935470645233;6549.836254093686;6649.534532582673;6682.9331706682315;10715.517801699098;11166.720831979266;11285.830712539482;11446.370449625017;11466.31202127875;11561.537538498365;11620.5351785931;11702.88297117018;11729.35488548138;11729.941350293195;9023.548822558714;9034.503102329172;9044.366894317598;9058.275337973078;9167.312451566026;9161.03809100035;9234.492102934402;9236.72289831306;9268.119528644767;9273;8059.637316320663;8149.307308878811;8182.631781569963;8246.38152138604;8486.702965396182;8067.83864322722;8077.232662897015;8124.065732440845;8175.632096555551;8275.08974012846;7386.372158366384;7676.731314403969;7715.652795624098;7757.301842834172;7790.376769858284;5533.695646739468;5641.294838145232;5757.568182386254;5761.251037365283;5835.824925252249;5837.211976383134;5854.648721076749;5899.652260307998;5985.042393217064;6011.549133814894 12:13:15 INFO - PROCESS | 18209 | |4;prototype.html;353.0837476747839;358.9479525468806;363.0451911472827;365.83171740999137;366.96513831186047;5620.156976453534;5692.5161361284345;5693.601447898649;5696.37339892612;5712.742926568304;5415.65284889015;5500.4499550044975;5500.752466139023;5623.465770751783;5635.5773317001285;4353.586409291112;4380.934285985721;4395.1649186654595;4408.779561021952;4437.35658329542;4385.254506733863;4399.824007039714;4408.493023302329;4412.271975124117;4438.467383913935;4392;4396.6043056124945;4407.338899165119;4418;4419.779011049451;4305.406999410207;4355.386767939242;4356.4336636237085;4379.4525684289465;4392.5367318855815;3900.5124359455067;3900.64894159527;3903.609639036102;3926.2147570486018;3927.410888366739;5428;5460.590455715797;5464.12573988164;5466.945330546683;5472.768627058919;4865.610751139936;4978.207845175734;5053.620978426633;5054.620903432257;5070.366204224472;5743.10981797822;5760.588655779319;5760.654360738369;5766.336871259775;5781.884362312772;4321.459817522809;4330.5669433056755;4332.241857674926;4332.7400355978425;4337.154254920292;5663.178839068353;5679.346875109332;5878.177055212316;5997.190379298782;6132.78535251264;4138.689598280081;4140.3375459926265;4142.627163555295;4157.605027522381;4329.523752387235;4400.427944367212;4401.899525118721;4404.6256068233915;4411.647068234533;4413.44831896013;4845.6123510119105;4944.629152813553;5021.824236151717;5033.0688822567945;5039.823606173766;5760.913586296209;5772.5959182856795;5798.9130163047585;5847.1581451843385;5851.502622277154;1512.7066358263526;1530.5255370835077;1531.157863175249;1534.1638806850294;1538.5768913548864;949.368669834566;970.9174720148725;974.9220062395133;988.6440881282732;1004.4124187350336;5006.872079366328;5022.497750225021;5034.622403319766;5053.84838454847;5055.317532133188;5254.4220135785035;5265.288376486113;5273.551748101378;5278.419373868871;5295.205719142083;5029.748512574357;5047.87380315495;5071.072992262916;5330.466953304716;5715.514181294553;3166.794158379698;3182.156728466958;3184.497053241416;3189.872405103816;3203.0711093782543;6180.351063138396;6221.2845522764555;6227.813165605039;6235.220597425322;6267.871783078998;6069.514438844882;6072.271327440647;6074.9392506075255;6112.388761123852;6116.908246376308;6214.378562143749;6221.564490485713;6224.533160012927;6228.408301211378;6246.718897649616;5826.135636596248;5990.940090599212;6011.398860113954;6033.668148251888;6118.510519158545;5823.388544202798;5939.46544810969;5941.287045554388;5961.821145365646;6031.396860313934;5962.344142144448;6080.787172448943;6190.597611155261;6208.2239720034995;6255.655034167676;4262.89164817156;4308.784560772012;4347.630451411539;4359.934600980924;4376.49670287921;5850.268716410449;5970.611910225822;6100.328963813889;6120;6126.5098792097415;5845.473907348359;5851.502622276984;5911.733971971357;5912.172295878667;5912.320083190316;5859.677717725566;5889.882202356014;5922.763089476372;5933.080372542263;5938.524918006636;5650.85872853182;5762;5795.710214489343;5836.766529338779;5850.893678275732;5859.355470898283;5866.413358664099;5919.260092488439;5951.880962380642;5984.1323008164445;5431.158170483582;5768.798092066758;5775.826725198251;5797.681127538026;5807.245058142415 12:13:15 INFO - PROCESS | 18209 | |5;yui.html;804.4650307545483;816.4325793573469;850.4344610833796;882.6292956958081;906.3700727994038;16909.661806763874;17520.38678646246;17601.64796704065;17638.118094095276;17692.115394230284;16240.106794126319;16391.0984895831;16393.262303196356;16410.753838692428;16424.917875410607;731.3381389842201;857.0829212742368;879.4327658660177;891.4116682989228;893.8435773739602;898.1467605774508;900.7432881628737;901.4501154295874;902.2060586683742;903.1104362203224;951.5289931483925;957.4064080270242;957.4877440569297;959.0888655777005;960.0975083421562;754.8150703077754;888.5779254853925;938.3619138985521;949.4635530925005;952.1763674421645;691.5228492340319;691.94810389221;693.3413257405434;693.3932808792307;693.7814588404636;14931.2534373282;14966.401343946229;14968.850311496963;15000;15008.924955375262;14792.482263120846;15762.448314309058;15864.682706345808;15958.361665533364;16261.51215463538;14368.281585920662;14550.12699238049;14796.112233266038;14802.777958330633;15037.548873533811;4614.769261536943;4620.930686039712;4742.383490146259;4770.594499467549;4791.640626952958;87192.90116536892;87194.5640271801;89189.55405222997;89320.55339723325;91478;12872.485100595872;12966.22202667824;12974;13058.738825223443;13149.539766108332;21449.67825482619;22460;24321.878390608286;24403.63394549083;24412.389690257885;9482.194013508792;9739.26955478342;9850.901490985141;9869.457179855177;10010.199184065257;5125.718085505258;5267.169527429663;5309.761060752276;5365.222042803772;5405.648632838853;4125.257453658371;4283.935740963888;4306.074194048295;4331.5884990925815;4334.566543345641;728.3735987051132;730.2113717185428;741.388354607451;758.9544627322379;762.1387831750197;710.7903168565182;716.3409663109951;787.1027029186731;808.0505406147753;868.079835374505;10618.309809862334;11113.388763618079;11189.160812939062;11238.494267757971;11361.261518001304;653.0595941843729;763.091920614467;785.5914924239363;807.3339494916718;808.2887059387701;5509.449055094458;5566.693831839207;5590.329160500766;5604.019296623074;5624.887502249932;74751;98643.50678246563;101901.49049254855;103881;105552.47223763986;85590.57204713937;85839;91320.54339728258;95305;102848;54834.72582637141;76270.61864690641;79861;81892.59053704812;90423;10182.847257290998;10808.297460665031;11127.801597644204;11147.219694621299;11147.777044459228;52968.4703152979;55354.446455534926;56038.439615603325;56098.71950640221;57573.136402953154;74281.6285918567;81270.18729812863;82874.58562707389;83888;84966;12795.065044897;13951.150569312827;13965.650858728613;14037.578872633838;14063.226522540948;16134.38366098105;16317.102559358875;16723.581910452336;17065.232064556876;17554.648907022045;14290.142591444546;14387.136771793726;14598.562043138723;15350.462733804263;15410.614734631725;14835.777463337843;15154.090754554762;15167.924160379127;15236.619084522532;15540.84459155394;13883.722325553634;14545.78181327302;14629.63425914318;14851.108933464027;14881.25593720288;11846.822297665369;11891.702707432383;12044.51821927113;13043.478260869459;13161.670958226121;12980;12993.440787105608;13330.466781328638;13432.932835335761;13662.795058073938 12:13:15 INFO - PROCESS | 18209 | __end_tp_report 12:13:15 INFO - PROCESS | 18209 | __start_cc_report 12:13:15 INFO - PROCESS | 18209 | _x_x_mozilla_cycle_collect,1092 12:13:15 INFO - PROCESS | 18209 | __end_cc_report 12:13:15 INFO - PROCESS | 18209 | __startTimestamp1470078795334__endTimestamp 12:13:15 INFO - PROCESS | 18209 | 12:13:15 INFO - PROCESS | 18209 | ------- Summary: start ------- 12:13:15 INFO - PROCESS | 18209 | Number of tests: 6 12:13:15 INFO - PROCESS | 18209 | 12:13:15 INFO - PROCESS | 18209 | [#0] dojo.html Cycles:165 Average:5611.34 Median:5820.07 stddev:620.03 (10.7%) stddev-sans-first:594.27 12:13:15 INFO - PROCESS | 18209 | Values: 3277.0 3306.6 3311.9 3332.8 3361.4 5604.6 5710.1 5713.6 5718.5 5726.5 5678.4 5726.1 5739.1 5740.7 5745.1 5000.2 5064.5 5166.7 5176.4 5207.5 5122.2 5171.5 5177.0 5181.8 5198.9 5069.3 5131.5 5131.7 5156.8 5177.7 5215.6 5219.1 5225.3 5225.8 5252.6 4972.0 4990.7 5003.6 5092.9 5109.9 5508.5 5516.3 5522.7 5559.4 5571.4 6040.8 6042.8 6046.2 6050.2 6063.2 5820.5 5984.6 5991.5 6016.5 6068.4 5662.4 5678.3 5692.4 5699.3 5699.9 6191.5 6192.8 6192.8 6196.6 6214.3 5609.3 5738.4 5773.1 5844.9 5886.7 5940.5 5947.6 5969.1 5980.0 5980.9 5945.4 5993.2 5997.0 6002.2 6005.8 5760.1 5872.8 5966.8 5992.6 6073.2 4645.6 4672.9 4683.4 4684.5 4711.0 4165.4 4173.7 4175.5 4194.7 4212.6 5606.3 5660.0 5750.4 5814.2 5820.1 6085.6 6087.8 6108.3 6113.5 6127.7 5751.1 5752.2 5755.0 5756.2 5757.8 5076.6 5130.7 5192.4 5241.3 5245.6 6116.4 6193.3 6202.0 6202.4 6210.7 5951.0 5953.6 5981.3 5985.9 5988.4 6117.6 6194.1 6204.2 6213.4 6217.8 5903.2 5987.3 5988.7 6023.5 6030.3 6045.7 6088.6 6089.3 6089.8 6101.8 5693.3 5880.8 5902.6 5956.6 5960.9 5916.4 5999.2 6001.8 6006.4 6039.0 5895.4 5947.2 5952.7 5956.0 5958.0 5799.3 5872.9 6032.0 6070.0 6079.5 5775.8 5777.0 5829.7 5841.9 5859.6 12:13:15 INFO - PROCESS | 18209 | 12:13:15 INFO - PROCESS | 18209 | [#1] ext.html Cycles:180 Average:70953.21 Median:41965.48 stddev:148066.55 (352.8%) stddev-sans-first:148387.70 12:13:15 INFO - PROCESS | 18209 | Values: 599.9 632.8 641.3 651.1 653.5 35870.3 38953.2 39169.6 39334.4 39431.0 39312.6 40296.0 48497.0 49375.3 49381.8 9259.1 9387.6 9393.1 9396.2 9398.3 9181.8 9274.6 9275.8 9281.4 9283.0 8606.8 9315.1 11226.9 11505.1 11505.3 11186.6 11194.0 11262.9 11269.5 11271.7 11155.5 11232.3 11238.2 11242.6 11246.8 35889.8 46283.0 46530.5 46724.5 51029.0 3953.7 4014.2 4310.9 4382.7 4658.4 35667.5 35745.5 35772.3 35979.0 36361.6 4767.8 4838.6 4869.5 4876.9 4951.7 387367.0 387634.0 388370.0 389452.0 392091.0 66921.3 67502.3 67552.3 67558.7 67821.3 59333.0 60072.1 60296.1 63879.4 71144.3 19424.2 19530.0 19588.7 19603.9 19618.7 15100.9 15181.2 15219.5 15219.8 15221.3 17975.6 20419.9 20730.4 20861.7 20941.5 5515.3 6517.1 6550.3 6569.1 6612.0 957.8 1003.8 1029.9 1041.8 1086.2 33780.5 34302.5 34320.1 34350.7 34693.8 1102.4 1179.8 1195.3 1204.3 1217.0 18264.7 18400.4 18438.4 18565.2 18592.4 594859.0 596374.0 599281.0 602007.0 602771.0 59664.4 64990.0 65258.0 65657.0 66668.3 1431.0 1439.4 1444.6 1474.1 1480.9 34751.5 36964.8 37228.8 37270.8 37435.3 58237.1 58730.4 58804.0 58854.7 58925.7 529933.0 537128.0 540614.1 778015.0 780206.0 32166.2 32213.7 32294.8 32433.8 32566.7 54244.7 54408.0 54773.0 54776.0 55881.7 44524.8 46796.5 47400.3 47721.0 49093.8 45443.3 45741.8 46257.5 47029.5 48003.5 45347.3 45659.5 46307.5 46945.8 46993.8 38365.6 41632.4 41872.8 41874.6 42056.4 30090.6 30345.0 30498.7 30858.8 30939.0 12:13:15 INFO - PROCESS | 18209 | 12:13:15 INFO - PROCESS | 18209 | [#2] jquery.html Cycles:180 Average:32492.96 Median:11821.89 stddev:97603.17 (825.6%) stddev-sans-first:97847.22 12:13:15 INFO - PROCESS | 18209 | Values: 400.2 406.8 420.9 431.2 435.5 17514.4 20003.5 20261.2 20429.3 20907.1 20125.2 20177.2 20331.0 20470.5 20561.4 5527.3 5865.5 5903.5 5903.5 5907.9 4210.9 5843.4 5935.3 6259.8 6512.6 6652.2 6668.2 6675.3 6677.1 6677.7 6373.3 6586.8 6587.9 6611.1 6611.3 5403.6 5687.6 5874.7 5878.3 5878.5 14552.3 14723.7 14781.2 14809.6 14837.0 2401.3 2529.7 3005.7 3077.5 3161.6 14749.6 15358.6 15359.8 15455.4 15622.1 1921.2 1961.5 1978.8 1988.2 2022.6 81674.0 83941.0 84008.6 86099.1 88050.0 11095.7 11544.4 11690.4 11691.6 11797.4 16519.8 16531.7 16569.3 16592.4 16598.0 8723.2 9108.9 9127.5 9198.0 9264.1 8943.1 8996.8 9005.3 9166.2 9204.1 4916.0 5034.3 5044.5 5092.4 5150.6 2031.8 2065.8 2066.2 2103.9 2124.6 950.6 975.3 992.7 1038.6 1077.9 20202.0 20926.6 21026.5 21190.2 21242.5 1005.5 1022.6 1066.0 1089.6 1173.6 10784.8 11670.3 11762.0 11773.2 11866.8 514779.0 598053.0 616350.0 616460.1 621019.0 85074.0 86146.0 89373.6 93702.5 98428.0 1039.6 1040.4 1046.0 1063.3 1068.1 18316.3 18513.4 18724.6 18804.8 18947.1 39791.0 45265.3 45692.0 46336.5 46638.8 63110.7 63345.0 64387.0 64554.0 64593.4 8329.8 8850.2 8952.6 9021.8 9134.4 9632.9 12944.2 13723.9 13853.4 14054.2 11535.6 11638.3 11652.1 11969.7 12304.4 10908.3 11117.0 11355.7 11444.8 11949.5 11112.9 12059.2 12416.5 12438.3 12610.8 9115.7 9185.3 9222.5 9315.2 9370.0 11741.4 12338.2 12656.8 12669.4 12951.4 12:13:15 INFO - PROCESS | 18209 | 12:13:15 INFO - PROCESS | 18209 | [#3] mootools.html Cycles:180 Average:6399.81 Median:4377.46 stddev:3701.54 (84.6%) stddev-sans-first:3693.66 12:13:15 INFO - PROCESS | 18209 | Values: 1505.7 1559.8 1723.3 1861.5 1865.2 8551.1 9160.0 9287.1 10019.0 10020.8 9284.4 9713.3 9718.0 9726.8 9761.2 2489.1 2517.4 2517.5 2518.3 2518.7 2180.1 2410.4 2448.3 2472.6 2534.0 2529.6 2555.1 2556.6 2559.1 2561.0 2443.8 2479.3 2482.6 2482.9 2484.0 2455.7 2474.1 2483.4 2486.4 2487.3 9813.9 9872.4 9893.7 9905.7 9909.0 5623.8 5624.4 5638.4 5650.9 5759.2 3547.5 3636.5 3679.4 3706.8 3707.9 1266.9 1304.6 1304.6 1331.8 1336.4 13751.9 13813.9 13827.1 13860.8 13887.0 4904.4 4918.0 4935.7 5031.6 5108.7 11610.5 11611.5 11612.0 11619.6 11645.4 5778.3 5809.8 5810.0 5810.1 5819.3 5240.2 5305.3 5345.8 5345.9 5346.1 4288.1 4325.1 4335.2 4362.3 4392.6 1206.9 1232.8 1233.9 1234.7 1326.1 828.8 1017.2 1057.1 1063.0 1081.6 6261.3 6401.7 6435.5 6532.6 6648.9 1025.3 1025.8 1045.8 1046.5 1066.1 4322.6 4491.7 4492.5 4507.4 4610.1 12008.7 12277.3 12393.8 12393.9 12469.8 10714.6 12235.9 12242.1 12255.2 12265.3 8641.2 8895.3 9047.7 9073.4 9078.6 6377.3 6452.9 6549.8 6649.5 6682.9 10715.5 11166.7 11285.8 11446.4 11466.3 11561.5 11620.5 11702.9 11729.4 11729.9 9023.5 9034.5 9044.4 9058.3 9167.3 9161.0 9234.5 9236.7 9268.1 9273.0 8059.6 8149.3 8182.6 8246.4 8486.7 8067.8 8077.2 8124.1 8175.6 8275.1 7386.4 7676.7 7715.7 7757.3 7790.4 5533.7 5641.3 5757.6 5761.3 5835.8 5837.2 5854.6 5899.7 5985.0 6011.5 12:13:15 INFO - PROCESS | 18209 | 12:13:15 INFO - PROCESS | 18209 | [#4] prototype.html Cycles:180 Average:4896.86 Median:5469.86 stddev:1423.33 (26.0%) stddev-sans-first:1385.86 12:13:15 INFO - PROCESS | 18209 | Values: 353.1 358.9 363.0 365.8 367.0 5620.2 5692.5 5693.6 5696.4 5712.7 5415.7 5500.4 5500.8 5623.5 5635.6 4353.6 4380.9 4395.2 4408.8 4437.4 4385.3 4399.8 4408.5 4412.3 4438.5 4392.0 4396.6 4407.3 4418.0 4419.8 4305.4 4355.4 4356.4 4379.5 4392.5 3900.5 3900.6 3903.6 3926.2 3927.4 5428.0 5460.6 5464.1 5466.9 5472.8 4865.6 4978.2 5053.6 5054.6 5070.4 5743.1 5760.6 5760.7 5766.3 5781.9 4321.5 4330.6 4332.2 4332.7 4337.2 5663.2 5679.3 5878.2 5997.2 6132.8 4138.7 4140.3 4142.6 4157.6 4329.5 4400.4 4401.9 4404.6 4411.6 4413.4 4845.6 4944.6 5021.8 5033.1 5039.8 5760.9 5772.6 5798.9 5847.2 5851.5 1512.7 1530.5 1531.2 1534.2 1538.6 949.4 970.9 974.9 988.6 1004.4 5006.9 5022.5 5034.6 5053.8 5055.3 5254.4 5265.3 5273.6 5278.4 5295.2 5029.7 5047.9 5071.1 5330.5 5715.5 3166.8 3182.2 3184.5 3189.9 3203.1 6180.4 6221.3 6227.8 6235.2 6267.9 6069.5 6072.3 6074.9 6112.4 6116.9 6214.4 6221.6 6224.5 6228.4 6246.7 5826.1 5990.9 6011.4 6033.7 6118.5 5823.4 5939.5 5941.3 5961.8 6031.4 5962.3 6080.8 6190.6 6208.2 6255.7 4262.9 4308.8 4347.6 4359.9 4376.5 5850.3 5970.6 6100.3 6120.0 6126.5 5845.5 5851.5 5911.7 5912.2 5912.3 5859.7 5889.9 5922.8 5933.1 5938.5 5650.9 5762.0 5795.7 5836.8 5850.9 5859.4 5866.4 5919.3 5951.9 5984.1 5431.2 5768.8 5775.8 5797.7 5807.2 12:13:15 INFO - PROCESS | 18209 | 12:13:15 INFO - PROCESS | 18209 | [#5] yui.html Cycles:180 Average:21311.56 Median:4617.85 stddev:28591.14 (619.1%) stddev-sans-first:28629.88 12:13:15 INFO - PROCESS | 18209 | Values: 804.5 816.4 850.4 882.6 906.4 16909.7 17520.4 17601.6 17638.1 17692.1 16240.1 16391.1 16393.3 16410.8 16424.9 731.3 857.1 879.4 891.4 893.8 898.1 900.7 901.5 902.2 903.1 951.5 957.4 957.5 959.1 960.1 754.8 888.6 938.4 949.5 952.2 691.5 691.9 693.3 693.4 693.8 14931.3 14966.4 14968.9 15000.0 15008.9 14792.5 15762.4 15864.7 15958.4 16261.5 14368.3 14550.1 14796.1 14802.8 15037.5 4614.8 4620.9 4742.4 4770.6 4791.6 87192.9 87194.6 89189.6 89320.6 91478.0 12872.5 12966.2 12974.0 13058.7 13149.5 21449.7 22460.0 24321.9 24403.6 24412.4 9482.2 9739.3 9850.9 9869.5 10010.2 5125.7 5267.2 5309.8 5365.2 5405.6 4125.3 4283.9 4306.1 4331.6 4334.6 728.4 730.2 741.4 759.0 762.1 710.8 716.3 787.1 808.1 868.1 10618.3 11113.4 11189.2 11238.5 11361.3 653.1 763.1 785.6 807.3 808.3 5509.4 5566.7 5590.3 5604.0 5624.9 74751.0 98643.5 101901.5 103881.0 105552.5 85590.6 85839.0 91320.5 95305.0 102848.0 54834.7 76270.6 79861.0 81892.6 90423.0 10182.8 10808.3 11127.8 11147.2 11147.8 52968.5 55354.4 56038.4 56098.7 57573.1 74281.6 81270.2 82874.6 83888.0 84966.0 12795.1 13951.2 13965.7 14037.6 14063.2 16134.4 16317.1 16723.6 17065.2 17554.6 14290.1 14387.1 14598.6 15350.5 15410.6 14835.8 15154.1 15167.9 15236.6 15540.8 13883.7 14545.8 14629.6 14851.1 14881.3 11846.8 11891.7 12044.5 13043.5 13161.7 12980.0 12993.4 13330.5 13432.9 13662.8 12:13:15 INFO - PROCESS | 18209 | -------- Summary: end -------- 12:13:15 INFO - PROCESS | 18209 | 12:13:16 INFO - TEST-INFO | 18209: exit 0 12:13:16 INFO - TEST-OK | dromaeo_css | took 1113393ms 12:13:16 INFO - TEST-START | kraken 12:13:16 INFO - operating with platform_type : linux_ 12:13:16 INFO - Initialising browser for kraken test... 12:13:16 INFO - TEST-INFO | started process 18408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiH4oIk/profile http://localhost:54044/getInfo.html) 12:13:19 INFO - PROCESS | 18408 | __metrics Screen width/height:1600/1200 12:13:19 INFO - PROCESS | 18408 | colorDepth:24 12:13:19 INFO - PROCESS | 18408 | Browser inner width/height: 1024/697 12:13:19 INFO - PROCESS | 18408 | __metrics 12:13:20 INFO - PROCESS | 18408 | 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" 12:13:20 INFO - PROCESS | 18408 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:13:21 INFO - TEST-INFO | 18408: exit 0 12:13:21 INFO - Browser initialized. 12:13:21 INFO - Running cycle 1/1 for kraken test... 12:13:21 INFO - TEST-INFO | started process 18495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiH4oIk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:33 INFO - PROCESS | 18495 | RSS: Main: 144957440 12:13:33 INFO - PROCESS | 18495 | 12:13:35 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54044/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:36 INFO - PROCESS | 18495 | RSS: Main: 191799296 12:13:36 INFO - PROCESS | 18495 | 12:13:38 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54044/tests/kraken/driver.html?testName=audio-dft) 12:13:39 INFO - PROCESS | 18495 | RSS: Main: 180707328 12:13:39 INFO - PROCESS | 18495 | 12:13:42 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54044/tests/kraken/driver.html?testName=audio-fft) 12:13:42 INFO - PROCESS | 18495 | RSS: Main: 269312000 12:13:42 INFO - PROCESS | 18495 | 12:13:45 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54044/tests/kraken/driver.html?testName=audio-oscillator) 12:13:45 INFO - PROCESS | 18495 | RSS: Main: 175702016 12:13:45 INFO - PROCESS | 18495 | 12:13:47 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54044/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:13:48 INFO - PROCESS | 18495 | RSS: Main: 176640000 12:13:48 INFO - PROCESS | 18495 | 12:13:51 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54044/tests/kraken/driver.html?testName=imaging-darkroom) 12:13:51 INFO - PROCESS | 18495 | RSS: Main: 212590592 12:13:51 INFO - PROCESS | 18495 | 12:13:55 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54044/tests/kraken/driver.html?testName=imaging-desaturate) 12:13:55 INFO - PROCESS | 18495 | RSS: Main: 211861504 12:13:55 INFO - PROCESS | 18495 | 12:13:58 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54044/tests/kraken/driver.html?testName=json-parse-financial) 12:13:59 INFO - PROCESS | 18495 | RSS: Main: 211955712 12:13:59 INFO - PROCESS | 18495 | 12:14:00 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54044/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:14:01 INFO - PROCESS | 18495 | RSS: Main: 175857664 12:14:01 INFO - PROCESS | 18495 | 12:14:03 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:14:03 INFO - PROCESS | 18495 | RSS: Main: 182378496 12:14:03 INFO - PROCESS | 18495 | 12:14:05 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:14:06 INFO - PROCESS | 18495 | RSS: Main: 186642432 12:14:06 INFO - PROCESS | 18495 | 12:14:08 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:14:09 INFO - PROCESS | 18495 | RSS: Main: 181862400 12:14:09 INFO - PROCESS | 18495 | 12:14:12 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:12 INFO - PROCESS | 18495 | RSS: Main: 184692736 12:14:12 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54044/tests/kraken/driver.html?testName=ai-astar) 12:14:14 INFO - PROCESS | 18495 | RSS: Main: 235569152 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | __start_tp_report 12:14:14 INFO - PROCESS | 18495 | _x_x_mozilla_page_load 12:14:14 INFO - PROCESS | 18495 | _x_x_mozilla_page_load_details 12:14:14 INFO - PROCESS | 18495 | |i|pagename|runs| 12:14:14 INFO - PROCESS | 18495 | |0;ai-astar;100;110;109;109;111;109;109;109;108;109 12:14:14 INFO - PROCESS | 18495 | |1;audio-beat-detection;143;117;116;173;116;123;146;115;158;115 12:14:14 INFO - PROCESS | 18495 | |2;audio-dft;160;161;160;161;160;160;161;160;160;160 12:14:14 INFO - PROCESS | 18495 | |3;audio-fft;73;76;76;133;75;77;74;74;104;74 12:14:14 INFO - PROCESS | 18495 | |4;audio-oscillator;85;83;123;83;83;84;121;84;83;125 12:14:14 INFO - PROCESS | 18495 | |5;imaging-gaussian-blur;117;117;116;118;117;117;117;117;118;116 12:14:14 INFO - PROCESS | 18495 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;146;147 12:14:14 INFO - PROCESS | 18495 | |7;imaging-desaturate;95;95;95;96;96;96;95;96;95;94 12:14:14 INFO - PROCESS | 18495 | |8;json-parse-financial;52;49;51;49;50;50;51;51;50;49 12:14:14 INFO - PROCESS | 18495 | |9;json-stringify-tinderbox;60;60;60;59;60;59;60;59;58;59 12:14:14 INFO - PROCESS | 18495 | |10;stanford-crypto-aes;73;72;82;76;72;72;71;72;72;71 12:14:14 INFO - PROCESS | 18495 | |11;stanford-crypto-ccm;118;116;116;127;126;118;116;116;154;122 12:14:14 INFO - PROCESS | 18495 | |12;stanford-crypto-pbkdf2;161;155;153;151;155;153;155;152;152;151 12:14:14 INFO - PROCESS | 18495 | |13;stanford-crypto-sha256-iterative;60;62;64;61;60;63;61;64;64;64 12:14:14 INFO - PROCESS | 18495 | __end_tp_report 12:14:14 INFO - PROCESS | 18495 | __start_cc_report 12:14:14 INFO - PROCESS | 18495 | _x_x_mozilla_cycle_collect,1604 12:14:14 INFO - PROCESS | 18495 | __end_cc_report 12:14:14 INFO - PROCESS | 18495 | __startTimestamp1470078854585__endTimestamp 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | ------- Summary: start ------- 12:14:14 INFO - PROCESS | 18495 | Number of tests: 14 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:3.02 (2.8%) stddev-sans-first:0.83 12:14:14 INFO - PROCESS | 18495 | Values: 100.0 110.0 109.0 109.0 111.0 109.0 109.0 109.0 108.0 109.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:133.00 stddev:21.26 (16.0%) stddev-sans-first:22.19 12:14:14 INFO - PROCESS | 18495 | Values: 143.0 117.0 116.0 173.0 116.0 123.0 146.0 115.0 158.0 115.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 12:14:14 INFO - PROCESS | 18495 | Values: 160.0 161.0 160.0 161.0 160.0 160.0 161.0 160.0 160.0 160.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.50 stddev:19.66 (26.4%) stddev-sans-first:20.47 12:14:14 INFO - PROCESS | 18495 | Values: 73.0 76.0 76.0 133.0 75.0 77.0 74.0 74.0 104.0 74.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:83.00 stddev:19.08 (23.0%) stddev-sans-first:19.86 12:14:14 INFO - PROCESS | 18495 | Values: 85.0 83.0 123.0 83.0 83.0 84.0 121.0 84.0 83.0 125.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 12:14:14 INFO - PROCESS | 18495 | Values: 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 118.0 116.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 12:14:14 INFO - PROCESS | 18495 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 147.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:14:14 INFO - PROCESS | 18495 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 94.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.50 stddev:1.03 (2.0%) stddev-sans-first:0.87 12:14:14 INFO - PROCESS | 18495 | Values: 52.0 49.0 51.0 49.0 50.0 50.0 51.0 51.0 50.0 49.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 12:14:14 INFO - PROCESS | 18495 | Values: 60.0 60.0 60.0 59.0 60.0 59.0 60.0 59.0 58.0 59.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:72.00 stddev:3.37 (4.7%) stddev-sans-first:3.57 12:14:14 INFO - PROCESS | 18495 | Values: 73.0 72.0 82.0 76.0 72.0 72.0 71.0 72.0 72.0 71.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:120.00 stddev:11.70 (9.8%) stddev-sans-first:12.28 12:14:14 INFO - PROCESS | 18495 | Values: 118.0 116.0 116.0 127.0 126.0 118.0 116.0 116.0 154.0 122.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:154.00 stddev:2.97 (1.9%) stddev-sans-first:1.66 12:14:14 INFO - PROCESS | 18495 | Values: 161.0 155.0 153.0 151.0 155.0 153.0 155.0 152.0 152.0 151.0 12:14:14 INFO - PROCESS | 18495 | 12:14:14 INFO - PROCESS | 18495 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:63.50 stddev:1.70 (2.7%) stddev-sans-first:1.59 12:14:14 INFO - PROCESS | 18495 | Values: 60.0 62.0 64.0 61.0 60.0 63.0 61.0 64.0 64.0 64.0 12:14:14 INFO - PROCESS | 18495 | -------- Summary: end -------- 12:14:14 INFO - PROCESS | 18495 | 12:14:15 INFO - TEST-INFO | 18495: exit 0 12:14:15 INFO - TEST-OK | kraken | took 59527ms 12:14:15 INFO - SUITE-END | took 1172s 12:14:15 INFO - Completed test suite (00:19:33) 12:14:15 INFO - javascript benchmark 12:14:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.0, 3306.6032076150864, 3311.917202069949, 3332.7500437467165, 3361.44536151535, 5604.5796565257615, 5710.057840456319, 5713.571482138836, 5718.485336319725, 5726.484616384525, 5678.43215678433, 5726.083826587746, 5739.110437882135, 5740.741666625001, 5745.080787074069, 5000.174971129777, 5064.468230835764, 5166.715830629314, 5176.352955880515, 5207.505286997729, 5122.206058060988, 5171.482851714836, 5177.042247184264, 5181.766820493087, 5198.870028249286, 5069.290299358093, 5131.461196574343, 5131.692098474104, 5156.793728250866, 5177.663451875616, 5215.608829337777, 5219.086659834533, 5225.268462415265, 5225.843224703265, 5252.606054545924, 4972.005598880239, 4990.675606085629, 5003.5997120230295, 5092.949070509321, 5109.897802043975, 5508.476694713996, 5516.255305533742, 5522.696251706155, 5559.360673522557, 5571.415001424833, 6040.8187754367, 6042.8187154385, 6046.244219472566, 6050.152978583002, 6063.151158837766, 5820.476157145835, 5984.611000284967, 5991.460768530809, 6016.458518733335, 6068.423499767515, 5662.405447428002, 5678.318601767773, 5692.430756924357, 5699.259096317535, 5699.8860022800145, 6191.535634827406, 6192.752289908353, 6192.783252586138, 6196.597221180609, 6214.316425193225, 5609.27079479665, 5738.426157384228, 5773.134029895549, 5844.88310233793, 5886.735096920649, 5940.46535811779, 5947.583669143119, 5969.074793407029, 5980.0, 5980.850478738066, 5945.3757355477055, 5993.220881285405, 5997.0, 6002.189704389939, 6005.819825405245, 5760.107183386582, 5872.765089396462, 5966.76132954677, 5992.580519363602, 6073.240844894388, 4645.628349732014, 4672.859814205579, 4683.437987441461, 4684.508126646653, 4711.010687755541, 4165.375193720966, 4173.707840451139, 4175.478065241845, 4194.727342722775, 4212.599803018769, 5606.327240731057, 5659.971700141556, 5750.367459579443, 5814.215080964016, 5820.068788993741, 6085.6348619083, 6087.756489740449, 6108.3280839107665, 6113.480354169857, 6127.662978536134, 5751.1373294006235, 5752.194692743019, 5755.0, 5756.222909907109, 5757.769689212469, 5076.6446348755235, 5130.692158470429, 5192.394546546439, 5241.344831896013, 5245.606579506552, 6116.388361163937, 6193.287771906198, 6201.968990155201, 6202.379762023852, 6210.658413787195, 5951.018082016419, 5953.553483488669, 5981.282246130492, 5985.880282394415, 5988.431099045583, 6117.632942023492, 6194.101855230876, 6204.224471941007, 6213.409726076015, 6217.751289948352, 5903.2325797647745, 5987.251593550806, 5988.6706231157705, 6023.48800351975, 6030.276366836008, 6045.667488288011, 6088.573799833969, 6089.2997305310455, 6089.756409743561, 6101.7559297627595, 5693.28833895763, 5880.794172204123, 5902.586818922806, 5956.612820166675, 5960.850978725566, 5916.378780228014, 5999.160117583455, 6001.849953751016, 6006.369331220334, 6038.969805150946, 5895.351511333664, 5947.197128387612, 5952.702364881825, 5956.0, 5957.987142185752, 5799.2750906136735, 5872.94127058741, 6031.969840150771, 6069.969650151721, 6079.483243924139, 5775.768969241183, 5776.971115144397, 5829.679367634821, 5841.912371314519, 5859.619124756877], "value": 5570.775140345332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8650303681669, 632.829136133244, 641.2721561028235, 651.1437459740441, 653.506602515101, 35870.2825943481, 38953.220935581274, 39169.60830391695, 39334.409983850266, 39431.0, 39312.606873931254, 40296.0, 48497.0, 49375.25937110946, 49381.753091234496, 9259.074092590721, 9387.57755900986, 9393.06069393062, 9396.248300135972, 9398.34211605188, 9181.816363672757, 9274.629014839398, 9275.768105797375, 9281.396709213914, 9282.953585232099, 8606.827863442728, 9315.068493150698, 11226.943865280662, 11505.137114716388, 11505.252158609705, 11186.552537898475, 11194.0, 11262.943685281522, 11269.492872820743, 11271.718207044807, 11155.498002589902, 11232.3260604364, 11238.157138214667, 11242.606508772154, 11246.775064498746, 35889.82055089708, 46283.0, 46530.53469465296, 46724.53275467236, 51029.0, 3953.723239373216, 4014.2372949139863, 4310.870673879788, 4382.671299652538, 4658.440987081572, 35667.464988025204, 35745.46381804275, 35772.28455430903, 35979.0, 36361.63638363609, 4767.833125840613, 4838.588719958808, 4869.5130486951375, 4876.853694389174, 4951.678140920829, 387366.9999999972, 387634.0, 388370.0, 389452.0, 392090.99999999715, 66921.33078669249, 67502.29990800313, 67552.32447675559, 67558.66220668964, 67821.3217867815, 59333.0, 60072.098918516254, 60296.09555856666, 63879.36120638827, 71144.2885571148, 19424.22303107888, 19530.0, 19588.70616940747, 19603.901980490005, 19618.70571941422, 15100.924495377452, 15181.16503592313, 15219.467318643794, 15219.771703424458, 15221.31504082319, 17975.55061123456, 20419.8979005104, 20730.378088657366, 20861.68707469389, 20941.476463088544, 5515.338159420895, 6517.087607734921, 6550.2794692583775, 6569.146011018537, 6612.0, 957.818014577228, 1003.7590978165188, 1029.8845990877505, 1041.8280983637767, 1086.179934149712, 33780.49329260063, 34302.485462718076, 34320.14199644979, 34350.65649343475, 34693.82653086718, 1102.404701461218, 1179.7876382251277, 1195.3306148556835, 1204.2834513464475, 1217.0020583121932, 18264.726029109574, 18400.447986560426, 18438.35465758692, 18565.16456759449, 18592.44222673322, 594859.0, 596374.0, 599281.0, 602007.0, 602771.0, 59664.40335596675, 64990.0, 65258.0, 65656.99999999904, 66668.33331666718, 1430.9713805723827, 1439.3522914688224, 1444.59551325629, 1474.078700811971, 1480.9333579988927, 34751.47872781961, 36964.81517592395, 37228.81385593163, 37270.813645931594, 37435.2512949734, 58237.12644310424, 58730.412695872496, 58804.0, 58854.7057264711, 58925.70537147287, 529933.0, 537128.0, 540614.0785072504, 778015.0, 780206.0, 32166.19584510406, 32213.677863221066, 32294.83852580722, 32433.837830810695, 32566.674333256364, 54244.72877635586, 54408.0, 54773.0, 54776.0, 55881.720591396785, 44524.777376112914, 46796.532034679214, 47400.2889956644, 47721.0, 49093.75453122712, 45443.31835022543, 45741.771291143334, 46257.537424626666, 47029.529704703884, 48003.5199647999, 45347.31979020251, 45659.54340456553, 46307.53692463032, 46945.765271174794, 46993.76503117599, 38365.616343836205, 41632.375514367915, 41872.79063604662, 41874.581254188284, 42056.369154462096, 30090.627796190074, 30345.0, 30498.695013049586, 30858.845705771328, 30939.0], "value": 22320.10718572622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.19560683027106, 406.82303198108843, 420.8674267605704, 431.18075656253126, 435.54920657119885, 17514.386996455127, 20003.499912502157, 20261.189552417905, 20429.284975025876, 20907.059182336794, 20125.194992200293, 20177.19291228349, 20331.0, 20470.488237794063, 20561.38315850527, 5527.2538207342095, 5865.530757539386, 5903.4686878180955, 5903.527717782588, 5907.940920590803, 4210.852620158295, 5843.386444423317, 5935.317438494563, 6259.843503912393, 6512.609243445385, 6652.2349929757975, 6668.199816022084, 6675.299093595151, 6677.098591690133, 6677.66611669417, 6373.298937116913, 6586.769463068769, 6587.901181482282, 6611.140551728293, 6611.272759996396, 5403.648762830403, 5687.573431992617, 5874.73563689635, 5878.265216847894, 5878.5297176225795, 14552.272386380639, 14723.705525889529, 14781.187034713086, 14809.555713328617, 14837.0, 2401.30362194965, 2529.696436427622, 3005.654349749785, 3077.476828939086, 3161.636411812625, 14749.631259218499, 15358.616034599112, 15359.846401535953, 15455.381784728597, 15622.14078225697, 1921.2219051284253, 1961.5194277401986, 1978.8317992970615, 1988.2444671025062, 2022.5853699991615, 81674.0, 83940.99999999939, 84008.57995710043, 86099.13900860974, 88050.0, 11095.667129986114, 11544.365059921616, 11690.415479226005, 11691.590794322328, 11797.410129493492, 16519.83480165183, 16531.6693666126, 16569.25438355277, 16592.419265325654, 16598.0, 8723.16272642019, 9108.908910910939, 9127.543622818832, 9198.0, 9264.073592640816, 8943.105689431004, 8996.82006359869, 9005.324600654845, 9166.175044245916, 9204.125608067223, 4916.0, 5034.34553508049, 5044.498583006045, 5092.363454568179, 5150.609335479399, 2031.7765045844944, 2065.824404925568, 2066.1528773202913, 2103.9263625773024, 2124.585705787357, 950.5532399772096, 975.2831668723483, 992.6575331510618, 1038.6416686243233, 1077.8922107789158, 20202.0, 20926.581468370547, 21026.47433814167, 21190.15239390438, 21242.468938276357, 1005.5274021210166, 1022.601185537641, 1065.9893401066045, 1089.6186334782763, 1173.6303064534645, 10784.838227426595, 11670.299782012937, 11762.0, 11773.234739741889, 11866.821997670042, 514779.0, 598053.0, 616350.0, 616460.1070876817, 621019.0, 85074.0, 86146.0, 89373.55313223392, 93702.53148734213, 98428.0, 1039.5737747523478, 1040.3965699894195, 1045.9529321180564, 1063.3194755356578, 1068.1188019883627, 18316.26734930588, 18513.44459666212, 18724.625507490047, 18804.811951880307, 18947.0526473673, 39791.0, 45265.32102018538, 45692.0, 46336.53663463322, 46638.76680616575, 63110.68444657747, 63345.0, 64387.0, 64554.0, 64593.35406646061, 8329.833403331779, 8850.247728942855, 8952.597133128895, 9021.819563608822, 9134.360594758304, 9632.90367096348, 12944.223346599234, 13723.862761372258, 13853.37659805291, 14054.227017514135, 11535.596254131066, 11638.301701897914, 11652.126090543074, 11969.700757481132, 12304.384780760747, 10908.34549927007, 11116.999470047735, 11355.716107097389, 11444.82832757526, 11949.522019119138, 11112.944435278096, 12059.15585908978, 12416.503339866666, 12438.253704777742, 12610.810837837624, 9115.680951166678, 9185.265178785547, 9222.538873056454, 9315.208207302456, 9370.0, 11741.354225517336, 12338.198017128858, 12656.810147847606, 12669.429875655433, 12951.352432378155], "value": 9765.401908913229, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.6913332766783, 1559.7660350947356, 1723.3192888808921, 1861.5067007243092, 1865.1513561329596, 8551.144885511461, 9159.954200228989, 9287.117723816235, 10019.0, 10020.799584008324, 9284.442933424, 9713.32006759527, 9717.951410242957, 9726.756831079227, 9761.219102471803, 2489.0914816092086, 2517.3832411059316, 2517.471331020488, 2518.282289547479, 2518.7355327690602, 2180.149741600777, 2410.421498840283, 2448.338948483908, 2472.554940110779, 2533.961990570143, 2529.5699731045765, 2555.080171138389, 2556.590945448719, 2559.0659409315654, 2560.9743902561017, 2443.8289319747623, 2479.3305807431893, 2482.565551028563, 2482.900683972648, 2483.950320993588, 2455.656208130863, 2474.134053081425, 2483.379155211197, 2486.353548077495, 2487.2662564543502, 9813.852792208123, 9872.40765554069, 9893.653722119763, 9905.702828915144, 9909.0, 5623.831285061455, 5624.3531993820825, 5638.407967163471, 5650.858728531778, 5759.1937128802, 3547.5388199534154, 3636.5090712753704, 3679.411294192916, 3706.777593344381, 3707.8887633370773, 1266.8986481081492, 1304.5825335892519, 1304.6412236634906, 1331.7669407853587, 1336.411978729356, 13751.931240343734, 13813.861861381358, 13827.101238419471, 13860.792088118686, 13887.027908046543, 4904.411470623548, 4917.967226882323, 4935.728534930541, 5031.622628302819, 5108.693478391308, 11610.477528511237, 11611.477483513263, 11612.0, 11619.593314233962, 11645.417729113511, 5778.27771528559, 5809.796657116981, 5810.041343178413, 5810.099434587646, 5819.330776960619, 5240.213967904769, 5305.31030965972, 5345.786168553214, 5345.946540534623, 5346.064438723208, 4288.120935208337, 4325.113351762881, 4335.154644844288, 4362.345648152803, 4392.582704643054, 1206.8551773787026, 1232.7534493101416, 1233.8519377674556, 1234.740704452075, 1326.1380102933172, 828.842519921213, 1017.2014968249888, 1057.1225882517492, 1062.9946850265853, 1081.5998080710187, 6261.311255761862, 6401.743930242831, 6435.452986496107, 6532.640704761284, 6648.933510664928, 1025.3181634213313, 1025.8409946458312, 1045.7542477517777, 1046.4924511611862, 1066.088494337346, 4322.632576231055, 4491.708038977456, 4492.528284530143, 4507.414036175276, 4610.101030299126, 12008.699782505333, 12277.324747138815, 12393.752124957451, 12393.876061239453, 12469.75060498785, 10714.571417143226, 12235.938820306019, 12242.081843861746, 12255.203411778206, 12265.325407102695, 8641.179087986631, 8895.332850036144, 9047.68333108338, 9073.410228335137, 9078.636854525877, 6377.330380310001, 6452.935470645233, 6549.836254093686, 6649.534532582673, 6682.9331706682315, 10715.517801699098, 11166.720831979266, 11285.830712539482, 11446.370449625017, 11466.31202127875, 11561.537538498365, 11620.5351785931, 11702.88297117018, 11729.35488548138, 11729.941350293195, 9023.548822558714, 9034.503102329172, 9044.366894317598, 9058.275337973078, 9167.312451566026, 9161.03809100035, 9234.492102934402, 9236.72289831306, 9268.119528644767, 9273.0, 8059.637316320663, 8149.307308878811, 8182.631781569963, 8246.38152138604, 8486.702965396182, 8067.83864322722, 8077.232662897015, 8124.065732440845, 8175.632096555551, 8275.08974012846, 7386.372158366384, 7676.731314403969, 7715.652795624098, 7757.301842834172, 7790.376769858284, 5533.695646739468, 5641.294838145232, 5757.568182386254, 5761.251037365283, 5835.824925252249, 5837.211976383134, 5854.648721076749, 5899.652260307998, 5985.042393217064, 6011.549133814894], "value": 5081.826989265266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.0837476747839, 358.9479525468806, 363.0451911472827, 365.83171740999137, 366.96513831186047, 5620.156976453534, 5692.5161361284345, 5693.601447898649, 5696.37339892612, 5712.742926568304, 5415.65284889015, 5500.4499550044975, 5500.752466139023, 5623.465770751783, 5635.5773317001285, 4353.586409291112, 4380.934285985721, 4395.1649186654595, 4408.779561021952, 4437.35658329542, 4385.254506733863, 4399.824007039714, 4408.493023302329, 4412.271975124117, 4438.467383913935, 4392.0, 4396.6043056124945, 4407.338899165119, 4418.0, 4419.779011049451, 4305.406999410207, 4355.386767939242, 4356.4336636237085, 4379.4525684289465, 4392.5367318855815, 3900.5124359455067, 3900.64894159527, 3903.609639036102, 3926.2147570486018, 3927.410888366739, 5428.0, 5460.590455715797, 5464.12573988164, 5466.945330546683, 5472.768627058919, 4865.610751139936, 4978.207845175734, 5053.620978426633, 5054.620903432257, 5070.366204224472, 5743.10981797822, 5760.588655779319, 5760.654360738369, 5766.336871259775, 5781.884362312772, 4321.459817522809, 4330.5669433056755, 4332.241857674926, 4332.7400355978425, 4337.154254920292, 5663.178839068353, 5679.346875109332, 5878.177055212316, 5997.190379298782, 6132.78535251264, 4138.689598280081, 4140.3375459926265, 4142.627163555295, 4157.605027522381, 4329.523752387235, 4400.427944367212, 4401.899525118721, 4404.6256068233915, 4411.647068234533, 4413.44831896013, 4845.6123510119105, 4944.629152813553, 5021.824236151717, 5033.0688822567945, 5039.823606173766, 5760.913586296209, 5772.5959182856795, 5798.9130163047585, 5847.1581451843385, 5851.502622277154, 1512.7066358263526, 1530.5255370835077, 1531.157863175249, 1534.1638806850294, 1538.5768913548864, 949.368669834566, 970.9174720148725, 974.9220062395133, 988.6440881282732, 1004.4124187350336, 5006.872079366328, 5022.497750225021, 5034.622403319766, 5053.84838454847, 5055.317532133188, 5254.4220135785035, 5265.288376486113, 5273.551748101378, 5278.419373868871, 5295.205719142083, 5029.748512574357, 5047.87380315495, 5071.072992262916, 5330.466953304716, 5715.514181294553, 3166.794158379698, 3182.156728466958, 3184.497053241416, 3189.872405103816, 3203.0711093782543, 6180.351063138396, 6221.2845522764555, 6227.813165605039, 6235.220597425322, 6267.871783078998, 6069.514438844882, 6072.271327440647, 6074.9392506075255, 6112.388761123852, 6116.908246376308, 6214.378562143749, 6221.564490485713, 6224.533160012927, 6228.408301211378, 6246.718897649616, 5826.135636596248, 5990.940090599212, 6011.398860113954, 6033.668148251888, 6118.510519158545, 5823.388544202798, 5939.46544810969, 5941.287045554388, 5961.821145365646, 6031.396860313934, 5962.344142144448, 6080.787172448943, 6190.597611155261, 6208.2239720034995, 6255.655034167676, 4262.89164817156, 4308.784560772012, 4347.630451411539, 4359.934600980924, 4376.49670287921, 5850.268716410449, 5970.611910225822, 6100.328963813889, 6120.0, 6126.5098792097415, 5845.473907348359, 5851.502622276984, 5911.733971971357, 5912.172295878667, 5912.320083190316, 5859.677717725566, 5889.882202356014, 5922.763089476372, 5933.080372542263, 5938.524918006636, 5650.85872853182, 5762.0, 5795.710214489343, 5836.766529338779, 5850.893678275732, 5859.355470898283, 5866.413358664099, 5919.260092488439, 5951.880962380642, 5984.1323008164445, 5431.158170483582, 5768.798092066758, 5775.826725198251, 5797.681127538026, 5807.245058142415], "value": 4447.539326211734, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.4650307545483, 816.4325793573469, 850.4344610833796, 882.6292956958081, 906.3700727994038, 16909.661806763874, 17520.38678646246, 17601.64796704065, 17638.118094095276, 17692.115394230284, 16240.106794126319, 16391.0984895831, 16393.262303196356, 16410.753838692428, 16424.917875410607, 731.3381389842201, 857.0829212742368, 879.4327658660177, 891.4116682989228, 893.8435773739602, 898.1467605774508, 900.7432881628737, 901.4501154295874, 902.2060586683742, 903.1104362203224, 951.5289931483925, 957.4064080270242, 957.4877440569297, 959.0888655777005, 960.0975083421562, 754.8150703077754, 888.5779254853925, 938.3619138985521, 949.4635530925005, 952.1763674421645, 691.5228492340319, 691.94810389221, 693.3413257405434, 693.3932808792307, 693.7814588404636, 14931.2534373282, 14966.401343946229, 14968.850311496963, 15000.0, 15008.924955375262, 14792.482263120846, 15762.448314309058, 15864.682706345808, 15958.361665533364, 16261.51215463538, 14368.281585920662, 14550.12699238049, 14796.112233266038, 14802.777958330633, 15037.548873533811, 4614.769261536943, 4620.930686039712, 4742.383490146259, 4770.594499467549, 4791.640626952958, 87192.90116536892, 87194.5640271801, 89189.55405222997, 89320.55339723325, 91478.0, 12872.485100595872, 12966.22202667824, 12974.0, 13058.738825223443, 13149.539766108332, 21449.67825482619, 22460.0, 24321.878390608286, 24403.63394549083, 24412.389690257885, 9482.194013508792, 9739.26955478342, 9850.901490985141, 9869.457179855177, 10010.199184065257, 5125.718085505258, 5267.169527429663, 5309.761060752276, 5365.222042803772, 5405.648632838853, 4125.257453658371, 4283.935740963888, 4306.074194048295, 4331.5884990925815, 4334.566543345641, 728.3735987051132, 730.2113717185428, 741.388354607451, 758.9544627322379, 762.1387831750197, 710.7903168565182, 716.3409663109951, 787.1027029186731, 808.0505406147753, 868.079835374505, 10618.309809862334, 11113.388763618079, 11189.160812939062, 11238.494267757971, 11361.261518001304, 653.0595941843729, 763.091920614467, 785.5914924239363, 807.3339494916718, 808.2887059387701, 5509.449055094458, 5566.693831839207, 5590.329160500766, 5604.019296623074, 5624.887502249932, 74751.0, 98643.50678246563, 101901.49049254855, 103881.0, 105552.47223763986, 85590.57204713937, 85839.0, 91320.54339728258, 95305.0, 102848.0, 54834.72582637141, 76270.61864690641, 79861.0, 81892.59053704812, 90423.0, 10182.847257290998, 10808.297460665031, 11127.801597644204, 11147.219694621299, 11147.777044459228, 52968.4703152979, 55354.446455534926, 56038.439615603325, 56098.71950640221, 57573.136402953154, 74281.6285918567, 81270.18729812863, 82874.58562707389, 83888.0, 84966.0, 12795.065044897, 13951.150569312827, 13965.650858728613, 14037.578872633838, 14063.226522540948, 16134.38366098105, 16317.102559358875, 16723.581910452336, 17065.232064556876, 17554.648907022045, 14290.142591444546, 14387.136771793726, 14598.562043138723, 15350.462733804263, 15410.614734631725, 14835.777463337843, 15154.090754554762, 15167.924160379127, 15236.619084522532, 15540.84459155394, 13883.722325553634, 14545.78181327302, 14629.63425914318, 14851.108933464027, 14881.25593720288, 11846.822297665369, 11891.702707432383, 12044.51821927113, 13043.478260869459, 13161.670958226121, 12980.0, 12993.440787105608, 13330.466781328638, 13432.932835335761, 13662.795058073938], "value": 8307.30529489735, "unit": "score"}], "name": "dromaeo_css", "value": 7816.115325882891, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 109.0, 109.0, 111.0, 109.0, 109.0, 109.0, 108.0, 109.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 116.0, 173.0, 116.0, 123.0, 146.0, 115.0, 158.0, 115.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 76.0, 133.0, 75.0, 77.0, 74.0, 74.0, 104.0, 74.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 123.0, 83.0, 83.0, 84.0, 121.0, 84.0, 83.0, 125.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 51.0, 49.0, 50.0, 50.0, 51.0, 51.0, 50.0, 49.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 58.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 82.0, 76.0, 72.0, 72.0, 71.0, 72.0, 72.0, 71.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 116.0, 127.0, 126.0, 118.0, 116.0, 116.0, 154.0, 122.0], "value": 122.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 153.0, 151.0, 155.0, 153.0, 155.0, 152.0, 152.0, 151.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 64.0, 61.0, 60.0, 63.0, 61.0, 64.0, 64.0, 64.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1460.0, "alertThreshold": 2.0}]} 12:14:15 INFO - Return code: 0 12:14:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:14:15 INFO - # TBPL SUCCESS # 12:14:15 INFO - Running post-action listener: _resource_record_post_action 12:14:15 INFO - [mozharness: 2016-08-01 19:14:15.903286Z] Finished run-tests step (success) 12:14:15 INFO - Running post-run listener: _resource_record_post_run 12:14:15 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504455168; Read time: 12; Write time: 389940 12:14:15 INFO - TinderboxPrint: CPU usage
13.0% 12:14:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:14:15 INFO - TinderboxPrint: I/O write bytes / time
504,455,168 / 389,940 12:14:15 INFO - TinderboxPrint: CPU idle
8,258.4 (87.0%) 12:14:15 INFO - TinderboxPrint: CPU user
1,187.2 (12.5%) 12:14:15 INFO - TinderboxPrint: Swap in / out
0 / 0 12:14:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 255123456; Read time: 0; Write time: 227736 12:14:15 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 249049088; Read time: 0; Write time: 162180 12:14:16 INFO - Running post-run listener: _upload_blobber_files 12:14:16 INFO - Blob upload gear active. 12:14:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:14:16 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 12:14:16 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'] 12:14:16 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 12:14:16 INFO - (blobuploader) - INFO - Open directory for files ... 12:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:14:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:17 INFO - (blobuploader) - INFO - Done attempting. 12:14:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:14:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:14:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:23 INFO - (blobuploader) - INFO - Done attempting. 12:14:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:14:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:14:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:24 INFO - (blobuploader) - INFO - Done attempting. 12:14:24 INFO - (blobuploader) - INFO - Iteration through files over. 12:14:24 INFO - Return code: 0 12:14:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:14:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:14:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/263c872490fb0ba4b80bde8791ef1f279947997027dc594849c3f1a003b8f643e40ab1b9420d53e9a10ee83eaf9eb9db2a80fb7360a88d78fab57c9568226abb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc7efb93f57a39da3bb031b24fecaf5192c5e6eb9039877ad6ce20431863d56ad8cb51bcae3267ba718c89657076ddad51345613c4c72fedd555c67ed256b410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77fd662dd11610448bd8c0ef2ca89a61bf78e73dccf760faec0b765f2854152060d6574ca2ac69a28ecc479de5ebd2cedc93492d94927d35bd159d5abb9993e5"} 12:14:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:14:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:14:24 INFO - Contents: 12:14:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/263c872490fb0ba4b80bde8791ef1f279947997027dc594849c3f1a003b8f643e40ab1b9420d53e9a10ee83eaf9eb9db2a80fb7360a88d78fab57c9568226abb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc7efb93f57a39da3bb031b24fecaf5192c5e6eb9039877ad6ce20431863d56ad8cb51bcae3267ba718c89657076ddad51345613c4c72fedd555c67ed256b410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77fd662dd11610448bd8c0ef2ca89a61bf78e73dccf760faec0b765f2854152060d6574ca2ac69a28ecc479de5ebd2cedc93492d94927d35bd159d5abb9993e5"} 12:14:24 INFO - Running post-run listener: copy_logs_to_upload_dir 12:14:24 INFO - Copying logs to upload dir... 12:14:24 INFO - mkdir: /builds/slave/test/build/upload/logs 12:14:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.232045 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-01 12:14:23.786401) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 12:14:23.789634) ========= 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=923d835db2ba3686ebe126b700000192-1470077633.144593-957521591 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/263c872490fb0ba4b80bde8791ef1f279947997027dc594849c3f1a003b8f643e40ab1b9420d53e9a10ee83eaf9eb9db2a80fb7360a88d78fab57c9568226abb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc7efb93f57a39da3bb031b24fecaf5192c5e6eb9039877ad6ce20431863d56ad8cb51bcae3267ba718c89657076ddad51345613c4c72fedd555c67ed256b410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77fd662dd11610448bd8c0ef2ca89a61bf78e73dccf760faec0b765f2854152060d6574ca2ac69a28ecc479de5ebd2cedc93492d94927d35bd159d5abb9993e5"} build_url:https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/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/263c872490fb0ba4b80bde8791ef1f279947997027dc594849c3f1a003b8f643e40ab1b9420d53e9a10ee83eaf9eb9db2a80fb7360a88d78fab57c9568226abb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc7efb93f57a39da3bb031b24fecaf5192c5e6eb9039877ad6ce20431863d56ad8cb51bcae3267ba718c89657076ddad51345613c4c72fedd555c67ed256b410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77fd662dd11610448bd8c0ef2ca89a61bf78e73dccf760faec0b765f2854152060d6574ca2ac69a28ecc479de5ebd2cedc93492d94927d35bd159d5abb9993e5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 12:14:23.814623) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 12:14:23.815085) ========= 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=923d835db2ba3686ebe126b700000192-1470077633.144593-957521591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 12:14:23.898984) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 12:14:23.899305) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 12:14:23.899586) ========= ========= Total master_lag: 0.16 =========