builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1466975261.3 results: success (0) buildid: 20160626113029 builduid: 173de99de5aa488881d329b8417b0487 revision: d490ad95a673b042d48e01331b9ae70683457da9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:41.304146) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:41.304584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:41.304876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:41.371615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:41.371885) ========= 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=0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-26 14:07:41-- 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% 228M=0s 2016-06-26 14:07:41 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181079 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:41.604598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:41.604875) ========= 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=0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.057791 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:41.674784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:41.675166) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d490ad95a673b042d48e01331b9ae70683457da9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d490ad95a673b042d48e01331b9ae70683457da9 --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=0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-26 14:07:41,738 truncating revision to first 12 chars 2016-06-26 14:07:41,739 Setting DEBUG logging. 2016-06-26 14:07:41,739 attempt 1/10 2016-06-26 14:07:41,739 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d490ad95a673?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-26 14:07:42,049 unpacking tar archive at: fx-team-d490ad95a673/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627760 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:42.318527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:42.318801) ========= script_repo_revision: d490ad95a673b042d48e01331b9ae70683457da9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:42.319162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:42.319432) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 14:07:42.329864) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-26 14:07:42.330163) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:42 INFO - MultiFileLogger online at 20160626 14:07:42 in /builds/slave/test 14:07:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:07:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:42 INFO - {'append_to_log': False, 14:07:42 INFO - 'base_work_dir': '/builds/slave/test', 14:07:42 INFO - 'blob_upload_branch': 'Fx-Team', 14:07:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:42 INFO - 'branch': 'Fx-Team', 14:07:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:42 INFO - 'config_files': ('talos/linux_config.py',), 14:07:42 INFO - 'default_actions': ('clobber', 14:07:42 INFO - 'read-buildbot-config', 14:07:42 INFO - 'download-and-extract', 14:07:42 INFO - 'populate-webroot', 14:07:42 INFO - 'create-virtualenv', 14:07:42 INFO - 'install', 14:07:42 INFO - 'run-tests'), 14:07:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:42 INFO - 'download_minidump_stackwalk': True, 14:07:42 INFO - 'download_symbols': 'ondemand', 14:07:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:42 INFO - 'installer_path': 'installer.exe', 14:07:42 INFO - 'log_level': 'info', 14:07:42 INFO - 'log_name': 'talos', 14:07:42 INFO - 'log_to_console': True, 14:07:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:42 INFO - 'opt_config_files': (), 14:07:42 INFO - 'pip_index': False, 14:07:42 INFO - 'sps_profile': False, 14:07:42 INFO - 'sps_profile_interval': 0, 14:07:42 INFO - 'suite': 'dromaeojs-e10s', 14:07:42 INFO - 'system_bits': '32', 14:07:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:42 INFO - 'title': 'talos-linux64-ix-058', 14:07:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:42 INFO - 'use_talos_json': True, 14:07:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:42 INFO - 'work_dir': 'build'} 14:07:42 INFO - ##### 14:07:42 INFO - ##### Running clobber step. 14:07:42 INFO - ##### 14:07:42 INFO - Running pre-action listener: _resource_record_pre_action 14:07:42 INFO - Running main action method: clobber 14:07:42 INFO - rmtree: /builds/slave/test/build 14:07:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:44 INFO - Running post-action listener: _resource_record_post_action 14:07:44 INFO - ##### 14:07:44 INFO - ##### Finished clobber step (success) 14:07:44 INFO - ##### 14:07:44 INFO - ##### 14:07:44 INFO - ##### Running read-buildbot-config step. 14:07:44 INFO - ##### 14:07:44 INFO - Running pre-action listener: _resource_record_pre_action 14:07:44 INFO - Running main action method: read_buildbot_config 14:07:44 INFO - Using buildbot properties: 14:07:44 INFO - { 14:07:44 INFO - "project": "", 14:07:44 INFO - "product": "firefox", 14:07:44 INFO - "script_repo_revision": "production", 14:07:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:07:44 INFO - "repository": "", 14:07:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:07:44 INFO - "buildid": "20160626113029", 14:07:44 INFO - "pgo_build": "True", 14:07:44 INFO - "basedir": "/builds/slave/test", 14:07:44 INFO - "buildnumber": 866, 14:07:44 INFO - "slavename": "talos-linux64-ix-058", 14:07:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:07:44 INFO - "platform": "ubuntu64_hw", 14:07:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:07:44 INFO - "branch": "fx-team", 14:07:44 INFO - "repo_path": "integration/fx-team", 14:07:44 INFO - "revision": "d490ad95a673b042d48e01331b9ae70683457da9", 14:07:44 INFO - "stage_platform": "linux64-pgo", 14:07:44 INFO - "builduid": "173de99de5aa488881d329b8417b0487", 14:07:44 INFO - "slavebuilddir": "test" 14:07:44 INFO - } 14:07:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:07:44 INFO - Running post-action listener: _resource_record_post_action 14:07:44 INFO - ##### 14:07:44 INFO - ##### Finished read-buildbot-config step (success) 14:07:44 INFO - ##### 14:07:44 INFO - ##### 14:07:44 INFO - ##### Running download-and-extract step. 14:07:44 INFO - ##### 14:07:44 INFO - Running pre-action listener: _resource_record_pre_action 14:07:44 INFO - Running main action method: download_and_extract 14:07:44 INFO - mkdir: /builds/slave/test/build/tests 14:07:44 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')]} 14:07:44 INFO - https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:07:46 INFO - Downloaded 1361 bytes. 14:07:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:46 INFO - Using the following test package requirements: 14:07:46 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:07:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:07:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:46 INFO - u'jsshell-linux-x86_64.zip'], 14:07:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:07:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:07:46 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:07:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:07:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:07:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:07:46 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')]} 14:07:46 INFO - https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:49 INFO - Downloaded 24279346 bytes. 14:07:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:07:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:07:50 INFO - Return code: 0 14:07:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:07:50 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')]} 14:07:50 INFO - https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:52 INFO - Downloaded 24279346 bytes. 14:07:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:07:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:07:54 INFO - Return code: 0 14:07:54 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')]} 14:07:54 INFO - https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:07:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:07:55 INFO - Downloaded 14405240 bytes. 14:07:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:07:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:07:55 INFO - Return code: 0 14:07:55 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')]} 14:07:55 INFO - https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:07:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:07:56 INFO - Downloaded 60169716 bytes. 14:07:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:56 INFO - mkdir: /builds/slave/test/properties 14:07:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:56 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:56 INFO - Contents: 14:07:56 INFO - build_url:https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:57 INFO - Running post-action listener: _resource_record_post_action 14:07:57 INFO - Running post-action listener: set_extra_try_arguments 14:07:57 INFO - ##### 14:07:57 INFO - ##### Finished download-and-extract step (success) 14:07:57 INFO - ##### 14:07:57 INFO - ##### 14:07:57 INFO - ##### Running populate-webroot step. 14:07:57 INFO - ##### 14:07:57 INFO - Running pre-action listener: _resource_record_pre_action 14:07:57 INFO - Running main action method: populate_webroot 14:07:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:57 INFO - '--tppagecycles', 14:07:57 INFO - '7'], 14:07:57 INFO - 'tests': ['tsvgm']}}, 14:07:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:07:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:07:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:07:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:57 INFO - 'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:57 INFO - 'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['damp', 'tps']}, 14:07:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:57 INFO - 'tests': ['damp', 'tps']}, 14:07:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['dromaeo_dom']}, 14:07:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['basic_compositor_video']}, 14:07:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:07:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['a11yr', 14:07:57 INFO - 'ts_paint', 14:07:57 INFO - 'tpaint', 14:07:57 INFO - 'sessionrestore', 14:07:57 INFO - 'sessionrestore_no_auto_restore', 14:07:57 INFO - 'tabpaint']}, 14:07:57 INFO - 'other-e10s': {'tests': ['a11yr', 14:07:57 INFO - 'ts_paint', 14:07:57 INFO - 'tpaint', 14:07:57 INFO - 'sessionrestore', 14:07:57 INFO - 'sessionrestore_no_auto_restore', 14:07:57 INFO - 'tabpaint']}, 14:07:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:07:57 INFO - 'ts_paint', 14:07:57 INFO - 'tpaint', 14:07:57 INFO - 'sessionrestore', 14:07:57 INFO - 'sessionrestore_no_auto_restore', 14:07:57 INFO - 'tabpaint']}, 14:07:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:07:57 INFO - 'ts_paint', 14:07:57 INFO - 'tpaint', 14:07:57 INFO - 'sessionrestore', 14:07:57 INFO - 'sessionrestore_no_auto_restore', 14:07:57 INFO - 'tabpaint']}, 14:07:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['a11yr', 14:07:57 INFO - 'ts_paint', 14:07:57 INFO - 'tpaint', 14:07:57 INFO - 'sessionrestore', 14:07:57 INFO - 'sessionrestore_no_auto_restore', 14:07:57 INFO - 'tabpaint']}, 14:07:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['a11yr', 14:07:57 INFO - 'ts_paint', 14:07:57 INFO - 'tpaint', 14:07:57 INFO - 'sessionrestore', 14:07:57 INFO - 'sessionrestore_no_auto_restore', 14:07:57 INFO - 'tabpaint']}, 14:07:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['tsvgx', 14:07:57 INFO - 'tsvgr_opacity', 14:07:57 INFO - 'tart', 14:07:57 INFO - 'tscrollx', 14:07:57 INFO - 'cart']}, 14:07:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:07:57 INFO - 'tsvgr_opacity', 14:07:57 INFO - 'tart', 14:07:57 INFO - 'tscrollx', 14:07:57 INFO - 'cart']}, 14:07:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:57 INFO - 'talos_options': ['--disable-e10s'], 14:07:57 INFO - 'tests': ['tp5o']}, 14:07:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:57 INFO - 'tests': ['tp5o']}, 14:07:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:57 INFO - 'talos_options': ['--disable-e10s', 14:07:57 INFO - '--xperf_path', 14:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:57 INFO - 'tests': ['tp5n']}, 14:07:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:57 INFO - 'talos_options': ['--xperf_path', 14:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:57 INFO - 'tests': ['tp5n']}}, 14:07:57 INFO - 'talos.zip': {'path': '', 14:07:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:57 INFO - Running post-action listener: _resource_record_post_action 14:07:57 INFO - ##### 14:07:57 INFO - ##### Finished populate-webroot step (success) 14:07:57 INFO - ##### 14:07:57 INFO - ##### 14:07:57 INFO - ##### Running create-virtualenv step. 14:07:57 INFO - ##### 14:07:57 INFO - Running pre-action listener: _resource_record_pre_action 14:07:57 INFO - Running main action method: create_virtualenv 14:07:57 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:57 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 14:07:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:57 INFO - Using real prefix '/usr' 14:07:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:58 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:00 INFO - Installing pip.................done. 14:08:00 INFO - Return code: 0 14:08:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:08:00 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')]} 14:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:00 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')]} 14:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:00 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 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:00 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 14:08:00 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 14:08:00 INFO - Using env: {'DISPLAY': ':0', 14:08:00 INFO - 'HOME': '/home/cltbld', 14:08:00 INFO - 'LANG': 'en_US.UTF-8', 14:08:00 INFO - 'LANGUAGE': 'en_US:en', 14:08:00 INFO - 'LOGNAME': 'cltbld', 14:08:00 INFO - 'MAIL': '/var/mail/cltbld', 14:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:00 INFO - 'MOZ_NO_REMOTE': '1', 14:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:00 INFO - 'NO_EM_RESTART': '1', 14:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:00 INFO - 'PWD': '/builds/slave/test', 14:08:00 INFO - 'SHELL': '/bin/bash', 14:08:00 INFO - 'SHLVL': '1', 14:08:00 INFO - 'TERM': 'linux', 14:08:00 INFO - 'TMOUT': '86400', 14:08:00 INFO - 'USER': 'cltbld', 14:08:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:00 INFO - '_': '/tools/buildbot/bin/python'} 14:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:01 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 14:08:01 INFO - Cleaning up... 14:08:01 INFO - Return code: 0 14:08:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:01 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 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:01 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 14:08:01 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 14:08:01 INFO - Using env: {'DISPLAY': ':0', 14:08:01 INFO - 'HOME': '/home/cltbld', 14:08:01 INFO - 'LANG': 'en_US.UTF-8', 14:08:01 INFO - 'LANGUAGE': 'en_US:en', 14:08:01 INFO - 'LOGNAME': 'cltbld', 14:08:01 INFO - 'MAIL': '/var/mail/cltbld', 14:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:01 INFO - 'MOZ_NO_REMOTE': '1', 14:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:01 INFO - 'NO_EM_RESTART': '1', 14:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:01 INFO - 'PWD': '/builds/slave/test', 14:08:01 INFO - 'SHELL': '/bin/bash', 14:08:01 INFO - 'SHLVL': '1', 14:08:01 INFO - 'TERM': 'linux', 14:08:01 INFO - 'TMOUT': '86400', 14:08:01 INFO - 'USER': 'cltbld', 14:08:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:01 INFO - '_': '/tools/buildbot/bin/python'} 14:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:01 INFO - Downloading/unpacking psutil>=3.1.1 14:08:01 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 14:08:01 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 14:08:01 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 14:08:01 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 14:08:01 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 14:08:01 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 14:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:04 INFO - Installing collected packages: psutil 14:08:04 INFO - Running setup.py install for psutil 14:08:04 INFO - building 'psutil._psutil_linux' extension 14:08:04 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 14:08:06 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 14:08:06 INFO - building 'psutil._psutil_posix' extension 14:08:06 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 14:08:06 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 14:08:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:06 INFO - Successfully installed psutil 14:08:06 INFO - Cleaning up... 14:08:06 INFO - Return code: 0 14:08:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:08:06 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')]} 14:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:06 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')]} 14:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:06 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 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:06 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 14:08:06 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 14:08:06 INFO - Using env: {'DISPLAY': ':0', 14:08:06 INFO - 'HOME': '/home/cltbld', 14:08:06 INFO - 'LANG': 'en_US.UTF-8', 14:08:06 INFO - 'LANGUAGE': 'en_US:en', 14:08:06 INFO - 'LOGNAME': 'cltbld', 14:08:06 INFO - 'MAIL': '/var/mail/cltbld', 14:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:06 INFO - 'MOZ_NO_REMOTE': '1', 14:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:06 INFO - 'NO_EM_RESTART': '1', 14:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:06 INFO - 'PWD': '/builds/slave/test', 14:08:06 INFO - 'SHELL': '/bin/bash', 14:08:06 INFO - 'SHLVL': '1', 14:08:06 INFO - 'TERM': 'linux', 14:08:06 INFO - 'TMOUT': '86400', 14:08:06 INFO - 'USER': 'cltbld', 14:08:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:06 INFO - '_': '/tools/buildbot/bin/python'} 14:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:08:06 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 14:08:06 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 14:08:06 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 14:08:06 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 14:08:06 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 14:08:06 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 14:08:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:08:08 INFO - Installing collected packages: mozsystemmonitor 14:08:08 INFO - Running setup.py install for mozsystemmonitor 14:08:08 INFO - Successfully installed mozsystemmonitor 14:08:08 INFO - Cleaning up... 14:08:08 INFO - Return code: 0 14:08:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:08:08 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')]} 14:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:08 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')]} 14:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:08 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 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:08 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 14:08:08 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 14:08:08 INFO - Using env: {'DISPLAY': ':0', 14:08:08 INFO - 'HOME': '/home/cltbld', 14:08:08 INFO - 'LANG': 'en_US.UTF-8', 14:08:08 INFO - 'LANGUAGE': 'en_US:en', 14:08:08 INFO - 'LOGNAME': 'cltbld', 14:08:08 INFO - 'MAIL': '/var/mail/cltbld', 14:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:08 INFO - 'MOZ_NO_REMOTE': '1', 14:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:08 INFO - 'NO_EM_RESTART': '1', 14:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:08 INFO - 'PWD': '/builds/slave/test', 14:08:08 INFO - 'SHELL': '/bin/bash', 14:08:08 INFO - 'SHLVL': '1', 14:08:08 INFO - 'TERM': 'linux', 14:08:08 INFO - 'TMOUT': '86400', 14:08:08 INFO - 'USER': 'cltbld', 14:08:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:08 INFO - '_': '/tools/buildbot/bin/python'} 14:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:09 INFO - Downloading/unpacking jsonschema==2.5.1 14:08:09 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 14:08:09 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 14:08:09 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 14:08:09 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 14:08:09 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 14:08:09 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 14:08:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:08:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 INFO - Downloading functools32-3.2.3-2.tar.gz 14:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:08:11 INFO - warning: no files found matching '*.txt' 14:08:11 INFO - no previously-included directories found matching 'build' 14:08:11 INFO - no previously-included directories found matching 'dist' 14:08:11 INFO - no previously-included directories found matching '.git*' 14:08:11 INFO - Installing collected packages: jsonschema, functools32 14:08:11 INFO - Running setup.py install for functools32 14:08:11 INFO - warning: no files found matching '*.txt' 14:08:11 INFO - no previously-included directories found matching 'build' 14:08:11 INFO - no previously-included directories found matching 'dist' 14:08:11 INFO - no previously-included directories found matching '.git*' 14:08:11 INFO - Successfully installed jsonschema functools32 14:08:11 INFO - Cleaning up... 14:08:11 INFO - Return code: 0 14:08:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:08:11 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')]} 14:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:11 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')]} 14:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:11 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 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:11 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 14:08:11 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 14:08:11 INFO - Using env: {'DISPLAY': ':0', 14:08:11 INFO - 'HOME': '/home/cltbld', 14:08:11 INFO - 'LANG': 'en_US.UTF-8', 14:08:11 INFO - 'LANGUAGE': 'en_US:en', 14:08:11 INFO - 'LOGNAME': 'cltbld', 14:08:11 INFO - 'MAIL': '/var/mail/cltbld', 14:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:11 INFO - 'MOZ_NO_REMOTE': '1', 14:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:11 INFO - 'NO_EM_RESTART': '1', 14:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:11 INFO - 'PWD': '/builds/slave/test', 14:08:11 INFO - 'SHELL': '/bin/bash', 14:08:11 INFO - 'SHLVL': '1', 14:08:11 INFO - 'TERM': 'linux', 14:08:11 INFO - 'TMOUT': '86400', 14:08:11 INFO - 'USER': 'cltbld', 14:08:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:11 INFO - '_': '/tools/buildbot/bin/python'} 14:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:11 INFO - Downloading/unpacking blobuploader==1.2.4 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 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 14:08:11 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 14:08:13 INFO - Downloading blobuploader-1.2.4.tar.gz 14:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:08:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:08:13 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 14:08:13 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 14:08:13 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 14:08:13 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 14:08:13 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 14:08:13 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 14:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:08:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08:14 INFO - Downloading docopt-0.6.1.tar.gz 14:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:08:14 INFO - Installing collected packages: blobuploader, requests, docopt 14:08:14 INFO - Running setup.py install for blobuploader 14:08:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:08:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:08:14 INFO - Running setup.py install for requests 14:08:14 INFO - Running setup.py install for docopt 14:08:14 INFO - Successfully installed blobuploader requests docopt 14:08:14 INFO - Cleaning up... 14:08:15 INFO - Return code: 0 14:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:15 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 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:15 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 14:08:15 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 14:08:15 INFO - Using env: {'DISPLAY': ':0', 14:08:15 INFO - 'HOME': '/home/cltbld', 14:08:15 INFO - 'LANG': 'en_US.UTF-8', 14:08:15 INFO - 'LANGUAGE': 'en_US:en', 14:08:15 INFO - 'LOGNAME': 'cltbld', 14:08:15 INFO - 'MAIL': '/var/mail/cltbld', 14:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:15 INFO - 'MOZ_NO_REMOTE': '1', 14:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:15 INFO - 'NO_EM_RESTART': '1', 14:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:15 INFO - 'PWD': '/builds/slave/test', 14:08:15 INFO - 'SHELL': '/bin/bash', 14:08:15 INFO - 'SHLVL': '1', 14:08:15 INFO - 'TERM': 'linux', 14:08:15 INFO - 'TMOUT': '86400', 14:08:15 INFO - 'USER': 'cltbld', 14:08:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:15 INFO - '_': '/tools/buildbot/bin/python'} 14:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:15 INFO - Running setup.py (path:/tmp/pip-1r3cE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:15 INFO - Running setup.py (path:/tmp/pip-ojU9ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:15 INFO - Running setup.py (path:/tmp/pip-vS9Pvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:15 INFO - Running setup.py (path:/tmp/pip-qCCwk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:15 INFO - Running setup.py (path:/tmp/pip-CAlm1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:15 INFO - Running setup.py (path:/tmp/pip-5ELDsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:15 INFO - Running setup.py (path:/tmp/pip-nvtCO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:15 INFO - Running setup.py (path:/tmp/pip-ZD0smE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:15 INFO - Running setup.py (path:/tmp/pip-6lzlWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:15 INFO - Running setup.py (path:/tmp/pip-X2IL_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:15 INFO - Running setup.py (path:/tmp/pip-DC8CZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:16 INFO - Running setup.py (path:/tmp/pip-o8C9mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:16 INFO - Running setup.py (path:/tmp/pip-IiRcyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:16 INFO - Running setup.py (path:/tmp/pip-yKoEqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:16 INFO - Running setup.py (path:/tmp/pip-X_qhkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:16 INFO - Running setup.py (path:/tmp/pip-GnssKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:16 INFO - Running setup.py (path:/tmp/pip-79rE6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:16 INFO - Running setup.py install for manifestparser 14:08:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:08:16 INFO - Running setup.py install for mozcrash 14:08:16 INFO - Running setup.py install for mozdebug 14:08:16 INFO - Running setup.py install for mozdevice 14:08:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:08:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:08:16 INFO - Running setup.py install for mozfile 14:08:17 INFO - Running setup.py install for mozhttpd 14:08:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozinfo 14:08:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozInstall 14:08:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozleak 14:08:17 INFO - Running setup.py install for mozlog 14:08:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for moznetwork 14:08:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozprocess 14:08:17 INFO - Running setup.py install for mozprofile 14:08:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozrunner 14:08:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:08:17 INFO - Running setup.py install for mozscreenshot 14:08:18 INFO - Running setup.py install for moztest 14:08:18 INFO - Running setup.py install for mozversion 14:08:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:08:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:18 INFO - Cleaning up... 14:08:18 INFO - Return code: 0 14:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:18 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 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:18 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 14:08:18 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 14:08:18 INFO - Using env: {'DISPLAY': ':0', 14:08:18 INFO - 'HOME': '/home/cltbld', 14:08:18 INFO - 'LANG': 'en_US.UTF-8', 14:08:18 INFO - 'LANGUAGE': 'en_US:en', 14:08:18 INFO - 'LOGNAME': 'cltbld', 14:08:18 INFO - 'MAIL': '/var/mail/cltbld', 14:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:18 INFO - 'MOZ_NO_REMOTE': '1', 14:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:18 INFO - 'NO_EM_RESTART': '1', 14:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:18 INFO - 'PWD': '/builds/slave/test', 14:08:18 INFO - 'SHELL': '/bin/bash', 14:08:18 INFO - 'SHLVL': '1', 14:08:18 INFO - 'TERM': 'linux', 14:08:18 INFO - 'TMOUT': '86400', 14:08:18 INFO - 'USER': 'cltbld', 14:08:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:18 INFO - '_': '/tools/buildbot/bin/python'} 14:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:18 INFO - Running setup.py (path:/tmp/pip-PpBy8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:18 INFO - Running setup.py (path:/tmp/pip-I6nuct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:18 INFO - Running setup.py (path:/tmp/pip-x0SIVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:18 INFO - Running setup.py (path:/tmp/pip-Xq92dK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:18 INFO - Running setup.py (path:/tmp/pip-oaNHHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:18 INFO - Running setup.py (path:/tmp/pip-ZevSGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:18 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)) 14:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:18 INFO - Running setup.py (path:/tmp/pip-dMRyQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:19 INFO - Running setup.py (path:/tmp/pip-JB9GI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:19 INFO - Running setup.py (path:/tmp/pip-fxibEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:19 INFO - Running setup.py (path:/tmp/pip-KU7rr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:19 INFO - Running setup.py (path:/tmp/pip-nza7hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:19 INFO - Running setup.py (path:/tmp/pip-T5BEt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:19 INFO - Running setup.py (path:/tmp/pip-NaVzgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:19 INFO - Running setup.py (path:/tmp/pip-kruQut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:19 INFO - Running setup.py (path:/tmp/pip-ymKvec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:19 INFO - Running setup.py (path:/tmp/pip-xLToXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:19 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)) 14:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:19 INFO - Running setup.py (path:/tmp/pip-E1BN0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:19 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)) 14:08:19 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)) 14:08:19 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)) 14:08:19 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)) 14:08:19 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)) 14:08:19 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)) 14:08:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:19 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 14:08:19 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 14:08:19 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 14:08:19 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 14:08:19 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 14:08:19 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 14:08:21 INFO - Downloading blessings-1.6.tar.gz 14:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:21 INFO - Installing collected packages: blessings 14:08:21 INFO - Running setup.py install for blessings 14:08:21 INFO - Successfully installed blessings 14:08:21 INFO - Cleaning up... 14:08:21 INFO - Return code: 0 14:08:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:22 INFO - Reading from file tmpfile_stdout 14:08:22 INFO - Current package versions: 14:08:22 INFO - argparse == 1.2.1 14:08:22 INFO - blessings == 1.6 14:08:22 INFO - blobuploader == 1.2.4 14:08:22 INFO - docopt == 0.6.1 14:08:22 INFO - functools32 == 3.2.3-2 14:08:22 INFO - jsonschema == 2.5.1 14:08:22 INFO - manifestparser == 1.1 14:08:22 INFO - mozInstall == 1.12 14:08:22 INFO - mozcrash == 0.17 14:08:22 INFO - mozdebug == 0.1 14:08:22 INFO - mozdevice == 0.48 14:08:22 INFO - mozfile == 1.2 14:08:22 INFO - mozhttpd == 0.7 14:08:22 INFO - mozinfo == 0.9 14:08:22 INFO - mozleak == 0.1 14:08:22 INFO - mozlog == 3.2 14:08:22 INFO - moznetwork == 0.27 14:08:22 INFO - mozprocess == 0.22 14:08:22 INFO - mozprofile == 0.28 14:08:22 INFO - mozrunner == 6.11 14:08:22 INFO - mozscreenshot == 0.1 14:08:22 INFO - mozsystemmonitor == 0.3 14:08:22 INFO - moztest == 0.7 14:08:22 INFO - mozversion == 1.4 14:08:22 INFO - psutil == 3.1.1 14:08:22 INFO - requests == 1.2.3 14:08:22 INFO - wsgiref == 0.1.2 14:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:22 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 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:22 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 14:08:22 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 14:08:22 INFO - Using env: {'DISPLAY': ':0', 14:08:22 INFO - 'HOME': '/home/cltbld', 14:08:22 INFO - 'LANG': 'en_US.UTF-8', 14:08:22 INFO - 'LANGUAGE': 'en_US:en', 14:08:22 INFO - 'LOGNAME': 'cltbld', 14:08:22 INFO - 'MAIL': '/var/mail/cltbld', 14:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:22 INFO - 'MOZ_NO_REMOTE': '1', 14:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:22 INFO - 'NO_EM_RESTART': '1', 14:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:22 INFO - 'PWD': '/builds/slave/test', 14:08:22 INFO - 'SHELL': '/bin/bash', 14:08:22 INFO - 'SHLVL': '1', 14:08:22 INFO - 'TERM': 'linux', 14:08:22 INFO - 'TMOUT': '86400', 14:08:22 INFO - 'USER': 'cltbld', 14:08:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:22 INFO - '_': '/tools/buildbot/bin/python'} 14:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 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)) 14:08:22 INFO - Cleaning up... 14:08:22 INFO - Return code: 0 14:08:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:08:22 INFO - Using env: {'DISPLAY': ':0', 14:08:22 INFO - 'HOME': '/home/cltbld', 14:08:22 INFO - 'LANG': 'en_US.UTF-8', 14:08:22 INFO - 'LANGUAGE': 'en_US:en', 14:08:22 INFO - 'LOGNAME': 'cltbld', 14:08:22 INFO - 'MAIL': '/var/mail/cltbld', 14:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:22 INFO - 'MOZ_NO_REMOTE': '1', 14:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:22 INFO - 'NO_EM_RESTART': '1', 14:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:22 INFO - 'PWD': '/builds/slave/test', 14:08:22 INFO - 'SHELL': '/bin/bash', 14:08:22 INFO - 'SHLVL': '1', 14:08:22 INFO - 'TERM': 'linux', 14:08:22 INFO - 'TMOUT': '86400', 14:08:22 INFO - 'USER': 'cltbld', 14:08:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:22 INFO - '_': '/tools/buildbot/bin/python'} 14:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:08:22 INFO - Cleaning up... 14:08:22 INFO - Return code: 0 14:08:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99fa49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, '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': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', '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 14:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:08:22 INFO - Using env: {'DISPLAY': ':0', 14:08:22 INFO - 'HOME': '/home/cltbld', 14:08:22 INFO - 'LANG': 'en_US.UTF-8', 14:08:22 INFO - 'LANGUAGE': 'en_US:en', 14:08:22 INFO - 'LOGNAME': 'cltbld', 14:08:22 INFO - 'MAIL': '/var/mail/cltbld', 14:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:22 INFO - 'MOZ_NO_REMOTE': '1', 14:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:22 INFO - 'NO_EM_RESTART': '1', 14:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:22 INFO - 'PWD': '/builds/slave/test', 14:08:22 INFO - 'SHELL': '/bin/bash', 14:08:22 INFO - 'SHLVL': '1', 14:08:22 INFO - 'TERM': 'linux', 14:08:22 INFO - 'TMOUT': '86400', 14:08:22 INFO - 'USER': 'cltbld', 14:08:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:22 INFO - '_': '/tools/buildbot/bin/python'} 14:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:22 INFO - Downloading/unpacking flake8 14:08:22 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 14:08:22 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 14:08:22 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 14:08:22 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 14:08:22 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 14:08:22 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 14:08:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:08:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:08:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 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 14:08:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:08:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:08:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:08:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:08:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:08:25 INFO - no previously-included directories found matching 'docs/_build' 14:08:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:08:25 INFO - Running setup.py install for pep8 14:08:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:08:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:08:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:08:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:08:25 INFO - no previously-included directories found matching 'docs/_build' 14:08:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:08:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:08:25 INFO - Cleaning up... 14:08:25 INFO - Return code: 0 14:08:25 INFO - Running post-action listener: _resource_record_post_action 14:08:25 INFO - Running post-action listener: _start_resource_monitoring 14:08:25 INFO - Starting resource monitoring. 14:08:25 INFO - ##### 14:08:25 INFO - ##### Finished create-virtualenv step (success) 14:08:25 INFO - ##### 14:08:25 INFO - ##### 14:08:25 INFO - ##### Running install step. 14:08:25 INFO - ##### 14:08:25 INFO - Running pre-action listener: _resource_record_pre_action 14:08:25 INFO - Running main action method: install 14:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:25 INFO - Reading from file tmpfile_stdout 14:08:25 INFO - Detecting whether we're running mozinstall >=1.0... 14:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:08:25 INFO - Reading from file tmpfile_stdout 14:08:25 INFO - Output received: 14:08:25 INFO - Usage: mozinstall [options] installer 14:08:25 INFO - Options: 14:08:25 INFO - -h, --help show this help message and exit 14:08:25 INFO - -d DEST, --destination=DEST 14:08:25 INFO - Directory to install application into. [default: 14:08:25 INFO - "/builds/slave/test"] 14:08:25 INFO - --app=APP Application being installed. [default: firefox] 14:08:25 INFO - mkdir: /builds/slave/test/build/application 14:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:08:43 INFO - Reading from file tmpfile_stdout 14:08:43 INFO - Output received: 14:08:43 INFO - /builds/slave/test/build/application/firefox/firefox 14:08:43 INFO - Running post-action listener: _resource_record_post_action 14:08:43 INFO - ##### 14:08:43 INFO - ##### Finished install step (success) 14:08:43 INFO - ##### 14:08:43 INFO - ##### 14:08:43 INFO - ##### Running run-tests step. 14:08:43 INFO - ##### 14:08:43 INFO - Running pre-action listener: _resource_record_pre_action 14:08:43 INFO - Running main action method: run_tests 14:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:43 INFO - Python 2.7.3 14:08:43 INFO - Return code: 0 14:08:43 INFO - grabbing minidump binary from tooltool 14:08:43 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')]} 14:08:43 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 0x1c60570>, '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 0x1c61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c61920>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08:43 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 14:08:43 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 14:08:43 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 14:08:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:43 INFO - Return code: 0 14:08:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:08:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:08:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:08:44 INFO - Return code: 0 14:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:08:44 INFO - Using env: {'DISPLAY': ':0', 14:08:44 INFO - 'HOME': '/home/cltbld', 14:08:44 INFO - 'LANG': 'en_US.UTF-8', 14:08:44 INFO - 'LANGUAGE': 'en_US:en', 14:08:44 INFO - 'LOGNAME': 'cltbld', 14:08:44 INFO - 'MAIL': '/var/mail/cltbld', 14:08:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:44 INFO - 'MOZ_NO_REMOTE': '1', 14:08:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:44 INFO - 'NO_EM_RESTART': '1', 14:08:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:44 INFO - 'PWD': '/builds/slave/test', 14:08:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:44 INFO - 'SHELL': '/bin/bash', 14:08:44 INFO - 'SHLVL': '1', 14:08:44 INFO - 'TERM': 'linux', 14:08:44 INFO - 'TMOUT': '86400', 14:08:44 INFO - 'USER': 'cltbld', 14:08:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967', 14:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:44 INFO - '_': '/tools/buildbot/bin/python'} 14:08:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:08:44 INFO - mozversion application_buildid: 20160626113029 14:08:44 INFO - mozversion application_changeset: d490ad95a673b042d48e01331b9ae70683457da9 14:08:44 INFO - mozversion application_display_name: Nightly 14:08:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:44 INFO - mozversion application_name: Firefox 14:08:44 INFO - mozversion application_remotingname: firefox 14:08:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:08:44 INFO - mozversion application_vendor: Mozilla 14:08:44 INFO - mozversion application_version: 50.0a1 14:08:44 INFO - mozversion platform_buildid: 20160626113029 14:08:44 INFO - mozversion platform_changeset: d490ad95a673b042d48e01331b9ae70683457da9 14:08:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:08:44 INFO - mozversion platform_version: 50.0a1 14:08:44 INFO - using testdate: 1466975324 14:08:44 INFO - actual date: 1466975324 14:08:44 INFO - starting webserver on 'localhost:50681' 14:08:44 INFO - SUITE-START | Running 2 tests 14:08:44 INFO - TEST-START | dromaeo_css 14:08:44 INFO - operating with platform_type : linux_ 14:08:44 INFO - Initialising browser for dromaeo_css test... 14:08:44 INFO - TEST-INFO | started process 3369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDwQGCS/profile http://localhost:50681/getInfo.html) 14:08:52 INFO - PROCESS | 3369 | __metrics Screen width/height:1600/1200 14:08:52 INFO - PROCESS | 3369 | colorDepth:24 14:08:52 INFO - PROCESS | 3369 | Browser inner width/height: 1024/697 14:08:52 INFO - PROCESS | 3369 | __metrics 14:08:52 ERROR - PROCESS | 3369 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:08:53 INFO - TEST-INFO | 3369: exit 0 14:08:53 INFO - Browser initialized. 14:08:53 INFO - Running cycle 1/1 for dromaeo_css test... 14:08:53 INFO - TEST-INFO | started process 3491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDwQGCS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:05 INFO - PROCESS | 3491 | RSS: Main: 185233408 14:09:05 INFO - PROCESS | 3491 | 14:09:55 INFO - PROCESS | 3491 | 1466975395184 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] 14:12:03 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50681/tests/dromaeo/cssquery-ext.html) 14:12:04 INFO - PROCESS | 3491 | RSS: Main: 189526016 14:12:04 INFO - PROCESS | 3491 | 14:15:06 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-ext.html (next: http://localhost:50681/tests/dromaeo/cssquery-jquery.html) 14:15:07 INFO - PROCESS | 3491 | RSS: Main: 188043264 14:15:07 INFO - PROCESS | 3491 | 14:18:08 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50681/tests/dromaeo/cssquery-mootools.html) 14:18:09 INFO - PROCESS | 3491 | RSS: Main: 189501440 14:18:09 INFO - PROCESS | 3491 | 14:21:11 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50681/tests/dromaeo/cssquery-prototype.html) 14:21:11 INFO - PROCESS | 3491 | RSS: Main: 186716160 14:21:11 INFO - PROCESS | 3491 | 14:24:14 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50681/tests/dromaeo/cssquery-yui.html) 14:24:15 INFO - PROCESS | 3491 | RSS: Main: 188895232 14:24:15 INFO - PROCESS | 3491 | 14:27:17 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-yui.html (next: http://localhost:50681/tests/dromaeo/cssquery-dojo.html) 14:27:17 INFO - PROCESS | 3491 | RSS: Main: 189837312 14:27:17 INFO - PROCESS | 3491 | 14:27:17 INFO - PROCESS | 3491 | __start_tp_report 14:27:17 INFO - PROCESS | 3491 | _x_x_mozilla_page_load 14:27:17 INFO - PROCESS | 3491 | _x_x_mozilla_page_load_details 14:27:17 INFO - PROCESS | 3491 | |i|pagename|runs| 14:27:17 INFO - PROCESS | 3491 | |0;dojo.html;3141.5287706843974;3177.761667874909;3178.459661857487;3193.1538142392255;3193.2336239302576;5496.065668836292;5503.944960550393;5508.366537848148;5609.971950140254;5624.072028115366;5336.9733151334185;5461.863453413666;5512.834614961557;5522.861928451791;5558.944410555893;4905.779239934202;4915.041566894457;5044.218146187329;5121.820736274231;5125.103106956286;830.7178545882385;4956.132676781567;5007.424146223177;5045.899082018375;5084.262781896623;4986.675866068712;4996.3504744383;5001.44984051754;5010.398752149747;5049.3183420238165;4889.853304400874;4980.800767969277;5004.199328107486;5079.390473143209;5092.719900405476;4917.459079501252;4920.458749537548;4921.434035085975;4952.529509696573;4967.652264341497;5462.863428414282;5513.365962914276;5551.389347171848;5552.944470555283;5640.323161220639;5888.146218798251;5942.346341902387;5950.553708471839;5952.077427998667;5955.731992060368;6007.459328660441;6034.547408944347;6060.212172417601;6064.120702498113;6112.877742445126;5642.351129620064;5645.491905728504;5647.181158731961;5651.886962260773;5656.547476201935;5932.555058370639;5962.642241465439;5995.730192141364;6035.969820150871;6077.3314935357075;5765.308163020464;5846.853828654318;5850.0932355484965;5853.004989151769;5872.677002764889;5943.791967281124;5953.196318496947;5965.13505541694;5967.492763115184;5967.76128954837;5748.367679555246;5821.563382746226;5903.911441328383;5936.732847021808;5951.047832346891;5835.124731290341;5945.10823376497;5965.642061476326;5970.970145149333;6009.068594367793;4522.909541809211;4551.431071116111;4562.384078149407;4564.612007979359;4605.40129783126;3967.940480892789;3993;3994.6404823566018;4021.9798901005306;4066.044479547304;5533.197686335539;5560.999020176407;5577.27495425592;5588.441155884379;5638.915416268759;5830.62100963436;5903.852403689856;5948.226730525004;5949.524038076944;5953.28560572734;5503.697296648723;5613.101903695389;5655.462731040545;5672.319321681342;5675.404082571353;5148.073346797538;5152.252923326097;5162.896742065138;5173.40505841833;5187.06632806091;5940.227770389822;6178.505719542516;6186.536009799283;6190.7523699051535;6204.658743769136;5888.705564721747;5925.6963468036965;5955.523558115254;5974.9103763444455;5978.312494063239;6117.816465506042;6140.846478838065;6157.230346206724;6162.476189523762;6188.257409110935;5687.573431992534;5742.712864356849;5834.533237341087;5843;5860.443257890493;5803.65178089316;5891.675957822361;5893.734781934738;5899.882002359843;5949.8215053548465;5692.5445964321925;5757.8560535986935;5787.334456537552;5789.218455508452;5804.419558044162;5681.119426488901;5702.258706368146;5763.94236057634;5792.942070579409;5810.7094645266725;5525.11598144295;5670.092785154356;5699.059655156852;5753.3958934311295;5816.505597024131;5854.2389489366105;5865.94134058671;5879.20630714848;5893.469587737124;5899.321578018411;5587.608867379245;5634.0422128239115;5657.575681823797;5721.971390143022;5735.684537350486 14:27:17 INFO - PROCESS | 3491 | |1;ext.html;573.9942600573993;609.5976655407432;627.8650090230602;628.9150964619776;641.4355367276797;41972;43913.902152446164;43936.34095488562;44004.33993490096;46275;45437.545624543745;45862.541374586246;45904.54095459045;45917.31124033142;46032;8911.50986695733;9026.593803278836;9028.50343231122;9030;9039.909600904006;8833.514156721378;8889.822203555925;8915.643374265022;8923;8947.955260223689;8983.865242021342;8984.640614375417;9002;9016.8647470288;9058.365914385995;8920.286377089817;8953;8964.372493925428;8976.102389761038;9006.549672516348;8844.11558844117;8902.376833621649;8965.641374345018;8971.192592666692;8978.50618215998;41879.37180942288;42152;42293;42297.57702422998;42435.57564424378;3554.413521768905;3554.8044857532827;3770.245950809849;4023.6579890709327;4334.461266250499;32588.18529536757;32710.509342359885;32903.6709632903;33103.33793324144;33295;4185.142045880587;4218.135282267128;4250.914981700349;4345.152695224432;4346.695731298811;363863;365566;367046;368756.499480041;369387;33341.83329083388;60170;61324.69337653283;61606;61704.38295617076;34664.13339666528;35686;36740.63259367426;36883.63116368802;36891.63108368882;15075.396984120513;15127.092374457568;15127.39490420393;15139.772903406238;15194.772078418833;12776;12779.361031948365;12794.68013299675;12812.103152779217;12880.420381082873;8304.958475207586;8342.207490288412;8381.203785640355;8436.873446898302;8444.197801208998;3220.4847224444443;3240.189952511872;3284.244623736554;3298.65364136767;3303.966960330414;960.6925783749273;980.7253968888723;1017.3641474078701;1017.8015287019108;1078.6224821312478;31558;31659.525107123412;31775.841120794248;31850.840745796588;32117.19707007297;1055.3826011783192;1063.9574417023232;1096.742265567591;1150.3155622404656;1187.6496433552122;17018.659626807395;17365.913170434065;17368.39210627622;18345.7248141278;18482.630347392977;561463;563520;571493;575305;576401;57832.71083644639;58705.41294587;58928;58945.705271474224;59007.40992590105;1367.5555444480583;1378.7725025370903;1417.6243295526695;1418.1065928465;1418.8864890808918;31714.365712686078;31861.68138318587;31892.84053579717;32666.673333266364;32729.34541309208;50688.74655626846;51466;51547.22679159891;51563.74218128886;51753.48246517637;359925;360833;361724;362649;472740;27834.721652784025;27849.303767405978;28155;28215.858920705265;28501.42997140087;46635.76682116568;46938.76530617325;47289.763551182026;47416.7629161852;47823.76088119537;38903.83288501349;39806.402903957045;40155.1968960625;40757.38863916984;41506.58493415027;39288.60711392964;40321.39517907175;40630.39054414127;40919.590804091575;41579;39260;39842.402363963985;40082.59917400789;40305.79847100746;40403;33426.33147337088;35331.64668353284;36114.638853611126;36539.451908220864;36707.63292367042;27955.580666289614;28189.859050704614;28499.28751781139;28528.42943141084;28590.285242869093 14:27:17 INFO - PROCESS | 3491 | |2;jquery.html;389.9434581985612;397.79911144871835;399.34308063235994;404.2924881457449;417.32393522493544;13823.654408639764;17967.640647187047;18962.905185474086;19537.316193933217;19563.804361956376;18332.08339583019;18740.718889216638;18746.062696865138;18914.527136821587;19171.42485725427;5607.130894711327;5762.1068734346245;5818.1272809078555;5828.708564571754;5866.090755932837;5694.487496125348;5742.54059675225;5745.138229265602;5755.597108202427;5770.913436298438;5545.916811247835;5641.830745077634;5680.801171958982;5756.165356023374;5758.395368486312;5611.719414029282;5654.660720356792;5662.122371032497;5668.971655141719;5675.489205971462;4861;5027.069992051483;5067.467915868818;5075.720835354054;5087.49125087492;21559.676604850938;22032.779672203233;22244.221452249254;22373.328800136023;22427.663585046237;2506.3859354458273;2588.974110258911;3022.4710675631895;3043.8325892075927;3107.9533806992913;9557.761055973588;10125.797484050277;13529.729405411936;14048.43806247749;14690.485832995793;1933.236371633211;1954.198778500822;1982.0882394098733;1999.730036445076;2051.271798511522;53528;70606.29393706049;73665;75017.24982750157;83952;10077.294589378673;10553.894461055444;10862.131029517619;11047.226694131334;11107.611233606785;15034.473793417177;15126.621834454227;15162.696746065238;15266.923665381602;15290.923545382202;7937.880931786028;8122.106568277485;8293.668253269801;8326.084130745614;8337.874931876027;7768.456208065494;7769.572673503011;8034.821189823055;8092.9479167709;8141.8371632568205;4556.703814252063;4655.813767449332;4657.86026419208;4667.649926255544;4702.27114797207;1847.464235371754;1898.2596787252983;1911.9848318530974;1920.8847469151895;1951;858.6050416808213;952.8523078922778;962.6967505235829;966.2221911361421;1036.730450082984;17941.7308740369;18645.533861653297;18858.15138318779;18890.244390224238;18993.240270389306;973.2992245583168;975.3806332978468;986.3637953520083;986.3982970388201;1031.9122874555746;10047.799044019079;10344.844827327595;10456.372617642966;10537.473126343652;10572.207084468695;483911;490736;492056;498344;502249;55481.72259138679;67762;91950.54024729834;92108.53945730363;94265.52867235757;939.5255396024963;971.3734641156556;975.9072888075622;976.0824824664793;987.8616993620755;15079.849201508283;16421.91789041047;16566.83433165653;16826.663466730843;17326.306947722453;36390;40184.59815401925;42291.57708422876;42845.78577107094;43043.7847810759;57243.71378143083;58004;58962.705186473795;59000.1149982742;59755.402445974985;8635.87046194295;8654.30765538768;8722.040575536812;8737.43206691563;8771.07903670131;9779.608815647294;12526.686832828887;12658.936705316415;12998.805017924928;13433.462661493822;11009.2843965142;11621.76756464883;11836.349000805038;12054;12131.514739410324;11675.708107297385;11760.059195264188;11788.410579471163;11933.940330298294;11997.76004479888;11604.6518604442;12013.399330033288;12096.637100886988;12132.514699411924;12461.626151215478;7777.455578109478;8301.83396332082;8371.916280837357;8440.704575339834;8492.532910689972;10815.783684326112;11438.656840294805;12118.818217726917;12160.331181785086;12167.087468440079 14:27:17 INFO - PROCESS | 3491 | |3;mootools.html;1424.729301432728;1475.8229012518498;1579.226179172206;1709.8375654312836;1740.8085110637828;7562.735304264352;8225.424220304581;8354.289885359743;8860.955695221523;8878.822423551534;8195.836083278331;8360.707375241867;8505.404621676485;8544.145585441453;8582.399232053758;2347.788699017088;2414.4808866093786;2420.092465325503;2423.4547226873988;2427.5509030829353;2269.818414526842;2334.7898689117974;2353.9411514712097;2382.0471811275456;2391.234804862445;2339.1812865497027;2352.0121548949396;2369.869657168855;2376.702912135983;2390.8326417150806;2280.5324908393823;2305.3660243433023;2305.6426253930667;2308.7575804540447;2375.798057165143;2318.675385446039;2340.7659234076627;2343.4961483281177;2354.835161538693;2360.6459031145296;8586.098459661707;8698.956505217433;8709.825803483895;8709.95645021777;8722.433041852322;5212.4266330703595;5332.066888294572;5337.653052551572;5341.145416733343;5341.732913354317;3419.093940105874;3431.7769344992744;3448.758586898918;3481.3211423772373;3492.4237500812337;1177.5643012085584;1192.6243233381545;1220.6277085488923;1229.6802831263847;1234.8271242026124;11596.130290228266;11668.708282292926;11760.647180584596;11806.586769463027;11808.763824723457;4595.759145030823;4599.103174880933;4767.380240568704;4768.593264986837;4781.282807578891;9981.900180998096;10005.099541041342;10013.098821106136;10017.148542373834;10023.2482563808;5256.185291279858;5300.496452836975;5336.386315573759;5342.839714808562;5355.3305836770405;4330.350447432847;4834.613230941586;4840.7337596432535;5004.124278251292;5006.199008158677;4119.361498967664;4122.237386083524;4148.958510414857;4149.688773341951;4176.352665336878;1260.2816394655142;1268.289757735671;1285.4986555243463;1295.5659853949032;1312.8162057311984;845.9407841451163;905.3391024552113;932.421898422982;998.7976511791483;1010.0909181736496;5856.765729370777;5940.34656187819;5998.760049598054;6148.1085242639565;6216.316205217422;968.3173362779223;973.0609961387295;985.2069084386994;988.7725823060737;1013.4020927652721;4368;4401.889952751143;4423.646108311327;4435.157320109169;4446.644268458515;10412.479376031168;10889.401082940356;10912.50893709785;10967.50646220922;10983.50574224146;9933.602655893828;10236.078752912124;10284.794304114026;10633.627823026158;10901.781964360669;7825.726099586487;8022.919770802334;8036.6383512740895;8036.879446808302;8052.959735201286;6239.812805615838;6370.840728981812;6491.636756281045;6496.967515162394;6499.4800415965665;9907.752306192402;10034.1972642187;10085.747856303651;10096.444695541522;10129.696109116738;10216.54025568866;10347.379157250589;10427.94786026065;10514.158867290751;10527.210459215743;6990.23107458169;7527.473076884785;7827.178146294557;7828.13890472059;7944.404169687181;8593.226609605166;8614.569271536524;8635.56822158877;8661.826763464569;8682.175193356621;7414.332710056121;7710;7733.4973226740085;7773.455858089879;7871.960640196762;7592.658330375036;7652.196519365387;7695;7702.229777022253;7788.571628560484;6848.246692863681;6889.448844092561;6919.792406227822;6931.514793964374;6953.930460695531;5167.147420675697;5334.226537152169;5397.649152805055;5445.727713614224;5475.534579560782;5273.841784746463;5292.5501332387175;5410.97294513525;5460.535854452257;5490.9841679287865 14:27:17 INFO - PROCESS | 3491 | |4;prototype.html;314.14552417424596;320.2713826045747;324.8846659435899;330.8759215294265;331.75947438107374;5649.915251271229;5687.118496633018;5705.857353566158;5741.540676745861;5742.712864356787;5641.8589535261635;5646.273459516719;5675.148727690848;5687.374388817238;5746.310442746866;4112;4176.394422808691;4297.763623000734;4304.450397856769;4332.176886391591;4287.485501739796;4312.310030395138;4316.935245971313;4335.609795118438;4338.739675619458;4303.289957157065;4318.82724691012;4331.4802223733195;4332.162433605993;4340.97829510852;4108.712390132692;4221.409002739619;4235.91528169438;4244.830206791725;4315.395844581761;3682.3187710273687;3699.297133544645;3700.111973126457;3704.25914817035;3711.1278849470355;5391.460853914617;5456.454354564551;5481.397046324901;5481.75332110056;5518.806841760559;4857.611391088704;4883.658143929926;4932.087563800708;4944.777485013183;4950.306957025983;5842.970785146047;5846.912296315559;5860.472557469806;5869.589128760988;5906.763729450817;4144.088300573869;4152.231837110114;4169.395437661552;4184.581541845821;4190.769507677077;5981.491573216282;6033.366496517846;6072.908906366408;6082.878342433127;6088.391160883921;4148.751074935453;4165.583961302437;4178.874633760992;4182.958170418317;4194.643455306272;4231.4710661167355;4238.978805105955;4240.5123410808155;4244.575542445792;4261.680373971964;4732.881677958078;4842.709437433765;4876.609871210366;4877.219644856877;4920.852374428773;5795.1886735857015;5835.503982161564;5860.970695146497;5909.438603332676;5916.911246331309;1433.433793651502;1449.3840117949828;1463.0343972977785;1472.6023973527301;1476.60131764423;921.4839689773748;932.4358762948455;946.394307643109;969.709087273815;996.6661168508485;5570.777168913198;5571.916421253684;5593.412691667317;5599.160125981135;5606.523445507178;5982.551308651869;5987.9101813472835;6015.578909476295;6020.217371741734;6021.729022194012;5408.810691625774;5603.439656034446;5606.635568688022;5636.971815140898;5648.181013752983;3178.98410507946;3201.6158061032825;3202.647708752035;3205.7916235444623;3221.2108033531936;5905.498032667271;6104.511639068864;6175.3515880831865;6205.393734631466;6212.627242365473;6006.219191505076;6052.576319657582;6060.303065147476;6071.635701857903;6098.298695650057;6117.388261173847;6132.325444201045;6193.473554747807;6194.473469755121;6228.22147231596;5673.449996040819;5878.326046221112;5885.793997210077;5983.521318294439;6013.218281623361;5855.94144058554;5916.852078698067;5961.850953726192;5970.611910225822;6022.939770602238;6054.424829641177;6174.351693072343;6206.162168107247;6260.154879091265;6265.310815810349;4194.979025104855;4201.676471911338;4222.3244280914905;4225.33099425719;4225.5351911290345;6048.274207095177;6085.604435711842;6102.176206212104;6117;6118.418750218722;5633.155026746021;5823.7379317931645;5832.300123985149;5845.240118784531;5856.047168161559;5786.652800831964;5847.619904706181;5853.473187413153;5878.706064696663;5893.850699113803;5227.503387178212;5709.286339207599;5782.5663075268685;5797.9420205797405;5805.390434004369;5921.851953701192;5946.702664866826;5948.910766338422;5953.880922381615;5981.3420523743225;5800.941990580209;5820.097884827858;5825.94174058254;5829.562782791223;5845.649261044351 14:27:17 INFO - PROCESS | 3491 | |5;yui.html;747.8878168274755;770.3644493293035;776.8679324514834;777.5956502618639;831.2975535672358;14844.628884277898;15329.463468778595;15369.769453458208;15434.691306173883;15499.457518986837;14622.488212912524;14646.926765366159;14808.55574332769;14833;14862.182579958126;654.7021105397033;783.1933108897845;788.8777239527868;804.9839003219961;807.725373373053;795.7254747112266;796.3430170109654;800.747764454198;804.505229283992;804.5132694719698;848.6690190825583;849.7280870121564;853.4111463090447;853.9146085391474;854.4616891358436;847.7711018025129;848.0374774630808;848.8302339532119;849.049065047145;849.545493161162;610.9644153160394;615.4368752591373;615.9322474527798;617.8887800195963;618.5886385553601;14580.635484112876;14601.926990365086;14678;14701.411943522246;14772.630684232872;14281.642958926006;14702.926485367505;14883.404663813542;15053.47312844056;15074.472393466176;11920.761584768255;11965.46155423008;12041.578544750892;12225.327606981613;12277.447514861853;3923.391874259494;3923.607639236082;3939.1333906540804;3963.8414463421427;4018.1561872006914;74079.0068729714;76738;76922.23077769151;78926;79397.60301198515;11664.883351166549;11696.239744416756;11839.704007399883;11935.761284774257;12046.216995895238;21847.781522184894;21882.671759923614;21989.780102199093;22073.889630552065;22159.778402216092;8657.437266577652;8665.696700615574;8827.69103081389;8944.776380590538;8982.730518084469;4992.2511623256805;5038.899222015539;5074.3657042869645;5088.821891233789;5101.489851014869;3349.916252093717;3449.724022078278;3459.9481007784902;3461.6365281645067;3470.548828652259;618.9783357582553;634.8222497700651;637.5568979559255;647.8088963755704;653.7809833705762;732.0812380462486;747.4879707400448;749.3892477630714;756.9432292578078;786.3709032773758;9276.900833812037;9330.393524420891;9484.146426821619;9600.567974441166;9628.518574071268;665.6438805239173;722.5556282885988;761.6191904047976;765.9085802731197;774.403709143956;4388.758618276025;4486.304622783474;4684.8756298488115;4723.197056500403;4760.406836531429;108068;111935;111942.44028779805;113418.43290783493;114358.42820785842;95265;96961;96974;98228;99596;86669;86853.5657321722;86955;87336;91147.54426227826;8763.474191548528;8824.691135810215;8899.243564296848;8958.10418958099;9119.589618467318;50124;50805.745971269906;50985.490145098076;51501.7424912873;53070;51824.48175518347;70799;75242.35682323738;75577.24422755702;76120;14090.647733806736;14142.292885355897;14485.348159333065;14487;14715.411383544966;15245.466408675644;15292.158931258888;15372.769408458658;16508.33966641369;16561.42035028768;13605.931970340482;14028;14439.350229239499;14716.705665886837;15281;14867.851321486647;14869.330880110205;15454.922725386301;15629.531114066596;15713.978591391522;13512.864871351554;13576.185428873903;13884.58346249614;14396;15104.54686359411;11262.197888774033;11417.429128543707;11806.173567850168;11843.230190037964;12132.150749447454;11756.23584467007;11885.405729713308;12004.279743215435;12006.879931200576;12238.571649992564 14:27:17 INFO - PROCESS | 3491 | __end_tp_report 14:27:17 INFO - PROCESS | 3491 | __start_cc_report 14:27:17 INFO - PROCESS | 3491 | _x_x_mozilla_cycle_collect,344 14:27:17 INFO - PROCESS | 3491 | __end_cc_report 14:27:17 INFO - PROCESS | 3491 | __startTimestamp1466976437868__endTimestamp 14:27:17 INFO - PROCESS | 3491 | 14:27:17 INFO - PROCESS | 3491 | ------- Summary: start ------- 14:27:17 INFO - PROCESS | 3491 | Number of tests: 6 14:27:17 INFO - PROCESS | 3491 | 14:27:17 INFO - PROCESS | 3491 | [#0] dojo.html Cycles:165 Average:5475.69 Median:5699.06 stddev:730.53 (12.8%) stddev-sans-first:709.45 14:27:17 INFO - PROCESS | 3491 | Values: 3141.5 3177.8 3178.5 3193.2 3193.2 5496.1 5503.9 5508.4 5610.0 5624.1 5337.0 5461.9 5512.8 5522.9 5558.9 4905.8 4915.0 5044.2 5121.8 5125.1 830.7 4956.1 5007.4 5045.9 5084.3 4986.7 4996.4 5001.4 5010.4 5049.3 4889.9 4980.8 5004.2 5079.4 5092.7 4917.5 4920.5 4921.4 4952.5 4967.7 5462.9 5513.4 5551.4 5552.9 5640.3 5888.1 5942.3 5950.6 5952.1 5955.7 6007.5 6034.5 6060.2 6064.1 6112.9 5642.4 5645.5 5647.2 5651.9 5656.5 5932.6 5962.6 5995.7 6036.0 6077.3 5765.3 5846.9 5850.1 5853.0 5872.7 5943.8 5953.2 5965.1 5967.5 5967.8 5748.4 5821.6 5903.9 5936.7 5951.0 5835.1 5945.1 5965.6 5971.0 6009.1 4522.9 4551.4 4562.4 4564.6 4605.4 3967.9 3993.0 3994.6 4022.0 4066.0 5533.2 5561.0 5577.3 5588.4 5638.9 5830.6 5903.9 5948.2 5949.5 5953.3 5503.7 5613.1 5655.5 5672.3 5675.4 5148.1 5152.3 5162.9 5173.4 5187.1 5940.2 6178.5 6186.5 6190.8 6204.7 5888.7 5925.7 5955.5 5974.9 5978.3 6117.8 6140.8 6157.2 6162.5 6188.3 5687.6 5742.7 5834.5 5843.0 5860.4 5803.7 5891.7 5893.7 5899.9 5949.8 5692.5 5757.9 5787.3 5789.2 5804.4 5681.1 5702.3 5763.9 5792.9 5810.7 5525.1 5670.1 5699.1 5753.4 5816.5 5854.2 5865.9 5879.2 5893.5 5899.3 5587.6 5634.0 5657.6 5722.0 5735.7 14:27:17 INFO - PROCESS | 3491 | 14:27:17 INFO - PROCESS | 3491 | [#1] ext.html Cycles:180 Average:59039.25 Median:40362.20 stddev:119770.01 (296.7%) stddev-sans-first:120025.56 14:27:17 INFO - PROCESS | 3491 | Values: 574.0 609.6 627.9 628.9 641.4 41972.0 43913.9 43936.3 44004.3 46275.0 45437.5 45862.5 45904.5 45917.3 46032.0 8911.5 9026.6 9028.5 9030.0 9039.9 8833.5 8889.8 8915.6 8923.0 8948.0 8983.9 8984.6 9002.0 9016.9 9058.4 8920.3 8953.0 8964.4 8976.1 9006.5 8844.1 8902.4 8965.6 8971.2 8978.5 41879.4 42152.0 42293.0 42297.6 42435.6 3554.4 3554.8 3770.2 4023.7 4334.5 32588.2 32710.5 32903.7 33103.3 33295.0 4185.1 4218.1 4250.9 4345.2 4346.7 363863.0 365566.0 367046.0 368756.5 369387.0 33341.8 60170.0 61324.7 61606.0 61704.4 34664.1 35686.0 36740.6 36883.6 36891.6 15075.4 15127.1 15127.4 15139.8 15194.8 12776.0 12779.4 12794.7 12812.1 12880.4 8305.0 8342.2 8381.2 8436.9 8444.2 3220.5 3240.2 3284.2 3298.7 3304.0 960.7 980.7 1017.4 1017.8 1078.6 31558.0 31659.5 31775.8 31850.8 32117.2 1055.4 1064.0 1096.7 1150.3 1187.6 17018.7 17365.9 17368.4 18345.7 18482.6 561463.0 563520.0 571493.0 575305.0 576401.0 57832.7 58705.4 58928.0 58945.7 59007.4 1367.6 1378.8 1417.6 1418.1 1418.9 31714.4 31861.7 31892.8 32666.7 32729.3 50688.7 51466.0 51547.2 51563.7 51753.5 359925.0 360833.0 361724.0 362649.0 472740.0 27834.7 27849.3 28155.0 28215.9 28501.4 46635.8 46938.8 47289.8 47416.8 47823.8 38903.8 39806.4 40155.2 40757.4 41506.6 39288.6 40321.4 40630.4 40919.6 41579.0 39260.0 39842.4 40082.6 40305.8 40403.0 33426.3 35331.6 36114.6 36539.5 36707.6 27955.6 28189.9 28499.3 28528.4 28590.3 14:27:17 INFO - PROCESS | 3491 | 14:27:17 INFO - PROCESS | 3491 | [#2] jquery.html Cycles:180 Average:28408.92 Median:410.81 stddev:81033.99 (19725.5%) stddev-sans-first:81234.00 14:27:17 INFO - PROCESS | 3491 | Values: 389.9 397.8 399.3 404.3 417.3 13823.7 17967.6 18962.9 19537.3 19563.8 18332.1 18740.7 18746.1 18914.5 19171.4 5607.1 5762.1 5818.1 5828.7 5866.1 5694.5 5742.5 5745.1 5755.6 5770.9 5545.9 5641.8 5680.8 5756.2 5758.4 5611.7 5654.7 5662.1 5669.0 5675.5 4861.0 5027.1 5067.5 5075.7 5087.5 21559.7 22032.8 22244.2 22373.3 22427.7 2506.4 2589.0 3022.5 3043.8 3108.0 9557.8 10125.8 13529.7 14048.4 14690.5 1933.2 1954.2 1982.1 1999.7 2051.3 53528.0 70606.3 73665.0 75017.2 83952.0 10077.3 10553.9 10862.1 11047.2 11107.6 15034.5 15126.6 15162.7 15266.9 15290.9 7937.9 8122.1 8293.7 8326.1 8337.9 7768.5 7769.6 8034.8 8092.9 8141.8 4556.7 4655.8 4657.9 4667.6 4702.3 1847.5 1898.3 1912.0 1920.9 1951.0 858.6 952.9 962.7 966.2 1036.7 17941.7 18645.5 18858.2 18890.2 18993.2 973.3 975.4 986.4 986.4 1031.9 10047.8 10344.8 10456.4 10537.5 10572.2 483911.0 490736.0 492056.0 498344.0 502249.0 55481.7 67762.0 91950.5 92108.5 94265.5 939.5 971.4 975.9 976.1 987.9 15079.8 16421.9 16566.8 16826.7 17326.3 36390.0 40184.6 42291.6 42845.8 43043.8 57243.7 58004.0 58962.7 59000.1 59755.4 8635.9 8654.3 8722.0 8737.4 8771.1 9779.6 12526.7 12658.9 12998.8 13433.5 11009.3 11621.8 11836.3 12054.0 12131.5 11675.7 11760.1 11788.4 11933.9 11997.8 11604.7 12013.4 12096.6 12132.5 12461.6 7777.5 8301.8 8371.9 8440.7 8492.5 10815.8 11438.7 12118.8 12160.3 12167.1 14:27:17 INFO - PROCESS | 3491 | 14:27:17 INFO - PROCESS | 3491 | [#3] mootools.html Cycles:180 Average:5794.75 Median:4837.67 stddev:3192.37 (66.0%) stddev-sans-first:3184.43 14:27:17 INFO - PROCESS | 3491 | Values: 1424.7 1475.8 1579.2 1709.8 1740.8 7562.7 8225.4 8354.3 8861.0 8878.8 8195.8 8360.7 8505.4 8544.1 8582.4 2347.8 2414.5 2420.1 2423.5 2427.6 2269.8 2334.8 2353.9 2382.0 2391.2 2339.2 2352.0 2369.9 2376.7 2390.8 2280.5 2305.4 2305.6 2308.8 2375.8 2318.7 2340.8 2343.5 2354.8 2360.6 8586.1 8699.0 8709.8 8710.0 8722.4 5212.4 5332.1 5337.7 5341.1 5341.7 3419.1 3431.8 3448.8 3481.3 3492.4 1177.6 1192.6 1220.6 1229.7 1234.8 11596.1 11668.7 11760.6 11806.6 11808.8 4595.8 4599.1 4767.4 4768.6 4781.3 9981.9 10005.1 10013.1 10017.1 10023.2 5256.2 5300.5 5336.4 5342.8 5355.3 4330.4 4834.6 4840.7 5004.1 5006.2 4119.4 4122.2 4149.0 4149.7 4176.4 1260.3 1268.3 1285.5 1295.6 1312.8 845.9 905.3 932.4 998.8 1010.1 5856.8 5940.3 5998.8 6148.1 6216.3 968.3 973.1 985.2 988.8 1013.4 4368.0 4401.9 4423.6 4435.2 4446.6 10412.5 10889.4 10912.5 10967.5 10983.5 9933.6 10236.1 10284.8 10633.6 10901.8 7825.7 8022.9 8036.6 8036.9 8053.0 6239.8 6370.8 6491.6 6497.0 6499.5 9907.8 10034.2 10085.7 10096.4 10129.7 10216.5 10347.4 10427.9 10514.2 10527.2 6990.2 7527.5 7827.2 7828.1 7944.4 8593.2 8614.6 8635.6 8661.8 8682.2 7414.3 7710.0 7733.5 7773.5 7872.0 7592.7 7652.2 7695.0 7702.2 7788.6 6848.2 6889.4 6919.8 6931.5 6953.9 5167.1 5334.2 5397.6 5445.7 5475.5 5273.8 5292.6 5411.0 5460.5 5491.0 14:27:17 INFO - PROCESS | 3491 | 14:27:17 INFO - PROCESS | 3491 | [#4] prototype.html Cycles:180 Average:4907.82 Median:5674.30 stddev:1467.74 (25.9%) stddev-sans-first:1430.79 14:27:17 INFO - PROCESS | 3491 | Values: 314.1 320.3 324.9 330.9 331.8 5649.9 5687.1 5705.9 5741.5 5742.7 5641.9 5646.3 5675.1 5687.4 5746.3 4112.0 4176.4 4297.8 4304.5 4332.2 4287.5 4312.3 4316.9 4335.6 4338.7 4303.3 4318.8 4331.5 4332.2 4341.0 4108.7 4221.4 4235.9 4244.8 4315.4 3682.3 3699.3 3700.1 3704.3 3711.1 5391.5 5456.5 5481.4 5481.8 5518.8 4857.6 4883.7 4932.1 4944.8 4950.3 5843.0 5846.9 5860.5 5869.6 5906.8 4144.1 4152.2 4169.4 4184.6 4190.8 5981.5 6033.4 6072.9 6082.9 6088.4 4148.8 4165.6 4178.9 4183.0 4194.6 4231.5 4239.0 4240.5 4244.6 4261.7 4732.9 4842.7 4876.6 4877.2 4920.9 5795.2 5835.5 5861.0 5909.4 5916.9 1433.4 1449.4 1463.0 1472.6 1476.6 921.5 932.4 946.4 969.7 996.7 5570.8 5571.9 5593.4 5599.2 5606.5 5982.6 5987.9 6015.6 6020.2 6021.7 5408.8 5603.4 5606.6 5637.0 5648.2 3179.0 3201.6 3202.6 3205.8 3221.2 5905.5 6104.5 6175.4 6205.4 6212.6 6006.2 6052.6 6060.3 6071.6 6098.3 6117.4 6132.3 6193.5 6194.5 6228.2 5673.4 5878.3 5885.8 5983.5 6013.2 5855.9 5916.9 5961.9 5970.6 6022.9 6054.4 6174.4 6206.2 6260.2 6265.3 4195.0 4201.7 4222.3 4225.3 4225.5 6048.3 6085.6 6102.2 6117.0 6118.4 5633.2 5823.7 5832.3 5845.2 5856.0 5786.7 5847.6 5853.5 5878.7 5893.9 5227.5 5709.3 5782.6 5797.9 5805.4 5921.9 5946.7 5948.9 5953.9 5981.3 5800.9 5820.1 5825.9 5829.6 5845.6 14:27:17 INFO - PROCESS | 3491 | 14:27:17 INFO - PROCESS | 3491 | [#5] yui.html Cycles:180 Average:20825.28 Median:27558.13 stddev:29452.67 (106.9%) stddev-sans-first:29496.71 14:27:17 INFO - PROCESS | 3491 | Values: 747.9 770.4 776.9 777.6 831.3 14844.6 15329.5 15369.8 15434.7 15499.5 14622.5 14646.9 14808.6 14833.0 14862.2 654.7 783.2 788.9 805.0 807.7 795.7 796.3 800.7 804.5 804.5 848.7 849.7 853.4 853.9 854.5 847.8 848.0 848.8 849.0 849.5 611.0 615.4 615.9 617.9 618.6 14580.6 14601.9 14678.0 14701.4 14772.6 14281.6 14702.9 14883.4 15053.5 15074.5 11920.8 11965.5 12041.6 12225.3 12277.4 3923.4 3923.6 3939.1 3963.8 4018.2 74079.0 76738.0 76922.2 78926.0 79397.6 11664.9 11696.2 11839.7 11935.8 12046.2 21847.8 21882.7 21989.8 22073.9 22159.8 8657.4 8665.7 8827.7 8944.8 8982.7 4992.3 5038.9 5074.4 5088.8 5101.5 3349.9 3449.7 3459.9 3461.6 3470.5 619.0 634.8 637.6 647.8 653.8 732.1 747.5 749.4 756.9 786.4 9276.9 9330.4 9484.1 9600.6 9628.5 665.6 722.6 761.6 765.9 774.4 4388.8 4486.3 4684.9 4723.2 4760.4 108068.0 111935.0 111942.4 113418.4 114358.4 95265.0 96961.0 96974.0 98228.0 99596.0 86669.0 86853.6 86955.0 87336.0 91147.5 8763.5 8824.7 8899.2 8958.1 9119.6 50124.0 50805.7 50985.5 51501.7 53070.0 51824.5 70799.0 75242.4 75577.2 76120.0 14090.6 14142.3 14485.3 14487.0 14715.4 15245.5 15292.2 15372.8 16508.3 16561.4 13605.9 14028.0 14439.4 14716.7 15281.0 14867.9 14869.3 15454.9 15629.5 15714.0 13512.9 13576.2 13884.6 14396.0 15104.5 11262.2 11417.4 11806.2 11843.2 12132.2 11756.2 11885.4 12004.3 12006.9 12238.6 14:27:17 INFO - PROCESS | 3491 | -------- Summary: end -------- 14:27:17 INFO - PROCESS | 3491 | 14:27:18 INFO - TEST-INFO | 3491: exit 0 14:27:18 INFO - TEST-OK | dromaeo_css | took 1114058ms 14:27:18 INFO - TEST-START | kraken 14:27:18 INFO - operating with platform_type : linux_ 14:27:18 INFO - Initialising browser for kraken test... 14:27:18 INFO - TEST-INFO | started process 3730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNU5iaI/profile http://localhost:50681/getInfo.html) 14:27:23 INFO - PROCESS | 3730 | __metrics Screen width/height:1600/1200 14:27:23 INFO - PROCESS | 3730 | colorDepth:24 14:27:23 INFO - PROCESS | 3730 | Browser inner width/height: 1024/697 14:27:23 INFO - PROCESS | 3730 | __metrics 14:27:23 ERROR - PROCESS | 3730 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:27:24 INFO - TEST-INFO | 3730: exit 0 14:27:24 INFO - Browser initialized. 14:27:24 INFO - Running cycle 1/1 for kraken test... 14:27:24 INFO - TEST-INFO | started process 3856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNU5iaI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:27:36 INFO - PROCESS | 3856 | RSS: Main: 184938496 14:27:36 INFO - PROCESS | 3856 | 14:27:39 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50681/tests/kraken/driver.html?testName=audio-beat-detection) 14:27:40 INFO - PROCESS | 3856 | RSS: Main: 190324736 14:27:40 INFO - PROCESS | 3856 | 14:27:42 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50681/tests/kraken/driver.html?testName=audio-dft) 14:27:43 INFO - PROCESS | 3856 | RSS: Main: 189526016 14:27:43 INFO - PROCESS | 3856 | 14:27:46 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50681/tests/kraken/driver.html?testName=audio-fft) 14:27:46 INFO - PROCESS | 3856 | RSS: Main: 184483840 14:27:46 INFO - PROCESS | 3856 | 14:27:49 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50681/tests/kraken/driver.html?testName=audio-oscillator) 14:27:49 INFO - PROCESS | 3856 | RSS: Main: 185384960 14:27:49 INFO - PROCESS | 3856 | 14:27:52 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:52 INFO - PROCESS | 3856 | RSS: Main: 185438208 14:27:52 INFO - PROCESS | 3856 | 14:27:55 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50681/tests/kraken/driver.html?testName=imaging-darkroom) 14:27:56 INFO - PROCESS | 3856 | RSS: Main: 186224640 14:27:56 INFO - PROCESS | 3856 | 14:27:59 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50681/tests/kraken/driver.html?testName=imaging-desaturate) 14:28:00 INFO - PROCESS | 3856 | RSS: Main: 183418880 14:28:00 INFO - PROCESS | 3856 | 14:28:03 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50681/tests/kraken/driver.html?testName=json-parse-financial) 14:28:03 INFO - PROCESS | 3856 | RSS: Main: 184897536 14:28:03 INFO - PROCESS | 3856 | 14:28:05 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:06 INFO - PROCESS | 3856 | RSS: Main: 185241600 14:28:06 INFO - PROCESS | 3856 | 14:28:07 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:08 INFO - PROCESS | 3856 | RSS: Main: 185380864 14:28:08 INFO - PROCESS | 3856 | 14:28:10 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:11 INFO - PROCESS | 3856 | RSS: Main: 185729024 14:28:11 INFO - PROCESS | 3856 | 14:28:13 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:14 INFO - PROCESS | 3856 | RSS: Main: 185733120 14:28:14 INFO - PROCESS | 3856 | 14:28:17 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:17 INFO - PROCESS | 3856 | RSS: Main: 185692160 14:28:17 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50681/tests/kraken/driver.html?testName=ai-astar) 14:28:19 INFO - PROCESS | 3856 | RSS: Main: 186286080 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | __start_tp_report 14:28:19 INFO - PROCESS | 3856 | _x_x_mozilla_page_load 14:28:19 INFO - PROCESS | 3856 | _x_x_mozilla_page_load_details 14:28:19 INFO - PROCESS | 3856 | |i|pagename|runs| 14:28:19 INFO - PROCESS | 3856 | |0;ai-astar;102;111;107;111;110;111;114;111;110;110 14:28:19 INFO - PROCESS | 3856 | |1;audio-beat-detection;165;128;151;176;128;153;168;135;189;141 14:28:19 INFO - PROCESS | 3856 | |2;audio-dft;162;163;164;162;166;175;164;163;162;161 14:28:19 INFO - PROCESS | 3856 | |3;audio-fft;76;76;76;160;77;73;74;76;162;77 14:28:19 INFO - PROCESS | 3856 | |4;audio-oscillator;85;84;144;86;86;85;134;84;85;150 14:28:19 INFO - PROCESS | 3856 | |5;imaging-gaussian-blur;118;118;117;119;117;118;119;119;118;117 14:28:19 INFO - PROCESS | 3856 | |6;imaging-darkroom;149;147;147;148;148;147;146;147;147;147 14:28:19 INFO - PROCESS | 3856 | |7;imaging-desaturate;95;95;95;96;96;95;95;96;95;96 14:28:19 INFO - PROCESS | 3856 | |8;json-parse-financial;57;57;58;58;59;66;56;58;63;60 14:28:19 INFO - PROCESS | 3856 | |9;json-stringify-tinderbox;63;61;61;62;61;61;61;61;61;61 14:28:19 INFO - PROCESS | 3856 | |10;stanford-crypto-aes;80;79;80;81;81;80;80;80;92;80 14:28:19 INFO - PROCESS | 3856 | |11;stanford-crypto-ccm;135;123;127;119;122;139;121;143;132;124 14:28:19 INFO - PROCESS | 3856 | |12;stanford-crypto-pbkdf2;161;165;164;163;166;159;157;162;162;160 14:28:19 INFO - PROCESS | 3856 | |13;stanford-crypto-sha256-iterative;65;63;64;63;64;64;66;64;63;62 14:28:19 INFO - PROCESS | 3856 | __end_tp_report 14:28:19 INFO - PROCESS | 3856 | __start_cc_report 14:28:19 INFO - PROCESS | 3856 | _x_x_mozilla_cycle_collect,897 14:28:19 INFO - PROCESS | 3856 | __end_cc_report 14:28:19 INFO - PROCESS | 3856 | __startTimestamp1466976499857__endTimestamp 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | ------- Summary: start ------- 14:28:19 INFO - PROCESS | 3856 | Number of tests: 14 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:1.81 14:28:19 INFO - PROCESS | 3856 | Values: 102.0 111.0 107.0 111.0 110.0 111.0 114.0 111.0 110.0 110.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:159.00 stddev:20.86 (13.1%) stddev-sans-first:21.69 14:28:19 INFO - PROCESS | 3856 | Values: 165.0 128.0 151.0 176.0 128.0 153.0 168.0 135.0 189.0 141.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:4.05 (2.5%) stddev-sans-first:4.22 14:28:19 INFO - PROCESS | 3856 | Values: 162.0 163.0 164.0 162.0 166.0 175.0 164.0 163.0 162.0 161.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:36.02 (47.4%) stddev-sans-first:37.70 14:28:19 INFO - PROCESS | 3856 | Values: 76.0 76.0 76.0 160.0 77.0 73.0 74.0 76.0 162.0 77.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:85.00 stddev:28.12 (33.1%) stddev-sans-first:29.12 14:28:19 INFO - PROCESS | 3856 | Values: 85.0 84.0 144.0 86.0 86.0 85.0 134.0 84.0 85.0 150.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 14:28:19 INFO - PROCESS | 3856 | Values: 118.0 118.0 117.0 119.0 117.0 118.0 119.0 119.0 118.0 117.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 14:28:19 INFO - PROCESS | 3856 | Values: 149.0 147.0 147.0 148.0 148.0 147.0 146.0 147.0 147.0 147.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:28:19 INFO - PROCESS | 3856 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.50 stddev:3.08 (5.3%) stddev-sans-first:3.17 14:28:19 INFO - PROCESS | 3856 | Values: 57.0 57.0 58.0 58.0 59.0 66.0 56.0 58.0 63.0 60.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.33 14:28:19 INFO - PROCESS | 3856 | Values: 63.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:3.80 (4.8%) stddev-sans-first:4.00 14:28:19 INFO - PROCESS | 3856 | Values: 80.0 79.0 80.0 81.0 81.0 80.0 80.0 80.0 92.0 80.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:129.50 stddev:8.28 (6.4%) stddev-sans-first:8.44 14:28:19 INFO - PROCESS | 3856 | Values: 135.0 123.0 127.0 119.0 122.0 139.0 121.0 143.0 132.0 124.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.50 stddev:2.77 (1.7%) stddev-sans-first:2.92 14:28:19 INFO - PROCESS | 3856 | Values: 161.0 165.0 164.0 163.0 166.0 159.0 157.0 162.0 162.0 160.0 14:28:19 INFO - PROCESS | 3856 | 14:28:19 INFO - PROCESS | 3856 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:1.12 14:28:19 INFO - PROCESS | 3856 | Values: 65.0 63.0 64.0 63.0 64.0 64.0 66.0 64.0 63.0 62.0 14:28:19 INFO - PROCESS | 3856 | -------- Summary: end -------- 14:28:19 INFO - PROCESS | 3856 | 14:28:20 INFO - TEST-INFO | 3856: exit 0 14:28:20 INFO - TEST-OK | kraken | took 62194ms 14:28:20 INFO - SUITE-END | took 1176s 14:28:21 INFO - Completed test suite (00:19:36) 14:28:21 INFO - javascript benchmark 14:28:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7286.714337139891, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3141.5287706843974, 3177.761667874909, 3178.459661857487, 3193.1538142392255, 3193.2336239302576, 5496.065668836292, 5503.944960550393, 5508.366537848148, 5609.971950140254, 5624.072028115366, 5336.9733151334185, 5461.863453413666, 5512.834614961557, 5522.861928451791, 5558.944410555893, 4905.779239934202, 4915.041566894457, 5044.218146187329, 5121.820736274231, 5125.103106956286, 830.7178545882385, 4956.132676781567, 5007.424146223177, 5045.899082018375, 5084.262781896623, 4986.675866068712, 4996.3504744383, 5001.44984051754, 5010.398752149747, 5049.3183420238165, 4889.853304400874, 4980.800767969277, 5004.199328107486, 5079.390473143209, 5092.719900405476, 4917.459079501252, 4920.458749537548, 4921.434035085975, 4952.529509696573, 4967.652264341497, 5462.863428414282, 5513.365962914276, 5551.389347171848, 5552.944470555283, 5640.323161220639, 5888.146218798251, 5942.346341902387, 5950.553708471839, 5952.077427998667, 5955.731992060368, 6007.459328660441, 6034.547408944347, 6060.212172417601, 6064.120702498113, 6112.877742445126, 5642.351129620064, 5645.491905728504, 5647.181158731961, 5651.886962260773, 5656.547476201935, 5932.555058370639, 5962.642241465439, 5995.730192141364, 6035.969820150871, 6077.3314935357075, 5765.308163020464, 5846.853828654318, 5850.0932355484965, 5853.004989151769, 5872.677002764889, 5943.791967281124, 5953.196318496947, 5965.13505541694, 5967.492763115184, 5967.76128954837, 5748.367679555246, 5821.563382746226, 5903.911441328383, 5936.732847021808, 5951.047832346891, 5835.124731290341, 5945.10823376497, 5965.642061476326, 5970.970145149333, 6009.068594367793, 4522.909541809211, 4551.431071116111, 4562.384078149407, 4564.612007979359, 4605.40129783126, 3967.940480892789, 3993.0, 3994.6404823566018, 4021.9798901005306, 4066.044479547304, 5533.197686335539, 5560.999020176407, 5577.27495425592, 5588.441155884379, 5638.915416268759, 5830.62100963436, 5903.852403689856, 5948.226730525004, 5949.524038076944, 5953.28560572734, 5503.697296648723, 5613.101903695389, 5655.462731040545, 5672.319321681342, 5675.404082571353, 5148.073346797538, 5152.252923326097, 5162.896742065138, 5173.40505841833, 5187.06632806091, 5940.227770389822, 6178.505719542516, 6186.536009799283, 6190.7523699051535, 6204.658743769136, 5888.705564721747, 5925.6963468036965, 5955.523558115254, 5974.9103763444455, 5978.312494063239, 6117.816465506042, 6140.846478838065, 6157.230346206724, 6162.476189523762, 6188.257409110935, 5687.573431992534, 5742.712864356849, 5834.533237341087, 5843.0, 5860.443257890493, 5803.65178089316, 5891.675957822361, 5893.734781934738, 5899.882002359843, 5949.8215053548465, 5692.5445964321925, 5757.8560535986935, 5787.334456537552, 5789.218455508452, 5804.419558044162, 5681.119426488901, 5702.258706368146, 5763.94236057634, 5792.942070579409, 5810.7094645266725, 5525.11598144295, 5670.092785154356, 5699.059655156852, 5753.3958934311295, 5816.505597024131, 5854.2389489366105, 5865.94134058671, 5879.20630714848, 5893.469587737124, 5899.321578018411, 5587.608867379245, 5634.0422128239115, 5657.575681823797, 5721.971390143022, 5735.684537350486], "value": 5427.33246140342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.9942600573993, 609.5976655407432, 627.8650090230602, 628.9150964619776, 641.4355367276797, 41972.0, 43913.902152446164, 43936.34095488562, 44004.33993490096, 46275.0, 45437.545624543745, 45862.541374586246, 45904.54095459045, 45917.31124033142, 46032.0, 8911.50986695733, 9026.593803278836, 9028.50343231122, 9030.0, 9039.909600904006, 8833.514156721378, 8889.822203555925, 8915.643374265022, 8923.0, 8947.955260223689, 8983.865242021342, 8984.640614375417, 9002.0, 9016.8647470288, 9058.365914385995, 8920.286377089817, 8953.0, 8964.372493925428, 8976.102389761038, 9006.549672516348, 8844.11558844117, 8902.376833621649, 8965.641374345018, 8971.192592666692, 8978.50618215998, 41879.37180942288, 42152.0, 42293.0, 42297.57702422998, 42435.57564424378, 3554.413521768905, 3554.8044857532827, 3770.245950809849, 4023.6579890709327, 4334.461266250499, 32588.18529536757, 32710.509342359885, 32903.6709632903, 33103.33793324144, 33295.0, 4185.142045880587, 4218.135282267128, 4250.914981700349, 4345.152695224432, 4346.695731298811, 363863.0, 365566.0, 367046.0, 368756.499480041, 369387.0, 33341.83329083388, 60170.0, 61324.69337653283, 61606.0, 61704.38295617076, 34664.13339666528, 35686.0, 36740.63259367426, 36883.63116368802, 36891.63108368882, 15075.396984120513, 15127.092374457568, 15127.39490420393, 15139.772903406238, 15194.772078418833, 12776.0, 12779.361031948365, 12794.68013299675, 12812.103152779217, 12880.420381082873, 8304.958475207586, 8342.207490288412, 8381.203785640355, 8436.873446898302, 8444.197801208998, 3220.4847224444443, 3240.189952511872, 3284.244623736554, 3298.65364136767, 3303.966960330414, 960.6925783749273, 980.7253968888723, 1017.3641474078701, 1017.8015287019108, 1078.6224821312478, 31558.0, 31659.525107123412, 31775.841120794248, 31850.840745796588, 32117.19707007297, 1055.3826011783192, 1063.9574417023232, 1096.742265567591, 1150.3155622404656, 1187.6496433552122, 17018.659626807395, 17365.913170434065, 17368.39210627622, 18345.7248141278, 18482.630347392977, 561463.0, 563520.0, 571493.0, 575305.0, 576401.0, 57832.71083644639, 58705.41294587, 58928.0, 58945.705271474224, 59007.40992590105, 1367.5555444480583, 1378.7725025370903, 1417.6243295526695, 1418.1065928465, 1418.8864890808918, 31714.365712686078, 31861.68138318587, 31892.84053579717, 32666.673333266364, 32729.34541309208, 50688.74655626846, 51466.0, 51547.22679159891, 51563.74218128886, 51753.48246517637, 359925.0, 360833.0, 361724.0, 362649.0, 472740.0, 27834.721652784025, 27849.303767405978, 28155.0, 28215.858920705265, 28501.42997140087, 46635.76682116568, 46938.76530617325, 47289.763551182026, 47416.7629161852, 47823.76088119537, 38903.83288501349, 39806.402903957045, 40155.1968960625, 40757.38863916984, 41506.58493415027, 39288.60711392964, 40321.39517907175, 40630.39054414127, 40919.590804091575, 41579.0, 39260.0, 39842.402363963985, 40082.59917400789, 40305.79847100746, 40403.0, 33426.33147337088, 35331.64668353284, 36114.638853611126, 36539.451908220864, 36707.63292367042, 27955.580666289614, 28189.859050704614, 28499.28751781139, 28528.42943141084, 28590.285242869093], "value": 18989.081774062277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.9434581985612, 397.79911144871835, 399.34308063235994, 404.2924881457449, 417.32393522493544, 13823.654408639764, 17967.640647187047, 18962.905185474086, 19537.316193933217, 19563.804361956376, 18332.08339583019, 18740.718889216638, 18746.062696865138, 18914.527136821587, 19171.42485725427, 5607.130894711327, 5762.1068734346245, 5818.1272809078555, 5828.708564571754, 5866.090755932837, 5694.487496125348, 5742.54059675225, 5745.138229265602, 5755.597108202427, 5770.913436298438, 5545.916811247835, 5641.830745077634, 5680.801171958982, 5756.165356023374, 5758.395368486312, 5611.719414029282, 5654.660720356792, 5662.122371032497, 5668.971655141719, 5675.489205971462, 4861.0, 5027.069992051483, 5067.467915868818, 5075.720835354054, 5087.49125087492, 21559.676604850938, 22032.779672203233, 22244.221452249254, 22373.328800136023, 22427.663585046237, 2506.3859354458273, 2588.974110258911, 3022.4710675631895, 3043.8325892075927, 3107.9533806992913, 9557.761055973588, 10125.797484050277, 13529.729405411936, 14048.43806247749, 14690.485832995793, 1933.236371633211, 1954.198778500822, 1982.0882394098733, 1999.730036445076, 2051.271798511522, 53528.0, 70606.29393706049, 73665.0, 75017.24982750157, 83952.0, 10077.294589378673, 10553.894461055444, 10862.131029517619, 11047.226694131334, 11107.611233606785, 15034.473793417177, 15126.621834454227, 15162.696746065238, 15266.923665381602, 15290.923545382202, 7937.880931786028, 8122.106568277485, 8293.668253269801, 8326.084130745614, 8337.874931876027, 7768.456208065494, 7769.572673503011, 8034.821189823055, 8092.9479167709, 8141.8371632568205, 4556.703814252063, 4655.813767449332, 4657.86026419208, 4667.649926255544, 4702.27114797207, 1847.464235371754, 1898.2596787252983, 1911.9848318530974, 1920.8847469151895, 1951.0, 858.6050416808213, 952.8523078922778, 962.6967505235829, 966.2221911361421, 1036.730450082984, 17941.7308740369, 18645.533861653297, 18858.15138318779, 18890.244390224238, 18993.240270389306, 973.2992245583168, 975.3806332978468, 986.3637953520083, 986.3982970388201, 1031.9122874555746, 10047.799044019079, 10344.844827327595, 10456.372617642966, 10537.473126343652, 10572.207084468695, 483911.0, 490736.0, 492056.0, 498344.0, 502249.0, 55481.72259138679, 67762.0, 91950.54024729834, 92108.53945730363, 94265.52867235757, 939.5255396024963, 971.3734641156556, 975.9072888075622, 976.0824824664793, 987.8616993620755, 15079.849201508283, 16421.91789041047, 16566.83433165653, 16826.663466730843, 17326.306947722453, 36390.0, 40184.59815401925, 42291.57708422876, 42845.78577107094, 43043.7847810759, 57243.71378143083, 58004.0, 58962.705186473795, 59000.1149982742, 59755.402445974985, 8635.87046194295, 8654.30765538768, 8722.040575536812, 8737.43206691563, 8771.07903670131, 9779.608815647294, 12526.686832828887, 12658.936705316415, 12998.805017924928, 13433.462661493822, 11009.2843965142, 11621.76756464883, 11836.349000805038, 12054.0, 12131.514739410324, 11675.708107297385, 11760.059195264188, 11788.410579471163, 11933.940330298294, 11997.76004479888, 11604.6518604442, 12013.399330033288, 12096.637100886988, 12132.514699411924, 12461.626151215478, 7777.455578109478, 8301.83396332082, 8371.916280837357, 8440.704575339834, 8492.532910689972, 10815.783684326112, 11438.656840294805, 12118.818217726917, 12160.331181785086, 12167.087468440079], "value": 9123.943786966269, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.729301432728, 1475.8229012518498, 1579.226179172206, 1709.8375654312836, 1740.8085110637828, 7562.735304264352, 8225.424220304581, 8354.289885359743, 8860.955695221523, 8878.822423551534, 8195.836083278331, 8360.707375241867, 8505.404621676485, 8544.145585441453, 8582.399232053758, 2347.788699017088, 2414.4808866093786, 2420.092465325503, 2423.4547226873988, 2427.5509030829353, 2269.818414526842, 2334.7898689117974, 2353.9411514712097, 2382.0471811275456, 2391.234804862445, 2339.1812865497027, 2352.0121548949396, 2369.869657168855, 2376.702912135983, 2390.8326417150806, 2280.5324908393823, 2305.3660243433023, 2305.6426253930667, 2308.7575804540447, 2375.798057165143, 2318.675385446039, 2340.7659234076627, 2343.4961483281177, 2354.835161538693, 2360.6459031145296, 8586.098459661707, 8698.956505217433, 8709.825803483895, 8709.95645021777, 8722.433041852322, 5212.4266330703595, 5332.066888294572, 5337.653052551572, 5341.145416733343, 5341.732913354317, 3419.093940105874, 3431.7769344992744, 3448.758586898918, 3481.3211423772373, 3492.4237500812337, 1177.5643012085584, 1192.6243233381545, 1220.6277085488923, 1229.6802831263847, 1234.8271242026124, 11596.130290228266, 11668.708282292926, 11760.647180584596, 11806.586769463027, 11808.763824723457, 4595.759145030823, 4599.103174880933, 4767.380240568704, 4768.593264986837, 4781.282807578891, 9981.900180998096, 10005.099541041342, 10013.098821106136, 10017.148542373834, 10023.2482563808, 5256.185291279858, 5300.496452836975, 5336.386315573759, 5342.839714808562, 5355.3305836770405, 4330.350447432847, 4834.613230941586, 4840.7337596432535, 5004.124278251292, 5006.199008158677, 4119.361498967664, 4122.237386083524, 4148.958510414857, 4149.688773341951, 4176.352665336878, 1260.2816394655142, 1268.289757735671, 1285.4986555243463, 1295.5659853949032, 1312.8162057311984, 845.9407841451163, 905.3391024552113, 932.421898422982, 998.7976511791483, 1010.0909181736496, 5856.765729370777, 5940.34656187819, 5998.760049598054, 6148.1085242639565, 6216.316205217422, 968.3173362779223, 973.0609961387295, 985.2069084386994, 988.7725823060737, 1013.4020927652721, 4368.0, 4401.889952751143, 4423.646108311327, 4435.157320109169, 4446.644268458515, 10412.479376031168, 10889.401082940356, 10912.50893709785, 10967.50646220922, 10983.50574224146, 9933.602655893828, 10236.078752912124, 10284.794304114026, 10633.627823026158, 10901.781964360669, 7825.726099586487, 8022.919770802334, 8036.6383512740895, 8036.879446808302, 8052.959735201286, 6239.812805615838, 6370.840728981812, 6491.636756281045, 6496.967515162394, 6499.4800415965665, 9907.752306192402, 10034.1972642187, 10085.747856303651, 10096.444695541522, 10129.696109116738, 10216.54025568866, 10347.379157250589, 10427.94786026065, 10514.158867290751, 10527.210459215743, 6990.23107458169, 7527.473076884785, 7827.178146294557, 7828.13890472059, 7944.404169687181, 8593.226609605166, 8614.569271536524, 8635.56822158877, 8661.826763464569, 8682.175193356621, 7414.332710056121, 7710.0, 7733.4973226740085, 7773.455858089879, 7871.960640196762, 7592.658330375036, 7652.196519365387, 7695.0, 7702.229777022253, 7788.571628560484, 6848.246692863681, 6889.448844092561, 6919.792406227822, 6931.514793964374, 6953.930460695531, 5167.147420675697, 5334.226537152169, 5397.649152805055, 5445.727713614224, 5475.534579560782, 5273.841784746463, 5292.5501332387175, 5410.97294513525, 5460.535854452257, 5490.9841679287865], "value": 4682.172186269134, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.14552417424596, 320.2713826045747, 324.8846659435899, 330.8759215294265, 331.75947438107374, 5649.915251271229, 5687.118496633018, 5705.857353566158, 5741.540676745861, 5742.712864356787, 5641.8589535261635, 5646.273459516719, 5675.148727690848, 5687.374388817238, 5746.310442746866, 4112.0, 4176.394422808691, 4297.763623000734, 4304.450397856769, 4332.176886391591, 4287.485501739796, 4312.310030395138, 4316.935245971313, 4335.609795118438, 4338.739675619458, 4303.289957157065, 4318.82724691012, 4331.4802223733195, 4332.162433605993, 4340.97829510852, 4108.712390132692, 4221.409002739619, 4235.91528169438, 4244.830206791725, 4315.395844581761, 3682.3187710273687, 3699.297133544645, 3700.111973126457, 3704.25914817035, 3711.1278849470355, 5391.460853914617, 5456.454354564551, 5481.397046324901, 5481.75332110056, 5518.806841760559, 4857.611391088704, 4883.658143929926, 4932.087563800708, 4944.777485013183, 4950.306957025983, 5842.970785146047, 5846.912296315559, 5860.472557469806, 5869.589128760988, 5906.763729450817, 4144.088300573869, 4152.231837110114, 4169.395437661552, 4184.581541845821, 4190.769507677077, 5981.491573216282, 6033.366496517846, 6072.908906366408, 6082.878342433127, 6088.391160883921, 4148.751074935453, 4165.583961302437, 4178.874633760992, 4182.958170418317, 4194.643455306272, 4231.4710661167355, 4238.978805105955, 4240.5123410808155, 4244.575542445792, 4261.680373971964, 4732.881677958078, 4842.709437433765, 4876.609871210366, 4877.219644856877, 4920.852374428773, 5795.1886735857015, 5835.503982161564, 5860.970695146497, 5909.438603332676, 5916.911246331309, 1433.433793651502, 1449.3840117949828, 1463.0343972977785, 1472.6023973527301, 1476.60131764423, 921.4839689773748, 932.4358762948455, 946.394307643109, 969.709087273815, 996.6661168508485, 5570.777168913198, 5571.916421253684, 5593.412691667317, 5599.160125981135, 5606.523445507178, 5982.551308651869, 5987.9101813472835, 6015.578909476295, 6020.217371741734, 6021.729022194012, 5408.810691625774, 5603.439656034446, 5606.635568688022, 5636.971815140898, 5648.181013752983, 3178.98410507946, 3201.6158061032825, 3202.647708752035, 3205.7916235444623, 3221.2108033531936, 5905.498032667271, 6104.511639068864, 6175.3515880831865, 6205.393734631466, 6212.627242365473, 6006.219191505076, 6052.576319657582, 6060.303065147476, 6071.635701857903, 6098.298695650057, 6117.388261173847, 6132.325444201045, 6193.473554747807, 6194.473469755121, 6228.22147231596, 5673.449996040819, 5878.326046221112, 5885.793997210077, 5983.521318294439, 6013.218281623361, 5855.94144058554, 5916.852078698067, 5961.850953726192, 5970.611910225822, 6022.939770602238, 6054.424829641177, 6174.351693072343, 6206.162168107247, 6260.154879091265, 6265.310815810349, 4194.979025104855, 4201.676471911338, 4222.3244280914905, 4225.33099425719, 4225.5351911290345, 6048.274207095177, 6085.604435711842, 6102.176206212104, 6117.0, 6118.418750218722, 5633.155026746021, 5823.7379317931645, 5832.300123985149, 5845.240118784531, 5856.047168161559, 5786.652800831964, 5847.619904706181, 5853.473187413153, 5878.706064696663, 5893.850699113803, 5227.503387178212, 5709.286339207599, 5782.5663075268685, 5797.9420205797405, 5805.390434004369, 5921.851953701192, 5946.702664866826, 5948.910766338422, 5953.880922381615, 5981.3420523743225, 5800.941990580209, 5820.097884827858, 5825.94174058254, 5829.562782791223, 5845.649261044351], "value": 4429.158306185083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.8878168274755, 770.3644493293035, 776.8679324514834, 777.5956502618639, 831.2975535672358, 14844.628884277898, 15329.463468778595, 15369.769453458208, 15434.691306173883, 15499.457518986837, 14622.488212912524, 14646.926765366159, 14808.55574332769, 14833.0, 14862.182579958126, 654.7021105397033, 783.1933108897845, 788.8777239527868, 804.9839003219961, 807.725373373053, 795.7254747112266, 796.3430170109654, 800.747764454198, 804.505229283992, 804.5132694719698, 848.6690190825583, 849.7280870121564, 853.4111463090447, 853.9146085391474, 854.4616891358436, 847.7711018025129, 848.0374774630808, 848.8302339532119, 849.049065047145, 849.545493161162, 610.9644153160394, 615.4368752591373, 615.9322474527798, 617.8887800195963, 618.5886385553601, 14580.635484112876, 14601.926990365086, 14678.0, 14701.411943522246, 14772.630684232872, 14281.642958926006, 14702.926485367505, 14883.404663813542, 15053.47312844056, 15074.472393466176, 11920.761584768255, 11965.46155423008, 12041.578544750892, 12225.327606981613, 12277.447514861853, 3923.391874259494, 3923.607639236082, 3939.1333906540804, 3963.8414463421427, 4018.1561872006914, 74079.0068729714, 76738.0, 76922.23077769151, 78926.0, 79397.60301198515, 11664.883351166549, 11696.239744416756, 11839.704007399883, 11935.761284774257, 12046.216995895238, 21847.781522184894, 21882.671759923614, 21989.780102199093, 22073.889630552065, 22159.778402216092, 8657.437266577652, 8665.696700615574, 8827.69103081389, 8944.776380590538, 8982.730518084469, 4992.2511623256805, 5038.899222015539, 5074.3657042869645, 5088.821891233789, 5101.489851014869, 3349.916252093717, 3449.724022078278, 3459.9481007784902, 3461.6365281645067, 3470.548828652259, 618.9783357582553, 634.8222497700651, 637.5568979559255, 647.8088963755704, 653.7809833705762, 732.0812380462486, 747.4879707400448, 749.3892477630714, 756.9432292578078, 786.3709032773758, 9276.900833812037, 9330.393524420891, 9484.146426821619, 9600.567974441166, 9628.518574071268, 665.6438805239173, 722.5556282885988, 761.6191904047976, 765.9085802731197, 774.403709143956, 4388.758618276025, 4486.304622783474, 4684.8756298488115, 4723.197056500403, 4760.406836531429, 108068.0, 111935.0, 111942.44028779805, 113418.43290783493, 114358.42820785842, 95265.0, 96961.0, 96974.0, 98228.0, 99596.0, 86669.0, 86853.5657321722, 86955.0, 87336.0, 91147.54426227826, 8763.474191548528, 8824.691135810215, 8899.243564296848, 8958.10418958099, 9119.589618467318, 50124.0, 50805.745971269906, 50985.490145098076, 51501.7424912873, 53070.0, 51824.48175518347, 70799.0, 75242.35682323738, 75577.24422755702, 76120.0, 14090.647733806736, 14142.292885355897, 14485.348159333065, 14487.0, 14715.411383544966, 15245.466408675644, 15292.158931258888, 15372.769408458658, 16508.33966641369, 16561.42035028768, 13605.931970340482, 14028.0, 14439.350229239499, 14716.705665886837, 15281.0, 14867.851321486647, 14869.330880110205, 15454.922725386301, 15629.531114066596, 15713.978591391522, 13512.864871351554, 13576.185428873903, 13884.58346249614, 14396.0, 15104.54686359411, 11262.197888774033, 11417.429128543707, 11806.173567850168, 11843.230190037964, 12132.150749447454, 11756.23584467007, 11885.405729713308, 12004.279743215435, 12006.879931200576, 12238.571649992564], "value": 7675.534445764071, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 107.0, 111.0, 110.0, 111.0, 114.0, 111.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 128.0, 151.0, 176.0, 128.0, 153.0, 168.0, 135.0, 189.0, 141.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 162.0, 166.0, 175.0, 164.0, 163.0, 162.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 160.0, 77.0, 73.0, 74.0, 76.0, 162.0, 77.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 144.0, 86.0, 86.0, 85.0, 134.0, 84.0, 85.0, 150.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 119.0, 117.0, 118.0, 119.0, 119.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 148.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 58.0, 59.0, 66.0, 56.0, 58.0, 63.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 81.0, 81.0, 80.0, 80.0, 80.0, 92.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 127.0, 119.0, 122.0, 139.0, 121.0, 143.0, 132.0, 124.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 164.0, 163.0, 166.0, 159.0, 157.0, 162.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 64.0, 64.0, 66.0, 64.0, 63.0, 62.0], "value": 63.8, "unit": "score"}]}]} 14:28:21 INFO - Return code: 0 14:28:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:28:21 ERROR - # TBPL SUCCESS # 14:28:21 INFO - Running post-action listener: _resource_record_post_action 14:28:21 INFO - ##### 14:28:21 INFO - ##### Finished run-tests step (success) 14:28:21 INFO - ##### 14:28:21 INFO - Running post-run listener: _resource_record_post_run 14:28:21 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7823360; Write bytes: 305221632; Read time: 1872; Write time: 275092 14:28:21 INFO - TinderboxPrint: CPU usage
13.4% 14:28:21 INFO - TinderboxPrint: I/O read bytes / time
7,823,360 / 1,872 14:28:21 INFO - TinderboxPrint: I/O write bytes / time
305,221,632 / 275,092 14:28:21 INFO - TinderboxPrint: CPU idle
8,254.9 (86.6%) 14:28:21 INFO - TinderboxPrint: CPU user
1,217.8 (12.8%) 14:28:21 INFO - TinderboxPrint: Swap in / out
0 / 0 14:28:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14815232; Read time: 0; Write time: 4608 14:28:21 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6062080; Write bytes: 290406400; Read time: 1832; Write time: 270484 14:28:21 INFO - Running post-run listener: _upload_blobber_files 14:28:21 INFO - Blob upload gear active. 14:28:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:28:21 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 14:28:21 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:28:21 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:28:22 INFO - (blobuploader) - INFO - Open directory for files ... 14:28:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:28:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:28:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:25 INFO - (blobuploader) - INFO - Done attempting. 14:28:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:28:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:26 INFO - (blobuploader) - INFO - Done attempting. 14:28:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:28:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:28:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:27 INFO - (blobuploader) - INFO - Done attempting. 14:28:27 INFO - (blobuploader) - INFO - Iteration through files over. 14:28:27 INFO - Return code: 0 14:28:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:28:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:28:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67c78a02d1102517ca435aa24ecb3c6809f2e7a275e7061da09f45f22c8a7b9699ee796b23acf33cc23bb35fc260dc501f64d885aa3b716ad2acc57c9bbf8b70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90554078d365f4fcc8d01df3c37eb465154cd42d67131eb08d300b113a13d56a20b4905db04f20f1529e52e47be3081211d9a5e6c102e639af8d279aca050a97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42cf497135bb6022193530a24fbaa1694a5476f04dc08232a9d1d268fb25f69ba0040932e163707b698c0cb5b55db0fd41a04df27436ea4bcdce78a61de0da09"} 14:28:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:28:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:28:27 INFO - Contents: 14:28:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67c78a02d1102517ca435aa24ecb3c6809f2e7a275e7061da09f45f22c8a7b9699ee796b23acf33cc23bb35fc260dc501f64d885aa3b716ad2acc57c9bbf8b70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90554078d365f4fcc8d01df3c37eb465154cd42d67131eb08d300b113a13d56a20b4905db04f20f1529e52e47be3081211d9a5e6c102e639af8d279aca050a97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42cf497135bb6022193530a24fbaa1694a5476f04dc08232a9d1d268fb25f69ba0040932e163707b698c0cb5b55db0fd41a04df27436ea4bcdce78a61de0da09"} 14:28:27 INFO - Running post-run listener: copy_logs_to_upload_dir 14:28:27 INFO - Copying logs to upload dir... 14:28:27 INFO - mkdir: /builds/slave/test/build/upload/logs 14:28:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.086637 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-26 14:28:27.434276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 14:28:27.437810) ========= 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=0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67c78a02d1102517ca435aa24ecb3c6809f2e7a275e7061da09f45f22c8a7b9699ee796b23acf33cc23bb35fc260dc501f64d885aa3b716ad2acc57c9bbf8b70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90554078d365f4fcc8d01df3c37eb465154cd42d67131eb08d300b113a13d56a20b4905db04f20f1529e52e47be3081211d9a5e6c102e639af8d279aca050a97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42cf497135bb6022193530a24fbaa1694a5476f04dc08232a9d1d268fb25f69ba0040932e163707b698c0cb5b55db0fd41a04df27436ea4bcdce78a61de0da09"} build_url:https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011012 build_url: 'https://queue.taskcluster.net/v1/task/D1_ix0txSc6tdfH1Q_BcBQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67c78a02d1102517ca435aa24ecb3c6809f2e7a275e7061da09f45f22c8a7b9699ee796b23acf33cc23bb35fc260dc501f64d885aa3b716ad2acc57c9bbf8b70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90554078d365f4fcc8d01df3c37eb465154cd42d67131eb08d300b113a13d56a20b4905db04f20f1529e52e47be3081211d9a5e6c102e639af8d279aca050a97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42cf497135bb6022193530a24fbaa1694a5476f04dc08232a9d1d268fb25f69ba0040932e163707b698c0cb5b55db0fd41a04df27436ea4bcdce78a61de0da09"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 14:28:27.463597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 14:28:27.463931) ========= 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=0e2a256762fed810e2f0f810000001b3-1466974846.720790-1757285967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 14:28:27.550196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 14:28:27.550672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 14:28:27.551023) ========= ========= Total master_lag: 0.19 =========