builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1465450578.14 results: success (0) buildid: 20160608214828 builduid: 7c9b023abf614c76872405037ea2aff1 revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:18.140912) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:18.141709) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:18.142098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:18.196642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:18.197329) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 22:36:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-08 22:36:18 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127718 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:18.344352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:18.344725) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020922 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:18.394376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:18.394774) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8bdceb55c9d191380176ab25e2385737bd9e1ab --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 f8bdceb55c9d191380176ab25e2385737bd9e1ab --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 22:36:18,758 truncating revision to first 12 chars 2016-06-08 22:36:18,758 Setting DEBUG logging. 2016-06-08 22:36:18,759 attempt 1/10 2016-06-08 22:36:18,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8bdceb55c9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 22:36:19,073 unpacking tar archive at: fx-team-f8bdceb55c9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664216 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:19.079128) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:19.079443) ========= script_repo_revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:19.079895) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:19.080192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 22:36:19.091515) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-08 22:36:19.091812) ========= /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=0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:36:19 INFO - MultiFileLogger online at 20160608 22:36:19 in /builds/slave/test 22:36:19 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 22:36:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:36:19 INFO - {'append_to_log': False, 22:36:19 INFO - 'base_work_dir': '/builds/slave/test', 22:36:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:36:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:36:19 INFO - 'branch': 'Fx-Team-Non-PGO', 22:36:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:36:19 INFO - 'config_files': ('talos/linux_config.py',), 22:36:19 INFO - 'default_actions': ('clobber', 22:36:19 INFO - 'read-buildbot-config', 22:36:19 INFO - 'download-and-extract', 22:36:19 INFO - 'populate-webroot', 22:36:19 INFO - 'create-virtualenv', 22:36:19 INFO - 'install', 22:36:19 INFO - 'run-tests'), 22:36:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:36:19 INFO - 'download_minidump_stackwalk': True, 22:36:19 INFO - 'download_symbols': 'ondemand', 22:36:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:36:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:36:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:36:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:36:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:36:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:36:19 INFO - 'installer_path': 'installer.exe', 22:36:19 INFO - 'log_level': 'info', 22:36:19 INFO - 'log_name': 'talos', 22:36:19 INFO - 'log_to_console': True, 22:36:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:36:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:36:19 INFO - 'opt_config_files': (), 22:36:19 INFO - 'pip_index': False, 22:36:19 INFO - 'sps_profile': False, 22:36:19 INFO - 'sps_profile_interval': 0, 22:36:19 INFO - 'suite': 'dromaeojs-e10s', 22:36:19 INFO - 'system_bits': '32', 22:36:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:36:19 INFO - 'title': 'talos-linux64-ix-058', 22:36:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:36:19 INFO - 'use_talos_json': True, 22:36:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:36:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:36:19 INFO - 'work_dir': 'build'} 22:36:19 INFO - ##### 22:36:19 INFO - ##### Running clobber step. 22:36:19 INFO - ##### 22:36:19 INFO - Running pre-action listener: _resource_record_pre_action 22:36:19 INFO - Running main action method: clobber 22:36:19 INFO - rmtree: /builds/slave/test/build 22:36:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:36:20 INFO - Running post-action listener: _resource_record_post_action 22:36:20 INFO - ##### 22:36:20 INFO - ##### Finished clobber step (success) 22:36:20 INFO - ##### 22:36:20 INFO - ##### 22:36:20 INFO - ##### Running read-buildbot-config step. 22:36:20 INFO - ##### 22:36:20 INFO - Running pre-action listener: _resource_record_pre_action 22:36:20 INFO - Running main action method: read_buildbot_config 22:36:20 INFO - Using buildbot properties: 22:36:20 INFO - { 22:36:20 INFO - "project": "", 22:36:20 INFO - "product": "firefox", 22:36:20 INFO - "script_repo_revision": "production", 22:36:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:36:20 INFO - "repository": "", 22:36:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:36:20 INFO - "buildid": "20160608214828", 22:36:20 INFO - "pgo_build": "False", 22:36:20 INFO - "basedir": "/builds/slave/test", 22:36:20 INFO - "buildnumber": 1574, 22:36:20 INFO - "slavename": "talos-linux64-ix-058", 22:36:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:36:20 INFO - "platform": "ubuntu64_hw", 22:36:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:36:20 INFO - "branch": "fx-team", 22:36:20 INFO - "repo_path": "integration/fx-team", 22:36:20 INFO - "revision": "f8bdceb55c9d191380176ab25e2385737bd9e1ab", 22:36:20 INFO - "stage_platform": "linux64", 22:36:20 INFO - "builduid": "7c9b023abf614c76872405037ea2aff1", 22:36:20 INFO - "slavebuilddir": "test" 22:36:20 INFO - } 22:36:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:36:20 INFO - Running post-action listener: _resource_record_post_action 22:36:20 INFO - ##### 22:36:20 INFO - ##### Finished read-buildbot-config step (success) 22:36:20 INFO - ##### 22:36:20 INFO - ##### 22:36:20 INFO - ##### Running download-and-extract step. 22:36:20 INFO - ##### 22:36:20 INFO - Running pre-action listener: _resource_record_pre_action 22:36:20 INFO - Running main action method: download_and_extract 22:36:20 INFO - mkdir: /builds/slave/test/build/tests 22:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:20 INFO - https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:36:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:36:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:36:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:24 INFO - Downloaded 1361 bytes. 22:36:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:36:24 INFO - Using the following test package requirements: 22:36:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:36:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:36:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:36:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:24 INFO - u'jsshell-linux-x86_64.zip'], 22:36:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:36:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:36:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:36:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:36:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:36:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:36:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:36:24 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')]} 22:36:24 INFO - https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:36:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:36:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:36:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:25 INFO - Downloaded 22879062 bytes. 22:36:25 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'] 22:36:25 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 22:36:26 INFO - Return code: 0 22:36:26 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 22:36:26 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')]} 22:36:26 INFO - https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:36:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:36:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:36:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:28 INFO - Downloaded 22879062 bytes. 22:36:28 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'] 22:36:28 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 22:36:29 INFO - Return code: 0 22:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:29 INFO - https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:36:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:36:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:36:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:30 INFO - Downloaded 10833369 bytes. 22:36:30 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'] 22:36:30 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 22:36:30 INFO - Return code: 0 22:36: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')]} 22:36:30 INFO - https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:36:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:36:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:36:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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 22:36:32 INFO - Downloaded 55336673 bytes. 22:36:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:36:32 INFO - mkdir: /builds/slave/test/properties 22:36:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:36:32 INFO - Writing to file /builds/slave/test/properties/build_url 22:36:32 INFO - Contents: 22:36:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:36:32 INFO - Running post-action listener: _resource_record_post_action 22:36:32 INFO - Running post-action listener: set_extra_try_arguments 22:36:32 INFO - ##### 22:36:32 INFO - ##### Finished download-and-extract step (success) 22:36:32 INFO - ##### 22:36:32 INFO - ##### 22:36:32 INFO - ##### Running populate-webroot step. 22:36:32 INFO - ##### 22:36:32 INFO - Running pre-action listener: _resource_record_pre_action 22:36:32 INFO - Running main action method: populate_webroot 22:36:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:36:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:36:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:36:32 INFO - '--tppagecycles', 22:36:32 INFO - '7'], 22:36:32 INFO - 'tests': ['tsvgm']}}, 22:36:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:36:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:36:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:36:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:36:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:32 INFO - 'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:36:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:36:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:32 INFO - 'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['damp', 'tps']}, 22:36:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:32 INFO - 'tests': ['damp', 'tps']}, 22:36:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['dromaeo_dom']}, 22:36:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:36:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['a11yr', 22:36:32 INFO - 'ts_paint', 22:36:32 INFO - 'tpaint', 22:36:32 INFO - 'sessionrestore', 22:36:32 INFO - 'sessionrestore_no_auto_restore', 22:36:32 INFO - 'tabpaint']}, 22:36:32 INFO - 'other-e10s': {'tests': ['a11yr', 22:36:32 INFO - 'ts_paint', 22:36:32 INFO - 'tpaint', 22:36:32 INFO - 'sessionrestore', 22:36:32 INFO - 'sessionrestore_no_auto_restore', 22:36:32 INFO - 'tabpaint']}, 22:36:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:36:32 INFO - 'ts_paint', 22:36:32 INFO - 'tpaint', 22:36:32 INFO - 'sessionrestore', 22:36:32 INFO - 'sessionrestore_no_auto_restore', 22:36:32 INFO - 'tabpaint']}, 22:36:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:36:32 INFO - 'ts_paint', 22:36:32 INFO - 'tpaint', 22:36:32 INFO - 'sessionrestore', 22:36:32 INFO - 'sessionrestore_no_auto_restore', 22:36:32 INFO - 'tabpaint']}, 22:36:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['a11yr', 22:36:32 INFO - 'ts_paint', 22:36:32 INFO - 'tpaint', 22:36:32 INFO - 'sessionrestore', 22:36:32 INFO - 'sessionrestore_no_auto_restore', 22:36:32 INFO - 'tabpaint']}, 22:36:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['a11yr', 22:36:32 INFO - 'ts_paint', 22:36:32 INFO - 'tpaint', 22:36:32 INFO - 'sessionrestore', 22:36:32 INFO - 'sessionrestore_no_auto_restore', 22:36:32 INFO - 'tabpaint']}, 22:36:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['tsvgx', 22:36:32 INFO - 'tsvgr_opacity', 22:36:32 INFO - 'tart', 22:36:32 INFO - 'tscrollx', 22:36:32 INFO - 'cart']}, 22:36:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:36:32 INFO - 'tsvgr_opacity', 22:36:32 INFO - 'tart', 22:36:32 INFO - 'tscrollx', 22:36:32 INFO - 'cart']}, 22:36:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:32 INFO - 'talos_options': ['--disable-e10s'], 22:36:32 INFO - 'tests': ['tp5o']}, 22:36:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:32 INFO - 'tests': ['tp5o']}, 22:36:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:32 INFO - 'talos_options': ['--disable-e10s', 22:36:32 INFO - '--xperf_path', 22:36:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:36:32 INFO - 'tests': ['tp5n']}, 22:36:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:36:32 INFO - 'talos_options': ['--xperf_path', 22:36:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:36:32 INFO - 'tests': ['tp5n']}}, 22:36:32 INFO - 'talos.zip': {'path': '', 22:36:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:36:32 INFO - Running post-action listener: _resource_record_post_action 22:36:32 INFO - ##### 22:36:32 INFO - ##### Finished populate-webroot step (success) 22:36:32 INFO - ##### 22:36:32 INFO - ##### 22:36:32 INFO - ##### Running create-virtualenv step. 22:36:32 INFO - ##### 22:36:32 INFO - Running pre-action listener: _resource_record_pre_action 22:36:32 INFO - Running main action method: create_virtualenv 22:36:32 INFO - Creating virtualenv /builds/slave/test/build/venv 22:36:32 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 22:36:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:36:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:36:33 INFO - Using real prefix '/usr' 22:36:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:36:33 INFO - Installing distribute.............................................................................................................................................................................................done. 22:36:35 INFO - Installing pip.................done. 22:36:35 INFO - Return code: 0 22:36:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:36:35 INFO - Using env: {'DISPLAY': ':0', 22:36:35 INFO - 'HOME': '/home/cltbld', 22:36:35 INFO - 'LANG': 'en_US.UTF-8', 22:36:35 INFO - 'LANGUAGE': 'en_US:en', 22:36:35 INFO - 'LOGNAME': 'cltbld', 22:36:35 INFO - 'MAIL': '/var/mail/cltbld', 22:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:35 INFO - 'MOZ_NO_REMOTE': '1', 22:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:35 INFO - 'NO_EM_RESTART': '1', 22:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:35 INFO - 'PWD': '/builds/slave/test', 22:36:35 INFO - 'SHELL': '/bin/bash', 22:36:35 INFO - 'SHLVL': '1', 22:36:35 INFO - 'TERM': 'linux', 22:36:35 INFO - 'TMOUT': '86400', 22:36:35 INFO - 'USER': 'cltbld', 22:36:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:35 INFO - '_': '/tools/buildbot/bin/python'} 22:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:35 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 22:36:35 INFO - Cleaning up... 22:36:35 INFO - Return code: 0 22:36:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:36:35 INFO - Using env: {'DISPLAY': ':0', 22:36:35 INFO - 'HOME': '/home/cltbld', 22:36:35 INFO - 'LANG': 'en_US.UTF-8', 22:36:35 INFO - 'LANGUAGE': 'en_US:en', 22:36:35 INFO - 'LOGNAME': 'cltbld', 22:36:35 INFO - 'MAIL': '/var/mail/cltbld', 22:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:35 INFO - 'MOZ_NO_REMOTE': '1', 22:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:35 INFO - 'NO_EM_RESTART': '1', 22:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:35 INFO - 'PWD': '/builds/slave/test', 22:36:35 INFO - 'SHELL': '/bin/bash', 22:36:35 INFO - 'SHLVL': '1', 22:36:35 INFO - 'TERM': 'linux', 22:36:35 INFO - 'TMOUT': '86400', 22:36:35 INFO - 'USER': 'cltbld', 22:36:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:35 INFO - '_': '/tools/buildbot/bin/python'} 22:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:35 INFO - Downloading/unpacking psutil>=3.1.1 22:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:36:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:36:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:36:38 INFO - Installing collected packages: psutil 22:36:38 INFO - Running setup.py install for psutil 22:36:38 INFO - building 'psutil._psutil_linux' extension 22:36:38 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 22:36:38 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 22:36:38 INFO - building 'psutil._psutil_posix' extension 22:36:38 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 22:36:38 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 22:36:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:36:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:36:38 INFO - Successfully installed psutil 22:36:38 INFO - Cleaning up... 22:36:38 INFO - Return code: 0 22:36:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:36: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')]} 22:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36: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')]} 22:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:38 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 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:38 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 22:36:38 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 22:36:38 INFO - Using env: {'DISPLAY': ':0', 22:36:38 INFO - 'HOME': '/home/cltbld', 22:36:38 INFO - 'LANG': 'en_US.UTF-8', 22:36:38 INFO - 'LANGUAGE': 'en_US:en', 22:36:38 INFO - 'LOGNAME': 'cltbld', 22:36:38 INFO - 'MAIL': '/var/mail/cltbld', 22:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:38 INFO - 'MOZ_NO_REMOTE': '1', 22:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:38 INFO - 'NO_EM_RESTART': '1', 22:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:38 INFO - 'PWD': '/builds/slave/test', 22:36:38 INFO - 'SHELL': '/bin/bash', 22:36:38 INFO - 'SHLVL': '1', 22:36:38 INFO - 'TERM': 'linux', 22:36:38 INFO - 'TMOUT': '86400', 22:36:38 INFO - 'USER': 'cltbld', 22:36:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:38 INFO - '_': '/tools/buildbot/bin/python'} 22:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:36:40 INFO - Installing collected packages: mozsystemmonitor 22:36:40 INFO - Running setup.py install for mozsystemmonitor 22:36:40 INFO - Successfully installed mozsystemmonitor 22:36:40 INFO - Cleaning up... 22:36:40 INFO - Return code: 0 22:36:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:40 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 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:40 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 22:36:40 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 22:36:40 INFO - Using env: {'DISPLAY': ':0', 22:36:40 INFO - 'HOME': '/home/cltbld', 22:36:40 INFO - 'LANG': 'en_US.UTF-8', 22:36:40 INFO - 'LANGUAGE': 'en_US:en', 22:36:40 INFO - 'LOGNAME': 'cltbld', 22:36:40 INFO - 'MAIL': '/var/mail/cltbld', 22:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:40 INFO - 'MOZ_NO_REMOTE': '1', 22:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:40 INFO - 'NO_EM_RESTART': '1', 22:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:40 INFO - 'PWD': '/builds/slave/test', 22:36:40 INFO - 'SHELL': '/bin/bash', 22:36:40 INFO - 'SHLVL': '1', 22:36:40 INFO - 'TERM': 'linux', 22:36:40 INFO - 'TMOUT': '86400', 22:36:40 INFO - 'USER': 'cltbld', 22:36:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:40 INFO - '_': '/tools/buildbot/bin/python'} 22:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:41 INFO - Downloading/unpacking jsonschema==2.5.1 22:36:41 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 22:36:41 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 22:36:41 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 22:36:41 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 22:36:41 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 22:36:41 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 22:36:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:36:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:43 INFO - Downloading functools32-3.2.3-2.tar.gz 22:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:36:43 INFO - warning: no files found matching '*.txt' 22:36:43 INFO - no previously-included directories found matching 'build' 22:36:43 INFO - no previously-included directories found matching 'dist' 22:36:43 INFO - no previously-included directories found matching '.git*' 22:36:43 INFO - Installing collected packages: jsonschema, functools32 22:36:43 INFO - Running setup.py install for functools32 22:36:43 INFO - warning: no files found matching '*.txt' 22:36:43 INFO - no previously-included directories found matching 'build' 22:36:43 INFO - no previously-included directories found matching 'dist' 22:36:43 INFO - no previously-included directories found matching '.git*' 22:36:43 INFO - Successfully installed jsonschema functools32 22:36:43 INFO - Cleaning up... 22:36:43 INFO - Return code: 0 22:36:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:43 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 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:43 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 22:36:43 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 22:36:43 INFO - Using env: {'DISPLAY': ':0', 22:36:43 INFO - 'HOME': '/home/cltbld', 22:36:43 INFO - 'LANG': 'en_US.UTF-8', 22:36:43 INFO - 'LANGUAGE': 'en_US:en', 22:36:43 INFO - 'LOGNAME': 'cltbld', 22:36:43 INFO - 'MAIL': '/var/mail/cltbld', 22:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:43 INFO - 'MOZ_NO_REMOTE': '1', 22:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:43 INFO - 'NO_EM_RESTART': '1', 22:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:43 INFO - 'PWD': '/builds/slave/test', 22:36:43 INFO - 'SHELL': '/bin/bash', 22:36:43 INFO - 'SHLVL': '1', 22:36:43 INFO - 'TERM': 'linux', 22:36:43 INFO - 'TMOUT': '86400', 22:36:43 INFO - 'USER': 'cltbld', 22:36:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:43 INFO - '_': '/tools/buildbot/bin/python'} 22:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:43 INFO - Downloading/unpacking blobuploader==1.2.4 22:36:43 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 22:36:43 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 22:36:43 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 22:36:43 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 22:36:43 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 22:36:43 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 22:36:45 INFO - Downloading blobuploader-1.2.4.tar.gz 22:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:36:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:36:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:36:46 INFO - Downloading docopt-0.6.1.tar.gz 22:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:36:46 INFO - Installing collected packages: blobuploader, requests, docopt 22:36:46 INFO - Running setup.py install for blobuploader 22:36:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:36:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:36:46 INFO - Running setup.py install for requests 22:36:46 INFO - Running setup.py install for docopt 22:36:46 INFO - Successfully installed blobuploader requests docopt 22:36:46 INFO - Cleaning up... 22:36:46 INFO - Return code: 0 22:36:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:46 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 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:46 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 22:36:46 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 22:36:46 INFO - Using env: {'DISPLAY': ':0', 22:36:46 INFO - 'HOME': '/home/cltbld', 22:36:46 INFO - 'LANG': 'en_US.UTF-8', 22:36:46 INFO - 'LANGUAGE': 'en_US:en', 22:36:46 INFO - 'LOGNAME': 'cltbld', 22:36:46 INFO - 'MAIL': '/var/mail/cltbld', 22:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:46 INFO - 'MOZ_NO_REMOTE': '1', 22:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:46 INFO - 'NO_EM_RESTART': '1', 22:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:46 INFO - 'PWD': '/builds/slave/test', 22:36:46 INFO - 'SHELL': '/bin/bash', 22:36:46 INFO - 'SHLVL': '1', 22:36:46 INFO - 'TERM': 'linux', 22:36:46 INFO - 'TMOUT': '86400', 22:36:46 INFO - 'USER': 'cltbld', 22:36:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:46 INFO - '_': '/tools/buildbot/bin/python'} 22:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:36:47 INFO - Running setup.py (path:/tmp/pip-lsiBUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:36:47 INFO - Running setup.py (path:/tmp/pip-5YLc8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:36:47 INFO - Running setup.py (path:/tmp/pip-wMYONV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:36:47 INFO - Running setup.py (path:/tmp/pip-qIq9ZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:36:47 INFO - Running setup.py (path:/tmp/pip-k9Ciie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:36:47 INFO - Running setup.py (path:/tmp/pip-8DFbdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:36:47 INFO - Running setup.py (path:/tmp/pip-e7pRia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:36:47 INFO - Running setup.py (path:/tmp/pip-bkSr3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:36:47 INFO - Running setup.py (path:/tmp/pip-f_driA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:36:47 INFO - Running setup.py (path:/tmp/pip-BMeFUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:36:47 INFO - Running setup.py (path:/tmp/pip-_gimfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:36:47 INFO - Running setup.py (path:/tmp/pip-7ZwIB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:36:48 INFO - Running setup.py (path:/tmp/pip-7GIsSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:36:48 INFO - Running setup.py (path:/tmp/pip-fJqAJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:48 INFO - Running setup.py (path:/tmp/pip-yT6Far-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:36:48 INFO - Running setup.py (path:/tmp/pip-tHuNlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:36:48 INFO - Running setup.py (path:/tmp/pip-QkAX7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:36:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:36:48 INFO - Running setup.py install for manifestparser 22:36:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:36:48 INFO - Running setup.py install for mozcrash 22:36:48 INFO - Running setup.py install for mozdebug 22:36:48 INFO - Running setup.py install for mozdevice 22:36:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:36:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:36:48 INFO - Running setup.py install for mozfile 22:36:48 INFO - Running setup.py install for mozhttpd 22:36:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Running setup.py install for mozinfo 22:36:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Running setup.py install for mozInstall 22:36:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Running setup.py install for mozleak 22:36:49 INFO - Running setup.py install for mozlog 22:36:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Running setup.py install for moznetwork 22:36:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Running setup.py install for mozprocess 22:36:49 INFO - Running setup.py install for mozprofile 22:36:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Running setup.py install for mozrunner 22:36:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:36:49 INFO - Running setup.py install for mozscreenshot 22:36:49 INFO - Running setup.py install for moztest 22:36:50 INFO - Running setup.py install for mozversion 22:36:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:36:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:36:50 INFO - Cleaning up... 22:36:50 INFO - Return code: 0 22:36:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:36: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')]} 22:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36: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')]} 22:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:50 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 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:50 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 22:36:50 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 22:36:50 INFO - Using env: {'DISPLAY': ':0', 22:36:50 INFO - 'HOME': '/home/cltbld', 22:36:50 INFO - 'LANG': 'en_US.UTF-8', 22:36:50 INFO - 'LANGUAGE': 'en_US:en', 22:36:50 INFO - 'LOGNAME': 'cltbld', 22:36:50 INFO - 'MAIL': '/var/mail/cltbld', 22:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:50 INFO - 'MOZ_NO_REMOTE': '1', 22:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:50 INFO - 'NO_EM_RESTART': '1', 22:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:50 INFO - 'PWD': '/builds/slave/test', 22:36:50 INFO - 'SHELL': '/bin/bash', 22:36:50 INFO - 'SHLVL': '1', 22:36:50 INFO - 'TERM': 'linux', 22:36:50 INFO - 'TMOUT': '86400', 22:36:50 INFO - 'USER': 'cltbld', 22:36:50 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:50 INFO - '_': '/tools/buildbot/bin/python'} 22:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:36:50 INFO - Running setup.py (path:/tmp/pip-3o2SGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:36:50 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)) 22:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:36:50 INFO - Running setup.py (path:/tmp/pip-UmJOpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:36:50 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)) 22:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:36:50 INFO - Running setup.py (path:/tmp/pip-vgKKV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:36:50 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)) 22:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:36:50 INFO - Running setup.py (path:/tmp/pip-psoquU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:36:50 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)) 22:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:36:50 INFO - Running setup.py (path:/tmp/pip-6ndjDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:36:50 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)) 22:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:36:50 INFO - Running setup.py (path:/tmp/pip-g1zEUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:36:50 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)) 22:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:36:50 INFO - Running setup.py (path:/tmp/pip-znTQfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:36:50 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)) 22:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:36:50 INFO - Running setup.py (path:/tmp/pip-1DZevM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:36:51 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)) 22:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:36:51 INFO - Running setup.py (path:/tmp/pip-kBD2Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:36:51 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)) 22:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:36:51 INFO - Running setup.py (path:/tmp/pip-pYgv1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:36:51 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)) 22:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:36:51 INFO - Running setup.py (path:/tmp/pip-K8xKvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:36:51 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)) 22:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:36:51 INFO - Running setup.py (path:/tmp/pip-1fmJqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:36:51 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)) 22:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:36:51 INFO - Running setup.py (path:/tmp/pip-gCA2fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:36:51 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)) 22:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:36:51 INFO - Running setup.py (path:/tmp/pip-rBiDbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:36:51 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)) 22:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:51 INFO - Running setup.py (path:/tmp/pip-agkDC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:36:51 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)) 22:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:36:51 INFO - Running setup.py (path:/tmp/pip-WRjtTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:36:51 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)) 22:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:36:51 INFO - Running setup.py (path:/tmp/pip-zBIJcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:36:51 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)) 22:36:51 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)) 22:36:51 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)) 22:36:51 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)) 22:36:51 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)) 22:36:51 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)) 22:36:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:36:51 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 22:36:51 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 22:36:51 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 22:36:51 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 22:36:51 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 22:36:51 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 22:36:53 INFO - Downloading blessings-1.6.tar.gz 22:36:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:36:53 INFO - Installing collected packages: blessings 22:36:53 INFO - Running setup.py install for blessings 22:36:53 INFO - Successfully installed blessings 22:36:53 INFO - Cleaning up... 22:36:53 INFO - Return code: 0 22:36:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:36:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:36:54 INFO - Reading from file tmpfile_stdout 22:36:54 INFO - Current package versions: 22:36:54 INFO - argparse == 1.2.1 22:36:54 INFO - blessings == 1.6 22:36:54 INFO - blobuploader == 1.2.4 22:36:54 INFO - docopt == 0.6.1 22:36:54 INFO - functools32 == 3.2.3-2 22:36:54 INFO - jsonschema == 2.5.1 22:36:54 INFO - manifestparser == 1.1 22:36:54 INFO - mozInstall == 1.12 22:36:54 INFO - mozcrash == 0.17 22:36:54 INFO - mozdebug == 0.1 22:36:54 INFO - mozdevice == 0.48 22:36:54 INFO - mozfile == 1.2 22:36:54 INFO - mozhttpd == 0.7 22:36:54 INFO - mozinfo == 0.9 22:36:54 INFO - mozleak == 0.1 22:36:54 INFO - mozlog == 3.2 22:36:54 INFO - moznetwork == 0.27 22:36:54 INFO - mozprocess == 0.22 22:36:54 INFO - mozprofile == 0.28 22:36:54 INFO - mozrunner == 6.11 22:36:54 INFO - mozscreenshot == 0.1 22:36:54 INFO - mozsystemmonitor == 0.3 22:36:54 INFO - moztest == 0.7 22:36:54 INFO - mozversion == 1.4 22:36:54 INFO - psutil == 3.1.1 22:36:54 INFO - requests == 1.2.3 22:36:54 INFO - wsgiref == 0.1.2 22:36:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:54 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 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:54 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 22:36:54 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 22:36:54 INFO - Using env: {'DISPLAY': ':0', 22:36:54 INFO - 'HOME': '/home/cltbld', 22:36:54 INFO - 'LANG': 'en_US.UTF-8', 22:36:54 INFO - 'LANGUAGE': 'en_US:en', 22:36:54 INFO - 'LOGNAME': 'cltbld', 22:36:54 INFO - 'MAIL': '/var/mail/cltbld', 22:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:54 INFO - 'MOZ_NO_REMOTE': '1', 22:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:54 INFO - 'NO_EM_RESTART': '1', 22:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:54 INFO - 'PWD': '/builds/slave/test', 22:36:54 INFO - 'SHELL': '/bin/bash', 22:36:54 INFO - 'SHLVL': '1', 22:36:54 INFO - 'TERM': 'linux', 22:36:54 INFO - 'TMOUT': '86400', 22:36:54 INFO - 'USER': 'cltbld', 22:36:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:54 INFO - '_': '/tools/buildbot/bin/python'} 22:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:54 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)) 22:36:54 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)) 22:36:54 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)) 22:36:54 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)) 22:36:54 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)) 22:36:54 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)) 22:36:54 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)) 22:36:54 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)) 22:36:54 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)) 22:36:54 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)) 22:36:54 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)) 22:36:54 INFO - Cleaning up... 22:36:54 INFO - Return code: 0 22:36:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:36:54 INFO - Using env: {'DISPLAY': ':0', 22:36:54 INFO - 'HOME': '/home/cltbld', 22:36:54 INFO - 'LANG': 'en_US.UTF-8', 22:36:54 INFO - 'LANGUAGE': 'en_US:en', 22:36:54 INFO - 'LOGNAME': 'cltbld', 22:36:54 INFO - 'MAIL': '/var/mail/cltbld', 22:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:54 INFO - 'MOZ_NO_REMOTE': '1', 22:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:54 INFO - 'NO_EM_RESTART': '1', 22:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:54 INFO - 'PWD': '/builds/slave/test', 22:36:54 INFO - 'SHELL': '/bin/bash', 22:36:54 INFO - 'SHLVL': '1', 22:36:54 INFO - 'TERM': 'linux', 22:36:54 INFO - 'TMOUT': '86400', 22:36:54 INFO - 'USER': 'cltbld', 22:36:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:54 INFO - '_': '/tools/buildbot/bin/python'} 22:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:36:54 INFO - Cleaning up... 22:36:54 INFO - Return code: 0 22:36:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:36:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcca717cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', '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 22:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:36:54 INFO - Using env: {'DISPLAY': ':0', 22:36:54 INFO - 'HOME': '/home/cltbld', 22:36:54 INFO - 'LANG': 'en_US.UTF-8', 22:36:54 INFO - 'LANGUAGE': 'en_US:en', 22:36:54 INFO - 'LOGNAME': 'cltbld', 22:36:54 INFO - 'MAIL': '/var/mail/cltbld', 22:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:54 INFO - 'MOZ_NO_REMOTE': '1', 22:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:36:54 INFO - 'NO_EM_RESTART': '1', 22:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:54 INFO - 'PWD': '/builds/slave/test', 22:36:54 INFO - 'SHELL': '/bin/bash', 22:36:54 INFO - 'SHLVL': '1', 22:36:54 INFO - 'TERM': 'linux', 22:36:54 INFO - 'TMOUT': '86400', 22:36:54 INFO - 'USER': 'cltbld', 22:36:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:54 INFO - '_': '/tools/buildbot/bin/python'} 22:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:36:54 INFO - Downloading/unpacking flake8 22:36: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 22:36: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 22:36: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 22:36: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 22:36: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 22:36: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 22:36:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:36:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:36:56 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 22:36:56 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 22:36:56 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 22:36:56 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 22:36:56 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 22:36:56 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 22:36:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:36:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:36:56 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 22:36:56 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 22:36:56 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 22:36:56 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 22:36:56 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 22:36:56 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 22:36:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:36: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 22:36: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 22:36: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 22:36: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 22:36: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 22:36: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 22:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:36:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:36:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:36:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:36:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:36:57 INFO - no previously-included directories found matching 'docs/_build' 22:36:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:36:57 INFO - Running setup.py install for pep8 22:36:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:36:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:36:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:36:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:36:57 INFO - no previously-included directories found matching 'docs/_build' 22:36:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:36:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:36:57 INFO - Cleaning up... 22:36:57 INFO - Return code: 0 22:36:57 INFO - Running post-action listener: _resource_record_post_action 22:36:57 INFO - Running post-action listener: _start_resource_monitoring 22:36:57 INFO - Starting resource monitoring. 22:36:57 INFO - ##### 22:36:57 INFO - ##### Finished create-virtualenv step (success) 22:36:57 INFO - ##### 22:36:57 INFO - ##### 22:36:57 INFO - ##### Running install step. 22:36:57 INFO - ##### 22:36:57 INFO - Running pre-action listener: _resource_record_pre_action 22:36:57 INFO - Running main action method: install 22:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:36:57 INFO - Reading from file tmpfile_stdout 22:36:57 INFO - Detecting whether we're running mozinstall >=1.0... 22:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:36:57 INFO - Reading from file tmpfile_stdout 22:36:57 INFO - Output received: 22:36:57 INFO - Usage: mozinstall [options] installer 22:36:57 INFO - Options: 22:36:57 INFO - -h, --help show this help message and exit 22:36:57 INFO - -d DEST, --destination=DEST 22:36:57 INFO - Directory to install application into. [default: 22:36:57 INFO - "/builds/slave/test"] 22:36:57 INFO - --app=APP Application being installed. [default: firefox] 22:36:57 INFO - mkdir: /builds/slave/test/build/application 22:36:57 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'] 22:36:57 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 22:37:13 INFO - Reading from file tmpfile_stdout 22:37:13 INFO - Output received: 22:37:13 INFO - /builds/slave/test/build/application/firefox/firefox 22:37:13 INFO - Running post-action listener: _resource_record_post_action 22:37:13 INFO - ##### 22:37:13 INFO - ##### Finished install step (success) 22:37:13 INFO - ##### 22:37:13 INFO - ##### 22:37:13 INFO - ##### Running run-tests step. 22:37:13 INFO - ##### 22:37:13 INFO - Running pre-action listener: _resource_record_pre_action 22:37:13 INFO - Running main action method: run_tests 22:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:37:13 INFO - Python 2.7.3 22:37:13 INFO - Return code: 0 22:37:13 INFO - grabbing minidump binary from tooltool 22:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:13 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 0x1e001c0>, '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 0x1e010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e01550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:37:13 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 22:37:13 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 22:37:13 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 22:37:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:37:14 INFO - Return code: 0 22:37:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:37:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:37:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:37:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:37:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:37:14 INFO - Return code: 0 22:37:14 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/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:37:14 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/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:37:14 INFO - Using env: {'DISPLAY': ':0', 22:37:14 INFO - 'HOME': '/home/cltbld', 22:37:14 INFO - 'LANG': 'en_US.UTF-8', 22:37:14 INFO - 'LANGUAGE': 'en_US:en', 22:37:14 INFO - 'LOGNAME': 'cltbld', 22:37:14 INFO - 'MAIL': '/var/mail/cltbld', 22:37:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:37:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:14 INFO - 'MOZ_NO_REMOTE': '1', 22:37:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:14 INFO - 'NO_EM_RESTART': '1', 22:37:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:14 INFO - 'PWD': '/builds/slave/test', 22:37:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:37:14 INFO - 'SHELL': '/bin/bash', 22:37:14 INFO - 'SHLVL': '1', 22:37:14 INFO - 'TERM': 'linux', 22:37:14 INFO - 'TMOUT': '86400', 22:37:14 INFO - 'USER': 'cltbld', 22:37:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659', 22:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:14 INFO - '_': '/tools/buildbot/bin/python'} 22:37:14 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/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:37:15 INFO - mozversion application_buildid: 20160608214828 22:37:15 INFO - mozversion application_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 22:37:15 INFO - mozversion application_display_name: Nightly 22:37:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:37:15 INFO - mozversion application_name: Firefox 22:37:15 INFO - mozversion application_remotingname: firefox 22:37:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:37:15 INFO - mozversion application_vendor: Mozilla 22:37:15 INFO - mozversion application_version: 50.0a1 22:37:15 INFO - mozversion platform_buildid: 20160608214828 22:37:15 INFO - mozversion platform_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 22:37:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:37:15 INFO - mozversion platform_version: 50.0a1 22:37:15 INFO - using testdate: 1465450635 22:37:15 INFO - actual date: 1465450635 22:37:15 INFO - starting webserver on 'localhost:53075' 22:37:15 INFO - SUITE-START | Running 2 tests 22:37:15 INFO - TEST-START | dromaeo_css 22:37:15 INFO - operating with platform_type : linux_ 22:37:15 INFO - Initialising browser for dromaeo_css test... 22:37:15 INFO - TEST-INFO | started process 7664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy8dMD6/profile http://localhost:53075/getInfo.html) 22:37:19 INFO - PROCESS | 7664 | __metrics Screen width/height:1600/1200 22:37:19 INFO - PROCESS | 7664 | colorDepth:24 22:37:19 INFO - PROCESS | 7664 | Browser inner width/height: 1024/697 22:37:19 INFO - PROCESS | 7664 | __metrics 22:37:20 ERROR - PROCESS | 7664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 22:37:21 INFO - TEST-INFO | 7664: exit 0 22:37:21 INFO - Browser initialized. 22:37:21 INFO - Running cycle 1/1 for dromaeo_css test... 22:37:21 INFO - TEST-INFO | started process 7781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy8dMD6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:37:33 INFO - PROCESS | 7781 | RSS: Main: 168640512 22:37:33 INFO - PROCESS | 7781 | 22:38:23 INFO - PROCESS | 7781 | 1465450703250 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] 22:40:33 INFO - PROCESS | 7781 | Cycle 1(1): loaded http://localhost:53075/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53075/tests/dromaeo/cssquery-ext.html) 22:40:35 INFO - PROCESS | 7781 | RSS: Main: 171732992 22:40:35 INFO - PROCESS | 7781 | 22:43:37 INFO - PROCESS | 7781 | Cycle 1(1): loaded http://localhost:53075/tests/dromaeo/cssquery-ext.html (next: http://localhost:53075/tests/dromaeo/cssquery-jquery.html) 22:43:38 INFO - PROCESS | 7781 | RSS: Main: 169943040 22:43:38 INFO - PROCESS | 7781 | 22:46:40 INFO - PROCESS | 7781 | Cycle 1(1): loaded http://localhost:53075/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53075/tests/dromaeo/cssquery-mootools.html) 22:46:40 INFO - PROCESS | 7781 | RSS: Main: 171175936 22:46:40 INFO - PROCESS | 7781 | 22:49:42 INFO - PROCESS | 7781 | Cycle 1(1): loaded http://localhost:53075/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53075/tests/dromaeo/cssquery-prototype.html) 22:49:43 INFO - PROCESS | 7781 | RSS: Main: 168755200 22:49:43 INFO - PROCESS | 7781 | 22:52:45 INFO - PROCESS | 7781 | Cycle 1(1): loaded http://localhost:53075/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53075/tests/dromaeo/cssquery-yui.html) 22:52:46 INFO - PROCESS | 7781 | RSS: Main: 171069440 22:52:46 INFO - PROCESS | 7781 | 22:55:49 INFO - PROCESS | 7781 | Cycle 1(1): loaded http://localhost:53075/tests/dromaeo/cssquery-yui.html (next: http://localhost:53075/tests/dromaeo/cssquery-dojo.html) 22:55:49 INFO - PROCESS | 7781 | RSS: Main: 172859392 22:55:49 INFO - PROCESS | 7781 | 22:55:49 INFO - PROCESS | 7781 | __start_tp_report 22:55:49 INFO - PROCESS | 7781 | _x_x_mozilla_page_load 22:55:49 INFO - PROCESS | 7781 | _x_x_mozilla_page_load_details 22:55:49 INFO - PROCESS | 7781 | |i|pagename|runs| 22:55:49 INFO - PROCESS | 7781 | |0;dojo.html;2636.446346267284;2704.594310853371;2718.768904643105;2720.891164353426;2734.5898115282707;4748.976255118724;4756.643251756119;4776.71339719617;4824.179889418799;4846.369971903648;4534.34252033455;4575.8169673213115;4599.908001839961;4637.605803506706;4657.673962822604;4248.745075295476;4272.4232228649125;4409.4488188976375;4463.107378524292;4516.322551617267;4384.62730667892;4419.4033805436175;4468.620167285784;4535.501094879577;4542.409486766715;157.73728583084045;4487.820487180509;4512.954870451286;4534.251848445003;4559.680822342438;4410.911781764379;4424.823007079713;4436.245838207513;4453.242948698729;4471.28459446487;4354.782260886943;4357;4360.258756011485;4361.847335343279;4413.691041627056;4587.9082418351445;4607.308903664477;4655.301704744282;4657.11514812188;4690.695104818176;5093.312402825608;5102.591792656579;5103.668261562986;5108.974455127738;5152.046871328816;5118.974405127988;5122.29440469417;5151.6908985461;5155.355580552431;5194.065068287707;4738.1708201064675;4754.548317909793;4760.071786001731;4775.617950563947;4789.090072886141;5185.533302002837;5197.272381866542;5245.816396426107;5264.605154613343;5277.155655095166;5059.468755780664;5073;5074.492550744896;5077.796888124508;5083.593312534988;4962.925556116661;5146.279520867081;5158.664686795421;5168.715720635326;5243.318368612132;5134.306868572695;5201.687898726089;5206.323177986837;5212.400573934046;5262.868483276114;4963.751812409438;5139.177731563007;5164.974175129176;5184.196449550326;5200.817971370984;4273.380359847804;4276.144771045803;4295.978520107442;4296.312589985588;4309.375140604658;3676.7242456815848;3709.295233905549;3748.5314335708035;3770.3401904666575;3773.64150405711;4294.441722576045;4425.889352766207;4434.3348497724955;4458.130664520388;4505.61702255312;5072.54347108762;5082.161443361878;5145.588352931756;5155.510226528474;5162.045021671003;4411.2721400968485;4421;4421.801018954155;4422.314541246112;4462.732236065846;4398.054418300081;4523.864284071483;4578.473475550288;4586.220342541709;4607.124646317189;4803.567678908915;4873.780679869344;4874.439439464507;4877.292792545132;4908.8772780680765;5132.358455193101;5176.456472070378;5179.093658609653;5180.430152683127;5184.766685499086;4666.580007799314;4701.976490117528;4706.670533062653;4859.538343857328;4942.28336891156;4994.5754610858485;5001.874953126201;5053;5053.949460505348;5066.442691304027;5134.05020071288;5153.381594208569;5155.484451554815;5155.561777248976;5198.584113270854;4863.148948933852;4897.681650692693;4979.477154898684;4981.452040275639;5014.84955451337;4909.239067944474;4947;4949.480304567968;4962.950370496394;5005.724685142352;4844.8304309349005;4868.756562171948;4871.951280487291;4876.4392094909535;4912.38595175603;4885.609151267961;4911.508849115203;4966.453690094015;4974;5023.296738456692;4887.169181239269;4900.240462728283;4903.41457588998;4917.9016419672125;4937.629677774253 22:55:49 INFO - PROCESS | 7781 | |1;ext.html;536.2203411806107;575.7006356694518;578.878435528539;596.4423264247929;610.3774150366629;37878;38830.80584597077;38854.805725971404;38934.61065389349;39030;38850.61149388505;39158;39160.21679566407;39230;39270;7760.874673172372;7874.763757087297;7886.487378320391;7918.4457088003865;7920.049594048723;7825.6087195640275;7841.21587841217;7901.96049019757;7915.327197188217;7925.088614809313;7875.763727088197;7897.8025549361155;7942.285194332509;7948.046234451845;7956.443048986544;7839.686412543491;7871.21287871214;7910.208979102073;7915.643796029135;7930.088039875402;7800.336971357441;7809.765707028798;7845.803854903616;7856.567888766115;7862.528248305063;29044.12867613975;36413;36747.08132296687;36791.4481282781;37354.81322593397;3012.186709588399;3039.863206155728;3056.419280336729;3127.9061628151194;3542.167590616229;26779;27029.729702703116;27075.323116922038;27092.864535677392;27562.724372756216;3361.478970759512;3391.2030672791875;3466.1507930557177;3498.265364273506;3506.7720598161036;259164;260989;261609;262319;262513;31463.685363146535;32883.50674739881;55273.72363138159;55433.44566554364;55521.72239138778;33014.8349258257;33015.66984330174;33324.3335133296;33327.66672333294;33585.16037099092;13726.794098088536;14003.159810411407;14025.5091071812;14047.297635118408;14067.2966351682;10859.13126949842;10946.343219406861;10949.616763413242;10954.616588419367;10956.506957186946;7760.146383897767;7869.803254918673;7967.641456134488;7982.481138725964;8008.479448835924;3116.67274936133;3120.2979329651102;3124.0627811656414;3143.072793525915;3148.7323577496168;872.8908886389202;874.0822136756381;945.7115579748105;962.3936919740519;994.5126887824914;26590.335241618726;27853.721462785114;28027.439451210863;28258.576121358197;28433.57349639757;975.1711045611315;992.4987881120132;1005.1857995024054;1006.4665727164614;1013.8529913162697;14625;15085.3211605478;15109;15161.166135862413;15413.460528881435;361240;361422;364202;365117;366158;32951.1762205942;33058;33090.17274568155;33094.83452582722;33151.66848331534;1194.3431112887877;1240.4418011894504;1241.050596293836;1245.7197130645714;1247.5820600099069;25636.23091307264;27621.30946726348;27675.49306970011;27984.72015279821;28229.858850705616;42079.36880946727;42768;42783.3582496269;42948.78525607352;42983.355249670654;305248;305382;305527;305964;306686;24945.37636559028;25091.74908250894;25396.111136110147;25518.23445296644;25591.744082559682;41756.3736543946;41938.79030604827;42170.78914605407;42204.36693449662;42613.36079958865;36431.817840910626;36693.71571994967;36815;37023.444648330835;37113;35663.46504802378;35876;35881;36808.631913681595;36848.81575592105;34905.12737181591;35284.64715352814;35392;35725;35727.106822329646;31844.203894901886;32674;32709;32754.83622581872;33110;24474.632880507164;25178.874105629355;25313.240602781945;25369.492610148063;25566.506150352903 22:55:49 INFO - PROCESS | 7781 | |2;jquery.html;357.43346795329387;365.67272291299287;366.68648305698633;374.12454855637804;376.1874351400974;15953;16310.673786524278;17041.06274154921;17069.914650426763;17078.829211707878;14137.787933180985;15218.619534511643;15257;15259.160746158957;15270.312835922383;4698.389209402773;5079.771410286546;5104.489551044884;5105.387353517564;5112.769925353368;4991.07665081961;5005.624578156635;5018.7992480300745;5037.622178336621;5045.545900868921;4810.4948980357085;4973.726445045521;4975.09464036661;5043.621728370368;5046.697198168122;5005.6496045276845;5007;5008.84973450797;5016;5037.773300201481;4477.171723231213;4500.617447516965;4783.665143439961;4835.153848076608;4870.951290487085;11815.94092029543;11919.94040029803;11935.343556104412;11943.223690460092;12484;1711;1722.1045056570513;1850.611371611963;1931.777845547766;2020.5251765835017;8648.783780405478;8725.258353039999;8985.46087234768;9098.363114581982;9252.16730494252;1663.1767275198733;1664.25108701085;1698.5583748225426;1748.8163742806948;1768.6109056007658;48955.51044489545;64653.67673161604;67737.66131169362;69118;70139;9513.191378732747;9610.135087842127;9693.273004524688;9774.95112524447;10060.647877324258;13299.13555618901;13324.533641322507;13336.799948000787;13437.529686460926;13456.25990570528;7362.631868406558;7476.775696729107;7511.774646760606;7637.4653774236385;7647.426443016796;7259.709611615582;7321.377682897013;7341.045664063638;7423.4061275097865;7456.105267367951;4183.309753890635;4236.449261596034;4238.817009240243;4256.404103425523;4368.301071828492;1764.6117854072083;1778.8043315235313;1796.9640607187782;1797.5506123469133;1817.2730907636787;851.5188918261163;872.3152325424638;905.5608030105394;960.6109525642127;968.8692026576463;16405.58986025359;16940.83059169417;17122.571935701708;17293.827061729222;17345.306187752347;820.2658620534588;852.2968550945495;875.4747151709051;915.1443400420628;971.0774763974111;9397.342186046912;9594.376365536218;9696.224302055818;9704.660336888175;9814.362066465657;364478;365948;369319;371539;372367;74671.25328746643;77095;77285.61357193178;77750.6112469434;78327.21672783313;872.1932212703351;878.6529320918202;889.621910687968;891.2869704236584;898.9325800564984;14882.77675834885;15026.474073407378;15160.09039457636;15297.158656274012;15363.539093827203;33310;33932.49101263434;34386.82806585951;34901.476477852346;34914.65085349114;45719.54280457286;47513;47751.52248477471;47936.7603161982;47976.7601161992;7194.532355396883;7217.855642887008;7260.237675044255;7318.1584117825005;7349.963250183929;9065;11372.886271137182;11563.942180289045;11581.420928953687;11734.882651173379;9117.77205569866;10032.398056116657;10196.286259961731;10317.226208034277;10467.371957682564;9890.258230632588;9902.306838521523;9963.202943764336;9981.750456238362;9992.750181245527;10325.63860264887;10348.53431595595;10414.47927603632;10417.374957502574;10462.68611941643;7354.852902942018;7433.9256607433235;7582.924170758221;7602.8099297518;7676.654550545127;7770.45606807518;9637.469939153134;10215.438150901771;10286.485675716334;10391.428471433841 22:55:49 INFO - PROCESS | 7781 | |3;mootools.html;1398.307837620378;1433.6774225799197;1521.2621878388986;1704.5568152280403;1707.9316827326907;6335.334789847057;7273.818154546139;7405.629718514079;7845.76462706119;7865.685372585097;7513.699452021912;7789.298963093321;7870.055593328809;7874;7883.211678832114;2123.638981373166;2150.9032093555747;2162.6215412302863;2169.208238992764;2169.6203164446238;2081.1779347157863;2125.5217576045343;2152.0208305221163;2155.7305336832897;2166.945826354346;2162.5999190149796;2164.9134034638596;2167.468970102327;2186.1036974840317;2188.081005977493;2117.396541985542;2119.9152033918626;2121.893905304736;2123.734533183352;2132.658774596073;2085.603735290305;2086.9478263043393;2118.682197670362;2141.7001619773246;2147.2162660628915;7833.529988200669;7840.921590784076;7844.686212551491;7904.683812647487;7919.049714034353;4370.147821174872;4498;4536.4102666653125;4541.091781643651;4546.113507865967;2756.1593713917246;2813.2404250852155;2878.6113874626867;2882.8990985315622;2892.638420197475;879.5338470610586;926.5129467205106;935.714607044851;979.0405402705318;983.1937810994987;10636.30863993838;10699.679009629723;10702.250842441032;10730.570777168827;10802.783944321069;3881.80590970456;3905.7656540607086;4025.4163146343617;4030.3954406839207;4050.7569545827346;9077.092290771003;9111.407758495676;9145.222656074175;9184.63261469547;9185.724428267162;4494.820207191676;4526.773661316987;4556.658250631216;4563.817447302071;4574.336721175411;3460.325236578843;3905.1213476967455;4116.5060192777055;4193.203291374629;4193.622573968358;3648.379775438129;3652.9634703652623;3745.8127093645207;3746.250749850041;3803.82882770276;1148.3970915269551;1202.4108186988312;1204.1811568133753;1214.319980810731;1216.5741990303322;664.8404382948057;794.3367288314207;812.9878051829228;821.5850995247481;822.6462621072876;4587.587117159472;5229.555487783505;5524.751386187631;5607.859803504945;5787.652740835563;846.1580727176499;852.5311078906576;889.4307643108416;912.9634814607474;930.6882194464795;3610.8014059226994;3643.3259846928404;3793.5447746270625;3808.8476460941806;3846.2307538492414;9432.669856555125;9573.664921727706;9770.658026969022;9788.55951482185;9796.069373409515;9580;9624.085711857362;9635.421874687541;9636.662716804878;9643.08390702882;6776.55952363085;7268.454865884974;7344.155422126417;7422.220666829905;7429;5260.44765299638;5306.310179676618;5311.256424100552;5332.786688532416;5387.568994480511;8751.606177722146;8829.735107946772;9096.681616143404;9125.817483650157;9148.679796207101;8917.598708058284;9160.908390916273;9195.862062069207;9207.677731279373;9257.629694812133;5945.851353716019;6634.0712300278965;6844.247132815486;6897.137857767779;7039.612821294878;7536.698532058656;7670.693172273047;7671.117821450382;7688.884666730115;7702.961485192538;6626.900596491153;6921.515493915377;6973.58158510491;6976.4767642426;7030;6809.965950170217;6830.146231721035;6843.315668433117;6871.690773915286;7002.3697867192195;5995.790147344822;6230.43926046658;6406.935930640634;6428.067930150009;6463.547551671526;4471.642268618568;4503;4565.77171141435;4566.657500687395;4696.013837094249;4647.790849411852;4745.430548334222;4767.809287628595;4801.135795556834;4813.3983252093485 22:55:49 INFO - PROCESS | 7781 | |4;prototype.html;277.8263585259213;277.8374650829265;280.35937881939765;282.67492383758673;288.86712112428285;4985.376827896513;5023.824166154185;5031.924521132181;5035.093683137034;5048.899022019562;4930.679505832119;4936.210206366982;4947.233178857283;4972.900541989167;4988.3265759122505;3600.459931010343;3701.0377301901567;3728.7949162796035;3756.3426400379963;3804.9429258561004;3758;3766.0436557302523;3767.4348847672795;3772.9624353302925;3782.602826703198;3757.9812100939594;3758.4174452959833;3764.623537646241;3767.2842159989514;3773.3962565989445;3576.6959808416054;3752.3302130551915;3754.324221640131;3767.5290588676417;3781.924361512782;3233.9353212935844;3237.077432931603;3273.639899611041;3280.769711358241;3288.819114948677;4664.813407463697;4688.390509233778;4729.266963620645;4737.418107131622;4738.218193997986;4278.7860606969525;4298.398224248608;4307.82768689252;4332.371806088099;4343;5034.446210916796;5159.916417552281;5170.3278573785165;5180.9740951295;5194.818181363672;3547.7516573839844;3563.1448452371246;3564.3405969895653;3570.857325655791;3573.874914377984;5403.621746477748;5406.35088806486;5412.864678383033;5435.510804027656;5447.346318441772;3530.5233793437556;3631.6368363164;3639.4358874374516;3640.927181456409;3650.9634903651154;3646.7082633389264;3664.871729489455;3670.1191713988983;3672.1186915140174;3688.9262214755554;4280.143971205771;4289.935650965238;4297.333913243452;4302.118065796504;4305;4958.454569997298;5231.03836061477;5233.973830130901;5242.580593552583;5250.238715386324;1265.5886836778084;1271.8664540223328;1274.5539061328461;1274.8661390554043;1275.2730943362194;781.2773184804033;795.944283900133;802.1497212954287;816.2368185746227;821.708293555791;4515.88710282239;4562.61217796491;4585.188850404072;4611.123886461562;4618.67669263155;5400.513953744182;5437.211604317352;5458.972705136449;5463.535599474089;5475.206095116186;4433.357163211316;4513.571210734975;4588.655850811202;4650.883727906829;4652.488226295105;2818.7040360762235;2852.774835628213;2873.7700983921236;2881.639795025622;2895.5077636801793;5079.873003174876;5096.668716533413;5096.878686688922;5108.233764935215;5111.948880511147;5226.092476246219;5461.208124821878;5502.9174562381595;5513.696746678971;5600.411956744565;5132.820351287687;5133.307003554472;5135.306733590917;5156.587473002151;5180.378354597472;5410.83767486976;5414.593905457185;5425.674459532441;5430.728463576885;5463.644863083887;5181.740912954413;5268.761840967293;5289.338832645919;5307.787688492417;5353.277307563585;5137.743112844418;5157.458466861076;5157.504323746071;5178.844634660966;5189.844304670866;3797.525309336333;3809.4476300935653;3821.9044523887123;3823.636754508317;3825.158465137665;5153.6907785532985;5337.919931201112;5339.813106541253;5359.758810853599;5419.620626556103;5195.74021298926;5197.4542673020305;5201;5201.297824793755;5207.453217412117;5177.922331165111;5194.922076168785;5208.479152084761;5209.765560549708;5222.242774797709;4967.180415231446;5143.794248230179;5144.048351055067;5150;5181.81863634771;5008.223725322581;5012.3233363495465;5248.9764495924455;5251.553617942518;5283.735813209401;5156.298421520814;5162.845114646567;5163.8192663256605;5167.173252279617;5188.948110518846 22:55:49 INFO - PROCESS | 7781 | |5;yui.html;595.7587177193237;598.3119412675426;618.6380967134227;631.1542533005772;727.5271073802031;11669.533218671253;12256;12468.688282792935;14342.42630294787;14902.105873647588;14575.927120364384;14728.631784205374;14780.482683106093;14781.260936953136;14782.482613108543;627.9560430769848;782.9569373684445;794.9165337639537;797.0515087046397;808.8907997420362;797.0913158998717;797.872340425532;798.632628990665;800.6117033238875;803.4215364937236;838.3628442383771;838.9538575378351;844.2823599940033;845.2350622686479;846.3863698818338;834.2700137379793;835.2941764209233;837.7821766340795;837.9497230166179;839.9118092600311;606.4178388746808;607.5898768331359;611.9969400153016;612.0849330251302;612.702839123025;12461.314627695474;12549.058820588401;12553.184043037265;12572.245665260023;12594.118411711184;12188;12401.441935112942;12479.93760031203;12639.304838233893;12744.299063551502;10068.94965525175;10286.845697314546;10447.42539160346;10451.581936722521;10633.893661063368;3226.8709251629907;3272.672732726708;3283.2612662150823;3288.391647545212;3317.7511686623598;59280.70359648174;59322.81354372888;60256;60626.090608640465;61183.69408152975;9874.506274686237;10025.19798416125;10047.497625118714;10080.647177348757;10230.386176829414;15985.360585576447;16007.679846403007;16008.199590020686;16130.919345403432;16328.591785205464;6687.465002799764;6764;6923.446124310043;6924.134483189601;6954.200266969363;3727.4222495512695;3773.2264885698364;3783.8837542924903;3797.1836055248255;3810.1998580297895;2825.321922738569;2891.9277018074717;2893.7250961158657;2911.505044142501;2935.324875278698;492.2517772985043;500.5945184400647;508.2554058304602;510;512.3621091740732;449.64702708373767;568.5877738639535;592.3424998251937;603.7916918663054;605.2736715940889;8341.541215233221;8346.457480263764;8496.745097647081;8589.103139680834;8633.697820576375;545.9918101228485;578.6672663218582;585.4467528185824;589.7464090441151;602.3103546439303;3902;4008.118213992917;4017.598240175959;4063.9390409143884;4078.286299897565;54517.72741136269;55490.72254638701;55809.72095139579;56208.71895640578;77897.61051194821;61583.38416615866;78666.6066669663;78993.21006789974;80562.59718701369;81971.18028819635;71787;71973.28026719771;72681;73309.6334518324;73636;7026.789196324118;7099.822504437224;7137.1435427749;7145.535540189871;7158.105236845395;31328.530072049394;37869.24261514809;37936.81031594824;40919.482853292306;41817;58292.125618114915;58644.70677646755;59148;59169;60408.395916040274;11022.779544409228;11139.498722557666;11173.223324963157;11293.71765705831;11441.313521188755;12391.256524608552;12437.37813109359;12668.493260269486;12727;12922.483100675867;11721.472533736172;11837.76324473523;11899.94050029779;11990.820137698116;12458.190217636187;11926.582569610022;11965.76068478643;11971.64085077449;12077.39613019363;12390.194637348544;11610.361430121424;11733.178677492835;11833.230839995373;12086.576969806014;12457.501699931901;9965.701028969142;10074.366202765501;10099.747506312107;10306.12397946153;10526.368417894952;10063.298674498139;10100.545475453475;10153.881271741115;10212;10273.794524109626 22:55:49 INFO - PROCESS | 7781 | __end_tp_report 22:55:49 INFO - PROCESS | 7781 | __start_cc_report 22:55:49 INFO - PROCESS | 7781 | _x_x_mozilla_cycle_collect,376 22:55:49 INFO - PROCESS | 7781 | __end_cc_report 22:55:49 INFO - PROCESS | 7781 | __startTimestamp1465451749308__endTimestamp 22:55:49 INFO - PROCESS | 7781 | 22:55:49 INFO - PROCESS | 7781 | ------- Summary: start ------- 22:55:49 INFO - PROCESS | 7781 | Number of tests: 6 22:55:49 INFO - PROCESS | 7781 | 22:55:49 INFO - PROCESS | 7781 | [#0] dojo.html Cycles:165 Average:4697.97 Median:4868.76 stddev:612.24 (12.6%) stddev-sans-first:592.37 22:55:49 INFO - PROCESS | 7781 | Values: 2636.4 2704.6 2718.8 2720.9 2734.6 4749.0 4756.6 4776.7 4824.2 4846.4 4534.3 4575.8 4599.9 4637.6 4657.7 4248.7 4272.4 4409.4 4463.1 4516.3 4384.6 4419.4 4468.6 4535.5 4542.4 157.7 4487.8 4513.0 4534.3 4559.7 4410.9 4424.8 4436.2 4453.2 4471.3 4354.8 4357.0 4360.3 4361.8 4413.7 4587.9 4607.3 4655.3 4657.1 4690.7 5093.3 5102.6 5103.7 5109.0 5152.0 5119.0 5122.3 5151.7 5155.4 5194.1 4738.2 4754.5 4760.1 4775.6 4789.1 5185.5 5197.3 5245.8 5264.6 5277.2 5059.5 5073.0 5074.5 5077.8 5083.6 4962.9 5146.3 5158.7 5168.7 5243.3 5134.3 5201.7 5206.3 5212.4 5262.9 4963.8 5139.2 5165.0 5184.2 5200.8 4273.4 4276.1 4296.0 4296.3 4309.4 3676.7 3709.3 3748.5 3770.3 3773.6 4294.4 4425.9 4434.3 4458.1 4505.6 5072.5 5082.2 5145.6 5155.5 5162.0 4411.3 4421.0 4421.8 4422.3 4462.7 4398.1 4523.9 4578.5 4586.2 4607.1 4803.6 4873.8 4874.4 4877.3 4908.9 5132.4 5176.5 5179.1 5180.4 5184.8 4666.6 4702.0 4706.7 4859.5 4942.3 4994.6 5001.9 5053.0 5053.9 5066.4 5134.1 5153.4 5155.5 5155.6 5198.6 4863.1 4897.7 4979.5 4981.5 5014.8 4909.2 4947.0 4949.5 4963.0 5005.7 4844.8 4868.8 4872.0 4876.4 4912.4 4885.6 4911.5 4966.5 4974.0 5023.3 4887.2 4900.2 4903.4 4917.9 4937.6 22:55:49 INFO - PROCESS | 7781 | 22:55:49 INFO - PROCESS | 7781 | [#1] ext.html Cycles:180 Average:44883.43 Median:19395.71 stddev:82438.24 (425.0%) stddev-sans-first:82602.25 22:55:49 INFO - PROCESS | 7781 | Values: 536.2 575.7 578.9 596.4 610.4 37878.0 38830.8 38854.8 38934.6 39030.0 38850.6 39158.0 39160.2 39230.0 39270.0 7760.9 7874.8 7886.5 7918.4 7920.0 7825.6 7841.2 7902.0 7915.3 7925.1 7875.8 7897.8 7942.3 7948.0 7956.4 7839.7 7871.2 7910.2 7915.6 7930.1 7800.3 7809.8 7845.8 7856.6 7862.5 29044.1 36413.0 36747.1 36791.4 37354.8 3012.2 3039.9 3056.4 3127.9 3542.2 26779.0 27029.7 27075.3 27092.9 27562.7 3361.5 3391.2 3466.2 3498.3 3506.8 259164.0 260989.0 261609.0 262319.0 262513.0 31463.7 32883.5 55273.7 55433.4 55521.7 33014.8 33015.7 33324.3 33327.7 33585.2 13726.8 14003.2 14025.5 14047.3 14067.3 10859.1 10946.3 10949.6 10954.6 10956.5 7760.1 7869.8 7967.6 7982.5 8008.5 3116.7 3120.3 3124.1 3143.1 3148.7 872.9 874.1 945.7 962.4 994.5 26590.3 27853.7 28027.4 28258.6 28433.6 975.2 992.5 1005.2 1006.5 1013.9 14625.0 15085.3 15109.0 15161.2 15413.5 361240.0 361422.0 364202.0 365117.0 366158.0 32951.2 33058.0 33090.2 33094.8 33151.7 1194.3 1240.4 1241.1 1245.7 1247.6 25636.2 27621.3 27675.5 27984.7 28229.9 42079.4 42768.0 42783.4 42948.8 42983.4 305248.0 305382.0 305527.0 305964.0 306686.0 24945.4 25091.7 25396.1 25518.2 25591.7 41756.4 41938.8 42170.8 42204.4 42613.4 36431.8 36693.7 36815.0 37023.4 37113.0 35663.5 35876.0 35881.0 36808.6 36848.8 34905.1 35284.6 35392.0 35725.0 35727.1 31844.2 32674.0 32709.0 32754.8 33110.0 24474.6 25178.9 25313.2 25369.5 25566.5 22:55:49 INFO - PROCESS | 7781 | 22:55:49 INFO - PROCESS | 7781 | [#2] jquery.html Cycles:180 Average:22980.20 Median:26393.63 stddev:60952.01 (230.9%) stddev-sans-first:61099.33 22:55:49 INFO - PROCESS | 7781 | Values: 357.4 365.7 366.7 374.1 376.2 15953.0 16310.7 17041.1 17069.9 17078.8 14137.8 15218.6 15257.0 15259.2 15270.3 4698.4 5079.8 5104.5 5105.4 5112.8 4991.1 5005.6 5018.8 5037.6 5045.5 4810.5 4973.7 4975.1 5043.6 5046.7 5005.6 5007.0 5008.8 5016.0 5037.8 4477.2 4500.6 4783.7 4835.2 4871.0 11815.9 11919.9 11935.3 11943.2 12484.0 1711.0 1722.1 1850.6 1931.8 2020.5 8648.8 8725.3 8985.5 9098.4 9252.2 1663.2 1664.3 1698.6 1748.8 1768.6 48955.5 64653.7 67737.7 69118.0 70139.0 9513.2 9610.1 9693.3 9775.0 10060.6 13299.1 13324.5 13336.8 13437.5 13456.3 7362.6 7476.8 7511.8 7637.5 7647.4 7259.7 7321.4 7341.0 7423.4 7456.1 4183.3 4236.4 4238.8 4256.4 4368.3 1764.6 1778.8 1797.0 1797.6 1817.3 851.5 872.3 905.6 960.6 968.9 16405.6 16940.8 17122.6 17293.8 17345.3 820.3 852.3 875.5 915.1 971.1 9397.3 9594.4 9696.2 9704.7 9814.4 364478.0 365948.0 369319.0 371539.0 372367.0 74671.3 77095.0 77285.6 77750.6 78327.2 872.2 878.7 889.6 891.3 898.9 14882.8 15026.5 15160.1 15297.2 15363.5 33310.0 33932.5 34386.8 34901.5 34914.7 45719.5 47513.0 47751.5 47936.8 47976.8 7194.5 7217.9 7260.2 7318.2 7350.0 9065.0 11372.9 11563.9 11581.4 11734.9 9117.8 10032.4 10196.3 10317.2 10467.4 9890.3 9902.3 9963.2 9981.8 9992.8 10325.6 10348.5 10414.5 10417.4 10462.7 7354.9 7433.9 7582.9 7602.8 7676.7 7770.5 9637.5 10215.4 10286.5 10391.4 22:55:49 INFO - PROCESS | 7781 | 22:55:49 INFO - PROCESS | 7781 | [#3] mootools.html Cycles:180 Average:5147.03 Median:5360.18 stddev:2898.98 (54.1%) stddev-sans-first:2893.43 22:55:49 INFO - PROCESS | 7781 | Values: 1398.3 1433.7 1521.3 1704.6 1707.9 6335.3 7273.8 7405.6 7845.8 7865.7 7513.7 7789.3 7870.1 7874.0 7883.2 2123.6 2150.9 2162.6 2169.2 2169.6 2081.2 2125.5 2152.0 2155.7 2166.9 2162.6 2164.9 2167.5 2186.1 2188.1 2117.4 2119.9 2121.9 2123.7 2132.7 2085.6 2086.9 2118.7 2141.7 2147.2 7833.5 7840.9 7844.7 7904.7 7919.0 4370.1 4498.0 4536.4 4541.1 4546.1 2756.2 2813.2 2878.6 2882.9 2892.6 879.5 926.5 935.7 979.0 983.2 10636.3 10699.7 10702.3 10730.6 10802.8 3881.8 3905.8 4025.4 4030.4 4050.8 9077.1 9111.4 9145.2 9184.6 9185.7 4494.8 4526.8 4556.7 4563.8 4574.3 3460.3 3905.1 4116.5 4193.2 4193.6 3648.4 3653.0 3745.8 3746.3 3803.8 1148.4 1202.4 1204.2 1214.3 1216.6 664.8 794.3 813.0 821.6 822.6 4587.6 5229.6 5524.8 5607.9 5787.7 846.2 852.5 889.4 913.0 930.7 3610.8 3643.3 3793.5 3808.8 3846.2 9432.7 9573.7 9770.7 9788.6 9796.1 9580.0 9624.1 9635.4 9636.7 9643.1 6776.6 7268.5 7344.2 7422.2 7429.0 5260.4 5306.3 5311.3 5332.8 5387.6 8751.6 8829.7 9096.7 9125.8 9148.7 8917.6 9160.9 9195.9 9207.7 9257.6 5945.9 6634.1 6844.2 6897.1 7039.6 7536.7 7670.7 7671.1 7688.9 7703.0 6626.9 6921.5 6973.6 6976.5 7030.0 6810.0 6830.1 6843.3 6871.7 7002.4 5995.8 6230.4 6406.9 6428.1 6463.5 4471.6 4503.0 4565.8 4566.7 4696.0 4647.8 4745.4 4767.8 4801.1 4813.4 22:55:49 INFO - PROCESS | 7781 | 22:55:49 INFO - PROCESS | 7781 | [#4] prototype.html Cycles:180 Average:4292.42 Median:4979.14 stddev:1289.27 (25.9%) stddev-sans-first:1257.18 22:55:49 INFO - PROCESS | 7781 | Values: 277.8 277.8 280.4 282.7 288.9 4985.4 5023.8 5031.9 5035.1 5048.9 4930.7 4936.2 4947.2 4972.9 4988.3 3600.5 3701.0 3728.8 3756.3 3804.9 3758.0 3766.0 3767.4 3773.0 3782.6 3758.0 3758.4 3764.6 3767.3 3773.4 3576.7 3752.3 3754.3 3767.5 3781.9 3233.9 3237.1 3273.6 3280.8 3288.8 4664.8 4688.4 4729.3 4737.4 4738.2 4278.8 4298.4 4307.8 4332.4 4343.0 5034.4 5159.9 5170.3 5181.0 5194.8 3547.8 3563.1 3564.3 3570.9 3573.9 5403.6 5406.4 5412.9 5435.5 5447.3 3530.5 3631.6 3639.4 3640.9 3651.0 3646.7 3664.9 3670.1 3672.1 3688.9 4280.1 4289.9 4297.3 4302.1 4305.0 4958.5 5231.0 5234.0 5242.6 5250.2 1265.6 1271.9 1274.6 1274.9 1275.3 781.3 795.9 802.1 816.2 821.7 4515.9 4562.6 4585.2 4611.1 4618.7 5400.5 5437.2 5459.0 5463.5 5475.2 4433.4 4513.6 4588.7 4650.9 4652.5 2818.7 2852.8 2873.8 2881.6 2895.5 5079.9 5096.7 5096.9 5108.2 5111.9 5226.1 5461.2 5502.9 5513.7 5600.4 5132.8 5133.3 5135.3 5156.6 5180.4 5410.8 5414.6 5425.7 5430.7 5463.6 5181.7 5268.8 5289.3 5307.8 5353.3 5137.7 5157.5 5157.5 5178.8 5189.8 3797.5 3809.4 3821.9 3823.6 3825.2 5153.7 5337.9 5339.8 5359.8 5419.6 5195.7 5197.5 5201.0 5201.3 5207.5 5177.9 5194.9 5208.5 5209.8 5222.2 4967.2 5143.8 5144.0 5150.0 5181.8 5008.2 5012.3 5249.0 5251.6 5283.7 5156.3 5162.8 5163.8 5167.2 5188.9 22:55:49 INFO - PROCESS | 7781 | 22:55:49 INFO - PROCESS | 7781 | [#5] yui.html Cycles:180 Average:16066.86 Median:22498.88 stddev:21431.63 (95.3%) stddev-sans-first:21460.27 22:55:49 INFO - PROCESS | 7781 | Values: 595.8 598.3 618.6 631.2 727.5 11669.5 12256.0 12468.7 14342.4 14902.1 14575.9 14728.6 14780.5 14781.3 14782.5 628.0 783.0 794.9 797.1 808.9 797.1 797.9 798.6 800.6 803.4 838.4 839.0 844.3 845.2 846.4 834.3 835.3 837.8 837.9 839.9 606.4 607.6 612.0 612.1 612.7 12461.3 12549.1 12553.2 12572.2 12594.1 12188.0 12401.4 12479.9 12639.3 12744.3 10068.9 10286.8 10447.4 10451.6 10633.9 3226.9 3272.7 3283.3 3288.4 3317.8 59280.7 59322.8 60256.0 60626.1 61183.7 9874.5 10025.2 10047.5 10080.6 10230.4 15985.4 16007.7 16008.2 16130.9 16328.6 6687.5 6764.0 6923.4 6924.1 6954.2 3727.4 3773.2 3783.9 3797.2 3810.2 2825.3 2891.9 2893.7 2911.5 2935.3 492.3 500.6 508.3 510.0 512.4 449.6 568.6 592.3 603.8 605.3 8341.5 8346.5 8496.7 8589.1 8633.7 546.0 578.7 585.4 589.7 602.3 3902.0 4008.1 4017.6 4063.9 4078.3 54517.7 55490.7 55809.7 56208.7 77897.6 61583.4 78666.6 78993.2 80562.6 81971.2 71787.0 71973.3 72681.0 73309.6 73636.0 7026.8 7099.8 7137.1 7145.5 7158.1 31328.5 37869.2 37936.8 40919.5 41817.0 58292.1 58644.7 59148.0 59169.0 60408.4 11022.8 11139.5 11173.2 11293.7 11441.3 12391.3 12437.4 12668.5 12727.0 12922.5 11721.5 11837.8 11899.9 11990.8 12458.2 11926.6 11965.8 11971.6 12077.4 12390.2 11610.4 11733.2 11833.2 12086.6 12457.5 9965.7 10074.4 10099.7 10306.1 10526.4 10063.3 10100.5 10153.9 10212.0 10273.8 22:55:49 INFO - PROCESS | 7781 | -------- Summary: end -------- 22:55:49 INFO - PROCESS | 7781 | 22:55:50 INFO - TEST-INFO | 7781: exit 0 22:55:50 INFO - TEST-OK | dromaeo_css | took 1114934ms 22:55:50 INFO - TEST-START | kraken 22:55:50 INFO - operating with platform_type : linux_ 22:55:50 INFO - Initialising browser for kraken test... 22:55:50 INFO - TEST-INFO | started process 8017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9IrWb3/profile http://localhost:53075/getInfo.html) 22:55:54 INFO - PROCESS | 8017 | __metrics Screen width/height:1600/1200 22:55:54 INFO - PROCESS | 8017 | colorDepth:24 22:55:54 INFO - PROCESS | 8017 | Browser inner width/height: 1024/697 22:55:54 INFO - PROCESS | 8017 | __metrics 22:55:55 ERROR - PROCESS | 8017 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 22:55:56 INFO - TEST-INFO | 8017: exit 0 22:55:56 INFO - Browser initialized. 22:55:56 INFO - Running cycle 1/1 for kraken test... 22:55:56 INFO - TEST-INFO | started process 8133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9IrWb3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:56:08 INFO - PROCESS | 8133 | RSS: Main: 168599552 22:56:08 INFO - PROCESS | 8133 | 22:56:11 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53075/tests/kraken/driver.html?testName=audio-beat-detection) 22:56:12 INFO - PROCESS | 8133 | RSS: Main: 172646400 22:56:12 INFO - PROCESS | 8133 | 22:56:14 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53075/tests/kraken/driver.html?testName=audio-dft) 22:56:15 INFO - PROCESS | 8133 | RSS: Main: 172695552 22:56:15 INFO - PROCESS | 8133 | 22:56:18 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53075/tests/kraken/driver.html?testName=audio-fft) 22:56:19 INFO - PROCESS | 8133 | RSS: Main: 168931328 22:56:19 INFO - PROCESS | 8133 | 22:56:21 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53075/tests/kraken/driver.html?testName=audio-oscillator) 22:56:21 INFO - PROCESS | 8133 | RSS: Main: 169308160 22:56:21 INFO - PROCESS | 8133 | 22:56:24 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53075/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:56:24 INFO - PROCESS | 8133 | RSS: Main: 169275392 22:56:24 INFO - PROCESS | 8133 | 22:56:27 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53075/tests/kraken/driver.html?testName=imaging-darkroom) 22:56:28 INFO - PROCESS | 8133 | RSS: Main: 169431040 22:56:28 INFO - PROCESS | 8133 | 22:56:32 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53075/tests/kraken/driver.html?testName=imaging-desaturate) 22:56:32 INFO - PROCESS | 8133 | RSS: Main: 166891520 22:56:32 INFO - PROCESS | 8133 | 22:56:35 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53075/tests/kraken/driver.html?testName=json-parse-financial) 22:56:36 INFO - PROCESS | 8133 | RSS: Main: 168460288 22:56:36 INFO - PROCESS | 8133 | 22:56:38 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53075/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:56:38 INFO - PROCESS | 8133 | RSS: Main: 168607744 22:56:38 INFO - PROCESS | 8133 | 22:56:40 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53075/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:56:41 INFO - PROCESS | 8133 | RSS: Main: 169132032 22:56:41 INFO - PROCESS | 8133 | 22:56:43 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53075/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:56:44 INFO - PROCESS | 8133 | RSS: Main: 169340928 22:56:44 INFO - PROCESS | 8133 | 22:56:47 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53075/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:56:47 INFO - PROCESS | 8133 | RSS: Main: 169213952 22:56:47 INFO - PROCESS | 8133 | 22:56:50 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53075/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:56:51 INFO - PROCESS | 8133 | RSS: Main: 168984576 22:56:51 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | Cycle 1(1): loaded http://localhost:53075/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53075/tests/kraken/driver.html?testName=ai-astar) 22:56:53 INFO - PROCESS | 8133 | RSS: Main: 169824256 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | __start_tp_report 22:56:53 INFO - PROCESS | 8133 | _x_x_mozilla_page_load 22:56:53 INFO - PROCESS | 8133 | _x_x_mozilla_page_load_details 22:56:53 INFO - PROCESS | 8133 | |i|pagename|runs| 22:56:53 INFO - PROCESS | 8133 | |0;ai-astar;118;115;113;115;115;115;116;114;113;114 22:56:53 INFO - PROCESS | 8133 | |1;audio-beat-detection;158;133;161;188;139;168;163;134;194;132 22:56:53 INFO - PROCESS | 8133 | |2;audio-dft;163;162;167;170;163;164;163;164;163;163 22:56:53 INFO - PROCESS | 8133 | |3;audio-fft;77;76;77;181;77;76;75;77;157;76 22:56:53 INFO - PROCESS | 8133 | |4;audio-oscillator;88;86;148;87;86;88;139;88;87;146 22:56:53 INFO - PROCESS | 8133 | |5;imaging-gaussian-blur;118;118;118;118;118;118;119;119;118;118 22:56:53 INFO - PROCESS | 8133 | |6;imaging-darkroom;148;147;149;149;147;148;148;149;148;147 22:56:53 INFO - PROCESS | 8133 | |7;imaging-desaturate;96;95;96;96;97;97;96;96;96;96 22:56:53 INFO - PROCESS | 8133 | |8;json-parse-financial;64;63;65;63;65;66;65;65;64;64 22:56:53 INFO - PROCESS | 8133 | |9;json-stringify-tinderbox;66;66;65;68;65;66;66;66;66;65 22:56:53 INFO - PROCESS | 8133 | |10;stanford-crypto-aes;84;87;86;86;85;91;93;85;118;91 22:56:53 INFO - PROCESS | 8133 | |11;stanford-crypto-ccm;136;150;135;136;136;131;134;142;143;137 22:56:53 INFO - PROCESS | 8133 | |12;stanford-crypto-pbkdf2;170;170;172;173;174;171;170;167;168;171 22:56:53 INFO - PROCESS | 8133 | |13;stanford-crypto-sha256-iterative;68;68;68;69;67;67;68;67;66;68 22:56:53 INFO - PROCESS | 8133 | __end_tp_report 22:56:53 INFO - PROCESS | 8133 | __start_cc_report 22:56:53 INFO - PROCESS | 8133 | _x_x_mozilla_cycle_collect,958 22:56:53 INFO - PROCESS | 8133 | __end_cc_report 22:56:53 INFO - PROCESS | 8133 | __startTimestamp1465451813348__endTimestamp 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | ------- Summary: start ------- 22:56:53 INFO - PROCESS | 8133 | Number of tests: 14 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:1.48 (1.3%) stddev-sans-first:1.01 22:56:53 INFO - PROCESS | 8133 | Values: 118.0 115.0 113.0 115.0 115.0 115.0 116.0 114.0 113.0 114.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:162.00 stddev:22.50 (13.9%) stddev-sans-first:23.87 22:56:53 INFO - PROCESS | 8133 | Values: 158.0 133.0 161.0 188.0 139.0 168.0 163.0 134.0 194.0 132.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.44 (1.5%) stddev-sans-first:2.55 22:56:53 INFO - PROCESS | 8133 | Values: 163.0 162.0 167.0 170.0 163.0 164.0 163.0 164.0 163.0 163.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.50 stddev:39.47 (51.6%) stddev-sans-first:41.33 22:56:53 INFO - PROCESS | 8133 | Values: 77.0 76.0 77.0 181.0 77.0 76.0 75.0 77.0 157.0 76.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:87.00 stddev:27.73 (31.9%) stddev-sans-first:28.77 22:56:53 INFO - PROCESS | 8133 | Values: 88.0 86.0 148.0 87.0 86.0 88.0 139.0 88.0 87.0 146.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:56:53 INFO - PROCESS | 8133 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 119.0 119.0 118.0 118.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 22:56:53 INFO - PROCESS | 8133 | Values: 148.0 147.0 149.0 149.0 147.0 148.0 148.0 149.0 148.0 147.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:56:53 INFO - PROCESS | 8133 | Values: 96.0 95.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 22:56:53 INFO - PROCESS | 8133 | Values: 64.0 63.0 65.0 63.0 65.0 66.0 65.0 65.0 64.0 64.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 22:56:53 INFO - PROCESS | 8133 | Values: 66.0 66.0 65.0 68.0 65.0 66.0 66.0 66.0 66.0 65.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:86.50 stddev:10.10 (11.7%) stddev-sans-first:10.43 22:56:53 INFO - PROCESS | 8133 | Values: 84.0 87.0 86.0 86.0 85.0 91.0 93.0 85.0 118.0 91.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:136.50 stddev:5.50 (4.0%) stddev-sans-first:5.78 22:56:53 INFO - PROCESS | 8133 | Values: 136.0 150.0 135.0 136.0 136.0 131.0 134.0 142.0 143.0 137.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.00 stddev:2.12 (1.2%) stddev-sans-first:2.24 22:56:53 INFO - PROCESS | 8133 | Values: 170.0 170.0 172.0 173.0 174.0 171.0 170.0 167.0 168.0 171.0 22:56:53 INFO - PROCESS | 8133 | 22:56:53 INFO - PROCESS | 8133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 22:56:53 INFO - PROCESS | 8133 | Values: 68.0 68.0 68.0 69.0 67.0 67.0 68.0 67.0 66.0 68.0 22:56:53 INFO - PROCESS | 8133 | -------- Summary: end -------- 22:56:53 INFO - PROCESS | 8133 | 22:56:54 INFO - TEST-INFO | 8133: exit 0 22:56:54 INFO - TEST-OK | kraken | took 64287ms 22:56:54 INFO - SUITE-END | took 1179s 22:56:54 INFO - Completed test suite (00:19:39) 22:56:54 INFO - javascript benchmark 22:56:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6268.497646004968, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.446346267284, 2704.594310853371, 2718.768904643105, 2720.891164353426, 2734.5898115282707, 4748.976255118724, 4756.643251756119, 4776.71339719617, 4824.179889418799, 4846.369971903648, 4534.34252033455, 4575.8169673213115, 4599.908001839961, 4637.605803506706, 4657.673962822604, 4248.745075295476, 4272.4232228649125, 4409.4488188976375, 4463.107378524292, 4516.322551617267, 4384.62730667892, 4419.4033805436175, 4468.620167285784, 4535.501094879577, 4542.409486766715, 157.73728583084045, 4487.820487180509, 4512.954870451286, 4534.251848445003, 4559.680822342438, 4410.911781764379, 4424.823007079713, 4436.245838207513, 4453.242948698729, 4471.28459446487, 4354.782260886943, 4357.0, 4360.258756011485, 4361.847335343279, 4413.691041627056, 4587.9082418351445, 4607.308903664477, 4655.301704744282, 4657.11514812188, 4690.695104818176, 5093.312402825608, 5102.591792656579, 5103.668261562986, 5108.974455127738, 5152.046871328816, 5118.974405127988, 5122.29440469417, 5151.6908985461, 5155.355580552431, 5194.065068287707, 4738.1708201064675, 4754.548317909793, 4760.071786001731, 4775.617950563947, 4789.090072886141, 5185.533302002837, 5197.272381866542, 5245.816396426107, 5264.605154613343, 5277.155655095166, 5059.468755780664, 5073.0, 5074.492550744896, 5077.796888124508, 5083.593312534988, 4962.925556116661, 5146.279520867081, 5158.664686795421, 5168.715720635326, 5243.318368612132, 5134.306868572695, 5201.687898726089, 5206.323177986837, 5212.400573934046, 5262.868483276114, 4963.751812409438, 5139.177731563007, 5164.974175129176, 5184.196449550326, 5200.817971370984, 4273.380359847804, 4276.144771045803, 4295.978520107442, 4296.312589985588, 4309.375140604658, 3676.7242456815848, 3709.295233905549, 3748.5314335708035, 3770.3401904666575, 3773.64150405711, 4294.441722576045, 4425.889352766207, 4434.3348497724955, 4458.130664520388, 4505.61702255312, 5072.54347108762, 5082.161443361878, 5145.588352931756, 5155.510226528474, 5162.045021671003, 4411.2721400968485, 4421.0, 4421.801018954155, 4422.314541246112, 4462.732236065846, 4398.054418300081, 4523.864284071483, 4578.473475550288, 4586.220342541709, 4607.124646317189, 4803.567678908915, 4873.780679869344, 4874.439439464507, 4877.292792545132, 4908.8772780680765, 5132.358455193101, 5176.456472070378, 5179.093658609653, 5180.430152683127, 5184.766685499086, 4666.580007799314, 4701.976490117528, 4706.670533062653, 4859.538343857328, 4942.28336891156, 4994.5754610858485, 5001.874953126201, 5053.0, 5053.949460505348, 5066.442691304027, 5134.05020071288, 5153.381594208569, 5155.484451554815, 5155.561777248976, 5198.584113270854, 4863.148948933852, 4897.681650692693, 4979.477154898684, 4981.452040275639, 5014.84955451337, 4909.239067944474, 4947.0, 4949.480304567968, 4962.950370496394, 5005.724685142352, 4844.8304309349005, 4868.756562171948, 4871.951280487291, 4876.4392094909535, 4912.38595175603, 4885.609151267961, 4911.508849115203, 4966.453690094015, 4974.0, 5023.296738456692, 4887.169181239269, 4900.240462728283, 4903.41457588998, 4917.9016419672125, 4937.629677774253], "value": 4662.381781904951, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.2203411806107, 575.7006356694518, 578.878435528539, 596.4423264247929, 610.3774150366629, 37878.0, 38830.80584597077, 38854.805725971404, 38934.61065389349, 39030.0, 38850.61149388505, 39158.0, 39160.21679566407, 39230.0, 39270.0, 7760.874673172372, 7874.763757087297, 7886.487378320391, 7918.4457088003865, 7920.049594048723, 7825.6087195640275, 7841.21587841217, 7901.96049019757, 7915.327197188217, 7925.088614809313, 7875.763727088197, 7897.8025549361155, 7942.285194332509, 7948.046234451845, 7956.443048986544, 7839.686412543491, 7871.21287871214, 7910.208979102073, 7915.643796029135, 7930.088039875402, 7800.336971357441, 7809.765707028798, 7845.803854903616, 7856.567888766115, 7862.528248305063, 29044.12867613975, 36413.0, 36747.08132296687, 36791.4481282781, 37354.81322593397, 3012.186709588399, 3039.863206155728, 3056.419280336729, 3127.9061628151194, 3542.167590616229, 26779.0, 27029.729702703116, 27075.323116922038, 27092.864535677392, 27562.724372756216, 3361.478970759512, 3391.2030672791875, 3466.1507930557177, 3498.265364273506, 3506.7720598161036, 259164.0, 260989.0, 261609.0, 262319.0, 262513.0, 31463.685363146535, 32883.50674739881, 55273.72363138159, 55433.44566554364, 55521.72239138778, 33014.8349258257, 33015.66984330174, 33324.3335133296, 33327.66672333294, 33585.16037099092, 13726.794098088536, 14003.159810411407, 14025.5091071812, 14047.297635118408, 14067.2966351682, 10859.13126949842, 10946.343219406861, 10949.616763413242, 10954.616588419367, 10956.506957186946, 7760.146383897767, 7869.803254918673, 7967.641456134488, 7982.481138725964, 8008.479448835924, 3116.67274936133, 3120.2979329651102, 3124.0627811656414, 3143.072793525915, 3148.7323577496168, 872.8908886389202, 874.0822136756381, 945.7115579748105, 962.3936919740519, 994.5126887824914, 26590.335241618726, 27853.721462785114, 28027.439451210863, 28258.576121358197, 28433.57349639757, 975.1711045611315, 992.4987881120132, 1005.1857995024054, 1006.4665727164614, 1013.8529913162697, 14625.0, 15085.3211605478, 15109.0, 15161.166135862413, 15413.460528881435, 361240.0, 361422.0, 364202.0, 365117.0, 366158.0, 32951.1762205942, 33058.0, 33090.17274568155, 33094.83452582722, 33151.66848331534, 1194.3431112887877, 1240.4418011894504, 1241.050596293836, 1245.7197130645714, 1247.5820600099069, 25636.23091307264, 27621.30946726348, 27675.49306970011, 27984.72015279821, 28229.858850705616, 42079.36880946727, 42768.0, 42783.3582496269, 42948.78525607352, 42983.355249670654, 305248.0, 305382.0, 305527.0, 305964.0, 306686.0, 24945.37636559028, 25091.74908250894, 25396.111136110147, 25518.23445296644, 25591.744082559682, 41756.3736543946, 41938.79030604827, 42170.78914605407, 42204.36693449662, 42613.36079958865, 36431.817840910626, 36693.71571994967, 36815.0, 37023.444648330835, 37113.0, 35663.46504802378, 35876.0, 35881.0, 36808.631913681595, 36848.81575592105, 34905.12737181591, 35284.64715352814, 35392.0, 35725.0, 35727.106822329646, 31844.203894901886, 32674.0, 32709.0, 32754.83622581872, 33110.0, 24474.632880507164, 25178.874105629355, 25313.240602781945, 25369.492610148063, 25566.506150352903], "value": 16217.170886850094, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.43346795329387, 365.67272291299287, 366.68648305698633, 374.12454855637804, 376.1874351400974, 15953.0, 16310.673786524278, 17041.06274154921, 17069.914650426763, 17078.829211707878, 14137.787933180985, 15218.619534511643, 15257.0, 15259.160746158957, 15270.312835922383, 4698.389209402773, 5079.771410286546, 5104.489551044884, 5105.387353517564, 5112.769925353368, 4991.07665081961, 5005.624578156635, 5018.7992480300745, 5037.622178336621, 5045.545900868921, 4810.4948980357085, 4973.726445045521, 4975.09464036661, 5043.621728370368, 5046.697198168122, 5005.6496045276845, 5007.0, 5008.84973450797, 5016.0, 5037.773300201481, 4477.171723231213, 4500.617447516965, 4783.665143439961, 4835.153848076608, 4870.951290487085, 11815.94092029543, 11919.94040029803, 11935.343556104412, 11943.223690460092, 12484.0, 1711.0, 1722.1045056570513, 1850.611371611963, 1931.777845547766, 2020.5251765835017, 8648.783780405478, 8725.258353039999, 8985.46087234768, 9098.363114581982, 9252.16730494252, 1663.1767275198733, 1664.25108701085, 1698.5583748225426, 1748.8163742806948, 1768.6109056007658, 48955.51044489545, 64653.67673161604, 67737.66131169362, 69118.0, 70139.0, 9513.191378732747, 9610.135087842127, 9693.273004524688, 9774.95112524447, 10060.647877324258, 13299.13555618901, 13324.533641322507, 13336.799948000787, 13437.529686460926, 13456.25990570528, 7362.631868406558, 7476.775696729107, 7511.774646760606, 7637.4653774236385, 7647.426443016796, 7259.709611615582, 7321.377682897013, 7341.045664063638, 7423.4061275097865, 7456.105267367951, 4183.309753890635, 4236.449261596034, 4238.817009240243, 4256.404103425523, 4368.301071828492, 1764.6117854072083, 1778.8043315235313, 1796.9640607187782, 1797.5506123469133, 1817.2730907636787, 851.5188918261163, 872.3152325424638, 905.5608030105394, 960.6109525642127, 968.8692026576463, 16405.58986025359, 16940.83059169417, 17122.571935701708, 17293.827061729222, 17345.306187752347, 820.2658620534588, 852.2968550945495, 875.4747151709051, 915.1443400420628, 971.0774763974111, 9397.342186046912, 9594.376365536218, 9696.224302055818, 9704.660336888175, 9814.362066465657, 364478.0, 365948.0, 369319.0, 371539.0, 372367.0, 74671.25328746643, 77095.0, 77285.61357193178, 77750.6112469434, 78327.21672783313, 872.1932212703351, 878.6529320918202, 889.621910687968, 891.2869704236584, 898.9325800564984, 14882.77675834885, 15026.474073407378, 15160.09039457636, 15297.158656274012, 15363.539093827203, 33310.0, 33932.49101263434, 34386.82806585951, 34901.476477852346, 34914.65085349114, 45719.54280457286, 47513.0, 47751.52248477471, 47936.7603161982, 47976.7601161992, 7194.532355396883, 7217.855642887008, 7260.237675044255, 7318.1584117825005, 7349.963250183929, 9065.0, 11372.886271137182, 11563.942180289045, 11581.420928953687, 11734.882651173379, 9117.77205569866, 10032.398056116657, 10196.286259961731, 10317.226208034277, 10467.371957682564, 9890.258230632588, 9902.306838521523, 9963.202943764336, 9981.750456238362, 9992.750181245527, 10325.63860264887, 10348.53431595595, 10414.47927603632, 10417.374957502574, 10462.68611941643, 7354.852902942018, 7433.9256607433235, 7582.924170758221, 7602.8099297518, 7676.654550545127, 7770.45606807518, 9637.469939153134, 10215.438150901771, 10286.485675716334, 10391.428471433841], "value": 7848.565162518959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.307837620378, 1433.6774225799197, 1521.2621878388986, 1704.5568152280403, 1707.9316827326907, 6335.334789847057, 7273.818154546139, 7405.629718514079, 7845.76462706119, 7865.685372585097, 7513.699452021912, 7789.298963093321, 7870.055593328809, 7874.0, 7883.211678832114, 2123.638981373166, 2150.9032093555747, 2162.6215412302863, 2169.208238992764, 2169.6203164446238, 2081.1779347157863, 2125.5217576045343, 2152.0208305221163, 2155.7305336832897, 2166.945826354346, 2162.5999190149796, 2164.9134034638596, 2167.468970102327, 2186.1036974840317, 2188.081005977493, 2117.396541985542, 2119.9152033918626, 2121.893905304736, 2123.734533183352, 2132.658774596073, 2085.603735290305, 2086.9478263043393, 2118.682197670362, 2141.7001619773246, 2147.2162660628915, 7833.529988200669, 7840.921590784076, 7844.686212551491, 7904.683812647487, 7919.049714034353, 4370.147821174872, 4498.0, 4536.4102666653125, 4541.091781643651, 4546.113507865967, 2756.1593713917246, 2813.2404250852155, 2878.6113874626867, 2882.8990985315622, 2892.638420197475, 879.5338470610586, 926.5129467205106, 935.714607044851, 979.0405402705318, 983.1937810994987, 10636.30863993838, 10699.679009629723, 10702.250842441032, 10730.570777168827, 10802.783944321069, 3881.80590970456, 3905.7656540607086, 4025.4163146343617, 4030.3954406839207, 4050.7569545827346, 9077.092290771003, 9111.407758495676, 9145.222656074175, 9184.63261469547, 9185.724428267162, 4494.820207191676, 4526.773661316987, 4556.658250631216, 4563.817447302071, 4574.336721175411, 3460.325236578843, 3905.1213476967455, 4116.5060192777055, 4193.203291374629, 4193.622573968358, 3648.379775438129, 3652.9634703652623, 3745.8127093645207, 3746.250749850041, 3803.82882770276, 1148.3970915269551, 1202.4108186988312, 1204.1811568133753, 1214.319980810731, 1216.5741990303322, 664.8404382948057, 794.3367288314207, 812.9878051829228, 821.5850995247481, 822.6462621072876, 4587.587117159472, 5229.555487783505, 5524.751386187631, 5607.859803504945, 5787.652740835563, 846.1580727176499, 852.5311078906576, 889.4307643108416, 912.9634814607474, 930.6882194464795, 3610.8014059226994, 3643.3259846928404, 3793.5447746270625, 3808.8476460941806, 3846.2307538492414, 9432.669856555125, 9573.664921727706, 9770.658026969022, 9788.55951482185, 9796.069373409515, 9580.0, 9624.085711857362, 9635.421874687541, 9636.662716804878, 9643.08390702882, 6776.55952363085, 7268.454865884974, 7344.155422126417, 7422.220666829905, 7429.0, 5260.44765299638, 5306.310179676618, 5311.256424100552, 5332.786688532416, 5387.568994480511, 8751.606177722146, 8829.735107946772, 9096.681616143404, 9125.817483650157, 9148.679796207101, 8917.598708058284, 9160.908390916273, 9195.862062069207, 9207.677731279373, 9257.629694812133, 5945.851353716019, 6634.0712300278965, 6844.247132815486, 6897.137857767779, 7039.612821294878, 7536.698532058656, 7670.693172273047, 7671.117821450382, 7688.884666730115, 7702.961485192538, 6626.900596491153, 6921.515493915377, 6973.58158510491, 6976.4767642426, 7030.0, 6809.965950170217, 6830.146231721035, 6843.315668433117, 6871.690773915286, 7002.3697867192195, 5995.790147344822, 6230.43926046658, 6406.935930640634, 6428.067930150009, 6463.547551671526, 4471.642268618568, 4503.0, 4565.77171141435, 4566.657500687395, 4696.013837094249, 4647.790849411852, 4745.430548334222, 4767.809287628595, 4801.135795556834, 4813.3983252093485], "value": 4138.974924010848, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.8263585259213, 277.8374650829265, 280.35937881939765, 282.67492383758673, 288.86712112428285, 4985.376827896513, 5023.824166154185, 5031.924521132181, 5035.093683137034, 5048.899022019562, 4930.679505832119, 4936.210206366982, 4947.233178857283, 4972.900541989167, 4988.3265759122505, 3600.459931010343, 3701.0377301901567, 3728.7949162796035, 3756.3426400379963, 3804.9429258561004, 3758.0, 3766.0436557302523, 3767.4348847672795, 3772.9624353302925, 3782.602826703198, 3757.9812100939594, 3758.4174452959833, 3764.623537646241, 3767.2842159989514, 3773.3962565989445, 3576.6959808416054, 3752.3302130551915, 3754.324221640131, 3767.5290588676417, 3781.924361512782, 3233.9353212935844, 3237.077432931603, 3273.639899611041, 3280.769711358241, 3288.819114948677, 4664.813407463697, 4688.390509233778, 4729.266963620645, 4737.418107131622, 4738.218193997986, 4278.7860606969525, 4298.398224248608, 4307.82768689252, 4332.371806088099, 4343.0, 5034.446210916796, 5159.916417552281, 5170.3278573785165, 5180.9740951295, 5194.818181363672, 3547.7516573839844, 3563.1448452371246, 3564.3405969895653, 3570.857325655791, 3573.874914377984, 5403.621746477748, 5406.35088806486, 5412.864678383033, 5435.510804027656, 5447.346318441772, 3530.5233793437556, 3631.6368363164, 3639.4358874374516, 3640.927181456409, 3650.9634903651154, 3646.7082633389264, 3664.871729489455, 3670.1191713988983, 3672.1186915140174, 3688.9262214755554, 4280.143971205771, 4289.935650965238, 4297.333913243452, 4302.118065796504, 4305.0, 4958.454569997298, 5231.03836061477, 5233.973830130901, 5242.580593552583, 5250.238715386324, 1265.5886836778084, 1271.8664540223328, 1274.5539061328461, 1274.8661390554043, 1275.2730943362194, 781.2773184804033, 795.944283900133, 802.1497212954287, 816.2368185746227, 821.708293555791, 4515.88710282239, 4562.61217796491, 4585.188850404072, 4611.123886461562, 4618.67669263155, 5400.513953744182, 5437.211604317352, 5458.972705136449, 5463.535599474089, 5475.206095116186, 4433.357163211316, 4513.571210734975, 4588.655850811202, 4650.883727906829, 4652.488226295105, 2818.7040360762235, 2852.774835628213, 2873.7700983921236, 2881.639795025622, 2895.5077636801793, 5079.873003174876, 5096.668716533413, 5096.878686688922, 5108.233764935215, 5111.948880511147, 5226.092476246219, 5461.208124821878, 5502.9174562381595, 5513.696746678971, 5600.411956744565, 5132.820351287687, 5133.307003554472, 5135.306733590917, 5156.587473002151, 5180.378354597472, 5410.83767486976, 5414.593905457185, 5425.674459532441, 5430.728463576885, 5463.644863083887, 5181.740912954413, 5268.761840967293, 5289.338832645919, 5307.787688492417, 5353.277307563585, 5137.743112844418, 5157.458466861076, 5157.504323746071, 5178.844634660966, 5189.844304670866, 3797.525309336333, 3809.4476300935653, 3821.9044523887123, 3823.636754508317, 3825.158465137665, 5153.6907785532985, 5337.919931201112, 5339.813106541253, 5359.758810853599, 5419.620626556103, 5195.74021298926, 5197.4542673020305, 5201.0, 5201.297824793755, 5207.453217412117, 5177.922331165111, 5194.922076168785, 5208.479152084761, 5209.765560549708, 5222.242774797709, 4967.180415231446, 5143.794248230179, 5144.048351055067, 5150.0, 5181.81863634771, 5008.223725322581, 5012.3233363495465, 5248.9764495924455, 5251.553617942518, 5283.735813209401, 5156.298421520814, 5162.845114646567, 5163.8192663256605, 5167.173252279617, 5188.948110518846], "value": 3869.507652990428, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.7587177193237, 598.3119412675426, 618.6380967134227, 631.1542533005772, 727.5271073802031, 11669.533218671253, 12256.0, 12468.688282792935, 14342.42630294787, 14902.105873647588, 14575.927120364384, 14728.631784205374, 14780.482683106093, 14781.260936953136, 14782.482613108543, 627.9560430769848, 782.9569373684445, 794.9165337639537, 797.0515087046397, 808.8907997420362, 797.0913158998717, 797.872340425532, 798.632628990665, 800.6117033238875, 803.4215364937236, 838.3628442383771, 838.9538575378351, 844.2823599940033, 845.2350622686479, 846.3863698818338, 834.2700137379793, 835.2941764209233, 837.7821766340795, 837.9497230166179, 839.9118092600311, 606.4178388746808, 607.5898768331359, 611.9969400153016, 612.0849330251302, 612.702839123025, 12461.314627695474, 12549.058820588401, 12553.184043037265, 12572.245665260023, 12594.118411711184, 12188.0, 12401.441935112942, 12479.93760031203, 12639.304838233893, 12744.299063551502, 10068.94965525175, 10286.845697314546, 10447.42539160346, 10451.581936722521, 10633.893661063368, 3226.8709251629907, 3272.672732726708, 3283.2612662150823, 3288.391647545212, 3317.7511686623598, 59280.70359648174, 59322.81354372888, 60256.0, 60626.090608640465, 61183.69408152975, 9874.506274686237, 10025.19798416125, 10047.497625118714, 10080.647177348757, 10230.386176829414, 15985.360585576447, 16007.679846403007, 16008.199590020686, 16130.919345403432, 16328.591785205464, 6687.465002799764, 6764.0, 6923.446124310043, 6924.134483189601, 6954.200266969363, 3727.4222495512695, 3773.2264885698364, 3783.8837542924903, 3797.1836055248255, 3810.1998580297895, 2825.321922738569, 2891.9277018074717, 2893.7250961158657, 2911.505044142501, 2935.324875278698, 492.2517772985043, 500.5945184400647, 508.2554058304602, 510.0, 512.3621091740732, 449.64702708373767, 568.5877738639535, 592.3424998251937, 603.7916918663054, 605.2736715940889, 8341.541215233221, 8346.457480263764, 8496.745097647081, 8589.103139680834, 8633.697820576375, 545.9918101228485, 578.6672663218582, 585.4467528185824, 589.7464090441151, 602.3103546439303, 3902.0, 4008.118213992917, 4017.598240175959, 4063.9390409143884, 4078.286299897565, 54517.72741136269, 55490.72254638701, 55809.72095139579, 56208.71895640578, 77897.61051194821, 61583.38416615866, 78666.6066669663, 78993.21006789974, 80562.59718701369, 81971.18028819635, 71787.0, 71973.28026719771, 72681.0, 73309.6334518324, 73636.0, 7026.789196324118, 7099.822504437224, 7137.1435427749, 7145.535540189871, 7158.105236845395, 31328.530072049394, 37869.24261514809, 37936.81031594824, 40919.482853292306, 41817.0, 58292.125618114915, 58644.70677646755, 59148.0, 59169.0, 60408.395916040274, 11022.779544409228, 11139.498722557666, 11173.223324963157, 11293.71765705831, 11441.313521188755, 12391.256524608552, 12437.37813109359, 12668.493260269486, 12727.0, 12922.483100675867, 11721.472533736172, 11837.76324473523, 11899.94050029779, 11990.820137698116, 12458.190217636187, 11926.582569610022, 11965.76068478643, 11971.64085077449, 12077.39613019363, 12390.194637348544, 11610.361430121424, 11733.178677492835, 11833.230839995373, 12086.576969806014, 12457.501699931901, 9965.701028969142, 10074.366202765501, 10099.747506312107, 10306.12397946153, 10526.368417894952, 10063.298674498139, 10100.545475453475, 10153.881271741115, 10212.0, 10273.794524109626], "value": 6382.845647624104, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 113.0, 115.0, 115.0, 115.0, 116.0, 114.0, 113.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 133.0, 161.0, 188.0, 139.0, 168.0, 163.0, 134.0, 194.0, 132.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 167.0, 170.0, 163.0, 164.0, 163.0, 164.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 181.0, 77.0, 76.0, 75.0, 77.0, 157.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 148.0, 87.0, 86.0, 88.0, 139.0, 88.0, 87.0, 146.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 149.0, 147.0, 148.0, 148.0, 149.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 65.0, 66.0, 65.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 68.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 86.0, 86.0, 85.0, 91.0, 93.0, 85.0, 118.0, 91.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 150.0, 135.0, 136.0, 136.0, 131.0, 134.0, 142.0, 143.0, 137.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 172.0, 173.0, 174.0, 171.0, 170.0, 167.0, 168.0, 171.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 67.0, 67.0, 68.0, 67.0, 66.0, 68.0], "value": 67.6, "unit": "score"}]}]} 22:56:54 INFO - Return code: 0 22:56:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:56:54 ERROR - # TBPL SUCCESS # 22:56:54 INFO - Running post-action listener: _resource_record_post_action 22:56:54 INFO - ##### 22:56:54 INFO - ##### Finished run-tests step (success) 22:56:54 INFO - ##### 22:56:54 INFO - Running post-run listener: _resource_record_post_run 22:56:54 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 541265920; Read time: 408; Write time: 466988 22:56:54 INFO - TinderboxPrint: CPU usage
13.4% 22:56:54 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 408 22:56:54 INFO - TinderboxPrint: I/O write bytes / time
541,265,920 / 466,988 22:56:54 INFO - TinderboxPrint: CPU idle
8,261.7 (86.6%) 22:56:54 INFO - TinderboxPrint: CPU user
1,226.6 (12.9%) 22:56:54 INFO - TinderboxPrint: Swap in / out
0 / 0 22:56:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 226963456; Read time: 260; Write time: 246464 22:56:54 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286285824; Read time: 148; Write time: 213528 22:56:55 INFO - Running post-run listener: _upload_blobber_files 22:56:55 INFO - Blob upload gear active. 22:56:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:56:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:56:55 INFO - (blobuploader) - INFO - Open directory for files ... 22:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:05 INFO - (blobuploader) - INFO - Done attempting. 22:57:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:57:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:57:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:06 INFO - (blobuploader) - INFO - Done attempting. 22:57:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:57:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:57:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:07 INFO - (blobuploader) - INFO - Done attempting. 22:57:07 INFO - (blobuploader) - INFO - Iteration through files over. 22:57:07 INFO - Return code: 0 22:57:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:57:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:57:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3945ff795c66eff3305bdb08970ab83429d9094a0b41da0b5d38ef442b6cd960fe6c4230826a555489d7024f4bdbc4b63ab92b7179917341c430d5b82325f093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4552892677187be6be98f254cdbb800d8705cc5e5253e7c7fb5a9d8ee5ba50689e71b58f1ffc8cd5353286d83c813800b2993fb582c7f8f5a958d6d3ac0a229", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5da01c8558e4eb823586e688ab6b1eab11026ab726c25934ff28bec71fb433268b684edc4bb127228038322f44aa161cb8b980b6a5d19feb8bf4c14af27cc448"} 22:57:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:57:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:57:07 INFO - Contents: 22:57:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3945ff795c66eff3305bdb08970ab83429d9094a0b41da0b5d38ef442b6cd960fe6c4230826a555489d7024f4bdbc4b63ab92b7179917341c430d5b82325f093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4552892677187be6be98f254cdbb800d8705cc5e5253e7c7fb5a9d8ee5ba50689e71b58f1ffc8cd5353286d83c813800b2993fb582c7f8f5a958d6d3ac0a229", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5da01c8558e4eb823586e688ab6b1eab11026ab726c25934ff28bec71fb433268b684edc4bb127228038322f44aa161cb8b980b6a5d19feb8bf4c14af27cc448"} 22:57:07 INFO - Running post-run listener: copy_logs_to_upload_dir 22:57:07 INFO - Copying logs to upload dir... 22:57:07 INFO - mkdir: /builds/slave/test/build/upload/logs 22:57:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.805875 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-08 22:57:06.912389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 22:57:06.915981) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659 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/3945ff795c66eff3305bdb08970ab83429d9094a0b41da0b5d38ef442b6cd960fe6c4230826a555489d7024f4bdbc4b63ab92b7179917341c430d5b82325f093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4552892677187be6be98f254cdbb800d8705cc5e5253e7c7fb5a9d8ee5ba50689e71b58f1ffc8cd5353286d83c813800b2993fb582c7f8f5a958d6d3ac0a229", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5da01c8558e4eb823586e688ab6b1eab11026ab726c25934ff28bec71fb433268b684edc4bb127228038322f44aa161cb8b980b6a5d19feb8bf4c14af27cc448"} build_url:https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011500 build_url: 'https://queue.taskcluster.net/v1/task/Q8-PP5qiTkmX2qCSNZ2_5Q/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/3945ff795c66eff3305bdb08970ab83429d9094a0b41da0b5d38ef442b6cd960fe6c4230826a555489d7024f4bdbc4b63ab92b7179917341c430d5b82325f093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4552892677187be6be98f254cdbb800d8705cc5e5253e7c7fb5a9d8ee5ba50689e71b58f1ffc8cd5353286d83c813800b2993fb582c7f8f5a958d6d3ac0a229", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5da01c8558e4eb823586e688ab6b1eab11026ab726c25934ff28bec71fb433268b684edc4bb127228038322f44aa161cb8b980b6a5d19feb8bf4c14af27cc448"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 22:57:06.941784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 22:57:06.942305) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1465450294.637106-1871879659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 22:57:07.024426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 22:57:07.024774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 22:57:07.025100) ========= ========= Total master_lag: 0.17 =========