builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1465553841.41 results: success (0) buildid: 20160610024929 builduid: d2c4356b9e1943cc98e2dc6983467cc0 revision: ce7f534b25804ed865a146882e1bc12670c69e87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.410497) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.410927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.411210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.447013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.447382) ========= 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=db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 03:17:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2016-06-10 03:17:21 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125059 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.586283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.586592) ========= 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=db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020506 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.644125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 03:17:21.644522) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ce7f534b25804ed865a146882e1bc12670c69e87 --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 ce7f534b25804ed865a146882e1bc12670c69e87 --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=db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 03:17:21,697 truncating revision to first 12 chars 2016-06-10 03:17:21,697 Setting DEBUG logging. 2016-06-10 03:17:21,697 attempt 1/10 2016-06-10 03:17:21,697 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ce7f534b2580?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 03:17:22,767 unpacking tar archive at: fx-team-ce7f534b2580/testing/mozharness/ program finished with exit code 0 elapsedTime=1.417203 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 03:17:23.075175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:23.075505) ========= script_repo_revision: ce7f534b25804ed865a146882e1bc12670c69e87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:23.075914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:23.076189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:23.086543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-10 03:17:23.086832) ========= /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=db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:17:23 INFO - MultiFileLogger online at 20160610 03:17:23 in /builds/slave/test 03:17:23 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 03:17:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:17:23 INFO - {'append_to_log': False, 03:17:23 INFO - 'base_work_dir': '/builds/slave/test', 03:17:23 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:17:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:17:23 INFO - 'branch': 'Fx-Team-Non-PGO', 03:17:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:17:23 INFO - 'config_files': ('talos/linux_config.py',), 03:17:23 INFO - 'default_actions': ('clobber', 03:17:23 INFO - 'read-buildbot-config', 03:17:23 INFO - 'download-and-extract', 03:17:23 INFO - 'populate-webroot', 03:17:23 INFO - 'create-virtualenv', 03:17:23 INFO - 'install', 03:17:23 INFO - 'run-tests'), 03:17:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:17:23 INFO - 'download_minidump_stackwalk': True, 03:17:23 INFO - 'download_symbols': 'ondemand', 03:17:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:17:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:17:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:17:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:17:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:17:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:17:23 INFO - 'installer_path': 'installer.exe', 03:17:23 INFO - 'log_level': 'info', 03:17:23 INFO - 'log_name': 'talos', 03:17:23 INFO - 'log_to_console': True, 03:17:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:17:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:17:23 INFO - 'opt_config_files': (), 03:17:23 INFO - 'pip_index': False, 03:17:23 INFO - 'sps_profile': False, 03:17:23 INFO - 'sps_profile_interval': 0, 03:17:23 INFO - 'suite': 'dromaeojs-e10s', 03:17:23 INFO - 'system_bits': '32', 03:17:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:17:23 INFO - 'title': 'talos-linux64-ix-031', 03:17:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:17:23 INFO - 'use_talos_json': True, 03:17:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:17:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:17:23 INFO - 'work_dir': 'build'} 03:17:23 INFO - ##### 03:17:23 INFO - ##### Running clobber step. 03:17:23 INFO - ##### 03:17:23 INFO - Running pre-action listener: _resource_record_pre_action 03:17:23 INFO - Running main action method: clobber 03:17:23 INFO - rmtree: /builds/slave/test/build 03:17:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:17:23 INFO - Running post-action listener: _resource_record_post_action 03:17:23 INFO - ##### 03:17:23 INFO - ##### Finished clobber step (success) 03:17:23 INFO - ##### 03:17:23 INFO - ##### 03:17:23 INFO - ##### Running read-buildbot-config step. 03:17:23 INFO - ##### 03:17:23 INFO - Running pre-action listener: _resource_record_pre_action 03:17:23 INFO - Running main action method: read_buildbot_config 03:17:23 INFO - Using buildbot properties: 03:17:23 INFO - { 03:17:23 INFO - "project": "", 03:17:23 INFO - "product": "firefox", 03:17:23 INFO - "script_repo_revision": "production", 03:17:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:17:23 INFO - "repository": "", 03:17:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:17:23 INFO - "buildid": "20160610024929", 03:17:23 INFO - "pgo_build": "False", 03:17:23 INFO - "basedir": "/builds/slave/test", 03:17:23 INFO - "buildnumber": 1401, 03:17:23 INFO - "slavename": "talos-linux64-ix-031", 03:17:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:17:23 INFO - "platform": "ubuntu64_hw", 03:17:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:17:23 INFO - "branch": "fx-team", 03:17:23 INFO - "repo_path": "integration/fx-team", 03:17:23 INFO - "revision": "ce7f534b25804ed865a146882e1bc12670c69e87", 03:17:23 INFO - "stage_platform": "linux64", 03:17:23 INFO - "builduid": "d2c4356b9e1943cc98e2dc6983467cc0", 03:17:23 INFO - "slavebuilddir": "test" 03:17:23 INFO - } 03:17:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:17:23 INFO - Running post-action listener: _resource_record_post_action 03:17:23 INFO - ##### 03:17:23 INFO - ##### Finished read-buildbot-config step (success) 03:17:23 INFO - ##### 03:17:23 INFO - ##### 03:17:23 INFO - ##### Running download-and-extract step. 03:17:23 INFO - ##### 03:17:23 INFO - Running pre-action listener: _resource_record_pre_action 03:17:23 INFO - Running main action method: download_and_extract 03:17:23 INFO - mkdir: /builds/slave/test/build/tests 03:17:23 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')]} 03:17:23 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:17:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:17:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:17:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:30 INFO - Downloaded 1361 bytes. 03:17:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:17:30 INFO - Using the following test package requirements: 03:17:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:17:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:17:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:17:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:30 INFO - u'jsshell-linux-x86_64.zip'], 03:17:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:17:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:17:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:17:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:17:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:17:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:17:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:17:30 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')]} 03:17:30 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:17:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:17:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:17:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:37 INFO - Downloaded 22879604 bytes. 03:17:37 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'] 03:17:37 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 03:17:38 INFO - Return code: 0 03:17:38 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 03:17:38 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')]} 03:17:38 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:17:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:17:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:17:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:39 INFO - Downloaded 22879604 bytes. 03:17:39 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'] 03:17:39 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 03:17:41 INFO - Return code: 0 03:17:41 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')]} 03:17:41 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:17:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:17:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:17:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:42 INFO - Downloaded 10833377 bytes. 03:17:42 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'] 03:17:42 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 03:17:42 INFO - Return code: 0 03:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:42 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:44 INFO - Downloaded 55379646 bytes. 03:17:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:17:44 INFO - mkdir: /builds/slave/test/properties 03:17:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:17:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:17:44 INFO - Contents: 03:17:44 INFO - build_url:https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:17:44 INFO - Running post-action listener: _resource_record_post_action 03:17:44 INFO - Running post-action listener: set_extra_try_arguments 03:17:44 INFO - ##### 03:17:44 INFO - ##### Finished download-and-extract step (success) 03:17:44 INFO - ##### 03:17:44 INFO - ##### 03:17:44 INFO - ##### Running populate-webroot step. 03:17:44 INFO - ##### 03:17:44 INFO - Running pre-action listener: _resource_record_pre_action 03:17:44 INFO - Running main action method: populate_webroot 03:17:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:17:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:17:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:17:44 INFO - '--tppagecycles', 03:17:44 INFO - '7'], 03:17:44 INFO - 'tests': ['tsvgm']}}, 03:17:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:17:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:17:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:17:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:17:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:44 INFO - 'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:44 INFO - 'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['damp', 'tps']}, 03:17:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:44 INFO - 'tests': ['damp', 'tps']}, 03:17:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['dromaeo_dom']}, 03:17:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:17:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['a11yr', 03:17:44 INFO - 'ts_paint', 03:17:44 INFO - 'tpaint', 03:17:44 INFO - 'sessionrestore', 03:17:44 INFO - 'sessionrestore_no_auto_restore', 03:17:44 INFO - 'tabpaint']}, 03:17:44 INFO - 'other-e10s': {'tests': ['a11yr', 03:17:44 INFO - 'ts_paint', 03:17:44 INFO - 'tpaint', 03:17:44 INFO - 'sessionrestore', 03:17:44 INFO - 'sessionrestore_no_auto_restore', 03:17:44 INFO - 'tabpaint']}, 03:17:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:17:44 INFO - 'ts_paint', 03:17:44 INFO - 'tpaint', 03:17:44 INFO - 'sessionrestore', 03:17:44 INFO - 'sessionrestore_no_auto_restore', 03:17:44 INFO - 'tabpaint']}, 03:17:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:17:44 INFO - 'ts_paint', 03:17:44 INFO - 'tpaint', 03:17:44 INFO - 'sessionrestore', 03:17:44 INFO - 'sessionrestore_no_auto_restore', 03:17:44 INFO - 'tabpaint']}, 03:17:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['a11yr', 03:17:44 INFO - 'ts_paint', 03:17:44 INFO - 'tpaint', 03:17:44 INFO - 'sessionrestore', 03:17:44 INFO - 'sessionrestore_no_auto_restore', 03:17:44 INFO - 'tabpaint']}, 03:17:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['a11yr', 03:17:44 INFO - 'ts_paint', 03:17:44 INFO - 'tpaint', 03:17:44 INFO - 'sessionrestore', 03:17:44 INFO - 'sessionrestore_no_auto_restore', 03:17:44 INFO - 'tabpaint']}, 03:17:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['tsvgx', 03:17:44 INFO - 'tsvgr_opacity', 03:17:44 INFO - 'tart', 03:17:44 INFO - 'tscrollx', 03:17:44 INFO - 'cart']}, 03:17:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:17:44 INFO - 'tsvgr_opacity', 03:17:44 INFO - 'tart', 03:17:44 INFO - 'tscrollx', 03:17:44 INFO - 'cart']}, 03:17:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:44 INFO - 'talos_options': ['--disable-e10s'], 03:17:44 INFO - 'tests': ['tp5o']}, 03:17:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:44 INFO - 'tests': ['tp5o']}, 03:17:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:44 INFO - 'talos_options': ['--disable-e10s', 03:17:44 INFO - '--xperf_path', 03:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:44 INFO - 'tests': ['tp5n']}, 03:17:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:44 INFO - 'talos_options': ['--xperf_path', 03:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:44 INFO - 'tests': ['tp5n']}}, 03:17:44 INFO - 'talos.zip': {'path': '', 03:17:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:17:44 INFO - Running post-action listener: _resource_record_post_action 03:17:44 INFO - ##### 03:17:44 INFO - ##### Finished populate-webroot step (success) 03:17:44 INFO - ##### 03:17:44 INFO - ##### 03:17:44 INFO - ##### Running create-virtualenv step. 03:17:44 INFO - ##### 03:17:44 INFO - Running pre-action listener: _resource_record_pre_action 03:17:44 INFO - Running main action method: create_virtualenv 03:17:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:17:44 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 03:17:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:17:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:17:45 INFO - Using real prefix '/usr' 03:17:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:17:45 INFO - Installing distribute.............................................................................................................................................................................................done. 03:17:47 INFO - Installing pip.................done. 03:17:47 INFO - Return code: 0 03:17:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:17:47 INFO - Using env: {'DISPLAY': ':0', 03:17:47 INFO - 'HOME': '/home/cltbld', 03:17:47 INFO - 'LANG': 'en_US.UTF-8', 03:17:47 INFO - 'LANGUAGE': 'en_US:en', 03:17:47 INFO - 'LOGNAME': 'cltbld', 03:17:47 INFO - 'MAIL': '/var/mail/cltbld', 03:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:47 INFO - 'MOZ_NO_REMOTE': '1', 03:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:47 INFO - 'NO_EM_RESTART': '1', 03:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:47 INFO - 'PWD': '/builds/slave/test', 03:17:47 INFO - 'SHELL': '/bin/bash', 03:17:47 INFO - 'SHLVL': '1', 03:17:47 INFO - 'TERM': 'linux', 03:17:47 INFO - 'TMOUT': '86400', 03:17:47 INFO - 'USER': 'cltbld', 03:17:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:47 INFO - '_': '/tools/buildbot/bin/python'} 03:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:47 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 03:17:47 INFO - Cleaning up... 03:17:47 INFO - Return code: 0 03:17:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:17:47 INFO - Using env: {'DISPLAY': ':0', 03:17:47 INFO - 'HOME': '/home/cltbld', 03:17:47 INFO - 'LANG': 'en_US.UTF-8', 03:17:47 INFO - 'LANGUAGE': 'en_US:en', 03:17:47 INFO - 'LOGNAME': 'cltbld', 03:17:47 INFO - 'MAIL': '/var/mail/cltbld', 03:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:47 INFO - 'MOZ_NO_REMOTE': '1', 03:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:47 INFO - 'NO_EM_RESTART': '1', 03:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:47 INFO - 'PWD': '/builds/slave/test', 03:17:47 INFO - 'SHELL': '/bin/bash', 03:17:47 INFO - 'SHLVL': '1', 03:17:47 INFO - 'TERM': 'linux', 03:17:47 INFO - 'TMOUT': '86400', 03:17:47 INFO - 'USER': 'cltbld', 03:17:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:47 INFO - '_': '/tools/buildbot/bin/python'} 03:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:47 INFO - Downloading/unpacking psutil>=3.1.1 03:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:50 INFO - Installing collected packages: psutil 03:17:50 INFO - Running setup.py install for psutil 03:17:50 INFO - building 'psutil._psutil_linux' extension 03:17:50 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 03:17:50 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 03:17:50 INFO - building 'psutil._psutil_posix' extension 03:17:50 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 03:17:50 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 03:17:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:50 INFO - Successfully installed psutil 03:17:50 INFO - Cleaning up... 03:17:50 INFO - Return code: 0 03:17:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:50 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 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:17:50 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 03:17:50 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 03:17:50 INFO - Using env: {'DISPLAY': ':0', 03:17:50 INFO - 'HOME': '/home/cltbld', 03:17:50 INFO - 'LANG': 'en_US.UTF-8', 03:17:50 INFO - 'LANGUAGE': 'en_US:en', 03:17:50 INFO - 'LOGNAME': 'cltbld', 03:17:50 INFO - 'MAIL': '/var/mail/cltbld', 03:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:50 INFO - 'MOZ_NO_REMOTE': '1', 03:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:50 INFO - 'NO_EM_RESTART': '1', 03:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:50 INFO - 'PWD': '/builds/slave/test', 03:17:50 INFO - 'SHELL': '/bin/bash', 03:17:50 INFO - 'SHLVL': '1', 03:17:50 INFO - 'TERM': 'linux', 03:17:50 INFO - 'TMOUT': '86400', 03:17:50 INFO - 'USER': 'cltbld', 03:17:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:50 INFO - '_': '/tools/buildbot/bin/python'} 03:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:17:52 INFO - Installing collected packages: mozsystemmonitor 03:17:52 INFO - Running setup.py install for mozsystemmonitor 03:17:52 INFO - Successfully installed mozsystemmonitor 03:17:52 INFO - Cleaning up... 03:17:52 INFO - Return code: 0 03:17:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:17:52 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')]} 03:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:52 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')]} 03:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:52 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 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:17:52 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 03:17:52 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 03:17:52 INFO - Using env: {'DISPLAY': ':0', 03:17:52 INFO - 'HOME': '/home/cltbld', 03:17:52 INFO - 'LANG': 'en_US.UTF-8', 03:17:52 INFO - 'LANGUAGE': 'en_US:en', 03:17:52 INFO - 'LOGNAME': 'cltbld', 03:17:52 INFO - 'MAIL': '/var/mail/cltbld', 03:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:52 INFO - 'MOZ_NO_REMOTE': '1', 03:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:52 INFO - 'NO_EM_RESTART': '1', 03:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:52 INFO - 'PWD': '/builds/slave/test', 03:17:52 INFO - 'SHELL': '/bin/bash', 03:17:52 INFO - 'SHLVL': '1', 03:17:52 INFO - 'TERM': 'linux', 03:17:52 INFO - 'TMOUT': '86400', 03:17:52 INFO - 'USER': 'cltbld', 03:17:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:52 INFO - '_': '/tools/buildbot/bin/python'} 03:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:17:53 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 03:17:53 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 03:17:53 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 03:17:53 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 03:17:53 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 03:17:53 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 03:17:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:17:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:17:54 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 03:17:54 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 03:17:54 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 03:17:54 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 03:17:54 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 03:17:54 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 03:17:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:17:55 INFO - warning: no files found matching '*.txt' 03:17:55 INFO - no previously-included directories found matching 'build' 03:17:55 INFO - no previously-included directories found matching 'dist' 03:17:55 INFO - no previously-included directories found matching '.git*' 03:17:55 INFO - Installing collected packages: jsonschema, functools32 03:17:55 INFO - Running setup.py install for functools32 03:17:55 INFO - warning: no files found matching '*.txt' 03:17:55 INFO - no previously-included directories found matching 'build' 03:17:55 INFO - no previously-included directories found matching 'dist' 03:17:55 INFO - no previously-included directories found matching '.git*' 03:17:55 INFO - Successfully installed jsonschema functools32 03:17:55 INFO - Cleaning up... 03:17:55 INFO - Return code: 0 03:17:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:55 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 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:17:55 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 03:17:55 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 03:17:55 INFO - Using env: {'DISPLAY': ':0', 03:17:55 INFO - 'HOME': '/home/cltbld', 03:17:55 INFO - 'LANG': 'en_US.UTF-8', 03:17:55 INFO - 'LANGUAGE': 'en_US:en', 03:17:55 INFO - 'LOGNAME': 'cltbld', 03:17:55 INFO - 'MAIL': '/var/mail/cltbld', 03:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:55 INFO - 'MOZ_NO_REMOTE': '1', 03:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:55 INFO - 'NO_EM_RESTART': '1', 03:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:55 INFO - 'PWD': '/builds/slave/test', 03:17:55 INFO - 'SHELL': '/bin/bash', 03:17:55 INFO - 'SHLVL': '1', 03:17:55 INFO - 'TERM': 'linux', 03:17:55 INFO - 'TMOUT': '86400', 03:17:55 INFO - 'USER': 'cltbld', 03:17:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:55 INFO - '_': '/tools/buildbot/bin/python'} 03:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17:57 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 03:17:57 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 03:17:57 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 03:17:57 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 03:17:57 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 03:17:57 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 03:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17:57 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 03:17:57 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 03:17:57 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 03:17:57 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 03:17:57 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 03:17:57 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 03:17:58 INFO - Downloading docopt-0.6.1.tar.gz 03:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:58 INFO - Running setup.py install for blobuploader 03:17:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:58 INFO - Running setup.py install for requests 03:17:58 INFO - Running setup.py install for docopt 03:17:58 INFO - Successfully installed blobuploader requests docopt 03:17:58 INFO - Cleaning up... 03:17:58 INFO - Return code: 0 03:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 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 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:17:58 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 03:17:58 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 03:17:58 INFO - Using env: {'DISPLAY': ':0', 03:17:58 INFO - 'HOME': '/home/cltbld', 03:17:58 INFO - 'LANG': 'en_US.UTF-8', 03:17:58 INFO - 'LANGUAGE': 'en_US:en', 03:17:58 INFO - 'LOGNAME': 'cltbld', 03:17:58 INFO - 'MAIL': '/var/mail/cltbld', 03:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:58 INFO - 'MOZ_NO_REMOTE': '1', 03:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:58 INFO - 'NO_EM_RESTART': '1', 03:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:58 INFO - 'PWD': '/builds/slave/test', 03:17:58 INFO - 'SHELL': '/bin/bash', 03:17:58 INFO - 'SHLVL': '1', 03:17:58 INFO - 'TERM': 'linux', 03:17:58 INFO - 'TMOUT': '86400', 03:17:58 INFO - 'USER': 'cltbld', 03:17:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:58 INFO - '_': '/tools/buildbot/bin/python'} 03:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:59 INFO - Running setup.py (path:/tmp/pip-4cwMUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:59 INFO - Running setup.py (path:/tmp/pip-H88fTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:59 INFO - Running setup.py (path:/tmp/pip-VJLnKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:59 INFO - Running setup.py (path:/tmp/pip-XWTB_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:59 INFO - Running setup.py (path:/tmp/pip-lpdwdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:59 INFO - Running setup.py (path:/tmp/pip-qhyDBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:59 INFO - Running setup.py (path:/tmp/pip-0Gpxp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:59 INFO - Running setup.py (path:/tmp/pip-J1EgLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:59 INFO - Running setup.py (path:/tmp/pip-bI25NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:59 INFO - Running setup.py (path:/tmp/pip-HvM430-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:59 INFO - Running setup.py (path:/tmp/pip-gx6Q7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:59 INFO - Running setup.py (path:/tmp/pip-YGmGvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:59 INFO - Running setup.py (path:/tmp/pip-CxRs_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:00 INFO - Running setup.py (path:/tmp/pip-MbFtLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:00 INFO - Running setup.py (path:/tmp/pip-KTCL66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:00 INFO - Running setup.py (path:/tmp/pip-K_MZ6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:00 INFO - Running setup.py (path:/tmp/pip-JPUdSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:18:00 INFO - Running setup.py install for manifestparser 03:18:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for mozcrash 03:18:00 INFO - Running setup.py install for mozdebug 03:18:00 INFO - Running setup.py install for mozdevice 03:18:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for mozfile 03:18:00 INFO - Running setup.py install for mozhttpd 03:18:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for mozinfo 03:18:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:18:00 INFO - Running setup.py install for mozInstall 03:18:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Running setup.py install for mozleak 03:18:01 INFO - Running setup.py install for mozlog 03:18:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Running setup.py install for moznetwork 03:18:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Running setup.py install for mozprocess 03:18:01 INFO - Running setup.py install for mozprofile 03:18:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Running setup.py install for mozrunner 03:18:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Running setup.py install for mozscreenshot 03:18:01 INFO - Running setup.py install for moztest 03:18:01 INFO - Running setup.py install for mozversion 03:18:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:18:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:02 INFO - Cleaning up... 03:18:02 INFO - Return code: 0 03:18:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:02 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')]} 03:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:02 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')]} 03:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:02 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 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:18:02 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 03:18:02 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 03:18:02 INFO - Using env: {'DISPLAY': ':0', 03:18:02 INFO - 'HOME': '/home/cltbld', 03:18:02 INFO - 'LANG': 'en_US.UTF-8', 03:18:02 INFO - 'LANGUAGE': 'en_US:en', 03:18:02 INFO - 'LOGNAME': 'cltbld', 03:18:02 INFO - 'MAIL': '/var/mail/cltbld', 03:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:02 INFO - 'MOZ_NO_REMOTE': '1', 03:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:02 INFO - 'NO_EM_RESTART': '1', 03:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:02 INFO - 'PWD': '/builds/slave/test', 03:18:02 INFO - 'SHELL': '/bin/bash', 03:18:02 INFO - 'SHLVL': '1', 03:18:02 INFO - 'TERM': 'linux', 03:18:02 INFO - 'TMOUT': '86400', 03:18:02 INFO - 'USER': 'cltbld', 03:18:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:02 INFO - '_': '/tools/buildbot/bin/python'} 03:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:02 INFO - Running setup.py (path:/tmp/pip-NRA8x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:02 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)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:02 INFO - Running setup.py (path:/tmp/pip-yWSeJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:02 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)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:02 INFO - Running setup.py (path:/tmp/pip-XcMk8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:02 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)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:02 INFO - Running setup.py (path:/tmp/pip-NZcJQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:02 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)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:02 INFO - Running setup.py (path:/tmp/pip-648Qnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:02 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)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:02 INFO - Running setup.py (path:/tmp/pip-SUuPB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:02 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)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:02 INFO - Running setup.py (path:/tmp/pip-O0RCVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:02 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)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:02 INFO - Running setup.py (path:/tmp/pip-7cSkhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:02 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)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:02 INFO - Running setup.py (path:/tmp/pip-L6ZUYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:02 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)) 03:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:02 INFO - Running setup.py (path:/tmp/pip-Fogp5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:03 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)) 03:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:03 INFO - Running setup.py (path:/tmp/pip-x2iWJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:03 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)) 03:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:03 INFO - Running setup.py (path:/tmp/pip-3VEXHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:03 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)) 03:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:03 INFO - Running setup.py (path:/tmp/pip-gXIbOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:03 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)) 03:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:03 INFO - Running setup.py (path:/tmp/pip-5o6nTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:03 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)) 03:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:03 INFO - Running setup.py (path:/tmp/pip-D0gKn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:03 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)) 03:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:03 INFO - Running setup.py (path:/tmp/pip-nLpsnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:03 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)) 03:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:03 INFO - Running setup.py (path:/tmp/pip-CQk9VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:03 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)) 03:18:03 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)) 03:18:03 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)) 03:18:03 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)) 03:18:03 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)) 03:18:03 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)) 03:18:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:05 INFO - Downloading blessings-1.6.tar.gz 03:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:18:05 INFO - Installing collected packages: blessings 03:18:05 INFO - Running setup.py install for blessings 03:18:05 INFO - Successfully installed blessings 03:18:05 INFO - Cleaning up... 03:18:05 INFO - Return code: 0 03:18:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:05 INFO - Reading from file tmpfile_stdout 03:18:05 INFO - Current package versions: 03:18:05 INFO - argparse == 1.2.1 03:18:05 INFO - blessings == 1.6 03:18:05 INFO - blobuploader == 1.2.4 03:18:05 INFO - docopt == 0.6.1 03:18:05 INFO - functools32 == 3.2.3-2 03:18:05 INFO - jsonschema == 2.5.1 03:18:05 INFO - manifestparser == 1.1 03:18:05 INFO - mozInstall == 1.12 03:18:05 INFO - mozcrash == 0.17 03:18:05 INFO - mozdebug == 0.1 03:18:05 INFO - mozdevice == 0.48 03:18:05 INFO - mozfile == 1.2 03:18:05 INFO - mozhttpd == 0.7 03:18:05 INFO - mozinfo == 0.9 03:18:05 INFO - mozleak == 0.1 03:18:05 INFO - mozlog == 3.2 03:18:05 INFO - moznetwork == 0.27 03:18:05 INFO - mozprocess == 0.22 03:18:05 INFO - mozprofile == 0.28 03:18:05 INFO - mozrunner == 6.11 03:18:05 INFO - mozscreenshot == 0.1 03:18:05 INFO - mozsystemmonitor == 0.3 03:18:05 INFO - moztest == 0.7 03:18:05 INFO - mozversion == 1.4 03:18:05 INFO - psutil == 3.1.1 03:18:05 INFO - requests == 1.2.3 03:18:05 INFO - wsgiref == 0.1.2 03:18:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:05 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')]} 03:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:05 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')]} 03:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:05 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 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:18:05 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 03:18:05 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 03:18:05 INFO - Using env: {'DISPLAY': ':0', 03:18:05 INFO - 'HOME': '/home/cltbld', 03:18:05 INFO - 'LANG': 'en_US.UTF-8', 03:18:05 INFO - 'LANGUAGE': 'en_US:en', 03:18:05 INFO - 'LOGNAME': 'cltbld', 03:18:05 INFO - 'MAIL': '/var/mail/cltbld', 03:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:05 INFO - 'MOZ_NO_REMOTE': '1', 03:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:05 INFO - 'NO_EM_RESTART': '1', 03:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:05 INFO - 'PWD': '/builds/slave/test', 03:18:05 INFO - 'SHELL': '/bin/bash', 03:18:05 INFO - 'SHLVL': '1', 03:18:05 INFO - 'TERM': 'linux', 03:18:05 INFO - 'TMOUT': '86400', 03:18:05 INFO - 'USER': 'cltbld', 03:18:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:05 INFO - '_': '/tools/buildbot/bin/python'} 03:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:06 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)) 03:18:06 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)) 03:18:06 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)) 03:18:06 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)) 03:18:06 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)) 03:18:06 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)) 03:18:06 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)) 03:18:06 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)) 03:18:06 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)) 03:18:06 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)) 03:18:06 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)) 03:18:06 INFO - Cleaning up... 03:18:06 INFO - Return code: 0 03:18:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:18:06 INFO - Using env: {'DISPLAY': ':0', 03:18:06 INFO - 'HOME': '/home/cltbld', 03:18:06 INFO - 'LANG': 'en_US.UTF-8', 03:18:06 INFO - 'LANGUAGE': 'en_US:en', 03:18:06 INFO - 'LOGNAME': 'cltbld', 03:18:06 INFO - 'MAIL': '/var/mail/cltbld', 03:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:06 INFO - 'MOZ_NO_REMOTE': '1', 03:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:06 INFO - 'NO_EM_RESTART': '1', 03:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:06 INFO - 'PWD': '/builds/slave/test', 03:18:06 INFO - 'SHELL': '/bin/bash', 03:18:06 INFO - 'SHLVL': '1', 03:18:06 INFO - 'TERM': 'linux', 03:18:06 INFO - 'TMOUT': '86400', 03:18:06 INFO - 'USER': 'cltbld', 03:18:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:06 INFO - '_': '/tools/buildbot/bin/python'} 03:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:18:06 INFO - Cleaning up... 03:18:06 INFO - Return code: 0 03:18:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe89df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, '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': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', '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 03:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:18:06 INFO - Using env: {'DISPLAY': ':0', 03:18:06 INFO - 'HOME': '/home/cltbld', 03:18:06 INFO - 'LANG': 'en_US.UTF-8', 03:18:06 INFO - 'LANGUAGE': 'en_US:en', 03:18:06 INFO - 'LOGNAME': 'cltbld', 03:18:06 INFO - 'MAIL': '/var/mail/cltbld', 03:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:06 INFO - 'MOZ_NO_REMOTE': '1', 03:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:06 INFO - 'NO_EM_RESTART': '1', 03:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:06 INFO - 'PWD': '/builds/slave/test', 03:18:06 INFO - 'SHELL': '/bin/bash', 03:18:06 INFO - 'SHLVL': '1', 03:18:06 INFO - 'TERM': 'linux', 03:18:06 INFO - 'TMOUT': '86400', 03:18:06 INFO - 'USER': 'cltbld', 03:18:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:06 INFO - '_': '/tools/buildbot/bin/python'} 03:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:06 INFO - Downloading/unpacking flake8 03:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:18:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:18:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 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 03:18:08 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 03:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:18:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:09 INFO - no previously-included directories found matching 'docs/_build' 03:18:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:18:09 INFO - Running setup.py install for pep8 03:18:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:09 INFO - no previously-included directories found matching 'docs/_build' 03:18:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:18:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:18:09 INFO - Cleaning up... 03:18:09 INFO - Return code: 0 03:18:09 INFO - Running post-action listener: _resource_record_post_action 03:18:09 INFO - Running post-action listener: _start_resource_monitoring 03:18:09 INFO - Starting resource monitoring. 03:18:09 INFO - ##### 03:18:09 INFO - ##### Finished create-virtualenv step (success) 03:18:09 INFO - ##### 03:18:09 INFO - ##### 03:18:09 INFO - ##### Running install step. 03:18:09 INFO - ##### 03:18:09 INFO - Running pre-action listener: _resource_record_pre_action 03:18:09 INFO - Running main action method: install 03:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:09 INFO - Reading from file tmpfile_stdout 03:18:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:18:09 INFO - Reading from file tmpfile_stdout 03:18:09 INFO - Output received: 03:18:09 INFO - Usage: mozinstall [options] installer 03:18:09 INFO - Options: 03:18:09 INFO - -h, --help show this help message and exit 03:18:09 INFO - -d DEST, --destination=DEST 03:18:09 INFO - Directory to install application into. [default: 03:18:09 INFO - "/builds/slave/test"] 03:18:09 INFO - --app=APP Application being installed. [default: firefox] 03:18:09 INFO - mkdir: /builds/slave/test/build/application 03:18:09 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'] 03:18:09 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 03:18:25 INFO - Reading from file tmpfile_stdout 03:18:25 INFO - Output received: 03:18:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:18:25 INFO - Running post-action listener: _resource_record_post_action 03:18:25 INFO - ##### 03:18:25 INFO - ##### Finished install step (success) 03:18:25 INFO - ##### 03:18:25 INFO - ##### 03:18:25 INFO - ##### Running run-tests step. 03:18:25 INFO - ##### 03:18:25 INFO - Running pre-action listener: _resource_record_pre_action 03:18:25 INFO - Running main action method: run_tests 03:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:18:25 INFO - Python 2.7.3 03:18:25 INFO - Return code: 0 03:18:25 INFO - grabbing minidump binary from tooltool 03:18:25 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')]} 03:18:25 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 0x1d14e20>, '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 0x1d183a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:18:25 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 03:18:25 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 03:18:25 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 03:18:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:18:25 INFO - Return code: 0 03:18:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:18:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:18:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:18:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:18:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:18:26 INFO - Return code: 0 03:18:26 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/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 03:18:26 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/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 03:18:26 INFO - Using env: {'DISPLAY': ':0', 03:18:26 INFO - 'HOME': '/home/cltbld', 03:18:26 INFO - 'LANG': 'en_US.UTF-8', 03:18:26 INFO - 'LANGUAGE': 'en_US:en', 03:18:26 INFO - 'LOGNAME': 'cltbld', 03:18:26 INFO - 'MAIL': '/var/mail/cltbld', 03:18:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:26 INFO - 'MOZ_NO_REMOTE': '1', 03:18:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:26 INFO - 'NO_EM_RESTART': '1', 03:18:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:26 INFO - 'PWD': '/builds/slave/test', 03:18:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:26 INFO - 'SHELL': '/bin/bash', 03:18:26 INFO - 'SHLVL': '1', 03:18:26 INFO - 'TERM': 'linux', 03:18:26 INFO - 'TMOUT': '86400', 03:18:26 INFO - 'USER': 'cltbld', 03:18:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095', 03:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:26 INFO - '_': '/tools/buildbot/bin/python'} 03:18:26 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/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 03:18:26 INFO - mozversion application_buildid: 20160610024929 03:18:26 INFO - mozversion application_changeset: ce7f534b25804ed865a146882e1bc12670c69e87 03:18:26 INFO - mozversion application_display_name: Nightly 03:18:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:18:26 INFO - mozversion application_name: Firefox 03:18:26 INFO - mozversion application_remotingname: firefox 03:18:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:18:26 INFO - mozversion application_vendor: Mozilla 03:18:26 INFO - mozversion application_version: 50.0a1 03:18:26 INFO - mozversion platform_buildid: 20160610024929 03:18:26 INFO - mozversion platform_changeset: ce7f534b25804ed865a146882e1bc12670c69e87 03:18:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:18:26 INFO - mozversion platform_version: 50.0a1 03:18:26 INFO - using testdate: 1465553906 03:18:26 INFO - actual date: 1465553906 03:18:26 INFO - starting webserver on 'localhost:37005' 03:18:26 INFO - SUITE-START | Running 2 tests 03:18:26 INFO - TEST-START | dromaeo_css 03:18:26 INFO - operating with platform_type : linux_ 03:18:26 INFO - Initialising browser for dromaeo_css test... 03:18:26 INFO - TEST-INFO | started process 16093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5NlrO/profile http://localhost:37005/getInfo.html) 03:18:32 INFO - PROCESS | 16093 | __metrics Screen width/height:1600/1200 03:18:32 INFO - PROCESS | 16093 | colorDepth:24 03:18:32 INFO - PROCESS | 16093 | Browser inner width/height: 1024/697 03:18:32 INFO - PROCESS | 16093 | __metrics 03:18:32 ERROR - PROCESS | 16093 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:18:33 INFO - TEST-INFO | 16093: exit 0 03:18:33 INFO - Browser initialized. 03:18:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:18:33 INFO - TEST-INFO | started process 16211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5NlrO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:45 INFO - PROCESS | 16211 | RSS: Main: 185110528 03:18:45 INFO - PROCESS | 16211 | 03:19:35 INFO - PROCESS | 16211 | 1465553975550 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] 03:21:47 INFO - PROCESS | 16211 | Cycle 1(1): loaded http://localhost:37005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37005/tests/dromaeo/cssquery-ext.html) 03:21:48 INFO - PROCESS | 16211 | RSS: Main: 187871232 03:21:48 INFO - PROCESS | 16211 | 03:24:50 INFO - PROCESS | 16211 | Cycle 1(1): loaded http://localhost:37005/tests/dromaeo/cssquery-ext.html (next: http://localhost:37005/tests/dromaeo/cssquery-jquery.html) 03:24:51 INFO - PROCESS | 16211 | RSS: Main: 186941440 03:24:51 INFO - PROCESS | 16211 | 03:27:53 INFO - PROCESS | 16211 | Cycle 1(1): loaded http://localhost:37005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37005/tests/dromaeo/cssquery-mootools.html) 03:27:53 INFO - PROCESS | 16211 | RSS: Main: 188420096 03:27:53 INFO - PROCESS | 16211 | 03:30:55 INFO - PROCESS | 16211 | Cycle 1(1): loaded http://localhost:37005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37005/tests/dromaeo/cssquery-prototype.html) 03:30:56 INFO - PROCESS | 16211 | RSS: Main: 185655296 03:30:56 INFO - PROCESS | 16211 | 03:33:59 INFO - PROCESS | 16211 | Cycle 1(1): loaded http://localhost:37005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37005/tests/dromaeo/cssquery-yui.html) 03:33:59 INFO - PROCESS | 16211 | RSS: Main: 187150336 03:33:59 INFO - PROCESS | 16211 | 03:37:02 INFO - PROCESS | 16211 | Cycle 1(1): loaded http://localhost:37005/tests/dromaeo/cssquery-yui.html (next: http://localhost:37005/tests/dromaeo/cssquery-dojo.html) 03:37:02 INFO - PROCESS | 16211 | RSS: Main: 188493824 03:37:02 INFO - PROCESS | 16211 | 03:37:02 INFO - PROCESS | 16211 | __start_tp_report 03:37:02 INFO - PROCESS | 16211 | _x_x_mozilla_page_load 03:37:02 INFO - PROCESS | 16211 | _x_x_mozilla_page_load_details 03:37:02 INFO - PROCESS | 16211 | |i|pagename|runs| 03:37:02 INFO - PROCESS | 16211 | |0;dojo.html;2600.0769726747008;2672.3319170207446;2680.343315887608;2693.434378780456;2694.2321438390063;4792.544708252714;4812.759362031898;4831.613470922327;4884.78018489168;4928.4825093365125;4597.126545956275;4814;4825.493323201057;4850.34520339754;4854.927176092361;4413.867583972478;4457.153140903234;4560.680752347337;4581.541845815408;4612.377329060584;583.4634493084023;4110.1163249901265;4264.701470897038;4358.106588149438;4391.27543955247;4368.453943257093;4400.163968845909;4403.977980110111;4415.66882483815;4443.777811109464;4414.977925110386;4415.558444155591;4425.955740442587;4438.223310920576;4460.442444694413;4388;4417.779111044467;4451.59935605797;4457.175422546807;4462.3975763271865;4815.446223684251;4860.05228980349;4861.829835955725;4866.051120031595;4874.293227481995;4907.55831975124;5118.667286626394;5138.794448222066;5156.252343410185;5173.844784656466;5226.085435048852;5232.241325007891;5258;5263.86840328991;5315.867103322409;4870.46424893265;4899.265110233458;4901.779419926112;4908.631852611068;4938.481459446778;5039.773210205476;5266.947330526646;5318.73406329682;5359.892802143935;5370.087085195526;5097.515736005073;5107.33604631403;5115.462876397999;5118.155504341742;5159.25190847325;5209.609279303992;5214.296070030573;5214.634975551751;5223.764930578133;5264.263003179558;4913.459519452857;4990.650654454226;5031.52200540948;5042.949570504248;5150.793968241228;5026.472220416804;5029.4719054498755;5052.595792336604;5063.392392912874;5074.06129865976;4322.891927701769;4323.070539833888;4332.978335108304;4337.587929146726;4393.275109606879;3687.520622319081;3723.497327860758;3820.3505404081375;3822.2928758179823;3847.8653247136217;4432.689711720213;4444.6666500012625;4451.1765323415275;4480;4546.61353784932;5246.344206974129;5252.763625636855;5258.474152584711;5260.289860868734;5275.393329767126;4273.572642735701;4386.407834942306;4413.095315460387;4429.867103986886;4533.54664533544;4600.60894823937;4619.930701039487;4626.467956185014;4627.8843028923875;4669.2996050592;4791.209450440708;4824.300476430968;4833.154198015403;4836.951630483721;4877.975610121997;5045.142325804549;5165;5183.974080129575;5206.9586082782835;5237.947620523746;4868.3427737255015;4879.4876537963;4880.536349046835;4895.534924182197;4945.901081978268;4876.414830220397;5137.691738495552;5139.049275883974;5144.76848541824;5145.382554093533;5159.09715799741;5201.583873290052;5204.58363330925;5209.843704688866;5223.660462069954;5063.417706963746;5071.137906555969;5073.847784566469;5089.694618322913;5111.284420181252;4803.447603525499;4962.082014827269;5077.39071311445;5079.288899554139;5089.236614507853;4905.043516514245;4936.111499929903;4985.077760614298;4990;5031.84904452867;5078.7206703631655;5080.949190508048;5096.108181068373;5105.387353517602;5137.17805151174;4975.676581022222;4985.850424487271;4990.775415106402;5027;5030.62270329734 03:37:02 INFO - PROCESS | 16211 | |1;ext.html;534.6046910861897;583.7519054401878;586.5805948746647;595;607.4290167242794;35281.11797205071;39627.81116566501;39864.800675996616;39909;39924.401133982974;39328.60671393285;39793;39941.8002909985;40043.199136017334;40199.19601607966;7741.961290193542;7873.96063019687;7892.684292628288;7897.526148431084;7906.723264685737;7650.3497202737835;7804.843903121934;7808.804779880492;7809.648565814524;7844.1763614820475;7837.451378403514;7845.293923546879;7866.6460009299435;7902.051753789553;7913.802154946115;7720.459567830254;7786.80532986677;7857.174996625329;7890.921090789076;7892.329152022085;7752.26353496417;7802.687892484294;7825.060992680915;7835.686572537092;7872.488288261245;30424.239394015105;38288;38427;38495;38739.806300968594;2824.901128460494;2838.9858050709613;2896.362800183956;2902.3034471726633;2942.926426839325;27516.862415687992;27655.58516622232;27948.301292467648;28757.85621071881;28834.855825720948;3055.266735983348;3167.5090360993854;3204.3911656785135;3250.8699652013893;3262.217067903686;254738;256175;257528.99999999814;257996.99999999814;258134;32278.354432911212;32830.99999999952;32942.835285823414;56518.43481565214;57487.42512574905;34519;34522.30955380878;34543.654563454045;34575;34869.476957845654;13767.31163441824;14024.509142179975;14059.859401405854;14068.296585170701;14093.15441073539;11530.077593792477;11725.296482211095;11730.237534560227;11771.117166212569;11790.823137652942;7865.764027079197;7866.410019248465;7925.247101525346;7952.284294413531;7974.960125199337;3143.3713257348622;3144.7326977206735;3162.810231386124;3176.539401786728;3214.421404147229;863.9891327147253;865.8787769712245;906.6464079009191;908.8545832666741;972.2999440402899;27456.45087098247;28569;28726.281842954093;29220.853895730812;29414.11757647274;946.7017889364828;954.746992047108;969.1229437359201;1010.0000999010927;1041.9947900260602;14279.286485621584;14566.563003109924;14753.188574628284;14757;14855.628609284639;382554;384297;387228;387587;388382;50499.24251136236;50713.23930141051;50870.49129508732;50872.491275087516;51085.23372149421;1173.8063219568676;1214.7266864955313;1227.8281040654315;1236.5919246648584;1250.4810503641252;25704.357391065372;27518.449631006868;27687.30781730473;27882.721172788824;28159.43681126407;43504.34743478914;43534.34698479462;43945.560544394146;44325.77837110794;44436.33345499885;323374;326696;328304;328562;330378;25643.487130257665;25968.740312596634;26056.609150863133;26105.347366315993;26270.4745905077;43192.56807431886;43249.567504325816;43450.782746086064;43621;44342;36981.63018369782;37003.25993480169;37208.28158589091;37358;37837;36752.44871326879;36797.63202367942;37146.6285337154;37234.6276537242;37412.625873740915;35969;36646.63353366539;37060.81469592742;37273.81363093167;37362.25275494529;31881.68118318787;32474.04421339381;32976.835115824266;33104.33791324208;33474;25554.488910222062;25613.3596660085;25662.358441039123;25732.8713356432;25759.742402576485 03:37:02 INFO - PROCESS | 16211 | |2;jquery.html;341.9606745224298;356.76275276940834;357.25155798601935;360.5439119513817;371.99256014879705;15800;16601;17525.386611468584;17586.032768197743;17606.559836004108;15788.921055394736;16032.43886463974;16640.33438662452;16808.66382672346;16842.326306947707;4817.494163112867;4990.6756060856105;5015.699058056528;5021.071101846152;5021.27191557224;3111.455495288327;4954.2568614707725;5661.348944871331;5942.910856337158;5945.821625351246;5988.8502787430225;6004.18943442634;6006.219191505098;6009.369016253296;6013.789517366893;5864.912026319608;5949.524038076965;5984.102384642295;5990.311114221877;5990.700464976734;4580.427446569179;5120.411152717448;5138.075146473633;5148.536631703128;5186.170212765939;11975.341356225492;12212.389380531027;12309.507619695201;12317.568885088978;12354.444050017772;1852.4905650945964;1870.78485974112;1922.644310802506;1938.4589251545056;1947.737055497504;8283.840262363274;8470.195331443503;8756.124387561193;8820.117988201193;8838.823223535494;1594.234767311697;1626.8698504119643;1648.5384092454133;1657.917104144788;1688.6622675464955;63328;67042.3295767041;67182.32817671858;69121;69236.30763692349;9845.704628861145;9879.80240395188;10004.599816007423;10014.49927503622;10183.643572474928;13504.324783760772;13587.728245435035;13614.591562253148;13620;13657;7428.1086269647985;7457.962710186414;7546.773596792105;7664.31021208094;7744.303012728881;7438.070241219848;7495.550266983998;7580.649998500482;7693.6537855795505;7721.806954826175;4225.683073769418;4231.788410579458;4257.084726783694;4331.935020974688;4414.514403415622;1636.2882146266413;1693.635868288324;1768.3545505890515;1813.5919418130816;1837.9540511487319;798.3972101063775;836.4981011393237;850.2093053460342;933.169479163545;940.3699521320732;16585.50243492697;16759.664806703797;16767.161641917854;16967.83032169687;17193.570160745832;874.7550685807984;879.560219890055;882.0694167653188;893.1113542025596;956.0248546482549;9306.90693093074;9441.386309889973;9582.952085239529;9670.274729395323;9768.853467197998;385572;389353;392682;394429;406941;47019;75136.24863751401;75720.62139689266;76126.61936690281;78759;834.1116710703203;895.0825403960993;913.2785099771239;935.9672411465566;938.9671361502315;15052.247387630794;15133.848661513244;15159.242037898282;15184.950031745573;15370.385184592938;35326;35569.46645800367;35797.28405431825;35916;36860.81569592135;48931;49233.75383123061;49485;49643.50356496534;49817.50182498273;7459.179490256176;7557.470977031555;7724.227577242231;7748.806279842824;8037.437379383387;11624.244424112405;11837.289762614271;11883.108766842694;11930.343831089373;12276.508939642672;9750.21998240125;9792.606582030521;9829.115379615869;9898.703038908845;10144.695659130239;10364.637237696645;10458.47707614601;10611.575536978435;10653.57385704563;10747.785044298915;6920.515563910478;10023.148032417326;10025.699229023141;10065.849012264676;10097.747556310856;7410.073740782403;7422.406207503279;7528.8494230116185;7667.731629392944;7893.486923349964;9409.811803763749;9785.119339259501;9818;9994.250431217542;9994.850077248702 03:37:02 INFO - PROCESS | 16211 | |3;mootools.html;1279.24524530527;1336.7527007503613;1366.2349084512673;1555.7121932442492;1563.8748900087994;6606.438452731523;7410.444216683743;7454.478186526939;7821.843563128741;7978.28195462409;7607.23927607239;7792.376609871211;7805.141434442221;7847.254510821463;7852.136265010844;2207.3267653365715;2214.0811563201332;2227.8329125315586;2231.9107235710553;2232.966505502419;2119.73503312086;2160.794724501178;2163.556470923465;2182.34529641107;2183.901724422397;2166.967495487569;2168.902399392031;2171.0664414301846;2172.2397160993683;2202.8458007939453;2069.224040984631;2081.3651836189956;2081.875087494755;2091.5294058836794;2102.873827570351;2068.152057656369;2097.7272954515815;2098.2551194325947;2103.05362586835;2125.1180759984586;7912.604369781546;7914.722984695565;7930.563818989954;7966.721164759264;7980;4435.379046933432;4518.412606361185;4557.817687292504;4565.155446242423;4567;2838.247864315958;2895.942081158386;2953.763698904104;2983.298924752703;2994.9850250748823;900.2482926756167;914.6158613382395;920.7513971227798;927.248928368024;931.4923366765129;10524.31591946521;10534.631287904964;10544.103751181083;10678.839817402744;10690.625828096057;4085.530164031115;4169.207850508394;4217.283061879488;4225.154969006211;4245.957540424618;9015.909840901639;9085.500297483703;9118.361714679908;9122.726318210463;9139.451632902048;4668.253079507263;4673.205555055649;4685.8594242172785;4697.600703940135;4718.4809670936165;3509.3507701074873;3915.353966595537;4026.1343811080174;4155.397467367215;4273.423087883159;3417.863285468603;3481.7040551552896;3528.3648943190474;3624.9456258156147;3640.21735326906;1154.549725607014;1178.3342411537453;1184.9703757405962;1185.8576970763563;1189.79178643737;707.9787606371817;726.989095163573;761.6572542355962;771.4792515052317;779.3453499060817;4811;4898.706077635354;4901.877453063631;4943.382077240345;4989.476105008995;392.4642862492677;395.7862754112804;402.67986950374524;402.76840816530614;420.49960546949035;3433.210361616842;3453.533772940621;3474.0967348489576;3492.161881148506;3519.595246546629;8777.692780752643;9521.333506654606;9532.52337383128;9571.18644915176;9584.0415958405;9238.95380523093;9392.8591071134;9444.244460443148;9498.905010949802;9499.335046546814;7215.67529461165;7253.9999999998945;7291.598962057138;7309.415246780245;7341.77974660761;4997.750112494434;5009.624278179224;5065.949340506548;5107.87230319245;5160.587153027674;8387;8694.34792390586;8696.521691306785;8884.60019299146;8900.198982091642;8778.244351129928;8957.552122393723;8971.955140224258;8982.820343593223;8993.010768815557;5652.717364131695;6225.284092329259;6289.27673317556;6331.3352098029045;6543.770968016097;7081.46888983318;7138.46461515378;7154.499185056996;7158.606276654834;7158.856822863409;6556.246031706415;6714.060031595678;6721.630310332978;6789.321067893171;6796.490263230178;6514.218293804774;6563.310852360624;6600.207975043026;6607.537472376887;6699.162604674416;5874.471297583238;5919.082542205965;5939.07944268639;5941.0197317442135;5964.5526585505395;4293.91412171761;4372.125574885099;4397.978010109929;4398.912021759611;4433.113377324484;4271.508776490619;4316;4335.739855608674;4393.275109606879;4445.133199026288 03:37:02 INFO - PROCESS | 16211 | |4;prototype.html;284.84903001409236;296.09100062807175;296.9376430949501;299.2951598984392;304.48845938822797;4955.4548999610015;5061.291419201306;5105.974470127653;5162.664426812259;5180.653030212144;5066.923996140061;5088.135017047101;5111.258867464216;5111.846644600668;5126.512981266783;4003.159336539323;4007.418924255981;4024.678025757947;4045.8152597597264;4046.4739583854057;3924.352481840507;4002.959970400288;4038.1116154445976;4059.939100913489;4063.5326937402133;3964.6233607807358;3973.5033120859894;3975.383815508601;3998.340688614236;3999.6200360965663;3985.202959408101;3992.161646054332;3999.1601763629383;4008.4588580541545;4019.919601607981;3533.522974398449;3541.4687796830426;3548.2193917338145;3548.6273941236313;3553.573571171476;4820.71075735457;4992.650514463989;5001.199808030734;5016.849494515171;5074.797008119671;4579.564941330568;4580.129775342674;4586.555235100933;4604.132528675928;4608.193566125948;5322.281491998569;5355.2770375999135;5374.381946076212;5412.756425960842;5420.457954204588;3777.58446570877;3856.710746693981;3860;3861.903452413684;3887.4946256986696;5650.491455769042;5665.206871038058;5676.2620859288445;5704.543636509069;5710.77156913723;3912.0439780109946;3922.666573341298;3930.5283365996265;3950.111224974358;3961.3463778476803;3886.9222615547533;3895.475079242258;3922.9607703922597;3992.1416895367634;4008.478897743333;4450.866474005785;4479.865604031885;4493.370928070073;4497.302918047708;4512.503624601291;5374.70439125844;5375.650582712111;5382.569394448435;5430.239766432703;5431.592630552725;1266.8859802617808;1318.8351456067992;1344.1733333999716;1346.414309775251;1346.5758286139835;848.3764433141636;866.8613021916589;871.4030888841037;871.6295574380863;873.1879352202512;4184.28867092595;4201.747895126302;4211.284081706117;4227.3447615619625;4240.300350442142;4835.274708793709;4919.434265059493;4931.950680493221;4933.531314525115;4939.87650308738;4105.609967053125;4175.749455032707;4204.495460544693;4228.154369126126;4236.152769446123;2522.621606758964;2624.1499742681362;2629.3426643339167;2629.7501737334924;2635.6968948570775;4586.701864378805;4600.470945841204;4609.53904609543;4642.489326174118;4672.229082201467;4932.013597280558;4956.265307142471;4978.352814134212;4994.502748625687;4999.650024498323;4309.353596960481;4565.128297398051;4568.680192386568;4582.95417045832;4630.699004564693;4844;4859.246816743411;4875.488073752205;4886.511348865085;4911.109222949119;4781.856544303677;4783.378160839069;4783.976080119577;4795.640326975421;4819.795051237191;4357.172137293904;4550.522195169459;4579.290210017452;4594.954050459452;4620.676552641283;3542.636085107201;3546.7231796552705;3551.5915669697283;3556.9466458002635;3575.481555174433;4854.320395144612;4858.004109157543;4895.951040489692;4913.48408417111;5280.656757310762;5254.947450525446;5380.273663055437;5386.599484134075;5390.27231323782;5393.7033463159905;5399.787126659631;5419.729013549228;5419.888922770744;5422.267993820784;5431.56547476193;5076.416212135504;5239.816606418757;5306.991671582387;5314.46588018963;5332.813351532678;5337.786488540415;5353.946460535345;5369.301990741179;5376.973115134399;5408.37803652585;5236.790528378974;5241.187615919539;5277.894442111213;5283.418823929288;5307.150855863043 03:37:02 INFO - PROCESS | 16211 | |5;yui.html;481.46316856704783;522.898034883198;539.0593414491711;573.8708790522134;579.672485045949;10470.68587942362;10714.142868570516;10805.621803236878;10806.78386432271;10850.348979061262;11728.82406763897;11730.237534560247;11853.348065856375;13609.591712248624;14005.789913151311;614.6220074654078;754.6717178027549;758.321302434321;759.1194214710937;760.9954859585349;751.0499218488588;778.9922100779005;784.2862994674847;787.5904529644581;788.7476007677517;793.9166387529312;804.2600807257337;805.5730462854697;806.4596720197452;807.0718673525434;797.972070977513;800.0679208721832;802.83541873916;803.2449497472358;804.891339669146;583.6789765628887;591.066115537454;591.2077815726947;591.4558606082414;593.7001814083903;12173.330466824322;12203.02375809933;12217.144799864012;12233.69415764613;12252.387380630933;11748.941255293754;12305.876941230563;12406.379681015913;12762.872371276262;12804.103712740112;9656.324057315991;9689.660861869872;9914;10163.996379946475;10334.638287659971;3219.7746157768966;3235.627902791162;3260.4620237660756;3261.266215101607;3274.3287626036604;57492.425075749125;59200.70399648017;59233;59358.032098394906;59788;8954.686585969459;9083.727488175366;9094.454332740057;9151.222146117521;9166.26669866409;18386.35647752349;18450.630987380177;18509.7223541647;18591.53521161982;18946.147423365983;5920.970395147997;5929.347771745104;6045.516358691294;6097.451229389376;6103.511719062464;3398.6431424700545;3433.7081348085194;3524.242287908112;3611.602723700391;3735.215604722984;2770.279727270884;2864.3412015236195;2872.8850845966344;2876.1227825513;2878.107786586165;471.7570451217626;474.103943546697;478.84437557793854;496.9403671559436;499.16888380845484;423.3184572837729;443.84909130895653;460.4589607211513;513.0739016075944;533.3652952985934;6987.161540615057;7416;7681.193474685189;7953;8105.6757729691335;431.86612150233526;436.7794263896712;483.20512756516035;493.81730754841954;513.2250302043866;3342.4986252062386;3470.843812028414;3793.374093274634;3805.46723458716;3890.533136023695;95464.52267738617;97934;99723.50138249407;100155;102491;62979;64509.35490645127;68478.22290524213;81265;88534.55732721295;50203.748981255594;71621.28378716251;71815.6409217961;73321;73919;7335.303146201102;7539.73610923637;7591.240875912365;7609.2010338913615;7765.572893490912;33947.83026084854;36281;39737.40393894036;43436;46191.30713039375;58929.70535147468;61904.69047654733;62202;62525;62780.686096569225;9346.20557252641;9603.951980240334;9644.614215431584;10355.326903751233;10664.740604219134;10400;10623.575056997943;10760.515776789907;11086.501107450345;11098.667039988813;9813.852792208265;9845.65540206118;10014.298999069995;10016.599336026477;10276.075153236245;10337.896621033995;10456.68629941103;10565.313254638424;10811.891881081088;10831.566737330419;9876.555554999899;9978.700638980843;10010.949945250228;10314.638987635397;10421.322614030063;9168.31237657165;9186.265098791948;9388.624455021996;9582.185514231089;9766.9023309766;8816.691415800417;8833.07252738479;8844.955775221082;8967.103289671242;9151 03:37:02 INFO - PROCESS | 16211 | __end_tp_report 03:37:02 INFO - PROCESS | 16211 | __start_cc_report 03:37:02 INFO - PROCESS | 16211 | _x_x_mozilla_cycle_collect,395 03:37:02 INFO - PROCESS | 16211 | __end_cc_report 03:37:02 INFO - PROCESS | 16211 | __startTimestamp1465555022382__endTimestamp 03:37:02 INFO - PROCESS | 16211 | 03:37:02 INFO - PROCESS | 16211 | ------- Summary: start ------- 03:37:02 INFO - PROCESS | 16211 | Number of tests: 6 03:37:02 INFO - PROCESS | 16211 | 03:37:02 INFO - PROCESS | 16211 | [#0] dojo.html Cycles:165 Average:4747.91 Median:4905.04 stddev:609.65 (12.4%) stddev-sans-first:587.78 03:37:02 INFO - PROCESS | 16211 | Values: 2600.1 2672.3 2680.3 2693.4 2694.2 4792.5 4812.8 4831.6 4884.8 4928.5 4597.1 4814.0 4825.5 4850.3 4854.9 4413.9 4457.2 4560.7 4581.5 4612.4 583.5 4110.1 4264.7 4358.1 4391.3 4368.5 4400.2 4404.0 4415.7 4443.8 4415.0 4415.6 4426.0 4438.2 4460.4 4388.0 4417.8 4451.6 4457.2 4462.4 4815.4 4860.1 4861.8 4866.1 4874.3 4907.6 5118.7 5138.8 5156.3 5173.8 5226.1 5232.2 5258.0 5263.9 5315.9 4870.5 4899.3 4901.8 4908.6 4938.5 5039.8 5266.9 5318.7 5359.9 5370.1 5097.5 5107.3 5115.5 5118.2 5159.3 5209.6 5214.3 5214.6 5223.8 5264.3 4913.5 4990.7 5031.5 5042.9 5150.8 5026.5 5029.5 5052.6 5063.4 5074.1 4322.9 4323.1 4333.0 4337.6 4393.3 3687.5 3723.5 3820.4 3822.3 3847.9 4432.7 4444.7 4451.2 4480.0 4546.6 5246.3 5252.8 5258.5 5260.3 5275.4 4273.6 4386.4 4413.1 4429.9 4533.5 4600.6 4619.9 4626.5 4627.9 4669.3 4791.2 4824.3 4833.2 4837.0 4878.0 5045.1 5165.0 5184.0 5207.0 5237.9 4868.3 4879.5 4880.5 4895.5 4945.9 4876.4 5137.7 5139.0 5144.8 5145.4 5159.1 5201.6 5204.6 5209.8 5223.7 5063.4 5071.1 5073.8 5089.7 5111.3 4803.4 4962.1 5077.4 5079.3 5089.2 4905.0 4936.1 4985.1 4990.0 5031.8 5078.7 5080.9 5096.1 5105.4 5137.2 4975.7 4985.9 4990.8 5027.0 5030.6 03:37:02 INFO - PROCESS | 16211 | 03:37:02 INFO - PROCESS | 16211 | [#1] ext.html Cycles:180 Average:46711.97 Median:36889.63 stddev:86453.46 (234.4%) stddev-sans-first:86626.47 03:37:02 INFO - PROCESS | 16211 | Values: 534.6 583.8 586.6 595.0 607.4 35281.1 39627.8 39864.8 39909.0 39924.4 39328.6 39793.0 39941.8 40043.2 40199.2 7742.0 7874.0 7892.7 7897.5 7906.7 7650.3 7804.8 7808.8 7809.6 7844.2 7837.5 7845.3 7866.6 7902.1 7913.8 7720.5 7786.8 7857.2 7890.9 7892.3 7752.3 7802.7 7825.1 7835.7 7872.5 30424.2 38288.0 38427.0 38495.0 38739.8 2824.9 2839.0 2896.4 2902.3 2942.9 27516.9 27655.6 27948.3 28757.9 28834.9 3055.3 3167.5 3204.4 3250.9 3262.2 254738.0 256175.0 257529.0 257997.0 258134.0 32278.4 32831.0 32942.8 56518.4 57487.4 34519.0 34522.3 34543.7 34575.0 34869.5 13767.3 14024.5 14059.9 14068.3 14093.2 11530.1 11725.3 11730.2 11771.1 11790.8 7865.8 7866.4 7925.2 7952.3 7975.0 3143.4 3144.7 3162.8 3176.5 3214.4 864.0 865.9 906.6 908.9 972.3 27456.5 28569.0 28726.3 29220.9 29414.1 946.7 954.7 969.1 1010.0 1042.0 14279.3 14566.6 14753.2 14757.0 14855.6 382554.0 384297.0 387228.0 387587.0 388382.0 50499.2 50713.2 50870.5 50872.5 51085.2 1173.8 1214.7 1227.8 1236.6 1250.5 25704.4 27518.4 27687.3 27882.7 28159.4 43504.3 43534.3 43945.6 44325.8 44436.3 323374.0 326696.0 328304.0 328562.0 330378.0 25643.5 25968.7 26056.6 26105.3 26270.5 43192.6 43249.6 43450.8 43621.0 44342.0 36981.6 37003.3 37208.3 37358.0 37837.0 36752.4 36797.6 37146.6 37234.6 37412.6 35969.0 36646.6 37060.8 37273.8 37362.3 31881.7 32474.0 32976.8 33104.3 33474.0 25554.5 25613.4 25662.4 25732.9 25759.7 03:37:02 INFO - PROCESS | 16211 | 03:37:02 INFO - PROCESS | 16211 | [#2] jquery.html Cycles:180 Average:23835.45 Median:27298.88 stddev:64873.20 (237.6%) stddev-sans-first:65031.20 03:37:02 INFO - PROCESS | 16211 | Values: 342.0 356.8 357.3 360.5 372.0 15800.0 16601.0 17525.4 17586.0 17606.6 15788.9 16032.4 16640.3 16808.7 16842.3 4817.5 4990.7 5015.7 5021.1 5021.3 3111.5 4954.3 5661.3 5942.9 5945.8 5988.9 6004.2 6006.2 6009.4 6013.8 5864.9 5949.5 5984.1 5990.3 5990.7 4580.4 5120.4 5138.1 5148.5 5186.2 11975.3 12212.4 12309.5 12317.6 12354.4 1852.5 1870.8 1922.6 1938.5 1947.7 8283.8 8470.2 8756.1 8820.1 8838.8 1594.2 1626.9 1648.5 1657.9 1688.7 63328.0 67042.3 67182.3 69121.0 69236.3 9845.7 9879.8 10004.6 10014.5 10183.6 13504.3 13587.7 13614.6 13620.0 13657.0 7428.1 7458.0 7546.8 7664.3 7744.3 7438.1 7495.6 7580.6 7693.7 7721.8 4225.7 4231.8 4257.1 4331.9 4414.5 1636.3 1693.6 1768.4 1813.6 1838.0 798.4 836.5 850.2 933.2 940.4 16585.5 16759.7 16767.2 16967.8 17193.6 874.8 879.6 882.1 893.1 956.0 9306.9 9441.4 9583.0 9670.3 9768.9 385572.0 389353.0 392682.0 394429.0 406941.0 47019.0 75136.2 75720.6 76126.6 78759.0 834.1 895.1 913.3 936.0 939.0 15052.2 15133.8 15159.2 15185.0 15370.4 35326.0 35569.5 35797.3 35916.0 36860.8 48931.0 49233.8 49485.0 49643.5 49817.5 7459.2 7557.5 7724.2 7748.8 8037.4 11624.2 11837.3 11883.1 11930.3 12276.5 9750.2 9792.6 9829.1 9898.7 10144.7 10364.6 10458.5 10611.6 10653.6 10747.8 6920.5 10023.1 10025.7 10065.8 10097.7 7410.1 7422.4 7528.8 7667.7 7893.5 9409.8 9785.1 9818.0 9994.3 9994.9 03:37:02 INFO - PROCESS | 16211 | 03:37:02 INFO - PROCESS | 16211 | [#3] mootools.html Cycles:180 Average:5018.07 Median:4854.85 stddev:2857.36 (58.9%) stddev-sans-first:2851.56 03:37:02 INFO - PROCESS | 16211 | Values: 1279.2 1336.8 1366.2 1555.7 1563.9 6606.4 7410.4 7454.5 7821.8 7978.3 7607.2 7792.4 7805.1 7847.3 7852.1 2207.3 2214.1 2227.8 2231.9 2233.0 2119.7 2160.8 2163.6 2182.3 2183.9 2167.0 2168.9 2171.1 2172.2 2202.8 2069.2 2081.4 2081.9 2091.5 2102.9 2068.2 2097.7 2098.3 2103.1 2125.1 7912.6 7914.7 7930.6 7966.7 7980.0 4435.4 4518.4 4557.8 4565.2 4567.0 2838.2 2895.9 2953.8 2983.3 2995.0 900.2 914.6 920.8 927.2 931.5 10524.3 10534.6 10544.1 10678.8 10690.6 4085.5 4169.2 4217.3 4225.2 4246.0 9015.9 9085.5 9118.4 9122.7 9139.5 4668.3 4673.2 4685.9 4697.6 4718.5 3509.4 3915.4 4026.1 4155.4 4273.4 3417.9 3481.7 3528.4 3624.9 3640.2 1154.5 1178.3 1185.0 1185.9 1189.8 708.0 727.0 761.7 771.5 779.3 4811.0 4898.7 4901.9 4943.4 4989.5 392.5 395.8 402.7 402.8 420.5 3433.2 3453.5 3474.1 3492.2 3519.6 8777.7 9521.3 9532.5 9571.2 9584.0 9239.0 9392.9 9444.2 9498.9 9499.3 7215.7 7254.0 7291.6 7309.4 7341.8 4997.8 5009.6 5065.9 5107.9 5160.6 8387.0 8694.3 8696.5 8884.6 8900.2 8778.2 8957.6 8972.0 8982.8 8993.0 5652.7 6225.3 6289.3 6331.3 6543.8 7081.5 7138.5 7154.5 7158.6 7158.9 6556.2 6714.1 6721.6 6789.3 6796.5 6514.2 6563.3 6600.2 6607.5 6699.2 5874.5 5919.1 5939.1 5941.0 5964.6 4293.9 4372.1 4398.0 4398.9 4433.1 4271.5 4316.0 4335.7 4393.3 4445.1 03:37:02 INFO - PROCESS | 16211 | 03:37:02 INFO - PROCESS | 16211 | [#4] prototype.html Cycles:180 Average:4276.14 Median:4615.11 stddev:1240.82 (26.9%) stddev-sans-first:1207.59 03:37:02 INFO - PROCESS | 16211 | Values: 284.8 296.1 296.9 299.3 304.5 4955.5 5061.3 5106.0 5162.7 5180.7 5066.9 5088.1 5111.3 5111.8 5126.5 4003.2 4007.4 4024.7 4045.8 4046.5 3924.4 4003.0 4038.1 4059.9 4063.5 3964.6 3973.5 3975.4 3998.3 3999.6 3985.2 3992.2 3999.2 4008.5 4019.9 3533.5 3541.5 3548.2 3548.6 3553.6 4820.7 4992.7 5001.2 5016.8 5074.8 4579.6 4580.1 4586.6 4604.1 4608.2 5322.3 5355.3 5374.4 5412.8 5420.5 3777.6 3856.7 3860.0 3861.9 3887.5 5650.5 5665.2 5676.3 5704.5 5710.8 3912.0 3922.7 3930.5 3950.1 3961.3 3886.9 3895.5 3923.0 3992.1 4008.5 4450.9 4479.9 4493.4 4497.3 4512.5 5374.7 5375.7 5382.6 5430.2 5431.6 1266.9 1318.8 1344.2 1346.4 1346.6 848.4 866.9 871.4 871.6 873.2 4184.3 4201.7 4211.3 4227.3 4240.3 4835.3 4919.4 4932.0 4933.5 4939.9 4105.6 4175.7 4204.5 4228.2 4236.2 2522.6 2624.1 2629.3 2629.8 2635.7 4586.7 4600.5 4609.5 4642.5 4672.2 4932.0 4956.3 4978.4 4994.5 4999.7 4309.4 4565.1 4568.7 4583.0 4630.7 4844.0 4859.2 4875.5 4886.5 4911.1 4781.9 4783.4 4784.0 4795.6 4819.8 4357.2 4550.5 4579.3 4595.0 4620.7 3542.6 3546.7 3551.6 3556.9 3575.5 4854.3 4858.0 4896.0 4913.5 5280.7 5254.9 5380.3 5386.6 5390.3 5393.7 5399.8 5419.7 5419.9 5422.3 5431.6 5076.4 5239.8 5307.0 5314.5 5332.8 5337.8 5353.9 5369.3 5377.0 5408.4 5236.8 5241.2 5277.9 5283.4 5307.2 03:37:02 INFO - PROCESS | 16211 | 03:37:02 INFO - PROCESS | 16211 | [#5] yui.html Cycles:180 Average:16572.37 Median:556.47 stddev:24240.76 (4356.2%) stddev-sans-first:24278.65 03:37:02 INFO - PROCESS | 16211 | Values: 481.5 522.9 539.1 573.9 579.7 10470.7 10714.1 10805.6 10806.8 10850.3 11728.8 11730.2 11853.3 13609.6 14005.8 614.6 754.7 758.3 759.1 761.0 751.0 779.0 784.3 787.6 788.7 793.9 804.3 805.6 806.5 807.1 798.0 800.1 802.8 803.2 804.9 583.7 591.1 591.2 591.5 593.7 12173.3 12203.0 12217.1 12233.7 12252.4 11748.9 12305.9 12406.4 12762.9 12804.1 9656.3 9689.7 9914.0 10164.0 10334.6 3219.8 3235.6 3260.5 3261.3 3274.3 57492.4 59200.7 59233.0 59358.0 59788.0 8954.7 9083.7 9094.5 9151.2 9166.3 18386.4 18450.6 18509.7 18591.5 18946.1 5921.0 5929.3 6045.5 6097.5 6103.5 3398.6 3433.7 3524.2 3611.6 3735.2 2770.3 2864.3 2872.9 2876.1 2878.1 471.8 474.1 478.8 496.9 499.2 423.3 443.8 460.5 513.1 533.4 6987.2 7416.0 7681.2 7953.0 8105.7 431.9 436.8 483.2 493.8 513.2 3342.5 3470.8 3793.4 3805.5 3890.5 95464.5 97934.0 99723.5 100155.0 102491.0 62979.0 64509.4 68478.2 81265.0 88534.6 50203.7 71621.3 71815.6 73321.0 73919.0 7335.3 7539.7 7591.2 7609.2 7765.6 33947.8 36281.0 39737.4 43436.0 46191.3 58929.7 61904.7 62202.0 62525.0 62780.7 9346.2 9604.0 9644.6 10355.3 10664.7 10400.0 10623.6 10760.5 11086.5 11098.7 9813.9 9845.7 10014.3 10016.6 10276.1 10337.9 10456.7 10565.3 10811.9 10831.6 9876.6 9978.7 10010.9 10314.6 10421.3 9168.3 9186.3 9388.6 9582.2 9766.9 8816.7 8833.1 8845.0 8967.1 9151.0 03:37:02 INFO - PROCESS | 16211 | -------- Summary: end -------- 03:37:02 INFO - PROCESS | 16211 | 03:37:03 INFO - TEST-INFO | 16211: exit 0 03:37:03 INFO - TEST-OK | dromaeo_css | took 1116248ms 03:37:03 INFO - TEST-START | kraken 03:37:03 INFO - operating with platform_type : linux_ 03:37:03 INFO - Initialising browser for kraken test... 03:37:03 INFO - TEST-INFO | started process 16441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxDxRI6/profile http://localhost:37005/getInfo.html) 03:37:08 INFO - PROCESS | 16441 | __metrics Screen width/height:1600/1200 03:37:08 INFO - PROCESS | 16441 | colorDepth:24 03:37:08 INFO - PROCESS | 16441 | Browser inner width/height: 1024/697 03:37:08 INFO - PROCESS | 16441 | __metrics 03:37:08 ERROR - PROCESS | 16441 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:37:09 INFO - TEST-INFO | 16441: exit 0 03:37:09 INFO - Browser initialized. 03:37:09 INFO - Running cycle 1/1 for kraken test... 03:37:09 INFO - TEST-INFO | started process 16561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxDxRI6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:21 INFO - PROCESS | 16561 | RSS: Main: 185069568 03:37:21 INFO - PROCESS | 16561 | 03:37:24 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37005/tests/kraken/driver.html?testName=audio-beat-detection) 03:37:25 INFO - PROCESS | 16561 | RSS: Main: 189337600 03:37:25 INFO - PROCESS | 16561 | 03:37:28 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37005/tests/kraken/driver.html?testName=audio-dft) 03:37:28 INFO - PROCESS | 16561 | RSS: Main: 188841984 03:37:28 INFO - PROCESS | 16561 | 03:37:31 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37005/tests/kraken/driver.html?testName=audio-fft) 03:37:32 INFO - PROCESS | 16561 | RSS: Main: 184799232 03:37:32 INFO - PROCESS | 16561 | 03:37:34 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37005/tests/kraken/driver.html?testName=audio-oscillator) 03:37:35 INFO - PROCESS | 16561 | RSS: Main: 185565184 03:37:35 INFO - PROCESS | 16561 | 03:37:37 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:38 INFO - PROCESS | 16561 | RSS: Main: 186040320 03:37:38 INFO - PROCESS | 16561 | 03:37:41 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37005/tests/kraken/driver.html?testName=imaging-darkroom) 03:37:42 INFO - PROCESS | 16561 | RSS: Main: 185962496 03:37:42 INFO - PROCESS | 16561 | 03:37:45 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37005/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:46 INFO - PROCESS | 16561 | RSS: Main: 183541760 03:37:46 INFO - PROCESS | 16561 | 03:37:49 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37005/tests/kraken/driver.html?testName=json-parse-financial) 03:37:49 INFO - PROCESS | 16561 | RSS: Main: 184819712 03:37:49 INFO - PROCESS | 16561 | 03:37:51 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:52 INFO - PROCESS | 16561 | RSS: Main: 185155584 03:37:52 INFO - PROCESS | 16561 | 03:37:54 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37005/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:54 INFO - PROCESS | 16561 | RSS: Main: 185389056 03:37:54 INFO - PROCESS | 16561 | 03:37:57 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:57 INFO - PROCESS | 16561 | RSS: Main: 185462784 03:37:57 INFO - PROCESS | 16561 | 03:38:00 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:01 INFO - PROCESS | 16561 | RSS: Main: 185622528 03:38:01 INFO - PROCESS | 16561 | 03:38:04 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:04 INFO - PROCESS | 16561 | RSS: Main: 185569280 03:38:04 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | Cycle 1(1): loaded http://localhost:37005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37005/tests/kraken/driver.html?testName=ai-astar) 03:38:06 INFO - PROCESS | 16561 | RSS: Main: 186556416 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | __start_tp_report 03:38:06 INFO - PROCESS | 16561 | _x_x_mozilla_page_load 03:38:06 INFO - PROCESS | 16561 | _x_x_mozilla_page_load_details 03:38:06 INFO - PROCESS | 16561 | |i|pagename|runs| 03:38:06 INFO - PROCESS | 16561 | |0;ai-astar;115;107;114;114;114;115;114;113;113;116 03:38:06 INFO - PROCESS | 16561 | |1;audio-beat-detection;161;129;154;188;135;152;162;130;185;130 03:38:06 INFO - PROCESS | 16561 | |2;audio-dft;165;167;173;173;163;162;162;163;162;161 03:38:06 INFO - PROCESS | 16561 | |3;audio-fft;76;75;76;165;77;76;78;75;166;76 03:38:06 INFO - PROCESS | 16561 | |4;audio-oscillator;87;88;154;87;86;86;137;88;86;146 03:38:06 INFO - PROCESS | 16561 | |5;imaging-gaussian-blur;118;118;117;118;121;118;117;117;117;118 03:38:06 INFO - PROCESS | 16561 | |6;imaging-darkroom;149;150;147;148;148;147;147;148;148;148 03:38:06 INFO - PROCESS | 16561 | |7;imaging-desaturate;96;96;95;96;97;99;96;96;96;95 03:38:06 INFO - PROCESS | 16561 | |8;json-parse-financial;63;63;66;67;64;64;64;70;68;64 03:38:06 INFO - PROCESS | 16561 | |9;json-stringify-tinderbox;65;65;64;65;66;64;64;66;64;65 03:38:06 INFO - PROCESS | 16561 | |10;stanford-crypto-aes;85;84;84;83;85;85;86;88;108;95 03:38:06 INFO - PROCESS | 16561 | |11;stanford-crypto-ccm;145;145;136;133;137;129;139;137;148;135 03:38:06 INFO - PROCESS | 16561 | |12;stanford-crypto-pbkdf2;178;175;169;170;169;180;169;172;174;174 03:38:06 INFO - PROCESS | 16561 | |13;stanford-crypto-sha256-iterative;73;68;69;71;69;72;67;67;70;67 03:38:06 INFO - PROCESS | 16561 | __end_tp_report 03:38:06 INFO - PROCESS | 16561 | __start_cc_report 03:38:06 INFO - PROCESS | 16561 | _x_x_mozilla_cycle_collect,970 03:38:06 INFO - PROCESS | 16561 | __end_cc_report 03:38:06 INFO - PROCESS | 16561 | __startTimestamp1465555086781__endTimestamp 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | ------- Summary: start ------- 03:38:06 INFO - PROCESS | 16561 | Number of tests: 14 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.46 (2.2%) stddev-sans-first:2.55 03:38:06 INFO - PROCESS | 16561 | Values: 115.0 107.0 114.0 114.0 114.0 115.0 114.0 113.0 113.0 116.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:157.50 stddev:21.99 (14.0%) stddev-sans-first:23.11 03:38:06 INFO - PROCESS | 16561 | Values: 161.0 129.0 154.0 188.0 135.0 152.0 162.0 130.0 185.0 130.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.51 (2.7%) stddev-sans-first:4.78 03:38:06 INFO - PROCESS | 16561 | Values: 165.0 167.0 173.0 173.0 163.0 162.0 162.0 163.0 162.0 161.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:37.69 (49.6%) stddev-sans-first:39.41 03:38:06 INFO - PROCESS | 16561 | Values: 76.0 75.0 76.0 165.0 77.0 76.0 78.0 75.0 166.0 76.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:86.50 stddev:28.70 (33.2%) stddev-sans-first:29.73 03:38:06 INFO - PROCESS | 16561 | Values: 87.0 88.0 154.0 87.0 86.0 86.0 137.0 88.0 86.0 146.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.27 03:38:06 INFO - PROCESS | 16561 | Values: 118.0 118.0 117.0 118.0 121.0 118.0 117.0 117.0 117.0 118.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 03:38:06 INFO - PROCESS | 16561 | Values: 149.0 150.0 147.0 148.0 148.0 147.0 147.0 148.0 148.0 148.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 03:38:06 INFO - PROCESS | 16561 | Values: 96.0 96.0 95.0 96.0 97.0 99.0 96.0 96.0 96.0 95.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:2.36 (3.6%) stddev-sans-first:2.35 03:38:06 INFO - PROCESS | 16561 | Values: 63.0 63.0 66.0 67.0 64.0 64.0 64.0 70.0 68.0 64.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 03:38:06 INFO - PROCESS | 16561 | Values: 65.0 65.0 64.0 65.0 66.0 64.0 64.0 66.0 64.0 65.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:85.00 stddev:7.72 (9.1%) stddev-sans-first:8.09 03:38:06 INFO - PROCESS | 16561 | Values: 85.0 84.0 84.0 83.0 85.0 85.0 86.0 88.0 108.0 95.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:138.00 stddev:5.95 (4.3%) stddev-sans-first:5.81 03:38:06 INFO - PROCESS | 16561 | Values: 145.0 145.0 136.0 133.0 137.0 129.0 139.0 137.0 148.0 135.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:174.00 stddev:3.92 (2.3%) stddev-sans-first:3.71 03:38:06 INFO - PROCESS | 16561 | Values: 178.0 175.0 169.0 170.0 169.0 180.0 169.0 172.0 174.0 174.0 03:38:06 INFO - PROCESS | 16561 | 03:38:06 INFO - PROCESS | 16561 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:2.16 (3.1%) stddev-sans-first:1.83 03:38:06 INFO - PROCESS | 16561 | Values: 73.0 68.0 69.0 71.0 69.0 72.0 67.0 67.0 70.0 67.0 03:38:06 INFO - PROCESS | 16561 | -------- Summary: end -------- 03:38:06 INFO - PROCESS | 16561 | 03:38:07 INFO - TEST-INFO | 16561: exit 0 03:38:08 INFO - TEST-OK | kraken | took 64847ms 03:38:08 INFO - SUITE-END | took 1181s 03:38:08 INFO - Completed test suite (00:19:41) 03:38:08 INFO - javascript benchmark 03:38:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6217.153595981908, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.0769726747008, 2672.3319170207446, 2680.343315887608, 2693.434378780456, 2694.2321438390063, 4792.544708252714, 4812.759362031898, 4831.613470922327, 4884.78018489168, 4928.4825093365125, 4597.126545956275, 4814.0, 4825.493323201057, 4850.34520339754, 4854.927176092361, 4413.867583972478, 4457.153140903234, 4560.680752347337, 4581.541845815408, 4612.377329060584, 583.4634493084023, 4110.1163249901265, 4264.701470897038, 4358.106588149438, 4391.27543955247, 4368.453943257093, 4400.163968845909, 4403.977980110111, 4415.66882483815, 4443.777811109464, 4414.977925110386, 4415.558444155591, 4425.955740442587, 4438.223310920576, 4460.442444694413, 4388.0, 4417.779111044467, 4451.59935605797, 4457.175422546807, 4462.3975763271865, 4815.446223684251, 4860.05228980349, 4861.829835955725, 4866.051120031595, 4874.293227481995, 4907.55831975124, 5118.667286626394, 5138.794448222066, 5156.252343410185, 5173.844784656466, 5226.085435048852, 5232.241325007891, 5258.0, 5263.86840328991, 5315.867103322409, 4870.46424893265, 4899.265110233458, 4901.779419926112, 4908.631852611068, 4938.481459446778, 5039.773210205476, 5266.947330526646, 5318.73406329682, 5359.892802143935, 5370.087085195526, 5097.515736005073, 5107.33604631403, 5115.462876397999, 5118.155504341742, 5159.25190847325, 5209.609279303992, 5214.296070030573, 5214.634975551751, 5223.764930578133, 5264.263003179558, 4913.459519452857, 4990.650654454226, 5031.52200540948, 5042.949570504248, 5150.793968241228, 5026.472220416804, 5029.4719054498755, 5052.595792336604, 5063.392392912874, 5074.06129865976, 4322.891927701769, 4323.070539833888, 4332.978335108304, 4337.587929146726, 4393.275109606879, 3687.520622319081, 3723.497327860758, 3820.3505404081375, 3822.2928758179823, 3847.8653247136217, 4432.689711720213, 4444.6666500012625, 4451.1765323415275, 4480.0, 4546.61353784932, 5246.344206974129, 5252.763625636855, 5258.474152584711, 5260.289860868734, 5275.393329767126, 4273.572642735701, 4386.407834942306, 4413.095315460387, 4429.867103986886, 4533.54664533544, 4600.60894823937, 4619.930701039487, 4626.467956185014, 4627.8843028923875, 4669.2996050592, 4791.209450440708, 4824.300476430968, 4833.154198015403, 4836.951630483721, 4877.975610121997, 5045.142325804549, 5165.0, 5183.974080129575, 5206.9586082782835, 5237.947620523746, 4868.3427737255015, 4879.4876537963, 4880.536349046835, 4895.534924182197, 4945.901081978268, 4876.414830220397, 5137.691738495552, 5139.049275883974, 5144.76848541824, 5145.382554093533, 5159.09715799741, 5201.583873290052, 5204.58363330925, 5209.843704688866, 5223.660462069954, 5063.417706963746, 5071.137906555969, 5073.847784566469, 5089.694618322913, 5111.284420181252, 4803.447603525499, 4962.082014827269, 5077.39071311445, 5079.288899554139, 5089.236614507853, 4905.043516514245, 4936.111499929903, 4985.077760614298, 4990.0, 5031.84904452867, 5078.7206703631655, 5080.949190508048, 5096.108181068373, 5105.387353517602, 5137.17805151174, 4975.676581022222, 4985.850424487271, 4990.775415106402, 5027.0, 5030.62270329734], "value": 4709.260659146461, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.6046910861897, 583.7519054401878, 586.5805948746647, 595.0, 607.4290167242794, 35281.11797205071, 39627.81116566501, 39864.800675996616, 39909.0, 39924.401133982974, 39328.60671393285, 39793.0, 39941.8002909985, 40043.199136017334, 40199.19601607966, 7741.961290193542, 7873.96063019687, 7892.684292628288, 7897.526148431084, 7906.723264685737, 7650.3497202737835, 7804.843903121934, 7808.804779880492, 7809.648565814524, 7844.1763614820475, 7837.451378403514, 7845.293923546879, 7866.6460009299435, 7902.051753789553, 7913.802154946115, 7720.459567830254, 7786.80532986677, 7857.174996625329, 7890.921090789076, 7892.329152022085, 7752.26353496417, 7802.687892484294, 7825.060992680915, 7835.686572537092, 7872.488288261245, 30424.239394015105, 38288.0, 38427.0, 38495.0, 38739.806300968594, 2824.901128460494, 2838.9858050709613, 2896.362800183956, 2902.3034471726633, 2942.926426839325, 27516.862415687992, 27655.58516622232, 27948.301292467648, 28757.85621071881, 28834.855825720948, 3055.266735983348, 3167.5090360993854, 3204.3911656785135, 3250.8699652013893, 3262.217067903686, 254738.0, 256175.0, 257528.99999999814, 257996.99999999814, 258134.0, 32278.354432911212, 32830.99999999952, 32942.835285823414, 56518.43481565214, 57487.42512574905, 34519.0, 34522.30955380878, 34543.654563454045, 34575.0, 34869.476957845654, 13767.31163441824, 14024.509142179975, 14059.859401405854, 14068.296585170701, 14093.15441073539, 11530.077593792477, 11725.296482211095, 11730.237534560227, 11771.117166212569, 11790.823137652942, 7865.764027079197, 7866.410019248465, 7925.247101525346, 7952.284294413531, 7974.960125199337, 3143.3713257348622, 3144.7326977206735, 3162.810231386124, 3176.539401786728, 3214.421404147229, 863.9891327147253, 865.8787769712245, 906.6464079009191, 908.8545832666741, 972.2999440402899, 27456.45087098247, 28569.0, 28726.281842954093, 29220.853895730812, 29414.11757647274, 946.7017889364828, 954.746992047108, 969.1229437359201, 1010.0000999010927, 1041.9947900260602, 14279.286485621584, 14566.563003109924, 14753.188574628284, 14757.0, 14855.628609284639, 382554.0, 384297.0, 387228.0, 387587.0, 388382.0, 50499.24251136236, 50713.23930141051, 50870.49129508732, 50872.491275087516, 51085.23372149421, 1173.8063219568676, 1214.7266864955313, 1227.8281040654315, 1236.5919246648584, 1250.4810503641252, 25704.357391065372, 27518.449631006868, 27687.30781730473, 27882.721172788824, 28159.43681126407, 43504.34743478914, 43534.34698479462, 43945.560544394146, 44325.77837110794, 44436.33345499885, 323374.0, 326696.0, 328304.0, 328562.0, 330378.0, 25643.487130257665, 25968.740312596634, 26056.609150863133, 26105.347366315993, 26270.4745905077, 43192.56807431886, 43249.567504325816, 43450.782746086064, 43621.0, 44342.0, 36981.63018369782, 37003.25993480169, 37208.28158589091, 37358.0, 37837.0, 36752.44871326879, 36797.63202367942, 37146.6285337154, 37234.6276537242, 37412.625873740915, 35969.0, 36646.63353366539, 37060.81469592742, 37273.81363093167, 37362.25275494529, 31881.68118318787, 32474.04421339381, 32976.835115824266, 33104.33791324208, 33474.0, 25554.488910222062, 25613.3596660085, 25662.358441039123, 25732.8713356432, 25759.742402576485], "value": 16500.98560239104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.9606745224298, 356.76275276940834, 357.25155798601935, 360.5439119513817, 371.99256014879705, 15800.0, 16601.0, 17525.386611468584, 17586.032768197743, 17606.559836004108, 15788.921055394736, 16032.43886463974, 16640.33438662452, 16808.66382672346, 16842.326306947707, 4817.494163112867, 4990.6756060856105, 5015.699058056528, 5021.071101846152, 5021.27191557224, 3111.455495288327, 4954.2568614707725, 5661.348944871331, 5942.910856337158, 5945.821625351246, 5988.8502787430225, 6004.18943442634, 6006.219191505098, 6009.369016253296, 6013.789517366893, 5864.912026319608, 5949.524038076965, 5984.102384642295, 5990.311114221877, 5990.700464976734, 4580.427446569179, 5120.411152717448, 5138.075146473633, 5148.536631703128, 5186.170212765939, 11975.341356225492, 12212.389380531027, 12309.507619695201, 12317.568885088978, 12354.444050017772, 1852.4905650945964, 1870.78485974112, 1922.644310802506, 1938.4589251545056, 1947.737055497504, 8283.840262363274, 8470.195331443503, 8756.124387561193, 8820.117988201193, 8838.823223535494, 1594.234767311697, 1626.8698504119643, 1648.5384092454133, 1657.917104144788, 1688.6622675464955, 63328.0, 67042.3295767041, 67182.32817671858, 69121.0, 69236.30763692349, 9845.704628861145, 9879.80240395188, 10004.599816007423, 10014.49927503622, 10183.643572474928, 13504.324783760772, 13587.728245435035, 13614.591562253148, 13620.0, 13657.0, 7428.1086269647985, 7457.962710186414, 7546.773596792105, 7664.31021208094, 7744.303012728881, 7438.070241219848, 7495.550266983998, 7580.649998500482, 7693.6537855795505, 7721.806954826175, 4225.683073769418, 4231.788410579458, 4257.084726783694, 4331.935020974688, 4414.514403415622, 1636.2882146266413, 1693.635868288324, 1768.3545505890515, 1813.5919418130816, 1837.9540511487319, 798.3972101063775, 836.4981011393237, 850.2093053460342, 933.169479163545, 940.3699521320732, 16585.50243492697, 16759.664806703797, 16767.161641917854, 16967.83032169687, 17193.570160745832, 874.7550685807984, 879.560219890055, 882.0694167653188, 893.1113542025596, 956.0248546482549, 9306.90693093074, 9441.386309889973, 9582.952085239529, 9670.274729395323, 9768.853467197998, 385572.0, 389353.0, 392682.0, 394429.0, 406941.0, 47019.0, 75136.24863751401, 75720.62139689266, 76126.61936690281, 78759.0, 834.1116710703203, 895.0825403960993, 913.2785099771239, 935.9672411465566, 938.9671361502315, 15052.247387630794, 15133.848661513244, 15159.242037898282, 15184.950031745573, 15370.385184592938, 35326.0, 35569.46645800367, 35797.28405431825, 35916.0, 36860.81569592135, 48931.0, 49233.75383123061, 49485.0, 49643.50356496534, 49817.50182498273, 7459.179490256176, 7557.470977031555, 7724.227577242231, 7748.806279842824, 8037.437379383387, 11624.244424112405, 11837.289762614271, 11883.108766842694, 11930.343831089373, 12276.508939642672, 9750.21998240125, 9792.606582030521, 9829.115379615869, 9898.703038908845, 10144.695659130239, 10364.637237696645, 10458.47707614601, 10611.575536978435, 10653.57385704563, 10747.785044298915, 6920.515563910478, 10023.148032417326, 10025.699229023141, 10065.849012264676, 10097.747556310856, 7410.073740782403, 7422.406207503279, 7528.8494230116185, 7667.731629392944, 7893.486923349964, 9409.811803763749, 9785.119339259501, 9818.0, 9994.250431217542, 9994.850077248702], "value": 8012.665006444826, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.24524530527, 1336.7527007503613, 1366.2349084512673, 1555.7121932442492, 1563.8748900087994, 6606.438452731523, 7410.444216683743, 7454.478186526939, 7821.843563128741, 7978.28195462409, 7607.23927607239, 7792.376609871211, 7805.141434442221, 7847.254510821463, 7852.136265010844, 2207.3267653365715, 2214.0811563201332, 2227.8329125315586, 2231.9107235710553, 2232.966505502419, 2119.73503312086, 2160.794724501178, 2163.556470923465, 2182.34529641107, 2183.901724422397, 2166.967495487569, 2168.902399392031, 2171.0664414301846, 2172.2397160993683, 2202.8458007939453, 2069.224040984631, 2081.3651836189956, 2081.875087494755, 2091.5294058836794, 2102.873827570351, 2068.152057656369, 2097.7272954515815, 2098.2551194325947, 2103.05362586835, 2125.1180759984586, 7912.604369781546, 7914.722984695565, 7930.563818989954, 7966.721164759264, 7980.0, 4435.379046933432, 4518.412606361185, 4557.817687292504, 4565.155446242423, 4567.0, 2838.247864315958, 2895.942081158386, 2953.763698904104, 2983.298924752703, 2994.9850250748823, 900.2482926756167, 914.6158613382395, 920.7513971227798, 927.248928368024, 931.4923366765129, 10524.31591946521, 10534.631287904964, 10544.103751181083, 10678.839817402744, 10690.625828096057, 4085.530164031115, 4169.207850508394, 4217.283061879488, 4225.154969006211, 4245.957540424618, 9015.909840901639, 9085.500297483703, 9118.361714679908, 9122.726318210463, 9139.451632902048, 4668.253079507263, 4673.205555055649, 4685.8594242172785, 4697.600703940135, 4718.4809670936165, 3509.3507701074873, 3915.353966595537, 4026.1343811080174, 4155.397467367215, 4273.423087883159, 3417.863285468603, 3481.7040551552896, 3528.3648943190474, 3624.9456258156147, 3640.21735326906, 1154.549725607014, 1178.3342411537453, 1184.9703757405962, 1185.8576970763563, 1189.79178643737, 707.9787606371817, 726.989095163573, 761.6572542355962, 771.4792515052317, 779.3453499060817, 4811.0, 4898.706077635354, 4901.877453063631, 4943.382077240345, 4989.476105008995, 392.4642862492677, 395.7862754112804, 402.67986950374524, 402.76840816530614, 420.49960546949035, 3433.210361616842, 3453.533772940621, 3474.0967348489576, 3492.161881148506, 3519.595246546629, 8777.692780752643, 9521.333506654606, 9532.52337383128, 9571.18644915176, 9584.0415958405, 9238.95380523093, 9392.8591071134, 9444.244460443148, 9498.905010949802, 9499.335046546814, 7215.67529461165, 7253.9999999998945, 7291.598962057138, 7309.415246780245, 7341.77974660761, 4997.750112494434, 5009.624278179224, 5065.949340506548, 5107.87230319245, 5160.587153027674, 8387.0, 8694.34792390586, 8696.521691306785, 8884.60019299146, 8900.198982091642, 8778.244351129928, 8957.552122393723, 8971.955140224258, 8982.820343593223, 8993.010768815557, 5652.717364131695, 6225.284092329259, 6289.27673317556, 6331.3352098029045, 6543.770968016097, 7081.46888983318, 7138.46461515378, 7154.499185056996, 7158.606276654834, 7158.856822863409, 6556.246031706415, 6714.060031595678, 6721.630310332978, 6789.321067893171, 6796.490263230178, 6514.218293804774, 6563.310852360624, 6600.207975043026, 6607.537472376887, 6699.162604674416, 5874.471297583238, 5919.082542205965, 5939.07944268639, 5941.0197317442135, 5964.5526585505395, 4293.91412171761, 4372.125574885099, 4397.978010109929, 4398.912021759611, 4433.113377324484, 4271.508776490619, 4316.0, 4335.739855608674, 4393.275109606879, 4445.133199026288], "value": 3961.91406347369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.84903001409236, 296.09100062807175, 296.9376430949501, 299.2951598984392, 304.48845938822797, 4955.4548999610015, 5061.291419201306, 5105.974470127653, 5162.664426812259, 5180.653030212144, 5066.923996140061, 5088.135017047101, 5111.258867464216, 5111.846644600668, 5126.512981266783, 4003.159336539323, 4007.418924255981, 4024.678025757947, 4045.8152597597264, 4046.4739583854057, 3924.352481840507, 4002.959970400288, 4038.1116154445976, 4059.939100913489, 4063.5326937402133, 3964.6233607807358, 3973.5033120859894, 3975.383815508601, 3998.340688614236, 3999.6200360965663, 3985.202959408101, 3992.161646054332, 3999.1601763629383, 4008.4588580541545, 4019.919601607981, 3533.522974398449, 3541.4687796830426, 3548.2193917338145, 3548.6273941236313, 3553.573571171476, 4820.71075735457, 4992.650514463989, 5001.199808030734, 5016.849494515171, 5074.797008119671, 4579.564941330568, 4580.129775342674, 4586.555235100933, 4604.132528675928, 4608.193566125948, 5322.281491998569, 5355.2770375999135, 5374.381946076212, 5412.756425960842, 5420.457954204588, 3777.58446570877, 3856.710746693981, 3860.0, 3861.903452413684, 3887.4946256986696, 5650.491455769042, 5665.206871038058, 5676.2620859288445, 5704.543636509069, 5710.77156913723, 3912.0439780109946, 3922.666573341298, 3930.5283365996265, 3950.111224974358, 3961.3463778476803, 3886.9222615547533, 3895.475079242258, 3922.9607703922597, 3992.1416895367634, 4008.478897743333, 4450.866474005785, 4479.865604031885, 4493.370928070073, 4497.302918047708, 4512.503624601291, 5374.70439125844, 5375.650582712111, 5382.569394448435, 5430.239766432703, 5431.592630552725, 1266.8859802617808, 1318.8351456067992, 1344.1733333999716, 1346.414309775251, 1346.5758286139835, 848.3764433141636, 866.8613021916589, 871.4030888841037, 871.6295574380863, 873.1879352202512, 4184.28867092595, 4201.747895126302, 4211.284081706117, 4227.3447615619625, 4240.300350442142, 4835.274708793709, 4919.434265059493, 4931.950680493221, 4933.531314525115, 4939.87650308738, 4105.609967053125, 4175.749455032707, 4204.495460544693, 4228.154369126126, 4236.152769446123, 2522.621606758964, 2624.1499742681362, 2629.3426643339167, 2629.7501737334924, 2635.6968948570775, 4586.701864378805, 4600.470945841204, 4609.53904609543, 4642.489326174118, 4672.229082201467, 4932.013597280558, 4956.265307142471, 4978.352814134212, 4994.502748625687, 4999.650024498323, 4309.353596960481, 4565.128297398051, 4568.680192386568, 4582.95417045832, 4630.699004564693, 4844.0, 4859.246816743411, 4875.488073752205, 4886.511348865085, 4911.109222949119, 4781.856544303677, 4783.378160839069, 4783.976080119577, 4795.640326975421, 4819.795051237191, 4357.172137293904, 4550.522195169459, 4579.290210017452, 4594.954050459452, 4620.676552641283, 3542.636085107201, 3546.7231796552705, 3551.5915669697283, 3556.9466458002635, 3575.481555174433, 4854.320395144612, 4858.004109157543, 4895.951040489692, 4913.48408417111, 5280.656757310762, 5254.947450525446, 5380.273663055437, 5386.599484134075, 5390.27231323782, 5393.7033463159905, 5399.787126659631, 5419.729013549228, 5419.888922770744, 5422.267993820784, 5431.56547476193, 5076.416212135504, 5239.816606418757, 5306.991671582387, 5314.46588018963, 5332.813351532678, 5337.786488540415, 5353.946460535345, 5369.301990741179, 5376.973115134399, 5408.37803652585, 5236.790528378974, 5241.187615919539, 5277.894442111213, 5283.418823929288, 5307.150855863043], "value": 3878.5885226980117, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.46316856704783, 522.898034883198, 539.0593414491711, 573.8708790522134, 579.672485045949, 10470.68587942362, 10714.142868570516, 10805.621803236878, 10806.78386432271, 10850.348979061262, 11728.82406763897, 11730.237534560247, 11853.348065856375, 13609.591712248624, 14005.789913151311, 614.6220074654078, 754.6717178027549, 758.321302434321, 759.1194214710937, 760.9954859585349, 751.0499218488588, 778.9922100779005, 784.2862994674847, 787.5904529644581, 788.7476007677517, 793.9166387529312, 804.2600807257337, 805.5730462854697, 806.4596720197452, 807.0718673525434, 797.972070977513, 800.0679208721832, 802.83541873916, 803.2449497472358, 804.891339669146, 583.6789765628887, 591.066115537454, 591.2077815726947, 591.4558606082414, 593.7001814083903, 12173.330466824322, 12203.02375809933, 12217.144799864012, 12233.69415764613, 12252.387380630933, 11748.941255293754, 12305.876941230563, 12406.379681015913, 12762.872371276262, 12804.103712740112, 9656.324057315991, 9689.660861869872, 9914.0, 10163.996379946475, 10334.638287659971, 3219.7746157768966, 3235.627902791162, 3260.4620237660756, 3261.266215101607, 3274.3287626036604, 57492.425075749125, 59200.70399648017, 59233.0, 59358.032098394906, 59788.0, 8954.686585969459, 9083.727488175366, 9094.454332740057, 9151.222146117521, 9166.26669866409, 18386.35647752349, 18450.630987380177, 18509.7223541647, 18591.53521161982, 18946.147423365983, 5920.970395147997, 5929.347771745104, 6045.516358691294, 6097.451229389376, 6103.511719062464, 3398.6431424700545, 3433.7081348085194, 3524.242287908112, 3611.602723700391, 3735.215604722984, 2770.279727270884, 2864.3412015236195, 2872.8850845966344, 2876.1227825513, 2878.107786586165, 471.7570451217626, 474.103943546697, 478.84437557793854, 496.9403671559436, 499.16888380845484, 423.3184572837729, 443.84909130895653, 460.4589607211513, 513.0739016075944, 533.3652952985934, 6987.161540615057, 7416.0, 7681.193474685189, 7953.0, 8105.6757729691335, 431.86612150233526, 436.7794263896712, 483.20512756516035, 493.81730754841954, 513.2250302043866, 3342.4986252062386, 3470.843812028414, 3793.374093274634, 3805.46723458716, 3890.533136023695, 95464.52267738617, 97934.0, 99723.50138249407, 100155.0, 102491.0, 62979.0, 64509.35490645127, 68478.22290524213, 81265.0, 88534.55732721295, 50203.748981255594, 71621.28378716251, 71815.6409217961, 73321.0, 73919.0, 7335.303146201102, 7539.73610923637, 7591.240875912365, 7609.2010338913615, 7765.572893490912, 33947.83026084854, 36281.0, 39737.40393894036, 43436.0, 46191.30713039375, 58929.70535147468, 61904.69047654733, 62202.0, 62525.0, 62780.686096569225, 9346.20557252641, 9603.951980240334, 9644.614215431584, 10355.326903751233, 10664.740604219134, 10400.0, 10623.575056997943, 10760.515776789907, 11086.501107450345, 11098.667039988813, 9813.852792208265, 9845.65540206118, 10014.298999069995, 10016.599336026477, 10276.075153236245, 10337.896621033995, 10456.68629941103, 10565.313254638424, 10811.891881081088, 10831.566737330419, 9876.555554999899, 9978.700638980843, 10010.949945250228, 10314.638987635397, 10421.322614030063, 9168.31237657165, 9186.265098791948, 9388.624455021996, 9582.185514231089, 9766.9023309766, 8816.691415800417, 8833.07252738479, 8844.955775221082, 8967.103289671242, 9151.0], "value": 6035.094403797566, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 113.0, 116.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 129.0, 154.0, 188.0, 135.0, 152.0, 162.0, 130.0, 185.0, 130.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 173.0, 173.0, 163.0, 162.0, 162.0, 163.0, 162.0, 161.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 165.0, 77.0, 76.0, 78.0, 75.0, 166.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 154.0, 87.0, 86.0, 86.0, 137.0, 88.0, 86.0, 146.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 121.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 99.0, 96.0, 96.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 66.0, 67.0, 64.0, 64.0, 64.0, 70.0, 68.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 66.0, 64.0, 64.0, 66.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 83.0, 85.0, 85.0, 86.0, 88.0, 108.0, 95.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 136.0, 133.0, 137.0, 129.0, 139.0, 137.0, 148.0, 135.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 169.0, 170.0, 169.0, 180.0, 169.0, 172.0, 174.0, 174.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 69.0, 71.0, 69.0, 72.0, 67.0, 67.0, 70.0, 67.0], "value": 69.3, "unit": "score"}]}]} 03:38:08 INFO - Return code: 0 03:38:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:08 ERROR - # TBPL SUCCESS # 03:38:08 INFO - Running post-action listener: _resource_record_post_action 03:38:08 INFO - ##### 03:38:08 INFO - ##### Finished run-tests step (success) 03:38:08 INFO - ##### 03:38:08 INFO - Running post-run listener: _resource_record_post_run 03:38:08 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 542449664; Read time: 16; Write time: 616648 03:38:08 INFO - TinderboxPrint: CPU usage
13.5% 03:38:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:38:08 INFO - TinderboxPrint: I/O write bytes / time
542,449,664 / 616,648 03:38:08 INFO - TinderboxPrint: CPU idle
8,267.8 (86.4%) 03:38:08 INFO - TinderboxPrint: CPU user
1,240.1 (13.0%) 03:38:08 INFO - TinderboxPrint: Swap in / out
0 / 0 03:38:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249446400; Read time: 0; Write time: 304052 03:38:08 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 4096; Write bytes: 293003264; Read time: 16; Write time: 312596 03:38:09 INFO - Running post-run listener: _upload_blobber_files 03:38:09 INFO - Blob upload gear active. 03:38:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:09 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 03:38:09 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'] 03:38:09 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 03:38:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:10 INFO - (blobuploader) - INFO - Done attempting. 03:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:38:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:14 INFO - (blobuploader) - INFO - Done attempting. 03:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:15 INFO - (blobuploader) - INFO - Done attempting. 03:38:15 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:15 INFO - Return code: 0 03:38:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/688b0d53932f993821ec624b1f58034d94887894d7e18f271698e25e05cd6df5b236fae5cfb1e39cc7d834c4c3a6a3d10182b2dfc303376fe806588a8afa2da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19e76921cb2889c3e12d44fa7f2f7e2881dfd89eca05a3fcec495b1c44015a3a0e3df5ae13ddc596a3616a1b11eae3e25cdb3f99e2b6c8fe8aac10a7afe4505e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7360699efe0909a2f1b342498bddf508e05a57a02412779e8ea066a2f35154732742422a0acc5669fe12b1e5e40e9c0699bf7a3e97fee7b24246ca8c3d91ff78"} 03:38:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:15 INFO - Contents: 03:38:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/688b0d53932f993821ec624b1f58034d94887894d7e18f271698e25e05cd6df5b236fae5cfb1e39cc7d834c4c3a6a3d10182b2dfc303376fe806588a8afa2da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19e76921cb2889c3e12d44fa7f2f7e2881dfd89eca05a3fcec495b1c44015a3a0e3df5ae13ddc596a3616a1b11eae3e25cdb3f99e2b6c8fe8aac10a7afe4505e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7360699efe0909a2f1b342498bddf508e05a57a02412779e8ea066a2f35154732742422a0acc5669fe12b1e5e40e9c0699bf7a3e97fee7b24246ca8c3d91ff78"} 03:38:15 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:15 INFO - Copying logs to upload dir... 03:38:15 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.153403 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-10 03:38:15.264202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 03:38:15.267762) ========= 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=db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095 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/688b0d53932f993821ec624b1f58034d94887894d7e18f271698e25e05cd6df5b236fae5cfb1e39cc7d834c4c3a6a3d10182b2dfc303376fe806588a8afa2da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19e76921cb2889c3e12d44fa7f2f7e2881dfd89eca05a3fcec495b1c44015a3a0e3df5ae13ddc596a3616a1b11eae3e25cdb3f99e2b6c8fe8aac10a7afe4505e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7360699efe0909a2f1b342498bddf508e05a57a02412779e8ea066a2f35154732742422a0acc5669fe12b1e5e40e9c0699bf7a3e97fee7b24246ca8c3d91ff78"} build_url:https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011135 build_url: 'https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/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/688b0d53932f993821ec624b1f58034d94887894d7e18f271698e25e05cd6df5b236fae5cfb1e39cc7d834c4c3a6a3d10182b2dfc303376fe806588a8afa2da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19e76921cb2889c3e12d44fa7f2f7e2881dfd89eca05a3fcec495b1c44015a3a0e3df5ae13ddc596a3616a1b11eae3e25cdb3f99e2b6c8fe8aac10a7afe4505e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7360699efe0909a2f1b342498bddf508e05a57a02412779e8ea066a2f35154732742422a0acc5669fe12b1e5e40e9c0699bf7a3e97fee7b24246ca8c3d91ff78"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 03:38:15.295861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:38:15.296194) ========= 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=db0483c52d987ecb441a263b000001ad-1465553840.655637-63984095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:38:15.382368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 03:38:15.382686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 03:38:15.382989) ========= ========= Total master_lag: 0.19 =========