builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1466652145.67 results: success (0) buildid: 20160622190824 builduid: 5ac875adcc2549e0a9941c2ac1ae8640 revision: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:25.675354) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:25.675880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:25.676237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:25.783541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:25.783844) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 20:22:25-- 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% 41.4M=0s 2016-06-22 20:22:25 (41.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:25.922161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:25.922739) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019569 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:26.006468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 20:22:26.006868) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3724c395569322ea7f9fbf4a76d8b0734e9b8cda --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 3724c395569322ea7f9fbf4a76d8b0734e9b8cda --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=9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 20:22:26,103 truncating revision to first 12 chars 2016-06-22 20:22:26,103 Setting DEBUG logging. 2016-06-22 20:22:26,104 attempt 1/10 2016-06-22 20:22:26,104 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3724c3955693?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 20:22:26,812 unpacking tar archive at: fx-team-3724c3955693/testing/mozharness/ program finished with exit code 0 elapsedTime=1.035484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 20:22:27.058244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:27.058641) ========= script_repo_revision: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:27.059189) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:27.059546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 20:22:27.074740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-22 20:22:27.075193) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:22:27 INFO - MultiFileLogger online at 20160622 20:22:27 in /builds/slave/test 20:22:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:22:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:22:27 INFO - {'append_to_log': False, 20:22:27 INFO - 'base_work_dir': '/builds/slave/test', 20:22:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:22:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:22:27 INFO - 'branch': 'Fx-Team-Non-PGO', 20:22:27 INFO - 'buildbot_json_path': 'buildprops.json', 20:22:27 INFO - 'config_files': ('talos/linux_config.py',), 20:22:27 INFO - 'default_actions': ('clobber', 20:22:27 INFO - 'read-buildbot-config', 20:22:27 INFO - 'download-and-extract', 20:22:27 INFO - 'populate-webroot', 20:22:27 INFO - 'create-virtualenv', 20:22:27 INFO - 'install', 20:22:27 INFO - 'run-tests'), 20:22:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:22:27 INFO - 'download_minidump_stackwalk': True, 20:22:27 INFO - 'download_symbols': 'ondemand', 20:22:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:22:27 INFO - 'tooltool.py': '/tools/tooltool.py', 20:22:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:22:27 INFO - '/tools/misc-python/virtualenv.py')}, 20:22:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:22:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:22:27 INFO - 'installer_path': 'installer.exe', 20:22:27 INFO - 'log_level': 'info', 20:22:27 INFO - 'log_name': 'talos', 20:22:27 INFO - 'log_to_console': True, 20:22:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:22:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:22:27 INFO - 'opt_config_files': (), 20:22:27 INFO - 'pip_index': False, 20:22:27 INFO - 'sps_profile': False, 20:22:27 INFO - 'sps_profile_interval': 0, 20:22:27 INFO - 'suite': 'dromaeojs-e10s', 20:22:27 INFO - 'system_bits': '32', 20:22:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:22:27 INFO - 'title': 'talos-linux64-ix-022', 20:22:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:22:27 INFO - 'use_talos_json': True, 20:22:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:22:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:22:27 INFO - 'work_dir': 'build'} 20:22:27 INFO - ##### 20:22:27 INFO - ##### Running clobber step. 20:22:27 INFO - ##### 20:22:27 INFO - Running pre-action listener: _resource_record_pre_action 20:22:27 INFO - Running main action method: clobber 20:22:27 INFO - rmtree: /builds/slave/test/build 20:22:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:22:28 INFO - Running post-action listener: _resource_record_post_action 20:22:28 INFO - ##### 20:22:28 INFO - ##### Finished clobber step (success) 20:22:28 INFO - ##### 20:22:28 INFO - ##### 20:22:28 INFO - ##### Running read-buildbot-config step. 20:22:28 INFO - ##### 20:22:28 INFO - Running pre-action listener: _resource_record_pre_action 20:22:28 INFO - Running main action method: read_buildbot_config 20:22:28 INFO - Using buildbot properties: 20:22:28 INFO - { 20:22:28 INFO - "project": "", 20:22:28 INFO - "product": "firefox", 20:22:28 INFO - "script_repo_revision": "production", 20:22:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:22:28 INFO - "repository": "", 20:22:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 20:22:28 INFO - "buildid": "20160622190824", 20:22:28 INFO - "pgo_build": "False", 20:22:28 INFO - "basedir": "/builds/slave/test", 20:22:28 INFO - "buildnumber": 1383, 20:22:28 INFO - "slavename": "talos-linux64-ix-022", 20:22:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:22:28 INFO - "platform": "ubuntu64_hw", 20:22:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:22:28 INFO - "branch": "fx-team", 20:22:28 INFO - "repo_path": "integration/fx-team", 20:22:28 INFO - "revision": "3724c395569322ea7f9fbf4a76d8b0734e9b8cda", 20:22:28 INFO - "stage_platform": "linux64", 20:22:28 INFO - "builduid": "5ac875adcc2549e0a9941c2ac1ae8640", 20:22:28 INFO - "slavebuilddir": "test" 20:22:28 INFO - } 20:22:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:22:28 INFO - Running post-action listener: _resource_record_post_action 20:22:28 INFO - ##### 20:22:28 INFO - ##### Finished read-buildbot-config step (success) 20:22:28 INFO - ##### 20:22:28 INFO - ##### 20:22:28 INFO - ##### Running download-and-extract step. 20:22:28 INFO - ##### 20:22:28 INFO - Running pre-action listener: _resource_record_pre_action 20:22:28 INFO - Running main action method: download_and_extract 20:22:28 INFO - mkdir: /builds/slave/test/build/tests 20:22:28 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')]} 20:22:28 INFO - https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:29 INFO - Downloaded 1361 bytes. 20:22:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:22:29 INFO - Using the following test package requirements: 20:22:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:22:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:22:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:29 INFO - u'jsshell-linux-x86_64.zip'], 20:22:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:22:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:22:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:22:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:22:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:22:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:22:29 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')]} 20:22:29 INFO - https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:22:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:22:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:31 INFO - Downloaded 22703251 bytes. 20:22:31 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'] 20:22:31 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 20:22:33 INFO - Return code: 0 20:22:33 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 20:22: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')]} 20:22:33 INFO - https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:22:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:22:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:44 INFO - Downloaded 22703251 bytes. 20:22:44 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'] 20:22:44 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 20:22:45 INFO - Return code: 0 20:22:45 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')]} 20:22:45 INFO - https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:49 INFO - Downloaded 14405384 bytes. 20:22:49 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'] 20:22:49 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 20:22:49 INFO - Return code: 0 20:22:49 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')]} 20:22:49 INFO - https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:22:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:22:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:22:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/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 20:22:51 INFO - Downloaded 56263900 bytes. 20:22:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:22:51 INFO - mkdir: /builds/slave/test/properties 20:22:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:22:51 INFO - Writing to file /builds/slave/test/properties/build_url 20:22:51 INFO - Contents: 20:22:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:22:52 INFO - Running post-action listener: _resource_record_post_action 20:22:52 INFO - Running post-action listener: set_extra_try_arguments 20:22:52 INFO - ##### 20:22:52 INFO - ##### Finished download-and-extract step (success) 20:22:52 INFO - ##### 20:22:52 INFO - ##### 20:22:52 INFO - ##### Running populate-webroot step. 20:22:52 INFO - ##### 20:22:52 INFO - Running pre-action listener: _resource_record_pre_action 20:22:52 INFO - Running main action method: populate_webroot 20:22:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:22:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:22:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:22:52 INFO - '--tppagecycles', 20:22:52 INFO - '7'], 20:22:52 INFO - 'tests': ['tsvgm']}}, 20:22:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:22:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:22:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:22:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:22:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:52 INFO - 'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:52 INFO - 'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['damp', 'tps']}, 20:22:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:52 INFO - 'tests': ['damp', 'tps']}, 20:22:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['dromaeo_dom']}, 20:22:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:22:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['basic_compositor_video']}, 20:22:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:22:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['a11yr', 20:22:52 INFO - 'ts_paint', 20:22:52 INFO - 'tpaint', 20:22:52 INFO - 'sessionrestore', 20:22:52 INFO - 'sessionrestore_no_auto_restore', 20:22:52 INFO - 'tabpaint']}, 20:22:52 INFO - 'other-e10s': {'tests': ['a11yr', 20:22:52 INFO - 'ts_paint', 20:22:52 INFO - 'tpaint', 20:22:52 INFO - 'sessionrestore', 20:22:52 INFO - 'sessionrestore_no_auto_restore', 20:22:52 INFO - 'tabpaint']}, 20:22:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:22:52 INFO - 'ts_paint', 20:22:52 INFO - 'tpaint', 20:22:52 INFO - 'sessionrestore', 20:22:52 INFO - 'sessionrestore_no_auto_restore', 20:22:52 INFO - 'tabpaint']}, 20:22:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:22:52 INFO - 'ts_paint', 20:22:52 INFO - 'tpaint', 20:22:52 INFO - 'sessionrestore', 20:22:52 INFO - 'sessionrestore_no_auto_restore', 20:22:52 INFO - 'tabpaint']}, 20:22:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['a11yr', 20:22:52 INFO - 'ts_paint', 20:22:52 INFO - 'tpaint', 20:22:52 INFO - 'sessionrestore', 20:22:52 INFO - 'sessionrestore_no_auto_restore', 20:22:52 INFO - 'tabpaint']}, 20:22:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['a11yr', 20:22:52 INFO - 'ts_paint', 20:22:52 INFO - 'tpaint', 20:22:52 INFO - 'sessionrestore', 20:22:52 INFO - 'sessionrestore_no_auto_restore', 20:22:52 INFO - 'tabpaint']}, 20:22:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['tsvgx', 20:22:52 INFO - 'tsvgr_opacity', 20:22:52 INFO - 'tart', 20:22:52 INFO - 'tscrollx', 20:22:52 INFO - 'cart']}, 20:22:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:22:52 INFO - 'tsvgr_opacity', 20:22:52 INFO - 'tart', 20:22:52 INFO - 'tscrollx', 20:22:52 INFO - 'cart']}, 20:22:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:52 INFO - 'talos_options': ['--disable-e10s'], 20:22:52 INFO - 'tests': ['tp5o']}, 20:22:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:52 INFO - 'tests': ['tp5o']}, 20:22:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:52 INFO - 'talos_options': ['--disable-e10s', 20:22:52 INFO - '--xperf_path', 20:22:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:52 INFO - 'tests': ['tp5n']}, 20:22:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:52 INFO - 'talos_options': ['--xperf_path', 20:22:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:52 INFO - 'tests': ['tp5n']}}, 20:22:52 INFO - 'talos.zip': {'path': '', 20:22:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:22:52 INFO - Running post-action listener: _resource_record_post_action 20:22:52 INFO - ##### 20:22:52 INFO - ##### Finished populate-webroot step (success) 20:22:52 INFO - ##### 20:22:52 INFO - ##### 20:22:52 INFO - ##### Running create-virtualenv step. 20:22:52 INFO - ##### 20:22:52 INFO - Running pre-action listener: _resource_record_pre_action 20:22:52 INFO - Running main action method: create_virtualenv 20:22:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:22:52 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 20:22:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:22:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:22:52 INFO - Using real prefix '/usr' 20:22:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:22:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:22:54 INFO - Installing pip.................done. 20:22:54 INFO - Return code: 0 20:22:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:54 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 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:22:54 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 20:22:54 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 20:22:54 INFO - Using env: {'DISPLAY': ':0', 20:22:54 INFO - 'HOME': '/home/cltbld', 20:22:54 INFO - 'LANG': 'en_US.UTF-8', 20:22:54 INFO - 'LANGUAGE': 'en_US:en', 20:22:54 INFO - 'LOGNAME': 'cltbld', 20:22:54 INFO - 'MAIL': '/var/mail/cltbld', 20:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:54 INFO - 'MOZ_NO_REMOTE': '1', 20:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:54 INFO - 'NO_EM_RESTART': '1', 20:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:54 INFO - 'PWD': '/builds/slave/test', 20:22:54 INFO - 'SHELL': '/bin/bash', 20:22:54 INFO - 'SHLVL': '1', 20:22:54 INFO - 'TERM': 'linux', 20:22:54 INFO - 'TMOUT': '86400', 20:22:54 INFO - 'USER': 'cltbld', 20:22:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:54 INFO - '_': '/tools/buildbot/bin/python'} 20:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:54 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 20:22:54 INFO - Cleaning up... 20:22:54 INFO - Return code: 0 20:22:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:54 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 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:22:54 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 20:22:54 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 20:22:54 INFO - Using env: {'DISPLAY': ':0', 20:22:54 INFO - 'HOME': '/home/cltbld', 20:22:54 INFO - 'LANG': 'en_US.UTF-8', 20:22:54 INFO - 'LANGUAGE': 'en_US:en', 20:22:54 INFO - 'LOGNAME': 'cltbld', 20:22:54 INFO - 'MAIL': '/var/mail/cltbld', 20:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:54 INFO - 'MOZ_NO_REMOTE': '1', 20:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:54 INFO - 'NO_EM_RESTART': '1', 20:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:54 INFO - 'PWD': '/builds/slave/test', 20:22:54 INFO - 'SHELL': '/bin/bash', 20:22:54 INFO - 'SHLVL': '1', 20:22:54 INFO - 'TERM': 'linux', 20:22:54 INFO - 'TMOUT': '86400', 20:22:54 INFO - 'USER': 'cltbld', 20:22:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:54 INFO - '_': '/tools/buildbot/bin/python'} 20:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:55 INFO - Downloading/unpacking psutil>=3.1.1 20:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:57 INFO - Installing collected packages: psutil 20:22:57 INFO - Running setup.py install for psutil 20:22:57 INFO - building 'psutil._psutil_linux' extension 20:22:57 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 20:22:57 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 20:22:57 INFO - building 'psutil._psutil_posix' extension 20:22:57 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 20:22:57 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 20:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:57 INFO - Successfully installed psutil 20:22:57 INFO - Cleaning up... 20:22:57 INFO - Return code: 0 20:22:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:22:57 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')]} 20:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:57 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')]} 20:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:57 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 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:22:57 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 20:22:57 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 20:22:57 INFO - Using env: {'DISPLAY': ':0', 20:22:57 INFO - 'HOME': '/home/cltbld', 20:22:57 INFO - 'LANG': 'en_US.UTF-8', 20:22:57 INFO - 'LANGUAGE': 'en_US:en', 20:22:57 INFO - 'LOGNAME': 'cltbld', 20:22:57 INFO - 'MAIL': '/var/mail/cltbld', 20:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:57 INFO - 'MOZ_NO_REMOTE': '1', 20:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:57 INFO - 'NO_EM_RESTART': '1', 20:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:57 INFO - 'PWD': '/builds/slave/test', 20:22:57 INFO - 'SHELL': '/bin/bash', 20:22:57 INFO - 'SHLVL': '1', 20:22:57 INFO - 'TERM': 'linux', 20:22:57 INFO - 'TMOUT': '86400', 20:22:57 INFO - 'USER': 'cltbld', 20:22:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:57 INFO - '_': '/tools/buildbot/bin/python'} 20:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:23:00 INFO - Installing collected packages: mozsystemmonitor 20:23:00 INFO - Running setup.py install for mozsystemmonitor 20:23:00 INFO - Successfully installed mozsystemmonitor 20:23:00 INFO - Cleaning up... 20:23:00 INFO - Return code: 0 20:23:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:23:00 INFO - Using env: {'DISPLAY': ':0', 20:23:00 INFO - 'HOME': '/home/cltbld', 20:23:00 INFO - 'LANG': 'en_US.UTF-8', 20:23:00 INFO - 'LANGUAGE': 'en_US:en', 20:23:00 INFO - 'LOGNAME': 'cltbld', 20:23:00 INFO - 'MAIL': '/var/mail/cltbld', 20:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:00 INFO - 'MOZ_NO_REMOTE': '1', 20:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:00 INFO - 'NO_EM_RESTART': '1', 20:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:00 INFO - 'PWD': '/builds/slave/test', 20:23:00 INFO - 'SHELL': '/bin/bash', 20:23:00 INFO - 'SHLVL': '1', 20:23:00 INFO - 'TERM': 'linux', 20:23:00 INFO - 'TMOUT': '86400', 20:23:00 INFO - 'USER': 'cltbld', 20:23:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:00 INFO - '_': '/tools/buildbot/bin/python'} 20:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:00 INFO - Downloading/unpacking jsonschema==2.5.1 20:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:23:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:23:02 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 20:23:02 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 20:23:02 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 20:23:02 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 20:23:02 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 20:23:02 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 20:23:02 INFO - Downloading functools32-3.2.3-2.tar.gz 20:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:23:02 INFO - warning: no files found matching '*.txt' 20:23:02 INFO - no previously-included directories found matching 'build' 20:23:02 INFO - no previously-included directories found matching 'dist' 20:23:02 INFO - no previously-included directories found matching '.git*' 20:23:02 INFO - Installing collected packages: jsonschema, functools32 20:23:03 INFO - Running setup.py install for functools32 20:23:03 INFO - warning: no files found matching '*.txt' 20:23:03 INFO - no previously-included directories found matching 'build' 20:23:03 INFO - no previously-included directories found matching 'dist' 20:23:03 INFO - no previously-included directories found matching '.git*' 20:23:03 INFO - Successfully installed jsonschema functools32 20:23:03 INFO - Cleaning up... 20:23:03 INFO - Return code: 0 20:23:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:23:03 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')]} 20:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:03 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')]} 20:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:03 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 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:23:03 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 20:23:03 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 20:23:03 INFO - Using env: {'DISPLAY': ':0', 20:23:03 INFO - 'HOME': '/home/cltbld', 20:23:03 INFO - 'LANG': 'en_US.UTF-8', 20:23:03 INFO - 'LANGUAGE': 'en_US:en', 20:23:03 INFO - 'LOGNAME': 'cltbld', 20:23:03 INFO - 'MAIL': '/var/mail/cltbld', 20:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:03 INFO - 'MOZ_NO_REMOTE': '1', 20:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:03 INFO - 'NO_EM_RESTART': '1', 20:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:03 INFO - 'PWD': '/builds/slave/test', 20:23:03 INFO - 'SHELL': '/bin/bash', 20:23:03 INFO - 'SHLVL': '1', 20:23:03 INFO - 'TERM': 'linux', 20:23:03 INFO - 'TMOUT': '86400', 20:23:03 INFO - 'USER': 'cltbld', 20:23:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:03 INFO - '_': '/tools/buildbot/bin/python'} 20:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:03 INFO - Downloading/unpacking blobuploader==1.2.4 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 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 20:23:03 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 20:23:05 INFO - Downloading blobuploader-1.2.4.tar.gz 20:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:23:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:23:05 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 20:23:05 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 20:23:05 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 20:23:05 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 20:23:05 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 20:23:05 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 20:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:23:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:23:05 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 20:23:05 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 20:23:05 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 20:23:05 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 20:23:05 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 20:23:05 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 20:23:06 INFO - Downloading docopt-0.6.1.tar.gz 20:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:23:06 INFO - Installing collected packages: blobuploader, requests, docopt 20:23:06 INFO - Running setup.py install for blobuploader 20:23:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:23:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:23:06 INFO - Running setup.py install for requests 20:23:06 INFO - Running setup.py install for docopt 20:23:06 INFO - Successfully installed blobuploader requests docopt 20:23:06 INFO - Cleaning up... 20:23:06 INFO - Return code: 0 20:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23: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')]} 20:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23: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')]} 20:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:06 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 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:23:06 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 20:23:06 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 20:23:06 INFO - Using env: {'DISPLAY': ':0', 20:23:06 INFO - 'HOME': '/home/cltbld', 20:23:06 INFO - 'LANG': 'en_US.UTF-8', 20:23:06 INFO - 'LANGUAGE': 'en_US:en', 20:23:06 INFO - 'LOGNAME': 'cltbld', 20:23:06 INFO - 'MAIL': '/var/mail/cltbld', 20:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:06 INFO - 'MOZ_NO_REMOTE': '1', 20:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:06 INFO - 'NO_EM_RESTART': '1', 20:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:06 INFO - 'PWD': '/builds/slave/test', 20:23:06 INFO - 'SHELL': '/bin/bash', 20:23:06 INFO - 'SHLVL': '1', 20:23:06 INFO - 'TERM': 'linux', 20:23:06 INFO - 'TMOUT': '86400', 20:23:06 INFO - 'USER': 'cltbld', 20:23:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:06 INFO - '_': '/tools/buildbot/bin/python'} 20:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:23:06 INFO - Running setup.py (path:/tmp/pip-SzfhWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:23:07 INFO - Running setup.py (path:/tmp/pip-EzVqCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:23:07 INFO - Running setup.py (path:/tmp/pip-fPw7_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:23:07 INFO - Running setup.py (path:/tmp/pip-3NCT0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:23:07 INFO - Running setup.py (path:/tmp/pip-uGAgBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:23:07 INFO - Running setup.py (path:/tmp/pip-XOXs9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:23:07 INFO - Running setup.py (path:/tmp/pip-foYnxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:23:07 INFO - Running setup.py (path:/tmp/pip-MvJ14n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:23:07 INFO - Running setup.py (path:/tmp/pip-0eo2v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:23:07 INFO - Running setup.py (path:/tmp/pip-ABiy8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:23:07 INFO - Running setup.py (path:/tmp/pip-yF4F3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:23:07 INFO - Running setup.py (path:/tmp/pip-v68NcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:23:07 INFO - Running setup.py (path:/tmp/pip-DoaA1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:23:07 INFO - Running setup.py (path:/tmp/pip-aEVFDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:07 INFO - Running setup.py (path:/tmp/pip-LjkN3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:23:08 INFO - Running setup.py (path:/tmp/pip-GYDsdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:23:08 INFO - Running setup.py (path:/tmp/pip-TIHhoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:23:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:23:08 INFO - Running setup.py install for manifestparser 20:23:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Running setup.py install for mozcrash 20:23:08 INFO - Running setup.py install for mozdebug 20:23:08 INFO - Running setup.py install for mozdevice 20:23:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Running setup.py install for mozfile 20:23:08 INFO - Running setup.py install for mozhttpd 20:23:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Running setup.py install for mozinfo 20:23:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Running setup.py install for mozInstall 20:23:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:23:08 INFO - Running setup.py install for mozleak 20:23:09 INFO - Running setup.py install for mozlog 20:23:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for moznetwork 20:23:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for mozprocess 20:23:09 INFO - Running setup.py install for mozprofile 20:23:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for mozrunner 20:23:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Running setup.py install for mozscreenshot 20:23:09 INFO - Running setup.py install for moztest 20:23:09 INFO - Running setup.py install for mozversion 20:23:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:23:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:23:09 INFO - Cleaning up... 20:23:09 INFO - Return code: 0 20:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23: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')]} 20:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23: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')]} 20:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:09 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 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:23:09 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 20:23:09 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 20:23:09 INFO - Using env: {'DISPLAY': ':0', 20:23:09 INFO - 'HOME': '/home/cltbld', 20:23:09 INFO - 'LANG': 'en_US.UTF-8', 20:23:09 INFO - 'LANGUAGE': 'en_US:en', 20:23:09 INFO - 'LOGNAME': 'cltbld', 20:23:09 INFO - 'MAIL': '/var/mail/cltbld', 20:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:09 INFO - 'MOZ_NO_REMOTE': '1', 20:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:09 INFO - 'NO_EM_RESTART': '1', 20:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:09 INFO - 'PWD': '/builds/slave/test', 20:23:09 INFO - 'SHELL': '/bin/bash', 20:23:09 INFO - 'SHLVL': '1', 20:23:09 INFO - 'TERM': 'linux', 20:23:09 INFO - 'TMOUT': '86400', 20:23:09 INFO - 'USER': 'cltbld', 20:23:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:09 INFO - '_': '/tools/buildbot/bin/python'} 20:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:23:10 INFO - Running setup.py (path:/tmp/pip-w1MQnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:23:10 INFO - Running setup.py (path:/tmp/pip-P5H4jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:23:10 INFO - Running setup.py (path:/tmp/pip-S6fvmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:23:10 INFO - Running setup.py (path:/tmp/pip-ebBIn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:23:10 INFO - Running setup.py (path:/tmp/pip-5rAr_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:23:10 INFO - Running setup.py (path:/tmp/pip-Q8u7dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:23:10 INFO - Running setup.py (path:/tmp/pip-W4LUhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:23:10 INFO - Running setup.py (path:/tmp/pip-i8YIIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:23:10 INFO - Running setup.py (path:/tmp/pip-KYMDjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:23:10 INFO - Running setup.py (path:/tmp/pip-pr_Qgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:23:10 INFO - Running setup.py (path:/tmp/pip-y4KE_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:23:10 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)) 20:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:23:10 INFO - Running setup.py (path:/tmp/pip-cFHzwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:23:11 INFO - Running setup.py (path:/tmp/pip-6odmra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:23:11 INFO - Running setup.py (path:/tmp/pip-D167WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:11 INFO - Running setup.py (path:/tmp/pip-sx1Ifr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:23:11 INFO - Running setup.py (path:/tmp/pip-r_eXL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:23:11 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)) 20:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:23:11 INFO - Running setup.py (path:/tmp/pip-tZ2Vhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:23:11 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)) 20:23:11 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)) 20:23:11 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)) 20:23:11 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)) 20:23:11 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)) 20:23:11 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)) 20:23:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:13 INFO - Downloading blessings-1.6.tar.gz 20:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:23:13 INFO - Installing collected packages: blessings 20:23:13 INFO - Running setup.py install for blessings 20:23:13 INFO - Successfully installed blessings 20:23:13 INFO - Cleaning up... 20:23:13 INFO - Return code: 0 20:23:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:23:13 INFO - Reading from file tmpfile_stdout 20:23:13 INFO - Current package versions: 20:23:13 INFO - argparse == 1.2.1 20:23:13 INFO - blessings == 1.6 20:23:13 INFO - blobuploader == 1.2.4 20:23:13 INFO - docopt == 0.6.1 20:23:13 INFO - functools32 == 3.2.3-2 20:23:13 INFO - jsonschema == 2.5.1 20:23:13 INFO - manifestparser == 1.1 20:23:13 INFO - mozInstall == 1.12 20:23:13 INFO - mozcrash == 0.17 20:23:13 INFO - mozdebug == 0.1 20:23:13 INFO - mozdevice == 0.48 20:23:13 INFO - mozfile == 1.2 20:23:13 INFO - mozhttpd == 0.7 20:23:13 INFO - mozinfo == 0.9 20:23:13 INFO - mozleak == 0.1 20:23:13 INFO - mozlog == 3.2 20:23:13 INFO - moznetwork == 0.27 20:23:13 INFO - mozprocess == 0.22 20:23:13 INFO - mozprofile == 0.28 20:23:13 INFO - mozrunner == 6.11 20:23:13 INFO - mozscreenshot == 0.1 20:23:13 INFO - mozsystemmonitor == 0.3 20:23:13 INFO - moztest == 0.7 20:23:13 INFO - mozversion == 1.4 20:23:13 INFO - psutil == 3.1.1 20:23:13 INFO - requests == 1.2.3 20:23:13 INFO - wsgiref == 0.1.2 20:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23:13 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')]} 20:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:13 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')]} 20:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:13 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 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:23:13 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 20:23:13 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 20:23:13 INFO - Using env: {'DISPLAY': ':0', 20:23:13 INFO - 'HOME': '/home/cltbld', 20:23:13 INFO - 'LANG': 'en_US.UTF-8', 20:23:13 INFO - 'LANGUAGE': 'en_US:en', 20:23:13 INFO - 'LOGNAME': 'cltbld', 20:23:13 INFO - 'MAIL': '/var/mail/cltbld', 20:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:13 INFO - 'MOZ_NO_REMOTE': '1', 20:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:13 INFO - 'NO_EM_RESTART': '1', 20:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:13 INFO - 'PWD': '/builds/slave/test', 20:23:13 INFO - 'SHELL': '/bin/bash', 20:23:13 INFO - 'SHLVL': '1', 20:23:13 INFO - 'TERM': 'linux', 20:23:13 INFO - 'TMOUT': '86400', 20:23:13 INFO - 'USER': 'cltbld', 20:23:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:13 INFO - '_': '/tools/buildbot/bin/python'} 20:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:13 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)) 20:23:13 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)) 20:23:13 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)) 20:23:13 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)) 20:23:13 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)) 20:23:13 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)) 20:23:13 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)) 20:23:13 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)) 20:23:13 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)) 20:23:13 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)) 20:23:13 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)) 20:23:13 INFO - Cleaning up... 20:23:13 INFO - Return code: 0 20:23:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:23:13 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')]} 20:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:13 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')]} 20:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:13 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 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:23:13 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 20:23:13 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 20:23:13 INFO - Using env: {'DISPLAY': ':0', 20:23:13 INFO - 'HOME': '/home/cltbld', 20:23:13 INFO - 'LANG': 'en_US.UTF-8', 20:23:13 INFO - 'LANGUAGE': 'en_US:en', 20:23:13 INFO - 'LOGNAME': 'cltbld', 20:23:13 INFO - 'MAIL': '/var/mail/cltbld', 20:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:13 INFO - 'MOZ_NO_REMOTE': '1', 20:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:13 INFO - 'NO_EM_RESTART': '1', 20:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:13 INFO - 'PWD': '/builds/slave/test', 20:23:13 INFO - 'SHELL': '/bin/bash', 20:23:13 INFO - 'SHLVL': '1', 20:23:13 INFO - 'TERM': 'linux', 20:23:13 INFO - 'TMOUT': '86400', 20:23:13 INFO - 'USER': 'cltbld', 20:23:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:13 INFO - '_': '/tools/buildbot/bin/python'} 20:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:23:14 INFO - Cleaning up... 20:23:14 INFO - Return code: 0 20:23:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f041a67af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2014350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', '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 20:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:23:14 INFO - Using env: {'DISPLAY': ':0', 20:23:14 INFO - 'HOME': '/home/cltbld', 20:23:14 INFO - 'LANG': 'en_US.UTF-8', 20:23:14 INFO - 'LANGUAGE': 'en_US:en', 20:23:14 INFO - 'LOGNAME': 'cltbld', 20:23:14 INFO - 'MAIL': '/var/mail/cltbld', 20:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:14 INFO - 'MOZ_NO_REMOTE': '1', 20:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:14 INFO - 'NO_EM_RESTART': '1', 20:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:14 INFO - 'PWD': '/builds/slave/test', 20:23:14 INFO - 'SHELL': '/bin/bash', 20:23:14 INFO - 'SHLVL': '1', 20:23:14 INFO - 'TERM': 'linux', 20:23:14 INFO - 'TMOUT': '86400', 20:23:14 INFO - 'USER': 'cltbld', 20:23:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:14 INFO - '_': '/tools/buildbot/bin/python'} 20:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:14 INFO - Downloading/unpacking flake8 20:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:23:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:23:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 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 20:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:23:16 INFO - no previously-included directories found matching 'docs/_build' 20:23:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:23:17 INFO - Running setup.py install for pep8 20:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:23:17 INFO - no previously-included directories found matching 'docs/_build' 20:23:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:23:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:23:17 INFO - Cleaning up... 20:23:17 INFO - Return code: 0 20:23:17 INFO - Running post-action listener: _resource_record_post_action 20:23:17 INFO - Running post-action listener: _start_resource_monitoring 20:23:17 INFO - Starting resource monitoring. 20:23:17 INFO - ##### 20:23:17 INFO - ##### Finished create-virtualenv step (success) 20:23:17 INFO - ##### 20:23:17 INFO - ##### 20:23:17 INFO - ##### Running install step. 20:23:17 INFO - ##### 20:23:17 INFO - Running pre-action listener: _resource_record_pre_action 20:23:17 INFO - Running main action method: install 20:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:23:17 INFO - Reading from file tmpfile_stdout 20:23:17 INFO - Detecting whether we're running mozinstall >=1.0... 20:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:23:17 INFO - Reading from file tmpfile_stdout 20:23:17 INFO - Output received: 20:23:17 INFO - Usage: mozinstall [options] installer 20:23:17 INFO - Options: 20:23:17 INFO - -h, --help show this help message and exit 20:23:17 INFO - -d DEST, --destination=DEST 20:23:17 INFO - Directory to install application into. [default: 20:23:17 INFO - "/builds/slave/test"] 20:23:17 INFO - --app=APP Application being installed. [default: firefox] 20:23:17 INFO - mkdir: /builds/slave/test/build/application 20:23:17 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'] 20:23:17 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 20:23:33 INFO - Reading from file tmpfile_stdout 20:23:33 INFO - Output received: 20:23:33 INFO - /builds/slave/test/build/application/firefox/firefox 20:23:33 INFO - Running post-action listener: _resource_record_post_action 20:23:33 INFO - ##### 20:23:33 INFO - ##### Finished install step (success) 20:23:33 INFO - ##### 20:23:33 INFO - ##### 20:23:33 INFO - ##### Running run-tests step. 20:23:33 INFO - ##### 20:23:33 INFO - Running pre-action listener: _resource_record_pre_action 20:23:33 INFO - Running main action method: run_tests 20:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:23:33 INFO - Python 2.7.3 20:23:33 INFO - Return code: 0 20:23:33 INFO - grabbing minidump binary from tooltool 20:23: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')]} 20:23:33 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 0x20a31c0>, '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 0x20a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:23:33 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 20:23:33 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 20:23:33 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 20:23:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:23:33 INFO - Return code: 0 20:23:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:23:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:23:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:23:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:23:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:23:34 INFO - Return code: 0 20:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:23:34 INFO - Using env: {'DISPLAY': ':0', 20:23:34 INFO - 'HOME': '/home/cltbld', 20:23:34 INFO - 'LANG': 'en_US.UTF-8', 20:23:34 INFO - 'LANGUAGE': 'en_US:en', 20:23:34 INFO - 'LOGNAME': 'cltbld', 20:23:34 INFO - 'MAIL': '/var/mail/cltbld', 20:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:34 INFO - 'MOZ_NO_REMOTE': '1', 20:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:34 INFO - 'NO_EM_RESTART': '1', 20:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:34 INFO - 'PWD': '/builds/slave/test', 20:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:23:34 INFO - 'SHELL': '/bin/bash', 20:23:34 INFO - 'SHLVL': '1', 20:23:34 INFO - 'TERM': 'linux', 20:23:34 INFO - 'TMOUT': '86400', 20:23:34 INFO - 'USER': 'cltbld', 20:23:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916', 20:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:34 INFO - '_': '/tools/buildbot/bin/python'} 20:23:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:23:34 INFO - mozversion application_buildid: 20160622190824 20:23:34 INFO - mozversion application_changeset: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda 20:23:34 INFO - mozversion application_display_name: Nightly 20:23:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:23:34 INFO - mozversion application_name: Firefox 20:23:34 INFO - mozversion application_remotingname: firefox 20:23:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:23:34 INFO - mozversion application_vendor: Mozilla 20:23:34 INFO - mozversion application_version: 50.0a1 20:23:34 INFO - mozversion platform_buildid: 20160622190824 20:23:34 INFO - mozversion platform_changeset: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda 20:23:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:23:34 INFO - mozversion platform_version: 50.0a1 20:23:34 INFO - using testdate: 1466652214 20:23:34 INFO - actual date: 1466652214 20:23:34 INFO - starting webserver on 'localhost:42300' 20:23:34 INFO - SUITE-START | Running 2 tests 20:23:34 INFO - TEST-START | dromaeo_css 20:23:34 INFO - operating with platform_type : linux_ 20:23:34 INFO - Initialising browser for dromaeo_css test... 20:23:34 INFO - TEST-INFO | started process 23604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1SjL3p/profile http://localhost:42300/getInfo.html) 20:23:40 INFO - PROCESS | 23604 | __metrics Screen width/height:1600/1200 20:23:40 INFO - PROCESS | 23604 | colorDepth:24 20:23:40 INFO - PROCESS | 23604 | Browser inner width/height: 1024/697 20:23:40 INFO - PROCESS | 23604 | __metrics 20:23:41 ERROR - PROCESS | 23604 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:23:42 INFO - TEST-INFO | 23604: exit 0 20:23:42 INFO - Browser initialized. 20:23:42 INFO - Running cycle 1/1 for dromaeo_css test... 20:23:42 INFO - TEST-INFO | started process 23721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1SjL3p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:54 INFO - PROCESS | 23721 | RSS: Main: 185495552 20:23:54 INFO - PROCESS | 23721 | 20:24:43 INFO - PROCESS | 23721 | 1466652283784 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] 20:26:56 INFO - PROCESS | 23721 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42300/tests/dromaeo/cssquery-ext.html) 20:26:57 INFO - PROCESS | 23721 | RSS: Main: 188858368 20:26:57 INFO - PROCESS | 23721 | 20:29:59 INFO - PROCESS | 23721 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-ext.html (next: http://localhost:42300/tests/dromaeo/cssquery-jquery.html) 20:30:00 INFO - PROCESS | 23721 | RSS: Main: 188116992 20:30:00 INFO - PROCESS | 23721 | 20:33:02 INFO - PROCESS | 23721 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42300/tests/dromaeo/cssquery-mootools.html) 20:33:03 INFO - PROCESS | 23721 | RSS: Main: 189018112 20:33:03 INFO - PROCESS | 23721 | 20:36:04 INFO - PROCESS | 23721 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42300/tests/dromaeo/cssquery-prototype.html) 20:36:05 INFO - PROCESS | 23721 | RSS: Main: 186671104 20:36:05 INFO - PROCESS | 23721 | 20:39:08 INFO - PROCESS | 23721 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42300/tests/dromaeo/cssquery-yui.html) 20:39:08 INFO - PROCESS | 23721 | RSS: Main: 188690432 20:39:08 INFO - PROCESS | 23721 | 20:42:11 INFO - PROCESS | 23721 | Cycle 1(1): loaded http://localhost:42300/tests/dromaeo/cssquery-yui.html (next: http://localhost:42300/tests/dromaeo/cssquery-dojo.html) 20:42:11 INFO - PROCESS | 23721 | RSS: Main: 189452288 20:42:11 INFO - PROCESS | 23721 | 20:42:11 INFO - PROCESS | 23721 | __start_tp_report 20:42:11 INFO - PROCESS | 23721 | _x_x_mozilla_page_load 20:42:11 INFO - PROCESS | 23721 | _x_x_mozilla_page_load_details 20:42:11 INFO - PROCESS | 23721 | |i|pagename|runs| 20:42:11 INFO - PROCESS | 23721 | |0;dojo.html;2623.396618777681;2674.505216534941;2683.6108764229175;2685.7717094047007;2697.878595463204;4823.614110871131;4917.114919314522;4985.576226020784;5007.148784706599;5062.974685126569;4821.228603423453;4902.950970490303;4916.336294600228;4976.253561965707;5026.547610715035;4436.312371582402;4480.910381792362;4579.702319349231;4587.655925805561;4592.908141837162;610.9904135705867;4447.84432544861;4552.135094332083;4570.451545814491;4583.977080114595;4583.289590113538;4597.54024597541;4623.398958135454;4630.398048253739;4684.133435314444;4628.375169352128;4632.397788287535;4640.744759038252;4648.697834640738;4698.882527936795;4435.800388982503;4494.842680506166;4494.910101797978;4533.478649955265;4551.40831691878;4939.456659767423;5010.348654674905;5054.772535235923;5067.341245638044;5138.922916156261;5264.078786212436;5425.484578964992;5446.046941785172;5450.890982180374;5454.972725136388;5346.091164502044;5407.215953686693;5414.160805075219;5421.942721169374;5461.781528738846;4978.7510624469;5011.899762004739;5022.070916880316;5023.14606516893;5078.13671675816;5370.409254981949;5470.152126420411;5504.0643090674685;5562.527185189304;5591.916121258185;5300.549453296513;5302.151655735064;5311.49540793624;5329.8934021319355;5358.812441564604;5407.486288802557;5425.186222066722;5425.213344065168;5426.131818908955;5486.835394938158;5194.584433245332;5285.920711189336;5338.279332290169;5341.332333458317;5356.678599284055;5323.920141197885;5327.334083239595;5357.866053348697;5359.035373632705;5363.168708850135;4589.770511474413;4603.723776573416;4608.147492713859;4608.193566125915;4631.62946964242;3847.499825022785;3914.099757055893;3927.9018024549614;3944.3491823849317;3977.1846771411792;4525.5700708433305;4538.909221815611;4544.613707834871;4562.1560011398;4634.9536504634525;5371.274877891513;5380.219868119101;5387.138057910715;5391.487808658249;5394.352677678704;4461.821527138878;4553.089382123589;4589.426321709786;4605.539446055434;4616.146012987541;4803.159447096744;4854.077725232195;4861.440934292531;4867.951320486821;4907.754612269372;4908.263760435963;5040.445550989388;5046.444891061907;5049.798008079636;5104.1067813133295;5405.5135037846785;5436.782528698966;5449.3188351456065;5455.427180146186;5533.3083364579425;5088.389393272831;5099.23511473282;5103.055934652101;5115.79536818538;5148.510891465305;5205.687658740488;5401.513863752281;5404.270423492778;5404.270423492935;5410.783568657367;5335.759890805;5387.973060134675;5392.218128371285;5471.753771080232;5476.698781567052;5299.205119232146;5302;5311.203319502106;5319.627626066293;5374.355077390738;5053.949460505495;5234.057869583511;5297.8145764898045;5307.124324486571;5316.3354580677415;5205.6356055075785;5212.582993360446;5214.947850521598;5248.9475105249985;5285.418603953639;5337.839864804062;5354.812581559627;5355.732213389237;5363.839084827461;5402.810901618424;5068.442471328225;5117.692938423706;5141.460146684693;5225.738713064407;5227.738613069255 20:42:11 INFO - PROCESS | 23721 | |1;ext.html;532.8219207823165;569.9572532060096;585.0697391148076;587.175019098167;613.3039000734166;35088.82455587722;36625.26749465009;40061.79969100158;40071.599284007185;40330.19339613206;40616;41315.17369652605;41322.58677413225;41433;41457;7823.530588164728;7993.920060799375;8002.199780021981;8003.079645840745;8025.23760242776;7727;7904.407169462284;7917.247861453182;7937.365010799151;7959.323457506119;7898.328642065431;7958.602069896511;7968.0039995000625;7970.362371010334;7974.840503189933;7923;7939.5633240171765;7949.324307433875;7978.960105199466;7986.041674999037;7885.645145968445;7886.881696774553;7925;7971.48185367955;7989.920100798976;29614.259643509085;38662.80668596667;38830.41754373687;38903.22193556113;39017;2838.503261929154;3056;3088.7528997680356;3177.9682203177904;3205.6954589313978;27968.30079248035;28213;28627;29467.263318416997;29555.70444295551;3135.8432078396218;3141.670124636903;3143.5441860930264;3157.36852629475;3305.586801649794;225560;226693;228298;229609;229720;29208;30369.392612148076;31414.70145634721;31699;33539.4969075464;32957.67042329546;32958.835205823816;33120;33170.33659326848;33292;12177.512899484098;12202.816957745463;12226.633201003984;12230.327331996825;12280.938595307145;11139.498722557504;11188.104951603853;11227.831582526269;11231.831522527169;11336.659900203007;7681.962935003703;7734.2265773422205;7788.922110778933;7844;7872.701004334221;3067.5705401243845;3097.4424603571124;3113.0972018114494;3121.984390078035;3131.5146152346424;874.4840544079024;896.3635818568758;917.417439925652;945.8959514453404;982.3074732313702;27936.441271174463;28084;28723.138305850858;28853.85573072121;28871;957.9856302155473;974.2595627323144;977.8973207813219;1005.6731562242301;1022.1669339488442;13938.790918136236;14002.0198586098;14210.431582736781;14399.856001440061;14401.279936003159;400381;404271;405220;405589.9720501379;406024;47593.286100708516;47897.04205915862;47981.520184798406;48019.27971080437;48150.27774583384;1161.0769438296575;1203.8796120387892;1204.873488283735;1206.1255589697398;1210.038019774264;25418.745812542376;26727.33181670396;26929;27396.863015684794;27401;40549;41512.377314339705;41658;41683;41683.37474937818;362613;366265;367508;369446;369663;24520.754792451848;24633.137840175506;24689.753102468745;24717;24830.875845620656;39736.60263397445;41024.51729856579;41461;41500.1699966005;41730.79134604307;35859.46210806788;35974.64025359713;36599;36842.447363290106;36891.81554092212;34950.65049349474;35472.29055418929;35603.287934241685;35714.46428303525;35880;34220.65779342175;34916.65083349134;35405.82297088498;35421.46867796934;35521.1119722009;30377.848110760187;34056.318873622884;34225.315493689486;34340;34351.65648343485;25595.872020639777;25889.22332330033;26297;26661.866690666422;26744.732552674224 20:42:11 INFO - PROCESS | 23721 | |2;jquery.html;376.3958846052086;377.59031450875796;386.48211396728396;387.4981898441518;390.7011136480593;10275;10869.83695244572;10878.292910960792;11106.333619982806;15894.92052539737;17359.82640173601;17746.46760597184;18773;18900.432987010376;18984.050797460106;4863.8540843774745;5939.88120237595;5958.7616495340135;5961.612495187821;5962.433568810956;5803.883922321551;5967;5968.224130863004;5970.462658360747;6730.2933192014625;7103.85792284154;7189.532680375759;7203.063601731767;7208.135023797152;7219.0976127984;6892.4830637702125;7140.1788794288805;7168.856622867514;7169.89245161323;7188.928110718878;6653.53425260232;6867.759628413031;6890.8621827563165;6898.448124150056;7008.754693585751;22892.54214915709;23460.765392346028;23771;23879.283621491384;23926.282211533682;2006.6087113012968;2020.1414398880418;2234.3297010896827;2556;2690.2467309153467;13406.731865362735;13662.658433539142;13916.30418479072;14757.409703611842;15373.461928832437;1947.46444727701;1957.0606109067728;1962.9214831406728;2001.769796473395;2014.5567975045467;74898;78616.60691696563;80619.99999999942;82446.17553824445;83952.16047839505;15563.066216027075;16760.497185084467;16800.32798688063;16934.322627094778;16940.322387104625;28831;28899;29083.854580726962;29315.12054638364;29325.120246392642;8121.593920303962;8640.913590864011;8660.826783464421;8662.177093176138;8774.166454186841;6726.125603671491;6887.758928437581;6926.480513961473;6942.236354001056;6995.300469952964;8412.994268410286;8502.957485212659;8640.15513096666;8717.259032982267;8790.648374065093;3143.424347322941;3269.8173395168924;3352.6814952579466;3390.965086247844;3440.415129428003;771.7414666086811;817.7628487738608;823.8187598728271;857.8412993596205;883.4478450968145;15987.040777553384;16805.571526420146;16918.830811691725;16963.406280780113;17072.146392680566;863.4991704811194;890.3411475508077;892.6964831957166;903.7379160043514;907.7503686486137;8249.958750206211;9214.308926830514;9412.764680883032;9472.28957828152;9591.616335346507;374462;375000;375113;383253;403324;72702.27297726955;76629.6168519165;81593.59203203947;81739;82880;917.5916717060844;938.1416004356074;940.0693313619468;942.8491441369348;962.7352478068588;15641.530754077396;15865.127417992122;15883;15967.44113956006;15998.9200053999;37009.81495092507;37190.25619487541;37343.43984840284;37647;39087.6091239084;47313;51960.74019630029;52859.207111894124;53023.73488132535;55306.446935530126;7652.881490485952;7700.19147989453;7880.921190788248;7917.920820791718;7918.524888506708;10667.679969600924;11962.940185299018;12107.273563586214;12171.573994910135;12285.938570307091;9729.4648794317;10147.797044059225;10301.74245643865;10310.07209351162;10381.11760500366;9915.851262230928;10111.89888101139;10269.897301026895;10505.737356566147;10525.210609204187;10373.481325933522;10404.167666586503;10518.316309439862;10552.525136369035;10811.081058110149;6596.670166491752;7854.450188486751;8118.837623247384;8163.428560000743;8235.176482351717;8603.225709686158;10560.524776385235;10654.8934510657;10689.625863094754;10717 20:42:11 INFO - PROCESS | 23721 | |3;mootools.html;1378.104232249038;1405.7476134692554;1500.2123884960395;1671.7492376143568;1704.6079401737593;6726.529142959983;7549.358304544114;7559.488102379532;8120.025596928362;8122.390820688443;7612.124605670349;7739.226077392258;7858.332041776456;7870.409719271063;7880.763577092682;2206.6138425775507;2247.550489902018;2251.876146811933;2254.8083412909923;2258.1306197114145;2210.7789221077924;2212.4911270407815;2235.3182279404773;2238.9888050559725;2240.025588868839;2201.856879302848;2213.1921848525253;2222.6443768996965;2229.041512149775;2235.541713948645;2157.11558261113;2195.6706494025943;2211.966820497694;2224.5995720770334;2229.2945896389274;2170.2838063439026;2209.2930262316067;2211.303439416579;2220.1785339424355;2226.9220577279716;7820.100688420791;7898.368130549542;7918;7946.6424010919645;7961.522308661499;4542.318652202163;4621.353010578522;4653.255479123358;4678.064387122589;4685.109829132488;2949.749271311941;2953.1140657802575;2997.655269643997;3019.441403340389;3021.712937270978;888.4491615198554;915.7390143809049;929.9628014879397;930.316217580078;945.2107490245653;10815.972482614217;10816.567337306498;10840.78318433627;10891.83662245067;10911.07255883251;4250.468691413574;4358.237308471005;4399.62603178727;4424.247877860771;4446.333050042519;9282.118198771106;9322.487263200454;9324.160825525736;9329.766755831159;9346.018668039895;4863.659543831898;4877.561019508261;4878.609711223094;4879.853604391874;4894.241392584155;3758;4267.893302667459;4273.465816772903;4381.84663536781;4453.487848897354;3668.614795446493;3696.9445458318146;3750.887473375803;3771.2080463102507;3790.905227369338;1198.820176973461;1216.793145165324;1233.0751936047964;1233.784087784634;1234.9567765128356;812.7764864662147;824.9135769498973;827.5407149032345;834.0200264689088;841.4488510025943;5070.974645126751;5137.8715532112;5220;5228.346456692913;5261.4738526147075;879.147227189625;908.5514538319167;920.4707293306376;951.3768481644533;964.5900492290889;3308.7022168004514;3392.3215356928217;3425.3834309823974;3438.707709844641;3453.1615866845136;9138.08619138081;9441.622335106518;9471.289653276031;9630.47032413224;9861.063198996084;9702.805943881083;9744;9750.75623109428;9770.853437198448;9829.45937973404;6954.756583519553;7302.5983570903045;7394.889076663854;7417.480776345712;7429.5170813898;5197.168453047494;5329.280547126088;5354.892902142014;5422.945770542244;5550.972245138749;8395.70615028471;8682.479051256945;8705.91294087051;9247.982721900451;9253.72238832836;8541.786455338666;8927.776805579913;8950.552472376485;8958.283337333129;8973.641054357753;6059.757609695563;6436.581622194542;6707.631080290435;6896.27589103157;7013.509054366349;7662.310392064741;7677.616119193906;7709.383249340151;7740.7677769667;7775.339096176888;6823.522353435411;6975.476839237179;7053.682584283617;7101.573905565682;7194.208637050025;6695.799126026227;6728.663566821541;6830;6859.451243900576;6967.616781077089;6076.513878889767;6085.726142323695;6124.663143527148;6131.141640170291;6132.693365331805;4476.485204201558;4514.503404625554;4523.683342166017;4532.546745325441;4597.494275629745;4431.180231657154;4484.551544845489;4528.660350473661;4574.679772415899;4620.353150558857 20:42:11 INFO - PROCESS | 23721 | |4;prototype.html;304.95273232648935;307.57861729430675;311.9266972261519;315.31261849168806;318.18703213290036;5174.741262936857;5264.894702105956;5272.78177458033;5283.920741188886;5297.523222909937;5146.356705411824;5166.870828229296;5167.767450464728;5189.377274727029;5190.558802501791;3807.638274363938;3868.903277418073;4007.7394969327047;4009;4019.2765302245584;3985.0435895385044;4027.395890616416;4043.65628921542;4053.29067413203;4055;4024.1750441159493;4037.253108174982;4041.7366274886012;4045.1909618076356;4060.9187816243657;3696.963030369716;3956.7823769692654;3957.8021098945223;4019.216252830714;4023.0948036691802;3450.9654903451146;3463.515107884898;3463.8787642432394;3477.8434970426392;3479.982600087009;5005.424376196747;5012.799488020475;5015.3480047593575;5019.322391477177;5068.18908974566;4296.226679197744;4519.661025423106;4548.476925153616;4568.977155114203;4578.450585929677;5327.041132596131;5337.411355492583;5340;5346.893062138774;5347.7058761768085;3816.9427458588143;3825.9043523911846;3845.9807700961596;3865.0095200971523;3866.168773713665;5339.332583427072;5673.149027645845;5690.016988108299;5717.456841600083;5743.569232307594;3788.3559794834946;3802.258559580855;3804.2201348723447;3823.9808800955816;3825.5026846509777;3873.7869417182324;3879.7090218233743;3879.8448062077764;3886.455896174538;3901.3367727486398;4466.41442287983;4468.687191896601;4469.754163520973;4487.192305384997;4527.253003254492;5169.53474187325;5363;5394.541463975606;5408.729563521808;5460.290162278958;1330.8003799429969;1343.9059265851297;1362.1146254934372;1366.8928168183802;1369.9930551044974;866.2680035370103;871.7428358634218;878.7319867440492;885.1458342699326;895.2435192262528;4601.930971035437;4676.438827340741;4676.95323046772;4696.483386827446;4712.670113092119;5429.945700542944;5472.753726082336;5477.397486276506;5489.615726899079;5502.449755024546;4513.864584062483;4590.724556526619;4625.583697467244;4629.51390104041;4634.189016922025;2936.634464973755;2938.9265268368463;2950.645922489315;2954.320506283567;2955.039612126068;5076.492350764968;5091.0836049511445;5105;5135.075686376488;5138.254953031789;5406.91889621656;5613.46672066153;5641.915371269434;5646.774129034792;5653.038983372837;5087.847364579068;5093.643444958891;5134.589232861437;5139;5174.09453345663;5447.155690867922;5466.835994920159;5468.535174510212;5484.561235101102;5585.748641311232;5265.131253343156;5337.813176538958;5347.090994531017;5393.541548968382;5394.275890675184;5086.415062267886;5093.115547247542;5104.2343648453025;5133.307003554622;5142.51146141116;3826.3303921813012;3827.4450204720715;3854.7494412863075;3863.3239183142277;3870.5742368340025;5372.758225879923;5445.373782015119;5453.954766962389;5472.781088756565;5479.616426850242;5301.946980530145;5326.307580014573;5336.332958380202;5345.75944082525;5355.30381050461;5105.285260063668;5288.153895376721;5300.734963251899;5351.946480535301;5364.731763411892;5283.181106928432;5287.964133808435;5292.444293349143;5294.920576191437;5323.467653234646;5263.263143159884;5265.289185959847;5472.835814925558;5488.725563721718;5497.36780270274;5357.892842143057;5381.623286369917;5382.138857782736;5391.51733273353;5400.2439658447065 20:42:11 INFO - PROCESS | 23721 | |5;yui.html;718.4216705552028;726.0670038999887;745.7911784700284;762.2796457347808;779.0884664942017;12295.200811947228;13157.210567365964;13429.127106738055;13552;13811.792823107637;12226.388680565959;12330.44512996915;12412.317322547256;12429.875701242985;12430.937845310784;620.3579295429232;763.5380594740158;777.4130531448762;794.6702118620766;795.7453614843253;794.8847417124514;796.2356138107424;800.5636927874323;803.8673618852882;804.3605333759646;833.9874901876477;840.9579521023954;842.1578421578422;844.9197326254027;845.4969293270494;830.0744669693308;833.6332013913889;834.6869923778584;837.7738010737066;838.907720150789;607.2864384348417;607.9148919151322;609.7012463892705;611.0376157551874;611.6330201878882;13019.674508137277;13080.672983175496;13178.34108294591;13220.272884991322;13229.801552976713;13959.511417100353;14186;14358.138511689227;14363.856361436461;14379.065360751518;10306.330088544295;10407.167426605929;10477.318974266724;10553.947230263799;10694.197935154894;3448.517207590914;3466.116140384186;3505.614382417932;3589.4974703541525;3590.0845284452557;61679.69160154215;61781;62297.06554401688;63898;64267;10771.138308935266;10820.94589527063;10927.235093543535;11013.724656883482;11062.280951738112;20846.68729969052;20864.895675521526;20894;20966.47583810417;20983.16067357319;7291.234420385783;7318.34134927859;7398.260173982559;7516.774496765106;7519.624018799148;3878.1274213302345;4024.3561030235605;4039.3738970459626;4044.2407552714662;4045.5347635021762;2985.5372417275357;3098.0550931965518;3103.9601733419104;3118.6413562440157;3123.1879711275233;491.52322247419943;494.3153732081022;499.5628824778319;505.5854199556402;507.0669967260259;536.3885170905171;591.8816236752667;595.8619037638091;627.5857933763695;630.5649102119523;8144.633491492897;8147.959260203661;8156.714514991947;8207.343412526983;8266.504009759434;600.4625859855405;614.7814852764258;621.1242148570494;625.1279465146187;633.297040285283;3769.8869033929027;4079;4184.727992680466;4239.660827133822;4255.297875850512;58859.41140588625;59755.70122149361;59778.70110649419;64698.676506617165;99928.50035749775;81704;82719;82828;83231.58384208161;83510.16489835146;59979;61808.38191618116;61932;69677.3032269681;71141.2885871145;8240.258376746122;8255.504669719836;8261.628226729692;8367.790805229917;8370.330373570221;41053.589464106175;42356.788216059955;43225.91935201645;43446.34830477482;43822.34266486069;57916;64626;64831.675841622375;64868.35131648623;64870.35129648643;11259.662210133709;11392.886071139183;11569;11627.127965402799;11929.522819087486;12808.103432759617;13213.207207567577;13216.074874759059;13227.80158297607;13972.161670299814;11133.721656958642;11237.7752444949;11369.943150284527;11889.048876089719;11977.401129943642;11552.133589980953;12011.879881201427;12483.687907802378;13120.803187951997;13202.933985330395;11446.427678616203;11547.942260288644;12059.638210853689;12079.094067944763;12159.270443773403;9498.620055197714;9590.808183836423;9664;9674.7581310465;9828.901710983084;9880.654177103766;10445.895541044492;10598.31110977784;10631.20265980039;10635.255532112678 20:42:11 INFO - PROCESS | 23721 | __end_tp_report 20:42:11 INFO - PROCESS | 23721 | __start_cc_report 20:42:11 INFO - PROCESS | 23721 | _x_x_mozilla_cycle_collect,411 20:42:11 INFO - PROCESS | 23721 | __end_cc_report 20:42:11 INFO - PROCESS | 23721 | __startTimestamp1466653331829__endTimestamp 20:42:11 INFO - PROCESS | 23721 | 20:42:11 INFO - PROCESS | 23721 | ------- Summary: start ------- 20:42:11 INFO - PROCESS | 23721 | Number of tests: 6 20:42:11 INFO - PROCESS | 23721 | 20:42:11 INFO - PROCESS | 23721 | [#0] dojo.html Cycles:165 Average:4939.53 Median:5104.11 stddev:653.06 (12.8%) stddev-sans-first:629.28 20:42:11 INFO - PROCESS | 23721 | Values: 2623.4 2674.5 2683.6 2685.8 2697.9 4823.6 4917.1 4985.6 5007.1 5063.0 4821.2 4903.0 4916.3 4976.3 5026.5 4436.3 4480.9 4579.7 4587.7 4592.9 611.0 4447.8 4552.1 4570.5 4584.0 4583.3 4597.5 4623.4 4630.4 4684.1 4628.4 4632.4 4640.7 4648.7 4698.9 4435.8 4494.8 4494.9 4533.5 4551.4 4939.5 5010.3 5054.8 5067.3 5138.9 5264.1 5425.5 5446.0 5450.9 5455.0 5346.1 5407.2 5414.2 5421.9 5461.8 4978.8 5011.9 5022.1 5023.1 5078.1 5370.4 5470.2 5504.1 5562.5 5591.9 5300.5 5302.2 5311.5 5329.9 5358.8 5407.5 5425.2 5425.2 5426.1 5486.8 5194.6 5285.9 5338.3 5341.3 5356.7 5323.9 5327.3 5357.9 5359.0 5363.2 4589.8 4603.7 4608.1 4608.2 4631.6 3847.5 3914.1 3927.9 3944.3 3977.2 4525.6 4538.9 4544.6 4562.2 4635.0 5371.3 5380.2 5387.1 5391.5 5394.4 4461.8 4553.1 4589.4 4605.5 4616.1 4803.2 4854.1 4861.4 4868.0 4907.8 4908.3 5040.4 5046.4 5049.8 5104.1 5405.5 5436.8 5449.3 5455.4 5533.3 5088.4 5099.2 5103.1 5115.8 5148.5 5205.7 5401.5 5404.3 5404.3 5410.8 5335.8 5388.0 5392.2 5471.8 5476.7 5299.2 5302.0 5311.2 5319.6 5374.4 5053.9 5234.1 5297.8 5307.1 5316.3 5205.6 5212.6 5214.9 5248.9 5285.4 5337.8 5354.8 5355.7 5363.8 5402.8 5068.4 5117.7 5141.5 5225.7 5227.7 20:42:11 INFO - PROCESS | 23721 | 20:42:11 INFO - PROCESS | 23721 | [#1] ext.html Cycles:180 Average:46790.69 Median:35562.20 stddev:90500.26 (254.5%) stddev-sans-first:90687.49 20:42:11 INFO - PROCESS | 23721 | Values: 532.8 570.0 585.1 587.2 613.3 35088.8 36625.3 40061.8 40071.6 40330.2 40616.0 41315.2 41322.6 41433.0 41457.0 7823.5 7993.9 8002.2 8003.1 8025.2 7727.0 7904.4 7917.2 7937.4 7959.3 7898.3 7958.6 7968.0 7970.4 7974.8 7923.0 7939.6 7949.3 7979.0 7986.0 7885.6 7886.9 7925.0 7971.5 7989.9 29614.3 38662.8 38830.4 38903.2 39017.0 2838.5 3056.0 3088.8 3178.0 3205.7 27968.3 28213.0 28627.0 29467.3 29555.7 3135.8 3141.7 3143.5 3157.4 3305.6 225560.0 226693.0 228298.0 229609.0 229720.0 29208.0 30369.4 31414.7 31699.0 33539.5 32957.7 32958.8 33120.0 33170.3 33292.0 12177.5 12202.8 12226.6 12230.3 12280.9 11139.5 11188.1 11227.8 11231.8 11336.7 7682.0 7734.2 7788.9 7844.0 7872.7 3067.6 3097.4 3113.1 3122.0 3131.5 874.5 896.4 917.4 945.9 982.3 27936.4 28084.0 28723.1 28853.9 28871.0 958.0 974.3 977.9 1005.7 1022.2 13938.8 14002.0 14210.4 14399.9 14401.3 400381.0 404271.0 405220.0 405590.0 406024.0 47593.3 47897.0 47981.5 48019.3 48150.3 1161.1 1203.9 1204.9 1206.1 1210.0 25418.7 26727.3 26929.0 27396.9 27401.0 40549.0 41512.4 41658.0 41683.0 41683.4 362613.0 366265.0 367508.0 369446.0 369663.0 24520.8 24633.1 24689.8 24717.0 24830.9 39736.6 41024.5 41461.0 41500.2 41730.8 35859.5 35974.6 36599.0 36842.4 36891.8 34950.7 35472.3 35603.3 35714.5 35880.0 34220.7 34916.7 35405.8 35421.5 35521.1 30377.8 34056.3 34225.3 34340.0 34351.7 25595.9 25889.2 26297.0 26661.9 26744.7 20:42:11 INFO - PROCESS | 23721 | 20:42:11 INFO - PROCESS | 23721 | [#2] jquery.html Cycles:180 Average:25639.85 Median:221205.80 stddev:63311.84 (28.6%) stddev-sans-first:63461.03 20:42:11 INFO - PROCESS | 23721 | Values: 376.4 377.6 386.5 387.5 390.7 10275.0 10869.8 10878.3 11106.3 15894.9 17359.8 17746.5 18773.0 18900.4 18984.1 4863.9 5939.9 5958.8 5961.6 5962.4 5803.9 5967.0 5968.2 5970.5 6730.3 7103.9 7189.5 7203.1 7208.1 7219.1 6892.5 7140.2 7168.9 7169.9 7188.9 6653.5 6867.8 6890.9 6898.4 7008.8 22892.5 23460.8 23771.0 23879.3 23926.3 2006.6 2020.1 2234.3 2556.0 2690.2 13406.7 13662.7 13916.3 14757.4 15373.5 1947.5 1957.1 1962.9 2001.8 2014.6 74898.0 78616.6 80620.0 82446.2 83952.2 15563.1 16760.5 16800.3 16934.3 16940.3 28831.0 28899.0 29083.9 29315.1 29325.1 8121.6 8640.9 8660.8 8662.2 8774.2 6726.1 6887.8 6926.5 6942.2 6995.3 8413.0 8503.0 8640.2 8717.3 8790.6 3143.4 3269.8 3352.7 3391.0 3440.4 771.7 817.8 823.8 857.8 883.4 15987.0 16805.6 16918.8 16963.4 17072.1 863.5 890.3 892.7 903.7 907.8 8250.0 9214.3 9412.8 9472.3 9591.6 374462.0 375000.0 375113.0 383253.0 403324.0 72702.3 76629.6 81593.6 81739.0 82880.0 917.6 938.1 940.1 942.8 962.7 15641.5 15865.1 15883.0 15967.4 15998.9 37009.8 37190.3 37343.4 37647.0 39087.6 47313.0 51960.7 52859.2 53023.7 55306.4 7652.9 7700.2 7880.9 7917.9 7918.5 10667.7 11962.9 12107.3 12171.6 12285.9 9729.5 10147.8 10301.7 10310.1 10381.1 9915.9 10111.9 10269.9 10505.7 10525.2 10373.5 10404.2 10518.3 10552.5 10811.1 6596.7 7854.5 8118.8 8163.4 8235.2 8603.2 10560.5 10654.9 10689.6 10717.0 20:42:11 INFO - PROCESS | 23721 | 20:42:11 INFO - PROCESS | 23721 | [#3] mootools.html Cycles:180 Average:5179.74 Median:5295.38 stddev:2884.83 (54.5%) stddev-sans-first:2878.77 20:42:11 INFO - PROCESS | 23721 | Values: 1378.1 1405.7 1500.2 1671.7 1704.6 6726.5 7549.4 7559.5 8120.0 8122.4 7612.1 7739.2 7858.3 7870.4 7880.8 2206.6 2247.6 2251.9 2254.8 2258.1 2210.8 2212.5 2235.3 2239.0 2240.0 2201.9 2213.2 2222.6 2229.0 2235.5 2157.1 2195.7 2212.0 2224.6 2229.3 2170.3 2209.3 2211.3 2220.2 2226.9 7820.1 7898.4 7918.0 7946.6 7961.5 4542.3 4621.4 4653.3 4678.1 4685.1 2949.7 2953.1 2997.7 3019.4 3021.7 888.4 915.7 930.0 930.3 945.2 10816.0 10816.6 10840.8 10891.8 10911.1 4250.5 4358.2 4399.6 4424.2 4446.3 9282.1 9322.5 9324.2 9329.8 9346.0 4863.7 4877.6 4878.6 4879.9 4894.2 3758.0 4267.9 4273.5 4381.8 4453.5 3668.6 3696.9 3750.9 3771.2 3790.9 1198.8 1216.8 1233.1 1233.8 1235.0 812.8 824.9 827.5 834.0 841.4 5071.0 5137.9 5220.0 5228.3 5261.5 879.1 908.6 920.5 951.4 964.6 3308.7 3392.3 3425.4 3438.7 3453.2 9138.1 9441.6 9471.3 9630.5 9861.1 9702.8 9744.0 9750.8 9770.9 9829.5 6954.8 7302.6 7394.9 7417.5 7429.5 5197.2 5329.3 5354.9 5422.9 5551.0 8395.7 8682.5 8705.9 9248.0 9253.7 8541.8 8927.8 8950.6 8958.3 8973.6 6059.8 6436.6 6707.6 6896.3 7013.5 7662.3 7677.6 7709.4 7740.8 7775.3 6823.5 6975.5 7053.7 7101.6 7194.2 6695.8 6728.7 6830.0 6859.5 6967.6 6076.5 6085.7 6124.7 6131.1 6132.7 4476.5 4514.5 4523.7 4532.5 4597.5 4431.2 4484.6 4528.7 4574.7 4620.4 20:42:11 INFO - PROCESS | 23721 | 20:42:11 INFO - PROCESS | 23721 | [#4] prototype.html Cycles:180 Average:4436.87 Median:5098.94 stddev:1297.10 (25.4%) stddev-sans-first:1263.12 20:42:11 INFO - PROCESS | 23721 | Values: 305.0 307.6 311.9 315.3 318.2 5174.7 5264.9 5272.8 5283.9 5297.5 5146.4 5166.9 5167.8 5189.4 5190.6 3807.6 3868.9 4007.7 4009.0 4019.3 3985.0 4027.4 4043.7 4053.3 4055.0 4024.2 4037.3 4041.7 4045.2 4060.9 3697.0 3956.8 3957.8 4019.2 4023.1 3451.0 3463.5 3463.9 3477.8 3480.0 5005.4 5012.8 5015.3 5019.3 5068.2 4296.2 4519.7 4548.5 4569.0 4578.5 5327.0 5337.4 5340.0 5346.9 5347.7 3816.9 3825.9 3846.0 3865.0 3866.2 5339.3 5673.1 5690.0 5717.5 5743.6 3788.4 3802.3 3804.2 3824.0 3825.5 3873.8 3879.7 3879.8 3886.5 3901.3 4466.4 4468.7 4469.8 4487.2 4527.3 5169.5 5363.0 5394.5 5408.7 5460.3 1330.8 1343.9 1362.1 1366.9 1370.0 866.3 871.7 878.7 885.1 895.2 4601.9 4676.4 4677.0 4696.5 4712.7 5429.9 5472.8 5477.4 5489.6 5502.4 4513.9 4590.7 4625.6 4629.5 4634.2 2936.6 2938.9 2950.6 2954.3 2955.0 5076.5 5091.1 5105.0 5135.1 5138.3 5406.9 5613.5 5641.9 5646.8 5653.0 5087.8 5093.6 5134.6 5139.0 5174.1 5447.2 5466.8 5468.5 5484.6 5585.7 5265.1 5337.8 5347.1 5393.5 5394.3 5086.4 5093.1 5104.2 5133.3 5142.5 3826.3 3827.4 3854.7 3863.3 3870.6 5372.8 5445.4 5454.0 5472.8 5479.6 5301.9 5326.3 5336.3 5345.8 5355.3 5105.3 5288.2 5300.7 5351.9 5364.7 5283.2 5288.0 5292.4 5294.9 5323.5 5263.3 5265.3 5472.8 5488.7 5497.4 5357.9 5381.6 5382.1 5391.5 5400.2 20:42:11 INFO - PROCESS | 23721 | 20:42:11 INFO - PROCESS | 23721 | [#5] yui.html Cycles:180 Average:16842.27 Median:496.94 stddev:22548.35 (4537.4%) stddev-sans-first:22579.10 20:42:11 INFO - PROCESS | 23721 | Values: 718.4 726.1 745.8 762.3 779.1 12295.2 13157.2 13429.1 13552.0 13811.8 12226.4 12330.4 12412.3 12429.9 12430.9 620.4 763.5 777.4 794.7 795.7 794.9 796.2 800.6 803.9 804.4 834.0 841.0 842.2 844.9 845.5 830.1 833.6 834.7 837.8 838.9 607.3 607.9 609.7 611.0 611.6 13019.7 13080.7 13178.3 13220.3 13229.8 13959.5 14186.0 14358.1 14363.9 14379.1 10306.3 10407.2 10477.3 10553.9 10694.2 3448.5 3466.1 3505.6 3589.5 3590.1 61679.7 61781.0 62297.1 63898.0 64267.0 10771.1 10820.9 10927.2 11013.7 11062.3 20846.7 20864.9 20894.0 20966.5 20983.2 7291.2 7318.3 7398.3 7516.8 7519.6 3878.1 4024.4 4039.4 4044.2 4045.5 2985.5 3098.1 3104.0 3118.6 3123.2 491.5 494.3 499.6 505.6 507.1 536.4 591.9 595.9 627.6 630.6 8144.6 8148.0 8156.7 8207.3 8266.5 600.5 614.8 621.1 625.1 633.3 3769.9 4079.0 4184.7 4239.7 4255.3 58859.4 59755.7 59778.7 64698.7 99928.5 81704.0 82719.0 82828.0 83231.6 83510.2 59979.0 61808.4 61932.0 69677.3 71141.3 8240.3 8255.5 8261.6 8367.8 8370.3 41053.6 42356.8 43225.9 43446.3 43822.3 57916.0 64626.0 64831.7 64868.4 64870.4 11259.7 11392.9 11569.0 11627.1 11929.5 12808.1 13213.2 13216.1 13227.8 13972.2 11133.7 11237.8 11369.9 11889.0 11977.4 11552.1 12011.9 12483.7 13120.8 13202.9 11446.4 11547.9 12059.6 12079.1 12159.3 9498.6 9590.8 9664.0 9674.8 9828.9 9880.7 10445.9 10598.3 10631.2 10635.3 20:42:11 INFO - PROCESS | 23721 | -------- Summary: end -------- 20:42:11 INFO - PROCESS | 23721 | 20:42:12 INFO - TEST-INFO | 23721: exit 0 20:42:12 INFO - TEST-OK | dromaeo_css | took 1117697ms 20:42:12 INFO - TEST-START | kraken 20:42:12 INFO - operating with platform_type : linux_ 20:42:12 INFO - Initialising browser for kraken test... 20:42:12 INFO - TEST-INFO | started process 23945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBlRElU/profile http://localhost:42300/getInfo.html) 20:42:17 INFO - PROCESS | 23945 | __metrics Screen width/height:1600/1200 20:42:17 INFO - PROCESS | 23945 | colorDepth:24 20:42:17 INFO - PROCESS | 23945 | Browser inner width/height: 1024/697 20:42:17 INFO - PROCESS | 23945 | __metrics 20:42:18 ERROR - PROCESS | 23945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:42:19 INFO - TEST-INFO | 23945: exit 0 20:42:19 INFO - Browser initialized. 20:42:19 INFO - Running cycle 1/1 for kraken test... 20:42:19 INFO - TEST-INFO | started process 24063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBlRElU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:42:31 INFO - PROCESS | 24063 | RSS: Main: 186458112 20:42:31 INFO - PROCESS | 24063 | 20:42:34 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42300/tests/kraken/driver.html?testName=audio-beat-detection) 20:42:35 INFO - PROCESS | 24063 | RSS: Main: 190976000 20:42:35 INFO - PROCESS | 24063 | 20:42:37 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42300/tests/kraken/driver.html?testName=audio-dft) 20:42:38 INFO - PROCESS | 24063 | RSS: Main: 190525440 20:42:38 INFO - PROCESS | 24063 | 20:42:41 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42300/tests/kraken/driver.html?testName=audio-fft) 20:42:42 INFO - PROCESS | 24063 | RSS: Main: 186974208 20:42:42 INFO - PROCESS | 24063 | 20:42:44 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42300/tests/kraken/driver.html?testName=audio-oscillator) 20:42:44 INFO - PROCESS | 24063 | RSS: Main: 187486208 20:42:44 INFO - PROCESS | 24063 | 20:42:47 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:42:47 INFO - PROCESS | 24063 | RSS: Main: 187084800 20:42:47 INFO - PROCESS | 24063 | 20:42:51 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42300/tests/kraken/driver.html?testName=imaging-darkroom) 20:42:51 INFO - PROCESS | 24063 | RSS: Main: 187518976 20:42:51 INFO - PROCESS | 24063 | 20:42:55 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42300/tests/kraken/driver.html?testName=imaging-desaturate) 20:42:55 INFO - PROCESS | 24063 | RSS: Main: 184840192 20:42:55 INFO - PROCESS | 24063 | 20:42:58 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42300/tests/kraken/driver.html?testName=json-parse-financial) 20:42:59 INFO - PROCESS | 24063 | RSS: Main: 186208256 20:42:59 INFO - PROCESS | 24063 | 20:43:01 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:43:01 INFO - PROCESS | 24063 | RSS: Main: 187510784 20:43:01 INFO - PROCESS | 24063 | 20:43:03 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:43:04 INFO - PROCESS | 24063 | RSS: Main: 187133952 20:43:04 INFO - PROCESS | 24063 | 20:43:06 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:43:07 INFO - PROCESS | 24063 | RSS: Main: 188063744 20:43:07 INFO - PROCESS | 24063 | 20:43:09 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:43:10 INFO - PROCESS | 24063 | RSS: Main: 188297216 20:43:10 INFO - PROCESS | 24063 | 20:43:13 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:43:14 INFO - PROCESS | 24063 | RSS: Main: 187584512 20:43:14 INFO - PROCESS | 24063 | 20:43:15 INFO - PROCESS | 24063 | Cycle 1(1): loaded http://localhost:42300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42300/tests/kraken/driver.html?testName=ai-astar) 20:43:16 INFO - PROCESS | 24063 | RSS: Main: 189579264 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | __start_tp_report 20:43:16 INFO - PROCESS | 24063 | _x_x_mozilla_page_load 20:43:16 INFO - PROCESS | 24063 | _x_x_mozilla_page_load_details 20:43:16 INFO - PROCESS | 24063 | |i|pagename|runs| 20:43:16 INFO - PROCESS | 24063 | |0;ai-astar;105;113;108;116;113;115;115;114;115;113 20:43:16 INFO - PROCESS | 24063 | |1;audio-beat-detection;159;132;162;191;132;161;158;135;182;131 20:43:16 INFO - PROCESS | 24063 | |2;audio-dft;165;165;166;170;163;164;164;162;165;163 20:43:16 INFO - PROCESS | 24063 | |3;audio-fft;76;77;76;161;76;76;76;76;162;78 20:43:16 INFO - PROCESS | 24063 | |4;audio-oscillator;87;87;143;86;88;87;127;87;88;133 20:43:16 INFO - PROCESS | 24063 | |5;imaging-gaussian-blur;118;118;118;118;118;117;119;119;118;118 20:43:16 INFO - PROCESS | 24063 | |6;imaging-darkroom;148;148;148;147;147;147;148;147;147;148 20:43:16 INFO - PROCESS | 24063 | |7;imaging-desaturate;95;95;95;96;96;96;96;96;96;96 20:43:16 INFO - PROCESS | 24063 | |8;json-parse-financial;64;64;65;63;64;64;62;65;64;65 20:43:16 INFO - PROCESS | 24063 | |9;json-stringify-tinderbox;68;66;66;66;65;65;64;65;65;65 20:43:16 INFO - PROCESS | 24063 | |10;stanford-crypto-aes;87;82;83;84;83;83;83;81;106;83 20:43:16 INFO - PROCESS | 24063 | |11;stanford-crypto-ccm;142;132;141;131;129;139;131;145;158;134 20:43:16 INFO - PROCESS | 24063 | |12;stanford-crypto-pbkdf2;170;169;167;169;178;172;170;178;170;172 20:43:16 INFO - PROCESS | 24063 | |13;stanford-crypto-sha256-iterative;68;68;73;70;69;68;68;75;68;66 20:43:16 INFO - PROCESS | 24063 | __end_tp_report 20:43:16 INFO - PROCESS | 24063 | __start_cc_report 20:43:16 INFO - PROCESS | 24063 | _x_x_mozilla_cycle_collect,968 20:43:16 INFO - PROCESS | 24063 | __end_cc_report 20:43:16 INFO - PROCESS | 24063 | __startTimestamp1466653396183__endTimestamp 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | ------- Summary: start ------- 20:43:16 INFO - PROCESS | 24063 | Number of tests: 14 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.50 stddev:3.50 (3.1%) stddev-sans-first:2.35 20:43:16 INFO - PROCESS | 24063 | Values: 105.0 113.0 108.0 116.0 113.0 115.0 115.0 114.0 115.0 113.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:160.00 stddev:21.51 (13.4%) stddev-sans-first:22.75 20:43:16 INFO - PROCESS | 24063 | Values: 159.0 132.0 162.0 191.0 132.0 161.0 158.0 135.0 182.0 131.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:2.21 (1.3%) stddev-sans-first:2.35 20:43:16 INFO - PROCESS | 24063 | Values: 165.0 165.0 166.0 170.0 163.0 164.0 164.0 162.0 165.0 163.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:35.90 (47.2%) stddev-sans-first:37.52 20:43:16 INFO - PROCESS | 24063 | Values: 76.0 77.0 76.0 161.0 76.0 76.0 76.0 76.0 162.0 78.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:87.00 stddev:23.12 (26.6%) stddev-sans-first:23.93 20:43:16 INFO - PROCESS | 24063 | Values: 87.0 87.0 143.0 86.0 88.0 87.0 127.0 87.0 88.0 133.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:43:16 INFO - PROCESS | 24063 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 119.0 119.0 118.0 118.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:43:16 INFO - PROCESS | 24063 | Values: 148.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 20:43:16 INFO - PROCESS | 24063 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 20:43:16 INFO - PROCESS | 24063 | Values: 64.0 64.0 65.0 63.0 64.0 64.0 62.0 65.0 64.0 65.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:1.08 (1.6%) stddev-sans-first:0.67 20:43:16 INFO - PROCESS | 24063 | Values: 68.0 66.0 66.0 66.0 65.0 65.0 64.0 65.0 65.0 65.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:83.00 stddev:7.37 (8.9%) stddev-sans-first:7.79 20:43:16 INFO - PROCESS | 24063 | Values: 87.0 82.0 83.0 84.0 83.0 83.0 83.0 81.0 106.0 83.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:140.00 stddev:8.85 (6.3%) stddev-sans-first:9.28 20:43:16 INFO - PROCESS | 24063 | Values: 142.0 132.0 141.0 131.0 129.0 139.0 131.0 145.0 158.0 134.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:171.00 stddev:3.72 (2.2%) stddev-sans-first:3.91 20:43:16 INFO - PROCESS | 24063 | Values: 170.0 169.0 167.0 169.0 178.0 172.0 170.0 178.0 170.0 172.0 20:43:16 INFO - PROCESS | 24063 | 20:43:16 INFO - PROCESS | 24063 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.50 stddev:2.71 (4.0%) stddev-sans-first:2.83 20:43:16 INFO - PROCESS | 24063 | Values: 68.0 68.0 73.0 70.0 69.0 68.0 68.0 75.0 68.0 66.0 20:43:16 INFO - PROCESS | 24063 | -------- Summary: end -------- 20:43:16 INFO - PROCESS | 24063 | 20:43:17 INFO - TEST-INFO | 24063: exit 0 20:43:17 INFO - TEST-OK | kraken | took 64639ms 20:43:17 INFO - SUITE-END | took 1182s 20:43:17 INFO - Completed test suite (00:19:42) 20:43:17 INFO - javascript benchmark 20:43:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6599.9956361519025, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.396618777681, 2674.505216534941, 2683.6108764229175, 2685.7717094047007, 2697.878595463204, 4823.614110871131, 4917.114919314522, 4985.576226020784, 5007.148784706599, 5062.974685126569, 4821.228603423453, 4902.950970490303, 4916.336294600228, 4976.253561965707, 5026.547610715035, 4436.312371582402, 4480.910381792362, 4579.702319349231, 4587.655925805561, 4592.908141837162, 610.9904135705867, 4447.84432544861, 4552.135094332083, 4570.451545814491, 4583.977080114595, 4583.289590113538, 4597.54024597541, 4623.398958135454, 4630.398048253739, 4684.133435314444, 4628.375169352128, 4632.397788287535, 4640.744759038252, 4648.697834640738, 4698.882527936795, 4435.800388982503, 4494.842680506166, 4494.910101797978, 4533.478649955265, 4551.40831691878, 4939.456659767423, 5010.348654674905, 5054.772535235923, 5067.341245638044, 5138.922916156261, 5264.078786212436, 5425.484578964992, 5446.046941785172, 5450.890982180374, 5454.972725136388, 5346.091164502044, 5407.215953686693, 5414.160805075219, 5421.942721169374, 5461.781528738846, 4978.7510624469, 5011.899762004739, 5022.070916880316, 5023.14606516893, 5078.13671675816, 5370.409254981949, 5470.152126420411, 5504.0643090674685, 5562.527185189304, 5591.916121258185, 5300.549453296513, 5302.151655735064, 5311.49540793624, 5329.8934021319355, 5358.812441564604, 5407.486288802557, 5425.186222066722, 5425.213344065168, 5426.131818908955, 5486.835394938158, 5194.584433245332, 5285.920711189336, 5338.279332290169, 5341.332333458317, 5356.678599284055, 5323.920141197885, 5327.334083239595, 5357.866053348697, 5359.035373632705, 5363.168708850135, 4589.770511474413, 4603.723776573416, 4608.147492713859, 4608.193566125915, 4631.62946964242, 3847.499825022785, 3914.099757055893, 3927.9018024549614, 3944.3491823849317, 3977.1846771411792, 4525.5700708433305, 4538.909221815611, 4544.613707834871, 4562.1560011398, 4634.9536504634525, 5371.274877891513, 5380.219868119101, 5387.138057910715, 5391.487808658249, 5394.352677678704, 4461.821527138878, 4553.089382123589, 4589.426321709786, 4605.539446055434, 4616.146012987541, 4803.159447096744, 4854.077725232195, 4861.440934292531, 4867.951320486821, 4907.754612269372, 4908.263760435963, 5040.445550989388, 5046.444891061907, 5049.798008079636, 5104.1067813133295, 5405.5135037846785, 5436.782528698966, 5449.3188351456065, 5455.427180146186, 5533.3083364579425, 5088.389393272831, 5099.23511473282, 5103.055934652101, 5115.79536818538, 5148.510891465305, 5205.687658740488, 5401.513863752281, 5404.270423492778, 5404.270423492935, 5410.783568657367, 5335.759890805, 5387.973060134675, 5392.218128371285, 5471.753771080232, 5476.698781567052, 5299.205119232146, 5302.0, 5311.203319502106, 5319.627626066293, 5374.355077390738, 5053.949460505495, 5234.057869583511, 5297.8145764898045, 5307.124324486571, 5316.3354580677415, 5205.6356055075785, 5212.582993360446, 5214.947850521598, 5248.9475105249985, 5285.418603953639, 5337.839864804062, 5354.812581559627, 5355.732213389237, 5363.839084827461, 5402.810901618424, 5068.442471328225, 5117.692938423706, 5141.460146684693, 5225.738713064407, 5227.738613069255], "value": 4896.163559501192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.8219207823165, 569.9572532060096, 585.0697391148076, 587.175019098167, 613.3039000734166, 35088.82455587722, 36625.26749465009, 40061.79969100158, 40071.599284007185, 40330.19339613206, 40616.0, 41315.17369652605, 41322.58677413225, 41433.0, 41457.0, 7823.530588164728, 7993.920060799375, 8002.199780021981, 8003.079645840745, 8025.23760242776, 7727.0, 7904.407169462284, 7917.247861453182, 7937.365010799151, 7959.323457506119, 7898.328642065431, 7958.602069896511, 7968.0039995000625, 7970.362371010334, 7974.840503189933, 7923.0, 7939.5633240171765, 7949.324307433875, 7978.960105199466, 7986.041674999037, 7885.645145968445, 7886.881696774553, 7925.0, 7971.48185367955, 7989.920100798976, 29614.259643509085, 38662.80668596667, 38830.41754373687, 38903.22193556113, 39017.0, 2838.503261929154, 3056.0, 3088.7528997680356, 3177.9682203177904, 3205.6954589313978, 27968.30079248035, 28213.0, 28627.0, 29467.263318416997, 29555.70444295551, 3135.8432078396218, 3141.670124636903, 3143.5441860930264, 3157.36852629475, 3305.586801649794, 225560.0, 226693.0, 228298.0, 229609.0, 229720.0, 29208.0, 30369.392612148076, 31414.70145634721, 31699.0, 33539.4969075464, 32957.67042329546, 32958.835205823816, 33120.0, 33170.33659326848, 33292.0, 12177.512899484098, 12202.816957745463, 12226.633201003984, 12230.327331996825, 12280.938595307145, 11139.498722557504, 11188.104951603853, 11227.831582526269, 11231.831522527169, 11336.659900203007, 7681.962935003703, 7734.2265773422205, 7788.922110778933, 7844.0, 7872.701004334221, 3067.5705401243845, 3097.4424603571124, 3113.0972018114494, 3121.984390078035, 3131.5146152346424, 874.4840544079024, 896.3635818568758, 917.417439925652, 945.8959514453404, 982.3074732313702, 27936.441271174463, 28084.0, 28723.138305850858, 28853.85573072121, 28871.0, 957.9856302155473, 974.2595627323144, 977.8973207813219, 1005.6731562242301, 1022.1669339488442, 13938.790918136236, 14002.0198586098, 14210.431582736781, 14399.856001440061, 14401.279936003159, 400381.0, 404271.0, 405220.0, 405589.9720501379, 406024.0, 47593.286100708516, 47897.04205915862, 47981.520184798406, 48019.27971080437, 48150.27774583384, 1161.0769438296575, 1203.8796120387892, 1204.873488283735, 1206.1255589697398, 1210.038019774264, 25418.745812542376, 26727.33181670396, 26929.0, 27396.863015684794, 27401.0, 40549.0, 41512.377314339705, 41658.0, 41683.0, 41683.37474937818, 362613.0, 366265.0, 367508.0, 369446.0, 369663.0, 24520.754792451848, 24633.137840175506, 24689.753102468745, 24717.0, 24830.875845620656, 39736.60263397445, 41024.51729856579, 41461.0, 41500.1699966005, 41730.79134604307, 35859.46210806788, 35974.64025359713, 36599.0, 36842.447363290106, 36891.81554092212, 34950.65049349474, 35472.29055418929, 35603.287934241685, 35714.46428303525, 35880.0, 34220.65779342175, 34916.65083349134, 35405.82297088498, 35421.46867796934, 35521.1119722009, 30377.848110760187, 34056.318873622884, 34225.315493689486, 34340.0, 34351.65648343485, 25595.872020639777, 25889.22332330033, 26297.0, 26661.866690666422, 26744.732552674224], "value": 16178.408767537725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.3958846052086, 377.59031450875796, 386.48211396728396, 387.4981898441518, 390.7011136480593, 10275.0, 10869.83695244572, 10878.292910960792, 11106.333619982806, 15894.92052539737, 17359.82640173601, 17746.46760597184, 18773.0, 18900.432987010376, 18984.050797460106, 4863.8540843774745, 5939.88120237595, 5958.7616495340135, 5961.612495187821, 5962.433568810956, 5803.883922321551, 5967.0, 5968.224130863004, 5970.462658360747, 6730.2933192014625, 7103.85792284154, 7189.532680375759, 7203.063601731767, 7208.135023797152, 7219.0976127984, 6892.4830637702125, 7140.1788794288805, 7168.856622867514, 7169.89245161323, 7188.928110718878, 6653.53425260232, 6867.759628413031, 6890.8621827563165, 6898.448124150056, 7008.754693585751, 22892.54214915709, 23460.765392346028, 23771.0, 23879.283621491384, 23926.282211533682, 2006.6087113012968, 2020.1414398880418, 2234.3297010896827, 2556.0, 2690.2467309153467, 13406.731865362735, 13662.658433539142, 13916.30418479072, 14757.409703611842, 15373.461928832437, 1947.46444727701, 1957.0606109067728, 1962.9214831406728, 2001.769796473395, 2014.5567975045467, 74898.0, 78616.60691696563, 80619.99999999942, 82446.17553824445, 83952.16047839505, 15563.066216027075, 16760.497185084467, 16800.32798688063, 16934.322627094778, 16940.322387104625, 28831.0, 28899.0, 29083.854580726962, 29315.12054638364, 29325.120246392642, 8121.593920303962, 8640.913590864011, 8660.826783464421, 8662.177093176138, 8774.166454186841, 6726.125603671491, 6887.758928437581, 6926.480513961473, 6942.236354001056, 6995.300469952964, 8412.994268410286, 8502.957485212659, 8640.15513096666, 8717.259032982267, 8790.648374065093, 3143.424347322941, 3269.8173395168924, 3352.6814952579466, 3390.965086247844, 3440.415129428003, 771.7414666086811, 817.7628487738608, 823.8187598728271, 857.8412993596205, 883.4478450968145, 15987.040777553384, 16805.571526420146, 16918.830811691725, 16963.406280780113, 17072.146392680566, 863.4991704811194, 890.3411475508077, 892.6964831957166, 903.7379160043514, 907.7503686486137, 8249.958750206211, 9214.308926830514, 9412.764680883032, 9472.28957828152, 9591.616335346507, 374462.0, 375000.0, 375113.0, 383253.0, 403324.0, 72702.27297726955, 76629.6168519165, 81593.59203203947, 81739.0, 82880.0, 917.5916717060844, 938.1416004356074, 940.0693313619468, 942.8491441369348, 962.7352478068588, 15641.530754077396, 15865.127417992122, 15883.0, 15967.44113956006, 15998.9200053999, 37009.81495092507, 37190.25619487541, 37343.43984840284, 37647.0, 39087.6091239084, 47313.0, 51960.74019630029, 52859.207111894124, 53023.73488132535, 55306.446935530126, 7652.881490485952, 7700.19147989453, 7880.921190788248, 7917.920820791718, 7918.524888506708, 10667.679969600924, 11962.940185299018, 12107.273563586214, 12171.573994910135, 12285.938570307091, 9729.4648794317, 10147.797044059225, 10301.74245643865, 10310.07209351162, 10381.11760500366, 9915.851262230928, 10111.89888101139, 10269.897301026895, 10505.737356566147, 10525.210609204187, 10373.481325933522, 10404.167666586503, 10518.316309439862, 10552.525136369035, 10811.081058110149, 6596.670166491752, 7854.450188486751, 8118.837623247384, 8163.428560000743, 8235.176482351717, 8603.225709686158, 10560.524776385235, 10654.8934510657, 10689.625863094754, 10717.0], "value": 9334.535676606816, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.104232249038, 1405.7476134692554, 1500.2123884960395, 1671.7492376143568, 1704.6079401737593, 6726.529142959983, 7549.358304544114, 7559.488102379532, 8120.025596928362, 8122.390820688443, 7612.124605670349, 7739.226077392258, 7858.332041776456, 7870.409719271063, 7880.763577092682, 2206.6138425775507, 2247.550489902018, 2251.876146811933, 2254.8083412909923, 2258.1306197114145, 2210.7789221077924, 2212.4911270407815, 2235.3182279404773, 2238.9888050559725, 2240.025588868839, 2201.856879302848, 2213.1921848525253, 2222.6443768996965, 2229.041512149775, 2235.541713948645, 2157.11558261113, 2195.6706494025943, 2211.966820497694, 2224.5995720770334, 2229.2945896389274, 2170.2838063439026, 2209.2930262316067, 2211.303439416579, 2220.1785339424355, 2226.9220577279716, 7820.100688420791, 7898.368130549542, 7918.0, 7946.6424010919645, 7961.522308661499, 4542.318652202163, 4621.353010578522, 4653.255479123358, 4678.064387122589, 4685.109829132488, 2949.749271311941, 2953.1140657802575, 2997.655269643997, 3019.441403340389, 3021.712937270978, 888.4491615198554, 915.7390143809049, 929.9628014879397, 930.316217580078, 945.2107490245653, 10815.972482614217, 10816.567337306498, 10840.78318433627, 10891.83662245067, 10911.07255883251, 4250.468691413574, 4358.237308471005, 4399.62603178727, 4424.247877860771, 4446.333050042519, 9282.118198771106, 9322.487263200454, 9324.160825525736, 9329.766755831159, 9346.018668039895, 4863.659543831898, 4877.561019508261, 4878.609711223094, 4879.853604391874, 4894.241392584155, 3758.0, 4267.893302667459, 4273.465816772903, 4381.84663536781, 4453.487848897354, 3668.614795446493, 3696.9445458318146, 3750.887473375803, 3771.2080463102507, 3790.905227369338, 1198.820176973461, 1216.793145165324, 1233.0751936047964, 1233.784087784634, 1234.9567765128356, 812.7764864662147, 824.9135769498973, 827.5407149032345, 834.0200264689088, 841.4488510025943, 5070.974645126751, 5137.8715532112, 5220.0, 5228.346456692913, 5261.4738526147075, 879.147227189625, 908.5514538319167, 920.4707293306376, 951.3768481644533, 964.5900492290889, 3308.7022168004514, 3392.3215356928217, 3425.3834309823974, 3438.707709844641, 3453.1615866845136, 9138.08619138081, 9441.622335106518, 9471.289653276031, 9630.47032413224, 9861.063198996084, 9702.805943881083, 9744.0, 9750.75623109428, 9770.853437198448, 9829.45937973404, 6954.756583519553, 7302.5983570903045, 7394.889076663854, 7417.480776345712, 7429.5170813898, 5197.168453047494, 5329.280547126088, 5354.892902142014, 5422.945770542244, 5550.972245138749, 8395.70615028471, 8682.479051256945, 8705.91294087051, 9247.982721900451, 9253.72238832836, 8541.786455338666, 8927.776805579913, 8950.552472376485, 8958.283337333129, 8973.641054357753, 6059.757609695563, 6436.581622194542, 6707.631080290435, 6896.27589103157, 7013.509054366349, 7662.310392064741, 7677.616119193906, 7709.383249340151, 7740.7677769667, 7775.339096176888, 6823.522353435411, 6975.476839237179, 7053.682584283617, 7101.573905565682, 7194.208637050025, 6695.799126026227, 6728.663566821541, 6830.0, 6859.451243900576, 6967.616781077089, 6076.513878889767, 6085.726142323695, 6124.663143527148, 6131.141640170291, 6132.693365331805, 4476.485204201558, 4514.503404625554, 4523.683342166017, 4532.546745325441, 4597.494275629745, 4431.180231657154, 4484.551544845489, 4528.660350473661, 4574.679772415899, 4620.353150558857], "value": 4187.594077583084, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.95273232648935, 307.57861729430675, 311.9266972261519, 315.31261849168806, 318.18703213290036, 5174.741262936857, 5264.894702105956, 5272.78177458033, 5283.920741188886, 5297.523222909937, 5146.356705411824, 5166.870828229296, 5167.767450464728, 5189.377274727029, 5190.558802501791, 3807.638274363938, 3868.903277418073, 4007.7394969327047, 4009.0, 4019.2765302245584, 3985.0435895385044, 4027.395890616416, 4043.65628921542, 4053.29067413203, 4055.0, 4024.1750441159493, 4037.253108174982, 4041.7366274886012, 4045.1909618076356, 4060.9187816243657, 3696.963030369716, 3956.7823769692654, 3957.8021098945223, 4019.216252830714, 4023.0948036691802, 3450.9654903451146, 3463.515107884898, 3463.8787642432394, 3477.8434970426392, 3479.982600087009, 5005.424376196747, 5012.799488020475, 5015.3480047593575, 5019.322391477177, 5068.18908974566, 4296.226679197744, 4519.661025423106, 4548.476925153616, 4568.977155114203, 4578.450585929677, 5327.041132596131, 5337.411355492583, 5340.0, 5346.893062138774, 5347.7058761768085, 3816.9427458588143, 3825.9043523911846, 3845.9807700961596, 3865.0095200971523, 3866.168773713665, 5339.332583427072, 5673.149027645845, 5690.016988108299, 5717.456841600083, 5743.569232307594, 3788.3559794834946, 3802.258559580855, 3804.2201348723447, 3823.9808800955816, 3825.5026846509777, 3873.7869417182324, 3879.7090218233743, 3879.8448062077764, 3886.455896174538, 3901.3367727486398, 4466.41442287983, 4468.687191896601, 4469.754163520973, 4487.192305384997, 4527.253003254492, 5169.53474187325, 5363.0, 5394.541463975606, 5408.729563521808, 5460.290162278958, 1330.8003799429969, 1343.9059265851297, 1362.1146254934372, 1366.8928168183802, 1369.9930551044974, 866.2680035370103, 871.7428358634218, 878.7319867440492, 885.1458342699326, 895.2435192262528, 4601.930971035437, 4676.438827340741, 4676.95323046772, 4696.483386827446, 4712.670113092119, 5429.945700542944, 5472.753726082336, 5477.397486276506, 5489.615726899079, 5502.449755024546, 4513.864584062483, 4590.724556526619, 4625.583697467244, 4629.51390104041, 4634.189016922025, 2936.634464973755, 2938.9265268368463, 2950.645922489315, 2954.320506283567, 2955.039612126068, 5076.492350764968, 5091.0836049511445, 5105.0, 5135.075686376488, 5138.254953031789, 5406.91889621656, 5613.46672066153, 5641.915371269434, 5646.774129034792, 5653.038983372837, 5087.847364579068, 5093.643444958891, 5134.589232861437, 5139.0, 5174.09453345663, 5447.155690867922, 5466.835994920159, 5468.535174510212, 5484.561235101102, 5585.748641311232, 5265.131253343156, 5337.813176538958, 5347.090994531017, 5393.541548968382, 5394.275890675184, 5086.415062267886, 5093.115547247542, 5104.2343648453025, 5133.307003554622, 5142.51146141116, 3826.3303921813012, 3827.4450204720715, 3854.7494412863075, 3863.3239183142277, 3870.5742368340025, 5372.758225879923, 5445.373782015119, 5453.954766962389, 5472.781088756565, 5479.616426850242, 5301.946980530145, 5326.307580014573, 5336.332958380202, 5345.75944082525, 5355.30381050461, 5105.285260063668, 5288.153895376721, 5300.734963251899, 5351.946480535301, 5364.731763411892, 5283.181106928432, 5287.964133808435, 5292.444293349143, 5294.920576191437, 5323.467653234646, 5263.263143159884, 5265.289185959847, 5472.835814925558, 5488.725563721718, 5497.36780270274, 5357.892842143057, 5381.623286369917, 5382.138857782736, 5391.51733273353, 5400.2439658447065], "value": 4021.176047299862, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4216705552028, 726.0670038999887, 745.7911784700284, 762.2796457347808, 779.0884664942017, 12295.200811947228, 13157.210567365964, 13429.127106738055, 13552.0, 13811.792823107637, 12226.388680565959, 12330.44512996915, 12412.317322547256, 12429.875701242985, 12430.937845310784, 620.3579295429232, 763.5380594740158, 777.4130531448762, 794.6702118620766, 795.7453614843253, 794.8847417124514, 796.2356138107424, 800.5636927874323, 803.8673618852882, 804.3605333759646, 833.9874901876477, 840.9579521023954, 842.1578421578422, 844.9197326254027, 845.4969293270494, 830.0744669693308, 833.6332013913889, 834.6869923778584, 837.7738010737066, 838.907720150789, 607.2864384348417, 607.9148919151322, 609.7012463892705, 611.0376157551874, 611.6330201878882, 13019.674508137277, 13080.672983175496, 13178.34108294591, 13220.272884991322, 13229.801552976713, 13959.511417100353, 14186.0, 14358.138511689227, 14363.856361436461, 14379.065360751518, 10306.330088544295, 10407.167426605929, 10477.318974266724, 10553.947230263799, 10694.197935154894, 3448.517207590914, 3466.116140384186, 3505.614382417932, 3589.4974703541525, 3590.0845284452557, 61679.69160154215, 61781.0, 62297.06554401688, 63898.0, 64267.0, 10771.138308935266, 10820.94589527063, 10927.235093543535, 11013.724656883482, 11062.280951738112, 20846.68729969052, 20864.895675521526, 20894.0, 20966.47583810417, 20983.16067357319, 7291.234420385783, 7318.34134927859, 7398.260173982559, 7516.774496765106, 7519.624018799148, 3878.1274213302345, 4024.3561030235605, 4039.3738970459626, 4044.2407552714662, 4045.5347635021762, 2985.5372417275357, 3098.0550931965518, 3103.9601733419104, 3118.6413562440157, 3123.1879711275233, 491.52322247419943, 494.3153732081022, 499.5628824778319, 505.5854199556402, 507.0669967260259, 536.3885170905171, 591.8816236752667, 595.8619037638091, 627.5857933763695, 630.5649102119523, 8144.633491492897, 8147.959260203661, 8156.714514991947, 8207.343412526983, 8266.504009759434, 600.4625859855405, 614.7814852764258, 621.1242148570494, 625.1279465146187, 633.297040285283, 3769.8869033929027, 4079.0, 4184.727992680466, 4239.660827133822, 4255.297875850512, 58859.41140588625, 59755.70122149361, 59778.70110649419, 64698.676506617165, 99928.50035749775, 81704.0, 82719.0, 82828.0, 83231.58384208161, 83510.16489835146, 59979.0, 61808.38191618116, 61932.0, 69677.3032269681, 71141.2885871145, 8240.258376746122, 8255.504669719836, 8261.628226729692, 8367.790805229917, 8370.330373570221, 41053.589464106175, 42356.788216059955, 43225.91935201645, 43446.34830477482, 43822.34266486069, 57916.0, 64626.0, 64831.675841622375, 64868.35131648623, 64870.35129648643, 11259.662210133709, 11392.886071139183, 11569.0, 11627.127965402799, 11929.522819087486, 12808.103432759617, 13213.207207567577, 13216.074874759059, 13227.80158297607, 13972.161670299814, 11133.721656958642, 11237.7752444949, 11369.943150284527, 11889.048876089719, 11977.401129943642, 11552.133589980953, 12011.879881201427, 12483.687907802378, 13120.803187951997, 13202.933985330395, 11446.427678616203, 11547.942260288644, 12059.638210853689, 12079.094067944763, 12159.270443773403, 9498.620055197714, 9590.808183836423, 9664.0, 9674.7581310465, 9828.901710983084, 9880.654177103766, 10445.895541044492, 10598.31110977784, 10631.20265980039, 10635.255532112678], "value": 6637.666080400094, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 108.0, 116.0, 113.0, 115.0, 115.0, 114.0, 115.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 162.0, 191.0, 132.0, 161.0, 158.0, 135.0, 182.0, 131.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 170.0, 163.0, 164.0, 164.0, 162.0, 165.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 161.0, 76.0, 76.0, 76.0, 76.0, 162.0, 78.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 143.0, 86.0, 88.0, 87.0, 127.0, 87.0, 88.0, 133.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 119.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 64.0, 64.0, 62.0, 65.0, 64.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 83.0, 84.0, 83.0, 83.0, 83.0, 81.0, 106.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 132.0, 141.0, 131.0, 129.0, 139.0, 131.0, 145.0, 158.0, 134.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 167.0, 169.0, 178.0, 172.0, 170.0, 178.0, 170.0, 172.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 73.0, 70.0, 69.0, 68.0, 68.0, 75.0, 68.0, 66.0], "value": 69.3, "unit": "score"}]}]} 20:43:17 INFO - Return code: 0 20:43:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:43:17 ERROR - # TBPL SUCCESS # 20:43:17 INFO - Running post-action listener: _resource_record_post_action 20:43:17 INFO - ##### 20:43:17 INFO - ##### Finished run-tests step (success) 20:43:17 INFO - ##### 20:43:17 INFO - Running post-run listener: _resource_record_post_run 20:43:17 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 143360; Write bytes: 297664512; Read time: 160; Write time: 153536 20:43:17 INFO - TinderboxPrint: CPU usage
13.4% 20:43:17 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 160 20:43:17 INFO - TinderboxPrint: I/O write bytes / time
297,664,512 / 153,536 20:43:17 INFO - TinderboxPrint: CPU idle
8,285.5 (86.5%) 20:43:17 INFO - TinderboxPrint: CPU user
1,232.8 (12.9%) 20:43:17 INFO - TinderboxPrint: Swap in / out
0 / 0 20:43:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1212416; Read time: 0; Write time: 36 20:43:17 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 143360; Write bytes: 296452096; Read time: 160; Write time: 153500 20:43:18 INFO - Running post-run listener: _upload_blobber_files 20:43:18 INFO - Blob upload gear active. 20:43:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:43:18 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 20:43:18 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'] 20:43:18 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 20:43:18 INFO - (blobuploader) - INFO - Open directory for files ... 20:43:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:43:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:43:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:43:19 INFO - (blobuploader) - INFO - Done attempting. 20:43:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:43:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:43:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:43:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:43:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:43:23 INFO - (blobuploader) - INFO - Done attempting. 20:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:43:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:43:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:43:23 INFO - (blobuploader) - INFO - Done attempting. 20:43:23 INFO - (blobuploader) - INFO - Iteration through files over. 20:43:23 INFO - Return code: 0 20:43:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:43:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:43:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7818c61a470e1d39d3bc6a5cc6fb9e383ee57a7b6e375f9af1df1125ee57498a0f350b4d8553a420a437a00d23f9a7ba5ce0a8cc746fbbda37a5a3f47bc71e69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f2d426da27a0e133cbcdf1f5724b49607dcf7c0a70949bc2d2775eb1089b25d37e28b2456095d609aa8965f768ff6d6c04111fe65a23f496a41c51c037080e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49d2e8e6b88e127d982a863973dd8a2622d7894aebdaade0cd525563926e7bba895cff710bd38cceccdec8e4bc2030e04a961c9bdecd1967edfd7fab004cfca8"} 20:43:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:43:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:43:23 INFO - Contents: 20:43:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7818c61a470e1d39d3bc6a5cc6fb9e383ee57a7b6e375f9af1df1125ee57498a0f350b4d8553a420a437a00d23f9a7ba5ce0a8cc746fbbda37a5a3f47bc71e69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f2d426da27a0e133cbcdf1f5724b49607dcf7c0a70949bc2d2775eb1089b25d37e28b2456095d609aa8965f768ff6d6c04111fe65a23f496a41c51c037080e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49d2e8e6b88e127d982a863973dd8a2622d7894aebdaade0cd525563926e7bba895cff710bd38cceccdec8e4bc2030e04a961c9bdecd1967edfd7fab004cfca8"} 20:43:23 INFO - Running post-run listener: copy_logs_to_upload_dir 20:43:23 INFO - Copying logs to upload dir... 20:43:23 INFO - mkdir: /builds/slave/test/build/upload/logs 20:43:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.871255 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-22 20:43:23.973281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 20:43:23.977111) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7818c61a470e1d39d3bc6a5cc6fb9e383ee57a7b6e375f9af1df1125ee57498a0f350b4d8553a420a437a00d23f9a7ba5ce0a8cc746fbbda37a5a3f47bc71e69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f2d426da27a0e133cbcdf1f5724b49607dcf7c0a70949bc2d2775eb1089b25d37e28b2456095d609aa8965f768ff6d6c04111fe65a23f496a41c51c037080e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49d2e8e6b88e127d982a863973dd8a2622d7894aebdaade0cd525563926e7bba895cff710bd38cceccdec8e4bc2030e04a961c9bdecd1967edfd7fab004cfca8"} build_url:https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/Ldnd9TxTRK2rS-kQZHs7fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7818c61a470e1d39d3bc6a5cc6fb9e383ee57a7b6e375f9af1df1125ee57498a0f350b4d8553a420a437a00d23f9a7ba5ce0a8cc746fbbda37a5a3f47bc71e69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f2d426da27a0e133cbcdf1f5724b49607dcf7c0a70949bc2d2775eb1089b25d37e28b2456095d609aa8965f768ff6d6c04111fe65a23f496a41c51c037080e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49d2e8e6b88e127d982a863973dd8a2622d7894aebdaade0cd525563926e7bba895cff710bd38cceccdec8e4bc2030e04a961c9bdecd1967edfd7fab004cfca8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 20:43:24.006008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 20:43:24.006427) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466649739.956585-1903871916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 20:43:24.093465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 20:43:24.094114) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 20:43:24.094704) ========= ========= Total master_lag: 0.22 =========