builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1466963584.69 results: success (0) buildid: 20160626093024 builduid: d7e565c0df984caf824009a3bae7eaa2 revision: d490ad95a673b042d48e01331b9ae70683457da9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:04.687139) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:04.687573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:04.687855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:04.760978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:04.761270) ========= 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=41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-26 10:53:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-06-26 10:53:05 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.243882 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:05.053236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:05.056178) ========= 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=41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.093895 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:05.162331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-26 10:53:05.162685) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d490ad95a673b042d48e01331b9ae70683457da9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d490ad95a673b042d48e01331b9ae70683457da9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-26 10:53:05,478 truncating revision to first 12 chars 2016-06-26 10:53:05,478 Setting DEBUG logging. 2016-06-26 10:53:05,478 attempt 1/10 2016-06-26 10:53:05,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d490ad95a673?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-26 10:53:05,744 unpacking tar archive at: fx-team-d490ad95a673/testing/mozharness/ program finished with exit code 0 elapsedTime=0.597258 ========= master_lag: 0.54 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-26 10:53:06.301637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:06.301938) ========= script_repo_revision: d490ad95a673b042d48e01331b9ae70683457da9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:06.302383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:06.302699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 10:53:06.333719) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-26 10:53:06.334013) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:53:06 INFO - MultiFileLogger online at 20160626 10:53:06 in /builds/slave/test 10:53:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:53:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:53:06 INFO - {'append_to_log': False, 10:53:06 INFO - 'base_work_dir': '/builds/slave/test', 10:53:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:53:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:53:06 INFO - 'branch': 'Fx-Team-Non-PGO', 10:53:06 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:06 INFO - 'config_files': ('talos/linux_config.py',), 10:53:06 INFO - 'default_actions': ('clobber', 10:53:06 INFO - 'read-buildbot-config', 10:53:06 INFO - 'download-and-extract', 10:53:06 INFO - 'populate-webroot', 10:53:06 INFO - 'create-virtualenv', 10:53:06 INFO - 'install', 10:53:06 INFO - 'run-tests'), 10:53:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:06 INFO - 'download_minidump_stackwalk': True, 10:53:06 INFO - 'download_symbols': 'ondemand', 10:53:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:06 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:06 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:06 INFO - 'installer_path': 'installer.exe', 10:53:06 INFO - 'log_level': 'info', 10:53:06 INFO - 'log_name': 'talos', 10:53:06 INFO - 'log_to_console': True, 10:53:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:53:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:53:06 INFO - 'opt_config_files': (), 10:53:06 INFO - 'pip_index': False, 10:53:06 INFO - 'sps_profile': False, 10:53:06 INFO - 'sps_profile_interval': 0, 10:53:06 INFO - 'suite': 'dromaeojs-e10s', 10:53:06 INFO - 'system_bits': '32', 10:53:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:06 INFO - 'title': 'talos-linux64-ix-026', 10:53:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:06 INFO - 'use_talos_json': True, 10:53:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:53:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:06 INFO - 'work_dir': 'build'} 10:53:06 INFO - ##### 10:53:06 INFO - ##### Running clobber step. 10:53:06 INFO - ##### 10:53:06 INFO - Running pre-action listener: _resource_record_pre_action 10:53:06 INFO - Running main action method: clobber 10:53:06 INFO - rmtree: /builds/slave/test/build 10:53:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:53:11 INFO - Running post-action listener: _resource_record_post_action 10:53:11 INFO - ##### 10:53:11 INFO - ##### Finished clobber step (success) 10:53:11 INFO - ##### 10:53:11 INFO - ##### 10:53:11 INFO - ##### Running read-buildbot-config step. 10:53:11 INFO - ##### 10:53:11 INFO - Running pre-action listener: _resource_record_pre_action 10:53:11 INFO - Running main action method: read_buildbot_config 10:53:11 INFO - Using buildbot properties: 10:53:11 INFO - { 10:53:11 INFO - "project": "", 10:53:11 INFO - "product": "firefox", 10:53:11 INFO - "script_repo_revision": "production", 10:53:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:53:11 INFO - "repository": "", 10:53:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:53:11 INFO - "buildid": "20160626093024", 10:53:11 INFO - "pgo_build": "False", 10:53:11 INFO - "basedir": "/builds/slave/test", 10:53:11 INFO - "buildnumber": 1433, 10:53:11 INFO - "slavename": "talos-linux64-ix-026", 10:53:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:53:11 INFO - "platform": "ubuntu64_hw", 10:53:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:53:11 INFO - "branch": "fx-team", 10:53:11 INFO - "repo_path": "integration/fx-team", 10:53:11 INFO - "revision": "d490ad95a673b042d48e01331b9ae70683457da9", 10:53:11 INFO - "stage_platform": "linux64", 10:53:11 INFO - "builduid": "d7e565c0df984caf824009a3bae7eaa2", 10:53:11 INFO - "slavebuilddir": "test" 10:53:11 INFO - } 10:53:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:53:11 INFO - Running post-action listener: _resource_record_post_action 10:53:11 INFO - ##### 10:53:11 INFO - ##### Finished read-buildbot-config step (success) 10:53:11 INFO - ##### 10:53:11 INFO - ##### 10:53:11 INFO - ##### Running download-and-extract step. 10:53:11 INFO - ##### 10:53:11 INFO - Running pre-action listener: _resource_record_pre_action 10:53:11 INFO - Running main action method: download_and_extract 10:53:11 INFO - mkdir: /builds/slave/test/build/tests 10:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:11 INFO - https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:12 INFO - Downloaded 1361 bytes. 10:53:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:53:12 INFO - Using the following test package requirements: 10:53:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:53:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:53:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:12 INFO - u'jsshell-linux-x86_64.zip'], 10:53:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:53:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:53:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:53:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:53:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:53:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:12 INFO - https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:53:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:53:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:53:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:14 INFO - Downloaded 22712973 bytes. 10:53:14 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'] 10:53:14 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 10:53:16 INFO - Return code: 0 10:53:16 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 10:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:16 INFO - https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:53:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:53:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:53:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:19 INFO - Downloaded 22712973 bytes. 10:53:19 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'] 10:53:19 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 10:53:20 INFO - Return code: 0 10:53: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')]} 10:53:20 INFO - https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:53:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:21 INFO - Downloaded 14405240 bytes. 10:53:21 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'] 10:53:21 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 10:53:22 INFO - Return code: 0 10:53: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')]} 10:53:22 INFO - https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U3iffMuOTQyA5F_bSuXyKg/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 10:53:23 INFO - Downloaded 56267008 bytes. 10:53:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:53:23 INFO - mkdir: /builds/slave/test/properties 10:53:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:23 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:23 INFO - Contents: 10:53:23 INFO - build_url:https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:53:24 INFO - Running post-action listener: _resource_record_post_action 10:53:24 INFO - Running post-action listener: set_extra_try_arguments 10:53:24 INFO - ##### 10:53:24 INFO - ##### Finished download-and-extract step (success) 10:53:24 INFO - ##### 10:53:24 INFO - ##### 10:53:24 INFO - ##### Running populate-webroot step. 10:53:24 INFO - ##### 10:53:24 INFO - Running pre-action listener: _resource_record_pre_action 10:53:24 INFO - Running main action method: populate_webroot 10:53:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:24 INFO - '--tppagecycles', 10:53:24 INFO - '7'], 10:53:24 INFO - 'tests': ['tsvgm']}}, 10:53:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:53:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:53:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:53:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:24 INFO - 'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:24 INFO - 'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['damp', 'tps']}, 10:53:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:24 INFO - 'tests': ['damp', 'tps']}, 10:53:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['dromaeo_dom']}, 10:53:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['basic_compositor_video']}, 10:53:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:53:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['a11yr', 10:53:24 INFO - 'ts_paint', 10:53:24 INFO - 'tpaint', 10:53:24 INFO - 'sessionrestore', 10:53:24 INFO - 'sessionrestore_no_auto_restore', 10:53:24 INFO - 'tabpaint']}, 10:53:24 INFO - 'other-e10s': {'tests': ['a11yr', 10:53:24 INFO - 'ts_paint', 10:53:24 INFO - 'tpaint', 10:53:24 INFO - 'sessionrestore', 10:53:24 INFO - 'sessionrestore_no_auto_restore', 10:53:24 INFO - 'tabpaint']}, 10:53:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:53:24 INFO - 'ts_paint', 10:53:24 INFO - 'tpaint', 10:53:24 INFO - 'sessionrestore', 10:53:24 INFO - 'sessionrestore_no_auto_restore', 10:53:24 INFO - 'tabpaint']}, 10:53:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:53:24 INFO - 'ts_paint', 10:53:24 INFO - 'tpaint', 10:53:24 INFO - 'sessionrestore', 10:53:24 INFO - 'sessionrestore_no_auto_restore', 10:53:24 INFO - 'tabpaint']}, 10:53:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['a11yr', 10:53:24 INFO - 'ts_paint', 10:53:24 INFO - 'tpaint', 10:53:24 INFO - 'sessionrestore', 10:53:24 INFO - 'sessionrestore_no_auto_restore', 10:53:24 INFO - 'tabpaint']}, 10:53:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['a11yr', 10:53:24 INFO - 'ts_paint', 10:53:24 INFO - 'tpaint', 10:53:24 INFO - 'sessionrestore', 10:53:24 INFO - 'sessionrestore_no_auto_restore', 10:53:24 INFO - 'tabpaint']}, 10:53:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['tsvgx', 10:53:24 INFO - 'tsvgr_opacity', 10:53:24 INFO - 'tart', 10:53:24 INFO - 'tscrollx', 10:53:24 INFO - 'cart']}, 10:53:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:53:24 INFO - 'tsvgr_opacity', 10:53:24 INFO - 'tart', 10:53:24 INFO - 'tscrollx', 10:53:24 INFO - 'cart']}, 10:53:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:24 INFO - 'talos_options': ['--disable-e10s'], 10:53:24 INFO - 'tests': ['tp5o']}, 10:53:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:24 INFO - 'tests': ['tp5o']}, 10:53:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:24 INFO - 'talos_options': ['--disable-e10s', 10:53:24 INFO - '--xperf_path', 10:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:24 INFO - 'tests': ['tp5n']}, 10:53:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:24 INFO - 'talos_options': ['--xperf_path', 10:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:24 INFO - 'tests': ['tp5n']}}, 10:53:24 INFO - 'talos.zip': {'path': '', 10:53:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:24 INFO - Running post-action listener: _resource_record_post_action 10:53:24 INFO - ##### 10:53:24 INFO - ##### Finished populate-webroot step (success) 10:53:24 INFO - ##### 10:53:24 INFO - ##### 10:53:24 INFO - ##### Running create-virtualenv step. 10:53:24 INFO - ##### 10:53:24 INFO - Running pre-action listener: _resource_record_pre_action 10:53:24 INFO - Running main action method: create_virtualenv 10:53:24 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:24 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 10:53:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:24 INFO - Using real prefix '/usr' 10:53:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:24 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:27 INFO - Installing pip.................done. 10:53:27 INFO - Return code: 0 10:53:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:53:27 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')]} 10:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:27 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')]} 10:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:27 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 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53:27 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 10:53:27 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 10:53:27 INFO - Using env: {'DISPLAY': ':0', 10:53:27 INFO - 'HOME': '/home/cltbld', 10:53:27 INFO - 'LANG': 'en_US.UTF-8', 10:53:27 INFO - 'LANGUAGE': 'en_US:en', 10:53:27 INFO - 'LOGNAME': 'cltbld', 10:53:27 INFO - 'MAIL': '/var/mail/cltbld', 10:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:27 INFO - 'MOZ_NO_REMOTE': '1', 10:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:27 INFO - 'NO_EM_RESTART': '1', 10:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:27 INFO - 'PWD': '/builds/slave/test', 10:53:27 INFO - 'SHELL': '/bin/bash', 10:53:27 INFO - 'SHLVL': '1', 10:53:27 INFO - 'TERM': 'linux', 10:53:27 INFO - 'TMOUT': '86400', 10:53:27 INFO - 'USER': 'cltbld', 10:53:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:27 INFO - '_': '/tools/buildbot/bin/python'} 10:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:27 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 10:53:27 INFO - Cleaning up... 10:53:27 INFO - Return code: 0 10:53:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:53:27 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')]} 10:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:27 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')]} 10:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:27 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 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53:27 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 10:53:27 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 10:53:27 INFO - Using env: {'DISPLAY': ':0', 10:53:27 INFO - 'HOME': '/home/cltbld', 10:53:27 INFO - 'LANG': 'en_US.UTF-8', 10:53:27 INFO - 'LANGUAGE': 'en_US:en', 10:53:27 INFO - 'LOGNAME': 'cltbld', 10:53:27 INFO - 'MAIL': '/var/mail/cltbld', 10:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:27 INFO - 'MOZ_NO_REMOTE': '1', 10:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:27 INFO - 'NO_EM_RESTART': '1', 10:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:27 INFO - 'PWD': '/builds/slave/test', 10:53:27 INFO - 'SHELL': '/bin/bash', 10:53:27 INFO - 'SHLVL': '1', 10:53:27 INFO - 'TERM': 'linux', 10:53:27 INFO - 'TMOUT': '86400', 10:53:27 INFO - 'USER': 'cltbld', 10:53:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:27 INFO - '_': '/tools/buildbot/bin/python'} 10:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:27 INFO - Downloading/unpacking psutil>=3.1.1 10:53:27 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 10:53:27 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 10:53:27 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 10:53:27 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 10:53:27 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 10:53:27 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 10:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:29 INFO - Installing collected packages: psutil 10:53:29 INFO - Running setup.py install for psutil 10:53:30 INFO - building 'psutil._psutil_linux' extension 10:53:30 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 10:53:31 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 10:53:31 INFO - building 'psutil._psutil_posix' extension 10:53:31 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 10:53:31 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 10:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:31 INFO - Successfully installed psutil 10:53:31 INFO - Cleaning up... 10:53:31 INFO - Return code: 0 10:53:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:53:31 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')]} 10:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:31 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')]} 10:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:31 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 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53:31 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 10:53:31 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 10:53:31 INFO - Using env: {'DISPLAY': ':0', 10:53:31 INFO - 'HOME': '/home/cltbld', 10:53:31 INFO - 'LANG': 'en_US.UTF-8', 10:53:31 INFO - 'LANGUAGE': 'en_US:en', 10:53:31 INFO - 'LOGNAME': 'cltbld', 10:53:31 INFO - 'MAIL': '/var/mail/cltbld', 10:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:31 INFO - 'MOZ_NO_REMOTE': '1', 10:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:31 INFO - 'NO_EM_RESTART': '1', 10:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:31 INFO - 'PWD': '/builds/slave/test', 10:53:31 INFO - 'SHELL': '/bin/bash', 10:53:31 INFO - 'SHLVL': '1', 10:53:31 INFO - 'TERM': 'linux', 10:53:31 INFO - 'TMOUT': '86400', 10:53:31 INFO - 'USER': 'cltbld', 10:53:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:31 INFO - '_': '/tools/buildbot/bin/python'} 10:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:53:33 INFO - Installing collected packages: mozsystemmonitor 10:53:33 INFO - Running setup.py install for mozsystemmonitor 10:53:33 INFO - Successfully installed mozsystemmonitor 10:53:33 INFO - Cleaning up... 10:53:34 INFO - Return code: 0 10:53:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:34 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 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53:34 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 10:53:34 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 10:53:34 INFO - Using env: {'DISPLAY': ':0', 10:53:34 INFO - 'HOME': '/home/cltbld', 10:53:34 INFO - 'LANG': 'en_US.UTF-8', 10:53:34 INFO - 'LANGUAGE': 'en_US:en', 10:53:34 INFO - 'LOGNAME': 'cltbld', 10:53:34 INFO - 'MAIL': '/var/mail/cltbld', 10:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:34 INFO - 'MOZ_NO_REMOTE': '1', 10:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:34 INFO - 'NO_EM_RESTART': '1', 10:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:34 INFO - 'PWD': '/builds/slave/test', 10:53:34 INFO - 'SHELL': '/bin/bash', 10:53:34 INFO - 'SHLVL': '1', 10:53:34 INFO - 'TERM': 'linux', 10:53:34 INFO - 'TMOUT': '86400', 10:53:34 INFO - 'USER': 'cltbld', 10:53:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:34 INFO - '_': '/tools/buildbot/bin/python'} 10:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:34 INFO - Downloading/unpacking jsonschema==2.5.1 10:53:34 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 10:53:34 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 10:53:34 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 10:53:34 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 10:53:34 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 10:53:34 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 10:53:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:53:36 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 10:53:36 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 10:53:36 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 10:53:36 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 10:53:36 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 10:53:36 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 10:53:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:36 INFO - warning: no files found matching '*.txt' 10:53:36 INFO - no previously-included directories found matching 'build' 10:53:36 INFO - no previously-included directories found matching 'dist' 10:53:36 INFO - no previously-included directories found matching '.git*' 10:53:36 INFO - Installing collected packages: jsonschema, functools32 10:53:36 INFO - Running setup.py install for functools32 10:53:36 INFO - warning: no files found matching '*.txt' 10:53:36 INFO - no previously-included directories found matching 'build' 10:53:36 INFO - no previously-included directories found matching 'dist' 10:53:36 INFO - no previously-included directories found matching '.git*' 10:53:36 INFO - Successfully installed jsonschema functools32 10:53:36 INFO - Cleaning up... 10:53:36 INFO - Return code: 0 10:53:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:53:36 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')]} 10:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:36 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')]} 10:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:36 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 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53:36 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 10:53:36 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 10:53:36 INFO - Using env: {'DISPLAY': ':0', 10:53:36 INFO - 'HOME': '/home/cltbld', 10:53:36 INFO - 'LANG': 'en_US.UTF-8', 10:53:36 INFO - 'LANGUAGE': 'en_US:en', 10:53:36 INFO - 'LOGNAME': 'cltbld', 10:53:36 INFO - 'MAIL': '/var/mail/cltbld', 10:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:36 INFO - 'MOZ_NO_REMOTE': '1', 10:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:36 INFO - 'NO_EM_RESTART': '1', 10:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:36 INFO - 'PWD': '/builds/slave/test', 10:53:36 INFO - 'SHELL': '/bin/bash', 10:53:36 INFO - 'SHLVL': '1', 10:53:36 INFO - 'TERM': 'linux', 10:53:36 INFO - 'TMOUT': '86400', 10:53:36 INFO - 'USER': 'cltbld', 10:53:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:36 INFO - '_': '/tools/buildbot/bin/python'} 10:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:36 INFO - Downloading/unpacking blobuploader==1.2.4 10:53:36 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 10:53:36 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 10:53:36 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 10:53:36 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 10:53:36 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 10:53:36 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 10:53:38 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53:38 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 10:53:38 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 10:53:38 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 10:53:38 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 10:53:38 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 10:53:38 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 10:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:53:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:39 INFO - Downloading docopt-0.6.1.tar.gz 10:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:39 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:39 INFO - Running setup.py install for blobuploader 10:53:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:53:39 INFO - Running setup.py install for requests 10:53:39 INFO - Running setup.py install for docopt 10:53:40 INFO - Successfully installed blobuploader requests docopt 10:53:40 INFO - Cleaning up... 10:53:40 INFO - Return code: 0 10:53:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:40 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')]} 10:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:40 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')]} 10:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:40 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 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53:40 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 10:53:40 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 10:53:40 INFO - Using env: {'DISPLAY': ':0', 10:53:40 INFO - 'HOME': '/home/cltbld', 10:53:40 INFO - 'LANG': 'en_US.UTF-8', 10:53:40 INFO - 'LANGUAGE': 'en_US:en', 10:53:40 INFO - 'LOGNAME': 'cltbld', 10:53:40 INFO - 'MAIL': '/var/mail/cltbld', 10:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:40 INFO - 'MOZ_NO_REMOTE': '1', 10:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:40 INFO - 'NO_EM_RESTART': '1', 10:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:40 INFO - 'PWD': '/builds/slave/test', 10:53:40 INFO - 'SHELL': '/bin/bash', 10:53:40 INFO - 'SHLVL': '1', 10:53:40 INFO - 'TERM': 'linux', 10:53:40 INFO - 'TMOUT': '86400', 10:53:40 INFO - 'USER': 'cltbld', 10:53:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:40 INFO - '_': '/tools/buildbot/bin/python'} 10:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:40 INFO - Running setup.py (path:/tmp/pip-8JeHtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:40 INFO - Running setup.py (path:/tmp/pip-M6Nsjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:40 INFO - Running setup.py (path:/tmp/pip-rOax2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:40 INFO - Running setup.py (path:/tmp/pip-RU6UX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:40 INFO - Running setup.py (path:/tmp/pip-m2aa6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:40 INFO - Running setup.py (path:/tmp/pip-3FaLqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:40 INFO - Running setup.py (path:/tmp/pip-_67vZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:40 INFO - Running setup.py (path:/tmp/pip-nkS4KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:40 INFO - Running setup.py (path:/tmp/pip-yxBuLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:40 INFO - Running setup.py (path:/tmp/pip-2n05aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:41 INFO - Running setup.py (path:/tmp/pip-XmrmuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:41 INFO - Running setup.py (path:/tmp/pip-t6Kk9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:41 INFO - Running setup.py (path:/tmp/pip-GLofP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:41 INFO - Running setup.py (path:/tmp/pip-ssHerx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:41 INFO - Running setup.py (path:/tmp/pip-cXoKdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:41 INFO - Running setup.py (path:/tmp/pip-GdftDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:41 INFO - Running setup.py (path:/tmp/pip-zXqiI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:41 INFO - Running setup.py install for manifestparser 10:53:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:53:41 INFO - Running setup.py install for mozcrash 10:53:41 INFO - Running setup.py install for mozdebug 10:53:41 INFO - Running setup.py install for mozdevice 10:53:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:53:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:53:41 INFO - Running setup.py install for mozfile 10:53:42 INFO - Running setup.py install for mozhttpd 10:53:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Running setup.py install for mozinfo 10:53:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Running setup.py install for mozInstall 10:53:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Running setup.py install for mozleak 10:53:42 INFO - Running setup.py install for mozlog 10:53:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Running setup.py install for moznetwork 10:53:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Running setup.py install for mozprocess 10:53:42 INFO - Running setup.py install for mozprofile 10:53:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:53:42 INFO - Running setup.py install for mozrunner 10:53:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:53:43 INFO - Running setup.py install for mozscreenshot 10:53:43 INFO - Running setup.py install for moztest 10:53:43 INFO - Running setup.py install for mozversion 10:53:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:53:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:43 INFO - Cleaning up... 10:53:43 INFO - Return code: 0 10:53:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:43 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 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53:43 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 10:53:43 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 10:53:43 INFO - Using env: {'DISPLAY': ':0', 10:53:43 INFO - 'HOME': '/home/cltbld', 10:53:43 INFO - 'LANG': 'en_US.UTF-8', 10:53:43 INFO - 'LANGUAGE': 'en_US:en', 10:53:43 INFO - 'LOGNAME': 'cltbld', 10:53:43 INFO - 'MAIL': '/var/mail/cltbld', 10:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:43 INFO - 'MOZ_NO_REMOTE': '1', 10:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:43 INFO - 'NO_EM_RESTART': '1', 10:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:43 INFO - 'PWD': '/builds/slave/test', 10:53:43 INFO - 'SHELL': '/bin/bash', 10:53:43 INFO - 'SHLVL': '1', 10:53:43 INFO - 'TERM': 'linux', 10:53:43 INFO - 'TMOUT': '86400', 10:53:43 INFO - 'USER': 'cltbld', 10:53:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:43 INFO - '_': '/tools/buildbot/bin/python'} 10:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:43 INFO - Running setup.py (path:/tmp/pip-HLTzWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:43 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)) 10:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:43 INFO - Running setup.py (path:/tmp/pip-f2Ahxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:43 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)) 10:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:43 INFO - Running setup.py (path:/tmp/pip-uq1xJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:43 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)) 10:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:43 INFO - Running setup.py (path:/tmp/pip-zsPxXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:43 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)) 10:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:43 INFO - Running setup.py (path:/tmp/pip-bFYDVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:43 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)) 10:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:43 INFO - Running setup.py (path:/tmp/pip-6UaTxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:43 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)) 10:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:44 INFO - Running setup.py (path:/tmp/pip-LeyZqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:44 INFO - Running setup.py (path:/tmp/pip-lPkgoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:44 INFO - Running setup.py (path:/tmp/pip-umpijl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:44 INFO - Running setup.py (path:/tmp/pip-rJepXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:44 INFO - Running setup.py (path:/tmp/pip-Ji_D8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:44 INFO - Running setup.py (path:/tmp/pip-bsLMg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:44 INFO - Running setup.py (path:/tmp/pip-YahIQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:44 INFO - Running setup.py (path:/tmp/pip-RhgLGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:44 INFO - Running setup.py (path:/tmp/pip-zxvjsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:44 INFO - Running setup.py (path:/tmp/pip-I8EPVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:44 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)) 10:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:44 INFO - Running setup.py (path:/tmp/pip-UtLv3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:44 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)) 10:53:44 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)) 10:53:44 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)) 10:53:44 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)) 10:53:44 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)) 10:53:44 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)) 10:53:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:44 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 10:53:44 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 10:53:44 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 10:53:44 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 10:53:44 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 10:53:44 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 10:53:46 INFO - Downloading blessings-1.6.tar.gz 10:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:46 INFO - Installing collected packages: blessings 10:53:46 INFO - Running setup.py install for blessings 10:53:46 INFO - Successfully installed blessings 10:53:46 INFO - Cleaning up... 10:53:46 INFO - Return code: 0 10:53:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:47 INFO - Reading from file tmpfile_stdout 10:53:47 INFO - Current package versions: 10:53:47 INFO - argparse == 1.2.1 10:53:47 INFO - blessings == 1.6 10:53:47 INFO - blobuploader == 1.2.4 10:53:47 INFO - docopt == 0.6.1 10:53:47 INFO - functools32 == 3.2.3-2 10:53:47 INFO - jsonschema == 2.5.1 10:53:47 INFO - manifestparser == 1.1 10:53:47 INFO - mozInstall == 1.12 10:53:47 INFO - mozcrash == 0.17 10:53:47 INFO - mozdebug == 0.1 10:53:47 INFO - mozdevice == 0.48 10:53:47 INFO - mozfile == 1.2 10:53:47 INFO - mozhttpd == 0.7 10:53:47 INFO - mozinfo == 0.9 10:53:47 INFO - mozleak == 0.1 10:53:47 INFO - mozlog == 3.2 10:53:47 INFO - moznetwork == 0.27 10:53:47 INFO - mozprocess == 0.22 10:53:47 INFO - mozprofile == 0.28 10:53:47 INFO - mozrunner == 6.11 10:53:47 INFO - mozscreenshot == 0.1 10:53:47 INFO - mozsystemmonitor == 0.3 10:53:47 INFO - moztest == 0.7 10:53:47 INFO - mozversion == 1.4 10:53:47 INFO - psutil == 3.1.1 10:53:47 INFO - requests == 1.2.3 10:53:47 INFO - wsgiref == 0.1.2 10:53:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:47 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 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53:47 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 10:53:47 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 10:53:47 INFO - Using env: {'DISPLAY': ':0', 10:53:47 INFO - 'HOME': '/home/cltbld', 10:53:47 INFO - 'LANG': 'en_US.UTF-8', 10:53:47 INFO - 'LANGUAGE': 'en_US:en', 10:53:47 INFO - 'LOGNAME': 'cltbld', 10:53:47 INFO - 'MAIL': '/var/mail/cltbld', 10:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:47 INFO - 'MOZ_NO_REMOTE': '1', 10:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:47 INFO - 'NO_EM_RESTART': '1', 10:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:47 INFO - 'PWD': '/builds/slave/test', 10:53:47 INFO - 'SHELL': '/bin/bash', 10:53:47 INFO - 'SHLVL': '1', 10:53:47 INFO - 'TERM': 'linux', 10:53:47 INFO - 'TMOUT': '86400', 10:53:47 INFO - 'USER': 'cltbld', 10:53:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:47 INFO - '_': '/tools/buildbot/bin/python'} 10:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:47 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)) 10:53:47 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)) 10:53:47 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)) 10:53:47 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)) 10:53:47 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)) 10:53:47 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)) 10:53:47 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)) 10:53:47 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)) 10:53:47 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)) 10:53:47 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)) 10:53:47 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)) 10:53:47 INFO - Cleaning up... 10:53:47 INFO - Return code: 0 10:53:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53: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', 'jsonschema'] in /builds/slave/test/build 10:53: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 jsonschema 10:53:47 INFO - Using env: {'DISPLAY': ':0', 10:53:47 INFO - 'HOME': '/home/cltbld', 10:53:47 INFO - 'LANG': 'en_US.UTF-8', 10:53:47 INFO - 'LANGUAGE': 'en_US:en', 10:53:47 INFO - 'LOGNAME': 'cltbld', 10:53:47 INFO - 'MAIL': '/var/mail/cltbld', 10:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:47 INFO - 'MOZ_NO_REMOTE': '1', 10:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:47 INFO - 'NO_EM_RESTART': '1', 10:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:47 INFO - 'PWD': '/builds/slave/test', 10:53:47 INFO - 'SHELL': '/bin/bash', 10:53:47 INFO - 'SHLVL': '1', 10:53:47 INFO - 'TERM': 'linux', 10:53:47 INFO - 'TMOUT': '86400', 10:53:47 INFO - 'USER': 'cltbld', 10:53:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:47 INFO - '_': '/tools/buildbot/bin/python'} 10:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:53:47 INFO - Cleaning up... 10:53:47 INFO - Return code: 0 10:53:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0f675f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, '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': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', '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 10:53: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', 'flake8'] in /builds/slave/test/build 10:53: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 flake8 10:53:47 INFO - Using env: {'DISPLAY': ':0', 10:53:47 INFO - 'HOME': '/home/cltbld', 10:53:47 INFO - 'LANG': 'en_US.UTF-8', 10:53:47 INFO - 'LANGUAGE': 'en_US:en', 10:53:47 INFO - 'LOGNAME': 'cltbld', 10:53:47 INFO - 'MAIL': '/var/mail/cltbld', 10:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:47 INFO - 'MOZ_NO_REMOTE': '1', 10:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:47 INFO - 'NO_EM_RESTART': '1', 10:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:47 INFO - 'PWD': '/builds/slave/test', 10:53:47 INFO - 'SHELL': '/bin/bash', 10:53:47 INFO - 'SHLVL': '1', 10:53:47 INFO - 'TERM': 'linux', 10:53:47 INFO - 'TMOUT': '86400', 10:53:47 INFO - 'USER': 'cltbld', 10:53:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:47 INFO - '_': '/tools/buildbot/bin/python'} 10:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:47 INFO - Downloading/unpacking flake8 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:53:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:53:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:50 INFO - no previously-included directories found matching 'docs/_build' 10:53:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:53:50 INFO - Running setup.py install for pep8 10:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:50 INFO - no previously-included directories found matching 'docs/_build' 10:53:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:53:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:53:50 INFO - Cleaning up... 10:53:50 INFO - Return code: 0 10:53:50 INFO - Running post-action listener: _resource_record_post_action 10:53:50 INFO - Running post-action listener: _start_resource_monitoring 10:53:50 INFO - Starting resource monitoring. 10:53:50 INFO - ##### 10:53:50 INFO - ##### Finished create-virtualenv step (success) 10:53:50 INFO - ##### 10:53:50 INFO - ##### 10:53:50 INFO - ##### Running install step. 10:53:50 INFO - ##### 10:53:50 INFO - Running pre-action listener: _resource_record_pre_action 10:53:50 INFO - Running main action method: install 10:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:50 INFO - Reading from file tmpfile_stdout 10:53:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:53:50 INFO - Reading from file tmpfile_stdout 10:53:50 INFO - Output received: 10:53:50 INFO - Usage: mozinstall [options] installer 10:53:50 INFO - Options: 10:53:50 INFO - -h, --help show this help message and exit 10:53:50 INFO - -d DEST, --destination=DEST 10:53:50 INFO - Directory to install application into. [default: 10:53:50 INFO - "/builds/slave/test"] 10:53:50 INFO - --app=APP Application being installed. [default: firefox] 10:53:50 INFO - mkdir: /builds/slave/test/build/application 10:53:50 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'] 10:53:50 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 10:54:07 INFO - Reading from file tmpfile_stdout 10:54:07 INFO - Output received: 10:54:07 INFO - /builds/slave/test/build/application/firefox/firefox 10:54:07 INFO - Running post-action listener: _resource_record_post_action 10:54:07 INFO - ##### 10:54:07 INFO - ##### Finished install step (success) 10:54:07 INFO - ##### 10:54:07 INFO - ##### 10:54:07 INFO - ##### Running run-tests step. 10:54:07 INFO - ##### 10:54:07 INFO - Running pre-action listener: _resource_record_pre_action 10:54:07 INFO - Running main action method: run_tests 10:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:54:07 INFO - Python 2.7.3 10:54:07 INFO - Return code: 0 10:54:07 INFO - grabbing minidump binary from tooltool 10:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:07 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 0x1c3a6f0>, '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 0x1c3b5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3baa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:54:07 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 10:54:07 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 10:54:07 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 10:54:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:07 INFO - Return code: 0 10:54:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:54:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:54:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:54:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:54:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:54:08 INFO - Return code: 0 10:54:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 10:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 10:54:08 INFO - Using env: {'DISPLAY': ':0', 10:54:08 INFO - 'HOME': '/home/cltbld', 10:54:08 INFO - 'LANG': 'en_US.UTF-8', 10:54:08 INFO - 'LANGUAGE': 'en_US:en', 10:54:08 INFO - 'LOGNAME': 'cltbld', 10:54:08 INFO - 'MAIL': '/var/mail/cltbld', 10:54:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:54:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:08 INFO - 'MOZ_NO_REMOTE': '1', 10:54:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:08 INFO - 'NO_EM_RESTART': '1', 10:54:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:08 INFO - 'PWD': '/builds/slave/test', 10:54:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:54:08 INFO - 'SHELL': '/bin/bash', 10:54:08 INFO - 'SHLVL': '1', 10:54:08 INFO - 'TERM': 'linux', 10:54:08 INFO - 'TMOUT': '86400', 10:54:08 INFO - 'USER': 'cltbld', 10:54:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602', 10:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:08 INFO - '_': '/tools/buildbot/bin/python'} 10:54:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 10:54:08 INFO - mozversion application_buildid: 20160626093024 10:54:08 INFO - mozversion application_changeset: d490ad95a673b042d48e01331b9ae70683457da9 10:54:08 INFO - mozversion application_display_name: Nightly 10:54:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:08 INFO - mozversion application_name: Firefox 10:54:08 INFO - mozversion application_remotingname: firefox 10:54:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:54:08 INFO - mozversion application_vendor: Mozilla 10:54:08 INFO - mozversion application_version: 50.0a1 10:54:08 INFO - mozversion platform_buildid: 20160626093024 10:54:08 INFO - mozversion platform_changeset: d490ad95a673b042d48e01331b9ae70683457da9 10:54:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:54:08 INFO - mozversion platform_version: 50.0a1 10:54:08 INFO - using testdate: 1466963648 10:54:08 INFO - actual date: 1466963648 10:54:08 INFO - starting webserver on 'localhost:41001' 10:54:08 INFO - SUITE-START | Running 2 tests 10:54:08 INFO - TEST-START | dromaeo_css 10:54:08 INFO - operating with platform_type : linux_ 10:54:08 INFO - Initialising browser for dromaeo_css test... 10:54:08 INFO - TEST-INFO | started process 5626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqNSJEq/profile http://localhost:41001/getInfo.html) 10:54:15 INFO - PROCESS | 5626 | __metrics Screen width/height:1600/1200 10:54:15 INFO - PROCESS | 5626 | colorDepth:24 10:54:15 INFO - PROCESS | 5626 | Browser inner width/height: 1024/697 10:54:15 INFO - PROCESS | 5626 | __metrics 10:54:15 ERROR - PROCESS | 5626 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:54:16 INFO - TEST-INFO | 5626: exit 0 10:54:16 INFO - Browser initialized. 10:54:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:16 INFO - TEST-INFO | started process 5747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqNSJEq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:28 INFO - PROCESS | 5747 | RSS: Main: 185991168 10:54:28 INFO - PROCESS | 5747 | 10:55:18 INFO - PROCESS | 5747 | 1466963718475 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] 10:57:31 INFO - PROCESS | 5747 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41001/tests/dromaeo/cssquery-ext.html) 10:57:32 INFO - PROCESS | 5747 | RSS: Main: 188776448 10:57:32 INFO - PROCESS | 5747 | 11:00:34 INFO - PROCESS | 5747 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-ext.html (next: http://localhost:41001/tests/dromaeo/cssquery-jquery.html) 11:00:34 INFO - PROCESS | 5747 | RSS: Main: 187826176 11:00:34 INFO - PROCESS | 5747 | 11:03:36 INFO - PROCESS | 5747 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41001/tests/dromaeo/cssquery-mootools.html) 11:03:37 INFO - PROCESS | 5747 | RSS: Main: 188866560 11:03:37 INFO - PROCESS | 5747 | 11:06:39 INFO - PROCESS | 5747 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41001/tests/dromaeo/cssquery-prototype.html) 11:06:39 INFO - PROCESS | 5747 | RSS: Main: 186806272 11:06:39 INFO - PROCESS | 5747 | 11:09:42 INFO - PROCESS | 5747 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41001/tests/dromaeo/cssquery-yui.html) 11:09:43 INFO - PROCESS | 5747 | RSS: Main: 189075456 11:09:43 INFO - PROCESS | 5747 | 11:12:45 INFO - PROCESS | 5747 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-yui.html (next: http://localhost:41001/tests/dromaeo/cssquery-dojo.html) 11:12:45 INFO - PROCESS | 5747 | RSS: Main: 189698048 11:12:45 INFO - PROCESS | 5747 | 11:12:45 INFO - PROCESS | 5747 | __start_tp_report 11:12:45 INFO - PROCESS | 5747 | _x_x_mozilla_page_load 11:12:45 INFO - PROCESS | 5747 | _x_x_mozilla_page_load_details 11:12:45 INFO - PROCESS | 5747 | |i|pagename|runs| 11:12:45 INFO - PROCESS | 5747 | |0;dojo.html;2615.30694365993;2643.101345542516;2644.6958599761033;2645.7354264573546;2651.880665370058;4673.60274376678;4760.857174284768;4791.616670666347;4814.085323788478;4833.130036593412;4738.620910327174;4818.59041981432;4833.661643684944;4835.806567737295;4865.951340486594;4377.7154484958455;4393.165298593273;4475.328700694906;4546.227141385956;4553.704009239389;4222.641075508585;4520.434945631796;4522.276435770261;4598.908021839561;4603.654725895554;4381.452318460192;4383.671224658132;4405.9118817623785;4434;4525.117602067598;4383.583559561836;4423.225935461313;4438.4451943507065;4449.777511124463;4489.461264648263;4438.42300500936;4488.147252022105;4488.640908727294;4495.303227999632;4525.389072475206;4689.88275293117;4731.858044258678;4766.356541866839;4766.451858036336;4869.610431165498;5022.648414610979;5063.848084557432;5067.417247016603;5082.80554069797;5095.363079615048;5020.3724534433195;5114.360704911886;5121.052605268037;5124.666896651705;5124.718140502271;4740.217864052427;4791.904161916742;4826.7827947742435;4845.248986407112;4846.733429661403;5280.683159010472;5292.761825717852;5307.28351672527;5314.5748340132695;5364.892702145935;4960.627952903546;4962.15643340633;5069;5078.822241221539;5082.796688132507;4902.117618828645;4982.850514484571;5071.163258062452;5137.820176293886;5142.614303927146;5182.792688292501;5188.429272779991;5218.634695571273;5234.97382513085;5238.083335416287;4987.177115775857;5030.4215015272985;5210.348706411699;5233.162693969023;5239.554637855748;4378.956210437855;4400.427944367276;4403.075354175659;4448.1770872388715;4449.822007119744;3814.923701525954;3836.290286297044;3846.5576458707046;3865.381538953754;3877.592852750477;4399.120175964756;4448.532904045093;4487.910241795146;4504.414426124648;4518.502964673883;5231.267622532849;5278.155495120763;5282.049231138432;5291.206319052173;5323.387810401776;4447.466304043535;4481.327800829901;4495.595396414273;4529.91282092302;4533.5013148553635;4530.954690453119;4557.863264102082;4562.041971186088;4590.173768721662;4717.339572459859;4772.594329482033;4791.712497250176;4812.230043193073;4819.927701084416;4869.464358920587;5117.667351622133;5145.434002259673;5149.356330458692;5159.767810448464;5199.4540573239265;4703.647226457961;4765.618750500021;4788.784504697227;4795.6163506918665;4865.9026819464125;5033.47148549397;5085.745712714275;5086.61850361217;5086.669366491166;5129.87175320605;5107.87230319245;5110.3356563646485;5116.130257856099;5145.665531740425;5159.587233021274;4857.101436234308;4894.119058569349;4938.16051271292;4960.7767650456535;5007.499250074963;5004.449510553909;5008.248762685626;5016.849494515171;5017.8243761468175;5095.414027386898;4847.2729090636685;4953.405591329064;4964.776585053609;4977.129002424489;5053;5135.92296115566;5157.045946499909;5159.380874295109;5206.219067139959;5207.375114986075;5017.24741288795;5029.974850125726;5058.443571207238;5066.06277838601;5073.13589040284 11:12:45 INFO - PROCESS | 5747 | |1;ext.html;559.6671819315974;581.8836232753449;595.3986473661606;600.0878664430065;600.9489193418559;38641.42037869434;40366.59633403665;40377.19245615086;40426.39360409592;43828.3425748614;40215;41005.179896402056;41115.38326925091;41128.58871411285;41169.382459263135;7723.227677232274;7937.325327347183;7949;7949.364050875916;7958.164392738766;7682.769516914502;7803.843923121534;7804.219578042207;7819.061712594496;7839.412044096687;7842.607869606525;7878.251566101211;7896.091949425803;7930.722424715107;7946.364290856746;7813.648385822652;7819.452638315321;7826.5695386753705;7834;7879.881801772978;7750.341220996222;7806.219378062206;7832.255935686101;7845.568493732842;7887;38128;38570.421443678366;38808.417873731916;38898;38943;2883.0774152271283;3029.2578318311935;3052.2216834707006;3054.5570892220726;3083.3370825272673;29497.852510737524;29608.40783184346;29842;30295.545566816516;30988.225294367596;3399.932001359959;3468.3063387322636;3488.5988111367265;3522.735794815399;3558.217192217708;253102;255818;257676.99999999814;257737;258759;32384.676153238637;33167.33665326728;33419.66580334165;54106.45893541093;54968.17547736787;32748.508772368434;32778.83610581932;32927.67072329294;32999.50500742491;33119.83440082784;12901.677458063623;12985.415656295301;13002.869971300166;13006.349682516025;13024.47902083925;10780.191485638608;10831.729206769895;10835.51240194193;10874.238803283693;10901.127909767358;7798.571078590732;7814.179511151361;7860.292573668397;7913.802154946057;7953.483023603448;3116.750659947199;3127.3276245607303;3129.906102816919;3181;3185.2196211928226;839.9370047246481;897.6140259688266;907.3240435875183;960.2126256469768;967.7677357434166;26522.734772652027;27221;27301.45397092047;27551.44897102047;27652.58521122185;952.6903756279237;962.6678795815433;971.4317124482257;976.1263669016191;994.0308199505424;14376.35306411214;14537.78193327101;14787;14938.850611493963;14963.986039949592;109761.45119274352;332254;335158;335465;337456;46557.534424656;46780.7660961693;47122;47174;47226.29160562594;1128.4414214963645;1171.344047333496;1184.946677399519;1191.2078467818976;1195.5994741761433;24105.879470602536;25513.61729574021;26889.193324200307;26904.59643105316;27231.45537089287;40653.1869362617;40917.38623920584;40969.59030409777;41006.1798764029;41099.58900410958;208933;209567;210347;211480;211500;24149.879250603633;25178.496430071664;25220.87389563114;25273.87363063173;25296.241112766646;38812;38920;39806.402903957045;40144.59855401408;40680.38979415252;34975.82512087423;35069.82465087761;35276;35289.64710352864;36008;33933.32133357369;34006.319873602886;34047;34576.65423345835;34624.82687586546;31122.844385777928;33915.15212119717;35801.1049723759;36485.27029459449;37317;25105.74894251034;25231.24306270815;25747;25940;26395.60406593941;24975.250742477754;25149;25568;25577.232683019538;25601.48797024086 11:12:45 INFO - PROCESS | 5747 | |2;jquery.html;356.13459293915776;367.0346987423077;373.8635398079701;376.62149539712584;392.1940412452409;15803.604909877258;17440.73838892416;17827.732584011235;17831.910840445813;17881.7317740234;15628.453004144858;16967.06681132537;17203.91398043008;17242.741358879626;17248.137593120326;5050.419201791795;5209.609279304048;5254.264402983586;5255;5258;3724.5158129443134;5175.482451754832;5736.942630573703;6078.057901025348;6087.391260873921;6117.204763380754;6135.079738039308;6135.509159267271;6152.230971128609;6155.753769849201;6704.497162712816;7027.227005029443;7066.152061752623;7163.7492687755675;7169.53398029129;6537.869242615121;6801.489888258351;7004.054452648929;7025.648717564152;7029.82425439363;22461.77538224613;22832.429189270402;23292.76707232923;24413.633795493082;24537.754622453904;1982.1773963805003;2081.760597531273;2158.6330323844986;2194.703714998471;2569.3833479964674;14072.507462238875;14256.429742810275;14354.425822967069;14710.264486775619;14737.557873263819;1879.2952642758964;1879.7744270687467;1905.5998240369538;1941.8155275248828;1971.6549603819274;80048.59975700143;81679.5916020422;82176.58911705462;82492.58753706193;83735.74396384059;15599.766003509956;17154.656906861794;17658.792650918636;17688.204030818386;17949.371771987917;29610.259743506154;29813.403731925675;30141.397172056873;30191.849040754656;30240.69759302423;8460.703875364332;8913.42062765931;8973.775655608662;9007;9057.547122643842;7181.245969173266;7275.818104547428;7284.817879553054;7353.558786472829;7381.594012329266;8368.3305335573;8408.2432581068;8435.95782021086;8463.830723385498;8536.74389768308;1561.2662048837028;1624.3664970661453;1632.9020258784274;1655.114513735146;3415.436452985279;824.6041899888087;833.8499070167428;881.2751289520115;884.2307192742355;947.8293907096789;16788.6642267154;16804.411845585346;17179.742303865452;17237.482875513753;17348.30606775715;834.1658341658342;845.572985642259;852.3053711225456;861.96983105591;893.2005854759954;9456.716298511055;9478.857817132748;9502.619895204114;9631.181349585224;9682.515874206261;403305;408305;410030;411650;418209;50900.74549627302;74976.25023749802;76669.6166519175;77662.61168694233;78125.2187478118;881.532787622561;903.8689390038408;919.5310391700281;923.5382308845577;923.7829110159107;14092.929535352258;14830.703385932005;15015.253354497792;15161.696766064397;15402.768958465407;35799;36070.81964590265;37735.245295093395;37927;38063.23873522569;50930.49069509257;51214.48785512097;52029.7398513005;52070.73964630304;52672.20991685051;7084.397826184832;7256.7822965311125;7382.630868456663;7401.851962960818;7453.888191677021;9771.511424428892;11783.410829458322;11793.823092653789;11808.409579521162;11937.582184623496;9796.804063918538;10046.146077583488;10304.278700490893;10416.791664166825;10643.627473038407;10482.790344193227;10569.63006294776;10581.153507719519;10598.788024239318;10684.09185219265;5098.694078355311;9890.159336456481;9953.502324883872;10299.3820370778;10312.175025998053;7123.180834204133;7179.425645948416;7292.817679558054;7366.558006519626;7418.814529636802;9947.801043979225;10295.433751143759;10632.362058276529;10657.893421066;10758.569657213937 11:12:45 INFO - PROCESS | 5747 | |3;mootools.html;1384.4185442114308;1393.4635165461298;1479.2899408284025;1637.94267200648;1668.040876496015;6807.2512023677355;7384.298491643285;7576.848463030736;8078.11140774515;8084.070331911832;7478.214787447308;7638.9618051909665;7712.498687585303;7736.96131519343;7766.495177813438;2213.8450308478414;2257.4017885260337;2257.954840903181;2260.0055975370865;2269.716285464317;2179.1610230061383;2180.2805074325433;2226.588081204974;2228.1755750372304;2236.105557776886;2211.07135003299;2211.845170838042;2221.5001624634488;2227.398602377365;2230.096810791632;2112.9366119016377;2120.533482633818;2132.3070002249333;2163.675448682702;2165.7942495462908;2164.718586583734;2192.4299682082615;2195.1987524553583;2208.39269200971;2225.621644320453;7736.574488403136;7747.457677962545;7764.99055122836;7780.5720685362285;7815.179406162385;4541.772911354419;4654.232051711463;4658.930116048262;4662.417197850269;4663.510331415187;2843.971560284391;2962.42232764611;3021.123874076515;3025.7579393648457;3028.1521174071295;851.2891735400948;870.3776799588325;888.0409158109227;892.4333048514176;901.8782464367358;10672.413017284047;10684.091852192572;10707.518161682743;10715.142788576895;10725.302855314458;4205.978970105191;4225.260579398654;4286.39990401344;4305.418768466279;4323.113761678848;9034.86447703285;9064.54677266134;9078.046805085503;9085.591148398205;9159.679411220575;4694.0611877624615;4733.573978341966;4734.313524538922;4735.076660051326;4738.573528382393;3762.548494180716;4112.321466957918;4144.233316836335;4204.327307630764;4273.273543497613;3614.981925090358;3654.9817250914107;3713;3748.7750734955443;3779.225258821935;1173.724174818917;1193.6956076200513;1200.6698158006618;1203.1577895473029;1214.8299238106672;657.5397221944658;792.1405275276389;798.3014861995754;809.5264270401881;823.9299659529007;4744.24092145262;5014.423341315723;5098.617603679739;5114.41184263807;5163.948360516422;405.43644334375244;408.1653019574976;409.1122264685639;409.13059748035425;432.81172689880003;3330.4171769940162;3371.9662803372144;3410.897673069812;3456.274182421669;3479.1128262292955;9308.069193080637;9531.38046027006;9542.713718588453;9638.325317227867;9647.083527064917;9536.52317384128;9574.32979691415;9584.472853993097;9635.807283854283;9657.951710241405;7282.308180722823;7373.741919032808;7445.069366329209;7472.85054298911;7475.551466912003;5002.374703162105;5125.692458452505;5142.460041695717;5142.845714628567;5174;8793.560321984003;8896.5996530155;8999.775005624912;9039.457632541806;9223.354365194373;8876.467411955304;9000.909990900269;9053.728388148365;9058.864117038382;9232.892052953688;5904.586678932434;6495.123158373559;6724.93275067243;6813.250542440427;6840.31596840312;7455.217202193691;7481.438892083007;7521.849563008818;7523.887141692989;7545.698172073276;6585.934140658532;6767.1879374475375;6789.219239787488;6830.726770929107;6862.210845752802;6813.386795188457;6842.281560436082;6843.452523798183;6911.5853048817235;6913.75801846933;5778.971105144447;5875.148103525051;5884.382139875252;5892.852678683067;5922.200502932049;4239.724417912826;4333.696641235209;4352.717073390219;4379.737215767064;4387.42963414754;4289.163613095541;4353.151135528541;4381.518033016302;4394.318880573516;4397.40635014269 11:12:45 INFO - PROCESS | 5747 | |4;prototype.html;308.7823084725269;310.6660340134356;311.68052745935415;311.9734822540084;313.25757953649855;5139.640225184238;5142.588592912567;5156.819511317105;5188.403333616635;5189.351331083614;5017.498250174981;5100.33695619569;5118.692878427297;5122.667026643266;5124.923126153101;3816.026913137146;3878.70909681775;3968.9007774805573;3973.562908080109;3973.6821054315587;3962.6829853611785;3975.2049590081956;4009.5389030261604;4023.75857448554;4047.2596783383133;4015.9799201003952;4019.31671615826;4025.9798701006453;4038.4144299076615;4041.333180025307;3779.773213607165;3930.862419815321;4029.415734718464;4042.959570404317;4068.3083875741195;3579.6420357964257;3602.6937710294656;3606.3688854450365;3606.5852426970973;3612.9096772580633;5002.999400119954;5005.749712514396;5036.697798132123;5043.42000669924;5070.7464626768515;4500.122476117159;4581.244094724367;4627.791749371287;4632.791524381411;4654.115718013601;5290.365156181244;5295.285136506599;5295.576353891718;5331.306930099062;5384.623076384654;3877.263319969225;3889.9805500972316;3896.980515097435;3900.31744444721;3908.9413658795143;5470.507654311092;5471.932973070213;5592.189132575794;5596.496315331599;5645.5483561314995;3906.374980003186;3920.196359746245;3936.094698219368;3941.1132495188353;3962.187751510933;3971;3973.4238535412205;3978.6419222270133;3983.1635356575443;4011.6590089842107;4537.2059889519205;4548;4563.041761230179;4569.360289559464;4601.723896566216;5031.798728050837;5332.813351532678;5340.798320377961;5361.705106219118;5410.458954104558;1398.1331574423923;1402.7404930087762;1403.5087719298165;1405.276282714403;1410.3653355989845;914.4421902639517;917.7980844214262;936.7704912296531;948.9952550237205;953.8378475659155;4629.560191781776;4639.559241872017;4652.209124448852;4655.369716110386;4664.55686709762;5448.318960129984;5471.890562188734;5482.91775623366;5488.286522752097;5531.197976293495;4461.620762235247;4627.8843028923875;4630.4443466784205;4630.606398456169;4644.396228490275;2898.7246211609863;2898.9130326090253;2901.680815110336;2901.7823663225345;2922.956155657667;4997.600191984632;5042;5059.595232381401;5074.898502030012;5102.540771330598;5267.814741683091;5547.362053363915;5551.805686800943;5572.944270557324;5590.357108932525;5022.673526220784;5082.313887625197;5085.8728531787;5095.8726031848755;5120.951619352289;5380.488853558905;5414.264157731153;5458.208559758892;5464.508194262536;5474.124140137559;5187.33132243215;5220.947790522198;5327.493888080626;5333.759980800951;5335.039692855324;5026.723530205873;5040.36995375578;5051.696898186121;5058.241263810458;5064.7467626619255;3995.7202995790017;4020.7386519876113;4022.2357752028192;4060.208259389509;4068.4304197411793;5292.655977361459;5537.972310138423;5592.217089607377;5596.0206963780365;5632.352279487911;5307.548858347083;5363.410024897336;5426.91461707668;5433.673979561239;5437.592180586393;5086.9745651271505;5296.761645725875;5335.386430560535;5352.4915133062295;5391.29913111293;5172.689638621695;5198;5231.581473482189;5237.895242095213;5245.291885595549;5080.669756465818;5209.661372010807;5376.489233522809;5380.390510602277;5448.591355648263;5289.391719952101;5322.33470816148;5342.6260161788305;5355.571554275571;5382.703951282717 11:12:45 INFO - PROCESS | 5747 | |5;yui.html;627.5607075047467;634.1660716158249;640.4012248547612;681.2166009089548;711.9572825630463;12241.449134788934;13289.401976911038;13296.534621288245;13312.800307995389;13546.119502232348;13295.933520332408;13818.447262109528;13875.16748995061;13905;13997.300134993235;632.2918331468761;796.824698566316;811.168552233959;816;816.808050108224;791.6081539637887;804.6499772598909;809.9028116626013;819.5615345790004;822.5845947796385;850.4344610833788;851.638053827124;857.5240741388527;858.9055203927563;862.905080441151;845.9830803383898;847.0936098374741;848.1518481518482;851.1786126388034;852.2713080316303;615.0988801405917;617.8486270863667;618.3599974026905;619.4208415131822;621.5307442880642;13207.867921320856;13289.13620614657;13316.467341306336;13352.132111412824;13378.464861405531;12948.54680086202;13099.934500327437;13108.2135071896;13144.14563053408;13567.45730170792;10542.314749541332;10666.733331666694;10749.892501074968;10953.123750099972;11008.449577521093;3235.5955505561806;3244.292862655286;3248.9187770305693;3272.8363581820813;3335.799852008863;60378.396216038156;60441;61194.694026529585;61412.69293653548;61887;10502.474876256156;10505.894941050645;10522.158227341793;10540.853382879566;10764.56941722338;19094.427167185007;19129.469642428572;19138.61722765537;19164.71252931207;19207.61584768297;6630.436412904861;6825.863482730417;6827.965860170667;6937.3062693731235;6961.825954351182;3500.36993341201;3623.112337477335;3624.9275014499563;3661.7436779425716;3663.065918190844;2907.752841008538;2997.5054116070605;3020.2600362911226;3023.365093330381;3025.0924722583577;500.40451862283766;506.8504791086638;507.3809951858726;514.904742622616;519.9246109314129;461.5499887609554;470.9034647897173;493.6125141763698;531.0865311663932;550.1472717288187;7729.149793522708;7796.298333150044;7836.568988705562;7857.607119643995;7864.41016923733;452.7034792211107;522.6890000449727;523.7355135656545;546.8332158691637;576.3976644406605;3420.264643101695;3736.9626303736613;3779.962200378016;3835.827387767557;3848.5189351331082;70174.64912675404;82953.58523207346;93774;95407.52296238474;99576.50211748896;80574;81679.5916020416;82237.17762822415;82361.58819205865;84287.57856210803;71504;73418.26581734221;73805;74544;74642;7106.786796396116;7237.565746055254;7347.70609175627;7433.553986760811;7456.96271518639;41798.1640367197;42329.1534169321;42848.57151428571;43268;43935.56064439315;54753.726231368586;55243.72378138245;57815.421845781006;62837;63247.68376158274;9245.76885577839;9466.526673666427;9561.61753529851;9605.759856003655;9663.806723865624;10668.199885008811;10693.839592405964;10798.406087665255;10853.186011049045;10922.672319830417;9600.231981441608;9800.11798938099;9815.2147828175;9846.704598862045;10016.248781341283;9507.904920950701;9975.551100200364;10073.194144468278;10080.445575493419;10117.443540605043;9246.445213287225;9314.906850931404;9483.66807161746;9521.904780952378;9558.474283914451;7978.960105199437;8101.8379632408205;8157.55133467665;8211.09096630163;8398.286145677686;7035.577865328097;7506.812329691801;7559.20628334017;7788.337991270805;7811.609419529114 11:12:45 INFO - PROCESS | 5747 | __end_tp_report 11:12:45 INFO - PROCESS | 5747 | __start_cc_report 11:12:45 INFO - PROCESS | 5747 | _x_x_mozilla_cycle_collect,399 11:12:45 INFO - PROCESS | 5747 | __end_cc_report 11:12:45 INFO - PROCESS | 5747 | __startTimestamp1466964765930__endTimestamp 11:12:45 INFO - PROCESS | 5747 | 11:12:45 INFO - PROCESS | 5747 | ------- Summary: start ------- 11:12:45 INFO - PROCESS | 5747 | Number of tests: 6 11:12:45 INFO - PROCESS | 5747 | 11:12:45 INFO - PROCESS | 5747 | [#0] dojo.html Cycles:165 Average:4764.94 Median:4857.10 stddev:501.64 (10.3%) stddev-sans-first:473.99 11:12:45 INFO - PROCESS | 5747 | Values: 2615.3 2643.1 2644.7 2645.7 2651.9 4673.6 4760.9 4791.6 4814.1 4833.1 4738.6 4818.6 4833.7 4835.8 4866.0 4377.7 4393.2 4475.3 4546.2 4553.7 4222.6 4520.4 4522.3 4598.9 4603.7 4381.5 4383.7 4405.9 4434.0 4525.1 4383.6 4423.2 4438.4 4449.8 4489.5 4438.4 4488.1 4488.6 4495.3 4525.4 4689.9 4731.9 4766.4 4766.5 4869.6 5022.6 5063.8 5067.4 5082.8 5095.4 5020.4 5114.4 5121.1 5124.7 5124.7 4740.2 4791.9 4826.8 4845.2 4846.7 5280.7 5292.8 5307.3 5314.6 5364.9 4960.6 4962.2 5069.0 5078.8 5082.8 4902.1 4982.9 5071.2 5137.8 5142.6 5182.8 5188.4 5218.6 5235.0 5238.1 4987.2 5030.4 5210.3 5233.2 5239.6 4379.0 4400.4 4403.1 4448.2 4449.8 3814.9 3836.3 3846.6 3865.4 3877.6 4399.1 4448.5 4487.9 4504.4 4518.5 5231.3 5278.2 5282.0 5291.2 5323.4 4447.5 4481.3 4495.6 4529.9 4533.5 4531.0 4557.9 4562.0 4590.2 4717.3 4772.6 4791.7 4812.2 4819.9 4869.5 5117.7 5145.4 5149.4 5159.8 5199.5 4703.6 4765.6 4788.8 4795.6 4865.9 5033.5 5085.7 5086.6 5086.7 5129.9 5107.9 5110.3 5116.1 5145.7 5159.6 4857.1 4894.1 4938.2 4960.8 5007.5 5004.4 5008.2 5016.8 5017.8 5095.4 4847.3 4953.4 4964.8 4977.1 5053.0 5135.9 5157.0 5159.4 5206.2 5207.4 5017.2 5030.0 5058.4 5066.1 5073.1 11:12:45 INFO - PROCESS | 5747 | 11:12:45 INFO - PROCESS | 5747 | [#1] ext.html Cycles:180 Average:40066.52 Median:19046.57 stddev:68214.34 (358.1%) stddev-sans-first:68341.20 11:12:45 INFO - PROCESS | 5747 | Values: 559.7 581.9 595.4 600.1 600.9 38641.4 40366.6 40377.2 40426.4 43828.3 40215.0 41005.2 41115.4 41128.6 41169.4 7723.2 7937.3 7949.0 7949.4 7958.2 7682.8 7803.8 7804.2 7819.1 7839.4 7842.6 7878.3 7896.1 7930.7 7946.4 7813.6 7819.5 7826.6 7834.0 7879.9 7750.3 7806.2 7832.3 7845.6 7887.0 38128.0 38570.4 38808.4 38898.0 38943.0 2883.1 3029.3 3052.2 3054.6 3083.3 29497.9 29608.4 29842.0 30295.5 30988.2 3399.9 3468.3 3488.6 3522.7 3558.2 253102.0 255818.0 257677.0 257737.0 258759.0 32384.7 33167.3 33419.7 54106.5 54968.2 32748.5 32778.8 32927.7 32999.5 33119.8 12901.7 12985.4 13002.9 13006.3 13024.5 10780.2 10831.7 10835.5 10874.2 10901.1 7798.6 7814.2 7860.3 7913.8 7953.5 3116.8 3127.3 3129.9 3181.0 3185.2 839.9 897.6 907.3 960.2 967.8 26522.7 27221.0 27301.5 27551.4 27652.6 952.7 962.7 971.4 976.1 994.0 14376.4 14537.8 14787.0 14938.9 14964.0 109761.5 332254.0 335158.0 335465.0 337456.0 46557.5 46780.8 47122.0 47174.0 47226.3 1128.4 1171.3 1184.9 1191.2 1195.6 24105.9 25513.6 26889.2 26904.6 27231.5 40653.2 40917.4 40969.6 41006.2 41099.6 208933.0 209567.0 210347.0 211480.0 211500.0 24149.9 25178.5 25220.9 25273.9 25296.2 38812.0 38920.0 39806.4 40144.6 40680.4 34975.8 35069.8 35276.0 35289.6 36008.0 33933.3 34006.3 34047.0 34576.7 34624.8 31122.8 33915.2 35801.1 36485.3 37317.0 25105.7 25231.2 25747.0 25940.0 26395.6 24975.3 25149.0 25568.0 25577.2 25601.5 11:12:45 INFO - PROCESS | 5747 | 11:12:45 INFO - PROCESS | 5747 | [#2] jquery.html Cycles:180 Average:26236.68 Median:27975.58 stddev:67649.04 (241.8%) stddev-sans-first:67810.90 11:12:45 INFO - PROCESS | 5747 | Values: 356.1 367.0 373.9 376.6 392.2 15803.6 17440.7 17827.7 17831.9 17881.7 15628.5 16967.1 17203.9 17242.7 17248.1 5050.4 5209.6 5254.3 5255.0 5258.0 3724.5 5175.5 5736.9 6078.1 6087.4 6117.2 6135.1 6135.5 6152.2 6155.8 6704.5 7027.2 7066.2 7163.7 7169.5 6537.9 6801.5 7004.1 7025.6 7029.8 22461.8 22832.4 23292.8 24413.6 24537.8 1982.2 2081.8 2158.6 2194.7 2569.4 14072.5 14256.4 14354.4 14710.3 14737.6 1879.3 1879.8 1905.6 1941.8 1971.7 80048.6 81679.6 82176.6 82492.6 83735.7 15599.8 17154.7 17658.8 17688.2 17949.4 29610.3 29813.4 30141.4 30191.8 30240.7 8460.7 8913.4 8973.8 9007.0 9057.5 7181.2 7275.8 7284.8 7353.6 7381.6 8368.3 8408.2 8436.0 8463.8 8536.7 1561.3 1624.4 1632.9 1655.1 3415.4 824.6 833.8 881.3 884.2 947.8 16788.7 16804.4 17179.7 17237.5 17348.3 834.2 845.6 852.3 862.0 893.2 9456.7 9478.9 9502.6 9631.2 9682.5 403305.0 408305.0 410030.0 411650.0 418209.0 50900.7 74976.3 76669.6 77662.6 78125.2 881.5 903.9 919.5 923.5 923.8 14092.9 14830.7 15015.3 15161.7 15402.8 35799.0 36070.8 37735.2 37927.0 38063.2 50930.5 51214.5 52029.7 52070.7 52672.2 7084.4 7256.8 7382.6 7401.9 7453.9 9771.5 11783.4 11793.8 11808.4 11937.6 9796.8 10046.1 10304.3 10416.8 10643.6 10482.8 10569.6 10581.2 10598.8 10684.1 5098.7 9890.2 9953.5 10299.4 10312.2 7123.2 7179.4 7292.8 7366.6 7418.8 9947.8 10295.4 10632.4 10657.9 10758.6 11:12:45 INFO - PROCESS | 5747 | 11:12:45 INFO - PROCESS | 5747 | [#3] mootools.html Cycles:180 Average:5094.79 Median:4873.31 stddev:2889.93 (59.3%) stddev-sans-first:2884.58 11:12:45 INFO - PROCESS | 5747 | Values: 1384.4 1393.5 1479.3 1637.9 1668.0 6807.3 7384.3 7576.8 8078.1 8084.1 7478.2 7639.0 7712.5 7737.0 7766.5 2213.8 2257.4 2258.0 2260.0 2269.7 2179.2 2180.3 2226.6 2228.2 2236.1 2211.1 2211.8 2221.5 2227.4 2230.1 2112.9 2120.5 2132.3 2163.7 2165.8 2164.7 2192.4 2195.2 2208.4 2225.6 7736.6 7747.5 7765.0 7780.6 7815.2 4541.8 4654.2 4658.9 4662.4 4663.5 2844.0 2962.4 3021.1 3025.8 3028.2 851.3 870.4 888.0 892.4 901.9 10672.4 10684.1 10707.5 10715.1 10725.3 4206.0 4225.3 4286.4 4305.4 4323.1 9034.9 9064.5 9078.0 9085.6 9159.7 4694.1 4733.6 4734.3 4735.1 4738.6 3762.5 4112.3 4144.2 4204.3 4273.3 3615.0 3655.0 3713.0 3748.8 3779.2 1173.7 1193.7 1200.7 1203.2 1214.8 657.5 792.1 798.3 809.5 823.9 4744.2 5014.4 5098.6 5114.4 5163.9 405.4 408.2 409.1 409.1 432.8 3330.4 3372.0 3410.9 3456.3 3479.1 9308.1 9531.4 9542.7 9638.3 9647.1 9536.5 9574.3 9584.5 9635.8 9658.0 7282.3 7373.7 7445.1 7472.9 7475.6 5002.4 5125.7 5142.5 5142.8 5174.0 8793.6 8896.6 8999.8 9039.5 9223.4 8876.5 9000.9 9053.7 9058.9 9232.9 5904.6 6495.1 6724.9 6813.3 6840.3 7455.2 7481.4 7521.8 7523.9 7545.7 6585.9 6767.2 6789.2 6830.7 6862.2 6813.4 6842.3 6843.5 6911.6 6913.8 5779.0 5875.1 5884.4 5892.9 5922.2 4239.7 4333.7 4352.7 4379.7 4387.4 4289.2 4353.2 4381.5 4394.3 4397.4 11:12:45 INFO - PROCESS | 5747 | 11:12:45 INFO - PROCESS | 5747 | [#4] prototype.html Cycles:180 Average:4437.90 Median:5047.56 stddev:1270.03 (25.2%) stddev-sans-first:1235.20 11:12:45 INFO - PROCESS | 5747 | Values: 308.8 310.7 311.7 312.0 313.3 5139.6 5142.6 5156.8 5188.4 5189.4 5017.5 5100.3 5118.7 5122.7 5124.9 3816.0 3878.7 3968.9 3973.6 3973.7 3962.7 3975.2 4009.5 4023.8 4047.3 4016.0 4019.3 4026.0 4038.4 4041.3 3779.8 3930.9 4029.4 4043.0 4068.3 3579.6 3602.7 3606.4 3606.6 3612.9 5003.0 5005.7 5036.7 5043.4 5070.7 4500.1 4581.2 4627.8 4632.8 4654.1 5290.4 5295.3 5295.6 5331.3 5384.6 3877.3 3890.0 3897.0 3900.3 3908.9 5470.5 5471.9 5592.2 5596.5 5645.5 3906.4 3920.2 3936.1 3941.1 3962.2 3971.0 3973.4 3978.6 3983.2 4011.7 4537.2 4548.0 4563.0 4569.4 4601.7 5031.8 5332.8 5340.8 5361.7 5410.5 1398.1 1402.7 1403.5 1405.3 1410.4 914.4 917.8 936.8 949.0 953.8 4629.6 4639.6 4652.2 4655.4 4664.6 5448.3 5471.9 5482.9 5488.3 5531.2 4461.6 4627.9 4630.4 4630.6 4644.4 2898.7 2898.9 2901.7 2901.8 2923.0 4997.6 5042.0 5059.6 5074.9 5102.5 5267.8 5547.4 5551.8 5572.9 5590.4 5022.7 5082.3 5085.9 5095.9 5121.0 5380.5 5414.3 5458.2 5464.5 5474.1 5187.3 5220.9 5327.5 5333.8 5335.0 5026.7 5040.4 5051.7 5058.2 5064.7 3995.7 4020.7 4022.2 4060.2 4068.4 5292.7 5538.0 5592.2 5596.0 5632.4 5307.5 5363.4 5426.9 5433.7 5437.6 5087.0 5296.8 5335.4 5352.5 5391.3 5172.7 5198.0 5231.6 5237.9 5245.3 5080.7 5209.7 5376.5 5380.4 5448.6 5289.4 5322.3 5342.6 5355.6 5382.7 11:12:45 INFO - PROCESS | 5747 | 11:12:45 INFO - PROCESS | 5747 | [#5] yui.html Cycles:180 Average:16878.72 Median:31013.90 stddev:24227.65 (78.1%) stddev-sans-first:24264.89 11:12:45 INFO - PROCESS | 5747 | Values: 627.6 634.2 640.4 681.2 712.0 12241.4 13289.4 13296.5 13312.8 13546.1 13295.9 13818.4 13875.2 13905.0 13997.3 632.3 796.8 811.2 816.0 816.8 791.6 804.6 809.9 819.6 822.6 850.4 851.6 857.5 858.9 862.9 846.0 847.1 848.2 851.2 852.3 615.1 617.8 618.4 619.4 621.5 13207.9 13289.1 13316.5 13352.1 13378.5 12948.5 13099.9 13108.2 13144.1 13567.5 10542.3 10666.7 10749.9 10953.1 11008.4 3235.6 3244.3 3248.9 3272.8 3335.8 60378.4 60441.0 61194.7 61412.7 61887.0 10502.5 10505.9 10522.2 10540.9 10764.6 19094.4 19129.5 19138.6 19164.7 19207.6 6630.4 6825.9 6828.0 6937.3 6961.8 3500.4 3623.1 3624.9 3661.7 3663.1 2907.8 2997.5 3020.3 3023.4 3025.1 500.4 506.9 507.4 514.9 519.9 461.5 470.9 493.6 531.1 550.1 7729.1 7796.3 7836.6 7857.6 7864.4 452.7 522.7 523.7 546.8 576.4 3420.3 3737.0 3780.0 3835.8 3848.5 70174.6 82953.6 93774.0 95407.5 99576.5 80574.0 81679.6 82237.2 82361.6 84287.6 71504.0 73418.3 73805.0 74544.0 74642.0 7106.8 7237.6 7347.7 7433.6 7457.0 41798.2 42329.2 42848.6 43268.0 43935.6 54753.7 55243.7 57815.4 62837.0 63247.7 9245.8 9466.5 9561.6 9605.8 9663.8 10668.2 10693.8 10798.4 10853.2 10922.7 9600.2 9800.1 9815.2 9846.7 10016.2 9507.9 9975.6 10073.2 10080.4 10117.4 9246.4 9314.9 9483.7 9521.9 9558.5 7979.0 8101.8 8157.6 8211.1 8398.3 7035.6 7506.8 7559.2 7788.3 7811.6 11:12:45 INFO - PROCESS | 5747 | -------- Summary: end -------- 11:12:45 INFO - PROCESS | 5747 | 11:12:46 INFO - TEST-INFO | 5747: exit 0 11:12:46 INFO - TEST-OK | dromaeo_css | took 1118107ms 11:12:46 INFO - TEST-START | kraken 11:12:46 INFO - operating with platform_type : linux_ 11:12:46 INFO - Initialising browser for kraken test... 11:12:46 INFO - TEST-INFO | started process 5981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3PUxB/profile http://localhost:41001/getInfo.html) 11:12:51 INFO - PROCESS | 5981 | __metrics Screen width/height:1600/1200 11:12:51 INFO - PROCESS | 5981 | colorDepth:24 11:12:51 INFO - PROCESS | 5981 | Browser inner width/height: 1024/697 11:12:51 INFO - PROCESS | 5981 | __metrics 11:12:52 ERROR - PROCESS | 5981 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:12:53 INFO - TEST-INFO | 5981: exit 0 11:12:53 INFO - Browser initialized. 11:12:53 INFO - Running cycle 1/1 for kraken test... 11:12:53 INFO - TEST-INFO | started process 6101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3PUxB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:05 INFO - PROCESS | 6101 | RSS: Main: 185909248 11:13:05 INFO - PROCESS | 6101 | 11:13:07 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41001/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:08 INFO - PROCESS | 6101 | RSS: Main: 190263296 11:13:08 INFO - PROCESS | 6101 | 11:13:11 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41001/tests/kraken/driver.html?testName=audio-dft) 11:13:12 INFO - PROCESS | 6101 | RSS: Main: 190038016 11:13:12 INFO - PROCESS | 6101 | 11:13:15 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41001/tests/kraken/driver.html?testName=audio-fft) 11:13:16 INFO - PROCESS | 6101 | RSS: Main: 185802752 11:13:16 INFO - PROCESS | 6101 | 11:13:18 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41001/tests/kraken/driver.html?testName=audio-oscillator) 11:13:18 INFO - PROCESS | 6101 | RSS: Main: 186191872 11:13:18 INFO - PROCESS | 6101 | 11:13:20 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:21 INFO - PROCESS | 6101 | RSS: Main: 186429440 11:13:21 INFO - PROCESS | 6101 | 11:13:24 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41001/tests/kraken/driver.html?testName=imaging-darkroom) 11:13:25 INFO - PROCESS | 6101 | RSS: Main: 186646528 11:13:25 INFO - PROCESS | 6101 | 11:13:29 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41001/tests/kraken/driver.html?testName=imaging-desaturate) 11:13:29 INFO - PROCESS | 6101 | RSS: Main: 183898112 11:13:29 INFO - PROCESS | 6101 | 11:13:32 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41001/tests/kraken/driver.html?testName=json-parse-financial) 11:13:33 INFO - PROCESS | 6101 | RSS: Main: 185200640 11:13:33 INFO - PROCESS | 6101 | 11:13:34 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:13:35 INFO - PROCESS | 6101 | RSS: Main: 185200640 11:13:35 INFO - PROCESS | 6101 | 11:13:37 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:13:38 INFO - PROCESS | 6101 | RSS: Main: 185524224 11:13:38 INFO - PROCESS | 6101 | 11:13:40 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:13:41 INFO - PROCESS | 6101 | RSS: Main: 186269696 11:13:41 INFO - PROCESS | 6101 | 11:13:43 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:13:44 INFO - PROCESS | 6101 | RSS: Main: 186388480 11:13:44 INFO - PROCESS | 6101 | 11:13:47 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:13:47 INFO - PROCESS | 6101 | RSS: Main: 186515456 11:13:47 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41001/tests/kraken/driver.html?testName=ai-astar) 11:13:49 INFO - PROCESS | 6101 | RSS: Main: 186757120 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | __start_tp_report 11:13:49 INFO - PROCESS | 6101 | _x_x_mozilla_page_load 11:13:49 INFO - PROCESS | 6101 | _x_x_mozilla_page_load_details 11:13:49 INFO - PROCESS | 6101 | |i|pagename|runs| 11:13:49 INFO - PROCESS | 6101 | |0;ai-astar;105;114;107;113;113;113;115;114;115;113 11:13:49 INFO - PROCESS | 6101 | |1;audio-beat-detection;154;129;159;191;129;171;168;144;199;132 11:13:49 INFO - PROCESS | 6101 | |2;audio-dft;164;166;175;164;164;164;163;161;162;160 11:13:49 INFO - PROCESS | 6101 | |3;audio-fft;76;76;76;156;76;76;76;75;157;79 11:13:49 INFO - PROCESS | 6101 | |4;audio-oscillator;86;86;144;87;86;86;135;87;87;142 11:13:49 INFO - PROCESS | 6101 | |5;imaging-gaussian-blur;117;117;118;117;118;117;118;118;118;119 11:13:49 INFO - PROCESS | 6101 | |6;imaging-darkroom;149;149;148;146;149;148;149;147;147;147 11:13:49 INFO - PROCESS | 6101 | |7;imaging-desaturate;95;96;95;97;96;96;96;96;96;96 11:13:49 INFO - PROCESS | 6101 | |8;json-parse-financial;63;63;63;63;63;64;63;64;64;64 11:13:49 INFO - PROCESS | 6101 | |9;json-stringify-tinderbox;67;65;64;66;66;65;65;66;65;66 11:13:49 INFO - PROCESS | 6101 | |10;stanford-crypto-aes;82;83;87;83;83;85;82;87;136;89 11:13:49 INFO - PROCESS | 6101 | |11;stanford-crypto-ccm;144;141;148;130;130;129;143;136;134;140 11:13:49 INFO - PROCESS | 6101 | |12;stanford-crypto-pbkdf2;166;168;166;170;177;171;179;169;171;170 11:13:49 INFO - PROCESS | 6101 | |13;stanford-crypto-sha256-iterative;67;68;71;67;67;66;66;70;65;64 11:13:49 INFO - PROCESS | 6101 | __end_tp_report 11:13:49 INFO - PROCESS | 6101 | __start_cc_report 11:13:49 INFO - PROCESS | 6101 | _x_x_mozilla_cycle_collect,982 11:13:49 INFO - PROCESS | 6101 | __end_cc_report 11:13:49 INFO - PROCESS | 6101 | __startTimestamp1466964829962__endTimestamp 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | ------- Summary: start ------- 11:13:49 INFO - PROCESS | 6101 | Number of tests: 14 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.50 stddev:3.39 (3.0%) stddev-sans-first:2.40 11:13:49 INFO - PROCESS | 6101 | Values: 105.0 114.0 107.0 113.0 113.0 113.0 115.0 114.0 115.0 113.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#1] audio-beat-detection Cycles:10 Average:157.60 Median:163.50 stddev:24.96 (15.3%) stddev-sans-first:26.44 11:13:49 INFO - PROCESS | 6101 | Values: 154.0 129.0 159.0 191.0 129.0 171.0 168.0 144.0 199.0 132.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:4.14 (2.5%) stddev-sans-first:4.39 11:13:49 INFO - PROCESS | 6101 | Values: 164.0 166.0 175.0 164.0 164.0 164.0 163.0 161.0 162.0 160.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#3] audio-fft Cycles:10 Average:92.30 Median:76.00 stddev:33.85 (44.5%) stddev-sans-first:35.39 11:13:49 INFO - PROCESS | 6101 | Values: 76.0 76.0 76.0 156.0 76.0 76.0 76.0 75.0 157.0 79.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:86.00 stddev:26.14 (30.4%) stddev-sans-first:27.02 11:13:49 INFO - PROCESS | 6101 | Values: 86.0 86.0 144.0 87.0 86.0 86.0 135.0 87.0 87.0 142.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 11:13:49 INFO - PROCESS | 6101 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 119.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 11:13:49 INFO - PROCESS | 6101 | Values: 149.0 149.0 148.0 146.0 149.0 148.0 149.0 147.0 147.0 147.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 11:13:49 INFO - PROCESS | 6101 | Values: 95.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 11:13:49 INFO - PROCESS | 6101 | Values: 63.0 63.0 63.0 63.0 63.0 64.0 63.0 64.0 64.0 64.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 11:13:49 INFO - PROCESS | 6101 | Values: 67.0 65.0 64.0 66.0 66.0 65.0 65.0 66.0 65.0 66.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:84.00 stddev:16.45 (19.6%) stddev-sans-first:17.21 11:13:49 INFO - PROCESS | 6101 | Values: 82.0 83.0 87.0 83.0 83.0 85.0 82.0 87.0 136.0 89.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:140.50 stddev:6.67 (4.7%) stddev-sans-first:6.65 11:13:49 INFO - PROCESS | 6101 | Values: 144.0 141.0 148.0 130.0 130.0 129.0 143.0 136.0 134.0 140.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:170.50 stddev:4.27 (2.5%) stddev-sans-first:4.18 11:13:49 INFO - PROCESS | 6101 | Values: 166.0 168.0 166.0 170.0 177.0 171.0 179.0 169.0 171.0 170.0 11:13:49 INFO - PROCESS | 6101 | 11:13:49 INFO - PROCESS | 6101 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.13 (3.2%) stddev-sans-first:2.26 11:13:49 INFO - PROCESS | 6101 | Values: 67.0 68.0 71.0 67.0 67.0 66.0 66.0 70.0 65.0 64.0 11:13:49 INFO - PROCESS | 6101 | -------- Summary: end -------- 11:13:49 INFO - PROCESS | 6101 | 11:13:51 INFO - TEST-INFO | 6101: exit 0 11:13:51 INFO - TEST-OK | kraken | took 64315ms 11:13:51 INFO - SUITE-END | took 1182s 11:13:51 INFO - Completed test suite (00:19:42) 11:13:51 INFO - javascript benchmark 11:13:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6408.852036440756, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2615.30694365993, 2643.101345542516, 2644.6958599761033, 2645.7354264573546, 2651.880665370058, 4673.60274376678, 4760.857174284768, 4791.616670666347, 4814.085323788478, 4833.130036593412, 4738.620910327174, 4818.59041981432, 4833.661643684944, 4835.806567737295, 4865.951340486594, 4377.7154484958455, 4393.165298593273, 4475.328700694906, 4546.227141385956, 4553.704009239389, 4222.641075508585, 4520.434945631796, 4522.276435770261, 4598.908021839561, 4603.654725895554, 4381.452318460192, 4383.671224658132, 4405.9118817623785, 4434.0, 4525.117602067598, 4383.583559561836, 4423.225935461313, 4438.4451943507065, 4449.777511124463, 4489.461264648263, 4438.42300500936, 4488.147252022105, 4488.640908727294, 4495.303227999632, 4525.389072475206, 4689.88275293117, 4731.858044258678, 4766.356541866839, 4766.451858036336, 4869.610431165498, 5022.648414610979, 5063.848084557432, 5067.417247016603, 5082.80554069797, 5095.363079615048, 5020.3724534433195, 5114.360704911886, 5121.052605268037, 5124.666896651705, 5124.718140502271, 4740.217864052427, 4791.904161916742, 4826.7827947742435, 4845.248986407112, 4846.733429661403, 5280.683159010472, 5292.761825717852, 5307.28351672527, 5314.5748340132695, 5364.892702145935, 4960.627952903546, 4962.15643340633, 5069.0, 5078.822241221539, 5082.796688132507, 4902.117618828645, 4982.850514484571, 5071.163258062452, 5137.820176293886, 5142.614303927146, 5182.792688292501, 5188.429272779991, 5218.634695571273, 5234.97382513085, 5238.083335416287, 4987.177115775857, 5030.4215015272985, 5210.348706411699, 5233.162693969023, 5239.554637855748, 4378.956210437855, 4400.427944367276, 4403.075354175659, 4448.1770872388715, 4449.822007119744, 3814.923701525954, 3836.290286297044, 3846.5576458707046, 3865.381538953754, 3877.592852750477, 4399.120175964756, 4448.532904045093, 4487.910241795146, 4504.414426124648, 4518.502964673883, 5231.267622532849, 5278.155495120763, 5282.049231138432, 5291.206319052173, 5323.387810401776, 4447.466304043535, 4481.327800829901, 4495.595396414273, 4529.91282092302, 4533.5013148553635, 4530.954690453119, 4557.863264102082, 4562.041971186088, 4590.173768721662, 4717.339572459859, 4772.594329482033, 4791.712497250176, 4812.230043193073, 4819.927701084416, 4869.464358920587, 5117.667351622133, 5145.434002259673, 5149.356330458692, 5159.767810448464, 5199.4540573239265, 4703.647226457961, 4765.618750500021, 4788.784504697227, 4795.6163506918665, 4865.9026819464125, 5033.47148549397, 5085.745712714275, 5086.61850361217, 5086.669366491166, 5129.87175320605, 5107.87230319245, 5110.3356563646485, 5116.130257856099, 5145.665531740425, 5159.587233021274, 4857.101436234308, 4894.119058569349, 4938.16051271292, 4960.7767650456535, 5007.499250074963, 5004.449510553909, 5008.248762685626, 5016.849494515171, 5017.8243761468175, 5095.414027386898, 4847.2729090636685, 4953.405591329064, 4964.776585053609, 4977.129002424489, 5053.0, 5135.92296115566, 5157.045946499909, 5159.380874295109, 5206.219067139959, 5207.375114986075, 5017.24741288795, 5029.974850125726, 5058.443571207238, 5066.06277838601, 5073.13589040284], "value": 4732.423324113171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6671819315974, 581.8836232753449, 595.3986473661606, 600.0878664430065, 600.9489193418559, 38641.42037869434, 40366.59633403665, 40377.19245615086, 40426.39360409592, 43828.3425748614, 40215.0, 41005.179896402056, 41115.38326925091, 41128.58871411285, 41169.382459263135, 7723.227677232274, 7937.325327347183, 7949.0, 7949.364050875916, 7958.164392738766, 7682.769516914502, 7803.843923121534, 7804.219578042207, 7819.061712594496, 7839.412044096687, 7842.607869606525, 7878.251566101211, 7896.091949425803, 7930.722424715107, 7946.364290856746, 7813.648385822652, 7819.452638315321, 7826.5695386753705, 7834.0, 7879.881801772978, 7750.341220996222, 7806.219378062206, 7832.255935686101, 7845.568493732842, 7887.0, 38128.0, 38570.421443678366, 38808.417873731916, 38898.0, 38943.0, 2883.0774152271283, 3029.2578318311935, 3052.2216834707006, 3054.5570892220726, 3083.3370825272673, 29497.852510737524, 29608.40783184346, 29842.0, 30295.545566816516, 30988.225294367596, 3399.932001359959, 3468.3063387322636, 3488.5988111367265, 3522.735794815399, 3558.217192217708, 253102.0, 255818.0, 257676.99999999814, 257737.0, 258759.0, 32384.676153238637, 33167.33665326728, 33419.66580334165, 54106.45893541093, 54968.17547736787, 32748.508772368434, 32778.83610581932, 32927.67072329294, 32999.50500742491, 33119.83440082784, 12901.677458063623, 12985.415656295301, 13002.869971300166, 13006.349682516025, 13024.47902083925, 10780.191485638608, 10831.729206769895, 10835.51240194193, 10874.238803283693, 10901.127909767358, 7798.571078590732, 7814.179511151361, 7860.292573668397, 7913.802154946057, 7953.483023603448, 3116.750659947199, 3127.3276245607303, 3129.906102816919, 3181.0, 3185.2196211928226, 839.9370047246481, 897.6140259688266, 907.3240435875183, 960.2126256469768, 967.7677357434166, 26522.734772652027, 27221.0, 27301.45397092047, 27551.44897102047, 27652.58521122185, 952.6903756279237, 962.6678795815433, 971.4317124482257, 976.1263669016191, 994.0308199505424, 14376.35306411214, 14537.78193327101, 14787.0, 14938.850611493963, 14963.986039949592, 109761.45119274352, 332254.0, 335158.0, 335465.0, 337456.0, 46557.534424656, 46780.7660961693, 47122.0, 47174.0, 47226.29160562594, 1128.4414214963645, 1171.344047333496, 1184.946677399519, 1191.2078467818976, 1195.5994741761433, 24105.879470602536, 25513.61729574021, 26889.193324200307, 26904.59643105316, 27231.45537089287, 40653.1869362617, 40917.38623920584, 40969.59030409777, 41006.1798764029, 41099.58900410958, 208933.0, 209567.0, 210347.0, 211480.0, 211500.0, 24149.879250603633, 25178.496430071664, 25220.87389563114, 25273.87363063173, 25296.241112766646, 38812.0, 38920.0, 39806.402903957045, 40144.59855401408, 40680.38979415252, 34975.82512087423, 35069.82465087761, 35276.0, 35289.64710352864, 36008.0, 33933.32133357369, 34006.319873602886, 34047.0, 34576.65423345835, 34624.82687586546, 31122.844385777928, 33915.15212119717, 35801.1049723759, 36485.27029459449, 37317.0, 25105.74894251034, 25231.24306270815, 25747.0, 25940.0, 26395.60406593941, 24975.250742477754, 25149.0, 25568.0, 25577.232683019538, 25601.48797024086], "value": 15837.138488779821, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.13459293915776, 367.0346987423077, 373.8635398079701, 376.62149539712584, 392.1940412452409, 15803.604909877258, 17440.73838892416, 17827.732584011235, 17831.910840445813, 17881.7317740234, 15628.453004144858, 16967.06681132537, 17203.91398043008, 17242.741358879626, 17248.137593120326, 5050.419201791795, 5209.609279304048, 5254.264402983586, 5255.0, 5258.0, 3724.5158129443134, 5175.482451754832, 5736.942630573703, 6078.057901025348, 6087.391260873921, 6117.204763380754, 6135.079738039308, 6135.509159267271, 6152.230971128609, 6155.753769849201, 6704.497162712816, 7027.227005029443, 7066.152061752623, 7163.7492687755675, 7169.53398029129, 6537.869242615121, 6801.489888258351, 7004.054452648929, 7025.648717564152, 7029.82425439363, 22461.77538224613, 22832.429189270402, 23292.76707232923, 24413.633795493082, 24537.754622453904, 1982.1773963805003, 2081.760597531273, 2158.6330323844986, 2194.703714998471, 2569.3833479964674, 14072.507462238875, 14256.429742810275, 14354.425822967069, 14710.264486775619, 14737.557873263819, 1879.2952642758964, 1879.7744270687467, 1905.5998240369538, 1941.8155275248828, 1971.6549603819274, 80048.59975700143, 81679.5916020422, 82176.58911705462, 82492.58753706193, 83735.74396384059, 15599.766003509956, 17154.656906861794, 17658.792650918636, 17688.204030818386, 17949.371771987917, 29610.259743506154, 29813.403731925675, 30141.397172056873, 30191.849040754656, 30240.69759302423, 8460.703875364332, 8913.42062765931, 8973.775655608662, 9007.0, 9057.547122643842, 7181.245969173266, 7275.818104547428, 7284.817879553054, 7353.558786472829, 7381.594012329266, 8368.3305335573, 8408.2432581068, 8435.95782021086, 8463.830723385498, 8536.74389768308, 1561.2662048837028, 1624.3664970661453, 1632.9020258784274, 1655.114513735146, 3415.436452985279, 824.6041899888087, 833.8499070167428, 881.2751289520115, 884.2307192742355, 947.8293907096789, 16788.6642267154, 16804.411845585346, 17179.742303865452, 17237.482875513753, 17348.30606775715, 834.1658341658342, 845.572985642259, 852.3053711225456, 861.96983105591, 893.2005854759954, 9456.716298511055, 9478.857817132748, 9502.619895204114, 9631.181349585224, 9682.515874206261, 403305.0, 408305.0, 410030.0, 411650.0, 418209.0, 50900.74549627302, 74976.25023749802, 76669.6166519175, 77662.61168694233, 78125.2187478118, 881.532787622561, 903.8689390038408, 919.5310391700281, 923.5382308845577, 923.7829110159107, 14092.929535352258, 14830.703385932005, 15015.253354497792, 15161.696766064397, 15402.768958465407, 35799.0, 36070.81964590265, 37735.245295093395, 37927.0, 38063.23873522569, 50930.49069509257, 51214.48785512097, 52029.7398513005, 52070.73964630304, 52672.20991685051, 7084.397826184832, 7256.7822965311125, 7382.630868456663, 7401.851962960818, 7453.888191677021, 9771.511424428892, 11783.410829458322, 11793.823092653789, 11808.409579521162, 11937.582184623496, 9796.804063918538, 10046.146077583488, 10304.278700490893, 10416.791664166825, 10643.627473038407, 10482.790344193227, 10569.63006294776, 10581.153507719519, 10598.788024239318, 10684.09185219265, 5098.694078355311, 9890.159336456481, 9953.502324883872, 10299.3820370778, 10312.175025998053, 7123.180834204133, 7179.425645948416, 7292.817679558054, 7366.558006519626, 7418.814529636802, 9947.801043979225, 10295.433751143759, 10632.362058276529, 10657.893421066, 10758.569657213937], "value": 9110.948279887296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.4185442114308, 1393.4635165461298, 1479.2899408284025, 1637.94267200648, 1668.040876496015, 6807.2512023677355, 7384.298491643285, 7576.848463030736, 8078.11140774515, 8084.070331911832, 7478.214787447308, 7638.9618051909665, 7712.498687585303, 7736.96131519343, 7766.495177813438, 2213.8450308478414, 2257.4017885260337, 2257.954840903181, 2260.0055975370865, 2269.716285464317, 2179.1610230061383, 2180.2805074325433, 2226.588081204974, 2228.1755750372304, 2236.105557776886, 2211.07135003299, 2211.845170838042, 2221.5001624634488, 2227.398602377365, 2230.096810791632, 2112.9366119016377, 2120.533482633818, 2132.3070002249333, 2163.675448682702, 2165.7942495462908, 2164.718586583734, 2192.4299682082615, 2195.1987524553583, 2208.39269200971, 2225.621644320453, 7736.574488403136, 7747.457677962545, 7764.99055122836, 7780.5720685362285, 7815.179406162385, 4541.772911354419, 4654.232051711463, 4658.930116048262, 4662.417197850269, 4663.510331415187, 2843.971560284391, 2962.42232764611, 3021.123874076515, 3025.7579393648457, 3028.1521174071295, 851.2891735400948, 870.3776799588325, 888.0409158109227, 892.4333048514176, 901.8782464367358, 10672.413017284047, 10684.091852192572, 10707.518161682743, 10715.142788576895, 10725.302855314458, 4205.978970105191, 4225.260579398654, 4286.39990401344, 4305.418768466279, 4323.113761678848, 9034.86447703285, 9064.54677266134, 9078.046805085503, 9085.591148398205, 9159.679411220575, 4694.0611877624615, 4733.573978341966, 4734.313524538922, 4735.076660051326, 4738.573528382393, 3762.548494180716, 4112.321466957918, 4144.233316836335, 4204.327307630764, 4273.273543497613, 3614.981925090358, 3654.9817250914107, 3713.0, 3748.7750734955443, 3779.225258821935, 1173.724174818917, 1193.6956076200513, 1200.6698158006618, 1203.1577895473029, 1214.8299238106672, 657.5397221944658, 792.1405275276389, 798.3014861995754, 809.5264270401881, 823.9299659529007, 4744.24092145262, 5014.423341315723, 5098.617603679739, 5114.41184263807, 5163.948360516422, 405.43644334375244, 408.1653019574976, 409.1122264685639, 409.13059748035425, 432.81172689880003, 3330.4171769940162, 3371.9662803372144, 3410.897673069812, 3456.274182421669, 3479.1128262292955, 9308.069193080637, 9531.38046027006, 9542.713718588453, 9638.325317227867, 9647.083527064917, 9536.52317384128, 9574.32979691415, 9584.472853993097, 9635.807283854283, 9657.951710241405, 7282.308180722823, 7373.741919032808, 7445.069366329209, 7472.85054298911, 7475.551466912003, 5002.374703162105, 5125.692458452505, 5142.460041695717, 5142.845714628567, 5174.0, 8793.560321984003, 8896.5996530155, 8999.775005624912, 9039.457632541806, 9223.354365194373, 8876.467411955304, 9000.909990900269, 9053.728388148365, 9058.864117038382, 9232.892052953688, 5904.586678932434, 6495.123158373559, 6724.93275067243, 6813.250542440427, 6840.31596840312, 7455.217202193691, 7481.438892083007, 7521.849563008818, 7523.887141692989, 7545.698172073276, 6585.934140658532, 6767.1879374475375, 6789.219239787488, 6830.726770929107, 6862.210845752802, 6813.386795188457, 6842.281560436082, 6843.452523798183, 6911.5853048817235, 6913.75801846933, 5778.971105144447, 5875.148103525051, 5884.382139875252, 5892.852678683067, 5922.200502932049, 4239.724417912826, 4333.696641235209, 4352.717073390219, 4379.737215767064, 4387.42963414754, 4289.163613095541, 4353.151135528541, 4381.518033016302, 4394.318880573516, 4397.40635014269], "value": 4028.2109166313226, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.7823084725269, 310.6660340134356, 311.68052745935415, 311.9734822540084, 313.25757953649855, 5139.640225184238, 5142.588592912567, 5156.819511317105, 5188.403333616635, 5189.351331083614, 5017.498250174981, 5100.33695619569, 5118.692878427297, 5122.667026643266, 5124.923126153101, 3816.026913137146, 3878.70909681775, 3968.9007774805573, 3973.562908080109, 3973.6821054315587, 3962.6829853611785, 3975.2049590081956, 4009.5389030261604, 4023.75857448554, 4047.2596783383133, 4015.9799201003952, 4019.31671615826, 4025.9798701006453, 4038.4144299076615, 4041.333180025307, 3779.773213607165, 3930.862419815321, 4029.415734718464, 4042.959570404317, 4068.3083875741195, 3579.6420357964257, 3602.6937710294656, 3606.3688854450365, 3606.5852426970973, 3612.9096772580633, 5002.999400119954, 5005.749712514396, 5036.697798132123, 5043.42000669924, 5070.7464626768515, 4500.122476117159, 4581.244094724367, 4627.791749371287, 4632.791524381411, 4654.115718013601, 5290.365156181244, 5295.285136506599, 5295.576353891718, 5331.306930099062, 5384.623076384654, 3877.263319969225, 3889.9805500972316, 3896.980515097435, 3900.31744444721, 3908.9413658795143, 5470.507654311092, 5471.932973070213, 5592.189132575794, 5596.496315331599, 5645.5483561314995, 3906.374980003186, 3920.196359746245, 3936.094698219368, 3941.1132495188353, 3962.187751510933, 3971.0, 3973.4238535412205, 3978.6419222270133, 3983.1635356575443, 4011.6590089842107, 4537.2059889519205, 4548.0, 4563.041761230179, 4569.360289559464, 4601.723896566216, 5031.798728050837, 5332.813351532678, 5340.798320377961, 5361.705106219118, 5410.458954104558, 1398.1331574423923, 1402.7404930087762, 1403.5087719298165, 1405.276282714403, 1410.3653355989845, 914.4421902639517, 917.7980844214262, 936.7704912296531, 948.9952550237205, 953.8378475659155, 4629.560191781776, 4639.559241872017, 4652.209124448852, 4655.369716110386, 4664.55686709762, 5448.318960129984, 5471.890562188734, 5482.91775623366, 5488.286522752097, 5531.197976293495, 4461.620762235247, 4627.8843028923875, 4630.4443466784205, 4630.606398456169, 4644.396228490275, 2898.7246211609863, 2898.9130326090253, 2901.680815110336, 2901.7823663225345, 2922.956155657667, 4997.600191984632, 5042.0, 5059.595232381401, 5074.898502030012, 5102.540771330598, 5267.814741683091, 5547.362053363915, 5551.805686800943, 5572.944270557324, 5590.357108932525, 5022.673526220784, 5082.313887625197, 5085.8728531787, 5095.8726031848755, 5120.951619352289, 5380.488853558905, 5414.264157731153, 5458.208559758892, 5464.508194262536, 5474.124140137559, 5187.33132243215, 5220.947790522198, 5327.493888080626, 5333.759980800951, 5335.039692855324, 5026.723530205873, 5040.36995375578, 5051.696898186121, 5058.241263810458, 5064.7467626619255, 3995.7202995790017, 4020.7386519876113, 4022.2357752028192, 4060.208259389509, 4068.4304197411793, 5292.655977361459, 5537.972310138423, 5592.217089607377, 5596.0206963780365, 5632.352279487911, 5307.548858347083, 5363.410024897336, 5426.91461707668, 5433.673979561239, 5437.592180586393, 5086.9745651271505, 5296.761645725875, 5335.386430560535, 5352.4915133062295, 5391.29913111293, 5172.689638621695, 5198.0, 5231.581473482189, 5237.895242095213, 5245.291885595549, 5080.669756465818, 5209.661372010807, 5376.489233522809, 5380.390510602277, 5448.591355648263, 5289.391719952101, 5322.33470816148, 5342.6260161788305, 5355.571554275571, 5382.703951282717], "value": 4034.8905149874554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.5607075047467, 634.1660716158249, 640.4012248547612, 681.2166009089548, 711.9572825630463, 12241.449134788934, 13289.401976911038, 13296.534621288245, 13312.800307995389, 13546.119502232348, 13295.933520332408, 13818.447262109528, 13875.16748995061, 13905.0, 13997.300134993235, 632.2918331468761, 796.824698566316, 811.168552233959, 816.0, 816.808050108224, 791.6081539637887, 804.6499772598909, 809.9028116626013, 819.5615345790004, 822.5845947796385, 850.4344610833788, 851.638053827124, 857.5240741388527, 858.9055203927563, 862.905080441151, 845.9830803383898, 847.0936098374741, 848.1518481518482, 851.1786126388034, 852.2713080316303, 615.0988801405917, 617.8486270863667, 618.3599974026905, 619.4208415131822, 621.5307442880642, 13207.867921320856, 13289.13620614657, 13316.467341306336, 13352.132111412824, 13378.464861405531, 12948.54680086202, 13099.934500327437, 13108.2135071896, 13144.14563053408, 13567.45730170792, 10542.314749541332, 10666.733331666694, 10749.892501074968, 10953.123750099972, 11008.449577521093, 3235.5955505561806, 3244.292862655286, 3248.9187770305693, 3272.8363581820813, 3335.799852008863, 60378.396216038156, 60441.0, 61194.694026529585, 61412.69293653548, 61887.0, 10502.474876256156, 10505.894941050645, 10522.158227341793, 10540.853382879566, 10764.56941722338, 19094.427167185007, 19129.469642428572, 19138.61722765537, 19164.71252931207, 19207.61584768297, 6630.436412904861, 6825.863482730417, 6827.965860170667, 6937.3062693731235, 6961.825954351182, 3500.36993341201, 3623.112337477335, 3624.9275014499563, 3661.7436779425716, 3663.065918190844, 2907.752841008538, 2997.5054116070605, 3020.2600362911226, 3023.365093330381, 3025.0924722583577, 500.40451862283766, 506.8504791086638, 507.3809951858726, 514.904742622616, 519.9246109314129, 461.5499887609554, 470.9034647897173, 493.6125141763698, 531.0865311663932, 550.1472717288187, 7729.149793522708, 7796.298333150044, 7836.568988705562, 7857.607119643995, 7864.41016923733, 452.7034792211107, 522.6890000449727, 523.7355135656545, 546.8332158691637, 576.3976644406605, 3420.264643101695, 3736.9626303736613, 3779.962200378016, 3835.827387767557, 3848.5189351331082, 70174.64912675404, 82953.58523207346, 93774.0, 95407.52296238474, 99576.50211748896, 80574.0, 81679.5916020416, 82237.17762822415, 82361.58819205865, 84287.57856210803, 71504.0, 73418.26581734221, 73805.0, 74544.0, 74642.0, 7106.786796396116, 7237.565746055254, 7347.70609175627, 7433.553986760811, 7456.96271518639, 41798.1640367197, 42329.1534169321, 42848.57151428571, 43268.0, 43935.56064439315, 54753.726231368586, 55243.72378138245, 57815.421845781006, 62837.0, 63247.68376158274, 9245.76885577839, 9466.526673666427, 9561.61753529851, 9605.759856003655, 9663.806723865624, 10668.199885008811, 10693.839592405964, 10798.406087665255, 10853.186011049045, 10922.672319830417, 9600.231981441608, 9800.11798938099, 9815.2147828175, 9846.704598862045, 10016.248781341283, 9507.904920950701, 9975.551100200364, 10073.194144468278, 10080.445575493419, 10117.443540605043, 9246.445213287225, 9314.906850931404, 9483.66807161746, 9521.904780952378, 9558.474283914451, 7978.960105199437, 8101.8379632408205, 8157.55133467665, 8211.09096630163, 8398.286145677686, 7035.577865328097, 7506.812329691801, 7559.20628334017, 7788.337991270805, 7811.609419529114], "value": 6242.640946753948, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 107.0, 113.0, 113.0, 113.0, 115.0, 114.0, 115.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 159.0, 191.0, 129.0, 171.0, 168.0, 144.0, 199.0, 132.0], "value": 157.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 175.0, 164.0, 164.0, 164.0, 163.0, 161.0, 162.0, 160.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 156.0, 76.0, 76.0, 76.0, 75.0, 157.0, 79.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 144.0, 87.0, 86.0, 86.0, 135.0, 87.0, 87.0, 142.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 146.0, 149.0, 148.0, 149.0, 147.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 87.0, 83.0, 83.0, 85.0, 82.0, 87.0, 136.0, 89.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 148.0, 130.0, 130.0, 129.0, 143.0, 136.0, 134.0, 140.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 166.0, 170.0, 177.0, 171.0, 179.0, 169.0, 171.0, 170.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 67.0, 67.0, 66.0, 66.0, 70.0, 65.0, 64.0], "value": 67.1, "unit": "score"}]}]} 11:13:51 INFO - Return code: 0 11:13:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:13:51 ERROR - # TBPL SUCCESS # 11:13:51 INFO - Running post-action listener: _resource_record_post_action 11:13:51 INFO - ##### 11:13:51 INFO - ##### Finished run-tests step (success) 11:13:51 INFO - ##### 11:13:51 INFO - Running post-run listener: _resource_record_post_run 11:13:51 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7913472; Write bytes: 441483264; Read time: 2500; Write time: 341596 11:13:51 INFO - TinderboxPrint: CPU usage
13.4% 11:13:51 INFO - TinderboxPrint: I/O read bytes / time
7,913,472 / 2,500 11:13:51 INFO - TinderboxPrint: I/O write bytes / time
441,483,264 / 341,596 11:13:51 INFO - TinderboxPrint: CPU idle
8,287.2 (86.6%) 11:13:51 INFO - TinderboxPrint: CPU user
1,230.5 (12.9%) 11:13:51 INFO - TinderboxPrint: Swap in / out
0 / 0 11:13:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13221888; Read time: 0; Write time: 6680 11:13:51 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 6148096; Write bytes: 342827008; Read time: 2168; Write time: 258800 11:13:51 INFO - Running post-run listener: _upload_blobber_files 11:13:51 INFO - Blob upload gear active. 11:13:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:13:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:13:51 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:13:51 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:13:52 INFO - (blobuploader) - INFO - Open directory for files ... 11:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:53 INFO - (blobuploader) - INFO - Done attempting. 11:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:54 INFO - (blobuploader) - INFO - Done attempting. 11:13:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:13:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:13:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:58 INFO - (blobuploader) - INFO - Done attempting. 11:13:58 INFO - (blobuploader) - INFO - Iteration through files over. 11:13:58 INFO - Return code: 0 11:13:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:13:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:13:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ebc435994c9dbb033c30afecf54a7223906a5233220e528d69fde13ad1791f690ededd349527606198bcb61790ed8b9c327c525f9593d22672b64c9c4fd38782", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9829a8fb953cdd75590f6d4fba6d2737839051e6426d457f8b523322d08b27b928ebbbd303835a3aae3970993125021780524b56363d8e6af491beb9307a8bc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24a9e594392a4e441e8f4f87e9eb74ba3588018fd9b301aa32d037b3e1cfb1cff53d3b55a760562b23dba0442d9fa374fb6f8ba3b7ec998e5b0d1e1e10102388"} 11:13:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:13:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:13:58 INFO - Contents: 11:13:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ebc435994c9dbb033c30afecf54a7223906a5233220e528d69fde13ad1791f690ededd349527606198bcb61790ed8b9c327c525f9593d22672b64c9c4fd38782", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9829a8fb953cdd75590f6d4fba6d2737839051e6426d457f8b523322d08b27b928ebbbd303835a3aae3970993125021780524b56363d8e6af491beb9307a8bc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24a9e594392a4e441e8f4f87e9eb74ba3588018fd9b301aa32d037b3e1cfb1cff53d3b55a760562b23dba0442d9fa374fb6f8ba3b7ec998e5b0d1e1e10102388"} 11:13:58 INFO - Running post-run listener: copy_logs_to_upload_dir 11:13:58 INFO - Copying logs to upload dir... 11:13:58 INFO - mkdir: /builds/slave/test/build/upload/logs 11:13:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.354270 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-26 11:13:58.713514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 11:13:58.716683) ========= 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=41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602 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-Non-PGO/sha512/ebc435994c9dbb033c30afecf54a7223906a5233220e528d69fde13ad1791f690ededd349527606198bcb61790ed8b9c327c525f9593d22672b64c9c4fd38782", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9829a8fb953cdd75590f6d4fba6d2737839051e6426d457f8b523322d08b27b928ebbbd303835a3aae3970993125021780524b56363d8e6af491beb9307a8bc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24a9e594392a4e441e8f4f87e9eb74ba3588018fd9b301aa32d037b3e1cfb1cff53d3b55a760562b23dba0442d9fa374fb6f8ba3b7ec998e5b0d1e1e10102388"} build_url:https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/U3iffMuOTQyA5F_bSuXyKg/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-Non-PGO/sha512/ebc435994c9dbb033c30afecf54a7223906a5233220e528d69fde13ad1791f690ededd349527606198bcb61790ed8b9c327c525f9593d22672b64c9c4fd38782", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9829a8fb953cdd75590f6d4fba6d2737839051e6426d457f8b523322d08b27b928ebbbd303835a3aae3970993125021780524b56363d8e6af491beb9307a8bc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/24a9e594392a4e441e8f4f87e9eb74ba3588018fd9b301aa32d037b3e1cfb1cff53d3b55a760562b23dba0442d9fa374fb6f8ba3b7ec998e5b0d1e1e10102388"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 11:13:58.742791) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:13:58.743163) ========= 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=41bf3e9aed84707956354da8000001c5-1466947005.834848-1098514602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:13:58.826598) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 11:13:58.826967) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 11:13:58.827313) ========= ========= Total master_lag: 0.72 =========