builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1466669739.15 results: success (0) buildid: 20160623004325 builduid: b9bdcd29e98b4ca9b138770d1014bf34 revision: dbe8807bcf0db60680a940eaaaf01f4488c6bf22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:39.148411) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:39.148924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:39.149210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:39.166576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:39.167064) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 01:15:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.2M=0s 2016-06-23 01:15:40 (51.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:39.307750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:39.308365) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:39.359310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 01:15:39.359653) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dbe8807bcf0db60680a940eaaaf01f4488c6bf22 --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 dbe8807bcf0db60680a940eaaaf01f4488c6bf22 --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=6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 01:15:40,453 truncating revision to first 12 chars 2016-06-23 01:15:40,453 Setting DEBUG logging. 2016-06-23 01:15:40,453 attempt 1/10 2016-06-23 01:15:40,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dbe8807bcf0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 01:15:41,308 unpacking tar archive at: fx-team-dbe8807bcf0d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.240967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 01:15:40.623898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:40.624216) ========= script_repo_revision: dbe8807bcf0db60680a940eaaaf01f4488c6bf22 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:40.624625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:40.624886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 01:15:40.634613) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-23 01:15:40.634903) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:15:41 INFO - MultiFileLogger online at 20160623 01:15:41 in /builds/slave/test 01:15:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:15:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:15:41 INFO - {'append_to_log': False, 01:15:41 INFO - 'base_work_dir': '/builds/slave/test', 01:15:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:15:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:15:41 INFO - 'branch': 'Fx-Team-Non-PGO', 01:15:41 INFO - 'buildbot_json_path': 'buildprops.json', 01:15:41 INFO - 'config_files': ('talos/linux_config.py',), 01:15:41 INFO - 'default_actions': ('clobber', 01:15:41 INFO - 'read-buildbot-config', 01:15:41 INFO - 'download-and-extract', 01:15:41 INFO - 'populate-webroot', 01:15:41 INFO - 'create-virtualenv', 01:15:41 INFO - 'install', 01:15:41 INFO - 'run-tests'), 01:15:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:15:41 INFO - 'download_minidump_stackwalk': True, 01:15:41 INFO - 'download_symbols': 'ondemand', 01:15:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:15:41 INFO - 'tooltool.py': '/tools/tooltool.py', 01:15:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:15:41 INFO - '/tools/misc-python/virtualenv.py')}, 01:15:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:15:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:15:41 INFO - 'installer_path': 'installer.exe', 01:15:41 INFO - 'log_level': 'info', 01:15:41 INFO - 'log_name': 'talos', 01:15:41 INFO - 'log_to_console': True, 01:15:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:15:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:15:41 INFO - 'opt_config_files': (), 01:15:41 INFO - 'pip_index': False, 01:15:41 INFO - 'sps_profile': False, 01:15:41 INFO - 'sps_profile_interval': 0, 01:15:41 INFO - 'suite': 'dromaeojs', 01:15:41 INFO - 'system_bits': '32', 01:15:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:15:41 INFO - 'title': 'talos-linux64-ix-023', 01:15:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:15:41 INFO - 'use_talos_json': True, 01:15:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:15:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:15:41 INFO - 'work_dir': 'build'} 01:15:41 INFO - ##### 01:15:41 INFO - ##### Running clobber step. 01:15:41 INFO - ##### 01:15:41 INFO - Running pre-action listener: _resource_record_pre_action 01:15:41 INFO - Running main action method: clobber 01:15:41 INFO - rmtree: /builds/slave/test/build 01:15:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:15:42 INFO - Running post-action listener: _resource_record_post_action 01:15:42 INFO - ##### 01:15:42 INFO - ##### Finished clobber step (success) 01:15:42 INFO - ##### 01:15:42 INFO - ##### 01:15:42 INFO - ##### Running read-buildbot-config step. 01:15:42 INFO - ##### 01:15:42 INFO - Running pre-action listener: _resource_record_pre_action 01:15:42 INFO - Running main action method: read_buildbot_config 01:15:42 INFO - Using buildbot properties: 01:15:42 INFO - { 01:15:42 INFO - "project": "", 01:15:42 INFO - "product": "firefox", 01:15:42 INFO - "script_repo_revision": "production", 01:15:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:15:42 INFO - "repository": "", 01:15:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:15:42 INFO - "buildid": "20160623004325", 01:15:42 INFO - "pgo_build": "False", 01:15:42 INFO - "basedir": "/builds/slave/test", 01:15:42 INFO - "buildnumber": 3104, 01:15:42 INFO - "slavename": "talos-linux64-ix-023", 01:15:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:15:42 INFO - "platform": "ubuntu64_hw", 01:15:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:15:42 INFO - "branch": "fx-team", 01:15:42 INFO - "repo_path": "integration/fx-team", 01:15:42 INFO - "revision": "dbe8807bcf0db60680a940eaaaf01f4488c6bf22", 01:15:42 INFO - "stage_platform": "linux64", 01:15:42 INFO - "builduid": "b9bdcd29e98b4ca9b138770d1014bf34", 01:15:42 INFO - "slavebuilddir": "test" 01:15:42 INFO - } 01:15:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:15:42 INFO - Running post-action listener: _resource_record_post_action 01:15:42 INFO - ##### 01:15:42 INFO - ##### Finished read-buildbot-config step (success) 01:15:42 INFO - ##### 01:15:42 INFO - ##### 01:15:42 INFO - ##### Running download-and-extract step. 01:15:42 INFO - ##### 01:15:42 INFO - Running pre-action listener: _resource_record_pre_action 01:15:42 INFO - Running main action method: download_and_extract 01:15:42 INFO - mkdir: /builds/slave/test/build/tests 01:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:42 INFO - https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:15:43 INFO - Downloaded 1361 bytes. 01:15:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:15:43 INFO - Using the following test package requirements: 01:15:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:15:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:15:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:15:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:43 INFO - u'jsshell-linux-x86_64.zip'], 01:15:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:15:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:15:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:15:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:15:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:15:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:15:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:15: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')]} 01:15:43 INFO - https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:15:46 INFO - Downloaded 22703251 bytes. 01:15:46 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'] 01:15:46 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 01:15:47 INFO - Return code: 0 01:15:47 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 01:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:47 INFO - https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:15:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:15:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:15:52 INFO - Downloaded 22703251 bytes. 01:15:52 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'] 01:15:52 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 01:15:54 INFO - Return code: 0 01:15: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')]} 01:15:54 INFO - https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:15:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:15:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:15:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:15:57 INFO - Downloaded 14405384 bytes. 01:15:57 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'] 01:15:57 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 01:15:57 INFO - Return code: 0 01:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:15:57 INFO - https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZ7vTcabQMW64NSxR4ke7w/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 01:16:07 INFO - Downloaded 56263088 bytes. 01:16:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:16:07 INFO - mkdir: /builds/slave/test/properties 01:16:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:16:07 INFO - Writing to file /builds/slave/test/properties/build_url 01:16:07 INFO - Contents: 01:16:07 INFO - build_url:https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:16:08 INFO - Running post-action listener: _resource_record_post_action 01:16:08 INFO - Running post-action listener: set_extra_try_arguments 01:16:08 INFO - ##### 01:16:08 INFO - ##### Finished download-and-extract step (success) 01:16:08 INFO - ##### 01:16:08 INFO - ##### 01:16:08 INFO - ##### Running populate-webroot step. 01:16:08 INFO - ##### 01:16:08 INFO - Running pre-action listener: _resource_record_pre_action 01:16:08 INFO - Running main action method: populate_webroot 01:16:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:16:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:16:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:16:08 INFO - '--tppagecycles', 01:16:08 INFO - '7'], 01:16:08 INFO - 'tests': ['tsvgm']}}, 01:16:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:16:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:16:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:16:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:16:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:08 INFO - 'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:16:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:16:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:08 INFO - 'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['damp', 'tps']}, 01:16:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:08 INFO - 'tests': ['damp', 'tps']}, 01:16:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['dromaeo_dom']}, 01:16:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:16:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['basic_compositor_video']}, 01:16:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:16:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['a11yr', 01:16:08 INFO - 'ts_paint', 01:16:08 INFO - 'tpaint', 01:16:08 INFO - 'sessionrestore', 01:16:08 INFO - 'sessionrestore_no_auto_restore', 01:16:08 INFO - 'tabpaint']}, 01:16:08 INFO - 'other-e10s': {'tests': ['a11yr', 01:16:08 INFO - 'ts_paint', 01:16:08 INFO - 'tpaint', 01:16:08 INFO - 'sessionrestore', 01:16:08 INFO - 'sessionrestore_no_auto_restore', 01:16:08 INFO - 'tabpaint']}, 01:16:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:16:08 INFO - 'ts_paint', 01:16:08 INFO - 'tpaint', 01:16:08 INFO - 'sessionrestore', 01:16:08 INFO - 'sessionrestore_no_auto_restore', 01:16:08 INFO - 'tabpaint']}, 01:16:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:16:08 INFO - 'ts_paint', 01:16:08 INFO - 'tpaint', 01:16:08 INFO - 'sessionrestore', 01:16:08 INFO - 'sessionrestore_no_auto_restore', 01:16:08 INFO - 'tabpaint']}, 01:16:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['a11yr', 01:16:08 INFO - 'ts_paint', 01:16:08 INFO - 'tpaint', 01:16:08 INFO - 'sessionrestore', 01:16:08 INFO - 'sessionrestore_no_auto_restore', 01:16:08 INFO - 'tabpaint']}, 01:16:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['a11yr', 01:16:08 INFO - 'ts_paint', 01:16:08 INFO - 'tpaint', 01:16:08 INFO - 'sessionrestore', 01:16:08 INFO - 'sessionrestore_no_auto_restore', 01:16:08 INFO - 'tabpaint']}, 01:16:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['tsvgx', 01:16:08 INFO - 'tsvgr_opacity', 01:16:08 INFO - 'tart', 01:16:08 INFO - 'tscrollx', 01:16:08 INFO - 'cart']}, 01:16:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:16:08 INFO - 'tsvgr_opacity', 01:16:08 INFO - 'tart', 01:16:08 INFO - 'tscrollx', 01:16:08 INFO - 'cart']}, 01:16:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:08 INFO - 'talos_options': ['--disable-e10s'], 01:16:08 INFO - 'tests': ['tp5o']}, 01:16:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:08 INFO - 'tests': ['tp5o']}, 01:16:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:08 INFO - 'talos_options': ['--disable-e10s', 01:16:08 INFO - '--xperf_path', 01:16:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:16:08 INFO - 'tests': ['tp5n']}, 01:16:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:08 INFO - 'talos_options': ['--xperf_path', 01:16:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:16:08 INFO - 'tests': ['tp5n']}}, 01:16:08 INFO - 'talos.zip': {'path': '', 01:16:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:16:08 INFO - Running post-action listener: _resource_record_post_action 01:16:08 INFO - ##### 01:16:08 INFO - ##### Finished populate-webroot step (success) 01:16:08 INFO - ##### 01:16:08 INFO - ##### 01:16:08 INFO - ##### Running create-virtualenv step. 01:16:08 INFO - ##### 01:16:08 INFO - Running pre-action listener: _resource_record_pre_action 01:16:08 INFO - Running main action method: create_virtualenv 01:16:08 INFO - Creating virtualenv /builds/slave/test/build/venv 01:16:08 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 01:16:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:16:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:16:08 INFO - Using real prefix '/usr' 01:16:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:16:09 INFO - Installing distribute.............................................................................................................................................................................................done. 01:16:11 INFO - Installing pip.................done. 01:16:11 INFO - Return code: 0 01:16:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:11 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 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:11 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 01:16:11 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 01:16:11 INFO - Using env: {'DISPLAY': ':0', 01:16:11 INFO - 'HOME': '/home/cltbld', 01:16:11 INFO - 'LANG': 'en_US.UTF-8', 01:16:11 INFO - 'LANGUAGE': 'en_US:en', 01:16:11 INFO - 'LOGNAME': 'cltbld', 01:16:11 INFO - 'MAIL': '/var/mail/cltbld', 01:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:11 INFO - 'MOZ_NO_REMOTE': '1', 01:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:11 INFO - 'NO_EM_RESTART': '1', 01:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:11 INFO - 'PWD': '/builds/slave/test', 01:16:11 INFO - 'SHELL': '/bin/bash', 01:16:11 INFO - 'SHLVL': '1', 01:16:11 INFO - 'TERM': 'linux', 01:16:11 INFO - 'TMOUT': '86400', 01:16:11 INFO - 'USER': 'cltbld', 01:16:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:11 INFO - '_': '/tools/buildbot/bin/python'} 01:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:11 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 01:16:11 INFO - Cleaning up... 01:16:11 INFO - Return code: 0 01:16:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:11 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 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:11 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 01:16:11 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 01:16:11 INFO - Using env: {'DISPLAY': ':0', 01:16:11 INFO - 'HOME': '/home/cltbld', 01:16:11 INFO - 'LANG': 'en_US.UTF-8', 01:16:11 INFO - 'LANGUAGE': 'en_US:en', 01:16:11 INFO - 'LOGNAME': 'cltbld', 01:16:11 INFO - 'MAIL': '/var/mail/cltbld', 01:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:11 INFO - 'MOZ_NO_REMOTE': '1', 01:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:11 INFO - 'NO_EM_RESTART': '1', 01:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:11 INFO - 'PWD': '/builds/slave/test', 01:16:11 INFO - 'SHELL': '/bin/bash', 01:16:11 INFO - 'SHLVL': '1', 01:16:11 INFO - 'TERM': 'linux', 01:16:11 INFO - 'TMOUT': '86400', 01:16:11 INFO - 'USER': 'cltbld', 01:16:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:11 INFO - '_': '/tools/buildbot/bin/python'} 01:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:11 INFO - Downloading/unpacking psutil>=3.1.1 01:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:16:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:16:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:16:13 INFO - Installing collected packages: psutil 01:16:13 INFO - Running setup.py install for psutil 01:16:13 INFO - building 'psutil._psutil_linux' extension 01:16:13 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 01:16:13 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 01:16:13 INFO - building 'psutil._psutil_posix' extension 01:16:13 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 01:16:14 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 01:16:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:16:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:16:14 INFO - Successfully installed psutil 01:16:14 INFO - Cleaning up... 01:16:14 INFO - Return code: 0 01:16:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:16:14 INFO - Using env: {'DISPLAY': ':0', 01:16:14 INFO - 'HOME': '/home/cltbld', 01:16:14 INFO - 'LANG': 'en_US.UTF-8', 01:16:14 INFO - 'LANGUAGE': 'en_US:en', 01:16:14 INFO - 'LOGNAME': 'cltbld', 01:16:14 INFO - 'MAIL': '/var/mail/cltbld', 01:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:14 INFO - 'MOZ_NO_REMOTE': '1', 01:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:14 INFO - 'NO_EM_RESTART': '1', 01:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:14 INFO - 'PWD': '/builds/slave/test', 01:16:14 INFO - 'SHELL': '/bin/bash', 01:16:14 INFO - 'SHLVL': '1', 01:16:14 INFO - 'TERM': 'linux', 01:16:14 INFO - 'TMOUT': '86400', 01:16:14 INFO - 'USER': 'cltbld', 01:16:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:14 INFO - '_': '/tools/buildbot/bin/python'} 01:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:16:16 INFO - Installing collected packages: mozsystemmonitor 01:16:16 INFO - Running setup.py install for mozsystemmonitor 01:16:16 INFO - Successfully installed mozsystemmonitor 01:16:16 INFO - Cleaning up... 01:16:16 INFO - Return code: 0 01:16:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:16 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 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:16 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 01:16:16 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 01:16:16 INFO - Using env: {'DISPLAY': ':0', 01:16:16 INFO - 'HOME': '/home/cltbld', 01:16:16 INFO - 'LANG': 'en_US.UTF-8', 01:16:16 INFO - 'LANGUAGE': 'en_US:en', 01:16:16 INFO - 'LOGNAME': 'cltbld', 01:16:16 INFO - 'MAIL': '/var/mail/cltbld', 01:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:16 INFO - 'MOZ_NO_REMOTE': '1', 01:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:16 INFO - 'NO_EM_RESTART': '1', 01:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:16 INFO - 'PWD': '/builds/slave/test', 01:16:16 INFO - 'SHELL': '/bin/bash', 01:16:16 INFO - 'SHLVL': '1', 01:16:16 INFO - 'TERM': 'linux', 01:16:16 INFO - 'TMOUT': '86400', 01:16:16 INFO - 'USER': 'cltbld', 01:16:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:16 INFO - '_': '/tools/buildbot/bin/python'} 01:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:16 INFO - Downloading/unpacking jsonschema==2.5.1 01:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:16:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:16:18 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 01:16:18 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 01:16:18 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 01:16:18 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 01:16:18 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 01:16:18 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 01:16:18 INFO - Downloading functools32-3.2.3-2.tar.gz 01:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:16:18 INFO - warning: no files found matching '*.txt' 01:16:18 INFO - no previously-included directories found matching 'build' 01:16:18 INFO - no previously-included directories found matching 'dist' 01:16:18 INFO - no previously-included directories found matching '.git*' 01:16:18 INFO - Installing collected packages: jsonschema, functools32 01:16:19 INFO - Running setup.py install for functools32 01:16:19 INFO - warning: no files found matching '*.txt' 01:16:19 INFO - no previously-included directories found matching 'build' 01:16:19 INFO - no previously-included directories found matching 'dist' 01:16:19 INFO - no previously-included directories found matching '.git*' 01:16:19 INFO - Successfully installed jsonschema functools32 01:16:19 INFO - Cleaning up... 01:16:19 INFO - Return code: 0 01:16:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:19 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 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:19 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 01:16:19 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 01:16:19 INFO - Using env: {'DISPLAY': ':0', 01:16:19 INFO - 'HOME': '/home/cltbld', 01:16:19 INFO - 'LANG': 'en_US.UTF-8', 01:16:19 INFO - 'LANGUAGE': 'en_US:en', 01:16:19 INFO - 'LOGNAME': 'cltbld', 01:16:19 INFO - 'MAIL': '/var/mail/cltbld', 01:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:19 INFO - 'MOZ_NO_REMOTE': '1', 01:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:19 INFO - 'NO_EM_RESTART': '1', 01:16:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:19 INFO - 'PWD': '/builds/slave/test', 01:16:19 INFO - 'SHELL': '/bin/bash', 01:16:19 INFO - 'SHLVL': '1', 01:16:19 INFO - 'TERM': 'linux', 01:16:19 INFO - 'TMOUT': '86400', 01:16:19 INFO - 'USER': 'cltbld', 01:16:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:19 INFO - '_': '/tools/buildbot/bin/python'} 01:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:19 INFO - Downloading/unpacking blobuploader==1.2.4 01:16:19 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 01:16:19 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 01:16:19 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 01:16:19 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 01:16:19 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 01:16:19 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 01:16:21 INFO - Downloading blobuploader-1.2.4.tar.gz 01:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:16:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:16:21 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 01:16:21 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 01:16:21 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 01:16:21 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 01:16:21 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 01:16:21 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 01:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:16:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:16:21 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 01:16:21 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 01:16:21 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 01:16:21 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 01:16:21 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 01:16:21 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 01:16:22 INFO - Downloading docopt-0.6.1.tar.gz 01:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:16:22 INFO - Installing collected packages: blobuploader, requests, docopt 01:16:22 INFO - Running setup.py install for blobuploader 01:16:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:16:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:16:22 INFO - Running setup.py install for requests 01:16:22 INFO - Running setup.py install for docopt 01:16:22 INFO - Successfully installed blobuploader requests docopt 01:16:22 INFO - Cleaning up... 01:16:22 INFO - Return code: 0 01:16:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:22 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 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:22 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 01:16:22 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 01:16:22 INFO - Using env: {'DISPLAY': ':0', 01:16:22 INFO - 'HOME': '/home/cltbld', 01:16:22 INFO - 'LANG': 'en_US.UTF-8', 01:16:22 INFO - 'LANGUAGE': 'en_US:en', 01:16:22 INFO - 'LOGNAME': 'cltbld', 01:16:22 INFO - 'MAIL': '/var/mail/cltbld', 01:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:22 INFO - 'MOZ_NO_REMOTE': '1', 01:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:22 INFO - 'NO_EM_RESTART': '1', 01:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:22 INFO - 'PWD': '/builds/slave/test', 01:16:22 INFO - 'SHELL': '/bin/bash', 01:16:22 INFO - 'SHLVL': '1', 01:16:22 INFO - 'TERM': 'linux', 01:16:22 INFO - 'TMOUT': '86400', 01:16:22 INFO - 'USER': 'cltbld', 01:16:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:22 INFO - '_': '/tools/buildbot/bin/python'} 01:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:16:23 INFO - Running setup.py (path:/tmp/pip-CStgTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:16:23 INFO - Running setup.py (path:/tmp/pip-hQiZE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:16:23 INFO - Running setup.py (path:/tmp/pip-KSSowm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:16:23 INFO - Running setup.py (path:/tmp/pip-C5ldrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:16:23 INFO - Running setup.py (path:/tmp/pip-sE2Isq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:16:23 INFO - Running setup.py (path:/tmp/pip-3ncj2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:16:23 INFO - Running setup.py (path:/tmp/pip-JicJBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:16:23 INFO - Running setup.py (path:/tmp/pip-kkdnpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:16:23 INFO - Running setup.py (path:/tmp/pip-XDr56H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:16:23 INFO - Running setup.py (path:/tmp/pip-mAbQNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:16:23 INFO - Running setup.py (path:/tmp/pip-M9imiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:16:23 INFO - Running setup.py (path:/tmp/pip-c8CP3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:16:23 INFO - Running setup.py (path:/tmp/pip-to4Lws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:16:24 INFO - Running setup.py (path:/tmp/pip-UuTEN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:16:24 INFO - Running setup.py (path:/tmp/pip-reQ_QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:16:24 INFO - Running setup.py (path:/tmp/pip-qVhS_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:16:24 INFO - Running setup.py (path:/tmp/pip-oVOfb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:16:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:16:24 INFO - Running setup.py install for manifestparser 01:16:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:16:24 INFO - Running setup.py install for mozcrash 01:16:24 INFO - Running setup.py install for mozdebug 01:16:24 INFO - Running setup.py install for mozdevice 01:16:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:16:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:16:24 INFO - Running setup.py install for mozfile 01:16:24 INFO - Running setup.py install for mozhttpd 01:16:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:16:24 INFO - Running setup.py install for mozinfo 01:16:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Running setup.py install for mozInstall 01:16:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Running setup.py install for mozleak 01:16:25 INFO - Running setup.py install for mozlog 01:16:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Running setup.py install for moznetwork 01:16:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Running setup.py install for mozprocess 01:16:25 INFO - Running setup.py install for mozprofile 01:16:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Running setup.py install for mozrunner 01:16:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:16:25 INFO - Running setup.py install for mozscreenshot 01:16:25 INFO - Running setup.py install for moztest 01:16:25 INFO - Running setup.py install for mozversion 01:16:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:16:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:16:26 INFO - Cleaning up... 01:16:26 INFO - Return code: 0 01:16:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:16: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')]} 01:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:26 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 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:26 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 01:16:26 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 01:16:26 INFO - Using env: {'DISPLAY': ':0', 01:16:26 INFO - 'HOME': '/home/cltbld', 01:16:26 INFO - 'LANG': 'en_US.UTF-8', 01:16:26 INFO - 'LANGUAGE': 'en_US:en', 01:16:26 INFO - 'LOGNAME': 'cltbld', 01:16:26 INFO - 'MAIL': '/var/mail/cltbld', 01:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:26 INFO - 'MOZ_NO_REMOTE': '1', 01:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:26 INFO - 'NO_EM_RESTART': '1', 01:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:26 INFO - 'PWD': '/builds/slave/test', 01:16:26 INFO - 'SHELL': '/bin/bash', 01:16:26 INFO - 'SHLVL': '1', 01:16:26 INFO - 'TERM': 'linux', 01:16:26 INFO - 'TMOUT': '86400', 01:16:26 INFO - 'USER': 'cltbld', 01:16:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:26 INFO - '_': '/tools/buildbot/bin/python'} 01:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:16:26 INFO - Running setup.py (path:/tmp/pip-6MBvV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:16:26 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)) 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:16:26 INFO - Running setup.py (path:/tmp/pip-HIzWgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:16:26 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)) 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:16:26 INFO - Running setup.py (path:/tmp/pip-C_GYGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:16:26 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)) 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:16:26 INFO - Running setup.py (path:/tmp/pip-EzXkO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:16:26 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)) 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:16:26 INFO - Running setup.py (path:/tmp/pip-RPsgve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:16:26 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)) 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:16:26 INFO - Running setup.py (path:/tmp/pip-juEv5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:16:26 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)) 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:16:26 INFO - Running setup.py (path:/tmp/pip-aaJLoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:16:26 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)) 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:16:26 INFO - Running setup.py (path:/tmp/pip-GwWVQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:16:26 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)) 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:16:26 INFO - Running setup.py (path:/tmp/pip-z7339y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:16:26 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)) 01:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:16:27 INFO - Running setup.py (path:/tmp/pip-w1nuhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:16:27 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)) 01:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:16:27 INFO - Running setup.py (path:/tmp/pip-wJXreI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:16:27 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)) 01:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:16:27 INFO - Running setup.py (path:/tmp/pip-LCDRxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:16:27 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)) 01:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:16:27 INFO - Running setup.py (path:/tmp/pip-Y6I7oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:16:27 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)) 01:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:16:27 INFO - Running setup.py (path:/tmp/pip-4EgCl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:16:27 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)) 01:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:16:27 INFO - Running setup.py (path:/tmp/pip-2wIvvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:16:27 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)) 01:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:16:27 INFO - Running setup.py (path:/tmp/pip-rRJxyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:16:27 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)) 01:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:16:27 INFO - Running setup.py (path:/tmp/pip-5VDNkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:16:27 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)) 01:16:27 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)) 01:16:27 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)) 01:16:27 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)) 01:16:27 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)) 01:16:27 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)) 01:16:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:29 INFO - Downloading blessings-1.6.tar.gz 01:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:16:29 INFO - Installing collected packages: blessings 01:16:29 INFO - Running setup.py install for blessings 01:16:29 INFO - Successfully installed blessings 01:16:29 INFO - Cleaning up... 01:16:29 INFO - Return code: 0 01:16:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:16:29 INFO - Reading from file tmpfile_stdout 01:16:29 INFO - Current package versions: 01:16:29 INFO - argparse == 1.2.1 01:16:29 INFO - blessings == 1.6 01:16:29 INFO - blobuploader == 1.2.4 01:16:29 INFO - docopt == 0.6.1 01:16:29 INFO - functools32 == 3.2.3-2 01:16:29 INFO - jsonschema == 2.5.1 01:16:29 INFO - manifestparser == 1.1 01:16:29 INFO - mozInstall == 1.12 01:16:29 INFO - mozcrash == 0.17 01:16:29 INFO - mozdebug == 0.1 01:16:29 INFO - mozdevice == 0.48 01:16:29 INFO - mozfile == 1.2 01:16:29 INFO - mozhttpd == 0.7 01:16:29 INFO - mozinfo == 0.9 01:16:29 INFO - mozleak == 0.1 01:16:29 INFO - mozlog == 3.2 01:16:29 INFO - moznetwork == 0.27 01:16:29 INFO - mozprocess == 0.22 01:16:29 INFO - mozprofile == 0.28 01:16:29 INFO - mozrunner == 6.11 01:16:29 INFO - mozscreenshot == 0.1 01:16:29 INFO - mozsystemmonitor == 0.3 01:16:29 INFO - moztest == 0.7 01:16:29 INFO - mozversion == 1.4 01:16:29 INFO - psutil == 3.1.1 01:16:29 INFO - requests == 1.2.3 01:16:29 INFO - wsgiref == 0.1.2 01:16:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:16: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')]} 01:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:29 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 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:29 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 01:16:29 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 01:16:29 INFO - Using env: {'DISPLAY': ':0', 01:16:29 INFO - 'HOME': '/home/cltbld', 01:16:29 INFO - 'LANG': 'en_US.UTF-8', 01:16:29 INFO - 'LANGUAGE': 'en_US:en', 01:16:29 INFO - 'LOGNAME': 'cltbld', 01:16:29 INFO - 'MAIL': '/var/mail/cltbld', 01:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:29 INFO - 'MOZ_NO_REMOTE': '1', 01:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:29 INFO - 'NO_EM_RESTART': '1', 01:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:29 INFO - 'PWD': '/builds/slave/test', 01:16:29 INFO - 'SHELL': '/bin/bash', 01:16:29 INFO - 'SHLVL': '1', 01:16:29 INFO - 'TERM': 'linux', 01:16:29 INFO - 'TMOUT': '86400', 01:16:29 INFO - 'USER': 'cltbld', 01:16:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:29 INFO - '_': '/tools/buildbot/bin/python'} 01:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:30 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)) 01:16:30 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)) 01:16:30 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)) 01:16:30 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)) 01:16:30 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)) 01:16:30 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)) 01:16:30 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)) 01:16:30 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)) 01:16:30 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)) 01:16:30 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)) 01:16:30 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)) 01:16:30 INFO - Cleaning up... 01:16:30 INFO - Return code: 0 01:16:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:16: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')]} 01:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:30 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 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:30 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 01:16:30 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 01:16:30 INFO - Using env: {'DISPLAY': ':0', 01:16:30 INFO - 'HOME': '/home/cltbld', 01:16:30 INFO - 'LANG': 'en_US.UTF-8', 01:16:30 INFO - 'LANGUAGE': 'en_US:en', 01:16:30 INFO - 'LOGNAME': 'cltbld', 01:16:30 INFO - 'MAIL': '/var/mail/cltbld', 01:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:30 INFO - 'MOZ_NO_REMOTE': '1', 01:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:30 INFO - 'NO_EM_RESTART': '1', 01:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:30 INFO - 'PWD': '/builds/slave/test', 01:16:30 INFO - 'SHELL': '/bin/bash', 01:16:30 INFO - 'SHLVL': '1', 01:16:30 INFO - 'TERM': 'linux', 01:16:30 INFO - 'TMOUT': '86400', 01:16:30 INFO - 'USER': 'cltbld', 01:16:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:30 INFO - '_': '/tools/buildbot/bin/python'} 01:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:16:30 INFO - Cleaning up... 01:16:30 INFO - Return code: 0 01:16:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:16: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')]} 01:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:30 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 0x7fa951226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, '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': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', '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 01:16:30 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 01:16:30 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 01:16:30 INFO - Using env: {'DISPLAY': ':0', 01:16:30 INFO - 'HOME': '/home/cltbld', 01:16:30 INFO - 'LANG': 'en_US.UTF-8', 01:16:30 INFO - 'LANGUAGE': 'en_US:en', 01:16:30 INFO - 'LOGNAME': 'cltbld', 01:16:30 INFO - 'MAIL': '/var/mail/cltbld', 01:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:30 INFO - 'MOZ_NO_REMOTE': '1', 01:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:30 INFO - 'NO_EM_RESTART': '1', 01:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:30 INFO - 'PWD': '/builds/slave/test', 01:16:30 INFO - 'SHELL': '/bin/bash', 01:16:30 INFO - 'SHLVL': '1', 01:16:30 INFO - 'TERM': 'linux', 01:16:30 INFO - 'TMOUT': '86400', 01:16:30 INFO - 'USER': 'cltbld', 01:16:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:30 INFO - '_': '/tools/buildbot/bin/python'} 01:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:30 INFO - Downloading/unpacking flake8 01:16:30 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 01:16:30 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 01:16:30 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 01:16:30 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 01:16:30 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 01:16:30 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 01:16:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:16:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:16:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 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 01:16:32 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 01:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:16:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:16:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:16:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:16:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:16:33 INFO - no previously-included directories found matching 'docs/_build' 01:16:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:16:33 INFO - Running setup.py install for pep8 01:16:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:16:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:16:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:16:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:16:33 INFO - no previously-included directories found matching 'docs/_build' 01:16:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:16:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:16:33 INFO - Cleaning up... 01:16:33 INFO - Return code: 0 01:16:33 INFO - Running post-action listener: _resource_record_post_action 01:16:33 INFO - Running post-action listener: _start_resource_monitoring 01:16:33 INFO - Starting resource monitoring. 01:16:33 INFO - ##### 01:16:33 INFO - ##### Finished create-virtualenv step (success) 01:16:33 INFO - ##### 01:16:33 INFO - ##### 01:16:33 INFO - ##### Running install step. 01:16:33 INFO - ##### 01:16:33 INFO - Running pre-action listener: _resource_record_pre_action 01:16:33 INFO - Running main action method: install 01:16:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:16:33 INFO - Reading from file tmpfile_stdout 01:16:33 INFO - Detecting whether we're running mozinstall >=1.0... 01:16:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:16:33 INFO - Reading from file tmpfile_stdout 01:16:33 INFO - Output received: 01:16:33 INFO - Usage: mozinstall [options] installer 01:16:33 INFO - Options: 01:16:33 INFO - -h, --help show this help message and exit 01:16:33 INFO - -d DEST, --destination=DEST 01:16:33 INFO - Directory to install application into. [default: 01:16:33 INFO - "/builds/slave/test"] 01:16:33 INFO - --app=APP Application being installed. [default: firefox] 01:16:33 INFO - mkdir: /builds/slave/test/build/application 01:16:33 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'] 01:16:33 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 01:16:49 INFO - Reading from file tmpfile_stdout 01:16:49 INFO - Output received: 01:16:49 INFO - /builds/slave/test/build/application/firefox/firefox 01:16:49 INFO - Running post-action listener: _resource_record_post_action 01:16:49 INFO - ##### 01:16:49 INFO - ##### Finished install step (success) 01:16:49 INFO - ##### 01:16:49 INFO - ##### 01:16:49 INFO - ##### Running run-tests step. 01:16:49 INFO - ##### 01:16:49 INFO - Running pre-action listener: _resource_record_pre_action 01:16:49 INFO - Running main action method: run_tests 01:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:16:49 INFO - Python 2.7.3 01:16:49 INFO - Return code: 0 01:16:49 INFO - grabbing minidump binary from tooltool 01:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:49 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 0x1cfe2c0>, '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 0x1cff1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cff650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:16:49 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 01:16:49 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 01:16:49 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 01:16:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:16:50 INFO - Return code: 0 01:16:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:16:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:16:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:16:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:16:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:16:50 INFO - Return code: 0 01:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:16:50 INFO - Using env: {'DISPLAY': ':0', 01:16:50 INFO - 'HOME': '/home/cltbld', 01:16:50 INFO - 'LANG': 'en_US.UTF-8', 01:16:50 INFO - 'LANGUAGE': 'en_US:en', 01:16:50 INFO - 'LOGNAME': 'cltbld', 01:16:50 INFO - 'MAIL': '/var/mail/cltbld', 01:16:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:16:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:50 INFO - 'MOZ_NO_REMOTE': '1', 01:16:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:50 INFO - 'NO_EM_RESTART': '1', 01:16:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:50 INFO - 'PWD': '/builds/slave/test', 01:16:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:16:50 INFO - 'SHELL': '/bin/bash', 01:16:50 INFO - 'SHLVL': '1', 01:16:50 INFO - 'TERM': 'linux', 01:16:50 INFO - 'TMOUT': '86400', 01:16:50 INFO - 'USER': 'cltbld', 01:16:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179', 01:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:50 INFO - '_': '/tools/buildbot/bin/python'} 01:16:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:16:51 INFO - mozversion application_buildid: 20160623004325 01:16:51 INFO - mozversion application_changeset: dbe8807bcf0db60680a940eaaaf01f4488c6bf22 01:16:51 INFO - mozversion application_display_name: Nightly 01:16:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:16:51 INFO - mozversion application_name: Firefox 01:16:51 INFO - mozversion application_remotingname: firefox 01:16:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:16:51 INFO - mozversion application_vendor: Mozilla 01:16:51 INFO - mozversion application_version: 50.0a1 01:16:51 INFO - mozversion platform_buildid: 20160623004325 01:16:51 INFO - mozversion platform_changeset: dbe8807bcf0db60680a940eaaaf01f4488c6bf22 01:16:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:16:51 INFO - mozversion platform_version: 50.0a1 01:16:51 INFO - using testdate: 1466669811 01:16:51 INFO - actual date: 1466669811 01:16:51 INFO - starting webserver on 'localhost:36536' 01:16:51 INFO - SUITE-START | Running 2 tests 01:16:51 INFO - TEST-START | dromaeo_css 01:16:51 INFO - operating with platform_type : linux_ 01:16:51 INFO - Initialising browser for dromaeo_css test... 01:16:51 INFO - TEST-INFO | started process 8730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMuVnGe/profile http://localhost:36536/getInfo.html) 01:16:55 INFO - PROCESS | 8730 | __metrics Screen width/height:1600/1200 01:16:55 INFO - PROCESS | 8730 | colorDepth:24 01:16:55 INFO - PROCESS | 8730 | Browser inner width/height: 1024/697 01:16:55 INFO - PROCESS | 8730 | __metrics 01:16:56 INFO - PROCESS | 8730 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:16:57 INFO - TEST-INFO | 8730: exit 0 01:16:57 INFO - Browser initialized. 01:16:57 INFO - Running cycle 1/1 for dromaeo_css test... 01:16:57 INFO - TEST-INFO | started process 8810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMuVnGe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:17:09 INFO - PROCESS | 8810 | RSS: Main: 175173632 01:17:09 INFO - PROCESS | 8810 | 01:18:00 INFO - PROCESS | 8810 | 1466669880770 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] 01:20:13 INFO - PROCESS | 8810 | Cycle 1(1): loaded http://localhost:36536/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36536/tests/dromaeo/cssquery-ext.html) 01:20:14 INFO - PROCESS | 8810 | RSS: Main: 256364544 01:20:14 INFO - PROCESS | 8810 | 01:23:17 INFO - PROCESS | 8810 | Cycle 1(1): loaded http://localhost:36536/tests/dromaeo/cssquery-ext.html (next: http://localhost:36536/tests/dromaeo/cssquery-jquery.html) 01:23:17 INFO - PROCESS | 8810 | RSS: Main: 254095360 01:23:17 INFO - PROCESS | 8810 | 01:26:20 INFO - PROCESS | 8810 | Cycle 1(1): loaded http://localhost:36536/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36536/tests/dromaeo/cssquery-mootools.html) 01:26:20 INFO - PROCESS | 8810 | RSS: Main: 255696896 01:26:20 INFO - PROCESS | 8810 | 01:29:22 INFO - PROCESS | 8810 | Cycle 1(1): loaded http://localhost:36536/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36536/tests/dromaeo/cssquery-prototype.html) 01:29:23 INFO - PROCESS | 8810 | RSS: Main: 253632512 01:29:23 INFO - PROCESS | 8810 | 01:32:26 INFO - PROCESS | 8810 | Cycle 1(1): loaded http://localhost:36536/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36536/tests/dromaeo/cssquery-yui.html) 01:32:27 INFO - PROCESS | 8810 | RSS: Main: 233021440 01:32:27 INFO - PROCESS | 8810 | 01:35:30 INFO - PROCESS | 8810 | Cycle 1(1): loaded http://localhost:36536/tests/dromaeo/cssquery-yui.html (next: http://localhost:36536/tests/dromaeo/cssquery-dojo.html) 01:35:30 INFO - PROCESS | 8810 | RSS: Main: 290807808 01:35:30 INFO - PROCESS | 8810 | 01:35:30 INFO - PROCESS | 8810 | __start_tp_report 01:35:30 INFO - PROCESS | 8810 | _x_x_mozilla_page_load 01:35:30 INFO - PROCESS | 8810 | _x_x_mozilla_page_load_details 01:35:30 INFO - PROCESS | 8810 | |i|pagename|runs| 01:35:30 INFO - PROCESS | 8810 | |0;dojo.html;2602.7787638050763;2612.1118819601356;2639.1158961747824;2639.45891092326;2647.682278126625;4756.262779269219;4762.666613337068;4821;4844.927326090103;4860.198067318893;4851.636127290459;4877.634177436697;4896.657233993622;4992.7753251103695;4994.475580064086;4438.178936896685;4470.195364834329;4480.731156130626;4540.9091818163615;4645.3264276679865;4541.772911354436;4581.289900065479;4591.058832939239;4602.2636378179495;4629.328747331635;4367.475902891658;4372.1692878353015;4421.889452763707;4424.9557504424865;4429.645628349725;4394.780260986938;4409.625181859546;4411.889702757425;4452.065066336041;4463;4445.466544014706;4455.866324010252;4462.598366147063;4487.798049087766;4501.144782491349;4792.424909010941;4893.04585605807;4911.631627627907;4959.851204463872;4966.205407134841;5412.729363531807;5412.91880621791;5429.4299098594865;5429.53848922842;5432.293801805779;5441.59188060897;5449.509544141007;5478.561715062785;5486;5487.588430867661;4800.831970881038;4896.069746748178;4948.38145231846;4952.801887924443;4955.4548999610015;5449.618526703172;5452.6183167177915;5509.090999985037;5512.448755124536;5512.641678290898;4972.129877271463;5240.0567897778765;5242.633015688942;5243.134882744381;5247.501487358695;5287.550558202519;5296.285001524822;5323.201519772065;5364.490373414519;5369.033573956647;5236.92144617831;5250.159974404077;5253.684778913277;5260.579153667697;5340.813071542478;5040.294358789773;5173.301604283449;5262.052830490548;5266.578673706171;5273.630845840831;4501.257292546758;4511.458624965026;4517.503074661785;4565.223911934979;4570.680052396367;3898.181381909774;3902.785346805953;3913.745606535566;3922.0391004204153;3942.034201620564;4363.650907927422;4382.956170438319;4499.662525310615;4546.772661366985;4548.5906268436;5125.2568377585785;5217.530422262014;5221.817236396708;5232.39827419844;5239.502247286502;4442.089371678798;4456.120547999935;4468.4414448193975;4483;4506.1663592235545;4635.142498637695;4722.693024953367;4745.074710431501;4752.95247047532;4783.473817880031;4932.926006109983;4951.950480495149;4962.727050012284;4981.277714731416;5019.84940451787;5268.209768534597;5290.021346050993;5312.442193569774;5314.5482633975;5354.973225133849;4811.398575178103;4889.168841297059;4895.020995800783;4976.527229913152;4982.252662100714;5205.817796377109;5222;5225.137852254487;5232.3459567554055;5262.000219958196;5252.42223355423;5253.579713622978;5305.071612467726;5314.787408503771;5368.812091576776;4893.045856058035;4945.035718034948;5008.348914641073;5024.321716568363;5076.796928122982;5095.210242412432;5103.3110530077965;5124;5124.231365295235;5171.689698618095;5060.49395060491;5062.797488100582;5138.820141295037;5140.614453915897;5149.871253218699;5008.449070602158;5078.263651770399;5126.769295381642;5155.53600175986;5174.379074511083;5024.874378140576;5054.924176137434;5056.84829455117;5062.291279220838;5115.897682046412 01:35:30 INFO - PROCESS | 8810 | |1;ext.html;553.26415866897;573.6128113523376;580.5674772294639;589.1986897818965;608.7990962982217;27158.321041973937;29678.40643187135;29692.257693557644;29694.703052969464;29704.40591188175;28558;29363.55954660682;40981.79509102458;41906.37140442896;41980.160396792046;7564.508306960058;7680.385569154482;7686.692532298702;7687.693092174316;7688.9231107688765;7688.9231107688765;7787.610619469032;7788.337991270749;7788.415868809833;7789.688412463523;7622.237776222389;9993.050660187308;10255.384676919371;10257.128144107759;10555;9985.500724963722;10045.296829221958;10052.648157314496;10057.748556286151;10059.396436213778;6432.260290066655;9751.853722194173;9923.206143508574;10000.749981250454;10001.749956251078;35937.64062359369;39661.20677586461;39686.801565992275;39708.60291397078;39727;3009;3110.2311281801276;3542.3446662367546;3665.303592317478;3693.741438099334;29931.25171870699;29933.850330748206;30005.399892002257;30139.849300753576;31383.215419614466;3480.32133733922;3524.3832329342263;3542.256126213498;3544.8404821782824;3582.3551760683067;263482;266570.9999999981;267282;267293;267314;54272.72863635736;54578;54614.18078728743;54650;54739.17891231635;57065.42934570601;57132;57163;57200;57210.42789572051;13777.862221377658;13997.44010239579;14010.789838152436;14014.649633759238;14014.71970560583;10538.578456861793;10580.418077005685;10592.15262778976;10598;10613;14881.627959301104;15473.381064757283;16113.113778742047;16776;16871.578210544834;6064.423879731418;6086.817395478054;6096.847578810476;6191.9690401547705;6234;825.5459497276474;899.6356475627381;909.4679612426804;911.9863202051974;931.5063016601213;27886.44227115487;28141.57787633187;28463.715362846106;28833.855830720713;28926.42147157045;932.3333816321227;948.0993056596124;990.7671697151163;991.8859331177007;994.2046362909788;15039.323230454656;15342.769858452131;15895.205239737967;16261.59346016359;16513.504594862174;383972;385658;387421;388361;388596;50654;50721.49278507241;50737.23894141591;50782.74608626933;50783;1173.4543437301695;1177.2936238256978;1216.2094638485055;1216.7140721930339;1219.676785651803;27488.45023099487;29021;29193;29214.853925730236;29436.411271774017;43266.783666081465;43678;43699;43790.78104609456;43806.34290485709;314273;319670;320434;321836;321977;22502.77497225072;23293.417664557845;24674.50650986934;25061.749382505943;25538.616920745833;39172.41241381439;42487.3626895603;43173;43359.34960975525;43885.78057109694;35326.293474130885;36220.637793621725;37104.25791484209;37194.8140259297;37559.62440375561;35607.10982225362;36285.455718164776;36431.635683642824;36537.63462365342;36707;35203;35353;39421;40076.799616001736;40085.799571003125;32035.35929281448;33364.332713346084;33565.83217083899;34118.31763364768;34204.14489637679;25779.613305800052;25822.483550328514;26004.34989125287;26034.60948085818;26045.088421905144 01:35:30 INFO - PROCESS | 8810 | |2;jquery.html;372.0846717075993;372.2350569579514;373.1454968122998;386.08497860071634;388.9863854765082;15628.3748650054;16795.244214010385;17430.738538921927;17573.121343932817;17578.121093945283;16187.433439829609;17131.14344282787;17293.30826766931;17295.654086918254;17314.913425432886;4955.4548999610015;5152.304438900756;5183.611229157809;5187.325647665798;5191.247269145972;3064.1879901826032;3211.903642890717;5059.848204553869;5678.43215678433;5992.7902523411685;6019.69901504923;6027.095935609672;6052.213212282397;6053;6055.485283750886;5798.826035218929;6092.634441933476;6096.055111457731;6101.603395779282;6105.084237364386;3041.9847900760356;4988.625853060998;5348.491893270133;5357.464253574651;5358.517733403974;19958.401247962585;20660.17359305626;20707;20753.481162970897;20811;2002.2791794953805;2085.103405535619;2339.4853132310864;2369.992753079934;2420.3586049696846;12730.108892377537;13243;13354.26551539665;13700.246486443242;13928.582142535639;1772.4771192498115;1832.3128826689992;1854.1192933356683;1857.7120546315343;1893.5739458621838;64303.67848160729;64497.67751161261;64975.675121625034;66748.3325166747;66849.66575167142;9060.912690477053;9638.228941684649;9859.654912078044;10161.08550230468;10529.631462898762;13317.600471985856;13348.065635405428;13406.329683515785;13438.462461501626;13443.932780336036;7003.054587630707;7096.042034325404;7140.357367836919;7225.385842203472;7267.672954717051;6784.8303792404595;6831.180258369028;6916.308369163144;6968.965155174192;6980.371766541036;5892.381299963527;5962.403759624003;6153.6334776619715;6168.35232300602;6203.875922481525;1590.3479573374862;1721.7675613792228;1729.5762538178226;1732.7424442048869;1750.7132257790513;759.2710997442407;901.8286525560254;907.9364444488955;932.8507438809758;972.5429048347265;16726;17547.29810807579;17645.38241161553;18032.729509057375;18217.18022688982;845.5856630251255;881.5460038080394;895.7357579514058;907.1427501011481;920.4753290624413;9636.614535418645;10048.29661923673;10194.643187488402;10207.693769186937;10300.175985921258;371749;383027;387920;389468;390758;42330.78834605869;51765.741171294656;57623.71188144032;70951;84099;864.9870251946226;866.3156106675782;870.6734974384606;909.8680691299725;924.523870206844;15714.292856821241;15791.131487768283;15875.841241587897;15928.362865485251;16211.270492828087;29801.5529767058;35859.103522411104;37958.051048724;38534;39188.41217381685;48631;49602.503974959785;52415.47584524106;55922.72038639944;58440.707796460745;4801.975990120027;5743.3395159557185;6306.4639505642535;7632.80917977055;7961.363090952594;8811.911880881109;10768.192385570957;11672.182947193614;11878.227915185485;12181.69545761363;9427.670031548863;9707.563159657973;9957.551910164206;10088.54601542947;10234.948825255826;9980.650677226262;10295.433751143759;10370.27408081427;10534.894651053391;10576.524056417633;9101.317401194805;9773.657921972697;10348.379097254188;10615.575376984834;10953.123750100132;7831.216878312123;7837.1770964047955;7854.4894581851995;8043.356531477585;8202.09776924526;8115.431919765796;9508;10348.844767328646;10382.740431489274;10560.471976401303 01:35:30 INFO - PROCESS | 8810 | |3;mootools.html;1182.0425455381137;1366.590022993102;1424.68656895483;1455.2796365798931;1653.8263482334362;6755.256921738611;7675.078990521131;7875.684972601096;7923.3661307095435;8134.105248422684;7849.764507064797;7992.360611151108;7995.640196191185;7995.960020199906;8009.759707208778;2210.7789221077883;2246.4608493961496;2249.5051088760447;2250.2799104286637;2252.7859853313907;2176.1948079210715;2180.3894909425385;2255.661650752384;2258.6837842702034;2260.1976298414074;2179.1174574297356;2193.287181665957;2196.2313190383397;2202.9118835246572;2207.2164381644525;2163.1888041984257;2173.098164261837;2181.8363622728357;2189.255653077945;2191.5507320999236;2162.5350549631903;2164.1235299703644;2168.642174041281;2169.045619927227;2171.4462811983003;7845.293923546908;7992;8057.59712014397;8058.5567793771315;8079.515229086215;4699.154152252593;4811.855644330676;4817.301491283744;4821.180399332087;4824.565789078964;2918.5622156676454;3001.3997200559975;3038.2100653829943;3042.2698552347497;3047.0097218403885;890.6838072484304;907.4782000349825;911.6399022386121;916.4089162490156;918.4168053286145;10600.257981941268;10625.574977000912;10701.518431670516;10720;10735.141188704885;4078.4494093297026;4187.664986801049;4259.041715613962;4263.744175349489;4269.893252668709;8436.704715335056;8470.237678608832;8515.616797244138;8523.701670441505;8531.146885311418;4613.76931153441;4617.930731039037;4635.281531362644;4645.070985802853;4647.674662773574;3824.7187192290894;3991.7006224533275;4205.474315710536;4278.850240241577;4344.370066340363;3488.2500262443696;3515.156362472988;3532.770369925998;3565.769809415747;3678.3378991781738;1034.7169509807784;1040.1730624153815;1045.482486169351;1048.4390850894736;1059.4861492176287;747.4805010517638;786.2334224131426;809.8056466448128;810.4448452809844;825.0264687668489;5191.6884986900905;5225.425203227642;5296.179092240709;5308.203769434615;5433.809816656398;851.1573542193184;859.1623167411724;888.8888888888889;890.7416849113814;902.5848109869534;3272.1655977726004;3643.872464463731;3656.524651795303;3676.1361080146144;3695.7228207883977;9793.069658382443;10046.949765251273;10078.092971632588;10124.898751012543;10151.289409741396;9897.042847318413;9931.80136397268;9999.100080992746;10014.29899907014;10028.69913902584;7500.774976750707;7610.695572177162;7665.463417560829;7668.5782281975025;7680.846383072308;5070.138076526926;5118.283440318432;5274.947250527599;5275.155975043975;5337.519623233772;9134.862977055482;9244.722658320261;9252.306077044113;9267.814643707223;9347.252219822534;8752.168543988311;9128.908710912805;9144.588493517675;9330.253579713471;9360.859587106335;6212.130301757667;6713.530052896251;6880.105586273752;6888.621125838127;6902.275261097512;7683.654235559301;7705.190954949874;7708.884366734392;7741.651625676745;7793.06483222017;6727.192139324884;6877.931220687929;6965.303469652994;6996.580205187705;7146.9285307146265;6752.426043786137;6752.459803215829;6780.186377634715;6811.591304521745;6886.10480637514;5988.431099045583;6003.159557662018;6022.45797878193;6053.485453736305;6115.480184184395;4416.447944006999;4466.106778644219;4468.597826195658;4544.545545445429;4545.886352841206;4412.139632771578;4436.977815110904;4450.910981780411;4466.330050492322;4517.525659805673 01:35:30 INFO - PROCESS | 8810 | |4;prototype.html;295.70872690399955;295.9985200073999;299.70928199646335;302.703350716298;304.2606466286922;4988.7755051022705;4996.600271978246;5005.57452616528;5023.995200959809;5030.48475762119;4926.261060840867;4934.901301973959;4937.6790508617005;4967.478414766451;4987.202047672373;3611.9819400902957;3700.574433940091;3793.3930571108626;3870.4774855394444;3889.5138107736534;3825.9808700956455;3864.6908247340143;3876.5154355705536;3884.6503814656676;3896.902577435558;3822.159124992511;3826.7512611680154;3838.6161383861668;3839.404892241707;3848;3690.483332333462;3745.4943582616543;3856.479375284329;3863.2273545291055;3882.5535063467496;3415.299863527971;3419.897403077912;3430.9828450857835;3433.3476639438427;3434.3555462294144;4847.079054979577;4868.342773725537;4884.340614017097;4894.216925291972;4947.604191664695;4210.936835947463;4408.845690400853;4410.867673969786;4488.775561221926;4511.278195488739;5212.071533532618;5222.477752224785;5234.136367499358;5237.3453318335205;5249;3706.5737440194453;3709.9814500927323;3720.1071742781537;3736.290104880064;3745.906352341186;5395.81114660985;5412.485813847678;5498.422665620133;5519.267962358658;5528.917066244009;3795.4686343911876;3800.2969450651717;3800.6317725618756;3806.01043728627;3815.4849095372324;3852.9982204627;3856.305864944337;3859.30190716084;3862.208247309295;3876.4185372193833;4383.254846676073;4421.53573874745;4422.601965823027;4432.734035957788;4443.533428989909;5064.341635587423;5257.868553286122;5267.367915850123;5275.841724748264;5277.498637629419;1291.7018396511446;1313.9408726607326;1319.4524272427027;1320.966975825612;1321.2931081871152;840.7771940435789;847.9824210946888;861.8104017116225;891.460666296894;911.4349103555705;4501.324801279834;4508.797104130322;4514.864554063383;4526.958799476073;4534.093181363674;5306.8407947761625;5313.415524292324;5327.227552004938;5332.30680011596;5334.653247538898;4348.847790327323;4460.799264033127;4479.955200447954;4546.318052292117;4546.318052292183;2803.9299017524727;2828.292926768308;2839.892441947642;2845.6056532299026;2854.929401474447;4941.160002799533;4965.280034394992;4970.17992031318;4990.326305948651;5021.623378246646;5194.740262986836;5440.727963601804;5447.945520544744;5464.316960379952;5503.504684578407;4953.529414705597;4958.157113290749;4961.5534601886;4993.875153121128;4997.700137991732;5284.630075894651;5297.894042119213;5301.496357845998;5337.519623233928;5343.145096784496;4912.312276281252;5156.762377029561;5198.246254293182;5209;5239.371275446971;4885.926711099265;4911.140550403594;4927.334809800775;4952.4057113146655;4956.479569645136;3759.661630453272;3763.1344790697744;3772.7359084864893;3777.0934975606206;3787.3561494546543;5096.541311282002;5299.7615107321035;5323.441038690882;5413.404525502113;5420.783168673367;5232.659877107976;5250.579953603779;5254.632175747661;5261.710605916712;5273.367195936512;5251.921221181762;5265;5276.234945932895;5282.366116066097;5295.549878260391;5065.493450654905;5141.203113517411;5213.7914483421755;5232.037985755342;5234.749057905137;5087.364079490064;5131.717755523482;5299.8410047698635;5312.229726689531;5337.199420087018;5189.195674670432;5213.322268105122;5229.267902493578;5231.8168864089575;5232.816851410183 01:35:30 INFO - PROCESS | 8810 | |5;yui.html;642.7300533775814;646.8576913079121;649.8277956341569;679.0527214535723;730.8940203670468;12362.752744945106;13268.734625307488;13295.202287862723;13298.933505332472;13299.933500332485;11621.47703353349;12061.095417843675;12092.516299348015;12102;12133;795.8527672380599;804.0873608454417;804.4167978215776;804.5172896262254;804.8229389534322;784.1335324466468;790.9604519774017;790.9802254943644;791.1495142721568;791.2325044706625;791.4776247676534;798.564782193703;800.5956991719173;800.7357572001255;801.5351096364124;799.2207597592359;799.7400844725429;799.8240387114826;800.4476910931497;800.5756948817136;593.092568370394;593.2910172344051;593.7446897833929;594.1384991761962;594.5273507561499;12323;12378.319192444413;12389.504419823195;12439.626811195678;12441.875581244161;12966.611001669966;13545.525906593222;13772.586822395344;13863.306834658226;14017.929910350384;10673.997818583897;10697.09074728649;10745.677629671123;10829.83755243672;10943.726406839813;3420.846061927219;3448.913777155591;3457.4640930655787;3468.4623883298127;3486.773359731609;43845.78077109626;44201.33697994533;53710;54095.72952135293;56018;10009.64966226193;10173.186145108373;10532.684019479428;10567.365958042543;10948.069414099731;18605.7209141863;18967.525811854815;18976.335828245945;19020.23919043223;19101.713474297896;5858.414158584193;5966.284045914518;6059.454649081604;6060.606060606135;7359.4848360615315;3896.6298201670797;3996.900077498086;4009.8596549121226;4024.014116541466;4087.795610219477;2865.2407112115307;2982.209714425679;3016.3213277012937;3016.6078409806587;3020.1694534003327;508.0575532387442;508.9185730283137;512.3800201755917;513.9306193663807;514.6886133888943;535.8124656370317;592;609.515435228994;625.4964753373487;641.0800501280677;7807.375409967189;8416.705415310435;8476.279516241066;8495.702650407206;8708.43395179324;484.5058040798366;609.1319869186392;622.8638803623733;624.4848000399597;640.2445114764529;3989.3218152914073;4058.1072164123843;4068.613481719232;4136.937945930814;4244.151169765997;93366;95357.45368643542;96610;96984.54523182158;97432.51283743537;79789.60105199553;85282.47175282546;86328.13671863326;86631.56684216538;87403.56298218468;44977;46009.15963361495;71387.64306178436;73904.63047684728;76352.2364776345;7677.347425468674;7804.453688241996;7863.292303692695;7915.604219789103;7977.880331794911;44174.779126104164;44665.33002005037;44702.3294650587;45339.77330113328;45409;58360.70819645875;59555.404445954984;60495.697521513874;63203.36796631975;64371;9898.703038908845;10169.89830101719;10219.948900255451;10340.172786176938;11223.214374993671;13169.407376668265;13215.66960825987;13438.865611343761;13448.327583620976;13451.192928424325;12073.154879158375;12351.3824308786;12370.681265813826;12866.485340586272;13025.218486890817;12272.693182670504;12349.691257718629;12807;13176.076142106545;13297.80053299182;11719.179657423898;11719.238249514096;11972.16194866351;13046;13054.15148015376;10082.798344032932;10094.54574544162;10573.390515382076;10848.288331365886;10932.56269749201;9920.255980801325;10033.648822291185;10176.542055607664;10208.693739187836;10240.692779216635 01:35:30 INFO - PROCESS | 8810 | __end_tp_report 01:35:30 INFO - PROCESS | 8810 | __start_cc_report 01:35:30 INFO - PROCESS | 8810 | _x_x_mozilla_cycle_collect,1074 01:35:30 INFO - PROCESS | 8810 | __end_cc_report 01:35:30 INFO - PROCESS | 8810 | __startTimestamp1466670930399__endTimestamp 01:35:30 INFO - PROCESS | 8810 | 01:35:30 INFO - PROCESS | 8810 | ------- Summary: start ------- 01:35:30 INFO - PROCESS | 8810 | Number of tests: 6 01:35:30 INFO - PROCESS | 8810 | 01:35:30 INFO - PROCESS | 8810 | [#0] dojo.html Cycles:165 Average:4860.11 Median:4976.53 stddev:544.91 (10.9%) stddev-sans-first:517.01 01:35:30 INFO - PROCESS | 8810 | Values: 2602.8 2612.1 2639.1 2639.5 2647.7 4756.3 4762.7 4821.0 4844.9 4860.2 4851.6 4877.6 4896.7 4992.8 4994.5 4438.2 4470.2 4480.7 4540.9 4645.3 4541.8 4581.3 4591.1 4602.3 4629.3 4367.5 4372.2 4421.9 4425.0 4429.6 4394.8 4409.6 4411.9 4452.1 4463.0 4445.5 4455.9 4462.6 4487.8 4501.1 4792.4 4893.0 4911.6 4959.9 4966.2 5412.7 5412.9 5429.4 5429.5 5432.3 5441.6 5449.5 5478.6 5486.0 5487.6 4800.8 4896.1 4948.4 4952.8 4955.5 5449.6 5452.6 5509.1 5512.4 5512.6 4972.1 5240.1 5242.6 5243.1 5247.5 5287.6 5296.3 5323.2 5364.5 5369.0 5236.9 5250.2 5253.7 5260.6 5340.8 5040.3 5173.3 5262.1 5266.6 5273.6 4501.3 4511.5 4517.5 4565.2 4570.7 3898.2 3902.8 3913.7 3922.0 3942.0 4363.7 4383.0 4499.7 4546.8 4548.6 5125.3 5217.5 5221.8 5232.4 5239.5 4442.1 4456.1 4468.4 4483.0 4506.2 4635.1 4722.7 4745.1 4753.0 4783.5 4932.9 4952.0 4962.7 4981.3 5019.8 5268.2 5290.0 5312.4 5314.5 5355.0 4811.4 4889.2 4895.0 4976.5 4982.3 5205.8 5222.0 5225.1 5232.3 5262.0 5252.4 5253.6 5305.1 5314.8 5368.8 4893.0 4945.0 5008.3 5024.3 5076.8 5095.2 5103.3 5124.0 5124.2 5171.7 5060.5 5062.8 5138.8 5140.6 5149.9 5008.4 5078.3 5126.8 5155.5 5174.4 5024.9 5054.9 5056.8 5062.3 5115.9 01:35:30 INFO - PROCESS | 8810 | 01:35:30 INFO - PROCESS | 8810 | [#1] ext.html Cycles:180 Average:47939.02 Median:19575.98 stddev:86301.95 (440.9%) stddev-sans-first:86470.71 01:35:30 INFO - PROCESS | 8810 | Values: 553.3 573.6 580.6 589.2 608.8 27158.3 29678.4 29692.3 29694.7 29704.4 28558.0 29363.6 40981.8 41906.4 41980.2 7564.5 7680.4 7686.7 7687.7 7688.9 7688.9 7787.6 7788.3 7788.4 7789.7 7622.2 9993.1 10255.4 10257.1 10555.0 9985.5 10045.3 10052.6 10057.7 10059.4 6432.3 9751.9 9923.2 10000.7 10001.7 35937.6 39661.2 39686.8 39708.6 39727.0 3009.0 3110.2 3542.3 3665.3 3693.7 29931.3 29933.9 30005.4 30139.8 31383.2 3480.3 3524.4 3542.3 3544.8 3582.4 263482.0 266571.0 267282.0 267293.0 267314.0 54272.7 54578.0 54614.2 54650.0 54739.2 57065.4 57132.0 57163.0 57200.0 57210.4 13777.9 13997.4 14010.8 14014.6 14014.7 10538.6 10580.4 10592.2 10598.0 10613.0 14881.6 15473.4 16113.1 16776.0 16871.6 6064.4 6086.8 6096.8 6192.0 6234.0 825.5 899.6 909.5 912.0 931.5 27886.4 28141.6 28463.7 28833.9 28926.4 932.3 948.1 990.8 991.9 994.2 15039.3 15342.8 15895.2 16261.6 16513.5 383972.0 385658.0 387421.0 388361.0 388596.0 50654.0 50721.5 50737.2 50782.7 50783.0 1173.5 1177.3 1216.2 1216.7 1219.7 27488.5 29021.0 29193.0 29214.9 29436.4 43266.8 43678.0 43699.0 43790.8 43806.3 314273.0 319670.0 320434.0 321836.0 321977.0 22502.8 23293.4 24674.5 25061.7 25538.6 39172.4 42487.4 43173.0 43359.3 43885.8 35326.3 36220.6 37104.3 37194.8 37559.6 35607.1 36285.5 36431.6 36537.6 36707.0 35203.0 35353.0 39421.0 40076.8 40085.8 32035.4 33364.3 33565.8 34118.3 34204.1 25779.6 25822.5 26004.3 26034.6 26045.1 01:35:30 INFO - PROCESS | 8810 | 01:35:30 INFO - PROCESS | 8810 | [#2] jquery.html Cycles:180 Average:23800.88 Median:23566.38 stddev:63209.11 (268.2%) stddev-sans-first:63361.95 01:35:30 INFO - PROCESS | 8810 | Values: 372.1 372.2 373.1 386.1 389.0 15628.4 16795.2 17430.7 17573.1 17578.1 16187.4 17131.1 17293.3 17295.7 17314.9 4955.5 5152.3 5183.6 5187.3 5191.2 3064.2 3211.9 5059.8 5678.4 5992.8 6019.7 6027.1 6052.2 6053.0 6055.5 5798.8 6092.6 6096.1 6101.6 6105.1 3042.0 4988.6 5348.5 5357.5 5358.5 19958.4 20660.2 20707.0 20753.5 20811.0 2002.3 2085.1 2339.5 2370.0 2420.4 12730.1 13243.0 13354.3 13700.2 13928.6 1772.5 1832.3 1854.1 1857.7 1893.6 64303.7 64497.7 64975.7 66748.3 66849.7 9060.9 9638.2 9859.7 10161.1 10529.6 13317.6 13348.1 13406.3 13438.5 13443.9 7003.1 7096.0 7140.4 7225.4 7267.7 6784.8 6831.2 6916.3 6969.0 6980.4 5892.4 5962.4 6153.6 6168.4 6203.9 1590.3 1721.8 1729.6 1732.7 1750.7 759.3 901.8 907.9 932.9 972.5 16726.0 17547.3 17645.4 18032.7 18217.2 845.6 881.5 895.7 907.1 920.5 9636.6 10048.3 10194.6 10207.7 10300.2 371749.0 383027.0 387920.0 389468.0 390758.0 42330.8 51765.7 57623.7 70951.0 84099.0 865.0 866.3 870.7 909.9 924.5 15714.3 15791.1 15875.8 15928.4 16211.3 29801.6 35859.1 37958.1 38534.0 39188.4 48631.0 49602.5 52415.5 55922.7 58440.7 4802.0 5743.3 6306.5 7632.8 7961.4 8811.9 10768.2 11672.2 11878.2 12181.7 9427.7 9707.6 9957.6 10088.5 10234.9 9980.7 10295.4 10370.3 10534.9 10576.5 9101.3 9773.7 10348.4 10615.6 10953.1 7831.2 7837.2 7854.5 8043.4 8202.1 8115.4 9508.0 10348.8 10382.7 10560.5 01:35:30 INFO - PROCESS | 8810 | 01:35:30 INFO - PROCESS | 8810 | [#3] mootools.html Cycles:180 Average:5180.62 Median:4947.35 stddev:2937.07 (59.4%) stddev-sans-first:2929.93 01:35:30 INFO - PROCESS | 8810 | Values: 1182.0 1366.6 1424.7 1455.3 1653.8 6755.3 7675.1 7875.7 7923.4 8134.1 7849.8 7992.4 7995.6 7996.0 8009.8 2210.8 2246.5 2249.5 2250.3 2252.8 2176.2 2180.4 2255.7 2258.7 2260.2 2179.1 2193.3 2196.2 2202.9 2207.2 2163.2 2173.1 2181.8 2189.3 2191.6 2162.5 2164.1 2168.6 2169.0 2171.4 7845.3 7992.0 8057.6 8058.6 8079.5 4699.2 4811.9 4817.3 4821.2 4824.6 2918.6 3001.4 3038.2 3042.3 3047.0 890.7 907.5 911.6 916.4 918.4 10600.3 10625.6 10701.5 10720.0 10735.1 4078.4 4187.7 4259.0 4263.7 4269.9 8436.7 8470.2 8515.6 8523.7 8531.1 4613.8 4617.9 4635.3 4645.1 4647.7 3824.7 3991.7 4205.5 4278.9 4344.4 3488.3 3515.2 3532.8 3565.8 3678.3 1034.7 1040.2 1045.5 1048.4 1059.5 747.5 786.2 809.8 810.4 825.0 5191.7 5225.4 5296.2 5308.2 5433.8 851.2 859.2 888.9 890.7 902.6 3272.2 3643.9 3656.5 3676.1 3695.7 9793.1 10046.9 10078.1 10124.9 10151.3 9897.0 9931.8 9999.1 10014.3 10028.7 7500.8 7610.7 7665.5 7668.6 7680.8 5070.1 5118.3 5274.9 5275.2 5337.5 9134.9 9244.7 9252.3 9267.8 9347.3 8752.2 9128.9 9144.6 9330.3 9360.9 6212.1 6713.5 6880.1 6888.6 6902.3 7683.7 7705.2 7708.9 7741.7 7793.1 6727.2 6877.9 6965.3 6996.6 7146.9 6752.4 6752.5 6780.2 6811.6 6886.1 5988.4 6003.2 6022.5 6053.5 6115.5 4416.4 4466.1 4468.6 4544.5 4545.9 4412.1 4437.0 4450.9 4466.3 4517.5 01:35:30 INFO - PROCESS | 8810 | 01:35:30 INFO - PROCESS | 8810 | [#4] prototype.html Cycles:180 Average:4314.65 Median:4939.42 stddev:1259.90 (25.5%) stddev-sans-first:1226.80 01:35:30 INFO - PROCESS | 8810 | Values: 295.7 296.0 299.7 302.7 304.3 4988.8 4996.6 5005.6 5024.0 5030.5 4926.3 4934.9 4937.7 4967.5 4987.2 3612.0 3700.6 3793.4 3870.5 3889.5 3826.0 3864.7 3876.5 3884.7 3896.9 3822.2 3826.8 3838.6 3839.4 3848.0 3690.5 3745.5 3856.5 3863.2 3882.6 3415.3 3419.9 3431.0 3433.3 3434.4 4847.1 4868.3 4884.3 4894.2 4947.6 4210.9 4408.8 4410.9 4488.8 4511.3 5212.1 5222.5 5234.1 5237.3 5249.0 3706.6 3710.0 3720.1 3736.3 3745.9 5395.8 5412.5 5498.4 5519.3 5528.9 3795.5 3800.3 3800.6 3806.0 3815.5 3853.0 3856.3 3859.3 3862.2 3876.4 4383.3 4421.5 4422.6 4432.7 4443.5 5064.3 5257.9 5267.4 5275.8 5277.5 1291.7 1313.9 1319.5 1321.0 1321.3 840.8 848.0 861.8 891.5 911.4 4501.3 4508.8 4514.9 4527.0 4534.1 5306.8 5313.4 5327.2 5332.3 5334.7 4348.8 4460.8 4480.0 4546.3 4546.3 2803.9 2828.3 2839.9 2845.6 2854.9 4941.2 4965.3 4970.2 4990.3 5021.6 5194.7 5440.7 5447.9 5464.3 5503.5 4953.5 4958.2 4961.6 4993.9 4997.7 5284.6 5297.9 5301.5 5337.5 5343.1 4912.3 5156.8 5198.2 5209.0 5239.4 4885.9 4911.1 4927.3 4952.4 4956.5 3759.7 3763.1 3772.7 3777.1 3787.4 5096.5 5299.8 5323.4 5413.4 5420.8 5232.7 5250.6 5254.6 5261.7 5273.4 5251.9 5265.0 5276.2 5282.4 5295.5 5065.5 5141.2 5213.8 5232.0 5234.7 5087.4 5131.7 5299.8 5312.2 5337.2 5189.2 5213.3 5229.3 5231.8 5232.8 01:35:30 INFO - PROCESS | 8810 | 01:35:30 INFO - PROCESS | 8810 | [#5] yui.html Cycles:180 Average:17123.21 Median:44433.33 stddev:24088.96 (54.2%) stddev-sans-first:24124.75 01:35:30 INFO - PROCESS | 8810 | Values: 642.7 646.9 649.8 679.1 730.9 12362.8 13268.7 13295.2 13298.9 13299.9 11621.5 12061.1 12092.5 12102.0 12133.0 795.9 804.1 804.4 804.5 804.8 784.1 791.0 791.0 791.1 791.2 791.5 798.6 800.6 800.7 801.5 799.2 799.7 799.8 800.4 800.6 593.1 593.3 593.7 594.1 594.5 12323.0 12378.3 12389.5 12439.6 12441.9 12966.6 13545.5 13772.6 13863.3 14017.9 10674.0 10697.1 10745.7 10829.8 10943.7 3420.8 3448.9 3457.5 3468.5 3486.8 43845.8 44201.3 53710.0 54095.7 56018.0 10009.6 10173.2 10532.7 10567.4 10948.1 18605.7 18967.5 18976.3 19020.2 19101.7 5858.4 5966.3 6059.5 6060.6 7359.5 3896.6 3996.9 4009.9 4024.0 4087.8 2865.2 2982.2 3016.3 3016.6 3020.2 508.1 508.9 512.4 513.9 514.7 535.8 592.0 609.5 625.5 641.1 7807.4 8416.7 8476.3 8495.7 8708.4 484.5 609.1 622.9 624.5 640.2 3989.3 4058.1 4068.6 4136.9 4244.2 93366.0 95357.5 96610.0 96984.5 97432.5 79789.6 85282.5 86328.1 86631.6 87403.6 44977.0 46009.2 71387.6 73904.6 76352.2 7677.3 7804.5 7863.3 7915.6 7977.9 44174.8 44665.3 44702.3 45339.8 45409.0 58360.7 59555.4 60495.7 63203.4 64371.0 9898.7 10169.9 10219.9 10340.2 11223.2 13169.4 13215.7 13438.9 13448.3 13451.2 12073.2 12351.4 12370.7 12866.5 13025.2 12272.7 12349.7 12807.0 13176.1 13297.8 11719.2 11719.2 11972.2 13046.0 13054.2 10082.8 10094.5 10573.4 10848.3 10932.6 9920.3 10033.6 10176.5 10208.7 10240.7 01:35:30 INFO - PROCESS | 8810 | -------- Summary: end -------- 01:35:30 INFO - PROCESS | 8810 | 01:35:31 INFO - TEST-INFO | 8810: exit 0 01:35:31 INFO - TEST-OK | dromaeo_css | took 1120097ms 01:35:31 INFO - TEST-START | kraken 01:35:31 INFO - operating with platform_type : linux_ 01:35:31 INFO - Initialising browser for kraken test... 01:35:31 INFO - TEST-INFO | started process 8995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp6fBwb/profile http://localhost:36536/getInfo.html) 01:35:35 INFO - PROCESS | 8995 | __metrics Screen width/height:1600/1200 01:35:35 INFO - PROCESS | 8995 | colorDepth:24 01:35:35 INFO - PROCESS | 8995 | Browser inner width/height: 1024/697 01:35:35 INFO - PROCESS | 8995 | __metrics 01:35:36 INFO - PROCESS | 8995 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:35:37 INFO - TEST-INFO | 8995: exit 0 01:35:37 INFO - Browser initialized. 01:35:37 INFO - Running cycle 1/1 for kraken test... 01:35:37 INFO - TEST-INFO | started process 9077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp6fBwb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:49 INFO - PROCESS | 9077 | RSS: Main: 175431680 01:35:49 INFO - PROCESS | 9077 | 01:35:52 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36536/tests/kraken/driver.html?testName=audio-beat-detection) 01:35:53 INFO - PROCESS | 9077 | RSS: Main: 233902080 01:35:53 INFO - PROCESS | 9077 | 01:35:56 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36536/tests/kraken/driver.html?testName=audio-dft) 01:35:56 INFO - PROCESS | 9077 | RSS: Main: 223481856 01:35:56 INFO - PROCESS | 9077 | 01:36:00 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36536/tests/kraken/driver.html?testName=audio-fft) 01:36:00 INFO - PROCESS | 9077 | RSS: Main: 288444416 01:36:00 INFO - PROCESS | 9077 | 01:36:02 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36536/tests/kraken/driver.html?testName=audio-oscillator) 01:36:03 INFO - PROCESS | 9077 | RSS: Main: 197959680 01:36:03 INFO - PROCESS | 9077 | 01:36:05 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36536/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:36:06 INFO - PROCESS | 9077 | RSS: Main: 202219520 01:36:06 INFO - PROCESS | 9077 | 01:36:09 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36536/tests/kraken/driver.html?testName=imaging-darkroom) 01:36:10 INFO - PROCESS | 9077 | RSS: Main: 238837760 01:36:10 INFO - PROCESS | 9077 | 01:36:13 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36536/tests/kraken/driver.html?testName=imaging-desaturate) 01:36:14 INFO - PROCESS | 9077 | RSS: Main: 234102784 01:36:14 INFO - PROCESS | 9077 | 01:36:17 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36536/tests/kraken/driver.html?testName=json-parse-financial) 01:36:17 INFO - PROCESS | 9077 | RSS: Main: 237576192 01:36:17 INFO - PROCESS | 9077 | 01:36:19 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36536/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:36:20 INFO - PROCESS | 9077 | RSS: Main: 225488896 01:36:20 INFO - PROCESS | 9077 | 01:36:21 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36536/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:36:22 INFO - PROCESS | 9077 | RSS: Main: 229548032 01:36:22 INFO - PROCESS | 9077 | 01:36:24 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36536/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:36:25 INFO - PROCESS | 9077 | RSS: Main: 238186496 01:36:25 INFO - PROCESS | 9077 | 01:36:28 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:36:28 INFO - PROCESS | 9077 | RSS: Main: 240750592 01:36:28 INFO - PROCESS | 9077 | 01:36:31 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:36:32 INFO - PROCESS | 9077 | RSS: Main: 238895104 01:36:32 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | Cycle 1(1): loaded http://localhost:36536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36536/tests/kraken/driver.html?testName=ai-astar) 01:36:34 INFO - PROCESS | 9077 | RSS: Main: 281698304 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | __start_tp_report 01:36:34 INFO - PROCESS | 9077 | _x_x_mozilla_page_load 01:36:34 INFO - PROCESS | 9077 | _x_x_mozilla_page_load_details 01:36:34 INFO - PROCESS | 9077 | |i|pagename|runs| 01:36:34 INFO - PROCESS | 9077 | |0;ai-astar;105;115;115;117;116;113;115;112;113;113 01:36:34 INFO - PROCESS | 9077 | |1;audio-beat-detection;163;130;132;190;130;131;152;132;170;140 01:36:34 INFO - PROCESS | 9077 | |2;audio-dft;162;162;163;162;162;163;162;163;163;162 01:36:34 INFO - PROCESS | 9077 | |3;audio-fft;76;75;76;105;77;78;75;75;104;74 01:36:34 INFO - PROCESS | 9077 | |4;audio-oscillator;86;85;128;85;93;87;116;85;86;121 01:36:34 INFO - PROCESS | 9077 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 01:36:34 INFO - PROCESS | 9077 | |6;imaging-darkroom;147;146;146;147;147;147;146;146;147;146 01:36:34 INFO - PROCESS | 9077 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;94 01:36:34 INFO - PROCESS | 9077 | |8;json-parse-financial;63;63;64;63;63;72;63;63;63;63 01:36:34 INFO - PROCESS | 9077 | |9;json-stringify-tinderbox;66;67;66;65;68;66;66;66;70;72 01:36:34 INFO - PROCESS | 9077 | |10;stanford-crypto-aes;88;87;87;81;82;85;86;84;108;83 01:36:34 INFO - PROCESS | 9077 | |11;stanford-crypto-ccm;134;129;139;131;147;129;133;130;137;134 01:36:34 INFO - PROCESS | 9077 | |12;stanford-crypto-pbkdf2;169;173;170;168;168;173;167;168;168;166 01:36:34 INFO - PROCESS | 9077 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;65;68;67;67;66 01:36:34 INFO - PROCESS | 9077 | __end_tp_report 01:36:34 INFO - PROCESS | 9077 | __start_cc_report 01:36:34 INFO - PROCESS | 9077 | _x_x_mozilla_cycle_collect,1879 01:36:34 INFO - PROCESS | 9077 | __end_cc_report 01:36:34 INFO - PROCESS | 9077 | __startTimestamp1466670994391__endTimestamp 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | ------- Summary: start ------- 01:36:34 INFO - PROCESS | 9077 | Number of tests: 14 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:3.34 (2.9%) stddev-sans-first:1.66 01:36:34 INFO - PROCESS | 9077 | Values: 105.0 115.0 115.0 117.0 116.0 113.0 115.0 112.0 113.0 113.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:146.00 stddev:21.06 (14.4%) stddev-sans-first:21.53 01:36:34 INFO - PROCESS | 9077 | Values: 163.0 130.0 132.0 190.0 130.0 131.0 152.0 132.0 170.0 140.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 01:36:34 INFO - PROCESS | 9077 | Values: 162.0 162.0 163.0 162.0 162.0 163.0 162.0 163.0 163.0 162.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:12.18 (16.1%) stddev-sans-first:12.75 01:36:34 INFO - PROCESS | 9077 | Values: 76.0 75.0 76.0 105.0 77.0 78.0 75.0 75.0 104.0 74.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:85.50 stddev:17.28 (20.2%) stddev-sans-first:17.85 01:36:34 INFO - PROCESS | 9077 | Values: 86.0 85.0 128.0 85.0 93.0 87.0 116.0 85.0 86.0 121.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:36:34 INFO - PROCESS | 9077 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:36:34 INFO - PROCESS | 9077 | Values: 147.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 01:36:34 INFO - PROCESS | 9077 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:63.00 stddev:2.83 (4.5%) stddev-sans-first:2.98 01:36:34 INFO - PROCESS | 9077 | Values: 63.0 63.0 64.0 63.0 63.0 72.0 63.0 63.0 63.0 63.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:66.50 stddev:2.20 (3.3%) stddev-sans-first:2.29 01:36:34 INFO - PROCESS | 9077 | Values: 66.0 67.0 66.0 65.0 68.0 66.0 66.0 66.0 70.0 72.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.50 stddev:7.69 (9.0%) stddev-sans-first:8.15 01:36:34 INFO - PROCESS | 9077 | Values: 88.0 87.0 87.0 81.0 82.0 85.0 86.0 84.0 108.0 83.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:134.00 stddev:5.56 (4.1%) stddev-sans-first:5.89 01:36:34 INFO - PROCESS | 9077 | Values: 134.0 129.0 139.0 131.0 147.0 129.0 133.0 130.0 137.0 134.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:168.50 stddev:2.36 (1.4%) stddev-sans-first:2.50 01:36:34 INFO - PROCESS | 9077 | Values: 169.0 173.0 170.0 168.0 168.0 173.0 167.0 168.0 168.0 166.0 01:36:34 INFO - PROCESS | 9077 | 01:36:34 INFO - PROCESS | 9077 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 01:36:34 INFO - PROCESS | 9077 | Values: 67.0 68.0 67.0 67.0 67.0 65.0 68.0 67.0 67.0 66.0 01:36:34 INFO - PROCESS | 9077 | -------- Summary: end -------- 01:36:34 INFO - PROCESS | 9077 | 01:36:35 INFO - TEST-INFO | 9077: exit 0 01:36:35 INFO - TEST-OK | kraken | took 64223ms 01:36:35 INFO - SUITE-END | took 1184s 01:36:35 INFO - Completed test suite (00:19:44) 01:36:35 INFO - javascript benchmark 01:36:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.7787638050763, 2612.1118819601356, 2639.1158961747824, 2639.45891092326, 2647.682278126625, 4756.262779269219, 4762.666613337068, 4821.0, 4844.927326090103, 4860.198067318893, 4851.636127290459, 4877.634177436697, 4896.657233993622, 4992.7753251103695, 4994.475580064086, 4438.178936896685, 4470.195364834329, 4480.731156130626, 4540.9091818163615, 4645.3264276679865, 4541.772911354436, 4581.289900065479, 4591.058832939239, 4602.2636378179495, 4629.328747331635, 4367.475902891658, 4372.1692878353015, 4421.889452763707, 4424.9557504424865, 4429.645628349725, 4394.780260986938, 4409.625181859546, 4411.889702757425, 4452.065066336041, 4463.0, 4445.466544014706, 4455.866324010252, 4462.598366147063, 4487.798049087766, 4501.144782491349, 4792.424909010941, 4893.04585605807, 4911.631627627907, 4959.851204463872, 4966.205407134841, 5412.729363531807, 5412.91880621791, 5429.4299098594865, 5429.53848922842, 5432.293801805779, 5441.59188060897, 5449.509544141007, 5478.561715062785, 5486.0, 5487.588430867661, 4800.831970881038, 4896.069746748178, 4948.38145231846, 4952.801887924443, 4955.4548999610015, 5449.618526703172, 5452.6183167177915, 5509.090999985037, 5512.448755124536, 5512.641678290898, 4972.129877271463, 5240.0567897778765, 5242.633015688942, 5243.134882744381, 5247.501487358695, 5287.550558202519, 5296.285001524822, 5323.201519772065, 5364.490373414519, 5369.033573956647, 5236.92144617831, 5250.159974404077, 5253.684778913277, 5260.579153667697, 5340.813071542478, 5040.294358789773, 5173.301604283449, 5262.052830490548, 5266.578673706171, 5273.630845840831, 4501.257292546758, 4511.458624965026, 4517.503074661785, 4565.223911934979, 4570.680052396367, 3898.181381909774, 3902.785346805953, 3913.745606535566, 3922.0391004204153, 3942.034201620564, 4363.650907927422, 4382.956170438319, 4499.662525310615, 4546.772661366985, 4548.5906268436, 5125.2568377585785, 5217.530422262014, 5221.817236396708, 5232.39827419844, 5239.502247286502, 4442.089371678798, 4456.120547999935, 4468.4414448193975, 4483.0, 4506.1663592235545, 4635.142498637695, 4722.693024953367, 4745.074710431501, 4752.95247047532, 4783.473817880031, 4932.926006109983, 4951.950480495149, 4962.727050012284, 4981.277714731416, 5019.84940451787, 5268.209768534597, 5290.021346050993, 5312.442193569774, 5314.5482633975, 5354.973225133849, 4811.398575178103, 4889.168841297059, 4895.020995800783, 4976.527229913152, 4982.252662100714, 5205.817796377109, 5222.0, 5225.137852254487, 5232.3459567554055, 5262.000219958196, 5252.42223355423, 5253.579713622978, 5305.071612467726, 5314.787408503771, 5368.812091576776, 4893.045856058035, 4945.035718034948, 5008.348914641073, 5024.321716568363, 5076.796928122982, 5095.210242412432, 5103.3110530077965, 5124.0, 5124.231365295235, 5171.689698618095, 5060.49395060491, 5062.797488100582, 5138.820141295037, 5140.614453915897, 5149.871253218699, 5008.449070602158, 5078.263651770399, 5126.769295381642, 5155.53600175986, 5174.379074511083, 5024.874378140576, 5054.924176137434, 5056.84829455117, 5062.291279220838, 5115.897682046412], "value": 4822.621859724123, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.26415866897, 573.6128113523376, 580.5674772294639, 589.1986897818965, 608.7990962982217, 27158.321041973937, 29678.40643187135, 29692.257693557644, 29694.703052969464, 29704.40591188175, 28558.0, 29363.55954660682, 40981.79509102458, 41906.37140442896, 41980.160396792046, 7564.508306960058, 7680.385569154482, 7686.692532298702, 7687.693092174316, 7688.9231107688765, 7688.9231107688765, 7787.610619469032, 7788.337991270749, 7788.415868809833, 7789.688412463523, 7622.237776222389, 9993.050660187308, 10255.384676919371, 10257.128144107759, 10555.0, 9985.500724963722, 10045.296829221958, 10052.648157314496, 10057.748556286151, 10059.396436213778, 6432.260290066655, 9751.853722194173, 9923.206143508574, 10000.749981250454, 10001.749956251078, 35937.64062359369, 39661.20677586461, 39686.801565992275, 39708.60291397078, 39727.0, 3009.0, 3110.2311281801276, 3542.3446662367546, 3665.303592317478, 3693.741438099334, 29931.25171870699, 29933.850330748206, 30005.399892002257, 30139.849300753576, 31383.215419614466, 3480.32133733922, 3524.3832329342263, 3542.256126213498, 3544.8404821782824, 3582.3551760683067, 263482.0, 266570.9999999981, 267282.0, 267293.0, 267314.0, 54272.72863635736, 54578.0, 54614.18078728743, 54650.0, 54739.17891231635, 57065.42934570601, 57132.0, 57163.0, 57200.0, 57210.42789572051, 13777.862221377658, 13997.44010239579, 14010.789838152436, 14014.649633759238, 14014.71970560583, 10538.578456861793, 10580.418077005685, 10592.15262778976, 10598.0, 10613.0, 14881.627959301104, 15473.381064757283, 16113.113778742047, 16776.0, 16871.578210544834, 6064.423879731418, 6086.817395478054, 6096.847578810476, 6191.9690401547705, 6234.0, 825.5459497276474, 899.6356475627381, 909.4679612426804, 911.9863202051974, 931.5063016601213, 27886.44227115487, 28141.57787633187, 28463.715362846106, 28833.855830720713, 28926.42147157045, 932.3333816321227, 948.0993056596124, 990.7671697151163, 991.8859331177007, 994.2046362909788, 15039.323230454656, 15342.769858452131, 15895.205239737967, 16261.59346016359, 16513.504594862174, 383972.0, 385658.0, 387421.0, 388361.0, 388596.0, 50654.0, 50721.49278507241, 50737.23894141591, 50782.74608626933, 50783.0, 1173.4543437301695, 1177.2936238256978, 1216.2094638485055, 1216.7140721930339, 1219.676785651803, 27488.45023099487, 29021.0, 29193.0, 29214.853925730236, 29436.411271774017, 43266.783666081465, 43678.0, 43699.0, 43790.78104609456, 43806.34290485709, 314273.0, 319670.0, 320434.0, 321836.0, 321977.0, 22502.77497225072, 23293.417664557845, 24674.50650986934, 25061.749382505943, 25538.616920745833, 39172.41241381439, 42487.3626895603, 43173.0, 43359.34960975525, 43885.78057109694, 35326.293474130885, 36220.637793621725, 37104.25791484209, 37194.8140259297, 37559.62440375561, 35607.10982225362, 36285.455718164776, 36431.635683642824, 36537.63462365342, 36707.0, 35203.0, 35353.0, 39421.0, 40076.799616001736, 40085.799571003125, 32035.35929281448, 33364.332713346084, 33565.83217083899, 34118.31763364768, 34204.14489637679, 25779.613305800052, 25822.483550328514, 26004.34989125287, 26034.60948085818, 26045.088421905144], "value": 17762.667478423005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.0846717075993, 372.2350569579514, 373.1454968122998, 386.08497860071634, 388.9863854765082, 15628.3748650054, 16795.244214010385, 17430.738538921927, 17573.121343932817, 17578.121093945283, 16187.433439829609, 17131.14344282787, 17293.30826766931, 17295.654086918254, 17314.913425432886, 4955.4548999610015, 5152.304438900756, 5183.611229157809, 5187.325647665798, 5191.247269145972, 3064.1879901826032, 3211.903642890717, 5059.848204553869, 5678.43215678433, 5992.7902523411685, 6019.69901504923, 6027.095935609672, 6052.213212282397, 6053.0, 6055.485283750886, 5798.826035218929, 6092.634441933476, 6096.055111457731, 6101.603395779282, 6105.084237364386, 3041.9847900760356, 4988.625853060998, 5348.491893270133, 5357.464253574651, 5358.517733403974, 19958.401247962585, 20660.17359305626, 20707.0, 20753.481162970897, 20811.0, 2002.2791794953805, 2085.103405535619, 2339.4853132310864, 2369.992753079934, 2420.3586049696846, 12730.108892377537, 13243.0, 13354.26551539665, 13700.246486443242, 13928.582142535639, 1772.4771192498115, 1832.3128826689992, 1854.1192933356683, 1857.7120546315343, 1893.5739458621838, 64303.67848160729, 64497.67751161261, 64975.675121625034, 66748.3325166747, 66849.66575167142, 9060.912690477053, 9638.228941684649, 9859.654912078044, 10161.08550230468, 10529.631462898762, 13317.600471985856, 13348.065635405428, 13406.329683515785, 13438.462461501626, 13443.932780336036, 7003.054587630707, 7096.042034325404, 7140.357367836919, 7225.385842203472, 7267.672954717051, 6784.8303792404595, 6831.180258369028, 6916.308369163144, 6968.965155174192, 6980.371766541036, 5892.381299963527, 5962.403759624003, 6153.6334776619715, 6168.35232300602, 6203.875922481525, 1590.3479573374862, 1721.7675613792228, 1729.5762538178226, 1732.7424442048869, 1750.7132257790513, 759.2710997442407, 901.8286525560254, 907.9364444488955, 932.8507438809758, 972.5429048347265, 16726.0, 17547.29810807579, 17645.38241161553, 18032.729509057375, 18217.18022688982, 845.5856630251255, 881.5460038080394, 895.7357579514058, 907.1427501011481, 920.4753290624413, 9636.614535418645, 10048.29661923673, 10194.643187488402, 10207.693769186937, 10300.175985921258, 371749.0, 383027.0, 387920.0, 389468.0, 390758.0, 42330.78834605869, 51765.741171294656, 57623.71188144032, 70951.0, 84099.0, 864.9870251946226, 866.3156106675782, 870.6734974384606, 909.8680691299725, 924.523870206844, 15714.292856821241, 15791.131487768283, 15875.841241587897, 15928.362865485251, 16211.270492828087, 29801.5529767058, 35859.103522411104, 37958.051048724, 38534.0, 39188.41217381685, 48631.0, 49602.503974959785, 52415.47584524106, 55922.72038639944, 58440.707796460745, 4801.975990120027, 5743.3395159557185, 6306.4639505642535, 7632.80917977055, 7961.363090952594, 8811.911880881109, 10768.192385570957, 11672.182947193614, 11878.227915185485, 12181.69545761363, 9427.670031548863, 9707.563159657973, 9957.551910164206, 10088.54601542947, 10234.948825255826, 9980.650677226262, 10295.433751143759, 10370.27408081427, 10534.894651053391, 10576.524056417633, 9101.317401194805, 9773.657921972697, 10348.379097254188, 10615.575376984834, 10953.123750100132, 7831.216878312123, 7837.1770964047955, 7854.4894581851995, 8043.356531477585, 8202.09776924526, 8115.431919765796, 9508.0, 10348.844767328646, 10382.740431489274, 10560.471976401303], "value": 8297.961303181068, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1182.0425455381137, 1366.590022993102, 1424.68656895483, 1455.2796365798931, 1653.8263482334362, 6755.256921738611, 7675.078990521131, 7875.684972601096, 7923.3661307095435, 8134.105248422684, 7849.764507064797, 7992.360611151108, 7995.640196191185, 7995.960020199906, 8009.759707208778, 2210.7789221077883, 2246.4608493961496, 2249.5051088760447, 2250.2799104286637, 2252.7859853313907, 2176.1948079210715, 2180.3894909425385, 2255.661650752384, 2258.6837842702034, 2260.1976298414074, 2179.1174574297356, 2193.287181665957, 2196.2313190383397, 2202.9118835246572, 2207.2164381644525, 2163.1888041984257, 2173.098164261837, 2181.8363622728357, 2189.255653077945, 2191.5507320999236, 2162.5350549631903, 2164.1235299703644, 2168.642174041281, 2169.045619927227, 2171.4462811983003, 7845.293923546908, 7992.0, 8057.59712014397, 8058.5567793771315, 8079.515229086215, 4699.154152252593, 4811.855644330676, 4817.301491283744, 4821.180399332087, 4824.565789078964, 2918.5622156676454, 3001.3997200559975, 3038.2100653829943, 3042.2698552347497, 3047.0097218403885, 890.6838072484304, 907.4782000349825, 911.6399022386121, 916.4089162490156, 918.4168053286145, 10600.257981941268, 10625.574977000912, 10701.518431670516, 10720.0, 10735.141188704885, 4078.4494093297026, 4187.664986801049, 4259.041715613962, 4263.744175349489, 4269.893252668709, 8436.704715335056, 8470.237678608832, 8515.616797244138, 8523.701670441505, 8531.146885311418, 4613.76931153441, 4617.930731039037, 4635.281531362644, 4645.070985802853, 4647.674662773574, 3824.7187192290894, 3991.7006224533275, 4205.474315710536, 4278.850240241577, 4344.370066340363, 3488.2500262443696, 3515.156362472988, 3532.770369925998, 3565.769809415747, 3678.3378991781738, 1034.7169509807784, 1040.1730624153815, 1045.482486169351, 1048.4390850894736, 1059.4861492176287, 747.4805010517638, 786.2334224131426, 809.8056466448128, 810.4448452809844, 825.0264687668489, 5191.6884986900905, 5225.425203227642, 5296.179092240709, 5308.203769434615, 5433.809816656398, 851.1573542193184, 859.1623167411724, 888.8888888888889, 890.7416849113814, 902.5848109869534, 3272.1655977726004, 3643.872464463731, 3656.524651795303, 3676.1361080146144, 3695.7228207883977, 9793.069658382443, 10046.949765251273, 10078.092971632588, 10124.898751012543, 10151.289409741396, 9897.042847318413, 9931.80136397268, 9999.100080992746, 10014.29899907014, 10028.69913902584, 7500.774976750707, 7610.695572177162, 7665.463417560829, 7668.5782281975025, 7680.846383072308, 5070.138076526926, 5118.283440318432, 5274.947250527599, 5275.155975043975, 5337.519623233772, 9134.862977055482, 9244.722658320261, 9252.306077044113, 9267.814643707223, 9347.252219822534, 8752.168543988311, 9128.908710912805, 9144.588493517675, 9330.253579713471, 9360.859587106335, 6212.130301757667, 6713.530052896251, 6880.105586273752, 6888.621125838127, 6902.275261097512, 7683.654235559301, 7705.190954949874, 7708.884366734392, 7741.651625676745, 7793.06483222017, 6727.192139324884, 6877.931220687929, 6965.303469652994, 6996.580205187705, 7146.9285307146265, 6752.426043786137, 6752.459803215829, 6780.186377634715, 6811.591304521745, 6886.10480637514, 5988.431099045583, 6003.159557662018, 6022.45797878193, 6053.485453736305, 6115.480184184395, 4416.447944006999, 4466.106778644219, 4468.597826195658, 4544.545545445429, 4545.886352841206, 4412.139632771578, 4436.977815110904, 4450.910981780411, 4466.330050492322, 4517.525659805673], "value": 4144.690683389787, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.70872690399955, 295.9985200073999, 299.70928199646335, 302.703350716298, 304.2606466286922, 4988.7755051022705, 4996.600271978246, 5005.57452616528, 5023.995200959809, 5030.48475762119, 4926.261060840867, 4934.901301973959, 4937.6790508617005, 4967.478414766451, 4987.202047672373, 3611.9819400902957, 3700.574433940091, 3793.3930571108626, 3870.4774855394444, 3889.5138107736534, 3825.9808700956455, 3864.6908247340143, 3876.5154355705536, 3884.6503814656676, 3896.902577435558, 3822.159124992511, 3826.7512611680154, 3838.6161383861668, 3839.404892241707, 3848.0, 3690.483332333462, 3745.4943582616543, 3856.479375284329, 3863.2273545291055, 3882.5535063467496, 3415.299863527971, 3419.897403077912, 3430.9828450857835, 3433.3476639438427, 3434.3555462294144, 4847.079054979577, 4868.342773725537, 4884.340614017097, 4894.216925291972, 4947.604191664695, 4210.936835947463, 4408.845690400853, 4410.867673969786, 4488.775561221926, 4511.278195488739, 5212.071533532618, 5222.477752224785, 5234.136367499358, 5237.3453318335205, 5249.0, 3706.5737440194453, 3709.9814500927323, 3720.1071742781537, 3736.290104880064, 3745.906352341186, 5395.81114660985, 5412.485813847678, 5498.422665620133, 5519.267962358658, 5528.917066244009, 3795.4686343911876, 3800.2969450651717, 3800.6317725618756, 3806.01043728627, 3815.4849095372324, 3852.9982204627, 3856.305864944337, 3859.30190716084, 3862.208247309295, 3876.4185372193833, 4383.254846676073, 4421.53573874745, 4422.601965823027, 4432.734035957788, 4443.533428989909, 5064.341635587423, 5257.868553286122, 5267.367915850123, 5275.841724748264, 5277.498637629419, 1291.7018396511446, 1313.9408726607326, 1319.4524272427027, 1320.966975825612, 1321.2931081871152, 840.7771940435789, 847.9824210946888, 861.8104017116225, 891.460666296894, 911.4349103555705, 4501.324801279834, 4508.797104130322, 4514.864554063383, 4526.958799476073, 4534.093181363674, 5306.8407947761625, 5313.415524292324, 5327.227552004938, 5332.30680011596, 5334.653247538898, 4348.847790327323, 4460.799264033127, 4479.955200447954, 4546.318052292117, 4546.318052292183, 2803.9299017524727, 2828.292926768308, 2839.892441947642, 2845.6056532299026, 2854.929401474447, 4941.160002799533, 4965.280034394992, 4970.17992031318, 4990.326305948651, 5021.623378246646, 5194.740262986836, 5440.727963601804, 5447.945520544744, 5464.316960379952, 5503.504684578407, 4953.529414705597, 4958.157113290749, 4961.5534601886, 4993.875153121128, 4997.700137991732, 5284.630075894651, 5297.894042119213, 5301.496357845998, 5337.519623233928, 5343.145096784496, 4912.312276281252, 5156.762377029561, 5198.246254293182, 5209.0, 5239.371275446971, 4885.926711099265, 4911.140550403594, 4927.334809800775, 4952.4057113146655, 4956.479569645136, 3759.661630453272, 3763.1344790697744, 3772.7359084864893, 3777.0934975606206, 3787.3561494546543, 5096.541311282002, 5299.7615107321035, 5323.441038690882, 5413.404525502113, 5420.783168673367, 5232.659877107976, 5250.579953603779, 5254.632175747661, 5261.710605916712, 5273.367195936512, 5251.921221181762, 5265.0, 5276.234945932895, 5282.366116066097, 5295.549878260391, 5065.493450654905, 5141.203113517411, 5213.7914483421755, 5232.037985755342, 5234.749057905137, 5087.364079490064, 5131.717755523482, 5299.8410047698635, 5312.229726689531, 5337.199420087018, 5189.195674670432, 5213.322268105122, 5229.267902493578, 5231.8168864089575, 5232.816851410183], "value": 3910.799530562997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.7300533775814, 646.8576913079121, 649.8277956341569, 679.0527214535723, 730.8940203670468, 12362.752744945106, 13268.734625307488, 13295.202287862723, 13298.933505332472, 13299.933500332485, 11621.47703353349, 12061.095417843675, 12092.516299348015, 12102.0, 12133.0, 795.8527672380599, 804.0873608454417, 804.4167978215776, 804.5172896262254, 804.8229389534322, 784.1335324466468, 790.9604519774017, 790.9802254943644, 791.1495142721568, 791.2325044706625, 791.4776247676534, 798.564782193703, 800.5956991719173, 800.7357572001255, 801.5351096364124, 799.2207597592359, 799.7400844725429, 799.8240387114826, 800.4476910931497, 800.5756948817136, 593.092568370394, 593.2910172344051, 593.7446897833929, 594.1384991761962, 594.5273507561499, 12323.0, 12378.319192444413, 12389.504419823195, 12439.626811195678, 12441.875581244161, 12966.611001669966, 13545.525906593222, 13772.586822395344, 13863.306834658226, 14017.929910350384, 10673.997818583897, 10697.09074728649, 10745.677629671123, 10829.83755243672, 10943.726406839813, 3420.846061927219, 3448.913777155591, 3457.4640930655787, 3468.4623883298127, 3486.773359731609, 43845.78077109626, 44201.33697994533, 53710.0, 54095.72952135293, 56018.0, 10009.64966226193, 10173.186145108373, 10532.684019479428, 10567.365958042543, 10948.069414099731, 18605.7209141863, 18967.525811854815, 18976.335828245945, 19020.23919043223, 19101.713474297896, 5858.414158584193, 5966.284045914518, 6059.454649081604, 6060.606060606135, 7359.4848360615315, 3896.6298201670797, 3996.900077498086, 4009.8596549121226, 4024.014116541466, 4087.795610219477, 2865.2407112115307, 2982.209714425679, 3016.3213277012937, 3016.6078409806587, 3020.1694534003327, 508.0575532387442, 508.9185730283137, 512.3800201755917, 513.9306193663807, 514.6886133888943, 535.8124656370317, 592.0, 609.515435228994, 625.4964753373487, 641.0800501280677, 7807.375409967189, 8416.705415310435, 8476.279516241066, 8495.702650407206, 8708.43395179324, 484.5058040798366, 609.1319869186392, 622.8638803623733, 624.4848000399597, 640.2445114764529, 3989.3218152914073, 4058.1072164123843, 4068.613481719232, 4136.937945930814, 4244.151169765997, 93366.0, 95357.45368643542, 96610.0, 96984.54523182158, 97432.51283743537, 79789.60105199553, 85282.47175282546, 86328.13671863326, 86631.56684216538, 87403.56298218468, 44977.0, 46009.15963361495, 71387.64306178436, 73904.63047684728, 76352.2364776345, 7677.347425468674, 7804.453688241996, 7863.292303692695, 7915.604219789103, 7977.880331794911, 44174.779126104164, 44665.33002005037, 44702.3294650587, 45339.77330113328, 45409.0, 58360.70819645875, 59555.404445954984, 60495.697521513874, 63203.36796631975, 64371.0, 9898.703038908845, 10169.89830101719, 10219.948900255451, 10340.172786176938, 11223.214374993671, 13169.407376668265, 13215.66960825987, 13438.865611343761, 13448.327583620976, 13451.192928424325, 12073.154879158375, 12351.3824308786, 12370.681265813826, 12866.485340586272, 13025.218486890817, 12272.693182670504, 12349.691257718629, 12807.0, 13176.076142106545, 13297.80053299182, 11719.179657423898, 11719.238249514096, 11972.16194866351, 13046.0, 13054.15148015376, 10082.798344032932, 10094.54574544162, 10573.390515382076, 10848.288331365886, 10932.56269749201, 9920.255980801325, 10033.648822291185, 10176.542055607664, 10208.693739187836, 10240.692779216635], "value": 6548.763818424289, "unit": "score"}], "name": "dromaeo_css", "value": 6500.618149852781, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 115.0, 117.0, 116.0, 113.0, 115.0, 112.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 130.0, 132.0, 190.0, 130.0, 131.0, 152.0, 132.0, 170.0, 140.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 105.0, 77.0, 78.0, 75.0, 75.0, 104.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 128.0, 85.0, 93.0, 87.0, 116.0, 85.0, 86.0, 121.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 63.0, 72.0, 63.0, 63.0, 63.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 68.0, 66.0, 66.0, 66.0, 70.0, 72.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 81.0, 82.0, 85.0, 86.0, 84.0, 108.0, 83.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 139.0, 131.0, 147.0, 129.0, 133.0, 130.0, 137.0, 134.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 170.0, 168.0, 168.0, 173.0, 167.0, 168.0, 168.0, 166.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 65.0, 68.0, 67.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1548.3999999999999, "alertThreshold": 2.0}]} 01:36:35 INFO - Return code: 0 01:36:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:36:35 INFO - # TBPL SUCCESS # 01:36:35 INFO - Running post-action listener: _resource_record_post_action 01:36:35 INFO - ##### 01:36:35 INFO - ##### Finished run-tests step (success) 01:36:35 INFO - ##### 01:36:35 INFO - Running post-run listener: _resource_record_post_run 01:36:35 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 312963072; Read time: 304; Write time: 273040 01:36:35 INFO - TinderboxPrint: CPU usage
13.1% 01:36:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 304 01:36:35 INFO - TinderboxPrint: I/O write bytes / time
312,963,072 / 273,040 01:36:35 INFO - TinderboxPrint: CPU idle
8,330.2 (86.8%) 01:36:35 INFO - TinderboxPrint: CPU user
1,216.8 (12.7%) 01:36:35 INFO - TinderboxPrint: Swap in / out
0 / 0 01:36:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13844480; Read time: 0; Write time: 2484 01:36:35 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 299118592; Read time: 304; Write time: 270556 01:36:36 INFO - Running post-run listener: _upload_blobber_files 01:36:36 INFO - Blob upload gear active. 01:36:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:36:36 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 01:36:36 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'] 01:36:36 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 01:36:36 INFO - (blobuploader) - INFO - Open directory for files ... 01:36:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:36:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:36:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:36:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:36:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:36:37 INFO - (blobuploader) - INFO - Done attempting. 01:36:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:36:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:36:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:36:38 INFO - (blobuploader) - INFO - Done attempting. 01:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:36:41 INFO - (blobuploader) - INFO - Done attempting. 01:36:41 INFO - (blobuploader) - INFO - Iteration through files over. 01:36:41 INFO - Return code: 0 01:36:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:36:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:36:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e88e775120409a2ba885b71fd705cdbd9477142275d3b52e7df56cc7d3c2c99f66b81b6457211424f5cfcd15646a299c3a399e2d3ac20fff43c429ea56d2e723", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5a293a88c2617bd5305f4a8263493a4728d2a31eaa1861995c22d1a0b9d09a85d3c3e3f7ce943365e101d7c13396bce43000395e74a84642aea62c3153ef4a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3828b888c096e6bfad32f1b7c6303d27b190ba5dde2280068433dc05bfbd6fff3da72ede9a371e7c99ccd6f1b845d774204be6bea38017a4640d88560115979c"} 01:36:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:36:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:36:41 INFO - Contents: 01:36:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e88e775120409a2ba885b71fd705cdbd9477142275d3b52e7df56cc7d3c2c99f66b81b6457211424f5cfcd15646a299c3a399e2d3ac20fff43c429ea56d2e723", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5a293a88c2617bd5305f4a8263493a4728d2a31eaa1861995c22d1a0b9d09a85d3c3e3f7ce943365e101d7c13396bce43000395e74a84642aea62c3153ef4a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3828b888c096e6bfad32f1b7c6303d27b190ba5dde2280068433dc05bfbd6fff3da72ede9a371e7c99ccd6f1b845d774204be6bea38017a4640d88560115979c"} 01:36:41 INFO - Running post-run listener: copy_logs_to_upload_dir 01:36:41 INFO - Copying logs to upload dir... 01:36:41 INFO - mkdir: /builds/slave/test/build/upload/logs 01:36:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.130251 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-23 01:36:40.775259) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 01:36:40.778640) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e88e775120409a2ba885b71fd705cdbd9477142275d3b52e7df56cc7d3c2c99f66b81b6457211424f5cfcd15646a299c3a399e2d3ac20fff43c429ea56d2e723", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5a293a88c2617bd5305f4a8263493a4728d2a31eaa1861995c22d1a0b9d09a85d3c3e3f7ce943365e101d7c13396bce43000395e74a84642aea62c3153ef4a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3828b888c096e6bfad32f1b7c6303d27b190ba5dde2280068433dc05bfbd6fff3da72ede9a371e7c99ccd6f1b845d774204be6bea38017a4640d88560115979c"} build_url:https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/eZ7vTcabQMW64NSxR4ke7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e88e775120409a2ba885b71fd705cdbd9477142275d3b52e7df56cc7d3c2c99f66b81b6457211424f5cfcd15646a299c3a399e2d3ac20fff43c429ea56d2e723", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5a293a88c2617bd5305f4a8263493a4728d2a31eaa1861995c22d1a0b9d09a85d3c3e3f7ce943365e101d7c13396bce43000395e74a84642aea62c3153ef4a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3828b888c096e6bfad32f1b7c6303d27b190ba5dde2280068433dc05bfbd6fff3da72ede9a371e7c99ccd6f1b845d774204be6bea38017a4640d88560115979c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 01:36:40.806314) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 01:36:40.806729) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466667322.89898-131025179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 01:36:40.888674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 01:36:40.889045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 01:36:40.889415) ========= ========= Total master_lag: 0.18 =========