builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1466030824.62 results: success (0) buildid: 20160615141625 builduid: 0d353c62ef9a412fa6fa4ae5eda92429 revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:04.615824) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:04.616395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:04.616698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:04.693360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:04.693639) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 15:47:04-- 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% 221M=0s 2016-06-15 15:47:05 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.405970 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:05.138264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:05.138586) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.104902 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:05.255535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:05.255905) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c914e1312fd6cede0da6dcaa1c605eaf07849138 --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 c914e1312fd6cede0da6dcaa1c605eaf07849138 --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=78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 15:47:05,463 truncating revision to first 12 chars 2016-06-15 15:47:05,463 Setting DEBUG logging. 2016-06-15 15:47:05,463 attempt 1/10 2016-06-15 15:47:05,463 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c914e1312fd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 15:47:05,786 unpacking tar archive at: fx-team-c914e1312fd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674059 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:05.945001) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:05.945287) ========= script_repo_revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:05.945669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:05.946167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:05.955546) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-15 15:47:05.955906) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:06 INFO - MultiFileLogger online at 20160615 15:47:06 in /builds/slave/test 15:47:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 15:47:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:06 INFO - {'append_to_log': False, 15:47:06 INFO - 'base_work_dir': '/builds/slave/test', 15:47:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:47:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:06 INFO - 'branch': 'Fx-Team-Non-PGO', 15:47:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:06 INFO - 'config_files': ('talos/linux_config.py',), 15:47:06 INFO - 'default_actions': ('clobber', 15:47:06 INFO - 'read-buildbot-config', 15:47:06 INFO - 'download-and-extract', 15:47:06 INFO - 'populate-webroot', 15:47:06 INFO - 'create-virtualenv', 15:47:06 INFO - 'install', 15:47:06 INFO - 'run-tests'), 15:47:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:06 INFO - 'download_minidump_stackwalk': True, 15:47:06 INFO - 'download_symbols': 'ondemand', 15:47:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:06 INFO - 'installer_path': 'installer.exe', 15:47:06 INFO - 'log_level': 'info', 15:47:06 INFO - 'log_name': 'talos', 15:47:06 INFO - 'log_to_console': True, 15:47:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:06 INFO - 'opt_config_files': (), 15:47:06 INFO - 'pip_index': False, 15:47:06 INFO - 'sps_profile': False, 15:47:06 INFO - 'sps_profile_interval': 0, 15:47:06 INFO - 'suite': 'dromaeojs', 15:47:06 INFO - 'system_bits': '32', 15:47:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:06 INFO - 'title': 'talos-linux64-ix-019', 15:47:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:06 INFO - 'use_talos_json': True, 15:47:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:06 INFO - 'work_dir': 'build'} 15:47:06 INFO - ##### 15:47:06 INFO - ##### Running clobber step. 15:47:06 INFO - ##### 15:47:06 INFO - Running pre-action listener: _resource_record_pre_action 15:47:06 INFO - Running main action method: clobber 15:47:06 INFO - rmtree: /builds/slave/test/build 15:47:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:07 INFO - Running post-action listener: _resource_record_post_action 15:47:07 INFO - ##### 15:47:07 INFO - ##### Finished clobber step (success) 15:47:07 INFO - ##### 15:47:07 INFO - ##### 15:47:07 INFO - ##### Running read-buildbot-config step. 15:47:07 INFO - ##### 15:47:07 INFO - Running pre-action listener: _resource_record_pre_action 15:47:07 INFO - Running main action method: read_buildbot_config 15:47:07 INFO - Using buildbot properties: 15:47:07 INFO - { 15:47:07 INFO - "project": "", 15:47:07 INFO - "product": "firefox", 15:47:07 INFO - "script_repo_revision": "production", 15:47:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:47:07 INFO - "repository": "", 15:47:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:47:07 INFO - "buildid": "20160615141625", 15:47:07 INFO - "pgo_build": "False", 15:47:07 INFO - "basedir": "/builds/slave/test", 15:47:07 INFO - "buildnumber": 1764, 15:47:07 INFO - "slavename": "talos-linux64-ix-019", 15:47:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:47:07 INFO - "platform": "ubuntu64_hw", 15:47:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:47:07 INFO - "branch": "fx-team", 15:47:07 INFO - "repo_path": "integration/fx-team", 15:47:07 INFO - "revision": "c914e1312fd6cede0da6dcaa1c605eaf07849138", 15:47:07 INFO - "stage_platform": "linux64", 15:47:07 INFO - "builduid": "0d353c62ef9a412fa6fa4ae5eda92429", 15:47:07 INFO - "slavebuilddir": "test" 15:47:07 INFO - } 15:47:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:47:07 INFO - Running post-action listener: _resource_record_post_action 15:47:07 INFO - ##### 15:47:07 INFO - ##### Finished read-buildbot-config step (success) 15:47:07 INFO - ##### 15:47:07 INFO - ##### 15:47:07 INFO - ##### Running download-and-extract step. 15:47:07 INFO - ##### 15:47:07 INFO - Running pre-action listener: _resource_record_pre_action 15:47:07 INFO - Running main action method: download_and_extract 15:47:07 INFO - mkdir: /builds/slave/test/build/tests 15:47: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')]} 15:47:07 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:47:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:09 INFO - Downloaded 1361 bytes. 15:47:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:09 INFO - Using the following test package requirements: 15:47:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:47:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:09 INFO - u'jsshell-linux-x86_64.zip'], 15:47:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:47:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:47:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:09 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')]} 15:47:09 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:13 INFO - Downloaded 22654307 bytes. 15:47:13 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'] 15:47:13 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 15:47:15 INFO - Return code: 0 15:47:15 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 15:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:15 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:18 INFO - Downloaded 22654307 bytes. 15:47:18 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'] 15:47:18 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 15:47:19 INFO - Return code: 0 15:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:19 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:47:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:20 INFO - Downloaded 14405384 bytes. 15:47:20 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'] 15:47:20 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 15:47:20 INFO - Return code: 0 15:47: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')]} 15:47:20 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/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 15:47:22 INFO - Downloaded 55438461 bytes. 15:47:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:47:22 INFO - mkdir: /builds/slave/test/properties 15:47:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:47:22 INFO - Writing to file /builds/slave/test/properties/build_url 15:47:22 INFO - Contents: 15:47:22 INFO - build_url:https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:47:24 INFO - Running post-action listener: _resource_record_post_action 15:47:24 INFO - Running post-action listener: set_extra_try_arguments 15:47:24 INFO - ##### 15:47:24 INFO - ##### Finished download-and-extract step (success) 15:47:24 INFO - ##### 15:47:24 INFO - ##### 15:47:24 INFO - ##### Running populate-webroot step. 15:47:24 INFO - ##### 15:47:24 INFO - Running pre-action listener: _resource_record_pre_action 15:47:24 INFO - Running main action method: populate_webroot 15:47:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:47:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:47:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:47:24 INFO - '--tppagecycles', 15:47:24 INFO - '7'], 15:47:24 INFO - 'tests': ['tsvgm']}}, 15:47:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:47:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:47:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:47:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:47:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['damp', 'tps']}, 15:47:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'tests': ['damp', 'tps']}, 15:47:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['dromaeo_dom']}, 15:47:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['basic_compositor_video']}, 15:47:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:47:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['tsvgx', 15:47:24 INFO - 'tsvgr_opacity', 15:47:24 INFO - 'tart', 15:47:24 INFO - 'tscrollx', 15:47:24 INFO - 'cart']}, 15:47:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:47:24 INFO - 'tsvgr_opacity', 15:47:24 INFO - 'tart', 15:47:24 INFO - 'tscrollx', 15:47:24 INFO - 'cart']}, 15:47:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['tp5o']}, 15:47:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'tests': ['tp5o']}, 15:47:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--disable-e10s', 15:47:24 INFO - '--xperf_path', 15:47:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:24 INFO - 'tests': ['tp5n']}, 15:47:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--xperf_path', 15:47:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:24 INFO - 'tests': ['tp5n']}}, 15:47:24 INFO - 'talos.zip': {'path': '', 15:47:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:47:24 INFO - Running post-action listener: _resource_record_post_action 15:47:24 INFO - ##### 15:47:24 INFO - ##### Finished populate-webroot step (success) 15:47:24 INFO - ##### 15:47:24 INFO - ##### 15:47:24 INFO - ##### Running create-virtualenv step. 15:47:24 INFO - ##### 15:47:24 INFO - Running pre-action listener: _resource_record_pre_action 15:47:24 INFO - Running main action method: create_virtualenv 15:47:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:47: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 15:47:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:47:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:24 INFO - Using real prefix '/usr' 15:47:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:47:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:27 INFO - Installing pip.................done. 15:47:27 INFO - Return code: 0 15:47:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47: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 15:47: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 15:47:27 INFO - Using env: {'DISPLAY': ':0', 15:47:27 INFO - 'HOME': '/home/cltbld', 15:47:27 INFO - 'LANG': 'en_US.UTF-8', 15:47:27 INFO - 'LANGUAGE': 'en_US:en', 15:47:27 INFO - 'LOGNAME': 'cltbld', 15:47:27 INFO - 'MAIL': '/var/mail/cltbld', 15:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:27 INFO - 'MOZ_NO_REMOTE': '1', 15:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:27 INFO - 'NO_EM_RESTART': '1', 15:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:27 INFO - 'PWD': '/builds/slave/test', 15:47:27 INFO - 'SHELL': '/bin/bash', 15:47:27 INFO - 'SHLVL': '1', 15:47:27 INFO - 'TERM': 'linux', 15:47:27 INFO - 'TMOUT': '86400', 15:47:27 INFO - 'USER': 'cltbld', 15:47:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:27 INFO - '_': '/tools/buildbot/bin/python'} 15:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47: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 15:47:27 INFO - Cleaning up... 15:47:27 INFO - Return code: 0 15:47:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47: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 15:47: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 15:47:27 INFO - Using env: {'DISPLAY': ':0', 15:47:27 INFO - 'HOME': '/home/cltbld', 15:47:27 INFO - 'LANG': 'en_US.UTF-8', 15:47:27 INFO - 'LANGUAGE': 'en_US:en', 15:47:27 INFO - 'LOGNAME': 'cltbld', 15:47:27 INFO - 'MAIL': '/var/mail/cltbld', 15:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:27 INFO - 'MOZ_NO_REMOTE': '1', 15:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:27 INFO - 'NO_EM_RESTART': '1', 15:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:27 INFO - 'PWD': '/builds/slave/test', 15:47:27 INFO - 'SHELL': '/bin/bash', 15:47:27 INFO - 'SHLVL': '1', 15:47:27 INFO - 'TERM': 'linux', 15:47:27 INFO - 'TMOUT': '86400', 15:47:27 INFO - 'USER': 'cltbld', 15:47:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:27 INFO - '_': '/tools/buildbot/bin/python'} 15:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:27 INFO - Downloading/unpacking psutil>=3.1.1 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:29 INFO - Installing collected packages: psutil 15:47:29 INFO - Running setup.py install for psutil 15:47:29 INFO - building 'psutil._psutil_linux' extension 15:47:29 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 15:47:30 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 15:47:30 INFO - building 'psutil._psutil_posix' extension 15:47:30 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 15:47:30 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 15:47:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:31 INFO - Successfully installed psutil 15:47:31 INFO - Cleaning up... 15:47:31 INFO - Return code: 0 15:47:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47: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 15:47: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 15:47:31 INFO - Using env: {'DISPLAY': ':0', 15:47:31 INFO - 'HOME': '/home/cltbld', 15:47:31 INFO - 'LANG': 'en_US.UTF-8', 15:47:31 INFO - 'LANGUAGE': 'en_US:en', 15:47:31 INFO - 'LOGNAME': 'cltbld', 15:47:31 INFO - 'MAIL': '/var/mail/cltbld', 15:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:31 INFO - 'MOZ_NO_REMOTE': '1', 15:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:31 INFO - 'NO_EM_RESTART': '1', 15:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:31 INFO - 'PWD': '/builds/slave/test', 15:47:31 INFO - 'SHELL': '/bin/bash', 15:47:31 INFO - 'SHLVL': '1', 15:47:31 INFO - 'TERM': 'linux', 15:47:31 INFO - 'TMOUT': '86400', 15:47:31 INFO - 'USER': 'cltbld', 15:47:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:31 INFO - '_': '/tools/buildbot/bin/python'} 15:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:47:33 INFO - Installing collected packages: mozsystemmonitor 15:47:33 INFO - Running setup.py install for mozsystemmonitor 15:47:33 INFO - Successfully installed mozsystemmonitor 15:47:33 INFO - Cleaning up... 15:47:33 INFO - Return code: 0 15:47:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:33 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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47:33 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 15:47:33 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 15:47:33 INFO - Using env: {'DISPLAY': ':0', 15:47:33 INFO - 'HOME': '/home/cltbld', 15:47:33 INFO - 'LANG': 'en_US.UTF-8', 15:47:33 INFO - 'LANGUAGE': 'en_US:en', 15:47:33 INFO - 'LOGNAME': 'cltbld', 15:47:33 INFO - 'MAIL': '/var/mail/cltbld', 15:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:33 INFO - 'MOZ_NO_REMOTE': '1', 15:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:33 INFO - 'NO_EM_RESTART': '1', 15:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:33 INFO - 'PWD': '/builds/slave/test', 15:47:33 INFO - 'SHELL': '/bin/bash', 15:47:33 INFO - 'SHLVL': '1', 15:47:33 INFO - 'TERM': 'linux', 15:47:33 INFO - 'TMOUT': '86400', 15:47:33 INFO - 'USER': 'cltbld', 15:47:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:33 INFO - '_': '/tools/buildbot/bin/python'} 15:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:33 INFO - Downloading/unpacking jsonschema==2.5.1 15:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:47:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:47:35 INFO - warning: no files found matching '*.txt' 15:47:35 INFO - no previously-included directories found matching 'build' 15:47:35 INFO - no previously-included directories found matching 'dist' 15:47:35 INFO - no previously-included directories found matching '.git*' 15:47:35 INFO - Installing collected packages: jsonschema, functools32 15:47:35 INFO - Running setup.py install for functools32 15:47:35 INFO - warning: no files found matching '*.txt' 15:47:35 INFO - no previously-included directories found matching 'build' 15:47:35 INFO - no previously-included directories found matching 'dist' 15:47:35 INFO - no previously-included directories found matching '.git*' 15:47:35 INFO - Successfully installed jsonschema functools32 15:47:35 INFO - Cleaning up... 15:47:35 INFO - Return code: 0 15:47:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:47:35 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')]} 15:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:35 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')]} 15:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:35 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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47:35 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 15:47:35 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 15:47:35 INFO - Using env: {'DISPLAY': ':0', 15:47:35 INFO - 'HOME': '/home/cltbld', 15:47:35 INFO - 'LANG': 'en_US.UTF-8', 15:47:35 INFO - 'LANGUAGE': 'en_US:en', 15:47:35 INFO - 'LOGNAME': 'cltbld', 15:47:35 INFO - 'MAIL': '/var/mail/cltbld', 15:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:35 INFO - 'MOZ_NO_REMOTE': '1', 15:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:35 INFO - 'NO_EM_RESTART': '1', 15:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:35 INFO - 'PWD': '/builds/slave/test', 15:47:35 INFO - 'SHELL': '/bin/bash', 15:47:35 INFO - 'SHLVL': '1', 15:47:35 INFO - 'TERM': 'linux', 15:47:35 INFO - 'TMOUT': '86400', 15:47:35 INFO - 'USER': 'cltbld', 15:47:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:35 INFO - '_': '/tools/buildbot/bin/python'} 15:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:47:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:38 INFO - Downloading docopt-0.6.1.tar.gz 15:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:38 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:38 INFO - Running setup.py install for blobuploader 15:47:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:47:38 INFO - Running setup.py install for requests 15:47:39 INFO - Running setup.py install for docopt 15:47:39 INFO - Successfully installed blobuploader requests docopt 15:47:39 INFO - Cleaning up... 15:47:39 INFO - Return code: 0 15:47:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:39 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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47:39 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 15:47:39 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 15:47:39 INFO - Using env: {'DISPLAY': ':0', 15:47:39 INFO - 'HOME': '/home/cltbld', 15:47:39 INFO - 'LANG': 'en_US.UTF-8', 15:47:39 INFO - 'LANGUAGE': 'en_US:en', 15:47:39 INFO - 'LOGNAME': 'cltbld', 15:47:39 INFO - 'MAIL': '/var/mail/cltbld', 15:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:39 INFO - 'MOZ_NO_REMOTE': '1', 15:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:39 INFO - 'NO_EM_RESTART': '1', 15:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:39 INFO - 'PWD': '/builds/slave/test', 15:47:39 INFO - 'SHELL': '/bin/bash', 15:47:39 INFO - 'SHLVL': '1', 15:47:39 INFO - 'TERM': 'linux', 15:47:39 INFO - 'TMOUT': '86400', 15:47:39 INFO - 'USER': 'cltbld', 15:47:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:39 INFO - '_': '/tools/buildbot/bin/python'} 15:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:39 INFO - Running setup.py (path:/tmp/pip-6mjY6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:39 INFO - Running setup.py (path:/tmp/pip-XTG5rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:39 INFO - Running setup.py (path:/tmp/pip-ZMHjbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:39 INFO - Running setup.py (path:/tmp/pip-1pwIHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:39 INFO - Running setup.py (path:/tmp/pip-4F5RcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:40 INFO - Running setup.py (path:/tmp/pip-yociWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:40 INFO - Running setup.py (path:/tmp/pip-7aFBxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:40 INFO - Running setup.py (path:/tmp/pip-B95fy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:40 INFO - Running setup.py (path:/tmp/pip-4RLyTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:40 INFO - Running setup.py (path:/tmp/pip-aCTdTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:40 INFO - Running setup.py (path:/tmp/pip-dZsvjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:40 INFO - Running setup.py (path:/tmp/pip-82tEVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:40 INFO - Running setup.py (path:/tmp/pip-JvPEp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:40 INFO - Running setup.py (path:/tmp/pip-CXzANp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:40 INFO - Running setup.py (path:/tmp/pip-V5djbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:40 INFO - Running setup.py (path:/tmp/pip-QpYfHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:40 INFO - Running setup.py (path:/tmp/pip-wfLD9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:40 INFO - Running setup.py install for manifestparser 15:47:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:47:40 INFO - Running setup.py install for mozcrash 15:47:41 INFO - Running setup.py install for mozdebug 15:47:41 INFO - Running setup.py install for mozdevice 15:47:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozfile 15:47:41 INFO - Running setup.py install for mozhttpd 15:47:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozinfo 15:47:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozInstall 15:47:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozleak 15:47:41 INFO - Running setup.py install for mozlog 15:47:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for moznetwork 15:47:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:47:42 INFO - Running setup.py install for mozprocess 15:47:42 INFO - Running setup.py install for mozprofile 15:47:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:47:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:47:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:47:42 INFO - Running setup.py install for mozrunner 15:47:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:47:42 INFO - Running setup.py install for mozscreenshot 15:47:42 INFO - Running setup.py install for moztest 15:47:42 INFO - Running setup.py install for mozversion 15:47:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:47:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:47:42 INFO - Cleaning up... 15:47:42 INFO - Return code: 0 15:47:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:42 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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47:42 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 15:47:42 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 15:47:42 INFO - Using env: {'DISPLAY': ':0', 15:47:42 INFO - 'HOME': '/home/cltbld', 15:47:42 INFO - 'LANG': 'en_US.UTF-8', 15:47:42 INFO - 'LANGUAGE': 'en_US:en', 15:47:42 INFO - 'LOGNAME': 'cltbld', 15:47:42 INFO - 'MAIL': '/var/mail/cltbld', 15:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:42 INFO - 'MOZ_NO_REMOTE': '1', 15:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:42 INFO - 'NO_EM_RESTART': '1', 15:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:42 INFO - 'PWD': '/builds/slave/test', 15:47:42 INFO - 'SHELL': '/bin/bash', 15:47:42 INFO - 'SHLVL': '1', 15:47:42 INFO - 'TERM': 'linux', 15:47:42 INFO - 'TMOUT': '86400', 15:47:42 INFO - 'USER': 'cltbld', 15:47:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:42 INFO - '_': '/tools/buildbot/bin/python'} 15:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:42 INFO - Running setup.py (path:/tmp/pip-Rr1JtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:42 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)) 15:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:42 INFO - Running setup.py (path:/tmp/pip-26Xo0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47: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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:43 INFO - Running setup.py (path:/tmp/pip-PREbBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47: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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:43 INFO - Running setup.py (path:/tmp/pip-PaFFDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47: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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:43 INFO - Running setup.py (path:/tmp/pip-OzpoFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47: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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:43 INFO - Running setup.py (path:/tmp/pip-7Dbizz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47: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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:43 INFO - Running setup.py (path:/tmp/pip-doBGrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:43 INFO - Running setup.py (path:/tmp/pip-HEvF0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:43 INFO - Running setup.py (path:/tmp/pip-hQkk9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:43 INFO - Running setup.py (path:/tmp/pip-F4C_Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:43 INFO - Running setup.py (path:/tmp/pip-jGh3ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:43 INFO - Running setup.py (path:/tmp/pip-YxRGKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:43 INFO - Running setup.py (path:/tmp/pip-gECbHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:43 INFO - Running setup.py (path:/tmp/pip-9tDbQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:43 INFO - Running setup.py (path:/tmp/pip-Dt7c7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:43 INFO - Running setup.py (path:/tmp/pip-ugVnV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47: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)) 15:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:44 INFO - Running setup.py (path:/tmp/pip-TJUOxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47: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)) 15:47: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)) 15:47: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)) 15:47: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)) 15:47: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)) 15:47: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)) 15:47:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:45 INFO - Downloading blessings-1.6.tar.gz 15:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:47:46 INFO - Installing collected packages: blessings 15:47:46 INFO - Running setup.py install for blessings 15:47:46 INFO - Successfully installed blessings 15:47:46 INFO - Cleaning up... 15:47:46 INFO - Return code: 0 15:47:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:47:46 INFO - Reading from file tmpfile_stdout 15:47:46 INFO - Current package versions: 15:47:46 INFO - argparse == 1.2.1 15:47:46 INFO - blessings == 1.6 15:47:46 INFO - blobuploader == 1.2.4 15:47:46 INFO - docopt == 0.6.1 15:47:46 INFO - functools32 == 3.2.3-2 15:47:46 INFO - jsonschema == 2.5.1 15:47:46 INFO - manifestparser == 1.1 15:47:46 INFO - mozInstall == 1.12 15:47:46 INFO - mozcrash == 0.17 15:47:46 INFO - mozdebug == 0.1 15:47:46 INFO - mozdevice == 0.48 15:47:46 INFO - mozfile == 1.2 15:47:46 INFO - mozhttpd == 0.7 15:47:46 INFO - mozinfo == 0.9 15:47:46 INFO - mozleak == 0.1 15:47:46 INFO - mozlog == 3.2 15:47:46 INFO - moznetwork == 0.27 15:47:46 INFO - mozprocess == 0.22 15:47:46 INFO - mozprofile == 0.28 15:47:46 INFO - mozrunner == 6.11 15:47:46 INFO - mozscreenshot == 0.1 15:47:46 INFO - mozsystemmonitor == 0.3 15:47:46 INFO - moztest == 0.7 15:47:46 INFO - mozversion == 1.4 15:47:46 INFO - psutil == 3.1.1 15:47:46 INFO - requests == 1.2.3 15:47:46 INFO - wsgiref == 0.1.2 15:47:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47:46 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 15:47:46 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 15:47:46 INFO - Using env: {'DISPLAY': ':0', 15:47:46 INFO - 'HOME': '/home/cltbld', 15:47:46 INFO - 'LANG': 'en_US.UTF-8', 15:47:46 INFO - 'LANGUAGE': 'en_US:en', 15:47:46 INFO - 'LOGNAME': 'cltbld', 15:47:46 INFO - 'MAIL': '/var/mail/cltbld', 15:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:46 INFO - 'MOZ_NO_REMOTE': '1', 15:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:46 INFO - 'NO_EM_RESTART': '1', 15:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:46 INFO - 'PWD': '/builds/slave/test', 15:47:46 INFO - 'SHELL': '/bin/bash', 15:47:46 INFO - 'SHLVL': '1', 15:47:46 INFO - 'TERM': 'linux', 15:47:46 INFO - 'TMOUT': '86400', 15:47:46 INFO - 'USER': 'cltbld', 15:47:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:46 INFO - '_': '/tools/buildbot/bin/python'} 15:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 INFO - Cleaning up... 15:47:46 INFO - Return code: 0 15:47:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47:46 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 15:47:46 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 15:47:46 INFO - Using env: {'DISPLAY': ':0', 15:47:46 INFO - 'HOME': '/home/cltbld', 15:47:46 INFO - 'LANG': 'en_US.UTF-8', 15:47:46 INFO - 'LANGUAGE': 'en_US:en', 15:47:46 INFO - 'LOGNAME': 'cltbld', 15:47:46 INFO - 'MAIL': '/var/mail/cltbld', 15:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:46 INFO - 'MOZ_NO_REMOTE': '1', 15:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:46 INFO - 'NO_EM_RESTART': '1', 15:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:46 INFO - 'PWD': '/builds/slave/test', 15:47:46 INFO - 'SHELL': '/bin/bash', 15:47:46 INFO - 'SHLVL': '1', 15:47:46 INFO - 'TERM': 'linux', 15:47:46 INFO - 'TMOUT': '86400', 15:47:46 INFO - 'USER': 'cltbld', 15:47:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:46 INFO - '_': '/tools/buildbot/bin/python'} 15:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:47:46 INFO - Cleaning up... 15:47:46 INFO - Return code: 0 15:47:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 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 0x7fe062e53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', '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 15:47:46 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 15:47:46 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 15:47:46 INFO - Using env: {'DISPLAY': ':0', 15:47:46 INFO - 'HOME': '/home/cltbld', 15:47:46 INFO - 'LANG': 'en_US.UTF-8', 15:47:46 INFO - 'LANGUAGE': 'en_US:en', 15:47:46 INFO - 'LOGNAME': 'cltbld', 15:47:46 INFO - 'MAIL': '/var/mail/cltbld', 15:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:46 INFO - 'MOZ_NO_REMOTE': '1', 15:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:46 INFO - 'NO_EM_RESTART': '1', 15:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:46 INFO - 'PWD': '/builds/slave/test', 15:47:46 INFO - 'SHELL': '/bin/bash', 15:47:46 INFO - 'SHLVL': '1', 15:47:46 INFO - 'TERM': 'linux', 15:47:46 INFO - 'TMOUT': '86400', 15:47:46 INFO - 'USER': 'cltbld', 15:47:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:46 INFO - '_': '/tools/buildbot/bin/python'} 15:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:47 INFO - Downloading/unpacking flake8 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:47:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:47:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:47:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:47:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:47:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:47:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:47:49 INFO - no previously-included directories found matching 'docs/_build' 15:47:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:47:49 INFO - Running setup.py install for pep8 15:47:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:47:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:47:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:47:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:47:49 INFO - no previously-included directories found matching 'docs/_build' 15:47:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:47:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:47:49 INFO - Cleaning up... 15:47:50 INFO - Return code: 0 15:47:50 INFO - Running post-action listener: _resource_record_post_action 15:47:50 INFO - Running post-action listener: _start_resource_monitoring 15:47:50 INFO - Starting resource monitoring. 15:47:50 INFO - ##### 15:47:50 INFO - ##### Finished create-virtualenv step (success) 15:47:50 INFO - ##### 15:47:50 INFO - ##### 15:47:50 INFO - ##### Running install step. 15:47:50 INFO - ##### 15:47:50 INFO - Running pre-action listener: _resource_record_pre_action 15:47:50 INFO - Running main action method: install 15:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:47:50 INFO - Reading from file tmpfile_stdout 15:47:50 INFO - Detecting whether we're running mozinstall >=1.0... 15:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:47:50 INFO - Reading from file tmpfile_stdout 15:47:50 INFO - Output received: 15:47:50 INFO - Usage: mozinstall [options] installer 15:47:50 INFO - Options: 15:47:50 INFO - -h, --help show this help message and exit 15:47:50 INFO - -d DEST, --destination=DEST 15:47:50 INFO - Directory to install application into. [default: 15:47:50 INFO - "/builds/slave/test"] 15:47:50 INFO - --app=APP Application being installed. [default: firefox] 15:47:50 INFO - mkdir: /builds/slave/test/build/application 15:47: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'] 15:47: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 15:48:06 INFO - Reading from file tmpfile_stdout 15:48:06 INFO - Output received: 15:48:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:06 INFO - Running post-action listener: _resource_record_post_action 15:48:06 INFO - ##### 15:48:06 INFO - ##### Finished install step (success) 15:48:06 INFO - ##### 15:48:06 INFO - ##### 15:48:06 INFO - ##### Running run-tests step. 15:48:06 INFO - ##### 15:48:06 INFO - Running pre-action listener: _resource_record_pre_action 15:48:06 INFO - Running main action method: run_tests 15:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:06 INFO - Python 2.7.3 15:48:06 INFO - Return code: 0 15:48:06 INFO - grabbing minidump binary from tooltool 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:06 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 0xebf1c0>, '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 0xec00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec0550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:06 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 15:48:06 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 15:48:06 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 15:48:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:06 INFO - Return code: 0 15:48:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:48:07 INFO - Return code: 0 15:48:07 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:48:07 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:48:07 INFO - Using env: {'DISPLAY': ':0', 15:48:07 INFO - 'HOME': '/home/cltbld', 15:48:07 INFO - 'LANG': 'en_US.UTF-8', 15:48:07 INFO - 'LANGUAGE': 'en_US:en', 15:48:07 INFO - 'LOGNAME': 'cltbld', 15:48:07 INFO - 'MAIL': '/var/mail/cltbld', 15:48:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:07 INFO - 'MOZ_NO_REMOTE': '1', 15:48:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:07 INFO - 'NO_EM_RESTART': '1', 15:48:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:07 INFO - 'PWD': '/builds/slave/test', 15:48:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:07 INFO - 'SHELL': '/bin/bash', 15:48:07 INFO - 'SHLVL': '1', 15:48:07 INFO - 'TERM': 'linux', 15:48:07 INFO - 'TMOUT': '86400', 15:48:07 INFO - 'USER': 'cltbld', 15:48:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529', 15:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:07 INFO - '_': '/tools/buildbot/bin/python'} 15:48:07 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:48:07 INFO - mozversion application_buildid: 20160615141625 15:48:07 INFO - mozversion application_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 15:48:07 INFO - mozversion application_display_name: Nightly 15:48:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:07 INFO - mozversion application_name: Firefox 15:48:07 INFO - mozversion application_remotingname: firefox 15:48:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:48:07 INFO - mozversion application_vendor: Mozilla 15:48:07 INFO - mozversion application_version: 50.0a1 15:48:07 INFO - mozversion platform_buildid: 20160615141625 15:48:07 INFO - mozversion platform_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 15:48:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:48:07 INFO - mozversion platform_version: 50.0a1 15:48:07 INFO - using testdate: 1466030887 15:48:07 INFO - actual date: 1466030887 15:48:07 INFO - starting webserver on 'localhost:44319' 15:48:07 INFO - SUITE-START | Running 2 tests 15:48:07 INFO - TEST-START | dromaeo_css 15:48:07 INFO - operating with platform_type : linux_ 15:48:07 INFO - Initialising browser for dromaeo_css test... 15:48:07 INFO - TEST-INFO | started process 3342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgYfS4N/profile http://localhost:44319/getInfo.html) 15:48:13 INFO - PROCESS | 3342 | __metrics Screen width/height:1600/1200 15:48:13 INFO - PROCESS | 3342 | colorDepth:24 15:48:13 INFO - PROCESS | 3342 | Browser inner width/height: 1024/697 15:48:13 INFO - PROCESS | 3342 | __metrics 15:48:14 INFO - PROCESS | 3342 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:14 INFO - PROCESS | 3342 | console.error: PushService: 15:48:14 INFO - PROCESS | 3342 | stateChangeProcessEnqueue: Error transitioning state 15:48:14 INFO - PROCESS | 3342 | UnknownError 15:48:15 INFO - TEST-INFO | 3342: exit 0 15:48:15 INFO - Browser initialized. 15:48:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:15 INFO - TEST-INFO | started process 3424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgYfS4N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:27 INFO - PROCESS | 3424 | RSS: Main: 175792128 15:48:27 INFO - PROCESS | 3424 | 15:49:18 INFO - PROCESS | 3424 | 1466030958204 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] 15:51:31 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:44319/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44319/tests/dromaeo/cssquery-ext.html) 15:51:32 INFO - PROCESS | 3424 | RSS: Main: 290586624 15:51:32 INFO - PROCESS | 3424 | 15:54:35 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:44319/tests/dromaeo/cssquery-ext.html (next: http://localhost:44319/tests/dromaeo/cssquery-jquery.html) 15:54:35 INFO - PROCESS | 3424 | RSS: Main: 258781184 15:54:35 INFO - PROCESS | 3424 | 15:57:37 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:44319/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44319/tests/dromaeo/cssquery-mootools.html) 15:57:38 INFO - PROCESS | 3424 | RSS: Main: 254275584 15:57:38 INFO - PROCESS | 3424 | 16:00:40 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:44319/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44319/tests/dromaeo/cssquery-prototype.html) 16:00:41 INFO - PROCESS | 3424 | RSS: Main: 253431808 16:00:41 INFO - PROCESS | 3424 | 16:03:44 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:44319/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44319/tests/dromaeo/cssquery-yui.html) 16:03:45 INFO - PROCESS | 3424 | RSS: Main: 226131968 16:03:45 INFO - PROCESS | 3424 | 16:06:47 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:44319/tests/dromaeo/cssquery-yui.html (next: http://localhost:44319/tests/dromaeo/cssquery-dojo.html) 16:06:48 INFO - PROCESS | 3424 | RSS: Main: 293425152 16:06:48 INFO - PROCESS | 3424 | 16:06:48 INFO - PROCESS | 3424 | __start_tp_report 16:06:48 INFO - PROCESS | 3424 | _x_x_mozilla_page_load 16:06:48 INFO - PROCESS | 3424 | _x_x_mozilla_page_load_details 16:06:48 INFO - PROCESS | 3424 | |i|pagename|runs| 16:06:48 INFO - PROCESS | 3424 | |0;dojo.html;2614.0981361430304;2625.212436269119;2649.854258015809;2661.401184733435;2665.6934452537953;4608.377868987685;4668.369770081038;4691.366665500156;4753.952460475394;4793.161196790561;4689.788959496822;4769.332293478916;4779.856604301868;4818;4881.145799485093;4363.236433624119;4411.911761764763;4415.22733521634;4415.249407600716;4483.663725220622;4419.580139886705;4439.689221754478;4478.596926276651;4496.392986946769;4497.64018878489;4248.065425606362;4269.060806622538;4272.636825869805;4313.09425020746;4373.956260437402;4312.396264522969;4375.912481750347;4406.801693923749;4408.691391602589;4411.536788637179;4362.825486980517;4374.671899607511;4374.759388233646;4418.734875907456;4426.18115648606;4529.5243999380245;4720.95279047212;4751.287306903958;4776.25967974961;4809.398825146856;5136.9743151284;5203.5837133029645;5218.791248350061;5222.190560463135;5226.92159617606;5248.134057880445;5252.894942101137;5257.631965762398;5258.211268309746;5259.605529585258;4640.327152562927;4778;4835.443923948791;4837.854864354075;4882.414110306786;5363.490468405574;5367.1680889462195;5402.972985135049;5407.594430417735;5422.8373148805595;5126.769295381717;5155.587552995751;5157.329547158845;5175.378954525481;5176.922346164811;4925.581325587365;4969.527894849984;5012.774425150877;5016.724080175552;5245.763940622681;5015.348004759431;5015.799368025311;5019.121653710659;5040.47075057121;5044.722540260321;4965.35450391454;4968.776405061781;4972.900541989212;5006.374203224597;5033.6224783141415;4235.4917409911;4266.466691663542;4292.59220374064;4293.742375457483;4335.544767799335;3772.5472943246436;3782.167923056923;3800.1069748609057;3822.636849499293;3876.6511014008875;4365.694401391872;4380.342948557742;4384.671149663788;4424.203643344229;4427.26950053244;4995.700257984533;5039.244113383022;5089.389273287229;5134.127198376285;5191.610629202825;4337.783110844445;4355.237833379146;4357.869263922087;4390.4511936008;4400.317950717644;4582.175208462442;4592.311153327028;4595.6783025187915;4602.792874320597;4644.883877903079;4568.360429539934;4758.405199350151;4789.44921334051;4838.225883858566;4841.806327746851;5191.402988656353;5194.68831870089;5203.973980130075;5205.895882082413;5233.267342572119;4864.318995340726;4864.708117512961;4865.416150062015;4897;4904.92642610354;4876.366072410564;5025;5031.22016087507;5059.747012649426;5101.8724531887;5130.050940575856;5150.845474635617;5165;5169.276301317744;5209.817656382009;4897.90204195907;5001.974990125172;5016.749162541785;5022.397312322545;5027.84916452507;4853.369062021915;4877.780499877443;4900.289458028495;4902.2156454967035;4922;4854.63590230727;4923.507649235048;4928.654994150518;4933.9013219736125;4937.703737775745;4828;4979.850604481871;4988.925166122439;4994.775235114501;5033.144365457808;4807.302941073455;4852.272159176011;4873.390826146731;4930.802767889388;4936.086823937583 16:06:48 INFO - PROCESS | 3424 | |1;ext.html;526.0215149956388;561.6686155168451;579.3800633322347;583.0467186150643;597.8355952113168;26641.200763977064;38835;39008.804955975254;39035.60964390359;39309.80345098278;41142.177156456855;41466.7926660367;41477.58522414775;41682.37476437856;41693.791531042305;7697.268759467842;7835.647395867171;7836.608169591526;7838.686452541891;7839.490433121858;7878.409119316046;7944.880826787603;7969.282764551189;7969.641366138538;7972.800679982989;7909.525428474281;7930.325922296612;7958.602069896482;7958.721444749435;7963.72126975556;7888.842223155533;7911.762647120596;7929.207079292082;7933.682652693886;7938.126806051329;7624.656890439888;7669.041369828771;7676.692932282758;7681.731139410093;7682.116556595951;38961.41557876634;39309.60690393088;39384.21231575381;39393.80303098466;39398.80300598507;3007.233155545344;3137.654857965622;3161.1148878314107;3172.191091271711;3212.759043071779;30037.549436758465;30133.849330753426;30148.698513015028;30204;30870.691293087006;3538.575370955476;3544.3088597723195;3561.9696772839493;3573.338932297533;3626.909327266813;237291.76249424918;237997;238514;239376;239942;31525.684743152735;51457.48542514602;51985.48014519807;51992.22011669828;52125.47874521282;33959;34096.82951585226;34139.82930085334;34160.829195854356;34169.65830341714;13014.284214368112;13134.73730525384;13144.211347319191;13146.4084116215;13151.60545183646;10701.304415213142;10766.56933722658;10770.461476926122;10776.084032857296;10801.405922674328;7890.723824666109;7895.684172633145;7907.881381779278;7985.2014798519685;7985.68057277714;3122.3286993296097;3125.1718294651937;3134.5925029745986;3156.98421507891;3174.4286028514625;808;856.1908995998846;862.1895418306772;879.6349514951223;923.9445633261892;27481.587776183373;29946.30483256474;31591.36817263642;31869.406529673422;32316.19209519781;800.6797281087495;939.4222553129775;950.396498223633;952.2191802721702;991.1822746234385;13770.586882393543;14039.508617198553;14093.85906140946;14216.119796741372;14266.215358155401;380510;381038;383826;384461;384702;47297.763511182915;47882.28176577354;47963;47981.280280795814;47985;1090.460222190021;1167.1654766841748;1202.0804084875078;1202.1464760020308;1211.8669044443473;27411.451770964868;28175.15474535767;28398.43203135967;28613.46083118797;29192;41187.1762564753;41647.58352416437;41800.79099604482;41842.372364413946;41846.37230441485;309696;312390;312913;313276;313391;22052.669209962183;23843.761562384156;24528.01887924463;24720.258392248263;26035.73964260333;41000.58999410087;41167.794161029;41439.79280103701;41639;42100.36849447322;35669.1082722934;35711.46432803458;35844.103897402776;36341.636583634885;36457.63542364542;35102;35535.46696799498;35538.289234215685;35593.82203088968;35748.106297342776;34246;34803;35154.64845351616;35577.46633800547;35714;30712.84643576768;31630.841845790623;31997.8400107998;32472.35055298928;34101.48847767335;25341.61987570151;25365.239042828744;25413.74586254114;25660.871695641403;25777.355566110247 16:06:48 INFO - PROCESS | 3424 | |2;jquery.html;351.12744829099677;357.88368780146453;358.48020370462837;377.33588883564954;382.0410768969885;15523.146226957513;17097.23062462189;17308.221130049147;17659;17809.198586063627;16111;16480.175991200453;17359.47921562352;17407.390741324056;17448.47654570362;4912.92630610542;5146.922796158061;5151.278820965068;5195;5195.116830138866;3695.113172838513;3831.04223944014;5053.67151135175;5716.857078573048;6017.789377371793;6006.639601623895;6010.489108425789;6018.6990650467305;6029.577929544934;6036.667983260919;5686.289213848269;5967.671778052206;5976.103584462344;5982.491488223506;5986.161937328778;3323.3187196624635;4907.803687852482;5224.085784987612;5269.473052694738;5280.551153151987;20416.285430009877;20495.077721502566;20613.175472981064;20630.17479300826;20638.690419643717;2024.230792298917;2037.7147199392098;2150.430136013942;2236.4856083100817;2454.239185852374;13242.404091815892;13274.86725132746;13335.533256336079;13391.129576577589;13843.30783460823;1725.6031112843991;1798.145880706667;1807.412590907947;1827.4426299978634;1849.6763066463316;63338.199708017666;63381.51401672906;63522.364776352566;64292.35707642957;65598.67200664013;9005.819883602291;9127.269818414643;9291.628334866666;9351.953240233892;9401.811963760687;12631.810522842165;12827.743445131046;12891.742165156644;12895.742085158245;12953.222806631633;6494.772682956074;6540.8364790880605;6605.207375115017;6700.162479690039;6728.562643428161;6195.783147589813;6264.467520260738;6313.779017734358;6393.552451328363;6404.48764098871;6151.169592105009;6152.846178845564;6221.657808820558;6275.121482992385;6383.4574061204385;1572.944946926852;1644.8930819496934;1645.2843013289257;1671.9331226751037;1746.5720898379725;868.0581568997582;870.2602787630464;886.1492966751862;895.3463971300987;959.6449313753956;16420.343186272654;16878.915605421895;17429.302827886997;17646.2059207336;18726.81273187278;832.8584140696096;846.5344060766554;856.6787454704486;862.4997501449144;927.0590350793949;9294.302927280482;9838.311318207656;9935.850962235572;9947.801043979225;10138.949305253427;384380;387530;389756;390650;391644;74363;79605.60197198977;80444.19555804484;80624;81580;886.2334081019872;902.7111324376268;907.5689047702289;921.7280902133887;947.3747326764164;15672.294746736652;15850.60373490672;15899.682006359577;16009.759853602438;16329.591760205614;36915.446268306536;37026.6297337034;37114.44328335023;37971.81014094912;38712.41931371088;49673;51309.23036154536;51428;51970.22044669409;52078;7524.548527088392;7636.427267954815;7680.462367634435;7743.690252389842;7788.221177882393;8216.383771217063;10414;11071.612493562687;11604.129690273094;11604.6518604442;9822.508874556386;9871.062249086326;10299.639512617023;10415.94792026035;10418.166546676399;10125.848112278469;10280;10288.331258468175;10403.219758518293;10515.474226288808;9352.205062569486;9933.801323973335;10062.094411503;10488.10851077667;10686.0916822071;7714.305712485903;7740.26467485588;7833.295003449717;7842.960785196037;7905.56519391439;9512.524373781422;9934.850977235492;10385.584576617153;10471;10516.737081573021 16:06:48 INFO - PROCESS | 3424 | |3;mootools.html;1178.3872386359087;1367.405178747245;1390.1520072755618;1469.5370958148183;1684.0400971446272;6522.0869078329015;7398.29716176963;7548.094228692565;7564.357029652486;7837.529748215111;7514.286142816437;7682.807929801757;7709.653065612061;7712.730054448096;7713.228677132298;1876.887386756799;2105.610462064515;2150.924717634887;2173.1416090644184;2182.15986845065;2225.8441909066373;2245.696830927828;2248.9662655060188;2252.3693365857584;2253.583087128878;2189.4526368407896;2202.2952655150357;2222.811061059812;2229.308914236592;2229.832762542808;1859.7396364509048;2069.3274685727197;2120.2579097315815;2128.457243402938;2154.5475450155486;2179.3353027326657;2194.297824696098;2201.416624594484;2202.1301585873653;2202.383332666856;7712.113106992711;7741.729039483591;7755.689772409097;7757.9224207758325;7769.53382797034;4504.864854054384;4619.214733495281;4631.861044168647;4632.629389648854;4635.188841952645;2736.8905243790423;2839.544011943485;2884.278930267433;2896.145637037058;2934.8826046958097;933.6732143749701;937.784309608787;946.4368700623119;949.1789601994294;958.3004406783087;10233.48832558369;10249.64126255585;10261.948690256575;10284.125849302818;10303.896961030368;4098.262312783668;4193.916121677549;4275.209086318979;4279.443672322578;4286.485621725413;8810.207081362709;8844.867326990101;8860.556972151368;8864.20222179994;8873.778155546162;4591.311303304465;4604.194266003436;4605.907881842344;4608.216603177468;4613;3636.2363903580545;4095.140020595649;4182.769947652909;4200.075983283673;4290.764007979528;3556.448750443634;3571.232185080168;3578.1054736315923;3641.617630148849;3679.19057807282;1134.920555561103;1167.9299242045504;1201.813718873576;1204.0608325506118;1205.9638210853689;780.8321210939562;786.5634572812144;799.8440304140637;805.0259186384424;812.6180695073306;4807.278908163804;5032.949670503248;5071.137906555894;5092.719900405439;5127.743612819344;386.25645632157983;392.9744566603219;396.8591150141716;400.08580393800025;403.3566461493912;3284.950725739116;3398.3543126805826;3434.1929646533545;3440.2775417162175;3447.9827600861836;8972.506512141896;9393;9458.716238512856;9478.95260523693;9485.573149208301;9326.440413575207;9353;9360.859587106199;9364.672236471692;9383.202427793578;7183.389411899942;7248.528845625017;7253.347198752138;7260.891086633705;7264.963675181696;4965.3296804932315;4975.776090075883;4994.350734404504;5036.143855544493;5207.505286997729;8295.917040829514;8600.698975535826;8650.956745216234;8749;8768.605412756313;8699.608517616596;8777.605007774539;8836.513991730517;8866.556672166236;8869.423487473294;5926.111083337534;6512.902306465312;6530.379613936669;6558.934410656023;6684.462573608;7521.811954701177;7540.886886696813;7564.735234266775;7599;7601.6579253934815;6335.366463353628;6504.447121994494;6518.641474718936;6592.406683398517;6632.701528431328;6112.572119951561;6229.781957631461;6235.688215589294;6241;6250.4374606285655;5726;5758.280214973129;5795.710214489174;5802.767889284381;5808.82573522795;4097.8770636880945;4148.8133034012935;4190.350495673054;4243.236217480883;4270.914581708286;4171.937420938749;4226.218149642326;4234.830606775818;4252.107057517832;4299.97850010748 16:06:48 INFO - PROCESS | 3424 | |4;prototype.html;299.4236095516131;300.7263390314814;305.3831260853076;306.4453339455584;307.6892338737877;4680.906381872361;4792.664513484057;4888.535589119028;4895.412550493946;4899.652595536225;4793.808247670097;4807.687500312486;4829.744266490711;4833.903321933559;4861.319415281863;3558.217192217708;3667.7249206309634;3676.1361080146144;3763.454299126625;3841.8271177797064;3396.813175275359;3618.8914332570066;3691.1325838428083;3694.2980833641523;3717.6839968602703;3702.426123950792;3714.294284086015;3724.7951362675044;3738.8504459821575;3745.4943582616406;3705.4627079073516;3741.588425273231;3746.7939263340504;3751.362268414349;3752.7428311515673;3160.3995240904155;3205.214722393005;3218.308063766278;3291.308825146722;3309.4043072246986;4459.531749166355;4516.909661806778;4631.143238500888;4661.650376221797;4700.788464519105;4252.808623611914;4260.190563792869;4285.914281714348;4286.228478873802;4289.506706728735;4828.203346447832;5045.8807300933695;5061.5950723942;5063.240513922904;5083.6441449098575;3574.928501429983;3586.444101164324;3606.801625910574;3610.855565777366;3616.18635806944;5081.8475445736685;5106.829597421044;5207.765650545697;5239.3712754469325;5255.842324730226;3716.646918542734;3737.467638268297;3741.1582393961685;3745.5879853216125;3751.2309976454762;3797.6582107610448;3798.3922572388287;3812.8856134316015;3838.9616103838603;3843.577206507282;4318.632916202095;4319.913601728011;4322.449754644775;4342.500612429548;4358.869233922987;5006.549410553068;5064.215046667772;5065.13892638245;5073.594112470993;5092.8472145835685;1305.0081937727207;1311.2001678975817;1312.4356526693423;1322.9680848937844;1354.9187048777105;815.1807433529265;851.1573542193184;853.3599800149888;854.3592305770673;857.0700789643307;4016.51388986077;4037.414574886625;4053.9594604054173;4056.7971601419813;4110.712250142521;4556.066006468666;4567.725936443758;4583.518730533313;4706.95293047072;4722.315264286659;4002.779847108437;4003.939940900889;4005.819738111792;4058.492688413948;4072.2873497137884;2460.8892599833052;2582.625519299691;2821.7883658725677;2834.8093800603797;2840.744333010039;4914.70511769295;4924.778384972685;4929.186684197139;4930.8767280818265;4949.208126699711;5182.738074600894;5325.893482130413;5334.91997620036;5383.7308134593895;5383.946160538345;4841.782119804618;4895.290182923456;4901.3383193268455;4921.597344756728;4932.654714170046;5214.634975551827;5245.564155478168;5251.973740131428;5264.263003179634;5280.762365693477;4884.316195732529;5170.1986192140275;5171.405288391883;5175.844724658266;5188.766505507186;4695.600873925755;4770.2129148691465;4882.170031094652;4949.430815456269;4952.826651067196;3696.4824924511126;3728.7762734236035;3764.284785890672;3777.792221427848;3791.4502397151705;5231.293775340432;5251.448597897166;5331.573474122139;5331.973340133274;5347.491988261109;4876.1474537396025;5061.089003979319;5072.213806859942;5072.51811077947;5089.592832573459;5049.242613607841;5054.891241886287;5057.241413787961;5058.443571207091;5067.341245638044;4961.7519124044375;4990.8253211137435;4992.425871024879;5003.924941125959;5013;4884.4382895966;5087.465816089258;5113.284140220298;5141.511556402136;5153.3815942087185;5008.6692349588575;5015.22264049073;5015.22264049073;5022.573081288131;5027.874303142451 16:06:48 INFO - PROCESS | 3424 | |5;yui.html;609.8808686061078;627.7802769030837;662.1954325494527;704.5350068954488;725.8330583965686;12754.617361479148;12883.484660613576;12932;13281.7343653127;13630.591082267536;12418.316992565406;12428.316442595653;12508.81236781449;12520.311382873939;12544.686382840433;624.8875202463555;740.5889731199196;750.4071783291193;768.2202564397141;788.9013873265842;748.9138749043848;751.3575892611793;751.9887201691979;752.1275320628073;753.3107206905675;811.9391045671598;814.6008455856618;815.2703330519182;815.2988429950238;815.4332738746574;645.4578154350345;783.6865253898486;808.5068108453838;809.3363441977581;811.679386642276;600.8858316919815;601.5548494114367;602.4908951935652;602.5360472436199;602.8432607522032;12031.939840300742;12050.276983381025;12060.276383416935;12069.698257543543;12082.456289466994;11997.880021199851;12503.249805011637;12733.554325598652;12899.09706320558;13065.412056457482;11365.09079273656;11828.112891533083;11873.881261187364;11986.160968732192;12000.51997920082;4219.535851056412;4266.701330906838;4332.891677708051;4334.479862416499;4486.327050942385;59094.409055909324;59895.70052149755;60758.696206519126;61016;61442;10042.19662427004;10121.139703125169;10295.3822770634;10361.326513776581;10373.58505659765;16371.672566548603;16401;16508;16550.586235344213;16557.420490283024;6769.932300677028;6818;6950.478714096463;6961.860762784716;7125.287471252833;3573.892783216456;3633.255182687543;3703.370427027358;3784.7350685452307;3807.2575847709986;2784.5962335461245;2881.150060732089;2881.6974217707257;2885.942281154365;2891.696371880922;495.14093048560716;497.4453484364907;503.7934147716199;507.56095976979645;510.6757209172128;479.9976000119977;531.3995185440427;537.5592014548112;547.7945770336124;552.5054033239775;6668.766593169215;6823.829404264933;6914.965425172842;7296.963515182496;7308.232635573188;481.1339588740254;494.49314452686286;515.9200323949793;523.1995047577213;541.2098336428779;3057.9847100764355;3192.1859925718795;3401.3197360527993;3491.0574144980715;3562.8574857005947;88161.55919220363;88187.55906220428;89117.97938185594;89121;90596.54701726449;47959;81388.18611813925;81582.59208704038;81661;82877.58561207275;73272.63363683254;73667.52664946778;75415.24584754193;75621;75718;6732.629705366252;6748.6963086660235;6764.661766911733;6808.65956702153;6891.620960847202;41825;42603;44396.77801610971;44783.32825007693;44784.328235075845;57409.425905740405;61353;62311;62754.37245627668;65252;9099.1810737034;9125.680601178927;9352.392094513834;9380.202682771767;9629.32594718363;10062.39625622465;10117.544710488193;10127.341722787995;10323.690289291333;10693.732656683645;8880.333974951775;9076.500792456478;9136.177744003071;9429.245660347018;9667.419954802734;8657;8816.118388161132;8836.425632334134;8852.424592401474;8864.379493435397;9097.909020909707;9341.719748407559;9429.717108486757;9568.856467153137;9580;7614.505057171266;7653.387728981556;7707.499012564165;7825;8050;7280.162781280009;7584.810379740551;7666;7950.960245198737;8077.919220807952 16:06:48 INFO - PROCESS | 3424 | __end_tp_report 16:06:48 INFO - PROCESS | 3424 | __start_cc_report 16:06:48 INFO - PROCESS | 3424 | _x_x_mozilla_cycle_collect,1094 16:06:48 INFO - PROCESS | 3424 | __end_cc_report 16:06:48 INFO - PROCESS | 3424 | __startTimestamp1466032008239__endTimestamp 16:06:48 INFO - PROCESS | 3424 | 16:06:48 INFO - PROCESS | 3424 | ------- Summary: start ------- 16:06:48 INFO - PROCESS | 3424 | Number of tests: 6 16:06:48 INFO - PROCESS | 3424 | 16:06:48 INFO - PROCESS | 3424 | [#0] dojo.html Cycles:165 Average:4723.83 Median:4854.64 stddev:511.05 (10.5%) stddev-sans-first:485.08 16:06:48 INFO - PROCESS | 3424 | Values: 2614.1 2625.2 2649.9 2661.4 2665.7 4608.4 4668.4 4691.4 4754.0 4793.2 4689.8 4769.3 4779.9 4818.0 4881.1 4363.2 4411.9 4415.2 4415.2 4483.7 4419.6 4439.7 4478.6 4496.4 4497.6 4248.1 4269.1 4272.6 4313.1 4374.0 4312.4 4375.9 4406.8 4408.7 4411.5 4362.8 4374.7 4374.8 4418.7 4426.2 4529.5 4721.0 4751.3 4776.3 4809.4 5137.0 5203.6 5218.8 5222.2 5226.9 5248.1 5252.9 5257.6 5258.2 5259.6 4640.3 4778.0 4835.4 4837.9 4882.4 5363.5 5367.2 5403.0 5407.6 5422.8 5126.8 5155.6 5157.3 5175.4 5176.9 4925.6 4969.5 5012.8 5016.7 5245.8 5015.3 5015.8 5019.1 5040.5 5044.7 4965.4 4968.8 4972.9 5006.4 5033.6 4235.5 4266.5 4292.6 4293.7 4335.5 3772.5 3782.2 3800.1 3822.6 3876.7 4365.7 4380.3 4384.7 4424.2 4427.3 4995.7 5039.2 5089.4 5134.1 5191.6 4337.8 4355.2 4357.9 4390.5 4400.3 4582.2 4592.3 4595.7 4602.8 4644.9 4568.4 4758.4 4789.4 4838.2 4841.8 5191.4 5194.7 5204.0 5205.9 5233.3 4864.3 4864.7 4865.4 4897.0 4904.9 4876.4 5025.0 5031.2 5059.7 5101.9 5130.1 5150.8 5165.0 5169.3 5209.8 4897.9 5002.0 5016.7 5022.4 5027.8 4853.4 4877.8 4900.3 4902.2 4922.0 4854.6 4923.5 4928.7 4933.9 4937.7 4828.0 4979.9 4988.9 4994.8 5033.1 4807.3 4852.3 4873.4 4930.8 4936.1 16:06:48 INFO - PROCESS | 3424 | 16:06:48 INFO - PROCESS | 3424 | [#1] ext.html Cycles:180 Average:45568.74 Median:19643.67 stddev:83544.46 (425.3%) stddev-sans-first:83710.38 16:06:48 INFO - PROCESS | 3424 | Values: 526.0 561.7 579.4 583.0 597.8 26641.2 38835.0 39008.8 39035.6 39309.8 41142.2 41466.8 41477.6 41682.4 41693.8 7697.3 7835.6 7836.6 7838.7 7839.5 7878.4 7944.9 7969.3 7969.6 7972.8 7909.5 7930.3 7958.6 7958.7 7963.7 7888.8 7911.8 7929.2 7933.7 7938.1 7624.7 7669.0 7676.7 7681.7 7682.1 38961.4 39309.6 39384.2 39393.8 39398.8 3007.2 3137.7 3161.1 3172.2 3212.8 30037.5 30133.8 30148.7 30204.0 30870.7 3538.6 3544.3 3562.0 3573.3 3626.9 237291.8 237997.0 238514.0 239376.0 239942.0 31525.7 51457.5 51985.5 51992.2 52125.5 33959.0 34096.8 34139.8 34160.8 34169.7 13014.3 13134.7 13144.2 13146.4 13151.6 10701.3 10766.6 10770.5 10776.1 10801.4 7890.7 7895.7 7907.9 7985.2 7985.7 3122.3 3125.2 3134.6 3157.0 3174.4 808.0 856.2 862.2 879.6 923.9 27481.6 29946.3 31591.4 31869.4 32316.2 800.7 939.4 950.4 952.2 991.2 13770.6 14039.5 14093.9 14216.1 14266.2 380510.0 381038.0 383826.0 384461.0 384702.0 47297.8 47882.3 47963.0 47981.3 47985.0 1090.5 1167.2 1202.1 1202.1 1211.9 27411.5 28175.2 28398.4 28613.5 29192.0 41187.2 41647.6 41800.8 41842.4 41846.4 309696.0 312390.0 312913.0 313276.0 313391.0 22052.7 23843.8 24528.0 24720.3 26035.7 41000.6 41167.8 41439.8 41639.0 42100.4 35669.1 35711.5 35844.1 36341.6 36457.6 35102.0 35535.5 35538.3 35593.8 35748.1 34246.0 34803.0 35154.6 35577.5 35714.0 30712.8 31630.8 31997.8 32472.4 34101.5 25341.6 25365.2 25413.7 25660.9 25777.4 16:06:48 INFO - PROCESS | 3424 | 16:06:48 INFO - PROCESS | 3424 | [#2] jquery.html Cycles:180 Average:24324.07 Median:28181.45 stddev:64150.30 (227.6%) stddev-sans-first:64305.01 16:06:48 INFO - PROCESS | 3424 | Values: 351.1 357.9 358.5 377.3 382.0 15523.1 17097.2 17308.2 17659.0 17809.2 16111.0 16480.2 17359.5 17407.4 17448.5 4912.9 5146.9 5151.3 5195.0 5195.1 3695.1 3831.0 5053.7 5716.9 6017.8 6006.6 6010.5 6018.7 6029.6 6036.7 5686.3 5967.7 5976.1 5982.5 5986.2 3323.3 4907.8 5224.1 5269.5 5280.6 20416.3 20495.1 20613.2 20630.2 20638.7 2024.2 2037.7 2150.4 2236.5 2454.2 13242.4 13274.9 13335.5 13391.1 13843.3 1725.6 1798.1 1807.4 1827.4 1849.7 63338.2 63381.5 63522.4 64292.4 65598.7 9005.8 9127.3 9291.6 9352.0 9401.8 12631.8 12827.7 12891.7 12895.7 12953.2 6494.8 6540.8 6605.2 6700.2 6728.6 6195.8 6264.5 6313.8 6393.6 6404.5 6151.2 6152.8 6221.7 6275.1 6383.5 1572.9 1644.9 1645.3 1671.9 1746.6 868.1 870.3 886.1 895.3 959.6 16420.3 16878.9 17429.3 17646.2 18726.8 832.9 846.5 856.7 862.5 927.1 9294.3 9838.3 9935.9 9947.8 10138.9 384380.0 387530.0 389756.0 390650.0 391644.0 74363.0 79605.6 80444.2 80624.0 81580.0 886.2 902.7 907.6 921.7 947.4 15672.3 15850.6 15899.7 16009.8 16329.6 36915.4 37026.6 37114.4 37971.8 38712.4 49673.0 51309.2 51428.0 51970.2 52078.0 7524.5 7636.4 7680.5 7743.7 7788.2 8216.4 10414.0 11071.6 11604.1 11604.7 9822.5 9871.1 10299.6 10415.9 10418.2 10125.8 10280.0 10288.3 10403.2 10515.5 9352.2 9933.8 10062.1 10488.1 10686.1 7714.3 7740.3 7833.3 7843.0 7905.6 9512.5 9934.9 10385.6 10471.0 10516.7 16:06:48 INFO - PROCESS | 3424 | 16:06:48 INFO - PROCESS | 3424 | [#3] mootools.html Cycles:180 Average:4978.70 Median:4886.30 stddev:2806.66 (57.4%) stddev-sans-first:2800.00 16:06:48 INFO - PROCESS | 3424 | Values: 1178.4 1367.4 1390.2 1469.5 1684.0 6522.1 7398.3 7548.1 7564.4 7837.5 7514.3 7682.8 7709.7 7712.7 7713.2 1876.9 2105.6 2150.9 2173.1 2182.2 2225.8 2245.7 2249.0 2252.4 2253.6 2189.5 2202.3 2222.8 2229.3 2229.8 1859.7 2069.3 2120.3 2128.5 2154.5 2179.3 2194.3 2201.4 2202.1 2202.4 7712.1 7741.7 7755.7 7757.9 7769.5 4504.9 4619.2 4631.9 4632.6 4635.2 2736.9 2839.5 2884.3 2896.1 2934.9 933.7 937.8 946.4 949.2 958.3 10233.5 10249.6 10261.9 10284.1 10303.9 4098.3 4193.9 4275.2 4279.4 4286.5 8810.2 8844.9 8860.6 8864.2 8873.8 4591.3 4604.2 4605.9 4608.2 4613.0 3636.2 4095.1 4182.8 4200.1 4290.8 3556.4 3571.2 3578.1 3641.6 3679.2 1134.9 1167.9 1201.8 1204.1 1206.0 780.8 786.6 799.8 805.0 812.6 4807.3 5032.9 5071.1 5092.7 5127.7 386.3 393.0 396.9 400.1 403.4 3285.0 3398.4 3434.2 3440.3 3448.0 8972.5 9393.0 9458.7 9479.0 9485.6 9326.4 9353.0 9360.9 9364.7 9383.2 7183.4 7248.5 7253.3 7260.9 7265.0 4965.3 4975.8 4994.4 5036.1 5207.5 8295.9 8600.7 8651.0 8749.0 8768.6 8699.6 8777.6 8836.5 8866.6 8869.4 5926.1 6512.9 6530.4 6558.9 6684.5 7521.8 7540.9 7564.7 7599.0 7601.7 6335.4 6504.4 6518.6 6592.4 6632.7 6112.6 6229.8 6235.7 6241.0 6250.4 5726.0 5758.3 5795.7 5802.8 5808.8 4097.9 4148.8 4190.4 4243.2 4270.9 4171.9 4226.2 4234.8 4252.1 4300.0 16:06:48 INFO - PROCESS | 3424 | 16:06:48 INFO - PROCESS | 3424 | [#4] prototype.html Cycles:180 Average:4160.71 Median:4714.63 stddev:1214.57 (25.8%) stddev-sans-first:1182.90 16:06:48 INFO - PROCESS | 3424 | Values: 299.4 300.7 305.4 306.4 307.7 4680.9 4792.7 4888.5 4895.4 4899.7 4793.8 4807.7 4829.7 4833.9 4861.3 3558.2 3667.7 3676.1 3763.5 3841.8 3396.8 3618.9 3691.1 3694.3 3717.7 3702.4 3714.3 3724.8 3738.9 3745.5 3705.5 3741.6 3746.8 3751.4 3752.7 3160.4 3205.2 3218.3 3291.3 3309.4 4459.5 4516.9 4631.1 4661.7 4700.8 4252.8 4260.2 4285.9 4286.2 4289.5 4828.2 5045.9 5061.6 5063.2 5083.6 3574.9 3586.4 3606.8 3610.9 3616.2 5081.8 5106.8 5207.8 5239.4 5255.8 3716.6 3737.5 3741.2 3745.6 3751.2 3797.7 3798.4 3812.9 3839.0 3843.6 4318.6 4319.9 4322.4 4342.5 4358.9 5006.5 5064.2 5065.1 5073.6 5092.8 1305.0 1311.2 1312.4 1323.0 1354.9 815.2 851.2 853.4 854.4 857.1 4016.5 4037.4 4054.0 4056.8 4110.7 4556.1 4567.7 4583.5 4707.0 4722.3 4002.8 4003.9 4005.8 4058.5 4072.3 2460.9 2582.6 2821.8 2834.8 2840.7 4914.7 4924.8 4929.2 4930.9 4949.2 5182.7 5325.9 5334.9 5383.7 5383.9 4841.8 4895.3 4901.3 4921.6 4932.7 5214.6 5245.6 5252.0 5264.3 5280.8 4884.3 5170.2 5171.4 5175.8 5188.8 4695.6 4770.2 4882.2 4949.4 4952.8 3696.5 3728.8 3764.3 3777.8 3791.5 5231.3 5251.4 5331.6 5332.0 5347.5 4876.1 5061.1 5072.2 5072.5 5089.6 5049.2 5054.9 5057.2 5058.4 5067.3 4961.8 4990.8 4992.4 5003.9 5013.0 4884.4 5087.5 5113.3 5141.5 5153.4 5008.7 5015.2 5015.2 5022.6 5027.9 16:06:48 INFO - PROCESS | 3424 | 16:06:48 INFO - PROCESS | 3424 | [#5] yui.html Cycles:180 Average:16582.19 Median:30812.94 stddev:24070.51 (78.1%) stddev-sans-first:24108.16 16:06:48 INFO - PROCESS | 3424 | Values: 609.9 627.8 662.2 704.5 725.8 12754.6 12883.5 12932.0 13281.7 13630.6 12418.3 12428.3 12508.8 12520.3 12544.7 624.9 740.6 750.4 768.2 788.9 748.9 751.4 752.0 752.1 753.3 811.9 814.6 815.3 815.3 815.4 645.5 783.7 808.5 809.3 811.7 600.9 601.6 602.5 602.5 602.8 12031.9 12050.3 12060.3 12069.7 12082.5 11997.9 12503.2 12733.6 12899.1 13065.4 11365.1 11828.1 11873.9 11986.2 12000.5 4219.5 4266.7 4332.9 4334.5 4486.3 59094.4 59895.7 60758.7 61016.0 61442.0 10042.2 10121.1 10295.4 10361.3 10373.6 16371.7 16401.0 16508.0 16550.6 16557.4 6769.9 6818.0 6950.5 6961.9 7125.3 3573.9 3633.3 3703.4 3784.7 3807.3 2784.6 2881.2 2881.7 2885.9 2891.7 495.1 497.4 503.8 507.6 510.7 480.0 531.4 537.6 547.8 552.5 6668.8 6823.8 6915.0 7297.0 7308.2 481.1 494.5 515.9 523.2 541.2 3058.0 3192.2 3401.3 3491.1 3562.9 88161.6 88187.6 89118.0 89121.0 90596.5 47959.0 81388.2 81582.6 81661.0 82877.6 73272.6 73667.5 75415.2 75621.0 75718.0 6732.6 6748.7 6764.7 6808.7 6891.6 41825.0 42603.0 44396.8 44783.3 44784.3 57409.4 61353.0 62311.0 62754.4 65252.0 9099.2 9125.7 9352.4 9380.2 9629.3 10062.4 10117.5 10127.3 10323.7 10693.7 8880.3 9076.5 9136.2 9429.2 9667.4 8657.0 8816.1 8836.4 8852.4 8864.4 9097.9 9341.7 9429.7 9568.9 9580.0 7614.5 7653.4 7707.5 7825.0 8050.0 7280.2 7584.8 7666.0 7951.0 8077.9 16:06:48 INFO - PROCESS | 3424 | -------- Summary: end -------- 16:06:48 INFO - PROCESS | 3424 | 16:06:49 INFO - TEST-INFO | 3424: exit 0 16:06:49 INFO - TEST-OK | dromaeo_css | took 1121459ms 16:06:49 INFO - TEST-START | kraken 16:06:49 INFO - operating with platform_type : linux_ 16:06:49 INFO - Initialising browser for kraken test... 16:06:49 INFO - TEST-INFO | started process 3601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQKvrck/profile http://localhost:44319/getInfo.html) 16:06:53 INFO - PROCESS | 3601 | __metrics Screen width/height:1600/1200 16:06:53 INFO - PROCESS | 3601 | colorDepth:24 16:06:53 INFO - PROCESS | 3601 | Browser inner width/height: 1024/697 16:06:53 INFO - PROCESS | 3601 | __metrics 16:06:54 INFO - PROCESS | 3601 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:06:54 INFO - PROCESS | 3601 | console.error: PushService: 16:06:54 INFO - PROCESS | 3601 | stateChangeProcessEnqueue: Error transitioning state 16:06:54 INFO - PROCESS | 3601 | UnknownError 16:06:55 INFO - TEST-INFO | 3601: exit 0 16:06:55 INFO - Browser initialized. 16:06:55 INFO - Running cycle 1/1 for kraken test... 16:06:55 INFO - TEST-INFO | started process 3681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQKvrck/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:07 INFO - PROCESS | 3681 | RSS: Main: 175374336 16:07:07 INFO - PROCESS | 3681 | 16:07:10 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44319/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:11 INFO - PROCESS | 3681 | RSS: Main: 233328640 16:07:11 INFO - PROCESS | 3681 | 16:07:14 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44319/tests/kraken/driver.html?testName=audio-dft) 16:07:14 INFO - PROCESS | 3681 | RSS: Main: 221134848 16:07:14 INFO - PROCESS | 3681 | 16:07:18 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44319/tests/kraken/driver.html?testName=audio-fft) 16:07:18 INFO - PROCESS | 3681 | RSS: Main: 288612352 16:07:18 INFO - PROCESS | 3681 | 16:07:20 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44319/tests/kraken/driver.html?testName=audio-oscillator) 16:07:21 INFO - PROCESS | 3681 | RSS: Main: 198369280 16:07:21 INFO - PROCESS | 3681 | 16:07:23 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44319/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:24 INFO - PROCESS | 3681 | RSS: Main: 202792960 16:07:24 INFO - PROCESS | 3681 | 16:07:27 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44319/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:28 INFO - PROCESS | 3681 | RSS: Main: 239009792 16:07:28 INFO - PROCESS | 3681 | 16:07:31 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44319/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:32 INFO - PROCESS | 3681 | RSS: Main: 239886336 16:07:32 INFO - PROCESS | 3681 | 16:07:35 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44319/tests/kraken/driver.html?testName=json-parse-financial) 16:07:35 INFO - PROCESS | 3681 | RSS: Main: 240209920 16:07:35 INFO - PROCESS | 3681 | 16:07:37 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44319/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:38 INFO - PROCESS | 3681 | RSS: Main: 226496512 16:07:38 INFO - PROCESS | 3681 | 16:07:39 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44319/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:40 INFO - PROCESS | 3681 | RSS: Main: 232026112 16:07:40 INFO - PROCESS | 3681 | 16:07:42 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44319/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:43 INFO - PROCESS | 3681 | RSS: Main: 239689728 16:07:43 INFO - PROCESS | 3681 | 16:07:46 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:46 INFO - PROCESS | 3681 | RSS: Main: 242245632 16:07:46 INFO - PROCESS | 3681 | 16:07:49 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:07:50 INFO - PROCESS | 3681 | RSS: Main: 243404800 16:07:50 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:44319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44319/tests/kraken/driver.html?testName=ai-astar) 16:07:52 INFO - PROCESS | 3681 | RSS: Main: 286220288 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | __start_tp_report 16:07:52 INFO - PROCESS | 3681 | _x_x_mozilla_page_load 16:07:52 INFO - PROCESS | 3681 | _x_x_mozilla_page_load_details 16:07:52 INFO - PROCESS | 3681 | |i|pagename|runs| 16:07:52 INFO - PROCESS | 3681 | |0;ai-astar;113;109;115;116;113;113;114;113;114;114 16:07:52 INFO - PROCESS | 3681 | |1;audio-beat-detection;160;141;133;180;136;133;160;130;192;139 16:07:52 INFO - PROCESS | 3681 | |2;audio-dft;161;162;163;162;161;162;165;161;161;161 16:07:52 INFO - PROCESS | 3681 | |3;audio-fft;76;76;75;107;76;78;74;74;99;76 16:07:52 INFO - PROCESS | 3681 | |4;audio-oscillator;87;87;120;86;88;87;128;88;86;135 16:07:52 INFO - PROCESS | 3681 | |5;imaging-gaussian-blur;117;117;117;118;117;119;117;116;118;117 16:07:52 INFO - PROCESS | 3681 | |6;imaging-darkroom;146;146;147;146;146;147;148;146;146;146 16:07:52 INFO - PROCESS | 3681 | |7;imaging-desaturate;96;96;96;95;96;95;95;96;95;95 16:07:52 INFO - PROCESS | 3681 | |8;json-parse-financial;64;64;63;63;63;64;65;64;63;63 16:07:52 INFO - PROCESS | 3681 | |9;json-stringify-tinderbox;65;65;65;66;65;65;67;65;65;65 16:07:52 INFO - PROCESS | 3681 | |10;stanford-crypto-aes;83;83;83;83;83;84;85;90;114;83 16:07:52 INFO - PROCESS | 3681 | |11;stanford-crypto-ccm;143;150;134;139;132;130;128;133;140;143 16:07:52 INFO - PROCESS | 3681 | |12;stanford-crypto-pbkdf2;170;174;174;170;177;173;171;168;167;165 16:07:52 INFO - PROCESS | 3681 | |13;stanford-crypto-sha256-iterative;68;66;68;68;67;67;67;66;67;67 16:07:52 INFO - PROCESS | 3681 | __end_tp_report 16:07:52 INFO - PROCESS | 3681 | __start_cc_report 16:07:52 INFO - PROCESS | 3681 | _x_x_mozilla_cycle_collect,1884 16:07:52 INFO - PROCESS | 3681 | __end_cc_report 16:07:52 INFO - PROCESS | 3681 | __startTimestamp1466032072410__endTimestamp 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | ------- Summary: start ------- 16:07:52 INFO - PROCESS | 3681 | Number of tests: 14 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.84 (1.6%) stddev-sans-first:1.94 16:07:52 INFO - PROCESS | 3681 | Values: 113.0 109.0 115.0 116.0 113.0 113.0 114.0 113.0 114.0 114.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:150.50 stddev:21.70 (14.4%) stddev-sans-first:22.74 16:07:52 INFO - PROCESS | 3681 | Values: 160.0 141.0 133.0 180.0 136.0 133.0 160.0 130.0 192.0 139.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 16:07:52 INFO - PROCESS | 3681 | Values: 161.0 162.0 163.0 162.0 161.0 162.0 165.0 161.0 161.0 161.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.75 (15.5%) stddev-sans-first:12.32 16:07:52 INFO - PROCESS | 3681 | Values: 76.0 76.0 75.0 107.0 76.0 78.0 74.0 74.0 99.0 76.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#4] audio-oscillator Cycles:10 Average:99.20 Median:87.00 stddev:19.97 (23.0%) stddev-sans-first:20.69 16:07:52 INFO - PROCESS | 3681 | Values: 87.0 87.0 120.0 86.0 88.0 87.0 128.0 88.0 86.0 135.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 16:07:52 INFO - PROCESS | 3681 | Values: 117.0 117.0 117.0 118.0 117.0 119.0 117.0 116.0 118.0 117.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:07:52 INFO - PROCESS | 3681 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 148.0 146.0 146.0 146.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:07:52 INFO - PROCESS | 3681 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 16:07:52 INFO - PROCESS | 3681 | Values: 64.0 64.0 63.0 63.0 63.0 64.0 65.0 64.0 63.0 63.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 16:07:52 INFO - PROCESS | 3681 | Values: 65.0 65.0 65.0 66.0 65.0 65.0 67.0 65.0 65.0 65.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:83.00 stddev:9.70 (11.7%) stddev-sans-first:10.17 16:07:52 INFO - PROCESS | 3681 | Values: 83.0 83.0 83.0 83.0 83.0 84.0 85.0 90.0 114.0 83.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:139.50 stddev:6.94 (5.0%) stddev-sans-first:7.04 16:07:52 INFO - PROCESS | 3681 | Values: 143.0 150.0 134.0 139.0 132.0 130.0 128.0 133.0 140.0 143.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:172.00 stddev:3.67 (2.1%) stddev-sans-first:3.87 16:07:52 INFO - PROCESS | 3681 | Values: 170.0 174.0 174.0 170.0 177.0 173.0 171.0 168.0 167.0 165.0 16:07:52 INFO - PROCESS | 3681 | 16:07:52 INFO - PROCESS | 3681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 16:07:52 INFO - PROCESS | 3681 | Values: 68.0 66.0 68.0 68.0 67.0 67.0 67.0 66.0 67.0 67.0 16:07:52 INFO - PROCESS | 3681 | -------- Summary: end -------- 16:07:52 INFO - PROCESS | 3681 | 16:07:53 INFO - TEST-INFO | 3681: exit 0 16:07:53 INFO - TEST-OK | kraken | took 64507ms 16:07:53 INFO - SUITE-END | took 1185s 16:07:54 INFO - Completed test suite (00:19:46) 16:07:54 INFO - javascript benchmark 16:07:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.0981361430304, 2625.212436269119, 2649.854258015809, 2661.401184733435, 2665.6934452537953, 4608.377868987685, 4668.369770081038, 4691.366665500156, 4753.952460475394, 4793.161196790561, 4689.788959496822, 4769.332293478916, 4779.856604301868, 4818.0, 4881.145799485093, 4363.236433624119, 4411.911761764763, 4415.22733521634, 4415.249407600716, 4483.663725220622, 4419.580139886705, 4439.689221754478, 4478.596926276651, 4496.392986946769, 4497.64018878489, 4248.065425606362, 4269.060806622538, 4272.636825869805, 4313.09425020746, 4373.956260437402, 4312.396264522969, 4375.912481750347, 4406.801693923749, 4408.691391602589, 4411.536788637179, 4362.825486980517, 4374.671899607511, 4374.759388233646, 4418.734875907456, 4426.18115648606, 4529.5243999380245, 4720.95279047212, 4751.287306903958, 4776.25967974961, 4809.398825146856, 5136.9743151284, 5203.5837133029645, 5218.791248350061, 5222.190560463135, 5226.92159617606, 5248.134057880445, 5252.894942101137, 5257.631965762398, 5258.211268309746, 5259.605529585258, 4640.327152562927, 4778.0, 4835.443923948791, 4837.854864354075, 4882.414110306786, 5363.490468405574, 5367.1680889462195, 5402.972985135049, 5407.594430417735, 5422.8373148805595, 5126.769295381717, 5155.587552995751, 5157.329547158845, 5175.378954525481, 5176.922346164811, 4925.581325587365, 4969.527894849984, 5012.774425150877, 5016.724080175552, 5245.763940622681, 5015.348004759431, 5015.799368025311, 5019.121653710659, 5040.47075057121, 5044.722540260321, 4965.35450391454, 4968.776405061781, 4972.900541989212, 5006.374203224597, 5033.6224783141415, 4235.4917409911, 4266.466691663542, 4292.59220374064, 4293.742375457483, 4335.544767799335, 3772.5472943246436, 3782.167923056923, 3800.1069748609057, 3822.636849499293, 3876.6511014008875, 4365.694401391872, 4380.342948557742, 4384.671149663788, 4424.203643344229, 4427.26950053244, 4995.700257984533, 5039.244113383022, 5089.389273287229, 5134.127198376285, 5191.610629202825, 4337.783110844445, 4355.237833379146, 4357.869263922087, 4390.4511936008, 4400.317950717644, 4582.175208462442, 4592.311153327028, 4595.6783025187915, 4602.792874320597, 4644.883877903079, 4568.360429539934, 4758.405199350151, 4789.44921334051, 4838.225883858566, 4841.806327746851, 5191.402988656353, 5194.68831870089, 5203.973980130075, 5205.895882082413, 5233.267342572119, 4864.318995340726, 4864.708117512961, 4865.416150062015, 4897.0, 4904.92642610354, 4876.366072410564, 5025.0, 5031.22016087507, 5059.747012649426, 5101.8724531887, 5130.050940575856, 5150.845474635617, 5165.0, 5169.276301317744, 5209.817656382009, 4897.90204195907, 5001.974990125172, 5016.749162541785, 5022.397312322545, 5027.84916452507, 4853.369062021915, 4877.780499877443, 4900.289458028495, 4902.2156454967035, 4922.0, 4854.63590230727, 4923.507649235048, 4928.654994150518, 4933.9013219736125, 4937.703737775745, 4828.0, 4979.850604481871, 4988.925166122439, 4994.775235114501, 5033.144365457808, 4807.302941073455, 4852.272159176011, 4873.390826146731, 4930.802767889388, 4936.086823937583], "value": 4690.427180953181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.0215149956388, 561.6686155168451, 579.3800633322347, 583.0467186150643, 597.8355952113168, 26641.200763977064, 38835.0, 39008.804955975254, 39035.60964390359, 39309.80345098278, 41142.177156456855, 41466.7926660367, 41477.58522414775, 41682.37476437856, 41693.791531042305, 7697.268759467842, 7835.647395867171, 7836.608169591526, 7838.686452541891, 7839.490433121858, 7878.409119316046, 7944.880826787603, 7969.282764551189, 7969.641366138538, 7972.800679982989, 7909.525428474281, 7930.325922296612, 7958.602069896482, 7958.721444749435, 7963.72126975556, 7888.842223155533, 7911.762647120596, 7929.207079292082, 7933.682652693886, 7938.126806051329, 7624.656890439888, 7669.041369828771, 7676.692932282758, 7681.731139410093, 7682.116556595951, 38961.41557876634, 39309.60690393088, 39384.21231575381, 39393.80303098466, 39398.80300598507, 3007.233155545344, 3137.654857965622, 3161.1148878314107, 3172.191091271711, 3212.759043071779, 30037.549436758465, 30133.849330753426, 30148.698513015028, 30204.0, 30870.691293087006, 3538.575370955476, 3544.3088597723195, 3561.9696772839493, 3573.338932297533, 3626.909327266813, 237291.76249424918, 237997.0, 238514.0, 239376.0, 239942.0, 31525.684743152735, 51457.48542514602, 51985.48014519807, 51992.22011669828, 52125.47874521282, 33959.0, 34096.82951585226, 34139.82930085334, 34160.829195854356, 34169.65830341714, 13014.284214368112, 13134.73730525384, 13144.211347319191, 13146.4084116215, 13151.60545183646, 10701.304415213142, 10766.56933722658, 10770.461476926122, 10776.084032857296, 10801.405922674328, 7890.723824666109, 7895.684172633145, 7907.881381779278, 7985.2014798519685, 7985.68057277714, 3122.3286993296097, 3125.1718294651937, 3134.5925029745986, 3156.98421507891, 3174.4286028514625, 808.0, 856.1908995998846, 862.1895418306772, 879.6349514951223, 923.9445633261892, 27481.587776183373, 29946.30483256474, 31591.36817263642, 31869.406529673422, 32316.19209519781, 800.6797281087495, 939.4222553129775, 950.396498223633, 952.2191802721702, 991.1822746234385, 13770.586882393543, 14039.508617198553, 14093.85906140946, 14216.119796741372, 14266.215358155401, 380510.0, 381038.0, 383826.0, 384461.0, 384702.0, 47297.763511182915, 47882.28176577354, 47963.0, 47981.280280795814, 47985.0, 1090.460222190021, 1167.1654766841748, 1202.0804084875078, 1202.1464760020308, 1211.8669044443473, 27411.451770964868, 28175.15474535767, 28398.43203135967, 28613.46083118797, 29192.0, 41187.1762564753, 41647.58352416437, 41800.79099604482, 41842.372364413946, 41846.37230441485, 309696.0, 312390.0, 312913.0, 313276.0, 313391.0, 22052.669209962183, 23843.761562384156, 24528.01887924463, 24720.258392248263, 26035.73964260333, 41000.58999410087, 41167.794161029, 41439.79280103701, 41639.0, 42100.36849447322, 35669.1082722934, 35711.46432803458, 35844.103897402776, 36341.636583634885, 36457.63542364542, 35102.0, 35535.46696799498, 35538.289234215685, 35593.82203088968, 35748.106297342776, 34246.0, 34803.0, 35154.64845351616, 35577.46633800547, 35714.0, 30712.84643576768, 31630.841845790623, 31997.8400107998, 32472.35055298928, 34101.48847767335, 25341.61987570151, 25365.239042828744, 25413.74586254114, 25660.871695641403, 25777.355566110247], "value": 16347.132248634782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.12744829099677, 357.88368780146453, 358.48020370462837, 377.33588883564954, 382.0410768969885, 15523.146226957513, 17097.23062462189, 17308.221130049147, 17659.0, 17809.198586063627, 16111.0, 16480.175991200453, 17359.47921562352, 17407.390741324056, 17448.47654570362, 4912.92630610542, 5146.922796158061, 5151.278820965068, 5195.0, 5195.116830138866, 3695.113172838513, 3831.04223944014, 5053.67151135175, 5716.857078573048, 6017.789377371793, 6006.639601623895, 6010.489108425789, 6018.6990650467305, 6029.577929544934, 6036.667983260919, 5686.289213848269, 5967.671778052206, 5976.103584462344, 5982.491488223506, 5986.161937328778, 3323.3187196624635, 4907.803687852482, 5224.085784987612, 5269.473052694738, 5280.551153151987, 20416.285430009877, 20495.077721502566, 20613.175472981064, 20630.17479300826, 20638.690419643717, 2024.230792298917, 2037.7147199392098, 2150.430136013942, 2236.4856083100817, 2454.239185852374, 13242.404091815892, 13274.86725132746, 13335.533256336079, 13391.129576577589, 13843.30783460823, 1725.6031112843991, 1798.145880706667, 1807.412590907947, 1827.4426299978634, 1849.6763066463316, 63338.199708017666, 63381.51401672906, 63522.364776352566, 64292.35707642957, 65598.67200664013, 9005.819883602291, 9127.269818414643, 9291.628334866666, 9351.953240233892, 9401.811963760687, 12631.810522842165, 12827.743445131046, 12891.742165156644, 12895.742085158245, 12953.222806631633, 6494.772682956074, 6540.8364790880605, 6605.207375115017, 6700.162479690039, 6728.562643428161, 6195.783147589813, 6264.467520260738, 6313.779017734358, 6393.552451328363, 6404.48764098871, 6151.169592105009, 6152.846178845564, 6221.657808820558, 6275.121482992385, 6383.4574061204385, 1572.944946926852, 1644.8930819496934, 1645.2843013289257, 1671.9331226751037, 1746.5720898379725, 868.0581568997582, 870.2602787630464, 886.1492966751862, 895.3463971300987, 959.6449313753956, 16420.343186272654, 16878.915605421895, 17429.302827886997, 17646.2059207336, 18726.81273187278, 832.8584140696096, 846.5344060766554, 856.6787454704486, 862.4997501449144, 927.0590350793949, 9294.302927280482, 9838.311318207656, 9935.850962235572, 9947.801043979225, 10138.949305253427, 384380.0, 387530.0, 389756.0, 390650.0, 391644.0, 74363.0, 79605.60197198977, 80444.19555804484, 80624.0, 81580.0, 886.2334081019872, 902.7111324376268, 907.5689047702289, 921.7280902133887, 947.3747326764164, 15672.294746736652, 15850.60373490672, 15899.682006359577, 16009.759853602438, 16329.591760205614, 36915.446268306536, 37026.6297337034, 37114.44328335023, 37971.81014094912, 38712.41931371088, 49673.0, 51309.23036154536, 51428.0, 51970.22044669409, 52078.0, 7524.548527088392, 7636.427267954815, 7680.462367634435, 7743.690252389842, 7788.221177882393, 8216.383771217063, 10414.0, 11071.612493562687, 11604.129690273094, 11604.6518604442, 9822.508874556386, 9871.062249086326, 10299.639512617023, 10415.94792026035, 10418.166546676399, 10125.848112278469, 10280.0, 10288.331258468175, 10403.219758518293, 10515.474226288808, 9352.205062569486, 9933.801323973335, 10062.094411503, 10488.10851077667, 10686.0916822071, 7714.305712485903, 7740.26467485588, 7833.295003449717, 7842.960785196037, 7905.56519391439, 9512.524373781422, 9934.850977235492, 10385.584576617153, 10471.0, 10516.737081573021], "value": 8307.955439307503, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1178.3872386359087, 1367.405178747245, 1390.1520072755618, 1469.5370958148183, 1684.0400971446272, 6522.0869078329015, 7398.29716176963, 7548.094228692565, 7564.357029652486, 7837.529748215111, 7514.286142816437, 7682.807929801757, 7709.653065612061, 7712.730054448096, 7713.228677132298, 1876.887386756799, 2105.610462064515, 2150.924717634887, 2173.1416090644184, 2182.15986845065, 2225.8441909066373, 2245.696830927828, 2248.9662655060188, 2252.3693365857584, 2253.583087128878, 2189.4526368407896, 2202.2952655150357, 2222.811061059812, 2229.308914236592, 2229.832762542808, 1859.7396364509048, 2069.3274685727197, 2120.2579097315815, 2128.457243402938, 2154.5475450155486, 2179.3353027326657, 2194.297824696098, 2201.416624594484, 2202.1301585873653, 2202.383332666856, 7712.113106992711, 7741.729039483591, 7755.689772409097, 7757.9224207758325, 7769.53382797034, 4504.864854054384, 4619.214733495281, 4631.861044168647, 4632.629389648854, 4635.188841952645, 2736.8905243790423, 2839.544011943485, 2884.278930267433, 2896.145637037058, 2934.8826046958097, 933.6732143749701, 937.784309608787, 946.4368700623119, 949.1789601994294, 958.3004406783087, 10233.48832558369, 10249.64126255585, 10261.948690256575, 10284.125849302818, 10303.896961030368, 4098.262312783668, 4193.916121677549, 4275.209086318979, 4279.443672322578, 4286.485621725413, 8810.207081362709, 8844.867326990101, 8860.556972151368, 8864.20222179994, 8873.778155546162, 4591.311303304465, 4604.194266003436, 4605.907881842344, 4608.216603177468, 4613.0, 3636.2363903580545, 4095.140020595649, 4182.769947652909, 4200.075983283673, 4290.764007979528, 3556.448750443634, 3571.232185080168, 3578.1054736315923, 3641.617630148849, 3679.19057807282, 1134.920555561103, 1167.9299242045504, 1201.813718873576, 1204.0608325506118, 1205.9638210853689, 780.8321210939562, 786.5634572812144, 799.8440304140637, 805.0259186384424, 812.6180695073306, 4807.278908163804, 5032.949670503248, 5071.137906555894, 5092.719900405439, 5127.743612819344, 386.25645632157983, 392.9744566603219, 396.8591150141716, 400.08580393800025, 403.3566461493912, 3284.950725739116, 3398.3543126805826, 3434.1929646533545, 3440.2775417162175, 3447.9827600861836, 8972.506512141896, 9393.0, 9458.716238512856, 9478.95260523693, 9485.573149208301, 9326.440413575207, 9353.0, 9360.859587106199, 9364.672236471692, 9383.202427793578, 7183.389411899942, 7248.528845625017, 7253.347198752138, 7260.891086633705, 7264.963675181696, 4965.3296804932315, 4975.776090075883, 4994.350734404504, 5036.143855544493, 5207.505286997729, 8295.917040829514, 8600.698975535826, 8650.956745216234, 8749.0, 8768.605412756313, 8699.608517616596, 8777.605007774539, 8836.513991730517, 8866.556672166236, 8869.423487473294, 5926.111083337534, 6512.902306465312, 6530.379613936669, 6558.934410656023, 6684.462573608, 7521.811954701177, 7540.886886696813, 7564.735234266775, 7599.0, 7601.6579253934815, 6335.366463353628, 6504.447121994494, 6518.641474718936, 6592.406683398517, 6632.701528431328, 6112.572119951561, 6229.781957631461, 6235.688215589294, 6241.0, 6250.4374606285655, 5726.0, 5758.280214973129, 5795.710214489174, 5802.767889284381, 5808.82573522795, 4097.8770636880945, 4148.8133034012935, 4190.350495673054, 4243.236217480883, 4270.914581708286, 4171.937420938749, 4226.218149642326, 4234.830606775818, 4252.107057517832, 4299.97850010748], "value": 3949.6018728636977, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.4236095516131, 300.7263390314814, 305.3831260853076, 306.4453339455584, 307.6892338737877, 4680.906381872361, 4792.664513484057, 4888.535589119028, 4895.412550493946, 4899.652595536225, 4793.808247670097, 4807.687500312486, 4829.744266490711, 4833.903321933559, 4861.319415281863, 3558.217192217708, 3667.7249206309634, 3676.1361080146144, 3763.454299126625, 3841.8271177797064, 3396.813175275359, 3618.8914332570066, 3691.1325838428083, 3694.2980833641523, 3717.6839968602703, 3702.426123950792, 3714.294284086015, 3724.7951362675044, 3738.8504459821575, 3745.4943582616406, 3705.4627079073516, 3741.588425273231, 3746.7939263340504, 3751.362268414349, 3752.7428311515673, 3160.3995240904155, 3205.214722393005, 3218.308063766278, 3291.308825146722, 3309.4043072246986, 4459.531749166355, 4516.909661806778, 4631.143238500888, 4661.650376221797, 4700.788464519105, 4252.808623611914, 4260.190563792869, 4285.914281714348, 4286.228478873802, 4289.506706728735, 4828.203346447832, 5045.8807300933695, 5061.5950723942, 5063.240513922904, 5083.6441449098575, 3574.928501429983, 3586.444101164324, 3606.801625910574, 3610.855565777366, 3616.18635806944, 5081.8475445736685, 5106.829597421044, 5207.765650545697, 5239.3712754469325, 5255.842324730226, 3716.646918542734, 3737.467638268297, 3741.1582393961685, 3745.5879853216125, 3751.2309976454762, 3797.6582107610448, 3798.3922572388287, 3812.8856134316015, 3838.9616103838603, 3843.577206507282, 4318.632916202095, 4319.913601728011, 4322.449754644775, 4342.500612429548, 4358.869233922987, 5006.549410553068, 5064.215046667772, 5065.13892638245, 5073.594112470993, 5092.8472145835685, 1305.0081937727207, 1311.2001678975817, 1312.4356526693423, 1322.9680848937844, 1354.9187048777105, 815.1807433529265, 851.1573542193184, 853.3599800149888, 854.3592305770673, 857.0700789643307, 4016.51388986077, 4037.414574886625, 4053.9594604054173, 4056.7971601419813, 4110.712250142521, 4556.066006468666, 4567.725936443758, 4583.518730533313, 4706.95293047072, 4722.315264286659, 4002.779847108437, 4003.939940900889, 4005.819738111792, 4058.492688413948, 4072.2873497137884, 2460.8892599833052, 2582.625519299691, 2821.7883658725677, 2834.8093800603797, 2840.744333010039, 4914.70511769295, 4924.778384972685, 4929.186684197139, 4930.8767280818265, 4949.208126699711, 5182.738074600894, 5325.893482130413, 5334.91997620036, 5383.7308134593895, 5383.946160538345, 4841.782119804618, 4895.290182923456, 4901.3383193268455, 4921.597344756728, 4932.654714170046, 5214.634975551827, 5245.564155478168, 5251.973740131428, 5264.263003179634, 5280.762365693477, 4884.316195732529, 5170.1986192140275, 5171.405288391883, 5175.844724658266, 5188.766505507186, 4695.600873925755, 4770.2129148691465, 4882.170031094652, 4949.430815456269, 4952.826651067196, 3696.4824924511126, 3728.7762734236035, 3764.284785890672, 3777.792221427848, 3791.4502397151705, 5231.293775340432, 5251.448597897166, 5331.573474122139, 5331.973340133274, 5347.491988261109, 4876.1474537396025, 5061.089003979319, 5072.213806859942, 5072.51811077947, 5089.592832573459, 5049.242613607841, 5054.891241886287, 5057.241413787961, 5058.443571207091, 5067.341245638044, 4961.7519124044375, 4990.8253211137435, 4992.425871024879, 5003.924941125959, 5013.0, 4884.4382895966, 5087.465816089258, 5113.284140220298, 5141.511556402136, 5153.3815942087185, 5008.6692349588575, 5015.22264049073, 5015.22264049073, 5022.573081288131, 5027.874303142451], "value": 3778.920385306129, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.8808686061078, 627.7802769030837, 662.1954325494527, 704.5350068954488, 725.8330583965686, 12754.617361479148, 12883.484660613576, 12932.0, 13281.7343653127, 13630.591082267536, 12418.316992565406, 12428.316442595653, 12508.81236781449, 12520.311382873939, 12544.686382840433, 624.8875202463555, 740.5889731199196, 750.4071783291193, 768.2202564397141, 788.9013873265842, 748.9138749043848, 751.3575892611793, 751.9887201691979, 752.1275320628073, 753.3107206905675, 811.9391045671598, 814.6008455856618, 815.2703330519182, 815.2988429950238, 815.4332738746574, 645.4578154350345, 783.6865253898486, 808.5068108453838, 809.3363441977581, 811.679386642276, 600.8858316919815, 601.5548494114367, 602.4908951935652, 602.5360472436199, 602.8432607522032, 12031.939840300742, 12050.276983381025, 12060.276383416935, 12069.698257543543, 12082.456289466994, 11997.880021199851, 12503.249805011637, 12733.554325598652, 12899.09706320558, 13065.412056457482, 11365.09079273656, 11828.112891533083, 11873.881261187364, 11986.160968732192, 12000.51997920082, 4219.535851056412, 4266.701330906838, 4332.891677708051, 4334.479862416499, 4486.327050942385, 59094.409055909324, 59895.70052149755, 60758.696206519126, 61016.0, 61442.0, 10042.19662427004, 10121.139703125169, 10295.3822770634, 10361.326513776581, 10373.58505659765, 16371.672566548603, 16401.0, 16508.0, 16550.586235344213, 16557.420490283024, 6769.932300677028, 6818.0, 6950.478714096463, 6961.860762784716, 7125.287471252833, 3573.892783216456, 3633.255182687543, 3703.370427027358, 3784.7350685452307, 3807.2575847709986, 2784.5962335461245, 2881.150060732089, 2881.6974217707257, 2885.942281154365, 2891.696371880922, 495.14093048560716, 497.4453484364907, 503.7934147716199, 507.56095976979645, 510.6757209172128, 479.9976000119977, 531.3995185440427, 537.5592014548112, 547.7945770336124, 552.5054033239775, 6668.766593169215, 6823.829404264933, 6914.965425172842, 7296.963515182496, 7308.232635573188, 481.1339588740254, 494.49314452686286, 515.9200323949793, 523.1995047577213, 541.2098336428779, 3057.9847100764355, 3192.1859925718795, 3401.3197360527993, 3491.0574144980715, 3562.8574857005947, 88161.55919220363, 88187.55906220428, 89117.97938185594, 89121.0, 90596.54701726449, 47959.0, 81388.18611813925, 81582.59208704038, 81661.0, 82877.58561207275, 73272.63363683254, 73667.52664946778, 75415.24584754193, 75621.0, 75718.0, 6732.629705366252, 6748.6963086660235, 6764.661766911733, 6808.65956702153, 6891.620960847202, 41825.0, 42603.0, 44396.77801610971, 44783.32825007693, 44784.328235075845, 57409.425905740405, 61353.0, 62311.0, 62754.37245627668, 65252.0, 9099.1810737034, 9125.680601178927, 9352.392094513834, 9380.202682771767, 9629.32594718363, 10062.39625622465, 10117.544710488193, 10127.341722787995, 10323.690289291333, 10693.732656683645, 8880.333974951775, 9076.500792456478, 9136.177744003071, 9429.245660347018, 9667.419954802734, 8657.0, 8816.118388161132, 8836.425632334134, 8852.424592401474, 8864.379493435397, 9097.909020909707, 9341.719748407559, 9429.717108486757, 9568.856467153137, 9580.0, 7614.505057171266, 7653.387728981556, 7707.499012564165, 7825.0, 8050.0, 7280.162781280009, 7584.810379740551, 7666.0, 7950.960245198737, 8077.919220807952], "value": 6085.625725114445, "unit": "score"}], "name": "dromaeo_css", "value": 6219.238130177069, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 115.0, 116.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 141.0, 133.0, 180.0, 136.0, 133.0, 160.0, 130.0, 192.0, 139.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 162.0, 161.0, 162.0, 165.0, 161.0, 161.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 107.0, 76.0, 78.0, 74.0, 74.0, 99.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 120.0, 86.0, 88.0, 87.0, 128.0, 88.0, 86.0, 135.0], "value": 99.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0, 116.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 64.0, 65.0, 64.0, 63.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 83.0, 84.0, 85.0, 90.0, 114.0, 83.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 150.0, 134.0, 139.0, 132.0, 130.0, 128.0, 133.0, 140.0, 143.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 174.0, 170.0, 177.0, 173.0, 171.0, 168.0, 167.0, 165.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 68.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1556.3999999999999, "alertThreshold": 2.0}]} 16:07:54 INFO - Return code: 0 16:07:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:07:54 INFO - # TBPL SUCCESS # 16:07:54 INFO - Running post-action listener: _resource_record_post_action 16:07:54 INFO - ##### 16:07:54 INFO - ##### Finished run-tests step (success) 16:07:54 INFO - ##### 16:07:54 INFO - Running post-run listener: _resource_record_post_run 16:07:54 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7786496; Write bytes: 448798720; Read time: 1416; Write time: 374432 16:07:54 INFO - TinderboxPrint: CPU usage
13.1% 16:07:54 INFO - TinderboxPrint: I/O read bytes / time
7,786,496 / 1,416 16:07:54 INFO - TinderboxPrint: I/O write bytes / time
448,798,720 / 374,432 16:07:54 INFO - TinderboxPrint: CPU idle
8,344.8 (86.9%) 16:07:54 INFO - TinderboxPrint: CPU user
1,215.6 (12.7%) 16:07:54 INFO - TinderboxPrint: Swap in / out
0 / 0 16:07:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107364352; Read time: 0; Write time: 71252 16:07:54 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 6025216; Write bytes: 341434368; Read time: 1392; Write time: 303180 16:07:54 INFO - Running post-run listener: _upload_blobber_files 16:07:54 INFO - Blob upload gear active. 16:07:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:07:54 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 16:07:54 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'] 16:07:54 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 16:07:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:07:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:07:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:07:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:55 INFO - (blobuploader) - INFO - Done attempting. 16:07:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:07:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:07:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:56 INFO - (blobuploader) - INFO - Done attempting. 16:07:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:07:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:00 INFO - (blobuploader) - INFO - Done attempting. 16:08:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:00 INFO - Return code: 0 16:08:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06c9bb2b1ea125dedf280d9e396641ae8a3f62b459f7334c7f8bc10ff8dea7a0f040c16ac6bc827382be274cf4ea61d431afca12a4006b4295f76acac69badee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/932ebd4f0193cf3887fc1292015460c816a76bbf0b898300a985891b982d26b942af6a8c2316dd5941795a51cfc9b7565e95bb0bf1a77c6ba19b7a47160c26b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f73e8770876c82d81388cb77b8391c126a9ae47f32a93498f443c55331106766177fe36371af9c1b5384849d4cb8559ad329cc7b54badaae60d1d8acdf8f2fc"} 16:08:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:00 INFO - Contents: 16:08:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06c9bb2b1ea125dedf280d9e396641ae8a3f62b459f7334c7f8bc10ff8dea7a0f040c16ac6bc827382be274cf4ea61d431afca12a4006b4295f76acac69badee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/932ebd4f0193cf3887fc1292015460c816a76bbf0b898300a985891b982d26b942af6a8c2316dd5941795a51cfc9b7565e95bb0bf1a77c6ba19b7a47160c26b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f73e8770876c82d81388cb77b8391c126a9ae47f32a93498f443c55331106766177fe36371af9c1b5384849d4cb8559ad329cc7b54badaae60d1d8acdf8f2fc"} 16:08:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:00 INFO - Copying logs to upload dir... 16:08:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.801659 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-15 16:08:00.774948) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 16:08:00.778663) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06c9bb2b1ea125dedf280d9e396641ae8a3f62b459f7334c7f8bc10ff8dea7a0f040c16ac6bc827382be274cf4ea61d431afca12a4006b4295f76acac69badee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/932ebd4f0193cf3887fc1292015460c816a76bbf0b898300a985891b982d26b942af6a8c2316dd5941795a51cfc9b7565e95bb0bf1a77c6ba19b7a47160c26b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f73e8770876c82d81388cb77b8391c126a9ae47f32a93498f443c55331106766177fe36371af9c1b5384849d4cb8559ad329cc7b54badaae60d1d8acdf8f2fc"} build_url:https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06c9bb2b1ea125dedf280d9e396641ae8a3f62b459f7334c7f8bc10ff8dea7a0f040c16ac6bc827382be274cf4ea61d431afca12a4006b4295f76acac69badee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/932ebd4f0193cf3887fc1292015460c816a76bbf0b898300a985891b982d26b942af6a8c2316dd5941795a51cfc9b7565e95bb0bf1a77c6ba19b7a47160c26b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5f73e8770876c82d81388cb77b8391c126a9ae47f32a93498f443c55331106766177fe36371af9c1b5384849d4cb8559ad329cc7b54badaae60d1d8acdf8f2fc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 16:08:00.803616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 16:08:00.803916) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466015675.849762-422823529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 16:08:00.885963) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 16:08:00.886269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 16:08:00.886540) ========= ========= Total master_lag: 0.17 =========