builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1464879648.84 results: success (0) buildid: 20160602053015 builduid: dbb3070b718e4003a0ee9ef1d47f5207 revision: a92a2888973b566c4d4630df3a22869f80ff5587 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:48.845179) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:48.845664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:48.845964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:48.880150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:48.880512) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 08:00:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.9M=0s 2016-06-02 08:00:49 (26.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:48.996019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:48.996321) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017932 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:49.054120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 08:00:49.054561) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a92a2888973b566c4d4630df3a22869f80ff5587 --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 a92a2888973b566c4d4630df3a22869f80ff5587 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 08:00:49,190 truncating revision to first 12 chars 2016-06-02 08:00:49,190 Setting DEBUG logging. 2016-06-02 08:00:49,190 attempt 1/10 2016-06-02 08:00:49,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a92a2888973b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 08:00:49,921 unpacking tar archive at: fx-team-a92a2888973b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.059703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 08:00:50.129735) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:50.130162) ========= script_repo_revision: a92a2888973b566c4d4630df3a22869f80ff5587 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:50.130577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:50.131074) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 08:00:50.140580) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-02 08:00:50.140946) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:50 INFO - MultiFileLogger online at 20160602 08:00:50 in /builds/slave/test 08:00:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:00:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:50 INFO - {'append_to_log': False, 08:00:50 INFO - 'base_work_dir': '/builds/slave/test', 08:00:50 INFO - 'blob_upload_branch': 'Fx-Team', 08:00:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:50 INFO - 'branch': 'Fx-Team', 08:00:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:50 INFO - 'config_files': ('talos/linux_config.py',), 08:00:50 INFO - 'default_actions': ('clobber', 08:00:50 INFO - 'read-buildbot-config', 08:00:50 INFO - 'download-and-extract', 08:00:50 INFO - 'populate-webroot', 08:00:50 INFO - 'create-virtualenv', 08:00:50 INFO - 'install', 08:00:50 INFO - 'run-tests'), 08:00:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:50 INFO - 'download_minidump_stackwalk': True, 08:00:50 INFO - 'download_symbols': 'ondemand', 08:00:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:50 INFO - 'installer_path': 'installer.exe', 08:00:50 INFO - 'log_level': 'info', 08:00:50 INFO - 'log_name': 'talos', 08:00:50 INFO - 'log_to_console': True, 08:00:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:50 INFO - 'opt_config_files': (), 08:00:50 INFO - 'pip_index': False, 08:00:50 INFO - 'sps_profile': False, 08:00:50 INFO - 'sps_profile_interval': 0, 08:00:50 INFO - 'suite': 'dromaeojs', 08:00:50 INFO - 'system_bits': '32', 08:00:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:50 INFO - 'title': 'talos-linux64-ix-058', 08:00:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:50 INFO - 'use_talos_json': True, 08:00:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:50 INFO - 'work_dir': 'build'} 08:00:50 INFO - ##### 08:00:50 INFO - ##### Running clobber step. 08:00:50 INFO - ##### 08:00:50 INFO - Running pre-action listener: _resource_record_pre_action 08:00:50 INFO - Running main action method: clobber 08:00:50 INFO - rmtree: /builds/slave/test/build 08:00:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:00:50 INFO - Running post-action listener: _resource_record_post_action 08:00:50 INFO - ##### 08:00:50 INFO - ##### Finished clobber step (success) 08:00:50 INFO - ##### 08:00:50 INFO - ##### 08:00:50 INFO - ##### Running read-buildbot-config step. 08:00:50 INFO - ##### 08:00:50 INFO - Running pre-action listener: _resource_record_pre_action 08:00:50 INFO - Running main action method: read_buildbot_config 08:00:50 INFO - Using buildbot properties: 08:00:50 INFO - { 08:00:50 INFO - "project": "", 08:00:50 INFO - "product": "firefox", 08:00:50 INFO - "script_repo_revision": "production", 08:00:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:00:50 INFO - "repository": "", 08:00:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:00:50 INFO - "buildid": "20160602053015", 08:00:50 INFO - "pgo_build": "True", 08:00:50 INFO - "basedir": "/builds/slave/test", 08:00:50 INFO - "buildnumber": 1215, 08:00:50 INFO - "slavename": "talos-linux64-ix-058", 08:00:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:00:50 INFO - "platform": "ubuntu64_hw", 08:00:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:00:50 INFO - "branch": "fx-team", 08:00:50 INFO - "repo_path": "integration/fx-team", 08:00:50 INFO - "revision": "a92a2888973b566c4d4630df3a22869f80ff5587", 08:00:50 INFO - "stage_platform": "linux64-pgo", 08:00:50 INFO - "builduid": "dbb3070b718e4003a0ee9ef1d47f5207", 08:00:50 INFO - "slavebuilddir": "test" 08:00:50 INFO - } 08:00:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:00:50 INFO - Running post-action listener: _resource_record_post_action 08:00:50 INFO - ##### 08:00:50 INFO - ##### Finished read-buildbot-config step (success) 08:00:50 INFO - ##### 08:00:50 INFO - ##### 08:00:50 INFO - ##### Running download-and-extract step. 08:00:50 INFO - ##### 08:00:50 INFO - Running pre-action listener: _resource_record_pre_action 08:00:50 INFO - Running main action method: download_and_extract 08:00:50 INFO - mkdir: /builds/slave/test/build/tests 08:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:50 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:00:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:00:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:00:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:00:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:00:51 INFO - Downloaded 1361 bytes. 08:00:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:00:51 INFO - Using the following test package requirements: 08:00:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:00:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:51 INFO - u'jsshell-linux-x86_64.zip'], 08:00:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:00:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:00:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:51 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')]} 08:00:51 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:52 INFO - Downloaded 24439699 bytes. 08:00:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:00:53 INFO - Return code: 0 08:00:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00:53 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')]} 08:00:53 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:55 INFO - Downloaded 24439699 bytes. 08:00:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:00:56 INFO - Return code: 0 08:00:56 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')]} 08:00:56 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:57 INFO - Downloaded 10834055 bytes. 08:00:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:00:57 INFO - Return code: 0 08:00: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')]} 08:00:57 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:00:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:00:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:00:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:59 INFO - Downloaded 59057139 bytes. 08:00:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:00:59 INFO - mkdir: /builds/slave/test/properties 08:00:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:00:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:00:59 INFO - Contents: 08:00:59 INFO - build_url:https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:01:00 INFO - Running post-action listener: _resource_record_post_action 08:01:00 INFO - Running post-action listener: set_extra_try_arguments 08:01:00 INFO - ##### 08:01:00 INFO - ##### Finished download-and-extract step (success) 08:01:00 INFO - ##### 08:01:00 INFO - ##### 08:01:00 INFO - ##### Running populate-webroot step. 08:01:00 INFO - ##### 08:01:00 INFO - Running pre-action listener: _resource_record_pre_action 08:01:00 INFO - Running main action method: populate_webroot 08:01:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:01:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:01:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:01:00 INFO - '--tppagecycles', 08:01:00 INFO - '7'], 08:01:00 INFO - 'tests': ['tsvgm']}}, 08:01:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:01:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:01:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:01:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:01:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:00 INFO - 'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:00 INFO - 'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['damp', 'tps']}, 08:01:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:00 INFO - 'tests': ['damp', 'tps']}, 08:01:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['dromaeo_dom']}, 08:01:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:01:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['a11yr', 08:01:00 INFO - 'ts_paint', 08:01:00 INFO - 'tpaint', 08:01:00 INFO - 'sessionrestore', 08:01:00 INFO - 'sessionrestore_no_auto_restore', 08:01:00 INFO - 'tabpaint']}, 08:01:00 INFO - 'other-e10s': {'tests': ['a11yr', 08:01:00 INFO - 'ts_paint', 08:01:00 INFO - 'tpaint', 08:01:00 INFO - 'sessionrestore', 08:01:00 INFO - 'sessionrestore_no_auto_restore', 08:01:00 INFO - 'tabpaint']}, 08:01:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:01:00 INFO - 'ts_paint', 08:01:00 INFO - 'tpaint', 08:01:00 INFO - 'sessionrestore', 08:01:00 INFO - 'sessionrestore_no_auto_restore', 08:01:00 INFO - 'tabpaint']}, 08:01:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:01:00 INFO - 'ts_paint', 08:01:00 INFO - 'tpaint', 08:01:00 INFO - 'sessionrestore', 08:01:00 INFO - 'sessionrestore_no_auto_restore', 08:01:00 INFO - 'tabpaint']}, 08:01:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['a11yr', 08:01:00 INFO - 'ts_paint', 08:01:00 INFO - 'tpaint', 08:01:00 INFO - 'sessionrestore', 08:01:00 INFO - 'sessionrestore_no_auto_restore', 08:01:00 INFO - 'tabpaint']}, 08:01:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['a11yr', 08:01:00 INFO - 'ts_paint', 08:01:00 INFO - 'tpaint', 08:01:00 INFO - 'sessionrestore', 08:01:00 INFO - 'sessionrestore_no_auto_restore', 08:01:00 INFO - 'tabpaint']}, 08:01:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['tsvgx', 08:01:00 INFO - 'tsvgr_opacity', 08:01:00 INFO - 'tart', 08:01:00 INFO - 'tscrollx', 08:01:00 INFO - 'cart']}, 08:01:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:01:00 INFO - 'tsvgr_opacity', 08:01:00 INFO - 'tart', 08:01:00 INFO - 'tscrollx', 08:01:00 INFO - 'cart']}, 08:01:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:00 INFO - 'talos_options': ['--disable-e10s'], 08:01:00 INFO - 'tests': ['tp5o']}, 08:01:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:00 INFO - 'tests': ['tp5o']}, 08:01:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:00 INFO - 'talos_options': ['--disable-e10s', 08:01:00 INFO - '--xperf_path', 08:01:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:00 INFO - 'tests': ['tp5n']}, 08:01:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:00 INFO - 'talos_options': ['--xperf_path', 08:01:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:00 INFO - 'tests': ['tp5n']}}, 08:01:00 INFO - 'talos.zip': {'path': '', 08:01:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:01:00 INFO - Running post-action listener: _resource_record_post_action 08:01:00 INFO - ##### 08:01:00 INFO - ##### Finished populate-webroot step (success) 08:01:00 INFO - ##### 08:01:00 INFO - ##### 08:01:00 INFO - ##### Running create-virtualenv step. 08:01:00 INFO - ##### 08:01:00 INFO - Running pre-action listener: _resource_record_pre_action 08:01:00 INFO - Running main action method: create_virtualenv 08:01:00 INFO - Creating virtualenv /builds/slave/test/build/venv 08:01:00 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 08:01:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:01:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:01:00 INFO - Using real prefix '/usr' 08:01:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:01:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:01:02 INFO - Installing pip.................done. 08:01:02 INFO - Return code: 0 08:01:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:02 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 0x7f486c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', '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 08:01:02 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 08:01:02 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 08:01:02 INFO - Using env: {'DISPLAY': ':0', 08:01:02 INFO - 'HOME': '/home/cltbld', 08:01:02 INFO - 'LANG': 'en_US.UTF-8', 08:01:02 INFO - 'LANGUAGE': 'en_US:en', 08:01:02 INFO - 'LOGNAME': 'cltbld', 08:01:02 INFO - 'MAIL': '/var/mail/cltbld', 08:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:02 INFO - 'MOZ_NO_REMOTE': '1', 08:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:02 INFO - 'NO_EM_RESTART': '1', 08:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:02 INFO - 'PWD': '/builds/slave/test', 08:01:02 INFO - 'SHELL': '/bin/bash', 08:01:02 INFO - 'SHLVL': '1', 08:01:02 INFO - 'TERM': 'linux', 08:01:02 INFO - 'TMOUT': '86400', 08:01:02 INFO - 'USER': 'cltbld', 08:01:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:02 INFO - '_': '/tools/buildbot/bin/python'} 08:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:02 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 08:01:02 INFO - Cleaning up... 08:01:02 INFO - Return code: 0 08:01:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:02 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 0x7f486c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', '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 08:01:02 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 08:01:02 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 08:01:02 INFO - Using env: {'DISPLAY': ':0', 08:01:02 INFO - 'HOME': '/home/cltbld', 08:01:02 INFO - 'LANG': 'en_US.UTF-8', 08:01:02 INFO - 'LANGUAGE': 'en_US:en', 08:01:02 INFO - 'LOGNAME': 'cltbld', 08:01:02 INFO - 'MAIL': '/var/mail/cltbld', 08:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:02 INFO - 'MOZ_NO_REMOTE': '1', 08:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:02 INFO - 'NO_EM_RESTART': '1', 08:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:02 INFO - 'PWD': '/builds/slave/test', 08:01:02 INFO - 'SHELL': '/bin/bash', 08:01:02 INFO - 'SHLVL': '1', 08:01:02 INFO - 'TERM': 'linux', 08:01:02 INFO - 'TMOUT': '86400', 08:01:02 INFO - 'USER': 'cltbld', 08:01:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:02 INFO - '_': '/tools/buildbot/bin/python'} 08:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:03 INFO - Downloading/unpacking psutil>=3.1.1 08:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:01:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:05 INFO - Installing collected packages: psutil 08:01:05 INFO - Running setup.py install for psutil 08:01:05 INFO - building 'psutil._psutil_linux' extension 08:01:05 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 08:01:05 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 08:01:05 INFO - building 'psutil._psutil_posix' extension 08:01:05 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 08:01:05 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 08:01:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:05 INFO - Successfully installed psutil 08:01:05 INFO - Cleaning up... 08:01:05 INFO - Return code: 0 08:01:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:05 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 0x7f486c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', '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 08:01:05 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 08:01:05 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 08:01:05 INFO - Using env: {'DISPLAY': ':0', 08:01:05 INFO - 'HOME': '/home/cltbld', 08:01:05 INFO - 'LANG': 'en_US.UTF-8', 08:01:05 INFO - 'LANGUAGE': 'en_US:en', 08:01:05 INFO - 'LOGNAME': 'cltbld', 08:01:05 INFO - 'MAIL': '/var/mail/cltbld', 08:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:05 INFO - 'MOZ_NO_REMOTE': '1', 08:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:05 INFO - 'NO_EM_RESTART': '1', 08:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:05 INFO - 'PWD': '/builds/slave/test', 08:01:05 INFO - 'SHELL': '/bin/bash', 08:01:05 INFO - 'SHLVL': '1', 08:01:05 INFO - 'TERM': 'linux', 08:01:05 INFO - 'TMOUT': '86400', 08:01:05 INFO - 'USER': 'cltbld', 08:01:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:05 INFO - '_': '/tools/buildbot/bin/python'} 08:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:01:07 INFO - Installing collected packages: mozsystemmonitor 08:01:07 INFO - Running setup.py install for mozsystemmonitor 08:01:07 INFO - Successfully installed mozsystemmonitor 08:01:07 INFO - Cleaning up... 08:01:08 INFO - Return code: 0 08:01:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:01:08 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')]} 08:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:08 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')]} 08:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:08 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 0x7f486c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', '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 08:01:08 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 08:01:08 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 08:01:08 INFO - Using env: {'DISPLAY': ':0', 08:01:08 INFO - 'HOME': '/home/cltbld', 08:01:08 INFO - 'LANG': 'en_US.UTF-8', 08:01:08 INFO - 'LANGUAGE': 'en_US:en', 08:01:08 INFO - 'LOGNAME': 'cltbld', 08:01:08 INFO - 'MAIL': '/var/mail/cltbld', 08:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:08 INFO - 'MOZ_NO_REMOTE': '1', 08:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:08 INFO - 'NO_EM_RESTART': '1', 08:01:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:08 INFO - 'PWD': '/builds/slave/test', 08:01:08 INFO - 'SHELL': '/bin/bash', 08:01:08 INFO - 'SHLVL': '1', 08:01:08 INFO - 'TERM': 'linux', 08:01:08 INFO - 'TMOUT': '86400', 08:01:08 INFO - 'USER': 'cltbld', 08:01:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:08 INFO - '_': '/tools/buildbot/bin/python'} 08:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:10 INFO - Downloading blobuploader-1.2.4.tar.gz 08:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:01:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:01:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 INFO - Downloading docopt-0.6.1.tar.gz 08:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:01:10 INFO - Installing collected packages: blobuploader, requests, docopt 08:01:10 INFO - Running setup.py install for blobuploader 08:01:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:01:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:01:10 INFO - Running setup.py install for requests 08:01:11 INFO - Running setup.py install for docopt 08:01:11 INFO - Successfully installed blobuploader requests docopt 08:01:11 INFO - Cleaning up... 08:01:11 INFO - Return code: 0 08:01:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01: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')]} 08:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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')]} 08:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:11 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 0x7f486c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', '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 08:01:11 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 08:01:11 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 08:01:11 INFO - Using env: {'DISPLAY': ':0', 08:01:11 INFO - 'HOME': '/home/cltbld', 08:01:11 INFO - 'LANG': 'en_US.UTF-8', 08:01:11 INFO - 'LANGUAGE': 'en_US:en', 08:01:11 INFO - 'LOGNAME': 'cltbld', 08:01:11 INFO - 'MAIL': '/var/mail/cltbld', 08:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:11 INFO - 'MOZ_NO_REMOTE': '1', 08:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:11 INFO - 'NO_EM_RESTART': '1', 08:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:11 INFO - 'PWD': '/builds/slave/test', 08:01:11 INFO - 'SHELL': '/bin/bash', 08:01:11 INFO - 'SHLVL': '1', 08:01:11 INFO - 'TERM': 'linux', 08:01:11 INFO - 'TMOUT': '86400', 08:01:11 INFO - 'USER': 'cltbld', 08:01:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:11 INFO - '_': '/tools/buildbot/bin/python'} 08:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:11 INFO - Running setup.py (path:/tmp/pip-MpXn4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:11 INFO - Running setup.py (path:/tmp/pip-8lejpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:11 INFO - Running setup.py (path:/tmp/pip-Olv0Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:11 INFO - Running setup.py (path:/tmp/pip-fziHXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:12 INFO - Running setup.py (path:/tmp/pip-TVTIqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:12 INFO - Running setup.py (path:/tmp/pip-4NC8g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:12 INFO - Running setup.py (path:/tmp/pip-ek16Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:12 INFO - Running setup.py (path:/tmp/pip-Jg4opi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:12 INFO - Running setup.py (path:/tmp/pip-rhl6yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:12 INFO - Running setup.py (path:/tmp/pip-NWyQnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:12 INFO - Running setup.py (path:/tmp/pip-sjDLGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:12 INFO - Running setup.py (path:/tmp/pip-bIgyU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:12 INFO - Running setup.py (path:/tmp/pip-fpzZsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:12 INFO - Running setup.py (path:/tmp/pip-VUMMzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:12 INFO - Running setup.py (path:/tmp/pip-ggFk9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:12 INFO - Running setup.py (path:/tmp/pip-aCRptY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:12 INFO - Running setup.py (path:/tmp/pip-ou6W2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:01:12 INFO - Running setup.py install for manifestparser 08:01:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Running setup.py install for mozcrash 08:01:13 INFO - Running setup.py install for mozdebug 08:01:13 INFO - Running setup.py install for mozdevice 08:01:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Running setup.py install for mozfile 08:01:13 INFO - Running setup.py install for mozhttpd 08:01:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Running setup.py install for mozinfo 08:01:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Running setup.py install for mozInstall 08:01:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Running setup.py install for mozleak 08:01:13 INFO - Running setup.py install for mozlog 08:01:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:01:13 INFO - Running setup.py install for moznetwork 08:01:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:01:14 INFO - Running setup.py install for mozprocess 08:01:14 INFO - Running setup.py install for mozprofile 08:01:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:01:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:01:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:01:14 INFO - Running setup.py install for mozrunner 08:01:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:01:14 INFO - Running setup.py install for mozscreenshot 08:01:14 INFO - Running setup.py install for moztest 08:01:14 INFO - Running setup.py install for mozversion 08:01:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:01:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:01:14 INFO - Cleaning up... 08:01:14 INFO - Return code: 0 08:01:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01: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')]} 08:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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')]} 08:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:14 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 0x7f486c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', '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 08:01:14 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 08:01:14 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 08:01:14 INFO - Using env: {'DISPLAY': ':0', 08:01:14 INFO - 'HOME': '/home/cltbld', 08:01:14 INFO - 'LANG': 'en_US.UTF-8', 08:01:14 INFO - 'LANGUAGE': 'en_US:en', 08:01:14 INFO - 'LOGNAME': 'cltbld', 08:01:14 INFO - 'MAIL': '/var/mail/cltbld', 08:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:14 INFO - 'MOZ_NO_REMOTE': '1', 08:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:14 INFO - 'NO_EM_RESTART': '1', 08:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:14 INFO - 'PWD': '/builds/slave/test', 08:01:14 INFO - 'SHELL': '/bin/bash', 08:01:14 INFO - 'SHLVL': '1', 08:01:14 INFO - 'TERM': 'linux', 08:01:14 INFO - 'TMOUT': '86400', 08:01:14 INFO - 'USER': 'cltbld', 08:01:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:14 INFO - '_': '/tools/buildbot/bin/python'} 08:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:14 INFO - Running setup.py (path:/tmp/pip-QnvR7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:15 INFO - Running setup.py (path:/tmp/pip-wXMw2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:15 INFO - Running setup.py (path:/tmp/pip-fFvDvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:15 INFO - Running setup.py (path:/tmp/pip-MWPYWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:15 INFO - Running setup.py (path:/tmp/pip-sasPml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:15 INFO - Running setup.py (path:/tmp/pip-JaPl0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:15 INFO - Running setup.py (path:/tmp/pip-kUov5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:15 INFO - Running setup.py (path:/tmp/pip-QB1Ah5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:15 INFO - Running setup.py (path:/tmp/pip-ompABr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:15 INFO - Running setup.py (path:/tmp/pip-zIxw26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:15 INFO - Running setup.py (path:/tmp/pip-93ujHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:15 INFO - Running setup.py (path:/tmp/pip-15npFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:15 INFO - Running setup.py (path:/tmp/pip-fsgiFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:15 INFO - Running setup.py (path:/tmp/pip-Z84LzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:15 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)) 08:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:15 INFO - Running setup.py (path:/tmp/pip-Xi4IGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:16 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)) 08:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:16 INFO - Running setup.py (path:/tmp/pip-NO__54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:16 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)) 08:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:16 INFO - Running setup.py (path:/tmp/pip-AkTgyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:16 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)) 08:01:16 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)) 08:01:16 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)) 08:01:16 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)) 08:01:16 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)) 08:01:16 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)) 08:01:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01:18 INFO - Downloading blessings-1.6.tar.gz 08:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:01:18 INFO - Installing collected packages: blessings 08:01:18 INFO - Running setup.py install for blessings 08:01:18 INFO - Successfully installed blessings 08:01:18 INFO - Cleaning up... 08:01:18 INFO - Return code: 0 08:01:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:01:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:18 INFO - Reading from file tmpfile_stdout 08:01:18 INFO - Current package versions: 08:01:18 INFO - argparse == 1.2.1 08:01:18 INFO - blessings == 1.6 08:01:18 INFO - blobuploader == 1.2.4 08:01:18 INFO - docopt == 0.6.1 08:01:18 INFO - manifestparser == 1.1 08:01:18 INFO - mozInstall == 1.12 08:01:18 INFO - mozcrash == 0.17 08:01:18 INFO - mozdebug == 0.1 08:01:18 INFO - mozdevice == 0.48 08:01:18 INFO - mozfile == 1.2 08:01:18 INFO - mozhttpd == 0.7 08:01:18 INFO - mozinfo == 0.9 08:01:18 INFO - mozleak == 0.1 08:01:18 INFO - mozlog == 3.2 08:01:18 INFO - moznetwork == 0.27 08:01:18 INFO - mozprocess == 0.22 08:01:18 INFO - mozprofile == 0.28 08:01:18 INFO - mozrunner == 6.11 08:01:18 INFO - mozscreenshot == 0.1 08:01:18 INFO - mozsystemmonitor == 0.3 08:01:18 INFO - moztest == 0.7 08:01:18 INFO - mozversion == 1.4 08:01:18 INFO - psutil == 3.1.1 08:01:18 INFO - requests == 1.2.3 08:01:18 INFO - wsgiref == 0.1.2 08:01:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:18 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')]} 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:18 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')]} 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:18 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 0x7f486c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', '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 08:01:18 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 08:01:18 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 08:01:18 INFO - Using env: {'DISPLAY': ':0', 08:01:18 INFO - 'HOME': '/home/cltbld', 08:01:18 INFO - 'LANG': 'en_US.UTF-8', 08:01:18 INFO - 'LANGUAGE': 'en_US:en', 08:01:18 INFO - 'LOGNAME': 'cltbld', 08:01:18 INFO - 'MAIL': '/var/mail/cltbld', 08:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:18 INFO - 'MOZ_NO_REMOTE': '1', 08:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:18 INFO - 'NO_EM_RESTART': '1', 08:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:18 INFO - 'PWD': '/builds/slave/test', 08:01:18 INFO - 'SHELL': '/bin/bash', 08:01:18 INFO - 'SHLVL': '1', 08:01:18 INFO - 'TERM': 'linux', 08:01:18 INFO - 'TMOUT': '86400', 08:01:18 INFO - 'USER': 'cltbld', 08:01:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:18 INFO - '_': '/tools/buildbot/bin/python'} 08:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:18 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)) 08:01:18 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)) 08:01:18 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)) 08:01:18 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)) 08:01:18 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)) 08:01:18 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)) 08:01:18 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)) 08:01:18 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)) 08:01:18 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)) 08:01:18 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)) 08:01:18 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)) 08:01:18 INFO - Cleaning up... 08:01:18 INFO - Return code: 0 08:01:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:01:18 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')]} 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:18 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')]} 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:18 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 0x7f486c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', '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 08:01:18 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 08:01:18 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 08:01:18 INFO - Using env: {'DISPLAY': ':0', 08:01:18 INFO - 'HOME': '/home/cltbld', 08:01:18 INFO - 'LANG': 'en_US.UTF-8', 08:01:18 INFO - 'LANGUAGE': 'en_US:en', 08:01:18 INFO - 'LOGNAME': 'cltbld', 08:01:18 INFO - 'MAIL': '/var/mail/cltbld', 08:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:18 INFO - 'MOZ_NO_REMOTE': '1', 08:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:18 INFO - 'NO_EM_RESTART': '1', 08:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:18 INFO - 'PWD': '/builds/slave/test', 08:01:18 INFO - 'SHELL': '/bin/bash', 08:01:18 INFO - 'SHLVL': '1', 08:01:18 INFO - 'TERM': 'linux', 08:01:18 INFO - 'TMOUT': '86400', 08:01:18 INFO - 'USER': 'cltbld', 08:01:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:18 INFO - '_': '/tools/buildbot/bin/python'} 08:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:18 INFO - Downloading/unpacking jsonschema 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:01:20 INFO - Downloading/unpacking functools32 (from jsonschema) 08:01:20 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 08:01:20 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 08:01:20 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 08:01:20 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 08:01:20 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 08:01:20 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 08:01:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:01:21 INFO - warning: no files found matching '*.txt' 08:01:21 INFO - no previously-included directories found matching 'build' 08:01:21 INFO - no previously-included directories found matching 'dist' 08:01:21 INFO - no previously-included directories found matching '.git*' 08:01:21 INFO - Installing collected packages: jsonschema, functools32 08:01:21 INFO - Running setup.py install for functools32 08:01:21 INFO - warning: no files found matching '*.txt' 08:01:21 INFO - no previously-included directories found matching 'build' 08:01:21 INFO - no previously-included directories found matching 'dist' 08:01:21 INFO - no previously-included directories found matching '.git*' 08:01:21 INFO - Successfully installed jsonschema functools32 08:01:21 INFO - Cleaning up... 08:01:21 INFO - Return code: 0 08:01:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:01:21 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')]} 08:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:21 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')]} 08:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:21 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 0x7f486c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', '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 08:01:21 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 08:01:21 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 08:01:21 INFO - Using env: {'DISPLAY': ':0', 08:01:21 INFO - 'HOME': '/home/cltbld', 08:01:21 INFO - 'LANG': 'en_US.UTF-8', 08:01:21 INFO - 'LANGUAGE': 'en_US:en', 08:01:21 INFO - 'LOGNAME': 'cltbld', 08:01:21 INFO - 'MAIL': '/var/mail/cltbld', 08:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:21 INFO - 'MOZ_NO_REMOTE': '1', 08:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:21 INFO - 'NO_EM_RESTART': '1', 08:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:21 INFO - 'PWD': '/builds/slave/test', 08:01:21 INFO - 'SHELL': '/bin/bash', 08:01:21 INFO - 'SHLVL': '1', 08:01:21 INFO - 'TERM': 'linux', 08:01:21 INFO - 'TMOUT': '86400', 08:01:21 INFO - 'USER': 'cltbld', 08:01:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:21 INFO - '_': '/tools/buildbot/bin/python'} 08:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:21 INFO - Downloading/unpacking flake8 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01: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 08:01:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:01:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:01:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 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 08:01:23 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 08:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:01:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:01:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:01:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:01:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:01:24 INFO - no previously-included directories found matching 'docs/_build' 08:01:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:01:24 INFO - Running setup.py install for pep8 08:01:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:01:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:01:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:01:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:01:24 INFO - no previously-included directories found matching 'docs/_build' 08:01:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:01:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:01:24 INFO - Cleaning up... 08:01:24 INFO - Return code: 0 08:01:24 INFO - Running post-action listener: _resource_record_post_action 08:01:24 INFO - Running post-action listener: _start_resource_monitoring 08:01:24 INFO - Starting resource monitoring. 08:01:24 INFO - ##### 08:01:24 INFO - ##### Finished create-virtualenv step (success) 08:01:24 INFO - ##### 08:01:24 INFO - ##### 08:01:24 INFO - ##### Running install step. 08:01:24 INFO - ##### 08:01:24 INFO - Running pre-action listener: _resource_record_pre_action 08:01:24 INFO - Running main action method: install 08:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:24 INFO - Reading from file tmpfile_stdout 08:01:24 INFO - Detecting whether we're running mozinstall >=1.0... 08:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:01:24 INFO - Reading from file tmpfile_stdout 08:01:24 INFO - Output received: 08:01:24 INFO - Usage: mozinstall [options] installer 08:01:24 INFO - Options: 08:01:24 INFO - -h, --help show this help message and exit 08:01:24 INFO - -d DEST, --destination=DEST 08:01:24 INFO - Directory to install application into. [default: 08:01:24 INFO - "/builds/slave/test"] 08:01:24 INFO - --app=APP Application being installed. [default: firefox] 08:01:24 INFO - mkdir: /builds/slave/test/build/application 08:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:01:41 INFO - Reading from file tmpfile_stdout 08:01:41 INFO - Output received: 08:01:41 INFO - /builds/slave/test/build/application/firefox/firefox 08:01:41 INFO - Running post-action listener: _resource_record_post_action 08:01:41 INFO - ##### 08:01:41 INFO - ##### Finished install step (success) 08:01:41 INFO - ##### 08:01:41 INFO - ##### 08:01:41 INFO - ##### Running run-tests step. 08:01:41 INFO - ##### 08:01:41 INFO - Running pre-action listener: _resource_record_pre_action 08:01:41 INFO - Running main action method: run_tests 08:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:01:41 INFO - Python 2.7.3 08:01:41 INFO - Return code: 0 08:01:41 INFO - grabbing minidump binary from tooltool 08:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:41 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 0x16409c0>, '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 0x16418c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1641d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:01:41 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 08:01:41 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 08:01:41 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 08:01:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:01:41 INFO - Return code: 0 08:01:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:01:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:01:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:01:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:01:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:01:42 INFO - Return code: 0 08:01:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:01:42 INFO - Using env: {'DISPLAY': ':0', 08:01:42 INFO - 'HOME': '/home/cltbld', 08:01:42 INFO - 'LANG': 'en_US.UTF-8', 08:01:42 INFO - 'LANGUAGE': 'en_US:en', 08:01:42 INFO - 'LOGNAME': 'cltbld', 08:01:42 INFO - 'MAIL': '/var/mail/cltbld', 08:01:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:01:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:42 INFO - 'MOZ_NO_REMOTE': '1', 08:01:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:42 INFO - 'NO_EM_RESTART': '1', 08:01:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:42 INFO - 'PWD': '/builds/slave/test', 08:01:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:01:42 INFO - 'SHELL': '/bin/bash', 08:01:42 INFO - 'SHLVL': '1', 08:01:42 INFO - 'TERM': 'linux', 08:01:42 INFO - 'TMOUT': '86400', 08:01:42 INFO - 'USER': 'cltbld', 08:01:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864', 08:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:42 INFO - '_': '/tools/buildbot/bin/python'} 08:01:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:01:42 INFO - mozversion application_buildid: 20160602053015 08:01:42 INFO - mozversion application_changeset: a92a2888973b566c4d4630df3a22869f80ff5587 08:01:42 INFO - mozversion application_display_name: Nightly 08:01:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:01:42 INFO - mozversion application_name: Firefox 08:01:42 INFO - mozversion application_remotingname: firefox 08:01:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:01:42 INFO - mozversion application_vendor: Mozilla 08:01:42 INFO - mozversion application_version: 49.0a1 08:01:42 INFO - mozversion platform_buildid: 20160602053015 08:01:42 INFO - mozversion platform_changeset: a92a2888973b566c4d4630df3a22869f80ff5587 08:01:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:01:42 INFO - mozversion platform_version: 49.0a1 08:01:42 INFO - using testdate: 1464879702 08:01:42 INFO - actual date: 1464879702 08:01:42 INFO - starting webserver on 'localhost:42207' 08:01:42 INFO - SUITE-START | Running 2 tests 08:01:42 INFO - TEST-START | dromaeo_css 08:01:42 INFO - operating with platform_type : linux_ 08:01:42 INFO - Initialising browser for dromaeo_css test... 08:01:42 INFO - TEST-INFO | started process 10468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_VZEhN/profile http://localhost:42207/getInfo.html) 08:01:46 INFO - PROCESS | 10468 | __metrics Screen width/height:1600/1200 08:01:46 INFO - PROCESS | 10468 | colorDepth:24 08:01:46 INFO - PROCESS | 10468 | Browser inner width/height: 1024/697 08:01:46 INFO - PROCESS | 10468 | __metrics 08:01:47 ERROR - PROCESS | 10468 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:01:48 INFO - TEST-INFO | 10468: exit 0 08:01:48 INFO - Browser initialized. 08:01:48 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:48 INFO - TEST-INFO | started process 10549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_VZEhN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:00 INFO - PROCESS | 10549 | RSS: Main: 155758592 08:02:00 INFO - PROCESS | 10549 | 08:02:51 INFO - PROCESS | 10549 | 1464879771743 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] 08:04:59 INFO - PROCESS | 10549 | Cycle 1(1): loaded http://localhost:42207/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42207/tests/dromaeo/cssquery-ext.html) 08:05:00 INFO - PROCESS | 10549 | RSS: Main: 238379008 08:05:00 INFO - PROCESS | 10549 | 08:08:02 INFO - PROCESS | 10549 | Cycle 1(1): loaded http://localhost:42207/tests/dromaeo/cssquery-ext.html (next: http://localhost:42207/tests/dromaeo/cssquery-jquery.html) 08:08:03 INFO - PROCESS | 10549 | RSS: Main: 243896320 08:08:03 INFO - PROCESS | 10549 | 08:11:05 INFO - PROCESS | 10549 | Cycle 1(1): loaded http://localhost:42207/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42207/tests/dromaeo/cssquery-mootools.html) 08:11:06 INFO - PROCESS | 10549 | RSS: Main: 245288960 08:11:06 INFO - PROCESS | 10549 | 08:14:08 INFO - PROCESS | 10549 | Cycle 1(1): loaded http://localhost:42207/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42207/tests/dromaeo/cssquery-prototype.html) 08:14:08 INFO - PROCESS | 10549 | RSS: Main: 240238592 08:14:08 INFO - PROCESS | 10549 | 08:17:11 INFO - PROCESS | 10549 | Cycle 1(1): loaded http://localhost:42207/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42207/tests/dromaeo/cssquery-yui.html) 08:17:11 INFO - PROCESS | 10549 | RSS: Main: 226631680 08:17:11 INFO - PROCESS | 10549 | 08:20:14 INFO - PROCESS | 10549 | Cycle 1(1): loaded http://localhost:42207/tests/dromaeo/cssquery-yui.html (next: http://localhost:42207/tests/dromaeo/cssquery-dojo.html) 08:20:15 INFO - PROCESS | 10549 | RSS: Main: 297123840 08:20:15 INFO - PROCESS | 10549 | 08:20:15 INFO - PROCESS | 10549 | __start_tp_report 08:20:15 INFO - PROCESS | 10549 | _x_x_mozilla_page_load 08:20:15 INFO - PROCESS | 10549 | _x_x_mozilla_page_load_details 08:20:15 INFO - PROCESS | 10549 | |i|pagename|runs| 08:20:15 INFO - PROCESS | 10549 | |0;dojo.html;3122.6096737907774;3125.2343175921897;3158.273597072673;3168.841557922103;3203.1511649412896;5353;5358.490943360384;5423.918641220384;5509.614326997112;5548.72256387181;5331.546818520431;5393.379761327448;5397.865053373667;5444.428335024825;5482.890342193154;4847.587955023819;4932.161532539477;4938.407391113072;4938.777755001016;5093.2105523643895;4994.750262486879;5027.597792176635;5034.370703662043;5049.3183420238165;5060.746962651871;4935.136351138536;4950.925736113961;5005.6996580205305;5006.774695138727;5011.799528018875;4842.757862106881;4845.248986407112;4862.902741945177;4935.259711043336;5100.719460429675;4883.047805677894;4893.584045356149;4902.926456103161;4918.213085906274;4926.261060840867;5160.56135228506;5328.333958255218;5357.223202635596;5382.381026182;5410.83767486976;5868.413158684098;5917.970410147922;5919.230500035011;5919.319278283009;5936.168936348915;5920.407959204088;5946.881062378771;5948.553858460633;5975.910361344583;5978.3124940631515;5284.154535274376;5322.627416080876;5371.677699338053;5372.382176049726;5549.278593782823;5935.970320148372;5937.376575459514;5938.2280303560265;5940.31686356066;5940.940590594125;5676;5688.345840228344;5713.143028545752;5724.198612194296;5724.627899186623;5672.631278966854;5741.311042674905;5831.737571809279;5840.182374467578;5880.117982302689;5756.7121643917635;5832.825015249549;5833.183354330397;5844.211031510692;5855.209546711225;5618.85952851182;5835.44563266489;5869;5873.735681894325;5885.558583106199;4421.690481666253;4455.9554404456185;4458.665600080007;4479.283314669702;4480;3975.7813320267664;3981.482407287034;3993.580674029185;4001.039750459927;4021.557628660845;5370.570354371641;5533.253010843565;5571.470710282517;5579.6652200868075;5592.384837667853;5764.538836893039;5769.105788602773;5816.912746308809;5846.181534585162;5925.4370834770625;5538.086215774432;5548.112302031736;5553.750406158582;5554.389017208104;5559.360673522597;4900.019996000814;5071.036503064406;5072.28987941681;5076.3908330999775;5129.333186685707;5869.236999190163;5895.41045895407;5919;5952.613080149863;5964.850878728066;5731.541476681939;5733.140028995684;5735.684537350486;5738.282714660668;5738.8278351649515;5809.883802323845;5842.444967728059;5932.406759324205;5947.672877991752;5950.31571369298;5555.111182210827;5619.2133101365025;5620.269364982526;5621.213030175697;5666.688332141772;5692.146178073156;5717.885642287214;5721.456461636138;5722.198892155018;5727.513161381163;5433.1035379161995;5503.7798488060025;5533.418991005887;5578.163275508706;5588.748506317144;5552.666839989613;5555.611107222456;5559.527440167631;5566.276384070207;5623;5465.262189604353;5468.699221542854;5469.589780766379;5471.644343117685;5530.446955304437;5441.591880609049;5561.721913904208;5610.410906854885;5615.550755939434;5621.943780562142;5511.917321240265;5519.061759500814;5520.66875987442;5520.779168833202;5562.193481945176 08:20:15 INFO - PROCESS | 10549 | |1;ext.html;598.9610675306108;608.695652173913;626.6208943589131;631.9715612797423;656.4748201438848;32178.67821321786;44436.3334549982;45593.77203113988;45673.31490027652;45751;47339.76330118345;47799.761001194944;47826.0434791304;47866.28200576994;47921.52078479214;8819.514926679047;9019.54902254888;9019.639214431414;9022.052684468103;9022.86465703015;8684.435511691752;8798.6920457784;8799.34004949628;8800.075992020842;8801.823963520726;9008.144226298524;9038.322125840556;9063.728088157366;9065.410748301372;9065.818683626323;8921.197092261695;8957.955210223972;8988.46069235848;8990.595423205972;8992.8651070234;8853;8926.553672316422;8959.41763785352;8960.865587016135;8964.59659315326;42622;43095;43172.78413607912;43253.56746432527;43406.565934340884;3562.2928465496993;3701.2782507411066;3720.9441858372147;3724.478572999782;3863.5363756349416;31519.054428367184;33615.49576756351;33877;34267.485987710206;34361.82819085888;4486.820527178909;4562.406887104688;4567.132244873464;4654.115718013567;4681.133990211822;351526;359320.2033989839;359571;359794;360232;57186.7140664294;63532;66512;67361;67506;63311.36688633147;69132.654336728;70528.29471705217;70585.64707176431;70684.64657676678;17189.656206876043;17192.828071719374;17310.826891731173;17317.653646926992;17342.826571734375;13696.65758356049;13783.931080344735;13801.723965520634;13806.86193138076;13813.654658633413;18563.32930036303;20335.4916127098;21048.368548943556;21071.78928210729;21878.781212187994;7664.846703065908;7668.846623067508;7919.970403847463;7962.601869906482;7981.640826162837;971.6502059258661;1001.3841487485145;1025.789713108826;1125.2404626876826;1135.636596289196;33386.833065834515;33778.32443351119;33843;33993.49009764855;34108;1137.5051852444212;1180.6871179137536;1205.921615095016;1232.9815052774215;1261.2054405724518;17435.47693569195;17790.110494475226;17900.46298611018;17916.820831791516;17963.371282005068;546998;553850;555136;555496;556348;60633.09050364248;62263.688681556305;62269.37730622727;62395.376046239864;62611.37388626146;1298.6558561981083;1400.6148309215048;1408.6830463145916;1411.3014058041335;1429.8284205895359;32734.34531309408;34931.47602786011;35011.82494087513;35115.1655863408;35305.646943530235;52493;53010.2048469281;53096.46903530915;53125;53156.734216328674;394881;396383;396633;397156;399184;34614.82692586521;35324.47013294854;40571.59428405678;43155.78422107869;43193.35209971916;46849.297260540436;47564.2865357013;47657.76171119122;48477.75761121172;48713.75643121762;39945;40489.79755101206;40815;40951.59048409597;41009.794951025055;39594;40056.1988760229;40059.39910901397;40763.592364077165;41046.58953410547;39729.602703973746;40905.38641920314;40984.79507602562;41044.79477602593;41157.1768564621;34199.4870076954;35779.821100894325;36023.63976360203;36738.63261367352;36864.26271474502;27665.308367290978;27883;27953.580696289166;28098.2975425616;28106 08:20:15 INFO - PROCESS | 10549 | |2;jquery.html;385.90352411897027;390.65622252417876;393.8582110440243;407.8959865234366;415.09923466078607;14171.433142674281;16201.675966480663;17895.64208715825;19488.317908873192;19501.122449489772;14886.776698349533;14942.252887355644;17717.114144292766;18109.366172183974;18138.274469021224;5357;5789.623674461168;5789.884202315951;5791.507721843648;5792.71036448178;3912.941305880414;5510.311211098613;5668.801591944282;5720.685362305072;5724.427557244284;5887.35239123696;6250.093736408218;6251.531135164858;6353;6361.2048493938255;6122.96938515309;6313.747450101991;6336.746530138789;6400.295967443578;6410.166678331787;5604.579656525736;5619.775208991636;5632.127020311858;5644.604877658566;5658.122990936411;20898.37304880856;21097.8945105275;21944;21957;22247.777522224733;2310.249169020075;2366.5858474766846;2492.8130390220626;2899.3476467794576;3139.0425920094362;13240.675563010733;13580.660483487893;13656.112352697042;14273;14450.566483005421;1937.94186174415;1959.7648282206226;1982.5935683184912;2002.67957126859;2072.616565935307;72582.63708681423;76206;81073.59463202705;81125.59437202776;84948;10775.676729698122;10801.621943232107;10870.782584348268;11069.50187241576;11191.216614837045;15256.694866102616;15260.084394936339;15350.155741434328;15372.923135384252;15394.846051539565;7377.704891804375;7971.641276142587;9668.951655241679;9686.225101991824;10203.642872499428;8461.196186362286;8475.152484751476;8502.914970850336;8535.701250456204;8701.129887011375;8510.61702223389;8713.52075635846;8830.602622881986;9014.233790127913;9110;3361.394948909171;3449.87925422609;3483.773554718935;3527.7530572859655;3591.4612808078996;895.2479916869861;943.8867335919596;991.6529214774771;1012.7873146639141;1027.8561001459802;18119.63760724778;18639.440816775517;18777.624447511247;18904.243830246636;18973.62052758937;1017.7862648843826;1024.6004058417222;1041.141058626636;1050.1231471721046;1087.494315143462;9959.402435853872;10610.68167954947;10614.097801686788;10663.520141593646;10688.679339619668;454357;460295.6985215119;460913;469338;472658;95086;96523.51738241404;97961;99979;102707.4864625672;478.2157262090175;495.45747406589726;500.2496255616648;501.1755661936095;980.9852852207223;10050.597976081168;10666.093382062301;10781.353118812896;10819.350838949687;10821.350718956888;36243.27513449664;39867.60132398639;41465.58534414617;42181.78909105435;42424;45744.77127614341;56284.718576406856;56887;57505.424945750005;57536.1369579465;8515.872261915953;8712.869306960527;8766.34252431083;8836.381453298207;8942.284617230476;9788.657396991071;13008.674783130498;13015.674608134872;13115.27865967381;13257.07200495956;11415.714607134889;11504.079673626256;11744.177907546731;11933.76132477363;12005.869669381776;11333.886661133283;11618.244814087057;11619.88380116222;11728.76542469163;11958.940205298917;11705.356205408443;11857.822132668189;12132;12161.87838121643;12173.634790956285;8418.663253470038;8427.8735818964;8504.34165337778;8654.567271636519;8889.066648001866;10836.512356943798;11209.43952802373;11519.88480115188;11524.423778811193;11893.464794084113 08:20:15 INFO - PROCESS | 10549 | |3;mootools.html;1405.3605609447702;1533.7009283189775;1543.1435553267936;1684.4946516045184;1851.1392202625777;7695.461317707763;8034.116247212809;8045.597720113993;8288.58557072147;8311.501309921408;8029.317508011826;8235.835283294331;8244.793880153;8246.299064579503;8253.257206851382;2044.9591008179827;2271.057511132878;2337.801286890612;2346.601077816775;2366.2782851230368;2398.1846172301416;2406.278116565032;2408.5664580375524;2409.4458274596764;2412.1436889904094;2353.9176128835493;2358;2373.964390534143;2380.2264264114146;2388.295452841407;2018.1523760020752;2219.7780221977673;2268.1834539565743;2280.600894843396;2287;2364.4679947011787;2386;2393.5930891748444;2394.724606670238;2400.195934361991;8327.791805204919;8373.748787536384;8379.664813407517;8394.874076888851;8396.202360775716;5097.362829646294;5237.3453318335205;5245.449227831061;5246.449122842123;5247.527722504955;3270.787398819093;3361.5629968104236;3424.434968230239;3430.5025771263277;3499.7200223982277;1158.5829101523445;1161.2567956507842;1196.7008247938015;1209.9153059285854;1215.9392030398444;11597.420128993517;11607.187496875138;11641.301521908712;11648.301101933912;11659.825102623467;4458.509563947963;4637.907241855144;4658.95341046592;4719.787609557578;4721.787519561628;9902.851457228147;9914.107730304308;9916.851247231298;9917.404955702681;9926.30515863897;5183.922241166386;5244.554212891947;5253.44838791929;5256.816011439581;5259.132243179909;4160.313548264502;4715.174844402216;4848.345473361122;4850;4945.975270123627;3845.8269377877505;3963.6630886374405;3975.7018223632763;4019.678425725935;4052.7163098582814;1274.840644919385;1304.5760127958451;1320.7688654485619;1334.0928168845278;1334.8932085433141;1057.4289883462998;1067.9199060070525;1071.3197119828965;1074.1943542343085;1075.0861767497565;6050.939490605126;6077.058056001327;6163.96918015407;6204.410580994799;6210.347913469111;453.20688794609435;457.4464897474094;457.50360858468935;1012.367270455965;1023.9334443261164;4322.394864718942;4326.870193894189;4339.7830108494445;4344.218040752695;4380.934285985712;10142;10275.383476991405;10296.742581435525;10395.740106497247;10396.636117735994;10225.693229203136;10280.02339777735;10291.588336466457;10294.227932904912;10310.845337319946;7581.886271705929;7920.564368959647;7923.881141782877;7924.128345881948;8085.83828323442;6047.848803779941;6196.287426945959;6206.627602343693;6236.376362363727;6382.840428989312;9258.768530786785;9451.952740236255;9566.378185417925;9568.95215523918;9569;9548;9806.411615303105;9817.165540929102;9836.901630983884;9889.604415823287;6945.374916257561;7148.821279468055;7150.213476517475;7537.6984920604755;7703;7588.506747061423;8259.132791056853;8270;8452.788680283042;8457.788555286166;7079;7305.305995930378;7499.362554182738;7527.88708169367;7634.6182690864125;6954.269801670954;7156.141263048467;7161.391281740902;7233.421326293778;7241.203467618452;6779.491538134758;6861.210960739579;6861.588304701734;6863.691133898887;6866.896996545156;5091.032703786417;5127.410502744161;5161.200013997836;5201.089809283436;5272.841814745564;5224.7648855802345;5383.219433182245;5406.270153529381;5452.945470545244;5483.972580137074 08:20:15 INFO - PROCESS | 10549 | |4;prototype.html;336.94271973764455;338.9406853800584;346.5010385045533;346.5719836002538;349.20729943029323;5315.627906046579;5362.758675859591;5364.436734142917;5372.286995067495;5376.623636345457;5308.601854860882;5321.760520776565;5325.547328477084;5326.254324394578;5349.786008559653;3857.787821669807;4012.538558065831;4014.598540145991;4031.21391328691;4116.300228961084;4151.667866570667;4166.874993750177;4179.373094035904;4180.414741936132;4191.413202151702;4106.753594784308;4151.294279972397;4167.687423443239;4169.812358443877;4198.664106871458;3974.3044967130636;4093.4269202311702;4182.247195504808;4186.3092589722655;4212.178625168093;3688.5389326334207;3693.2244228711734;3720.5163328767358;3733.607971163016;3740.4202348636004;5068.062408454411;5076.898462030738;5081.8475445736685;5120.591837244788;5130.3074084998425;4525.479569849476;4713.929291060636;4724.76376181193;4736.810527578893;4757.26262429324;5540.36285827131;5567.691592475765;5570.1592187984015;5571.4428557144365;5582.944170558283;3992.900177495557;4002.4396584478195;4007.8998025049314;4044.3326851069537;4074.0425999890003;5704.771809127671;5712.22884910536;5732.426757324276;5892.440218179266;5921.644701317891;4030.435738996543;4057.391391291271;4066.4510291110323;4066.9796651016554;4080.2655522006326;4110.958890411058;4114.053767633461;4120.237756015147;4120.320147175742;4129.29801933672;4492.113312408796;4702.976485117552;4723.385959825201;4731.313959475857;4739.431268247832;5601.5238704710555;5621.494065534122;5627.7467513961155;5636.577256705681;5641.80253691127;1381.7996390523317;1389.6942672612008;1401.6005438450197;1410.9012369134268;1417.588899219215;882.6601758322963;898.9325800564984;916.0473107967772;926.3515539122641;928.911753383441;4819;4857.708537487762;4862.197737373364;4872.4929440268315;4875.439324477659;5090.516400941905;5101.336826212643;5115.974420127875;5147.871303217449;5182.922256166161;4606;4710.26990816424;4757.405324334458;4806.14034649383;4817.421909370898;2709.7832173426077;2710.986445067762;2723.6323096381734;2735.5076086304657;2742;5241.9737901310245;5253.527182553588;5256.816011439581;5277.709725965032;5303.628745987744;4934.82867538282;5149.613778966593;5169.957866642655;5172.327597412387;5579.9163012554845;5796.159556864315;5824.155497452845;5935.881282374415;5937.30786725781;5938.673372964528;5676;5712.371639119777;5734.283214598176;5800.796972105956;5800.970995145166;5533.446655334596;5724.885502289848;5729.169270455844;5735.931276767076;5747.85042991395;5937.643741375531;5944.295345617647;5958.285005799332;5975.193348897843;5992.700364981646;4167.166566686736;4180.686448516312;4213.705040647125;4225.28170211071;4250.447441832665;5532.114861622282;5804.332501762351;5824.388439213822;5836.358000619844;5844.561657875592;5549.5837812163445;5563.860903477445;5594.1049432092295;5594.440555944536;5607.523360514402;5438.992254252195;5530.944690553043;5568.77724891016;5595.972020139873;5604.327480702179;5412.242286079873;5454.290942177491;5522.392536821027;5527.198556209247;5527.474889885454;5648.322201335866;5676.2337084493065;5676.978143933967;5690.658560486384;5703.515201207943;5258.7904781899615;5493.983613031602;5513.42109078557;5550.278463799842;5562.721863906708 08:20:15 INFO - PROCESS | 10549 | |5;yui.html;716.0369303287081;729.9744508942184;798.2855344466706;808.4906508899393;809.2514424157654;15438.768418473705;15597.84402155978;15697.686046279081;15754.606134846634;15904.840951590466;14281.71436571268;14402.063865848713;14445.277736113205;14457.5662730118;14459.638509037279;690.3062422265616;810.2909953790434;817.9386546009043;837.1628371628371;845.6194712379423;838.4550042472412;838.5890913452395;840.2899549880341;841.8232171244047;842.2588122452233;838.6771093129129;839.1398816213369;839.3495041342946;839.6095815445816;839.6515446089866;716.8028792082167;835.3317346123108;841.5792103948025;869.7303835810856;872.0930232558131;634.8761991411676;634.9174607301068;635.3455940381415;635.4185919883301;636.538509580555;15062.32219550112;15079.5476135715;15117.622059448602;15118.622034449118;15125.621859453491;13938.233397163152;14266.714665706731;14275.357608907623;14339.42642294307;14541.636459088502;12035.819462708067;12174.81737773934;12283.938580307042;12303.69240768979;12356.62930112098;4413;4463.263561512379;4484.7084939479155;4496.055828276033;4527.253003254459;68392.9961866354;68645.65677171633;68702.31297687058;69184.30815691828;69355.65322173407;10455.68632941013;10504.527296271686;10553.155747540179;10694.518746656264;10829.187810914056;19279;19279.710804337945;19302.13140408685;19303.4208973731;19312;7868.842623147505;7956.681732730742;8057.556834374049;8123.512589244664;8362.498250105013;4443.200223959719;4495.797689103998;4515.954840451619;4523.7285762854335;4596.126735920165;3438.1232785639504;3444.844981975817;3550.55618047744;3554.7156227501737;3554.8578056877436;593.6467801658007;600.6994856136503;604.4046614085123;610.9633421994695;616.017452163798;580.523970344322;627.4823270801515;676.5061505101304;734.1007266098986;740.6852087862637;9336.206422454168;9828.754281142885;9876.160526355341;9916.752081198028;9926.80146397068;588.8704485013291;698.7342275408658;712.2272334517004;721.3435773446139;723.2767232767233;4593.63250939924;4787.257975013878;4813.95186048135;4876.683015603974;4928.704277743275;105855;105870;109920;110435;114365;92832;93853;96211.51894240484;96447;96491;86975.56512217398;88748.55625721959;89459;89628.5518572403;90049;8985.595648195716;9020.729378118667;9036.141566551167;9088.636454541744;9097.363184577016;43278.567214328716;44116.77941610271;45616.771916140206;50976.235356470424;52024.21963670472;71150.6442467805;72940.6352968253;73450.26549734434;73704.63147684227;73851.63074184595;13210.405531750903;13508.459661613426;13575.86424135746;13586.524471643444;14012.369443374868;15209.239538023276;15390.384384624938;15734.449294275104;16223.107729075015;16321.67356652884;14178.361973711002;14605.561833145022;14619.342129604405;14952.850471495145;15073.773893391828;14157.292135392983;14230.430782768573;14370.209638469985;14536.781948270997;15068.54794356171;12890.634748711167;13190.736185276433;13233;13283.269420181983;14219.715605688036;11294.94352528265;11565.248258863146;11576.94211528937;11611.709707257387;11717.414129293671;11078.944605276922;11608.535658573563;11914.880851191723;11987.520499179935;12016.098792590765 08:20:15 INFO - PROCESS | 10549 | __end_tp_report 08:20:15 INFO - PROCESS | 10549 | __start_cc_report 08:20:15 INFO - PROCESS | 10549 | _x_x_mozilla_cycle_collect,999 08:20:15 INFO - PROCESS | 10549 | __end_cc_report 08:20:15 INFO - PROCESS | 10549 | __startTimestamp1464880815079__endTimestamp 08:20:15 INFO - PROCESS | 10549 | 08:20:15 INFO - PROCESS | 10549 | ------- Summary: start ------- 08:20:15 INFO - PROCESS | 10549 | Number of tests: 6 08:20:15 INFO - PROCESS | 10549 | 08:20:15 INFO - PROCESS | 10549 | [#0] dojo.html Cycles:165 Average:5376.20 Median:5552.67 stddev:595.89 (10.7%) stddev-sans-first:570.89 08:20:15 INFO - PROCESS | 10549 | Values: 3122.6 3125.2 3158.3 3168.8 3203.2 5353.0 5358.5 5423.9 5509.6 5548.7 5331.5 5393.4 5397.9 5444.4 5482.9 4847.6 4932.2 4938.4 4938.8 5093.2 4994.8 5027.6 5034.4 5049.3 5060.7 4935.1 4950.9 5005.7 5006.8 5011.8 4842.8 4845.2 4862.9 4935.3 5100.7 4883.0 4893.6 4902.9 4918.2 4926.3 5160.6 5328.3 5357.2 5382.4 5410.8 5868.4 5918.0 5919.2 5919.3 5936.2 5920.4 5946.9 5948.6 5975.9 5978.3 5284.2 5322.6 5371.7 5372.4 5549.3 5936.0 5937.4 5938.2 5940.3 5940.9 5676.0 5688.3 5713.1 5724.2 5724.6 5672.6 5741.3 5831.7 5840.2 5880.1 5756.7 5832.8 5833.2 5844.2 5855.2 5618.9 5835.4 5869.0 5873.7 5885.6 4421.7 4456.0 4458.7 4479.3 4480.0 3975.8 3981.5 3993.6 4001.0 4021.6 5370.6 5533.3 5571.5 5579.7 5592.4 5764.5 5769.1 5816.9 5846.2 5925.4 5538.1 5548.1 5553.8 5554.4 5559.4 4900.0 5071.0 5072.3 5076.4 5129.3 5869.2 5895.4 5919.0 5952.6 5964.9 5731.5 5733.1 5735.7 5738.3 5738.8 5809.9 5842.4 5932.4 5947.7 5950.3 5555.1 5619.2 5620.3 5621.2 5666.7 5692.1 5717.9 5721.5 5722.2 5727.5 5433.1 5503.8 5533.4 5578.2 5588.7 5552.7 5555.6 5559.5 5566.3 5623.0 5465.3 5468.7 5469.6 5471.6 5530.4 5441.6 5561.7 5610.4 5615.6 5621.9 5511.9 5519.1 5520.7 5520.8 5562.2 08:20:15 INFO - PROCESS | 10549 | 08:20:15 INFO - PROCESS | 10549 | [#1] ext.html Cycles:180 Average:61102.52 Median:41045.69 stddev:117634.17 (286.6%) stddev-sans-first:117876.45 08:20:15 INFO - PROCESS | 10549 | Values: 599.0 608.7 626.6 632.0 656.5 32178.7 44436.3 45593.8 45673.3 45751.0 47339.8 47799.8 47826.0 47866.3 47921.5 8819.5 9019.5 9019.6 9022.1 9022.9 8684.4 8798.7 8799.3 8800.1 8801.8 9008.1 9038.3 9063.7 9065.4 9065.8 8921.2 8958.0 8988.5 8990.6 8992.9 8853.0 8926.6 8959.4 8960.9 8964.6 42622.0 43095.0 43172.8 43253.6 43406.6 3562.3 3701.3 3720.9 3724.5 3863.5 31519.1 33615.5 33877.0 34267.5 34361.8 4486.8 4562.4 4567.1 4654.1 4681.1 351526.0 359320.2 359571.0 359794.0 360232.0 57186.7 63532.0 66512.0 67361.0 67506.0 63311.4 69132.7 70528.3 70585.6 70684.6 17189.7 17192.8 17310.8 17317.7 17342.8 13696.7 13783.9 13801.7 13806.9 13813.7 18563.3 20335.5 21048.4 21071.8 21878.8 7664.8 7668.8 7920.0 7962.6 7981.6 971.7 1001.4 1025.8 1125.2 1135.6 33386.8 33778.3 33843.0 33993.5 34108.0 1137.5 1180.7 1205.9 1233.0 1261.2 17435.5 17790.1 17900.5 17916.8 17963.4 546998.0 553850.0 555136.0 555496.0 556348.0 60633.1 62263.7 62269.4 62395.4 62611.4 1298.7 1400.6 1408.7 1411.3 1429.8 32734.3 34931.5 35011.8 35115.2 35305.6 52493.0 53010.2 53096.5 53125.0 53156.7 394881.0 396383.0 396633.0 397156.0 399184.0 34614.8 35324.5 40571.6 43155.8 43193.4 46849.3 47564.3 47657.8 48477.8 48713.8 39945.0 40489.8 40815.0 40951.6 41009.8 39594.0 40056.2 40059.4 40763.6 41046.6 39729.6 40905.4 40984.8 41044.8 41157.2 34199.5 35779.8 36023.6 36738.6 36864.3 27665.3 27883.0 27953.6 28098.3 28106.0 08:20:15 INFO - PROCESS | 10549 | 08:20:15 INFO - PROCESS | 10549 | [#2] jquery.html Cycles:180 Average:28204.14 Median:3559.61 stddev:76656.00 (2153.5%) stddev-sans-first:76842.59 08:20:15 INFO - PROCESS | 10549 | Values: 385.9 390.7 393.9 407.9 415.1 14171.4 16201.7 17895.6 19488.3 19501.1 14886.8 14942.3 17717.1 18109.4 18138.3 5357.0 5789.6 5789.9 5791.5 5792.7 3912.9 5510.3 5668.8 5720.7 5724.4 5887.4 6250.1 6251.5 6353.0 6361.2 6123.0 6313.7 6336.7 6400.3 6410.2 5604.6 5619.8 5632.1 5644.6 5658.1 20898.4 21097.9 21944.0 21957.0 22247.8 2310.2 2366.6 2492.8 2899.3 3139.0 13240.7 13580.7 13656.1 14273.0 14450.6 1937.9 1959.8 1982.6 2002.7 2072.6 72582.6 76206.0 81073.6 81125.6 84948.0 10775.7 10801.6 10870.8 11069.5 11191.2 15256.7 15260.1 15350.2 15372.9 15394.8 7377.7 7971.6 9669.0 9686.2 10203.6 8461.2 8475.2 8502.9 8535.7 8701.1 8510.6 8713.5 8830.6 9014.2 9110.0 3361.4 3449.9 3483.8 3527.8 3591.5 895.2 943.9 991.7 1012.8 1027.9 18119.6 18639.4 18777.6 18904.2 18973.6 1017.8 1024.6 1041.1 1050.1 1087.5 9959.4 10610.7 10614.1 10663.5 10688.7 454357.0 460295.7 460913.0 469338.0 472658.0 95086.0 96523.5 97961.0 99979.0 102707.5 478.2 495.5 500.2 501.2 981.0 10050.6 10666.1 10781.4 10819.4 10821.4 36243.3 39867.6 41465.6 42181.8 42424.0 45744.8 56284.7 56887.0 57505.4 57536.1 8515.9 8712.9 8766.3 8836.4 8942.3 9788.7 13008.7 13015.7 13115.3 13257.1 11415.7 11504.1 11744.2 11933.8 12005.9 11333.9 11618.2 11619.9 11728.8 11958.9 11705.4 11857.8 12132.0 12161.9 12173.6 8418.7 8427.9 8504.3 8654.6 8889.1 10836.5 11209.4 11519.9 11524.4 11893.5 08:20:15 INFO - PROCESS | 10549 | 08:20:15 INFO - PROCESS | 10549 | [#3] mootools.html Cycles:180 Average:5632.57 Median:5094.20 stddev:3076.44 (60.4%) stddev-sans-first:3068.67 08:20:15 INFO - PROCESS | 10549 | Values: 1405.4 1533.7 1543.1 1684.5 1851.1 7695.5 8034.1 8045.6 8288.6 8311.5 8029.3 8235.8 8244.8 8246.3 8253.3 2045.0 2271.1 2337.8 2346.6 2366.3 2398.2 2406.3 2408.6 2409.4 2412.1 2353.9 2358.0 2374.0 2380.2 2388.3 2018.2 2219.8 2268.2 2280.6 2287.0 2364.5 2386.0 2393.6 2394.7 2400.2 8327.8 8373.7 8379.7 8394.9 8396.2 5097.4 5237.3 5245.4 5246.4 5247.5 3270.8 3361.6 3424.4 3430.5 3499.7 1158.6 1161.3 1196.7 1209.9 1215.9 11597.4 11607.2 11641.3 11648.3 11659.8 4458.5 4637.9 4659.0 4719.8 4721.8 9902.9 9914.1 9916.9 9917.4 9926.3 5183.9 5244.6 5253.4 5256.8 5259.1 4160.3 4715.2 4848.3 4850.0 4946.0 3845.8 3963.7 3975.7 4019.7 4052.7 1274.8 1304.6 1320.8 1334.1 1334.9 1057.4 1067.9 1071.3 1074.2 1075.1 6050.9 6077.1 6164.0 6204.4 6210.3 453.2 457.4 457.5 1012.4 1023.9 4322.4 4326.9 4339.8 4344.2 4380.9 10142.0 10275.4 10296.7 10395.7 10396.6 10225.7 10280.0 10291.6 10294.2 10310.8 7581.9 7920.6 7923.9 7924.1 8085.8 6047.8 6196.3 6206.6 6236.4 6382.8 9258.8 9452.0 9566.4 9569.0 9569.0 9548.0 9806.4 9817.2 9836.9 9889.6 6945.4 7148.8 7150.2 7537.7 7703.0 7588.5 8259.1 8270.0 8452.8 8457.8 7079.0 7305.3 7499.4 7527.9 7634.6 6954.3 7156.1 7161.4 7233.4 7241.2 6779.5 6861.2 6861.6 6863.7 6866.9 5091.0 5127.4 5161.2 5201.1 5272.8 5224.8 5383.2 5406.3 5452.9 5484.0 08:20:15 INFO - PROCESS | 10549 | 08:20:15 INFO - PROCESS | 10549 | [#4] prototype.html Cycles:180 Average:4614.74 Median:5159.79 stddev:1360.55 (26.4%) stddev-sans-first:1325.93 08:20:15 INFO - PROCESS | 10549 | Values: 336.9 338.9 346.5 346.6 349.2 5315.6 5362.8 5364.4 5372.3 5376.6 5308.6 5321.8 5325.5 5326.3 5349.8 3857.8 4012.5 4014.6 4031.2 4116.3 4151.7 4166.9 4179.4 4180.4 4191.4 4106.8 4151.3 4167.7 4169.8 4198.7 3974.3 4093.4 4182.2 4186.3 4212.2 3688.5 3693.2 3720.5 3733.6 3740.4 5068.1 5076.9 5081.8 5120.6 5130.3 4525.5 4713.9 4724.8 4736.8 4757.3 5540.4 5567.7 5570.2 5571.4 5582.9 3992.9 4002.4 4007.9 4044.3 4074.0 5704.8 5712.2 5732.4 5892.4 5921.6 4030.4 4057.4 4066.5 4067.0 4080.3 4111.0 4114.1 4120.2 4120.3 4129.3 4492.1 4703.0 4723.4 4731.3 4739.4 5601.5 5621.5 5627.7 5636.6 5641.8 1381.8 1389.7 1401.6 1410.9 1417.6 882.7 898.9 916.0 926.4 928.9 4819.0 4857.7 4862.2 4872.5 4875.4 5090.5 5101.3 5116.0 5147.9 5182.9 4606.0 4710.3 4757.4 4806.1 4817.4 2709.8 2711.0 2723.6 2735.5 2742.0 5242.0 5253.5 5256.8 5277.7 5303.6 4934.8 5149.6 5170.0 5172.3 5579.9 5796.2 5824.2 5935.9 5937.3 5938.7 5676.0 5712.4 5734.3 5800.8 5801.0 5533.4 5724.9 5729.2 5735.9 5747.9 5937.6 5944.3 5958.3 5975.2 5992.7 4167.2 4180.7 4213.7 4225.3 4250.4 5532.1 5804.3 5824.4 5836.4 5844.6 5549.6 5563.9 5594.1 5594.4 5607.5 5439.0 5530.9 5568.8 5596.0 5604.3 5412.2 5454.3 5522.4 5527.2 5527.5 5648.3 5676.2 5677.0 5690.7 5703.5 5258.8 5494.0 5513.4 5550.3 5562.7 08:20:15 INFO - PROCESS | 10549 | 08:20:15 INFO - PROCESS | 10549 | [#5] yui.html Cycles:180 Average:20281.38 Median:25072.01 stddev:28749.34 (114.7%) stddev-sans-first:28792.46 08:20:15 INFO - PROCESS | 10549 | Values: 716.0 730.0 798.3 808.5 809.3 15438.8 15597.8 15697.7 15754.6 15904.8 14281.7 14402.1 14445.3 14457.6 14459.6 690.3 810.3 817.9 837.2 845.6 838.5 838.6 840.3 841.8 842.3 838.7 839.1 839.3 839.6 839.7 716.8 835.3 841.6 869.7 872.1 634.9 634.9 635.3 635.4 636.5 15062.3 15079.5 15117.6 15118.6 15125.6 13938.2 14266.7 14275.4 14339.4 14541.6 12035.8 12174.8 12283.9 12303.7 12356.6 4413.0 4463.3 4484.7 4496.1 4527.3 68393.0 68645.7 68702.3 69184.3 69355.7 10455.7 10504.5 10553.2 10694.5 10829.2 19279.0 19279.7 19302.1 19303.4 19312.0 7868.8 7956.7 8057.6 8123.5 8362.5 4443.2 4495.8 4516.0 4523.7 4596.1 3438.1 3444.8 3550.6 3554.7 3554.9 593.6 600.7 604.4 611.0 616.0 580.5 627.5 676.5 734.1 740.7 9336.2 9828.8 9876.2 9916.8 9926.8 588.9 698.7 712.2 721.3 723.3 4593.6 4787.3 4814.0 4876.7 4928.7 105855.0 105870.0 109920.0 110435.0 114365.0 92832.0 93853.0 96211.5 96447.0 96491.0 86975.6 88748.6 89459.0 89628.6 90049.0 8985.6 9020.7 9036.1 9088.6 9097.4 43278.6 44116.8 45616.8 50976.2 52024.2 71150.6 72940.6 73450.3 73704.6 73851.6 13210.4 13508.5 13575.9 13586.5 14012.4 15209.2 15390.4 15734.4 16223.1 16321.7 14178.4 14605.6 14619.3 14952.9 15073.8 14157.3 14230.4 14370.2 14536.8 15068.5 12890.6 13190.7 13233.0 13283.3 14219.7 11294.9 11565.2 11576.9 11611.7 11717.4 11078.9 11608.5 11914.9 11987.5 12016.1 08:20:15 INFO - PROCESS | 10549 | -------- Summary: end -------- 08:20:15 INFO - PROCESS | 10549 | 08:20:15 INFO - TEST-INFO | 10549: exit 0 08:20:15 INFO - TEST-OK | dromaeo_css | took 1113102ms 08:20:15 INFO - TEST-START | kraken 08:20:15 INFO - operating with platform_type : linux_ 08:20:15 INFO - Initialising browser for kraken test... 08:20:15 INFO - TEST-INFO | started process 10729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLqWDO2/profile http://localhost:42207/getInfo.html) 08:20:20 INFO - PROCESS | 10729 | __metrics Screen width/height:1600/1200 08:20:20 INFO - PROCESS | 10729 | colorDepth:24 08:20:20 INFO - PROCESS | 10729 | Browser inner width/height: 1024/697 08:20:20 INFO - PROCESS | 10729 | __metrics 08:20:21 ERROR - PROCESS | 10729 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:20:21 INFO - TEST-INFO | 10729: exit 0 08:20:21 INFO - Browser initialized. 08:20:21 INFO - Running cycle 1/1 for kraken test... 08:20:21 INFO - TEST-INFO | started process 10815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLqWDO2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:33 INFO - PROCESS | 10815 | RSS: Main: 156512256 08:20:33 INFO - PROCESS | 10815 | 08:20:36 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42207/tests/kraken/driver.html?testName=audio-beat-detection) 08:20:37 INFO - PROCESS | 10815 | RSS: Main: 214437888 08:20:37 INFO - PROCESS | 10815 | 08:20:39 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42207/tests/kraken/driver.html?testName=audio-dft) 08:20:40 INFO - PROCESS | 10815 | RSS: Main: 201461760 08:20:40 INFO - PROCESS | 10815 | 08:20:43 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42207/tests/kraken/driver.html?testName=audio-fft) 08:20:44 INFO - PROCESS | 10815 | RSS: Main: 269164544 08:20:44 INFO - PROCESS | 10815 | 08:20:46 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42207/tests/kraken/driver.html?testName=audio-oscillator) 08:20:46 INFO - PROCESS | 10815 | RSS: Main: 179580928 08:20:46 INFO - PROCESS | 10815 | 08:20:48 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42207/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:49 INFO - PROCESS | 10815 | RSS: Main: 183525376 08:20:49 INFO - PROCESS | 10815 | 08:20:52 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42207/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:53 INFO - PROCESS | 10815 | RSS: Main: 219127808 08:20:53 INFO - PROCESS | 10815 | 08:20:56 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42207/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:57 INFO - PROCESS | 10815 | RSS: Main: 220663808 08:20:57 INFO - PROCESS | 10815 | 08:21:00 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42207/tests/kraken/driver.html?testName=json-parse-financial) 08:21:00 INFO - PROCESS | 10815 | RSS: Main: 219996160 08:21:00 INFO - PROCESS | 10815 | 08:21:02 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42207/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:21:02 INFO - PROCESS | 10815 | RSS: Main: 206458880 08:21:02 INFO - PROCESS | 10815 | 08:21:04 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42207/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:21:05 INFO - PROCESS | 10815 | RSS: Main: 210911232 08:21:05 INFO - PROCESS | 10815 | 08:21:07 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42207/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:21:07 INFO - PROCESS | 10815 | RSS: Main: 219512832 08:21:07 INFO - PROCESS | 10815 | 08:21:10 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:21:11 INFO - PROCESS | 10815 | RSS: Main: 221777920 08:21:11 INFO - PROCESS | 10815 | 08:21:13 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:21:14 INFO - PROCESS | 10815 | RSS: Main: 221179904 08:21:14 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:42207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42207/tests/kraken/driver.html?testName=ai-astar) 08:21:16 INFO - PROCESS | 10815 | RSS: Main: 263614464 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | __start_tp_report 08:21:16 INFO - PROCESS | 10815 | _x_x_mozilla_page_load 08:21:16 INFO - PROCESS | 10815 | _x_x_mozilla_page_load_details 08:21:16 INFO - PROCESS | 10815 | |i|pagename|runs| 08:21:16 INFO - PROCESS | 10815 | |0;ai-astar;113;107;110;111;111;110;111;111;109;110 08:21:16 INFO - PROCESS | 10815 | |1;audio-beat-detection;151;127;127;172;135;125;151;126;164;124 08:21:16 INFO - PROCESS | 10815 | |2;audio-dft;159;161;160;161;163;160;161;161;162;163 08:21:16 INFO - PROCESS | 10815 | |3;audio-fft;74;74;75;122;75;76;82;75;108;76 08:21:16 INFO - PROCESS | 10815 | |4;audio-oscillator;84;83;112;84;85;86;117;82;83;125 08:21:16 INFO - PROCESS | 10815 | |5;imaging-gaussian-blur;117;116;118;119;119;119;118;119;118;118 08:21:16 INFO - PROCESS | 10815 | |6;imaging-darkroom;145;147;145;146;146;145;145;146;145;145 08:21:16 INFO - PROCESS | 10815 | |7;imaging-desaturate;95;95;95;94;94;95;95;95;95;95 08:21:16 INFO - PROCESS | 10815 | |8;json-parse-financial;55;52;53;53;54;53;53;53;54;53 08:21:16 INFO - PROCESS | 10815 | |9;json-stringify-tinderbox;62;67;62;62;62;61;61;61;63;61 08:21:16 INFO - PROCESS | 10815 | |10;stanford-crypto-aes;80;84;81;83;80;81;81;81;122;86 08:21:16 INFO - PROCESS | 10815 | |11;stanford-crypto-ccm;130;120;123;125;119;136;119;120;125;132 08:21:16 INFO - PROCESS | 10815 | |12;stanford-crypto-pbkdf2;160;164;163;158;164;162;162;162;160;162 08:21:16 INFO - PROCESS | 10815 | |13;stanford-crypto-sha256-iterative;64;65;69;63;64;63;65;64;62;65 08:21:16 INFO - PROCESS | 10815 | __end_tp_report 08:21:16 INFO - PROCESS | 10815 | __start_cc_report 08:21:16 INFO - PROCESS | 10815 | _x_x_mozilla_cycle_collect,1620 08:21:16 INFO - PROCESS | 10815 | __end_cc_report 08:21:16 INFO - PROCESS | 10815 | __startTimestamp1464880876305__endTimestamp 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | ------- Summary: start ------- 08:21:16 INFO - PROCESS | 10815 | Number of tests: 14 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.57 (1.4%) stddev-sans-first:1.32 08:21:16 INFO - PROCESS | 10815 | Values: 113.0 107.0 110.0 111.0 111.0 110.0 111.0 111.0 109.0 110.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:143.00 stddev:17.89 (12.5%) stddev-sans-first:18.55 08:21:16 INFO - PROCESS | 10815 | Values: 151.0 127.0 127.0 172.0 135.0 125.0 151.0 126.0 164.0 124.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.12 08:21:16 INFO - PROCESS | 10815 | Values: 159.0 161.0 160.0 161.0 163.0 160.0 161.0 161.0 162.0 163.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#3] audio-fft Cycles:10 Average:83.70 Median:75.00 stddev:16.98 (22.6%) stddev-sans-first:17.64 08:21:16 INFO - PROCESS | 10815 | Values: 74.0 74.0 75.0 122.0 75.0 76.0 82.0 75.0 108.0 76.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:83.50 stddev:16.82 (20.1%) stddev-sans-first:17.43 08:21:16 INFO - PROCESS | 10815 | Values: 84.0 83.0 112.0 84.0 85.0 86.0 117.0 82.0 83.0 125.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.50 stddev:0.99 (0.8%) stddev-sans-first:0.97 08:21:16 INFO - PROCESS | 10815 | Values: 117.0 116.0 118.0 119.0 119.0 119.0 118.0 119.0 118.0 118.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 08:21:16 INFO - PROCESS | 10815 | Values: 145.0 147.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:21:16 INFO - PROCESS | 10815 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.60 08:21:16 INFO - PROCESS | 10815 | Values: 55.0 52.0 53.0 53.0 54.0 53.0 53.0 53.0 54.0 53.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:1.81 (2.9%) stddev-sans-first:1.92 08:21:16 INFO - PROCESS | 10815 | Values: 62.0 67.0 62.0 62.0 62.0 61.0 61.0 61.0 63.0 61.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:81.00 stddev:12.83 (15.8%) stddev-sans-first:13.43 08:21:16 INFO - PROCESS | 10815 | Values: 80.0 84.0 81.0 83.0 80.0 81.0 81.0 81.0 122.0 86.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.00 stddev:5.97 (4.8%) stddev-sans-first:6.04 08:21:16 INFO - PROCESS | 10815 | Values: 130.0 120.0 123.0 125.0 119.0 136.0 119.0 120.0 125.0 132.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:1.89 (1.2%) stddev-sans-first:1.90 08:21:16 INFO - PROCESS | 10815 | Values: 160.0 164.0 163.0 158.0 164.0 162.0 162.0 162.0 160.0 162.0 08:21:16 INFO - PROCESS | 10815 | 08:21:16 INFO - PROCESS | 10815 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.90 (2.9%) stddev-sans-first:2.01 08:21:16 INFO - PROCESS | 10815 | Values: 64.0 65.0 69.0 63.0 64.0 63.0 65.0 64.0 62.0 65.0 08:21:16 INFO - PROCESS | 10815 | -------- Summary: end -------- 08:21:16 INFO - PROCESS | 10815 | 08:21:17 INFO - TEST-INFO | 10815: exit 0 08:21:17 INFO - TEST-OK | kraken | took 61474ms 08:21:17 INFO - SUITE-END | took 1174s 08:21:17 INFO - Completed test suite (00:19:34) 08:21:17 INFO - javascript benchmark 08:21:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.6096737907774, 3125.2343175921897, 3158.273597072673, 3168.841557922103, 3203.1511649412896, 5353.0, 5358.490943360384, 5423.918641220384, 5509.614326997112, 5548.72256387181, 5331.546818520431, 5393.379761327448, 5397.865053373667, 5444.428335024825, 5482.890342193154, 4847.587955023819, 4932.161532539477, 4938.407391113072, 4938.777755001016, 5093.2105523643895, 4994.750262486879, 5027.597792176635, 5034.370703662043, 5049.3183420238165, 5060.746962651871, 4935.136351138536, 4950.925736113961, 5005.6996580205305, 5006.774695138727, 5011.799528018875, 4842.757862106881, 4845.248986407112, 4862.902741945177, 4935.259711043336, 5100.719460429675, 4883.047805677894, 4893.584045356149, 4902.926456103161, 4918.213085906274, 4926.261060840867, 5160.56135228506, 5328.333958255218, 5357.223202635596, 5382.381026182, 5410.83767486976, 5868.413158684098, 5917.970410147922, 5919.230500035011, 5919.319278283009, 5936.168936348915, 5920.407959204088, 5946.881062378771, 5948.553858460633, 5975.910361344583, 5978.3124940631515, 5284.154535274376, 5322.627416080876, 5371.677699338053, 5372.382176049726, 5549.278593782823, 5935.970320148372, 5937.376575459514, 5938.2280303560265, 5940.31686356066, 5940.940590594125, 5676.0, 5688.345840228344, 5713.143028545752, 5724.198612194296, 5724.627899186623, 5672.631278966854, 5741.311042674905, 5831.737571809279, 5840.182374467578, 5880.117982302689, 5756.7121643917635, 5832.825015249549, 5833.183354330397, 5844.211031510692, 5855.209546711225, 5618.85952851182, 5835.44563266489, 5869.0, 5873.735681894325, 5885.558583106199, 4421.690481666253, 4455.9554404456185, 4458.665600080007, 4479.283314669702, 4480.0, 3975.7813320267664, 3981.482407287034, 3993.580674029185, 4001.039750459927, 4021.557628660845, 5370.570354371641, 5533.253010843565, 5571.470710282517, 5579.6652200868075, 5592.384837667853, 5764.538836893039, 5769.105788602773, 5816.912746308809, 5846.181534585162, 5925.4370834770625, 5538.086215774432, 5548.112302031736, 5553.750406158582, 5554.389017208104, 5559.360673522597, 4900.019996000814, 5071.036503064406, 5072.28987941681, 5076.3908330999775, 5129.333186685707, 5869.236999190163, 5895.41045895407, 5919.0, 5952.613080149863, 5964.850878728066, 5731.541476681939, 5733.140028995684, 5735.684537350486, 5738.282714660668, 5738.8278351649515, 5809.883802323845, 5842.444967728059, 5932.406759324205, 5947.672877991752, 5950.31571369298, 5555.111182210827, 5619.2133101365025, 5620.269364982526, 5621.213030175697, 5666.688332141772, 5692.146178073156, 5717.885642287214, 5721.456461636138, 5722.198892155018, 5727.513161381163, 5433.1035379161995, 5503.7798488060025, 5533.418991005887, 5578.163275508706, 5588.748506317144, 5552.666839989613, 5555.611107222456, 5559.527440167631, 5566.276384070207, 5623.0, 5465.262189604353, 5468.699221542854, 5469.589780766379, 5471.644343117685, 5530.446955304437, 5441.591880609049, 5561.721913904208, 5610.410906854885, 5615.550755939434, 5621.943780562142, 5511.917321240265, 5519.061759500814, 5520.66875987442, 5520.779168833202, 5562.193481945176], "value": 5337.005949684212, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.9610675306108, 608.695652173913, 626.6208943589131, 631.9715612797423, 656.4748201438848, 32178.67821321786, 44436.3334549982, 45593.77203113988, 45673.31490027652, 45751.0, 47339.76330118345, 47799.761001194944, 47826.0434791304, 47866.28200576994, 47921.52078479214, 8819.514926679047, 9019.54902254888, 9019.639214431414, 9022.052684468103, 9022.86465703015, 8684.435511691752, 8798.6920457784, 8799.34004949628, 8800.075992020842, 8801.823963520726, 9008.144226298524, 9038.322125840556, 9063.728088157366, 9065.410748301372, 9065.818683626323, 8921.197092261695, 8957.955210223972, 8988.46069235848, 8990.595423205972, 8992.8651070234, 8853.0, 8926.553672316422, 8959.41763785352, 8960.865587016135, 8964.59659315326, 42622.0, 43095.0, 43172.78413607912, 43253.56746432527, 43406.565934340884, 3562.2928465496993, 3701.2782507411066, 3720.9441858372147, 3724.478572999782, 3863.5363756349416, 31519.054428367184, 33615.49576756351, 33877.0, 34267.485987710206, 34361.82819085888, 4486.820527178909, 4562.406887104688, 4567.132244873464, 4654.115718013567, 4681.133990211822, 351526.0, 359320.2033989839, 359571.0, 359794.0, 360232.0, 57186.7140664294, 63532.0, 66512.0, 67361.0, 67506.0, 63311.36688633147, 69132.654336728, 70528.29471705217, 70585.64707176431, 70684.64657676678, 17189.656206876043, 17192.828071719374, 17310.826891731173, 17317.653646926992, 17342.826571734375, 13696.65758356049, 13783.931080344735, 13801.723965520634, 13806.86193138076, 13813.654658633413, 18563.32930036303, 20335.4916127098, 21048.368548943556, 21071.78928210729, 21878.781212187994, 7664.846703065908, 7668.846623067508, 7919.970403847463, 7962.601869906482, 7981.640826162837, 971.6502059258661, 1001.3841487485145, 1025.789713108826, 1125.2404626876826, 1135.636596289196, 33386.833065834515, 33778.32443351119, 33843.0, 33993.49009764855, 34108.0, 1137.5051852444212, 1180.6871179137536, 1205.921615095016, 1232.9815052774215, 1261.2054405724518, 17435.47693569195, 17790.110494475226, 17900.46298611018, 17916.820831791516, 17963.371282005068, 546998.0, 553850.0, 555136.0, 555496.0, 556348.0, 60633.09050364248, 62263.688681556305, 62269.37730622727, 62395.376046239864, 62611.37388626146, 1298.6558561981083, 1400.6148309215048, 1408.6830463145916, 1411.3014058041335, 1429.8284205895359, 32734.34531309408, 34931.47602786011, 35011.82494087513, 35115.1655863408, 35305.646943530235, 52493.0, 53010.2048469281, 53096.46903530915, 53125.0, 53156.734216328674, 394881.0, 396383.0, 396633.0, 397156.0, 399184.0, 34614.82692586521, 35324.47013294854, 40571.59428405678, 43155.78422107869, 43193.35209971916, 46849.297260540436, 47564.2865357013, 47657.76171119122, 48477.75761121172, 48713.75643121762, 39945.0, 40489.79755101206, 40815.0, 40951.59048409597, 41009.794951025055, 39594.0, 40056.1988760229, 40059.39910901397, 40763.592364077165, 41046.58953410547, 39729.602703973746, 40905.38641920314, 40984.79507602562, 41044.79477602593, 41157.1768564621, 34199.4870076954, 35779.821100894325, 36023.63976360203, 36738.63261367352, 36864.26271474502, 27665.308367290978, 27883.0, 27953.580696289166, 28098.2975425616, 28106.0], "value": 20953.515220232704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.90352411897027, 390.65622252417876, 393.8582110440243, 407.8959865234366, 415.09923466078607, 14171.433142674281, 16201.675966480663, 17895.64208715825, 19488.317908873192, 19501.122449489772, 14886.776698349533, 14942.252887355644, 17717.114144292766, 18109.366172183974, 18138.274469021224, 5357.0, 5789.623674461168, 5789.884202315951, 5791.507721843648, 5792.71036448178, 3912.941305880414, 5510.311211098613, 5668.801591944282, 5720.685362305072, 5724.427557244284, 5887.35239123696, 6250.093736408218, 6251.531135164858, 6353.0, 6361.2048493938255, 6122.96938515309, 6313.747450101991, 6336.746530138789, 6400.295967443578, 6410.166678331787, 5604.579656525736, 5619.775208991636, 5632.127020311858, 5644.604877658566, 5658.122990936411, 20898.37304880856, 21097.8945105275, 21944.0, 21957.0, 22247.777522224733, 2310.249169020075, 2366.5858474766846, 2492.8130390220626, 2899.3476467794576, 3139.0425920094362, 13240.675563010733, 13580.660483487893, 13656.112352697042, 14273.0, 14450.566483005421, 1937.94186174415, 1959.7648282206226, 1982.5935683184912, 2002.67957126859, 2072.616565935307, 72582.63708681423, 76206.0, 81073.59463202705, 81125.59437202776, 84948.0, 10775.676729698122, 10801.621943232107, 10870.782584348268, 11069.50187241576, 11191.216614837045, 15256.694866102616, 15260.084394936339, 15350.155741434328, 15372.923135384252, 15394.846051539565, 7377.704891804375, 7971.641276142587, 9668.951655241679, 9686.225101991824, 10203.642872499428, 8461.196186362286, 8475.152484751476, 8502.914970850336, 8535.701250456204, 8701.129887011375, 8510.61702223389, 8713.52075635846, 8830.602622881986, 9014.233790127913, 9110.0, 3361.394948909171, 3449.87925422609, 3483.773554718935, 3527.7530572859655, 3591.4612808078996, 895.2479916869861, 943.8867335919596, 991.6529214774771, 1012.7873146639141, 1027.8561001459802, 18119.63760724778, 18639.440816775517, 18777.624447511247, 18904.243830246636, 18973.62052758937, 1017.7862648843826, 1024.6004058417222, 1041.141058626636, 1050.1231471721046, 1087.494315143462, 9959.402435853872, 10610.68167954947, 10614.097801686788, 10663.520141593646, 10688.679339619668, 454357.0, 460295.6985215119, 460913.0, 469338.0, 472658.0, 95086.0, 96523.51738241404, 97961.0, 99979.0, 102707.4864625672, 478.2157262090175, 495.45747406589726, 500.2496255616648, 501.1755661936095, 980.9852852207223, 10050.597976081168, 10666.093382062301, 10781.353118812896, 10819.350838949687, 10821.350718956888, 36243.27513449664, 39867.60132398639, 41465.58534414617, 42181.78909105435, 42424.0, 45744.77127614341, 56284.718576406856, 56887.0, 57505.424945750005, 57536.1369579465, 8515.872261915953, 8712.869306960527, 8766.34252431083, 8836.381453298207, 8942.284617230476, 9788.657396991071, 13008.674783130498, 13015.674608134872, 13115.27865967381, 13257.07200495956, 11415.714607134889, 11504.079673626256, 11744.177907546731, 11933.76132477363, 12005.869669381776, 11333.886661133283, 11618.244814087057, 11619.88380116222, 11728.76542469163, 11958.940205298917, 11705.356205408443, 11857.822132668189, 12132.0, 12161.87838121643, 12173.634790956285, 8418.663253470038, 8427.8735818964, 8504.34165337778, 8654.567271636519, 8889.066648001866, 10836.512356943798, 11209.43952802373, 11519.88480115188, 11524.423778811193, 11893.464794084113], "value": 9340.776927699404, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.3605609447702, 1533.7009283189775, 1543.1435553267936, 1684.4946516045184, 1851.1392202625777, 7695.461317707763, 8034.116247212809, 8045.597720113993, 8288.58557072147, 8311.501309921408, 8029.317508011826, 8235.835283294331, 8244.793880153, 8246.299064579503, 8253.257206851382, 2044.9591008179827, 2271.057511132878, 2337.801286890612, 2346.601077816775, 2366.2782851230368, 2398.1846172301416, 2406.278116565032, 2408.5664580375524, 2409.4458274596764, 2412.1436889904094, 2353.9176128835493, 2358.0, 2373.964390534143, 2380.2264264114146, 2388.295452841407, 2018.1523760020752, 2219.7780221977673, 2268.1834539565743, 2280.600894843396, 2287.0, 2364.4679947011787, 2386.0, 2393.5930891748444, 2394.724606670238, 2400.195934361991, 8327.791805204919, 8373.748787536384, 8379.664813407517, 8394.874076888851, 8396.202360775716, 5097.362829646294, 5237.3453318335205, 5245.449227831061, 5246.449122842123, 5247.527722504955, 3270.787398819093, 3361.5629968104236, 3424.434968230239, 3430.5025771263277, 3499.7200223982277, 1158.5829101523445, 1161.2567956507842, 1196.7008247938015, 1209.9153059285854, 1215.9392030398444, 11597.420128993517, 11607.187496875138, 11641.301521908712, 11648.301101933912, 11659.825102623467, 4458.509563947963, 4637.907241855144, 4658.95341046592, 4719.787609557578, 4721.787519561628, 9902.851457228147, 9914.107730304308, 9916.851247231298, 9917.404955702681, 9926.30515863897, 5183.922241166386, 5244.554212891947, 5253.44838791929, 5256.816011439581, 5259.132243179909, 4160.313548264502, 4715.174844402216, 4848.345473361122, 4850.0, 4945.975270123627, 3845.8269377877505, 3963.6630886374405, 3975.7018223632763, 4019.678425725935, 4052.7163098582814, 1274.840644919385, 1304.5760127958451, 1320.7688654485619, 1334.0928168845278, 1334.8932085433141, 1057.4289883462998, 1067.9199060070525, 1071.3197119828965, 1074.1943542343085, 1075.0861767497565, 6050.939490605126, 6077.058056001327, 6163.96918015407, 6204.410580994799, 6210.347913469111, 453.20688794609435, 457.4464897474094, 457.50360858468935, 1012.367270455965, 1023.9334443261164, 4322.394864718942, 4326.870193894189, 4339.7830108494445, 4344.218040752695, 4380.934285985712, 10142.0, 10275.383476991405, 10296.742581435525, 10395.740106497247, 10396.636117735994, 10225.693229203136, 10280.02339777735, 10291.588336466457, 10294.227932904912, 10310.845337319946, 7581.886271705929, 7920.564368959647, 7923.881141782877, 7924.128345881948, 8085.83828323442, 6047.848803779941, 6196.287426945959, 6206.627602343693, 6236.376362363727, 6382.840428989312, 9258.768530786785, 9451.952740236255, 9566.378185417925, 9568.95215523918, 9569.0, 9548.0, 9806.411615303105, 9817.165540929102, 9836.901630983884, 9889.604415823287, 6945.374916257561, 7148.821279468055, 7150.213476517475, 7537.6984920604755, 7703.0, 7588.506747061423, 8259.132791056853, 8270.0, 8452.788680283042, 8457.788555286166, 7079.0, 7305.305995930378, 7499.362554182738, 7527.88708169367, 7634.6182690864125, 6954.269801670954, 7156.141263048467, 7161.391281740902, 7233.421326293778, 7241.203467618452, 6779.491538134758, 6861.210960739579, 6861.588304701734, 6863.691133898887, 6866.896996545156, 5091.032703786417, 5127.410502744161, 5161.200013997836, 5201.089809283436, 5272.841814745564, 5224.7648855802345, 5383.219433182245, 5406.270153529381, 5452.945470545244, 5483.972580137074], "value": 4553.466084069662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.94271973764455, 338.9406853800584, 346.5010385045533, 346.5719836002538, 349.20729943029323, 5315.627906046579, 5362.758675859591, 5364.436734142917, 5372.286995067495, 5376.623636345457, 5308.601854860882, 5321.760520776565, 5325.547328477084, 5326.254324394578, 5349.786008559653, 3857.787821669807, 4012.538558065831, 4014.598540145991, 4031.21391328691, 4116.300228961084, 4151.667866570667, 4166.874993750177, 4179.373094035904, 4180.414741936132, 4191.413202151702, 4106.753594784308, 4151.294279972397, 4167.687423443239, 4169.812358443877, 4198.664106871458, 3974.3044967130636, 4093.4269202311702, 4182.247195504808, 4186.3092589722655, 4212.178625168093, 3688.5389326334207, 3693.2244228711734, 3720.5163328767358, 3733.607971163016, 3740.4202348636004, 5068.062408454411, 5076.898462030738, 5081.8475445736685, 5120.591837244788, 5130.3074084998425, 4525.479569849476, 4713.929291060636, 4724.76376181193, 4736.810527578893, 4757.26262429324, 5540.36285827131, 5567.691592475765, 5570.1592187984015, 5571.4428557144365, 5582.944170558283, 3992.900177495557, 4002.4396584478195, 4007.8998025049314, 4044.3326851069537, 4074.0425999890003, 5704.771809127671, 5712.22884910536, 5732.426757324276, 5892.440218179266, 5921.644701317891, 4030.435738996543, 4057.391391291271, 4066.4510291110323, 4066.9796651016554, 4080.2655522006326, 4110.958890411058, 4114.053767633461, 4120.237756015147, 4120.320147175742, 4129.29801933672, 4492.113312408796, 4702.976485117552, 4723.385959825201, 4731.313959475857, 4739.431268247832, 5601.5238704710555, 5621.494065534122, 5627.7467513961155, 5636.577256705681, 5641.80253691127, 1381.7996390523317, 1389.6942672612008, 1401.6005438450197, 1410.9012369134268, 1417.588899219215, 882.6601758322963, 898.9325800564984, 916.0473107967772, 926.3515539122641, 928.911753383441, 4819.0, 4857.708537487762, 4862.197737373364, 4872.4929440268315, 4875.439324477659, 5090.516400941905, 5101.336826212643, 5115.974420127875, 5147.871303217449, 5182.922256166161, 4606.0, 4710.26990816424, 4757.405324334458, 4806.14034649383, 4817.421909370898, 2709.7832173426077, 2710.986445067762, 2723.6323096381734, 2735.5076086304657, 2742.0, 5241.9737901310245, 5253.527182553588, 5256.816011439581, 5277.709725965032, 5303.628745987744, 4934.82867538282, 5149.613778966593, 5169.957866642655, 5172.327597412387, 5579.9163012554845, 5796.159556864315, 5824.155497452845, 5935.881282374415, 5937.30786725781, 5938.673372964528, 5676.0, 5712.371639119777, 5734.283214598176, 5800.796972105956, 5800.970995145166, 5533.446655334596, 5724.885502289848, 5729.169270455844, 5735.931276767076, 5747.85042991395, 5937.643741375531, 5944.295345617647, 5958.285005799332, 5975.193348897843, 5992.700364981646, 4167.166566686736, 4180.686448516312, 4213.705040647125, 4225.28170211071, 4250.447441832665, 5532.114861622282, 5804.332501762351, 5824.388439213822, 5836.358000619844, 5844.561657875592, 5549.5837812163445, 5563.860903477445, 5594.1049432092295, 5594.440555944536, 5607.523360514402, 5438.992254252195, 5530.944690553043, 5568.77724891016, 5595.972020139873, 5604.327480702179, 5412.242286079873, 5454.290942177491, 5522.392536821027, 5527.198556209247, 5527.474889885454, 5648.322201335866, 5676.2337084493065, 5676.978143933967, 5690.658560486384, 5703.515201207943, 5258.7904781899615, 5493.983613031602, 5513.42109078557, 5550.278463799842, 5562.721863906708], "value": 4183.366200077764, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.0369303287081, 729.9744508942184, 798.2855344466706, 808.4906508899393, 809.2514424157654, 15438.768418473705, 15597.84402155978, 15697.686046279081, 15754.606134846634, 15904.840951590466, 14281.71436571268, 14402.063865848713, 14445.277736113205, 14457.5662730118, 14459.638509037279, 690.3062422265616, 810.2909953790434, 817.9386546009043, 837.1628371628371, 845.6194712379423, 838.4550042472412, 838.5890913452395, 840.2899549880341, 841.8232171244047, 842.2588122452233, 838.6771093129129, 839.1398816213369, 839.3495041342946, 839.6095815445816, 839.6515446089866, 716.8028792082167, 835.3317346123108, 841.5792103948025, 869.7303835810856, 872.0930232558131, 634.8761991411676, 634.9174607301068, 635.3455940381415, 635.4185919883301, 636.538509580555, 15062.32219550112, 15079.5476135715, 15117.622059448602, 15118.622034449118, 15125.621859453491, 13938.233397163152, 14266.714665706731, 14275.357608907623, 14339.42642294307, 14541.636459088502, 12035.819462708067, 12174.81737773934, 12283.938580307042, 12303.69240768979, 12356.62930112098, 4413.0, 4463.263561512379, 4484.7084939479155, 4496.055828276033, 4527.253003254459, 68392.9961866354, 68645.65677171633, 68702.31297687058, 69184.30815691828, 69355.65322173407, 10455.68632941013, 10504.527296271686, 10553.155747540179, 10694.518746656264, 10829.187810914056, 19279.0, 19279.710804337945, 19302.13140408685, 19303.4208973731, 19312.0, 7868.842623147505, 7956.681732730742, 8057.556834374049, 8123.512589244664, 8362.498250105013, 4443.200223959719, 4495.797689103998, 4515.954840451619, 4523.7285762854335, 4596.126735920165, 3438.1232785639504, 3444.844981975817, 3550.55618047744, 3554.7156227501737, 3554.8578056877436, 593.6467801658007, 600.6994856136503, 604.4046614085123, 610.9633421994695, 616.017452163798, 580.523970344322, 627.4823270801515, 676.5061505101304, 734.1007266098986, 740.6852087862637, 9336.206422454168, 9828.754281142885, 9876.160526355341, 9916.752081198028, 9926.80146397068, 588.8704485013291, 698.7342275408658, 712.2272334517004, 721.3435773446139, 723.2767232767233, 4593.63250939924, 4787.257975013878, 4813.95186048135, 4876.683015603974, 4928.704277743275, 105855.0, 105870.0, 109920.0, 110435.0, 114365.0, 92832.0, 93853.0, 96211.51894240484, 96447.0, 96491.0, 86975.56512217398, 88748.55625721959, 89459.0, 89628.5518572403, 90049.0, 8985.595648195716, 9020.729378118667, 9036.141566551167, 9088.636454541744, 9097.363184577016, 43278.567214328716, 44116.77941610271, 45616.771916140206, 50976.235356470424, 52024.21963670472, 71150.6442467805, 72940.6352968253, 73450.26549734434, 73704.63147684227, 73851.63074184595, 13210.405531750903, 13508.459661613426, 13575.86424135746, 13586.524471643444, 14012.369443374868, 15209.239538023276, 15390.384384624938, 15734.449294275104, 16223.107729075015, 16321.67356652884, 14178.361973711002, 14605.561833145022, 14619.342129604405, 14952.850471495145, 15073.773893391828, 14157.292135392983, 14230.430782768573, 14370.209638469985, 14536.781948270997, 15068.54794356171, 12890.634748711167, 13190.736185276433, 13233.0, 13283.269420181983, 14219.715605688036, 11294.94352528265, 11565.248258863146, 11576.94211528937, 11611.709707257387, 11717.414129293671, 11078.944605276922, 11608.535658573563, 11914.880851191723, 11987.520499179935, 12016.098792590765], "value": 7518.57269069422, "unit": "score"}], "name": "dromaeo_css", "value": 7286.1506387060745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 109.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 127.0, 172.0, 135.0, 125.0, 151.0, 126.0, 164.0, 124.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 161.0, 163.0, 160.0, 161.0, 161.0, 162.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 122.0, 75.0, 76.0, 82.0, 75.0, 108.0, 76.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 84.0, 85.0, 86.0, 117.0, 82.0, 83.0, 125.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 119.0, 119.0, 119.0, 118.0, 119.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 54.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 63.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 81.0, 83.0, 80.0, 81.0, 81.0, 81.0, 122.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 120.0, 123.0, 125.0, 119.0, 136.0, 119.0, 120.0, 125.0, 132.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 163.0, 158.0, 164.0, 162.0, 162.0, 162.0, 160.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 69.0, 63.0, 64.0, 63.0, 65.0, 64.0, 62.0, 65.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1500.2000000000003, "alertThreshold": 2.0}]} 08:21:17 INFO - Return code: 0 08:21:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:21:17 ERROR - # TBPL SUCCESS # 08:21:17 INFO - Running post-action listener: _resource_record_post_action 08:21:17 INFO - ##### 08:21:17 INFO - ##### Finished run-tests step (success) 08:21:17 INFO - ##### 08:21:17 INFO - Running post-run listener: _resource_record_post_run 08:21:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549367808; Read time: 12; Write time: 648992 08:21:17 INFO - TinderboxPrint: CPU usage
13.2% 08:21:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:21:17 INFO - TinderboxPrint: I/O write bytes / time
549,367,808 / 648,992 08:21:17 INFO - TinderboxPrint: CPU idle
8,263.5 (86.8%) 08:21:17 INFO - TinderboxPrint: CPU user
1,210.0 (12.7%) 08:21:17 INFO - TinderboxPrint: Swap in / out
0 / 0 08:21:17 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259411968; Read time: 0; Write time: 382228 08:21:17 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289955840; Read time: 12; Write time: 266764 08:21:18 INFO - Running post-run listener: _upload_blobber_files 08:21:18 INFO - Blob upload gear active. 08:21:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:21:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:21:18 INFO - (blobuploader) - INFO - Open directory for files ... 08:21:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:21:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:21:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:19 INFO - (blobuploader) - INFO - Done attempting. 08:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:20 INFO - (blobuploader) - INFO - Done attempting. 08:21:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:21:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:21:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:24 INFO - (blobuploader) - INFO - Done attempting. 08:21:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:21:24 INFO - Return code: 0 08:21:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:21:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:21:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8880db185d934751a664c852aa05823692d62a19d842bc5691f9e953dd5c084f40b6047be675c99625d99111926e6dcca103260147fc18bba10743028a0df53d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcb6e42fa2dc39ba5afa797bb8d94f286e5d8685c1fcf69f4350356d979c302d6676ec74e68d7d7e359712ffdab2108e12b0728b91fc74018320372163a45bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6aca02a6360e94a6485aede9c175afaf5bc3d6ac4c3b31611d1acc1c6ad75a3bb23f5da3a177abb1b80b6a60fa39ca2ea33656fea7d334220b23c004c74acaa9"} 08:21:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:21:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:21:24 INFO - Contents: 08:21:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8880db185d934751a664c852aa05823692d62a19d842bc5691f9e953dd5c084f40b6047be675c99625d99111926e6dcca103260147fc18bba10743028a0df53d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcb6e42fa2dc39ba5afa797bb8d94f286e5d8685c1fcf69f4350356d979c302d6676ec74e68d7d7e359712ffdab2108e12b0728b91fc74018320372163a45bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6aca02a6360e94a6485aede9c175afaf5bc3d6ac4c3b31611d1acc1c6ad75a3bb23f5da3a177abb1b80b6a60fa39ca2ea33656fea7d334220b23c004c74acaa9"} 08:21:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:21:24 INFO - Copying logs to upload dir... 08:21:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:21:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.170347 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-02 08:21:24.324256) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 08:21:24.328093) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864 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/sha512/8880db185d934751a664c852aa05823692d62a19d842bc5691f9e953dd5c084f40b6047be675c99625d99111926e6dcca103260147fc18bba10743028a0df53d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcb6e42fa2dc39ba5afa797bb8d94f286e5d8685c1fcf69f4350356d979c302d6676ec74e68d7d7e359712ffdab2108e12b0728b91fc74018320372163a45bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6aca02a6360e94a6485aede9c175afaf5bc3d6ac4c3b31611d1acc1c6ad75a3bb23f5da3a177abb1b80b6a60fa39ca2ea33656fea7d334220b23c004c74acaa9"} build_url:https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8880db185d934751a664c852aa05823692d62a19d842bc5691f9e953dd5c084f40b6047be675c99625d99111926e6dcca103260147fc18bba10743028a0df53d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcb6e42fa2dc39ba5afa797bb8d94f286e5d8685c1fcf69f4350356d979c302d6676ec74e68d7d7e359712ffdab2108e12b0728b91fc74018320372163a45bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6aca02a6360e94a6485aede9c175afaf5bc3d6ac4c3b31611d1acc1c6ad75a3bb23f5da3a177abb1b80b6a60fa39ca2ea33656fea7d334220b23c004c74acaa9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 08:21:24.354644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:21:24.355255) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1464879275.332991-446862864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:21:24.437536) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 08:21:24.437853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 08:21:24.438135) ========= ========= Total master_lag: 0.18 =========