builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1465917076.02 results: success (0) buildid: 20160614053033 builduid: fa9b71cac7904fd4b7e42bf559cb37a1 revision: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:16.016611) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:16.017138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:16.017494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:16.032600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:16.032932) ========= 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-1465915542.324287-1955222013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 08:11:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-06-14 08:11:17 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077709 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:16.128802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:16.129262) ========= 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-1465915542.324287-1955222013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018287 ========= master_lag: 0.23 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:16.379879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:16.380218) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 --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 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 --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-1465915542.324287-1955222013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 08:11:18,092 truncating revision to first 12 chars 2016-06-14 08:11:18,092 Setting DEBUG logging. 2016-06-14 08:11:18,093 attempt 1/10 2016-06-14 08:11:18,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5003caf3aa25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 08:11:18,481 unpacking tar archive at: fx-team-5003caf3aa25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711284 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:17.127085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:17.127385) ========= script_repo_revision: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:17.127785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:17.128045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 08:11:17.142176) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-14 08:11:17.142498) ========= /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-1465915542.324287-1955222013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:11:18 INFO - MultiFileLogger online at 20160614 08:11:18 in /builds/slave/test 08:11:18 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 08:11:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:11:18 INFO - {'append_to_log': False, 08:11:18 INFO - 'base_work_dir': '/builds/slave/test', 08:11:18 INFO - 'blob_upload_branch': 'Fx-Team', 08:11:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:11:18 INFO - 'branch': 'Fx-Team', 08:11:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:18 INFO - 'config_files': ('talos/linux_config.py',), 08:11:18 INFO - 'default_actions': ('clobber', 08:11:18 INFO - 'read-buildbot-config', 08:11:18 INFO - 'download-and-extract', 08:11:18 INFO - 'populate-webroot', 08:11:18 INFO - 'create-virtualenv', 08:11:18 INFO - 'install', 08:11:18 INFO - 'run-tests'), 08:11:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:18 INFO - 'download_minidump_stackwalk': True, 08:11:18 INFO - 'download_symbols': 'ondemand', 08:11:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:18 INFO - 'installer_path': 'installer.exe', 08:11:18 INFO - 'log_level': 'info', 08:11:18 INFO - 'log_name': 'talos', 08:11:18 INFO - 'log_to_console': True, 08:11:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:11:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:11:18 INFO - 'opt_config_files': (), 08:11:18 INFO - 'pip_index': False, 08:11:18 INFO - 'sps_profile': False, 08:11:18 INFO - 'sps_profile_interval': 0, 08:11:18 INFO - 'suite': 'dromaeojs-e10s', 08:11:18 INFO - 'system_bits': '32', 08:11:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:18 INFO - 'title': 'talos-linux64-ix-058', 08:11:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:18 INFO - 'use_talos_json': True, 08:11:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:11:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:18 INFO - 'work_dir': 'build'} 08:11:18 INFO - ##### 08:11:18 INFO - ##### Running clobber step. 08:11:18 INFO - ##### 08:11:18 INFO - Running pre-action listener: _resource_record_pre_action 08:11:18 INFO - Running main action method: clobber 08:11:18 INFO - rmtree: /builds/slave/test/build 08:11:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:11:19 INFO - Running post-action listener: _resource_record_post_action 08:11:19 INFO - ##### 08:11:19 INFO - ##### Finished clobber step (success) 08:11:19 INFO - ##### 08:11:19 INFO - ##### 08:11:19 INFO - ##### Running read-buildbot-config step. 08:11:19 INFO - ##### 08:11:19 INFO - Running pre-action listener: _resource_record_pre_action 08:11:19 INFO - Running main action method: read_buildbot_config 08:11:19 INFO - Using buildbot properties: 08:11:19 INFO - { 08:11:19 INFO - "project": "", 08:11:19 INFO - "product": "firefox", 08:11:19 INFO - "script_repo_revision": "production", 08:11:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:11:19 INFO - "repository": "", 08:11:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:11:19 INFO - "buildid": "20160614053033", 08:11:19 INFO - "pgo_build": "True", 08:11:19 INFO - "basedir": "/builds/slave/test", 08:11:19 INFO - "buildnumber": 832, 08:11:19 INFO - "slavename": "talos-linux64-ix-058", 08:11:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:11:19 INFO - "platform": "ubuntu64_hw", 08:11:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:11:19 INFO - "branch": "fx-team", 08:11:19 INFO - "repo_path": "integration/fx-team", 08:11:19 INFO - "revision": "5003caf3aa25dad509e53c68d2ee39de58fe5ec5", 08:11:19 INFO - "stage_platform": "linux64-pgo", 08:11:19 INFO - "builduid": "fa9b71cac7904fd4b7e42bf559cb37a1", 08:11:19 INFO - "slavebuilddir": "test" 08:11:19 INFO - } 08:11:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:11:19 INFO - Running post-action listener: _resource_record_post_action 08:11:19 INFO - ##### 08:11:19 INFO - ##### Finished read-buildbot-config step (success) 08:11:19 INFO - ##### 08:11:19 INFO - ##### 08:11:19 INFO - ##### Running download-and-extract step. 08:11:19 INFO - ##### 08:11:19 INFO - Running pre-action listener: _resource_record_pre_action 08:11:19 INFO - Running main action method: download_and_extract 08:11:19 INFO - mkdir: /builds/slave/test/build/tests 08:11:19 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')]} 08:11:19 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:11:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:20 INFO - Downloaded 1361 bytes. 08:11:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:20 INFO - Using the following test package requirements: 08:11:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:11:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:20 INFO - u'jsshell-linux-x86_64.zip'], 08:11:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:11:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:11:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11:20 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')]} 08:11:20 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:21 INFO - Downloaded 24219727 bytes. 08:11:21 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'] 08:11:21 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 08:11:22 INFO - Return code: 0 08:11:22 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 08:11: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')]} 08:11:22 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:32 INFO - Downloaded 24219727 bytes. 08:11:32 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'] 08:11:32 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 08:11:33 INFO - Return code: 0 08:11:33 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')]} 08:11:33 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:11:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:34 INFO - Downloaded 14405384 bytes. 08:11:34 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'] 08:11:34 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 08:11:34 INFO - Return code: 0 08:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:34 INFO - https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:11:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqDFH2XlQLOpBaq642OTZQ/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 08:11:36 INFO - Downloaded 59341232 bytes. 08:11:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:36 INFO - mkdir: /builds/slave/test/properties 08:11:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:36 INFO - Contents: 08:11:36 INFO - build_url:https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:36 INFO - Running post-action listener: _resource_record_post_action 08:11:36 INFO - Running post-action listener: set_extra_try_arguments 08:11:36 INFO - ##### 08:11:36 INFO - ##### Finished download-and-extract step (success) 08:11:36 INFO - ##### 08:11:36 INFO - ##### 08:11:36 INFO - ##### Running populate-webroot step. 08:11:36 INFO - ##### 08:11:36 INFO - Running pre-action listener: _resource_record_pre_action 08:11:36 INFO - Running main action method: populate_webroot 08:11:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:36 INFO - '--tppagecycles', 08:11:36 INFO - '7'], 08:11:36 INFO - 'tests': ['tsvgm']}}, 08:11:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:36 INFO - 'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:36 INFO - 'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['damp', 'tps']}, 08:11:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:36 INFO - 'tests': ['damp', 'tps']}, 08:11:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['dromaeo_dom']}, 08:11:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['basic_compositor_video']}, 08:11:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:11:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['a11yr', 08:11:36 INFO - 'ts_paint', 08:11:36 INFO - 'tpaint', 08:11:36 INFO - 'sessionrestore', 08:11:36 INFO - 'sessionrestore_no_auto_restore', 08:11:36 INFO - 'tabpaint']}, 08:11:36 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:36 INFO - 'ts_paint', 08:11:36 INFO - 'tpaint', 08:11:36 INFO - 'sessionrestore', 08:11:36 INFO - 'sessionrestore_no_auto_restore', 08:11:36 INFO - 'tabpaint']}, 08:11:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:36 INFO - 'ts_paint', 08:11:36 INFO - 'tpaint', 08:11:36 INFO - 'sessionrestore', 08:11:36 INFO - 'sessionrestore_no_auto_restore', 08:11:36 INFO - 'tabpaint']}, 08:11:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:36 INFO - 'ts_paint', 08:11:36 INFO - 'tpaint', 08:11:36 INFO - 'sessionrestore', 08:11:36 INFO - 'sessionrestore_no_auto_restore', 08:11:36 INFO - 'tabpaint']}, 08:11:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['a11yr', 08:11:36 INFO - 'ts_paint', 08:11:36 INFO - 'tpaint', 08:11:36 INFO - 'sessionrestore', 08:11:36 INFO - 'sessionrestore_no_auto_restore', 08:11:36 INFO - 'tabpaint']}, 08:11:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['a11yr', 08:11:36 INFO - 'ts_paint', 08:11:36 INFO - 'tpaint', 08:11:36 INFO - 'sessionrestore', 08:11:36 INFO - 'sessionrestore_no_auto_restore', 08:11:36 INFO - 'tabpaint']}, 08:11:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['tsvgx', 08:11:36 INFO - 'tsvgr_opacity', 08:11:36 INFO - 'tart', 08:11:36 INFO - 'tscrollx', 08:11:36 INFO - 'cart']}, 08:11:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:36 INFO - 'tsvgr_opacity', 08:11:36 INFO - 'tart', 08:11:36 INFO - 'tscrollx', 08:11:36 INFO - 'cart']}, 08:11:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:36 INFO - 'talos_options': ['--disable-e10s'], 08:11:36 INFO - 'tests': ['tp5o']}, 08:11:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:36 INFO - 'tests': ['tp5o']}, 08:11:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:36 INFO - 'talos_options': ['--disable-e10s', 08:11:36 INFO - '--xperf_path', 08:11:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:36 INFO - 'tests': ['tp5n']}, 08:11:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:36 INFO - 'talos_options': ['--xperf_path', 08:11:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:36 INFO - 'tests': ['tp5n']}}, 08:11:36 INFO - 'talos.zip': {'path': '', 08:11:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:36 INFO - Running post-action listener: _resource_record_post_action 08:11:36 INFO - ##### 08:11:36 INFO - ##### Finished populate-webroot step (success) 08:11:36 INFO - ##### 08:11:36 INFO - ##### 08:11:36 INFO - ##### Running create-virtualenv step. 08:11:36 INFO - ##### 08:11:36 INFO - Running pre-action listener: _resource_record_pre_action 08:11:36 INFO - Running main action method: create_virtualenv 08:11:36 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:36 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 08:11:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:37 INFO - Using real prefix '/usr' 08:11:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:39 INFO - Installing pip.................done. 08:11:39 INFO - Return code: 0 08:11:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11:39 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')]} 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 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')]} 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:39 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 08:11:39 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 08:11:39 INFO - Using env: {'DISPLAY': ':0', 08:11:39 INFO - 'HOME': '/home/cltbld', 08:11:39 INFO - 'LANG': 'en_US.UTF-8', 08:11:39 INFO - 'LANGUAGE': 'en_US:en', 08:11:39 INFO - 'LOGNAME': 'cltbld', 08:11:39 INFO - 'MAIL': '/var/mail/cltbld', 08:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:39 INFO - 'MOZ_NO_REMOTE': '1', 08:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:39 INFO - 'NO_EM_RESTART': '1', 08:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:39 INFO - 'PWD': '/builds/slave/test', 08:11:39 INFO - 'SHELL': '/bin/bash', 08:11:39 INFO - 'SHLVL': '1', 08:11:39 INFO - 'TERM': 'linux', 08:11:39 INFO - 'TMOUT': '86400', 08:11:39 INFO - 'USER': 'cltbld', 08:11:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:39 INFO - '_': '/tools/buildbot/bin/python'} 08:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:39 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 08:11:39 INFO - Cleaning up... 08:11:39 INFO - Return code: 0 08:11:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11:39 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')]} 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 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')]} 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:39 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 08:11:39 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 08:11:39 INFO - Using env: {'DISPLAY': ':0', 08:11:39 INFO - 'HOME': '/home/cltbld', 08:11:39 INFO - 'LANG': 'en_US.UTF-8', 08:11:39 INFO - 'LANGUAGE': 'en_US:en', 08:11:39 INFO - 'LOGNAME': 'cltbld', 08:11:39 INFO - 'MAIL': '/var/mail/cltbld', 08:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:39 INFO - 'MOZ_NO_REMOTE': '1', 08:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:39 INFO - 'NO_EM_RESTART': '1', 08:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:39 INFO - 'PWD': '/builds/slave/test', 08:11:39 INFO - 'SHELL': '/bin/bash', 08:11:39 INFO - 'SHLVL': '1', 08:11:39 INFO - 'TERM': 'linux', 08:11:39 INFO - 'TMOUT': '86400', 08:11:39 INFO - 'USER': 'cltbld', 08:11:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:39 INFO - '_': '/tools/buildbot/bin/python'} 08:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:39 INFO - Downloading/unpacking psutil>=3.1.1 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:41 INFO - Installing collected packages: psutil 08:11:41 INFO - Running setup.py install for psutil 08:11:42 INFO - building 'psutil._psutil_linux' extension 08:11:42 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 08:11:42 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 08:11:42 INFO - building 'psutil._psutil_posix' extension 08:11:42 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 08:11:42 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 08:11:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:42 INFO - Successfully installed psutil 08:11:42 INFO - Cleaning up... 08:11:42 INFO - Return code: 0 08:11:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:42 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:42 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 08:11:42 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 08:11:42 INFO - Using env: {'DISPLAY': ':0', 08:11:42 INFO - 'HOME': '/home/cltbld', 08:11:42 INFO - 'LANG': 'en_US.UTF-8', 08:11:42 INFO - 'LANGUAGE': 'en_US:en', 08:11:42 INFO - 'LOGNAME': 'cltbld', 08:11:42 INFO - 'MAIL': '/var/mail/cltbld', 08:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:42 INFO - 'MOZ_NO_REMOTE': '1', 08:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:42 INFO - 'NO_EM_RESTART': '1', 08:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:42 INFO - 'PWD': '/builds/slave/test', 08:11:42 INFO - 'SHELL': '/bin/bash', 08:11:42 INFO - 'SHLVL': '1', 08:11:42 INFO - 'TERM': 'linux', 08:11:42 INFO - 'TMOUT': '86400', 08:11:42 INFO - 'USER': 'cltbld', 08:11:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:42 INFO - '_': '/tools/buildbot/bin/python'} 08:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:42 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 08:11:42 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 08:11:42 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 08:11:42 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 08:11:42 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 08:11:42 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 08:11:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:44 INFO - Installing collected packages: mozsystemmonitor 08:11:44 INFO - Running setup.py install for mozsystemmonitor 08:11:44 INFO - Successfully installed mozsystemmonitor 08:11:44 INFO - Cleaning up... 08:11:44 INFO - Return code: 0 08:11:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:44 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:44 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 08:11:44 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 08:11:44 INFO - Using env: {'DISPLAY': ':0', 08:11:44 INFO - 'HOME': '/home/cltbld', 08:11:44 INFO - 'LANG': 'en_US.UTF-8', 08:11:44 INFO - 'LANGUAGE': 'en_US:en', 08:11:44 INFO - 'LOGNAME': 'cltbld', 08:11:44 INFO - 'MAIL': '/var/mail/cltbld', 08:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:44 INFO - 'MOZ_NO_REMOTE': '1', 08:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:44 INFO - 'NO_EM_RESTART': '1', 08:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:44 INFO - 'PWD': '/builds/slave/test', 08:11:44 INFO - 'SHELL': '/bin/bash', 08:11:44 INFO - 'SHLVL': '1', 08:11:44 INFO - 'TERM': 'linux', 08:11:44 INFO - 'TMOUT': '86400', 08:11:44 INFO - 'USER': 'cltbld', 08:11:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:44 INFO - '_': '/tools/buildbot/bin/python'} 08:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:45 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 08:11:45 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 08:11:45 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 08:11:45 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 08:11:45 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 08:11:45 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 08:11:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:46 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 08:11:46 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 08:11:46 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 08:11:46 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 08:11:46 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 08:11:46 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 08:11:47 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:47 INFO - warning: no files found matching '*.txt' 08:11:47 INFO - no previously-included directories found matching 'build' 08:11:47 INFO - no previously-included directories found matching 'dist' 08:11:47 INFO - no previously-included directories found matching '.git*' 08:11:47 INFO - Installing collected packages: jsonschema, functools32 08:11:47 INFO - Running setup.py install for functools32 08:11:47 INFO - warning: no files found matching '*.txt' 08:11:47 INFO - no previously-included directories found matching 'build' 08:11:47 INFO - no previously-included directories found matching 'dist' 08:11:47 INFO - no previously-included directories found matching '.git*' 08:11:47 INFO - Successfully installed jsonschema functools32 08:11:47 INFO - Cleaning up... 08:11:47 INFO - Return code: 0 08:11:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:47 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')]} 08:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:47 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')]} 08:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:47 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:47 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 08:11:47 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 08:11:47 INFO - Using env: {'DISPLAY': ':0', 08:11:47 INFO - 'HOME': '/home/cltbld', 08:11:47 INFO - 'LANG': 'en_US.UTF-8', 08:11:47 INFO - 'LANGUAGE': 'en_US:en', 08:11:47 INFO - 'LOGNAME': 'cltbld', 08:11:47 INFO - 'MAIL': '/var/mail/cltbld', 08:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:47 INFO - 'MOZ_NO_REMOTE': '1', 08:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:47 INFO - 'NO_EM_RESTART': '1', 08:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:47 INFO - 'PWD': '/builds/slave/test', 08:11:47 INFO - 'SHELL': '/bin/bash', 08:11:47 INFO - 'SHLVL': '1', 08:11:47 INFO - 'TERM': 'linux', 08:11:47 INFO - 'TMOUT': '86400', 08:11:47 INFO - 'USER': 'cltbld', 08:11:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:47 INFO - '_': '/tools/buildbot/bin/python'} 08:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:47 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 08:11:47 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 08:11:47 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 08:11:47 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 08:11:47 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 08:11:47 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 08:11:49 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:49 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 08:11:49 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 08:11:49 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 08:11:49 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 08:11:49 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 08:11:49 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 08:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 INFO - Downloading docopt-0.6.1.tar.gz 08:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:50 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:50 INFO - Running setup.py install for blobuploader 08:11:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:50 INFO - Running setup.py install for requests 08:11:50 INFO - Running setup.py install for docopt 08:11:50 INFO - Successfully installed blobuploader requests docopt 08:11:50 INFO - Cleaning up... 08:11:50 INFO - Return code: 0 08:11:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:50 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:50 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 08:11:50 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 08:11:50 INFO - Using env: {'DISPLAY': ':0', 08:11:50 INFO - 'HOME': '/home/cltbld', 08:11:50 INFO - 'LANG': 'en_US.UTF-8', 08:11:50 INFO - 'LANGUAGE': 'en_US:en', 08:11:50 INFO - 'LOGNAME': 'cltbld', 08:11:50 INFO - 'MAIL': '/var/mail/cltbld', 08:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:50 INFO - 'MOZ_NO_REMOTE': '1', 08:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:50 INFO - 'NO_EM_RESTART': '1', 08:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:50 INFO - 'PWD': '/builds/slave/test', 08:11:50 INFO - 'SHELL': '/bin/bash', 08:11:50 INFO - 'SHLVL': '1', 08:11:50 INFO - 'TERM': 'linux', 08:11:50 INFO - 'TMOUT': '86400', 08:11:50 INFO - 'USER': 'cltbld', 08:11:50 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:50 INFO - '_': '/tools/buildbot/bin/python'} 08:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:51 INFO - Running setup.py (path:/tmp/pip-9E77AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:51 INFO - Running setup.py (path:/tmp/pip-BmvIKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:51 INFO - Running setup.py (path:/tmp/pip-MJHbzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:51 INFO - Running setup.py (path:/tmp/pip-Jh8KRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:51 INFO - Running setup.py (path:/tmp/pip-BbLKch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:51 INFO - Running setup.py (path:/tmp/pip-kAtPLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:51 INFO - Running setup.py (path:/tmp/pip-WUi_c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:51 INFO - Running setup.py (path:/tmp/pip-VAnd3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:51 INFO - Running setup.py (path:/tmp/pip-z4hGmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:51 INFO - Running setup.py (path:/tmp/pip-x5PYPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:51 INFO - Running setup.py (path:/tmp/pip-KLvPll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:51 INFO - Running setup.py (path:/tmp/pip-iPI2AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:52 INFO - Running setup.py (path:/tmp/pip-DLTaiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:52 INFO - Running setup.py (path:/tmp/pip-RqGYYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:52 INFO - Running setup.py (path:/tmp/pip-AtI3ID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:52 INFO - Running setup.py (path:/tmp/pip-xmmcrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:52 INFO - Running setup.py (path:/tmp/pip-Xpsjot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:52 INFO - Running setup.py install for manifestparser 08:11:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:52 INFO - Running setup.py install for mozcrash 08:11:52 INFO - Running setup.py install for mozdebug 08:11:52 INFO - Running setup.py install for mozdevice 08:11:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:52 INFO - Running setup.py install for mozfile 08:11:52 INFO - Running setup.py install for mozhttpd 08:11:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Running setup.py install for mozinfo 08:11:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Running setup.py install for mozInstall 08:11:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Running setup.py install for mozleak 08:11:53 INFO - Running setup.py install for mozlog 08:11:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Running setup.py install for moznetwork 08:11:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Running setup.py install for mozprocess 08:11:53 INFO - Running setup.py install for mozprofile 08:11:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Running setup.py install for mozrunner 08:11:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:53 INFO - Running setup.py install for mozscreenshot 08:11:53 INFO - Running setup.py install for moztest 08:11:54 INFO - Running setup.py install for mozversion 08:11:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:54 INFO - Cleaning up... 08:11:54 INFO - Return code: 0 08:11:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:54 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:54 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 08:11:54 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 08:11:54 INFO - Using env: {'DISPLAY': ':0', 08:11:54 INFO - 'HOME': '/home/cltbld', 08:11:54 INFO - 'LANG': 'en_US.UTF-8', 08:11:54 INFO - 'LANGUAGE': 'en_US:en', 08:11:54 INFO - 'LOGNAME': 'cltbld', 08:11:54 INFO - 'MAIL': '/var/mail/cltbld', 08:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:54 INFO - 'MOZ_NO_REMOTE': '1', 08:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:54 INFO - 'NO_EM_RESTART': '1', 08:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:54 INFO - 'PWD': '/builds/slave/test', 08:11:54 INFO - 'SHELL': '/bin/bash', 08:11:54 INFO - 'SHLVL': '1', 08:11:54 INFO - 'TERM': 'linux', 08:11:54 INFO - 'TMOUT': '86400', 08:11:54 INFO - 'USER': 'cltbld', 08:11:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:54 INFO - '_': '/tools/buildbot/bin/python'} 08:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:54 INFO - Running setup.py (path:/tmp/pip-q_3wlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:54 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)) 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:54 INFO - Running setup.py (path:/tmp/pip-aD8MuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:54 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)) 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:54 INFO - Running setup.py (path:/tmp/pip-VNyZLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:54 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)) 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:54 INFO - Running setup.py (path:/tmp/pip-DZr43r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:54 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)) 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:54 INFO - Running setup.py (path:/tmp/pip-cvECh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:54 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)) 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:54 INFO - Running setup.py (path:/tmp/pip-eV9ygp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:54 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)) 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:54 INFO - Running setup.py (path:/tmp/pip-D5v8_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:54 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)) 08:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:54 INFO - Running setup.py (path:/tmp/pip-NMLf7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:55 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)) 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:55 INFO - Running setup.py (path:/tmp/pip-aAHV0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:55 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)) 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:55 INFO - Running setup.py (path:/tmp/pip-o4r1nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:55 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)) 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:55 INFO - Running setup.py (path:/tmp/pip-WT4ihI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:55 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)) 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:55 INFO - Running setup.py (path:/tmp/pip-epi5Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:55 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)) 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:55 INFO - Running setup.py (path:/tmp/pip-DVN3dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:55 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)) 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:55 INFO - Running setup.py (path:/tmp/pip-sBDeYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:55 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)) 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:55 INFO - Running setup.py (path:/tmp/pip-jjj0gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:55 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)) 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:55 INFO - Running setup.py (path:/tmp/pip-ynf9Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:55 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)) 08:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:55 INFO - Running setup.py (path:/tmp/pip-2GDUQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:55 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)) 08:11:55 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)) 08:11:55 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)) 08:11:55 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)) 08:11:55 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)) 08:11:55 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)) 08:11:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:55 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 08:11:55 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 08:11:55 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 08:11:55 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 08:11:55 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 08:11:55 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 08:11:57 INFO - Downloading blessings-1.6.tar.gz 08:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:57 INFO - Installing collected packages: blessings 08:11:57 INFO - Running setup.py install for blessings 08:11:57 INFO - Successfully installed blessings 08:11:57 INFO - Cleaning up... 08:11:57 INFO - Return code: 0 08:11:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:58 INFO - Reading from file tmpfile_stdout 08:11:58 INFO - Current package versions: 08:11:58 INFO - argparse == 1.2.1 08:11:58 INFO - blessings == 1.6 08:11:58 INFO - blobuploader == 1.2.4 08:11:58 INFO - docopt == 0.6.1 08:11:58 INFO - functools32 == 3.2.3-2 08:11:58 INFO - jsonschema == 2.5.1 08:11:58 INFO - manifestparser == 1.1 08:11:58 INFO - mozInstall == 1.12 08:11:58 INFO - mozcrash == 0.17 08:11:58 INFO - mozdebug == 0.1 08:11:58 INFO - mozdevice == 0.48 08:11:58 INFO - mozfile == 1.2 08:11:58 INFO - mozhttpd == 0.7 08:11:58 INFO - mozinfo == 0.9 08:11:58 INFO - mozleak == 0.1 08:11:58 INFO - mozlog == 3.2 08:11:58 INFO - moznetwork == 0.27 08:11:58 INFO - mozprocess == 0.22 08:11:58 INFO - mozprofile == 0.28 08:11:58 INFO - mozrunner == 6.11 08:11:58 INFO - mozscreenshot == 0.1 08:11:58 INFO - mozsystemmonitor == 0.3 08:11:58 INFO - moztest == 0.7 08:11:58 INFO - mozversion == 1.4 08:11:58 INFO - psutil == 3.1.1 08:11:58 INFO - requests == 1.2.3 08:11:58 INFO - wsgiref == 0.1.2 08:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:58 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:58 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 08:11:58 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 08:11:58 INFO - Using env: {'DISPLAY': ':0', 08:11:58 INFO - 'HOME': '/home/cltbld', 08:11:58 INFO - 'LANG': 'en_US.UTF-8', 08:11:58 INFO - 'LANGUAGE': 'en_US:en', 08:11:58 INFO - 'LOGNAME': 'cltbld', 08:11:58 INFO - 'MAIL': '/var/mail/cltbld', 08:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:58 INFO - 'MOZ_NO_REMOTE': '1', 08:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:58 INFO - 'NO_EM_RESTART': '1', 08:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:58 INFO - 'PWD': '/builds/slave/test', 08:11:58 INFO - 'SHELL': '/bin/bash', 08:11:58 INFO - 'SHLVL': '1', 08:11:58 INFO - 'TERM': 'linux', 08:11:58 INFO - 'TMOUT': '86400', 08:11:58 INFO - 'USER': 'cltbld', 08:11:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:58 INFO - '_': '/tools/buildbot/bin/python'} 08:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:58 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)) 08:11:58 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)) 08:11:58 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)) 08:11:58 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)) 08:11:58 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)) 08:11:58 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)) 08:11:58 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)) 08:11:58 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)) 08:11:58 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)) 08:11:58 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)) 08:11:58 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)) 08:11:58 INFO - Cleaning up... 08:11:58 INFO - Return code: 0 08:11:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:58 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:58 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 08:11:58 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 08:11:58 INFO - Using env: {'DISPLAY': ':0', 08:11:58 INFO - 'HOME': '/home/cltbld', 08:11:58 INFO - 'LANG': 'en_US.UTF-8', 08:11:58 INFO - 'LANGUAGE': 'en_US:en', 08:11:58 INFO - 'LOGNAME': 'cltbld', 08:11:58 INFO - 'MAIL': '/var/mail/cltbld', 08:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:58 INFO - 'MOZ_NO_REMOTE': '1', 08:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:58 INFO - 'NO_EM_RESTART': '1', 08:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:58 INFO - 'PWD': '/builds/slave/test', 08:11:58 INFO - 'SHELL': '/bin/bash', 08:11:58 INFO - 'SHLVL': '1', 08:11:58 INFO - 'TERM': 'linux', 08:11:58 INFO - 'TMOUT': '86400', 08:11:58 INFO - 'USER': 'cltbld', 08:11:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:58 INFO - '_': '/tools/buildbot/bin/python'} 08:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:58 INFO - Cleaning up... 08:11:58 INFO - Return code: 0 08:11:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:58 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 0x7f486ed84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, '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-1465915542.324287-1955222013', '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 08:11:58 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 08:11:58 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 08:11:58 INFO - Using env: {'DISPLAY': ':0', 08:11:58 INFO - 'HOME': '/home/cltbld', 08:11:58 INFO - 'LANG': 'en_US.UTF-8', 08:11:58 INFO - 'LANGUAGE': 'en_US:en', 08:11:58 INFO - 'LOGNAME': 'cltbld', 08:11:58 INFO - 'MAIL': '/var/mail/cltbld', 08:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:58 INFO - 'MOZ_NO_REMOTE': '1', 08:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:58 INFO - 'NO_EM_RESTART': '1', 08:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:58 INFO - 'PWD': '/builds/slave/test', 08:11:58 INFO - 'SHELL': '/bin/bash', 08:11:58 INFO - 'SHLVL': '1', 08:11:58 INFO - 'TERM': 'linux', 08:11:58 INFO - 'TMOUT': '86400', 08:11:58 INFO - 'USER': 'cltbld', 08:11:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:58 INFO - '_': '/tools/buildbot/bin/python'} 08:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:58 INFO - Downloading/unpacking flake8 08:11:58 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 08:11:58 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 08:11:58 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 08:11:58 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 08:11:58 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 08:11:58 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 08:12:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:12:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:12:00 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 08:12:00 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 08:12:00 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 08:12:00 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 08:12:00 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 08:12:00 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 08:12:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:12:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:12:00 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 08:12:00 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 08:12:00 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 08:12:00 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 08:12:00 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 08:12:00 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 08:12:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:01 INFO - no previously-included directories found matching 'docs/_build' 08:12:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:12:01 INFO - Running setup.py install for pep8 08:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:01 INFO - no previously-included directories found matching 'docs/_build' 08:12:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:12:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:12:01 INFO - Cleaning up... 08:12:01 INFO - Return code: 0 08:12:01 INFO - Running post-action listener: _resource_record_post_action 08:12:01 INFO - Running post-action listener: _start_resource_monitoring 08:12:01 INFO - Starting resource monitoring. 08:12:01 INFO - ##### 08:12:01 INFO - ##### Finished create-virtualenv step (success) 08:12:01 INFO - ##### 08:12:01 INFO - ##### 08:12:01 INFO - ##### Running install step. 08:12:01 INFO - ##### 08:12:01 INFO - Running pre-action listener: _resource_record_pre_action 08:12:01 INFO - Running main action method: install 08:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:01 INFO - Reading from file tmpfile_stdout 08:12:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:12:01 INFO - Reading from file tmpfile_stdout 08:12:01 INFO - Output received: 08:12:01 INFO - Usage: mozinstall [options] installer 08:12:01 INFO - Options: 08:12:01 INFO - -h, --help show this help message and exit 08:12:01 INFO - -d DEST, --destination=DEST 08:12:01 INFO - Directory to install application into. [default: 08:12:01 INFO - "/builds/slave/test"] 08:12:01 INFO - --app=APP Application being installed. [default: firefox] 08:12:01 INFO - mkdir: /builds/slave/test/build/application 08:12:01 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'] 08:12:01 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 08:12:18 INFO - Reading from file tmpfile_stdout 08:12:18 INFO - Output received: 08:12:18 INFO - /builds/slave/test/build/application/firefox/firefox 08:12:18 INFO - Running post-action listener: _resource_record_post_action 08:12:18 INFO - ##### 08:12:18 INFO - ##### Finished install step (success) 08:12:18 INFO - ##### 08:12:18 INFO - ##### 08:12:18 INFO - ##### Running run-tests step. 08:12:18 INFO - ##### 08:12:18 INFO - Running pre-action listener: _resource_record_pre_action 08:12:18 INFO - Running main action method: run_tests 08:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:18 INFO - Python 2.7.3 08:12:18 INFO - Return code: 0 08:12:18 INFO - grabbing minidump binary from tooltool 08:12: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')]} 08:12:18 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 0x2cfb1c0>, '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 0x2cfc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfc550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:18 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 08:12:18 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 08:12:18 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 08:12:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:18 INFO - Return code: 0 08:12:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:12:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:12:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:12:19 INFO - Return code: 0 08:12:19 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/SqDFH2XlQLOpBaq642OTZQ/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 08:12:19 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/SqDFH2XlQLOpBaq642OTZQ/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 08:12:19 INFO - Using env: {'DISPLAY': ':0', 08:12:19 INFO - 'HOME': '/home/cltbld', 08:12:19 INFO - 'LANG': 'en_US.UTF-8', 08:12:19 INFO - 'LANGUAGE': 'en_US:en', 08:12:19 INFO - 'LOGNAME': 'cltbld', 08:12:19 INFO - 'MAIL': '/var/mail/cltbld', 08:12:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:19 INFO - 'MOZ_NO_REMOTE': '1', 08:12:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:19 INFO - 'NO_EM_RESTART': '1', 08:12:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:19 INFO - 'PWD': '/builds/slave/test', 08:12:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:19 INFO - 'SHELL': '/bin/bash', 08:12:19 INFO - 'SHLVL': '1', 08:12:19 INFO - 'TERM': 'linux', 08:12:19 INFO - 'TMOUT': '86400', 08:12:19 INFO - 'USER': 'cltbld', 08:12:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465915542.324287-1955222013', 08:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:19 INFO - '_': '/tools/buildbot/bin/python'} 08:12:19 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/SqDFH2XlQLOpBaq642OTZQ/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 08:12:20 INFO - mozversion application_buildid: 20160614053033 08:12:20 INFO - mozversion application_changeset: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 08:12:20 INFO - mozversion application_display_name: Nightly 08:12:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:20 INFO - mozversion application_name: Firefox 08:12:20 INFO - mozversion application_remotingname: firefox 08:12:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:12:20 INFO - mozversion application_vendor: Mozilla 08:12:20 INFO - mozversion application_version: 50.0a1 08:12:20 INFO - mozversion platform_buildid: 20160614053033 08:12:20 INFO - mozversion platform_changeset: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 08:12:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:12:20 INFO - mozversion platform_version: 50.0a1 08:12:20 INFO - using testdate: 1465917140 08:12:20 INFO - actual date: 1465917140 08:12:20 INFO - starting webserver on 'localhost:39235' 08:12:20 INFO - SUITE-START | Running 2 tests 08:12:20 INFO - TEST-START | dromaeo_css 08:12:20 INFO - operating with platform_type : linux_ 08:12:20 INFO - Initialising browser for dromaeo_css test... 08:12:20 INFO - TEST-INFO | started process 8783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXTD0G/profile http://localhost:39235/getInfo.html) 08:12:25 INFO - PROCESS | 8783 | __metrics Screen width/height:1600/1200 08:12:25 INFO - PROCESS | 8783 | colorDepth:24 08:12:25 INFO - PROCESS | 8783 | Browser inner width/height: 1024/697 08:12:25 INFO - PROCESS | 8783 | __metrics 08:12:25 ERROR - PROCESS | 8783 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:12:26 INFO - TEST-INFO | 8783: exit 0 08:12:26 INFO - Browser initialized. 08:12:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:26 INFO - TEST-INFO | started process 8904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXTD0G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:38 INFO - PROCESS | 8904 | RSS: Main: 184918016 08:12:38 INFO - PROCESS | 8904 | 08:13:28 INFO - PROCESS | 8904 | 1465917208349 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] 08:15:36 INFO - PROCESS | 8904 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39235/tests/dromaeo/cssquery-ext.html) 08:15:37 INFO - PROCESS | 8904 | RSS: Main: 189022208 08:15:37 INFO - PROCESS | 8904 | 08:18:39 INFO - PROCESS | 8904 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-ext.html (next: http://localhost:39235/tests/dromaeo/cssquery-jquery.html) 08:18:39 INFO - PROCESS | 8904 | RSS: Main: 187711488 08:18:39 INFO - PROCESS | 8904 | 08:21:41 INFO - PROCESS | 8904 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39235/tests/dromaeo/cssquery-mootools.html) 08:21:42 INFO - PROCESS | 8904 | RSS: Main: 189251584 08:21:42 INFO - PROCESS | 8904 | 08:24:44 INFO - PROCESS | 8904 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39235/tests/dromaeo/cssquery-prototype.html) 08:24:44 INFO - PROCESS | 8904 | RSS: Main: 186773504 08:24:44 INFO - PROCESS | 8904 | 08:27:47 INFO - PROCESS | 8904 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39235/tests/dromaeo/cssquery-yui.html) 08:27:47 INFO - PROCESS | 8904 | RSS: Main: 188522496 08:27:47 INFO - PROCESS | 8904 | 08:30:50 INFO - PROCESS | 8904 | Cycle 1(1): loaded http://localhost:39235/tests/dromaeo/cssquery-yui.html (next: http://localhost:39235/tests/dromaeo/cssquery-dojo.html) 08:30:50 INFO - PROCESS | 8904 | RSS: Main: 189280256 08:30:50 INFO - PROCESS | 8904 | 08:30:50 INFO - PROCESS | 8904 | __start_tp_report 08:30:50 INFO - PROCESS | 8904 | _x_x_mozilla_page_load 08:30:50 INFO - PROCESS | 8904 | _x_x_mozilla_page_load_details 08:30:50 INFO - PROCESS | 8904 | |i|pagename|runs| 08:30:50 INFO - PROCESS | 8904 | |0;dojo.html;3116.768876293864;3131.3580715953226;3140.8272545010013;3172.3179516403984;3177.9205519862016;5481.75332110055;5552.6390784599025;5603.07549254373;5611.7755289788465;5623.606347555673;5430.886668233013;5507.586930980173;5529.751161197746;5550.16747487877;5614.859628509289;4880.9755951220195;4915.238138088602;5025.57282630975;5068.8732781680565;5127.02586508564;198.2483601941619;4916.410030796309;4950.6287028472825;4999.7500124993785;5020.523050310215;4958.603311735053;4975.7263350515705;4986.252062190682;4997.6501644884875;5006.998600279959;5001.324821149135;5008.323876276692;5008.69947803133;5016.147254966628;5044.344235249431;4878.707277563358;4936.827211047632;4950.554450099472;4956.727379994099;4979.8008079676765;5431.53831924283;5556.638818476786;5557.5831812613815;5562.610617256793;5610.607257491977;5771.307443106854;5836.533077353802;5910.320313163955;5918.348981612019;5931.703414829241;5903.26209223847;6021.969890150521;6043.033114701627;6067.089936509515;6091.360407157274;5605.691686957216;5607.2990876140075;5608.887822243532;5620.381758006616;5621.971890140523;5953.702314884238;6079.635221886701;6100.420460056288;6136.9079463808075;6149.3235744068115;5921.289445266596;5929.73316200772;5930.970345148246;5938.703064846827;5971.4028597140805;6009.399060093956;6014.578979471395;6021.849453763691;6025.216721826135;6037.63774173551;5795.072788353843;5883.676397798076;5914.556408269397;5948.553858460633;5989.850253743692;5943.435373639497;5982.282126144803;5987.101934709828;5987.251593550806;6004.669743164168;4408.181200814957;4413.117376524708;4460.353248778909;4468.396766436489;4515;3886.5530463997;3911.8435262589746;3921.5882332355263;3925.0776067624083;3967.067739081371;5554.250176226238;5558.333000040021;5561.749721262553;5572.749226284827;5612.214289999403;5940.940590594125;5950.940490595039;5954.106883967353;5956.642601443928;5979.4917432018765;5534.944650553523;5568.303962004749;5585.022621041301;5653;5658.151277308437;4926.926096108561;4946.752662366867;4960;4969.204927211629;4971.90056198874;6197;6200.658963756947;6206.379362063757;6206.844828879314;6218.502519798405;6006.969965150146;6038.547108966757;6041.305249896318;6046.274447066205;6054.878902422015;5924.348321684525;6024.819255422344;6038.426349496791;6086.969565152146;6181.072839074175;5809.302883653989;5844.853878653068;5860.736266867916;5876.970615146897;5900.380460051632;5889.911651325147;5938.970305148447;5944.346121926671;5949.077892926603;5969.940300597113;5672.262605861211;5746.569007324551;5790.276215473066;5811.709414529341;5854.297484301911;5817.680027598522;5826.475617194304;5827.475527202572;5830.183774271521;5845.444682755132;5579.525740312119;5749.195112684144;5750.166225897138;5750.6837123958585;5765.192872997867;5808.7095645218415;5818.505427038749;5826.271716035496;5830.067189249699;5918.082697181943;5662.377138514677;5673.461021202979;5696.686682232517;5698.2592263005545;5706.686132262599 08:30:50 INFO - PROCESS | 8904 | |1;ext.html;611.4313688269907;612.1613389656171;635.2504045226631;649.8700259948012;669.6618207805058;36435;37166.62833371669;39813;39860.80069599648;40230.396544051866;40883.386749198784;41460.17079658405;41480.17039659205;41691.16617667645;41750;8465.44974576652;8743.300535957109;8745.518996455192;8753.737387878375;8755.25580325673;8745.781355466132;8758.737237882842;8811.603477843513;8820.911790882074;8836.072212417668;8807;8839.46963182211;8871.24594409476;8894.066123057082;8903.332250081237;8800.07599202081;8838.29293656506;8864.911350886505;8871.068537803567;8871.778205544913;8737.694180703646;8759.2992560595;8810;8821.558922053871;8837.204651581324;40031;40391.39412908779;40426.19147617061;40499.190016199806;40618.59381406207;2829.1936798012675;3350.966490335114;3536.7877927324444;3571.8928432147077;3607.188382613917;30979.845100774353;31060;31228.063158105295;31533;31595.52606710901;4037.1118353962083;4073.348264277731;4148.357004664282;4171.395147703596;4202.537720850704;300984;301024;303325;303696;305485.9999999978;35227.82386088053;35870;36034.45948310778;36229.27541449156;36347.81826090853;35774;37724.24551508955;37810;37902.43146352807;38191.23617527634;15153.090814551162;15287.923560382127;15397;15440.84559154394;15455.768163477556;11827.467763950643;12029.518819247307;12047.337396443105;12055.613604435426;12109.757804843854;8856.114388561222;8935.195832375117;8961.59672814725;9013.63945442188;9017.098290171061;3438.432658611301;3466.2547552276383;3475.4960530722906;3512.297540491912;3543.362194804908;1028.1466382902174;1036.3212096077082;1058.4707646176912;1060.2578195263347;1077.8113830079706;32359.51460728091;32389.35221295608;32414.35171296561;32502.674973249967;32835;1029.629333439961;1097.4403054442291;1153.3598852636699;1167.2121318110242;1196.6350263169816;16685.666286674197;16808.831911680973;17392.956422614683;17479.986732082343;17504.737428938577;506868;509303;515455;516892;520567;59172.40827591755;59998;60005.399946000856;60026.29881655336;60044;1305.7127431964952;1380.751464736337;1381.0470775165104;1383.4950243161175;1388.6528367908022;30672;31590;32036.6796332043;32053;32507.83746081349;49668;50099.499005009486;50349.734261957565;50355.74822125866;50593.49406506035;433632;437309;444516;445191;447709;28293.43413131767;28659.426811464073;28683.8565807178;28948.42103157883;28975.7102428973;47132.29301560548;48212.75893620509;48607.5139248603;48698.26952595643;49844.25233621571;41017.58982410138;41790.79104604579;42322.576774231864;42486.57513424826;42600.57399425966;40432;40817.18365632612;41284.38073428961;41512.79243603763;41674.58325416828;40747;40758;41495;41501.792491037355;44427;32660.510092349108;34924;35137.824310878284;35231.64768352284;35713.64286357103;27100.457990840467;27657.308567285978;27679.584806227518;27838.58242126329;28240.576391353734 08:30:50 INFO - PROCESS | 8904 | |2;jquery.html;401.7930765655687;407.26895223074575;415.5470537114546;418.98533551325704;431.96112349888506;19153.61692766144;19411.41765747028;20029.799702002976;20116.497087572818;20133.094010769513;12974.870251297485;13047.478100875976;13054.955603551716;13169.604911852659;13219.471221151143;5299.099153143975;5421.051316019681;5430;5438.864028399282;5439.211314359435;5690.5447564194765;5971.193888825018;5996.610220335664;6063.757449702007;6071.241094863142;5955.225820643311;6010.639361638294;6030.638161710312;6057.30341010785;6302.7163777629885;6460.3862633049785;6491.578047426902;6526.575772574767;6532.3467653234775;6577.440917522016;5729.598928075036;5795.304563452412;5809.912851307234;5810.796622118206;5812.534997200214;14848.925755371154;15046.623834404118;15097.622559435993;21814.672779908313;22774.316770496913;2306.6194077977116;2349.7767712067325;2351.341624345186;2441.609342505191;2531.873406329676;10232.334898231591;10761.08530774885;10780.5687772489;11132.220744547885;11269.154813388946;1902.6099649571943;1966.6165097805933;1976.8122028407279;1993.820556149939;2049.3237231713497;79569.60215198944;85333.57333213356;87021.69467458056;87760;87896.56051719765;11162.274452160584;11368;11659.650210493699;12109.455074521667;12541.749165016648;16671.83328166727;16785.83214167867;16819.579510512336;16890.915545422195;16913.66172676564;8090.352771778244;8184.386171037077;8186.590670466453;8209.79475513105;8250.3812214083;7616;7648.847023059619;7820.374370050382;8073.31376832964;8128.471649342774;4889.413270407503;4929.950700493021;4962.354893863775;5233.267342571967;5306.708131052829;2072.347210628647;2120.787921207867;2132.168454302823;2153.5477549714738;2174.423777698911;922.8246633139682;969.6606187834202;973.7419583810296;988.6687959533637;1093.6336327330275;20317.390478285673;20452.488687782923;20468.18127274922;20508.79491205069;20625;984.5077461269366;992.5186284651938;996.0786272697726;1020.4948550467418;1078.0620859851822;10762.085222755997;11342.489587968561;11553.884461155281;11701.122415818847;11785.823212651818;352951;359573;362296;416273;422250;58283;69390;84562;86410.56794715986;87625.56187219023;1006.4162785584343;1015.28422462164;1041.4272150317295;1052.6157952347492;1053.7207639975413;18439;18489.352872649393;19012.619747605248;19077.687335408544;19104.522386940436;40947.795261024694;43331.35002975021;43947.34078988754;44454.55545444634;45810.08379832318;59915.40084599273;60741.0888836659;60780.39219607924;61744.69127654513;61760;9249.30630202751;9330.440173589606;9333.906660933304;9371.953140234255;9654.806903862023;11228.326300422;13774.311284435938;13848.930755346159;14021.228832414316;14158.929205353907;11396.373199474108;12065.698357540781;12375.62873113772;12489.93755031219;12526.686832828887;11807.055435565306;11823.940880295544;11925.880741192825;12192;12456.564020259248;12239.69400764988;12324.07569432314;12412.56556020535;12449;12449.688757781129;9085.591148398205;9233.722988310094;9256.814863702553;9341.766455838659;9521.190698790404;11933.164678472423;11984.340861252715;11990.100742444178;12090.335031572997;12144.39278036077 08:30:50 INFO - PROCESS | 8904 | |3;mootools.html;1491.4556186991747;1500.4598344595947;1654.8924319919204;1787.9361779741066;1796.946091617251;8241.752747417571;8925;9074.319426043041;9644.90355096449;9686.66096686616;9469.147776700096;9479.146876781087;9571.2343012559;9586.952065239682;9604.711858644252;2450.8406953548006;2482.4290413204885;2499.8125140614434;2503.6244563315468;2509.1845150326126;2420.6006009008493;2478.330850670318;2488.9875550622223;2504.9248522544353;2518.6725725655638;2450.571150048743;2460.5817011108065;2479.293401380607;2487.1046423287694;2492.5638013347684;2451.852888826676;2453.092355828337;2471.530409222251;2493.6259561065804;2498.700155981294;2417.2748175547267;2422.2369953464777;2442.0353960185626;2442.511497700467;2479.789217916479;9463.38487998278;9677.661281855102;9695.563699633534;9695.806083878353;9717.90282097177;5414.160805075219;5516.613837031409;5521.4539928819995;5538.9169162462595;5543.99999999996;3339.5491608632765;3429.5027221053056;3479.0954351868695;3511.7892926424242;3653.6894363979095;1095.6439157273837;1113.8551988241559;1116.9835449740697;1118.9104871610334;1131.609594689839;12637.684057898627;12642.988560915104;12655.493780248778;12698.365081745967;12700.491980320776;4943.382077240345;5031;5124.846254612367;5128.9230661540105;5148.794048238104;10591.523381447852;10591.523381447852;10687.519061642244;10712.46437678113;10719.946400267949;5635.5773317001385;5676.801311954062;5712.65724056558;5720.256366672389;5741;4489.214387482178;4944.456109827916;5037.748112594356;5170.793168273302;5193.169092945111;4188.6230239278;4254.829806807755;4267.487901451784;4347.7173983690955;4384.758838263862;1345.3004437692346;1380.641033331341;1390.1172755300254;1399.5451478269604;1406.4655430936384;944.7165850244899;964.5322018820866;975.6487664440796;976.0337266106503;990.0545876018787;6084.969575152096;6172.938270617326;6190.164327815777;6222.533310001768;6299.937000630027;475.9262314341283;477.46762359968386;489.16597201771606;490.32335377179265;491.0179640718563;3820.656140947328;3876.1666241758157;3903.687704983651;3923.313420151462;3963.9405408918315;11275.887241127484;11647.76704465906;11713.121515886343;11734.70663233409;11754.11844111695;11552.133589980785;11642.185047046625;11651.650450486499;11679.124065695107;11710.180287379972;8018.077921039038;8303.128171542023;8386.245237928615;8599.14008599135;8637.913620863837;6096.542759292982;6334.651594162366;6344.238691356882;6386.840328991812;6481.157449531531;10649.254552181583;10775.515101820594;10811.6215932442;11014.614488492864;11027.062699670618;10196.286259961731;10584.100351469904;10628.256022078689;10999.285046471954;11083.944580277048;8167.1424500428975;8260;8272.958635206785;8316.334693224648;8334.958325208336;8874.467531948103;8876.20114189726;8908.910910890809;8936.553172341486;8977.147171018743;7910.9604451977375;8085.71699990521;8147.63335649909;8173.79565510867;8191.344692424473;7615.581143036965;7617.771466856003;7706.730264440717;7840.686372545034;7860.135385107519;6904.344087311697;6935.133108361455;6985.615791131537;7075.82310442243;7093.432525398059;5052.1663925451885;5094.541491265803;5105.31078304439;5124.56441202502;5183;5026.346574945233;5201.687898726089;5237;5315.574754019592;5385.596080294072 08:30:50 INFO - PROCESS | 8904 | |4;prototype.html;335.6157200005993;351.6044449993758;352.56458274031576;354.8190422884328;358.4211498430035;5496.835094947158;5550.8057217997375;5683.772649094037;5724.742386592603;5739.971300143498;5510.3744395403355;5549.77800887964;5558.610897237185;5592.692401917893;5609.270794796681;4336.76147811871;4358.498772641139;4362.32383980482;4383.868483945486;4403.163398954189;4137.958620413802;4401.645119860875;4404.911901761963;4443.488998765151;4445.68880178386;4398.142362239365;4410.536893626171;4411.779411029452;4418.580234877698;4419.0057237121555;4439.955600443986;4441.777911104432;4443.644508439317;4478.7984540695425;4498.415206023229;3726.347889119393;3942.5071866016747;3981.5222173339093;3992.7005474589523;3997.060690737674;5473.370562385297;5532.336119665666;5534.391216966131;5549.250851135085;5563;5107.208382700687;5107.540321371094;5110.693358398471;5129.820456284012;5137.766935935386;5688.317401911797;5952.136940143699;5999.220101386792;6001.969990150022;6043.184170137063;4335.436393268887;4357.324614684729;4372.606465418127;4391.14372697321;4403.691741578091;6186.81439556814;6189.876202475925;6192.473639740628;6203.906941395838;6214.4407003369915;4314.7626880521875;4391;4404.119176164716;4435.844745433958;4451.530994771718;4451.532589078165;4486.75322857246;4489.371487991683;4496.100779843979;4507.57178068083;5080.6790234539285;5104.923426148611;5122.667026643257;5163.793448262102;5178.275041494194;5641.802536911188;5651.378348381675;5811.3316968548315;5968.552358573124;6003.369646187175;1515.3559737111684;1516.6208447888027;1536.4238410596026;1538.7768773528;1541.6685412636336;990.7523119220195;993.1409330928839;1002.9147522460672;1026.296986564206;1030.3766221436074;5083.923741143886;5085.313482679865;5091.592672586185;5114.820981265638;5127.6154288428515;5325.2810870531985;5334.546563542142;5432.864178395572;5434.750007498297;5443.537299329522;4854.344663470457;4969.751512424436;4975.676581022222;5148.2277658350795;5227.294315267391;2831.7734581233453;2859.411438644488;2864.985675071653;2884.5096333623333;2898.6376702912135;5470.972645136749;5483.353569876068;5550.223928342892;5592.748326325325;5596.916046259309;5246.3704355477585;5448.945510544923;5452.40023597404;5469.890602188014;5515.448455154533;5393.298871146804;5447.428020057837;5482.314710661168;5490.752916118704;5509.944900551023;5032.43994361749;5245.580353571629;5327.547158491571;5334.359876814807;5335.546478549211;5311.49540793624;5341.732913354239;5355.919661205007;5407.729613519387;5433.510984011458;5473.397926228032;5538.584606154474;5548.085910360919;5563.193336966198;5564.972175139098;3859.842047385829;4067.552569217443;4115.526714427879;4120.75275483472;4134.297169481135;5309.415964244007;5337.973310133424;5399.892002159856;5770.5095066919785;5802.4197580241635;5754.251947246831;5781.728019835629;5794.420557944172;5803.100519419497;5842.094475356326;5801.6519008859605;5843.532517398513;5873.3832947539895;5890.14592884038;5895.4399332063385;5613.214150018919;5764.674124951201;5802.274715660543;5803.912941305968;5815.883682326415;5878.617889837318;5894.2926848778425;5910.763569457174;5925.970370148121;5928.170056192051;5614.24207731951;5770.163326317576;5773.278340207474;5787.276590426197;5787.7395517200985 08:30:50 INFO - PROCESS | 8904 | |5;yui.html;734.3464316758085;785.9821531117202;796.3748457460895;835.3275613131427;839.8908141941548;15500.147491887941;15871.285792139353;16075.83924160758;16130.193490325495;16191.83808161918;15411.07533547988;15427.382904683827;15505.06969581823;15614.843851561482;15685.058896466191;676.7766637009775;784.3176436500253;798.2217338095369;803.3693550562809;813.6013353456823;806.7337778533099;807.0597753617029;809.6194788449419;809.7732634862218;815.6248125862081;855.5850412549909;856.7729551668813;861.0786458489418;864.0322838420977;864.9437786543855;854.5257382152903;855.9914400856036;860.3848248502288;861.4314552395451;862.3144600042949;616.7101462312751;626.2578844069792;626.6428135962503;630.2814791138106;630.552307861419;15105.848941510554;15158;15210.391584336614;15236.085834849833;15275.923620381827;15591.45429909959;15709.921450392789;15905.204739763081;15922.203889805463;16024.278907449076;12320.322382268972;12369.62891113268;12406.441710123067;12409.255444673257;12746.617601471971;3811.294910441577;3915.4714113594587;3919.941200881989;3927.8625248116464;3938.547067087264;78147.6092619539;78382.21617783807;78964;79540.60229698873;83275;11995.340256285814;12070.275783452846;12147.210431321935;12219.800824826469;12506;23838.16566420167;23862.880685596807;23866.403339916294;23973.28080157598;23985.52028959446;8632.741017769476;8748.825023499494;8939.106089391009;8963.551822408985;9109.225715814098;4625.190591646516;4678.157931572349;4749.525047495223;4834.830780922651;5022.42242142151;3514.947275790865;3592.389293820057;3598.9820050900103;3635.5455568053994;3784.110733977513;609.7103875659027;610.6732897899602;612.1705089603612;615.3323643846387;624.712632189189;645.1484041065748;721.9241979592172;739.5747445218913;760.2093822424616;761.9885701714479;9459.905400945903;9861.309708320492;9956.701298961043;10221.846672299922;10652.36085834837;714.6426786606696;776.4564804636777;782.8825676148623;794.6702118620708;806.9878951815728;4914.754262286871;5065.316182315414;5077.492250774893;5092.796288148506;5212.630950307298;79527;113400;114938.42530787292;120827;124597.37701311617;104651;105330.47334763277;106375;106827.79516614514;107426.46286768516;84291.5785421069;86685.566572168;88380.55809721039;89476;89513.99999999869;9562.808743825224;9629.807403851744;9645.27660425485;9648.565814538222;9760.170385517311;48793;49811.50188498069;50677.23984140167;51477.7426112867;52056.73971630269;71625.64187179031;79424.60287698524;79947.20052799398;81845.59077204576;83036.58481707553;12367.814482782946;12455.626331210078;12478.875211248134;12614.49542018309;13141.868581314448;14477.638059048608;14842.257887105818;15134.697306054037;15482.458113965957;16091.356345746039;13671;14269.928650356682;14497.92751036238;14611.342489588207;14622.92688536593;13683.247421391521;14386.784198236826;14718.852811471748;15096.094234345974;15500.591739515126;13612;13853.515126970507;14129.646758831112;14390;14414.639634009234;11697;11731.303732778142;11796.29222246668;12017;12182.817257741319;11746.941265293619;12066.698332541757;12284.1401101922;12409.93795031019;12782.296973666538 08:30:50 INFO - PROCESS | 8904 | __end_tp_report 08:30:50 INFO - PROCESS | 8904 | __start_cc_report 08:30:50 INFO - PROCESS | 8904 | _x_x_mozilla_cycle_collect,361 08:30:50 INFO - PROCESS | 8904 | __end_cc_report 08:30:50 INFO - PROCESS | 8904 | __startTimestamp1465918250798__endTimestamp 08:30:50 INFO - PROCESS | 8904 | 08:30:50 INFO - PROCESS | 8904 | ------- Summary: start ------- 08:30:50 INFO - PROCESS | 8904 | Number of tests: 6 08:30:50 INFO - PROCESS | 8904 | 08:30:50 INFO - PROCESS | 8904 | [#0] dojo.html Cycles:165 Average:5472.71 Median:5746.57 stddev:781.18 (13.6%) stddev-sans-first:761.40 08:30:50 INFO - PROCESS | 8904 | Values: 3116.8 3131.4 3140.8 3172.3 3177.9 5481.8 5552.6 5603.1 5611.8 5623.6 5430.9 5507.6 5529.8 5550.2 5614.9 4881.0 4915.2 5025.6 5068.9 5127.0 198.2 4916.4 4950.6 4999.8 5020.5 4958.6 4975.7 4986.3 4997.7 5007.0 5001.3 5008.3 5008.7 5016.1 5044.3 4878.7 4936.8 4950.6 4956.7 4979.8 5431.5 5556.6 5557.6 5562.6 5610.6 5771.3 5836.5 5910.3 5918.3 5931.7 5903.3 6022.0 6043.0 6067.1 6091.4 5605.7 5607.3 5608.9 5620.4 5622.0 5953.7 6079.6 6100.4 6136.9 6149.3 5921.3 5929.7 5931.0 5938.7 5971.4 6009.4 6014.6 6021.8 6025.2 6037.6 5795.1 5883.7 5914.6 5948.6 5989.9 5943.4 5982.3 5987.1 5987.3 6004.7 4408.2 4413.1 4460.4 4468.4 4515.0 3886.6 3911.8 3921.6 3925.1 3967.1 5554.3 5558.3 5561.7 5572.7 5612.2 5940.9 5950.9 5954.1 5956.6 5979.5 5534.9 5568.3 5585.0 5653.0 5658.2 4926.9 4946.8 4960.0 4969.2 4971.9 6197.0 6200.7 6206.4 6206.8 6218.5 6007.0 6038.5 6041.3 6046.3 6054.9 5924.3 6024.8 6038.4 6087.0 6181.1 5809.3 5844.9 5860.7 5877.0 5900.4 5889.9 5939.0 5944.3 5949.1 5969.9 5672.3 5746.6 5790.3 5811.7 5854.3 5817.7 5826.5 5827.5 5830.2 5845.4 5579.5 5749.2 5750.2 5750.7 5765.2 5808.7 5818.5 5826.3 5830.1 5918.1 5662.4 5673.5 5696.7 5698.3 5706.7 08:30:50 INFO - PROCESS | 8904 | 08:30:50 INFO - PROCESS | 8904 | [#1] ext.html Cycles:180 Average:56534.97 Median:22133.75 stddev:113854.50 (514.4%) stddev-sans-first:114096.47 08:30:50 INFO - PROCESS | 8904 | Values: 611.4 612.2 635.3 649.9 669.7 36435.0 37166.6 39813.0 39860.8 40230.4 40883.4 41460.2 41480.2 41691.2 41750.0 8465.4 8743.3 8745.5 8753.7 8755.3 8745.8 8758.7 8811.6 8820.9 8836.1 8807.0 8839.5 8871.2 8894.1 8903.3 8800.1 8838.3 8864.9 8871.1 8871.8 8737.7 8759.3 8810.0 8821.6 8837.2 40031.0 40391.4 40426.2 40499.2 40618.6 2829.2 3351.0 3536.8 3571.9 3607.2 30979.8 31060.0 31228.1 31533.0 31595.5 4037.1 4073.3 4148.4 4171.4 4202.5 300984.0 301024.0 303325.0 303696.0 305486.0 35227.8 35870.0 36034.5 36229.3 36347.8 35774.0 37724.2 37810.0 37902.4 38191.2 15153.1 15287.9 15397.0 15440.8 15455.8 11827.5 12029.5 12047.3 12055.6 12109.8 8856.1 8935.2 8961.6 9013.6 9017.1 3438.4 3466.3 3475.5 3512.3 3543.4 1028.1 1036.3 1058.5 1060.3 1077.8 32359.5 32389.4 32414.4 32502.7 32835.0 1029.6 1097.4 1153.4 1167.2 1196.6 16685.7 16808.8 17393.0 17480.0 17504.7 506868.0 509303.0 515455.0 516892.0 520567.0 59172.4 59998.0 60005.4 60026.3 60044.0 1305.7 1380.8 1381.0 1383.5 1388.7 30672.0 31590.0 32036.7 32053.0 32507.8 49668.0 50099.5 50349.7 50355.7 50593.5 433632.0 437309.0 444516.0 445191.0 447709.0 28293.4 28659.4 28683.9 28948.4 28975.7 47132.3 48212.8 48607.5 48698.3 49844.3 41017.6 41790.8 42322.6 42486.6 42600.6 40432.0 40817.2 41284.4 41512.8 41674.6 40747.0 40758.0 41495.0 41501.8 44427.0 32660.5 34924.0 35137.8 35231.6 35713.6 27100.5 27657.3 27679.6 27838.6 28240.6 08:30:50 INFO - PROCESS | 8904 | 08:30:50 INFO - PROCESS | 8904 | [#2] jquery.html Cycles:180 Average:25904.40 Median:2396.48 stddev:63833.69 (2663.6%) stddev-sans-first:63984.04 08:30:50 INFO - PROCESS | 8904 | Values: 401.8 407.3 415.5 419.0 432.0 19153.6 19411.4 20029.8 20116.5 20133.1 12974.9 13047.5 13055.0 13169.6 13219.5 5299.1 5421.1 5430.0 5438.9 5439.2 5690.5 5971.2 5996.6 6063.8 6071.2 5955.2 6010.6 6030.6 6057.3 6302.7 6460.4 6491.6 6526.6 6532.3 6577.4 5729.6 5795.3 5809.9 5810.8 5812.5 14848.9 15046.6 15097.6 21814.7 22774.3 2306.6 2349.8 2351.3 2441.6 2531.9 10232.3 10761.1 10780.6 11132.2 11269.2 1902.6 1966.6 1976.8 1993.8 2049.3 79569.6 85333.6 87021.7 87760.0 87896.6 11162.3 11368.0 11659.7 12109.5 12541.7 16671.8 16785.8 16819.6 16890.9 16913.7 8090.4 8184.4 8186.6 8209.8 8250.4 7616.0 7648.8 7820.4 8073.3 8128.5 4889.4 4930.0 4962.4 5233.3 5306.7 2072.3 2120.8 2132.2 2153.5 2174.4 922.8 969.7 973.7 988.7 1093.6 20317.4 20452.5 20468.2 20508.8 20625.0 984.5 992.5 996.1 1020.5 1078.1 10762.1 11342.5 11553.9 11701.1 11785.8 352951.0 359573.0 362296.0 416273.0 422250.0 58283.0 69390.0 84562.0 86410.6 87625.6 1006.4 1015.3 1041.4 1052.6 1053.7 18439.0 18489.4 19012.6 19077.7 19104.5 40947.8 43331.4 43947.3 44454.6 45810.1 59915.4 60741.1 60780.4 61744.7 61760.0 9249.3 9330.4 9333.9 9372.0 9654.8 11228.3 13774.3 13848.9 14021.2 14158.9 11396.4 12065.7 12375.6 12489.9 12526.7 11807.1 11823.9 11925.9 12192.0 12456.6 12239.7 12324.1 12412.6 12449.0 12449.7 9085.6 9233.7 9256.8 9341.8 9521.2 11933.2 11984.3 11990.1 12090.3 12144.4 08:30:50 INFO - PROCESS | 8904 | 08:30:50 INFO - PROCESS | 8904 | [#3] mootools.html Cycles:180 Average:6072.45 Median:2717.20 stddev:3500.66 (128.8%) stddev-sans-first:3493.55 08:30:50 INFO - PROCESS | 8904 | Values: 1491.5 1500.5 1654.9 1787.9 1796.9 8241.8 8925.0 9074.3 9644.9 9686.7 9469.1 9479.1 9571.2 9587.0 9604.7 2450.8 2482.4 2499.8 2503.6 2509.2 2420.6 2478.3 2489.0 2504.9 2518.7 2450.6 2460.6 2479.3 2487.1 2492.6 2451.9 2453.1 2471.5 2493.6 2498.7 2417.3 2422.2 2442.0 2442.5 2479.8 9463.4 9677.7 9695.6 9695.8 9717.9 5414.2 5516.6 5521.5 5538.9 5544.0 3339.5 3429.5 3479.1 3511.8 3653.7 1095.6 1113.9 1117.0 1118.9 1131.6 12637.7 12643.0 12655.5 12698.4 12700.5 4943.4 5031.0 5124.8 5128.9 5148.8 10591.5 10591.5 10687.5 10712.5 10719.9 5635.6 5676.8 5712.7 5720.3 5741.0 4489.2 4944.5 5037.7 5170.8 5193.2 4188.6 4254.8 4267.5 4347.7 4384.8 1345.3 1380.6 1390.1 1399.5 1406.5 944.7 964.5 975.6 976.0 990.1 6085.0 6172.9 6190.2 6222.5 6299.9 475.9 477.5 489.2 490.3 491.0 3820.7 3876.2 3903.7 3923.3 3963.9 11275.9 11647.8 11713.1 11734.7 11754.1 11552.1 11642.2 11651.7 11679.1 11710.2 8018.1 8303.1 8386.2 8599.1 8637.9 6096.5 6334.7 6344.2 6386.8 6481.2 10649.3 10775.5 10811.6 11014.6 11027.1 10196.3 10584.1 10628.3 10999.3 11083.9 8167.1 8260.0 8273.0 8316.3 8335.0 8874.5 8876.2 8908.9 8936.6 8977.1 7911.0 8085.7 8147.6 8173.8 8191.3 7615.6 7617.8 7706.7 7840.7 7860.1 6904.3 6935.1 6985.6 7075.8 7093.4 5052.2 5094.5 5105.3 5124.6 5183.0 5026.3 5201.7 5237.0 5315.6 5385.6 08:30:50 INFO - PROCESS | 8904 | 08:30:50 INFO - PROCESS | 8904 | [#4] prototype.html Cycles:180 Average:4784.98 Median:5334.45 stddev:1359.14 (25.5%) stddev-sans-first:1321.28 08:30:50 INFO - PROCESS | 8904 | Values: 335.6 351.6 352.6 354.8 358.4 5496.8 5550.8 5683.8 5724.7 5740.0 5510.4 5549.8 5558.6 5592.7 5609.3 4336.8 4358.5 4362.3 4383.9 4403.2 4138.0 4401.6 4404.9 4443.5 4445.7 4398.1 4410.5 4411.8 4418.6 4419.0 4440.0 4441.8 4443.6 4478.8 4498.4 3726.3 3942.5 3981.5 3992.7 3997.1 5473.4 5532.3 5534.4 5549.3 5563.0 5107.2 5107.5 5110.7 5129.8 5137.8 5688.3 5952.1 5999.2 6002.0 6043.2 4335.4 4357.3 4372.6 4391.1 4403.7 6186.8 6189.9 6192.5 6203.9 6214.4 4314.8 4391.0 4404.1 4435.8 4451.5 4451.5 4486.8 4489.4 4496.1 4507.6 5080.7 5104.9 5122.7 5163.8 5178.3 5641.8 5651.4 5811.3 5968.6 6003.4 1515.4 1516.6 1536.4 1538.8 1541.7 990.8 993.1 1002.9 1026.3 1030.4 5083.9 5085.3 5091.6 5114.8 5127.6 5325.3 5334.5 5432.9 5434.8 5443.5 4854.3 4969.8 4975.7 5148.2 5227.3 2831.8 2859.4 2865.0 2884.5 2898.6 5471.0 5483.4 5550.2 5592.7 5596.9 5246.4 5448.9 5452.4 5469.9 5515.4 5393.3 5447.4 5482.3 5490.8 5509.9 5032.4 5245.6 5327.5 5334.4 5335.5 5311.5 5341.7 5355.9 5407.7 5433.5 5473.4 5538.6 5548.1 5563.2 5565.0 3859.8 4067.6 4115.5 4120.8 4134.3 5309.4 5338.0 5399.9 5770.5 5802.4 5754.3 5781.7 5794.4 5803.1 5842.1 5801.7 5843.5 5873.4 5890.1 5895.4 5613.2 5764.7 5802.3 5803.9 5815.9 5878.6 5894.3 5910.8 5926.0 5928.2 5614.2 5770.2 5773.3 5787.3 5787.7 08:30:50 INFO - PROCESS | 8904 | 08:30:50 INFO - PROCESS | 8904 | [#5] yui.html Cycles:180 Average:21465.05 Median:4281.87 stddev:30622.65 (715.2%) stddev-sans-first:30668.99 08:30:50 INFO - PROCESS | 8904 | Values: 734.3 786.0 796.4 835.3 839.9 15500.1 15871.3 16075.8 16130.2 16191.8 15411.1 15427.4 15505.1 15614.8 15685.1 676.8 784.3 798.2 803.4 813.6 806.7 807.1 809.6 809.8 815.6 855.6 856.8 861.1 864.0 864.9 854.5 856.0 860.4 861.4 862.3 616.7 626.3 626.6 630.3 630.6 15105.8 15158.0 15210.4 15236.1 15275.9 15591.5 15709.9 15905.2 15922.2 16024.3 12320.3 12369.6 12406.4 12409.3 12746.6 3811.3 3915.5 3919.9 3927.9 3938.5 78147.6 78382.2 78964.0 79540.6 83275.0 11995.3 12070.3 12147.2 12219.8 12506.0 23838.2 23862.9 23866.4 23973.3 23985.5 8632.7 8748.8 8939.1 8963.6 9109.2 4625.2 4678.2 4749.5 4834.8 5022.4 3514.9 3592.4 3599.0 3635.5 3784.1 609.7 610.7 612.2 615.3 624.7 645.1 721.9 739.6 760.2 762.0 9459.9 9861.3 9956.7 10221.8 10652.4 714.6 776.5 782.9 794.7 807.0 4914.8 5065.3 5077.5 5092.8 5212.6 79527.0 113400.0 114938.4 120827.0 124597.4 104651.0 105330.5 106375.0 106827.8 107426.5 84291.6 86685.6 88380.6 89476.0 89514.0 9562.8 9629.8 9645.3 9648.6 9760.2 48793.0 49811.5 50677.2 51477.7 52056.7 71625.6 79424.6 79947.2 81845.6 83036.6 12367.8 12455.6 12478.9 12614.5 13141.9 14477.6 14842.3 15134.7 15482.5 16091.4 13671.0 14269.9 14497.9 14611.3 14622.9 13683.2 14386.8 14718.9 15096.1 15500.6 13612.0 13853.5 14129.6 14390.0 14414.6 11697.0 11731.3 11796.3 12017.0 12182.8 11746.9 12066.7 12284.1 12409.9 12782.3 08:30:50 INFO - PROCESS | 8904 | -------- Summary: end -------- 08:30:50 INFO - PROCESS | 8904 | 08:30:51 INFO - TEST-INFO | 8904: exit 0 08:30:51 INFO - TEST-OK | dromaeo_css | took 1111548ms 08:30:51 INFO - TEST-START | kraken 08:30:51 INFO - operating with platform_type : linux_ 08:30:51 INFO - Initialising browser for kraken test... 08:30:51 INFO - TEST-INFO | started process 9135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6l_iP/profile http://localhost:39235/getInfo.html) 08:30:56 INFO - PROCESS | 9135 | __metrics Screen width/height:1600/1200 08:30:56 INFO - PROCESS | 9135 | colorDepth:24 08:30:56 INFO - PROCESS | 9135 | Browser inner width/height: 1024/697 08:30:56 INFO - PROCESS | 9135 | __metrics 08:30:57 ERROR - PROCESS | 9135 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:30:58 INFO - TEST-INFO | 9135: exit 0 08:30:58 INFO - Browser initialized. 08:30:58 INFO - Running cycle 1/1 for kraken test... 08:30:58 INFO - TEST-INFO | started process 9254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6l_iP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:10 INFO - PROCESS | 9254 | RSS: Main: 184614912 08:31:10 INFO - PROCESS | 9254 | 08:31:12 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39235/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:13 INFO - PROCESS | 9254 | RSS: Main: 190701568 08:31:13 INFO - PROCESS | 9254 | 08:31:16 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39235/tests/kraken/driver.html?testName=audio-dft) 08:31:16 INFO - PROCESS | 9254 | RSS: Main: 190361600 08:31:16 INFO - PROCESS | 9254 | 08:31:19 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39235/tests/kraken/driver.html?testName=audio-fft) 08:31:20 INFO - PROCESS | 9254 | RSS: Main: 185040896 08:31:20 INFO - PROCESS | 9254 | 08:31:22 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39235/tests/kraken/driver.html?testName=audio-oscillator) 08:31:23 INFO - PROCESS | 9254 | RSS: Main: 185892864 08:31:23 INFO - PROCESS | 9254 | 08:31:25 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:25 INFO - PROCESS | 9254 | RSS: Main: 186028032 08:31:25 INFO - PROCESS | 9254 | 08:31:29 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39235/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:29 INFO - PROCESS | 9254 | RSS: Main: 186499072 08:31:29 INFO - PROCESS | 9254 | 08:31:33 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39235/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:33 INFO - PROCESS | 9254 | RSS: Main: 184053760 08:31:33 INFO - PROCESS | 9254 | 08:31:36 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39235/tests/kraken/driver.html?testName=json-parse-financial) 08:31:37 INFO - PROCESS | 9254 | RSS: Main: 185294848 08:31:37 INFO - PROCESS | 9254 | 08:31:38 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:39 INFO - PROCESS | 9254 | RSS: Main: 185925632 08:31:39 INFO - PROCESS | 9254 | 08:31:41 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:41 INFO - PROCESS | 9254 | RSS: Main: 186486784 08:31:41 INFO - PROCESS | 9254 | 08:31:43 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:44 INFO - PROCESS | 9254 | RSS: Main: 186671104 08:31:44 INFO - PROCESS | 9254 | 08:31:47 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:47 INFO - PROCESS | 9254 | RSS: Main: 186195968 08:31:47 INFO - PROCESS | 9254 | 08:31:50 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:51 INFO - PROCESS | 9254 | RSS: Main: 186208256 08:31:51 INFO - PROCESS | 9254 | 08:31:52 INFO - PROCESS | 9254 | Cycle 1(1): loaded http://localhost:39235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39235/tests/kraken/driver.html?testName=ai-astar) 08:31:53 INFO - PROCESS | 9254 | RSS: Main: 187117568 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | __start_tp_report 08:31:53 INFO - PROCESS | 9254 | _x_x_mozilla_page_load 08:31:53 INFO - PROCESS | 9254 | _x_x_mozilla_page_load_details 08:31:53 INFO - PROCESS | 9254 | |i|pagename|runs| 08:31:53 INFO - PROCESS | 9254 | |0;ai-astar;112;106;109;110;113;112;114;110;112;109 08:31:53 INFO - PROCESS | 9254 | |1;audio-beat-detection;154;125;159;186;127;157;158;129;180;135 08:31:53 INFO - PROCESS | 9254 | |2;audio-dft;162;164;162;165;165;169;163;162;162;163 08:31:53 INFO - PROCESS | 9254 | |3;audio-fft;75;74;74;159;76;77;76;76;180;74 08:31:53 INFO - PROCESS | 9254 | |4;audio-oscillator;85;84;154;84;85;86;144;83;84;139 08:31:53 INFO - PROCESS | 9254 | |5;imaging-gaussian-blur;119;118;117;118;118;117;118;117;118;122 08:31:53 INFO - PROCESS | 9254 | |6;imaging-darkroom;147;149;148;148;146;147;146;146;147;146 08:31:53 INFO - PROCESS | 9254 | |7;imaging-desaturate;97;95;95;95;96;96;96;95;95;97 08:31:53 INFO - PROCESS | 9254 | |8;json-parse-financial;54;55;54;57;55;54;56;54;57;52 08:31:53 INFO - PROCESS | 9254 | |9;json-stringify-tinderbox;60;61;61;60;60;61;60;59;61;61 08:31:53 INFO - PROCESS | 9254 | |10;stanford-crypto-aes;79;80;77;80;81;82;82;82;106;79 08:31:53 INFO - PROCESS | 9254 | |11;stanford-crypto-ccm;128;130;124;120;122;135;126;124;126;136 08:31:53 INFO - PROCESS | 9254 | |12;stanford-crypto-pbkdf2;169;164;164;164;160;159;162;167;158;160 08:31:53 INFO - PROCESS | 9254 | |13;stanford-crypto-sha256-iterative;67;66;68;63;65;67;63;62;65;64 08:31:53 INFO - PROCESS | 9254 | __end_tp_report 08:31:53 INFO - PROCESS | 9254 | __start_cc_report 08:31:53 INFO - PROCESS | 9254 | _x_x_mozilla_cycle_collect,900 08:31:53 INFO - PROCESS | 9254 | __end_cc_report 08:31:53 INFO - PROCESS | 9254 | __startTimestamp1465918313090__endTimestamp 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | ------- Summary: start ------- 08:31:53 INFO - PROCESS | 9254 | Number of tests: 14 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.36 (2.1%) stddev-sans-first:2.46 08:31:53 INFO - PROCESS | 9254 | Values: 112.0 106.0 109.0 110.0 113.0 112.0 114.0 110.0 112.0 109.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:157.50 stddev:21.64 (13.7%) stddev-sans-first:22.93 08:31:53 INFO - PROCESS | 9254 | Values: 154.0 125.0 159.0 186.0 127.0 157.0 158.0 129.0 180.0 135.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.21 (1.4%) stddev-sans-first:2.26 08:31:53 INFO - PROCESS | 9254 | Values: 162.0 164.0 162.0 165.0 165.0 169.0 163.0 162.0 162.0 163.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:40.06 (53.1%) stddev-sans-first:41.89 08:31:53 INFO - PROCESS | 9254 | Values: 75.0 74.0 74.0 159.0 76.0 77.0 76.0 76.0 180.0 74.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:84.00 stddev:29.81 (35.5%) stddev-sans-first:30.91 08:31:53 INFO - PROCESS | 9254 | Values: 85.0 84.0 154.0 84.0 85.0 86.0 144.0 83.0 84.0 139.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.48 (1.3%) stddev-sans-first:1.54 08:31:53 INFO - PROCESS | 9254 | Values: 119.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 122.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 08:31:53 INFO - PROCESS | 9254 | Values: 147.0 149.0 148.0 148.0 146.0 147.0 146.0 146.0 147.0 146.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 08:31:53 INFO - PROCESS | 9254 | Values: 97.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 97.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.55 (2.8%) stddev-sans-first:1.62 08:31:53 INFO - PROCESS | 9254 | Values: 54.0 55.0 54.0 57.0 55.0 54.0 56.0 54.0 57.0 52.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 08:31:53 INFO - PROCESS | 9254 | Values: 60.0 61.0 61.0 60.0 60.0 61.0 60.0 59.0 61.0 61.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:80.50 stddev:8.31 (10.3%) stddev-sans-first:8.70 08:31:53 INFO - PROCESS | 9254 | Values: 79.0 80.0 77.0 80.0 81.0 82.0 82.0 82.0 106.0 79.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:127.00 stddev:5.26 (4.1%) stddev-sans-first:5.57 08:31:53 INFO - PROCESS | 9254 | Values: 128.0 130.0 124.0 120.0 122.0 135.0 126.0 124.0 126.0 136.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:164.00 stddev:3.56 (2.2%) stddev-sans-first:2.96 08:31:53 INFO - PROCESS | 9254 | Values: 169.0 164.0 164.0 164.0 160.0 159.0 162.0 167.0 158.0 160.0 08:31:53 INFO - PROCESS | 9254 | 08:31:53 INFO - PROCESS | 9254 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.50 stddev:2.00 (3.1%) stddev-sans-first:1.99 08:31:53 INFO - PROCESS | 9254 | Values: 67.0 66.0 68.0 63.0 65.0 67.0 63.0 62.0 65.0 64.0 08:31:53 INFO - PROCESS | 9254 | -------- Summary: end -------- 08:31:53 INFO - PROCESS | 9254 | 08:31:54 INFO - TEST-INFO | 9254: exit 0 08:31:54 INFO - TEST-OK | kraken | took 62555ms 08:31:54 INFO - SUITE-END | took 1174s 08:31:54 INFO - Completed test suite (00:19:34) 08:31:54 INFO - javascript benchmark 08:31:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7303.113763335396, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.768876293864, 3131.3580715953226, 3140.8272545010013, 3172.3179516403984, 3177.9205519862016, 5481.75332110055, 5552.6390784599025, 5603.07549254373, 5611.7755289788465, 5623.606347555673, 5430.886668233013, 5507.586930980173, 5529.751161197746, 5550.16747487877, 5614.859628509289, 4880.9755951220195, 4915.238138088602, 5025.57282630975, 5068.8732781680565, 5127.02586508564, 198.2483601941619, 4916.410030796309, 4950.6287028472825, 4999.7500124993785, 5020.523050310215, 4958.603311735053, 4975.7263350515705, 4986.252062190682, 4997.6501644884875, 5006.998600279959, 5001.324821149135, 5008.323876276692, 5008.69947803133, 5016.147254966628, 5044.344235249431, 4878.707277563358, 4936.827211047632, 4950.554450099472, 4956.727379994099, 4979.8008079676765, 5431.53831924283, 5556.638818476786, 5557.5831812613815, 5562.610617256793, 5610.607257491977, 5771.307443106854, 5836.533077353802, 5910.320313163955, 5918.348981612019, 5931.703414829241, 5903.26209223847, 6021.969890150521, 6043.033114701627, 6067.089936509515, 6091.360407157274, 5605.691686957216, 5607.2990876140075, 5608.887822243532, 5620.381758006616, 5621.971890140523, 5953.702314884238, 6079.635221886701, 6100.420460056288, 6136.9079463808075, 6149.3235744068115, 5921.289445266596, 5929.73316200772, 5930.970345148246, 5938.703064846827, 5971.4028597140805, 6009.399060093956, 6014.578979471395, 6021.849453763691, 6025.216721826135, 6037.63774173551, 5795.072788353843, 5883.676397798076, 5914.556408269397, 5948.553858460633, 5989.850253743692, 5943.435373639497, 5982.282126144803, 5987.101934709828, 5987.251593550806, 6004.669743164168, 4408.181200814957, 4413.117376524708, 4460.353248778909, 4468.396766436489, 4515.0, 3886.5530463997, 3911.8435262589746, 3921.5882332355263, 3925.0776067624083, 3967.067739081371, 5554.250176226238, 5558.333000040021, 5561.749721262553, 5572.749226284827, 5612.214289999403, 5940.940590594125, 5950.940490595039, 5954.106883967353, 5956.642601443928, 5979.4917432018765, 5534.944650553523, 5568.303962004749, 5585.022621041301, 5653.0, 5658.151277308437, 4926.926096108561, 4946.752662366867, 4960.0, 4969.204927211629, 4971.90056198874, 6197.0, 6200.658963756947, 6206.379362063757, 6206.844828879314, 6218.502519798405, 6006.969965150146, 6038.547108966757, 6041.305249896318, 6046.274447066205, 6054.878902422015, 5924.348321684525, 6024.819255422344, 6038.426349496791, 6086.969565152146, 6181.072839074175, 5809.302883653989, 5844.853878653068, 5860.736266867916, 5876.970615146897, 5900.380460051632, 5889.911651325147, 5938.970305148447, 5944.346121926671, 5949.077892926603, 5969.940300597113, 5672.262605861211, 5746.569007324551, 5790.276215473066, 5811.709414529341, 5854.297484301911, 5817.680027598522, 5826.475617194304, 5827.475527202572, 5830.183774271521, 5845.444682755132, 5579.525740312119, 5749.195112684144, 5750.166225897138, 5750.6837123958585, 5765.192872997867, 5808.7095645218415, 5818.505427038749, 5826.271716035496, 5830.067189249699, 5918.082697181943, 5662.377138514677, 5673.461021202979, 5696.686682232517, 5698.2592263005545, 5706.686132262599], "value": 5418.67295444144, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.4313688269907, 612.1613389656171, 635.2504045226631, 649.8700259948012, 669.6618207805058, 36435.0, 37166.62833371669, 39813.0, 39860.80069599648, 40230.396544051866, 40883.386749198784, 41460.17079658405, 41480.17039659205, 41691.16617667645, 41750.0, 8465.44974576652, 8743.300535957109, 8745.518996455192, 8753.737387878375, 8755.25580325673, 8745.781355466132, 8758.737237882842, 8811.603477843513, 8820.911790882074, 8836.072212417668, 8807.0, 8839.46963182211, 8871.24594409476, 8894.066123057082, 8903.332250081237, 8800.07599202081, 8838.29293656506, 8864.911350886505, 8871.068537803567, 8871.778205544913, 8737.694180703646, 8759.2992560595, 8810.0, 8821.558922053871, 8837.204651581324, 40031.0, 40391.39412908779, 40426.19147617061, 40499.190016199806, 40618.59381406207, 2829.1936798012675, 3350.966490335114, 3536.7877927324444, 3571.8928432147077, 3607.188382613917, 30979.845100774353, 31060.0, 31228.063158105295, 31533.0, 31595.52606710901, 4037.1118353962083, 4073.348264277731, 4148.357004664282, 4171.395147703596, 4202.537720850704, 300984.0, 301024.0, 303325.0, 303696.0, 305485.9999999978, 35227.82386088053, 35870.0, 36034.45948310778, 36229.27541449156, 36347.81826090853, 35774.0, 37724.24551508955, 37810.0, 37902.43146352807, 38191.23617527634, 15153.090814551162, 15287.923560382127, 15397.0, 15440.84559154394, 15455.768163477556, 11827.467763950643, 12029.518819247307, 12047.337396443105, 12055.613604435426, 12109.757804843854, 8856.114388561222, 8935.195832375117, 8961.59672814725, 9013.63945442188, 9017.098290171061, 3438.432658611301, 3466.2547552276383, 3475.4960530722906, 3512.297540491912, 3543.362194804908, 1028.1466382902174, 1036.3212096077082, 1058.4707646176912, 1060.2578195263347, 1077.8113830079706, 32359.51460728091, 32389.35221295608, 32414.35171296561, 32502.674973249967, 32835.0, 1029.629333439961, 1097.4403054442291, 1153.3598852636699, 1167.2121318110242, 1196.6350263169816, 16685.666286674197, 16808.831911680973, 17392.956422614683, 17479.986732082343, 17504.737428938577, 506868.0, 509303.0, 515455.0, 516892.0, 520567.0, 59172.40827591755, 59998.0, 60005.399946000856, 60026.29881655336, 60044.0, 1305.7127431964952, 1380.751464736337, 1381.0470775165104, 1383.4950243161175, 1388.6528367908022, 30672.0, 31590.0, 32036.6796332043, 32053.0, 32507.83746081349, 49668.0, 50099.499005009486, 50349.734261957565, 50355.74822125866, 50593.49406506035, 433632.0, 437309.0, 444516.0, 445191.0, 447709.0, 28293.43413131767, 28659.426811464073, 28683.8565807178, 28948.42103157883, 28975.7102428973, 47132.29301560548, 48212.75893620509, 48607.5139248603, 48698.26952595643, 49844.25233621571, 41017.58982410138, 41790.79104604579, 42322.576774231864, 42486.57513424826, 42600.57399425966, 40432.0, 40817.18365632612, 41284.38073428961, 41512.79243603763, 41674.58325416828, 40747.0, 40758.0, 41495.0, 41501.792491037355, 44427.0, 32660.510092349108, 34924.0, 35137.824310878284, 35231.64768352284, 35713.64286357103, 27100.457990840467, 27657.308567285978, 27679.584806227518, 27838.58242126329, 28240.576391353734], "value": 18512.723380746815, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.7930765655687, 407.26895223074575, 415.5470537114546, 418.98533551325704, 431.96112349888506, 19153.61692766144, 19411.41765747028, 20029.799702002976, 20116.497087572818, 20133.094010769513, 12974.870251297485, 13047.478100875976, 13054.955603551716, 13169.604911852659, 13219.471221151143, 5299.099153143975, 5421.051316019681, 5430.0, 5438.864028399282, 5439.211314359435, 5690.5447564194765, 5971.193888825018, 5996.610220335664, 6063.757449702007, 6071.241094863142, 5955.225820643311, 6010.639361638294, 6030.638161710312, 6057.30341010785, 6302.7163777629885, 6460.3862633049785, 6491.578047426902, 6526.575772574767, 6532.3467653234775, 6577.440917522016, 5729.598928075036, 5795.304563452412, 5809.912851307234, 5810.796622118206, 5812.534997200214, 14848.925755371154, 15046.623834404118, 15097.622559435993, 21814.672779908313, 22774.316770496913, 2306.6194077977116, 2349.7767712067325, 2351.341624345186, 2441.609342505191, 2531.873406329676, 10232.334898231591, 10761.08530774885, 10780.5687772489, 11132.220744547885, 11269.154813388946, 1902.6099649571943, 1966.6165097805933, 1976.8122028407279, 1993.820556149939, 2049.3237231713497, 79569.60215198944, 85333.57333213356, 87021.69467458056, 87760.0, 87896.56051719765, 11162.274452160584, 11368.0, 11659.650210493699, 12109.455074521667, 12541.749165016648, 16671.83328166727, 16785.83214167867, 16819.579510512336, 16890.915545422195, 16913.66172676564, 8090.352771778244, 8184.386171037077, 8186.590670466453, 8209.79475513105, 8250.3812214083, 7616.0, 7648.847023059619, 7820.374370050382, 8073.31376832964, 8128.471649342774, 4889.413270407503, 4929.950700493021, 4962.354893863775, 5233.267342571967, 5306.708131052829, 2072.347210628647, 2120.787921207867, 2132.168454302823, 2153.5477549714738, 2174.423777698911, 922.8246633139682, 969.6606187834202, 973.7419583810296, 988.6687959533637, 1093.6336327330275, 20317.390478285673, 20452.488687782923, 20468.18127274922, 20508.79491205069, 20625.0, 984.5077461269366, 992.5186284651938, 996.0786272697726, 1020.4948550467418, 1078.0620859851822, 10762.085222755997, 11342.489587968561, 11553.884461155281, 11701.122415818847, 11785.823212651818, 352951.0, 359573.0, 362296.0, 416273.0, 422250.0, 58283.0, 69390.0, 84562.0, 86410.56794715986, 87625.56187219023, 1006.4162785584343, 1015.28422462164, 1041.4272150317295, 1052.6157952347492, 1053.7207639975413, 18439.0, 18489.352872649393, 19012.619747605248, 19077.687335408544, 19104.522386940436, 40947.795261024694, 43331.35002975021, 43947.34078988754, 44454.55545444634, 45810.08379832318, 59915.40084599273, 60741.0888836659, 60780.39219607924, 61744.69127654513, 61760.0, 9249.30630202751, 9330.440173589606, 9333.906660933304, 9371.953140234255, 9654.806903862023, 11228.326300422, 13774.311284435938, 13848.930755346159, 14021.228832414316, 14158.929205353907, 11396.373199474108, 12065.698357540781, 12375.62873113772, 12489.93755031219, 12526.686832828887, 11807.055435565306, 11823.940880295544, 11925.880741192825, 12192.0, 12456.564020259248, 12239.69400764988, 12324.07569432314, 12412.56556020535, 12449.0, 12449.688757781129, 9085.591148398205, 9233.722988310094, 9256.814863702553, 9341.766455838659, 9521.190698790404, 11933.164678472423, 11984.340861252715, 11990.100742444178, 12090.335031572997, 12144.39278036077], "value": 9319.688350812014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.4556186991747, 1500.4598344595947, 1654.8924319919204, 1787.9361779741066, 1796.946091617251, 8241.752747417571, 8925.0, 9074.319426043041, 9644.90355096449, 9686.66096686616, 9469.147776700096, 9479.146876781087, 9571.2343012559, 9586.952065239682, 9604.711858644252, 2450.8406953548006, 2482.4290413204885, 2499.8125140614434, 2503.6244563315468, 2509.1845150326126, 2420.6006009008493, 2478.330850670318, 2488.9875550622223, 2504.9248522544353, 2518.6725725655638, 2450.571150048743, 2460.5817011108065, 2479.293401380607, 2487.1046423287694, 2492.5638013347684, 2451.852888826676, 2453.092355828337, 2471.530409222251, 2493.6259561065804, 2498.700155981294, 2417.2748175547267, 2422.2369953464777, 2442.0353960185626, 2442.511497700467, 2479.789217916479, 9463.38487998278, 9677.661281855102, 9695.563699633534, 9695.806083878353, 9717.90282097177, 5414.160805075219, 5516.613837031409, 5521.4539928819995, 5538.9169162462595, 5543.99999999996, 3339.5491608632765, 3429.5027221053056, 3479.0954351868695, 3511.7892926424242, 3653.6894363979095, 1095.6439157273837, 1113.8551988241559, 1116.9835449740697, 1118.9104871610334, 1131.609594689839, 12637.684057898627, 12642.988560915104, 12655.493780248778, 12698.365081745967, 12700.491980320776, 4943.382077240345, 5031.0, 5124.846254612367, 5128.9230661540105, 5148.794048238104, 10591.523381447852, 10591.523381447852, 10687.519061642244, 10712.46437678113, 10719.946400267949, 5635.5773317001385, 5676.801311954062, 5712.65724056558, 5720.256366672389, 5741.0, 4489.214387482178, 4944.456109827916, 5037.748112594356, 5170.793168273302, 5193.169092945111, 4188.6230239278, 4254.829806807755, 4267.487901451784, 4347.7173983690955, 4384.758838263862, 1345.3004437692346, 1380.641033331341, 1390.1172755300254, 1399.5451478269604, 1406.4655430936384, 944.7165850244899, 964.5322018820866, 975.6487664440796, 976.0337266106503, 990.0545876018787, 6084.969575152096, 6172.938270617326, 6190.164327815777, 6222.533310001768, 6299.937000630027, 475.9262314341283, 477.46762359968386, 489.16597201771606, 490.32335377179265, 491.0179640718563, 3820.656140947328, 3876.1666241758157, 3903.687704983651, 3923.313420151462, 3963.9405408918315, 11275.887241127484, 11647.76704465906, 11713.121515886343, 11734.70663233409, 11754.11844111695, 11552.133589980785, 11642.185047046625, 11651.650450486499, 11679.124065695107, 11710.180287379972, 8018.077921039038, 8303.128171542023, 8386.245237928615, 8599.14008599135, 8637.913620863837, 6096.542759292982, 6334.651594162366, 6344.238691356882, 6386.840328991812, 6481.157449531531, 10649.254552181583, 10775.515101820594, 10811.6215932442, 11014.614488492864, 11027.062699670618, 10196.286259961731, 10584.100351469904, 10628.256022078689, 10999.285046471954, 11083.944580277048, 8167.1424500428975, 8260.0, 8272.958635206785, 8316.334693224648, 8334.958325208336, 8874.467531948103, 8876.20114189726, 8908.910910890809, 8936.553172341486, 8977.147171018743, 7910.9604451977375, 8085.71699990521, 8147.63335649909, 8173.79565510867, 8191.344692424473, 7615.581143036965, 7617.771466856003, 7706.730264440717, 7840.686372545034, 7860.135385107519, 6904.344087311697, 6935.133108361455, 6985.615791131537, 7075.82310442243, 7093.432525398059, 5052.1663925451885, 5094.541491265803, 5105.31078304439, 5124.56441202502, 5183.0, 5026.346574945233, 5201.687898726089, 5237.0, 5315.574754019592, 5385.596080294072], "value": 4765.591230594818, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.6157200005993, 351.6044449993758, 352.56458274031576, 354.8190422884328, 358.4211498430035, 5496.835094947158, 5550.8057217997375, 5683.772649094037, 5724.742386592603, 5739.971300143498, 5510.3744395403355, 5549.77800887964, 5558.610897237185, 5592.692401917893, 5609.270794796681, 4336.76147811871, 4358.498772641139, 4362.32383980482, 4383.868483945486, 4403.163398954189, 4137.958620413802, 4401.645119860875, 4404.911901761963, 4443.488998765151, 4445.68880178386, 4398.142362239365, 4410.536893626171, 4411.779411029452, 4418.580234877698, 4419.0057237121555, 4439.955600443986, 4441.777911104432, 4443.644508439317, 4478.7984540695425, 4498.415206023229, 3726.347889119393, 3942.5071866016747, 3981.5222173339093, 3992.7005474589523, 3997.060690737674, 5473.370562385297, 5532.336119665666, 5534.391216966131, 5549.250851135085, 5563.0, 5107.208382700687, 5107.540321371094, 5110.693358398471, 5129.820456284012, 5137.766935935386, 5688.317401911797, 5952.136940143699, 5999.220101386792, 6001.969990150022, 6043.184170137063, 4335.436393268887, 4357.324614684729, 4372.606465418127, 4391.14372697321, 4403.691741578091, 6186.81439556814, 6189.876202475925, 6192.473639740628, 6203.906941395838, 6214.4407003369915, 4314.7626880521875, 4391.0, 4404.119176164716, 4435.844745433958, 4451.530994771718, 4451.532589078165, 4486.75322857246, 4489.371487991683, 4496.100779843979, 4507.57178068083, 5080.6790234539285, 5104.923426148611, 5122.667026643257, 5163.793448262102, 5178.275041494194, 5641.802536911188, 5651.378348381675, 5811.3316968548315, 5968.552358573124, 6003.369646187175, 1515.3559737111684, 1516.6208447888027, 1536.4238410596026, 1538.7768773528, 1541.6685412636336, 990.7523119220195, 993.1409330928839, 1002.9147522460672, 1026.296986564206, 1030.3766221436074, 5083.923741143886, 5085.313482679865, 5091.592672586185, 5114.820981265638, 5127.6154288428515, 5325.2810870531985, 5334.546563542142, 5432.864178395572, 5434.750007498297, 5443.537299329522, 4854.344663470457, 4969.751512424436, 4975.676581022222, 5148.2277658350795, 5227.294315267391, 2831.7734581233453, 2859.411438644488, 2864.985675071653, 2884.5096333623333, 2898.6376702912135, 5470.972645136749, 5483.353569876068, 5550.223928342892, 5592.748326325325, 5596.916046259309, 5246.3704355477585, 5448.945510544923, 5452.40023597404, 5469.890602188014, 5515.448455154533, 5393.298871146804, 5447.428020057837, 5482.314710661168, 5490.752916118704, 5509.944900551023, 5032.43994361749, 5245.580353571629, 5327.547158491571, 5334.359876814807, 5335.546478549211, 5311.49540793624, 5341.732913354239, 5355.919661205007, 5407.729613519387, 5433.510984011458, 5473.397926228032, 5538.584606154474, 5548.085910360919, 5563.193336966198, 5564.972175139098, 3859.842047385829, 4067.552569217443, 4115.526714427879, 4120.75275483472, 4134.297169481135, 5309.415964244007, 5337.973310133424, 5399.892002159856, 5770.5095066919785, 5802.4197580241635, 5754.251947246831, 5781.728019835629, 5794.420557944172, 5803.100519419497, 5842.094475356326, 5801.6519008859605, 5843.532517398513, 5873.3832947539895, 5890.14592884038, 5895.4399332063385, 5613.214150018919, 5764.674124951201, 5802.274715660543, 5803.912941305968, 5815.883682326415, 5878.617889837318, 5894.2926848778425, 5910.763569457174, 5925.970370148121, 5928.170056192051, 5614.24207731951, 5770.163326317576, 5773.278340207474, 5787.276590426197, 5787.7395517200985], "value": 4356.682100678206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.3464316758085, 785.9821531117202, 796.3748457460895, 835.3275613131427, 839.8908141941548, 15500.147491887941, 15871.285792139353, 16075.83924160758, 16130.193490325495, 16191.83808161918, 15411.07533547988, 15427.382904683827, 15505.06969581823, 15614.843851561482, 15685.058896466191, 676.7766637009775, 784.3176436500253, 798.2217338095369, 803.3693550562809, 813.6013353456823, 806.7337778533099, 807.0597753617029, 809.6194788449419, 809.7732634862218, 815.6248125862081, 855.5850412549909, 856.7729551668813, 861.0786458489418, 864.0322838420977, 864.9437786543855, 854.5257382152903, 855.9914400856036, 860.3848248502288, 861.4314552395451, 862.3144600042949, 616.7101462312751, 626.2578844069792, 626.6428135962503, 630.2814791138106, 630.552307861419, 15105.848941510554, 15158.0, 15210.391584336614, 15236.085834849833, 15275.923620381827, 15591.45429909959, 15709.921450392789, 15905.204739763081, 15922.203889805463, 16024.278907449076, 12320.322382268972, 12369.62891113268, 12406.441710123067, 12409.255444673257, 12746.617601471971, 3811.294910441577, 3915.4714113594587, 3919.941200881989, 3927.8625248116464, 3938.547067087264, 78147.6092619539, 78382.21617783807, 78964.0, 79540.60229698873, 83275.0, 11995.340256285814, 12070.275783452846, 12147.210431321935, 12219.800824826469, 12506.0, 23838.16566420167, 23862.880685596807, 23866.403339916294, 23973.28080157598, 23985.52028959446, 8632.741017769476, 8748.825023499494, 8939.106089391009, 8963.551822408985, 9109.225715814098, 4625.190591646516, 4678.157931572349, 4749.525047495223, 4834.830780922651, 5022.42242142151, 3514.947275790865, 3592.389293820057, 3598.9820050900103, 3635.5455568053994, 3784.110733977513, 609.7103875659027, 610.6732897899602, 612.1705089603612, 615.3323643846387, 624.712632189189, 645.1484041065748, 721.9241979592172, 739.5747445218913, 760.2093822424616, 761.9885701714479, 9459.905400945903, 9861.309708320492, 9956.701298961043, 10221.846672299922, 10652.36085834837, 714.6426786606696, 776.4564804636777, 782.8825676148623, 794.6702118620708, 806.9878951815728, 4914.754262286871, 5065.316182315414, 5077.492250774893, 5092.796288148506, 5212.630950307298, 79527.0, 113400.0, 114938.42530787292, 120827.0, 124597.37701311617, 104651.0, 105330.47334763277, 106375.0, 106827.79516614514, 107426.46286768516, 84291.5785421069, 86685.566572168, 88380.55809721039, 89476.0, 89513.99999999869, 9562.808743825224, 9629.807403851744, 9645.27660425485, 9648.565814538222, 9760.170385517311, 48793.0, 49811.50188498069, 50677.23984140167, 51477.7426112867, 52056.73971630269, 71625.64187179031, 79424.60287698524, 79947.20052799398, 81845.59077204576, 83036.58481707553, 12367.814482782946, 12455.626331210078, 12478.875211248134, 12614.49542018309, 13141.868581314448, 14477.638059048608, 14842.257887105818, 15134.697306054037, 15482.458113965957, 16091.356345746039, 13671.0, 14269.928650356682, 14497.92751036238, 14611.342489588207, 14622.92688536593, 13683.247421391521, 14386.784198236826, 14718.852811471748, 15096.094234345974, 15500.591739515126, 13612.0, 13853.515126970507, 14129.646758831112, 14390.0, 14414.639634009234, 11697.0, 11731.303732778142, 11796.29222246668, 12017.0, 12182.817257741319, 11746.941265293619, 12066.698332541757, 12284.1401101922, 12409.93795031019, 12782.296973666538], "value": 7815.761853530431, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 109.0, 110.0, 113.0, 112.0, 114.0, 110.0, 112.0, 109.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 159.0, 186.0, 127.0, 157.0, 158.0, 129.0, 180.0, 135.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 165.0, 165.0, 169.0, 163.0, 162.0, 162.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 159.0, 76.0, 77.0, 76.0, 76.0, 180.0, 74.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 154.0, 84.0, 85.0, 86.0, 144.0, 83.0, 84.0, 139.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 122.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 97.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 57.0, 55.0, 54.0, 56.0, 54.0, 57.0, 52.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 61.0, 60.0, 59.0, 61.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 77.0, 80.0, 81.0, 82.0, 82.0, 82.0, 106.0, 79.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 124.0, 120.0, 122.0, 135.0, 126.0, 124.0, 126.0, 136.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 164.0, 164.0, 160.0, 159.0, 162.0, 167.0, 158.0, 160.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 63.0, 65.0, 67.0, 63.0, 62.0, 65.0, 64.0], "value": 65.0, "unit": "score"}]}]} 08:31:54 INFO - Return code: 0 08:31:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:54 ERROR - # TBPL SUCCESS # 08:31:54 INFO - Running post-action listener: _resource_record_post_action 08:31:54 INFO - ##### 08:31:54 INFO - ##### Finished run-tests step (success) 08:31:54 INFO - ##### 08:31:54 INFO - Running post-run listener: _resource_record_post_run 08:31:54 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 4096; Write bytes: 548536320; Read time: 8; Write time: 617224 08:31:54 INFO - TinderboxPrint: CPU usage
13.6% 08:31:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:31:54 INFO - TinderboxPrint: I/O write bytes / time
548,536,320 / 617,224 08:31:54 INFO - TinderboxPrint: CPU idle
8,214.9 (86.4%) 08:31:54 INFO - TinderboxPrint: CPU user
1,233.1 (13.0%) 08:31:54 INFO - TinderboxPrint: Swap in / out
0 / 0 08:31:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255451136; Read time: 0; Write time: 286840 08:31:54 INFO - run-tests - Wall time: 1176s; CPU: 14.0%; Read bytes: 4096; Write bytes: 292499456; Read time: 8; Write time: 330352 08:31:55 INFO - Running post-run listener: _upload_blobber_files 08:31:55 INFO - Blob upload gear active. 08:31:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:55 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 08:31:55 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'] 08:31:55 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 08:31:55 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:58 INFO - (blobuploader) - INFO - Done attempting. 08:31:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:31:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:31:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:59 INFO - (blobuploader) - INFO - Done attempting. 08:31:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:31:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:32:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:00 INFO - (blobuploader) - INFO - Done attempting. 08:32:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:32:00 INFO - Return code: 0 08:32:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:32:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:32:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f976e3ac89f028be81e96e2449c80c738e0952ab390db200679ffde90dd713d1a2f9bce9863f174acaee66cade8fdd3ea6484831e8a7f59a73d6cd083361f136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b88796841eaf1133d004fcb756d6625d9d1623428f57c6c90e2c532a2a18cbf64e77153d82ec6c554ccd973945c69e0a2721c11f60c74e18ae9dd56657f222a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97fa242c81a5911bac1e2559433ea8ec1284e1079d2581b0c52877ca6ffb524bfd0b5debf7a68164ebc586c7b314394b81e095058610620203fc5323c94bb2c6"} 08:32:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:32:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:32:00 INFO - Contents: 08:32:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f976e3ac89f028be81e96e2449c80c738e0952ab390db200679ffde90dd713d1a2f9bce9863f174acaee66cade8fdd3ea6484831e8a7f59a73d6cd083361f136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b88796841eaf1133d004fcb756d6625d9d1623428f57c6c90e2c532a2a18cbf64e77153d82ec6c554ccd973945c69e0a2721c11f60c74e18ae9dd56657f222a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97fa242c81a5911bac1e2559433ea8ec1284e1079d2581b0c52877ca6ffb524bfd0b5debf7a68164ebc586c7b314394b81e095058610620203fc5323c94bb2c6"} 08:32:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:32:00 INFO - Copying logs to upload dir... 08:32:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:32:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.590682 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-14 08:31:58.745373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 08:31:58.749114) ========= 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-1465915542.324287-1955222013 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/f976e3ac89f028be81e96e2449c80c738e0952ab390db200679ffde90dd713d1a2f9bce9863f174acaee66cade8fdd3ea6484831e8a7f59a73d6cd083361f136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b88796841eaf1133d004fcb756d6625d9d1623428f57c6c90e2c532a2a18cbf64e77153d82ec6c554ccd973945c69e0a2721c11f60c74e18ae9dd56657f222a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97fa242c81a5911bac1e2559433ea8ec1284e1079d2581b0c52877ca6ffb524bfd0b5debf7a68164ebc586c7b314394b81e095058610620203fc5323c94bb2c6"} build_url:https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/SqDFH2XlQLOpBaq642OTZQ/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/f976e3ac89f028be81e96e2449c80c738e0952ab390db200679ffde90dd713d1a2f9bce9863f174acaee66cade8fdd3ea6484831e8a7f59a73d6cd083361f136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b88796841eaf1133d004fcb756d6625d9d1623428f57c6c90e2c532a2a18cbf64e77153d82ec6c554ccd973945c69e0a2721c11f60c74e18ae9dd56657f222a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97fa242c81a5911bac1e2559433ea8ec1284e1079d2581b0c52877ca6ffb524bfd0b5debf7a68164ebc586c7b314394b81e095058610620203fc5323c94bb2c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 08:31:58.774683) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:31:58.774999) ========= 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-1465915542.324287-1955222013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 08:31:58.858108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 08:31:58.858420) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 08:31:58.858735) ========= ========= Total master_lag: 0.39 =========