builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1464028458.46 results: success (0) buildid: 20160523083107 builduid: fdf84cb8792e4c3ebd72a5f3021c2e8c revision: d55c8a642e3aae2913df508d513d83bfa39959fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:18.456815) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:18.457215) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:18.459518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:18.862116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:18.862362) ========= 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=41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 11:34:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 27.1M=0s 2016-05-23 11:34:20 (27.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107939 ========= master_lag: 0.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:19.642370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:19.646731) ========= 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=41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019761 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:19.813723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:34:19.814055) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d55c8a642e3aae2913df508d513d83bfa39959fe --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 d55c8a642e3aae2913df508d513d83bfa39959fe --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=41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 11:34:21,109 truncating revision to first 12 chars 2016-05-23 11:34:21,109 Setting DEBUG logging. 2016-05-23 11:34:21,109 attempt 1/10 2016-05-23 11:34:21,109 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d55c8a642e3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 11:34:21,910 unpacking tar archive at: fx-team-d55c8a642e3a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.102962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:34:20.932245) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:20.932583) ========= script_repo_revision: d55c8a642e3aae2913df508d513d83bfa39959fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:20.932961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:20.933228) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:20.952323) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-23 11:34:20.952700) ========= /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=41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:34:22 INFO - MultiFileLogger online at 20160523 11:34:22 in /builds/slave/test 11:34:22 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 11:34:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:34:22 INFO - {'append_to_log': False, 11:34:22 INFO - 'base_work_dir': '/builds/slave/test', 11:34:22 INFO - 'blob_upload_branch': 'Fx-Team', 11:34:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:34:22 INFO - 'branch': 'Fx-Team', 11:34:22 INFO - 'buildbot_json_path': 'buildprops.json', 11:34:22 INFO - 'config_files': ('talos/linux_config.py',), 11:34:22 INFO - 'default_actions': ('clobber', 11:34:22 INFO - 'read-buildbot-config', 11:34:22 INFO - 'download-and-extract', 11:34:22 INFO - 'populate-webroot', 11:34:22 INFO - 'create-virtualenv', 11:34:22 INFO - 'install', 11:34:22 INFO - 'run-tests'), 11:34:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:34:22 INFO - 'download_minidump_stackwalk': True, 11:34:22 INFO - 'download_symbols': 'ondemand', 11:34:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:34:22 INFO - 'tooltool.py': '/tools/tooltool.py', 11:34:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:34:22 INFO - '/tools/misc-python/virtualenv.py')}, 11:34:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:34:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:34:22 INFO - 'installer_path': 'installer.exe', 11:34:22 INFO - 'log_level': 'info', 11:34:22 INFO - 'log_name': 'talos', 11:34:22 INFO - 'log_to_console': True, 11:34:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:34:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:34:22 INFO - 'opt_config_files': (), 11:34:22 INFO - 'pip_index': False, 11:34:22 INFO - 'sps_profile': False, 11:34:22 INFO - 'sps_profile_interval': 0, 11:34:22 INFO - 'suite': 'dromaeojs', 11:34:22 INFO - 'system_bits': '32', 11:34:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:34:22 INFO - 'title': 'talos-linux64-ix-026', 11:34:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:34:22 INFO - 'use_talos_json': True, 11:34:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:34:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:34:22 INFO - 'work_dir': 'build'} 11:34:22 INFO - ##### 11:34:22 INFO - ##### Running clobber step. 11:34:22 INFO - ##### 11:34:22 INFO - Running pre-action listener: _resource_record_pre_action 11:34:22 INFO - Running main action method: clobber 11:34:22 INFO - rmtree: /builds/slave/test/build 11:34:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:34:22 INFO - Running post-action listener: _resource_record_post_action 11:34:22 INFO - ##### 11:34:22 INFO - ##### Finished clobber step (success) 11:34:22 INFO - ##### 11:34:22 INFO - ##### 11:34:22 INFO - ##### Running read-buildbot-config step. 11:34:22 INFO - ##### 11:34:22 INFO - Running pre-action listener: _resource_record_pre_action 11:34:22 INFO - Running main action method: read_buildbot_config 11:34:22 INFO - Using buildbot properties: 11:34:22 INFO - { 11:34:22 INFO - "project": "", 11:34:22 INFO - "product": "firefox", 11:34:22 INFO - "script_repo_revision": "production", 11:34:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:34:22 INFO - "repository": "", 11:34:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:34:22 INFO - "buildid": "20160523083107", 11:34:22 INFO - "pgo_build": "True", 11:34:22 INFO - "basedir": "/builds/slave/test", 11:34:22 INFO - "buildnumber": 705, 11:34:22 INFO - "slavename": "talos-linux64-ix-026", 11:34:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:34:22 INFO - "platform": "ubuntu64_hw", 11:34:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:34:22 INFO - "branch": "fx-team", 11:34:22 INFO - "repo_path": "integration/fx-team", 11:34:22 INFO - "revision": "d55c8a642e3aae2913df508d513d83bfa39959fe", 11:34:22 INFO - "stage_platform": "linux64-pgo", 11:34:22 INFO - "builduid": "fdf84cb8792e4c3ebd72a5f3021c2e8c", 11:34:22 INFO - "slavebuilddir": "test" 11:34:22 INFO - } 11:34:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:34:22 INFO - Running post-action listener: _resource_record_post_action 11:34:22 INFO - ##### 11:34:22 INFO - ##### Finished read-buildbot-config step (success) 11:34:22 INFO - ##### 11:34:22 INFO - ##### 11:34:22 INFO - ##### Running download-and-extract step. 11:34:22 INFO - ##### 11:34:22 INFO - Running pre-action listener: _resource_record_pre_action 11:34:22 INFO - Running main action method: download_and_extract 11:34:22 INFO - mkdir: /builds/slave/test/build/tests 11:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:22 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:24 INFO - Downloaded 1361 bytes. 11:34:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:34:24 INFO - Using the following test package requirements: 11:34:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:34:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:34:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:34:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:24 INFO - u'jsshell-linux-x86_64.zip'], 11:34:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:34:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:34:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:34:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:34:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:34:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:34:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:24 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:34:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:34:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:34:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:25 INFO - Downloaded 24388158 bytes. 11:34:25 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'] 11:34:25 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 11:34:26 INFO - Return code: 0 11:34:26 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 11:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:26 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:34:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:34:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:34:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:27 INFO - Downloaded 24388158 bytes. 11:34:27 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'] 11:34:27 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 11:34:29 INFO - Return code: 0 11:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:29 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:34:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:34:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:34:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:30 INFO - Downloaded 10840359 bytes. 11:34:30 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'] 11:34:30 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 11:34:30 INFO - Return code: 0 11:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:30 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:34:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:34:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:34:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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 11:34:31 INFO - Downloaded 58610420 bytes. 11:34:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:34:31 INFO - mkdir: /builds/slave/test/properties 11:34:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:34:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:34:31 INFO - Contents: 11:34:31 INFO - build_url:https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:34:32 INFO - Running post-action listener: _resource_record_post_action 11:34:32 INFO - Running post-action listener: set_extra_try_arguments 11:34:32 INFO - ##### 11:34:32 INFO - ##### Finished download-and-extract step (success) 11:34:32 INFO - ##### 11:34:32 INFO - ##### 11:34:32 INFO - ##### Running populate-webroot step. 11:34:32 INFO - ##### 11:34:32 INFO - Running pre-action listener: _resource_record_pre_action 11:34:32 INFO - Running main action method: populate_webroot 11:34:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:34:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:34:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:34:32 INFO - '--tppagecycles', 11:34:32 INFO - '7'], 11:34:32 INFO - 'tests': ['tsvgm']}}, 11:34:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:34:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:34:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:34:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:34:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:32 INFO - 'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:32 INFO - 'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['damp', 'tps']}, 11:34:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:32 INFO - 'tests': ['damp', 'tps']}, 11:34:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['dromaeo_dom']}, 11:34:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:34:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['a11yr', 11:34:32 INFO - 'ts_paint', 11:34:32 INFO - 'tpaint', 11:34:32 INFO - 'sessionrestore', 11:34:32 INFO - 'sessionrestore_no_auto_restore', 11:34:32 INFO - 'tabpaint']}, 11:34:32 INFO - 'other-e10s': {'tests': ['a11yr', 11:34:32 INFO - 'ts_paint', 11:34:32 INFO - 'tpaint', 11:34:32 INFO - 'sessionrestore', 11:34:32 INFO - 'sessionrestore_no_auto_restore', 11:34:32 INFO - 'tabpaint']}, 11:34:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:34:32 INFO - 'ts_paint', 11:34:32 INFO - 'tpaint', 11:34:32 INFO - 'sessionrestore', 11:34:32 INFO - 'sessionrestore_no_auto_restore', 11:34:32 INFO - 'tabpaint']}, 11:34:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:34:32 INFO - 'ts_paint', 11:34:32 INFO - 'tpaint', 11:34:32 INFO - 'sessionrestore', 11:34:32 INFO - 'sessionrestore_no_auto_restore', 11:34:32 INFO - 'tabpaint']}, 11:34:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['a11yr', 11:34:32 INFO - 'ts_paint', 11:34:32 INFO - 'tpaint', 11:34:32 INFO - 'sessionrestore', 11:34:32 INFO - 'sessionrestore_no_auto_restore', 11:34:32 INFO - 'tabpaint']}, 11:34:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['a11yr', 11:34:32 INFO - 'ts_paint', 11:34:32 INFO - 'tpaint', 11:34:32 INFO - 'sessionrestore', 11:34:32 INFO - 'sessionrestore_no_auto_restore', 11:34:32 INFO - 'tabpaint']}, 11:34:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['tsvgx', 11:34:32 INFO - 'tsvgr_opacity', 11:34:32 INFO - 'tart', 11:34:32 INFO - 'tscrollx', 11:34:32 INFO - 'cart']}, 11:34:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:34:32 INFO - 'tsvgr_opacity', 11:34:32 INFO - 'tart', 11:34:32 INFO - 'tscrollx', 11:34:32 INFO - 'cart']}, 11:34:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:32 INFO - 'talos_options': ['--disable-e10s'], 11:34:32 INFO - 'tests': ['tp5o']}, 11:34:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:32 INFO - 'tests': ['tp5o']}, 11:34:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:32 INFO - 'talos_options': ['--disable-e10s', 11:34:32 INFO - '--xperf_path', 11:34:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:32 INFO - 'tests': ['tp5n']}, 11:34:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:32 INFO - 'talos_options': ['--xperf_path', 11:34:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:32 INFO - 'tests': ['tp5n']}}, 11:34:32 INFO - 'talos.zip': {'path': '', 11:34:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:34:32 INFO - Running post-action listener: _resource_record_post_action 11:34:32 INFO - ##### 11:34:32 INFO - ##### Finished populate-webroot step (success) 11:34:32 INFO - ##### 11:34:32 INFO - ##### 11:34:32 INFO - ##### Running create-virtualenv step. 11:34:32 INFO - ##### 11:34:32 INFO - Running pre-action listener: _resource_record_pre_action 11:34:32 INFO - Running main action method: create_virtualenv 11:34:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:34:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:34:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:34:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:34:32 INFO - Using real prefix '/usr' 11:34:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:34:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:34:35 INFO - Installing pip.................done. 11:34:35 INFO - Return code: 0 11:34:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0b2e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, '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': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', '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 11:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:34:35 INFO - Using env: {'DISPLAY': ':0', 11:34:35 INFO - 'HOME': '/home/cltbld', 11:34:35 INFO - 'LANG': 'en_US.UTF-8', 11:34:35 INFO - 'LANGUAGE': 'en_US:en', 11:34:35 INFO - 'LOGNAME': 'cltbld', 11:34:35 INFO - 'MAIL': '/var/mail/cltbld', 11:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:35 INFO - 'MOZ_NO_REMOTE': '1', 11:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:35 INFO - 'NO_EM_RESTART': '1', 11:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:35 INFO - 'PWD': '/builds/slave/test', 11:34:35 INFO - 'SHELL': '/bin/bash', 11:34:35 INFO - 'SHLVL': '1', 11:34:35 INFO - 'TERM': 'linux', 11:34:35 INFO - 'TMOUT': '86400', 11:34:35 INFO - 'USER': 'cltbld', 11:34:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:35 INFO - '_': '/tools/buildbot/bin/python'} 11:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:34:35 INFO - Cleaning up... 11:34:35 INFO - Return code: 0 11:34:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0b2e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, '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': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', '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 11:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:34:35 INFO - Using env: {'DISPLAY': ':0', 11:34:35 INFO - 'HOME': '/home/cltbld', 11:34:35 INFO - 'LANG': 'en_US.UTF-8', 11:34:35 INFO - 'LANGUAGE': 'en_US:en', 11:34:35 INFO - 'LOGNAME': 'cltbld', 11:34:35 INFO - 'MAIL': '/var/mail/cltbld', 11:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:35 INFO - 'MOZ_NO_REMOTE': '1', 11:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:35 INFO - 'NO_EM_RESTART': '1', 11:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:35 INFO - 'PWD': '/builds/slave/test', 11:34:35 INFO - 'SHELL': '/bin/bash', 11:34:35 INFO - 'SHLVL': '1', 11:34:35 INFO - 'TERM': 'linux', 11:34:35 INFO - 'TMOUT': '86400', 11:34:35 INFO - 'USER': 'cltbld', 11:34:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:35 INFO - '_': '/tools/buildbot/bin/python'} 11:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:35 INFO - Downloading/unpacking psutil>=3.1.1 11:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:34:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:37 INFO - Installing collected packages: psutil 11:34:37 INFO - Running setup.py install for psutil 11:34:37 INFO - building 'psutil._psutil_linux' extension 11:34:37 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 11:34:37 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 11:34:37 INFO - building 'psutil._psutil_posix' extension 11:34:37 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 11:34:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:34:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:38 INFO - Successfully installed psutil 11:34:38 INFO - Cleaning up... 11:34:38 INFO - Return code: 0 11:34:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0b2e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, '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': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', '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 11:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:34:38 INFO - Using env: {'DISPLAY': ':0', 11:34:38 INFO - 'HOME': '/home/cltbld', 11:34:38 INFO - 'LANG': 'en_US.UTF-8', 11:34:38 INFO - 'LANGUAGE': 'en_US:en', 11:34:38 INFO - 'LOGNAME': 'cltbld', 11:34:38 INFO - 'MAIL': '/var/mail/cltbld', 11:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:38 INFO - 'MOZ_NO_REMOTE': '1', 11:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:38 INFO - 'NO_EM_RESTART': '1', 11:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:38 INFO - 'PWD': '/builds/slave/test', 11:34:38 INFO - 'SHELL': '/bin/bash', 11:34:38 INFO - 'SHLVL': '1', 11:34:38 INFO - 'TERM': 'linux', 11:34:38 INFO - 'TMOUT': '86400', 11:34:38 INFO - 'USER': 'cltbld', 11:34:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:38 INFO - '_': '/tools/buildbot/bin/python'} 11:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:34:40 INFO - Installing collected packages: mozsystemmonitor 11:34:40 INFO - Running setup.py install for mozsystemmonitor 11:34:40 INFO - Successfully installed mozsystemmonitor 11:34:40 INFO - Cleaning up... 11:34:40 INFO - Return code: 0 11:34:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fea0b2e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, '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': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', '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 11:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:34:40 INFO - Using env: {'DISPLAY': ':0', 11:34:40 INFO - 'HOME': '/home/cltbld', 11:34:40 INFO - 'LANG': 'en_US.UTF-8', 11:34:40 INFO - 'LANGUAGE': 'en_US:en', 11:34:40 INFO - 'LOGNAME': 'cltbld', 11:34:40 INFO - 'MAIL': '/var/mail/cltbld', 11:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:40 INFO - 'MOZ_NO_REMOTE': '1', 11:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:40 INFO - 'NO_EM_RESTART': '1', 11:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:40 INFO - 'PWD': '/builds/slave/test', 11:34:40 INFO - 'SHELL': '/bin/bash', 11:34:40 INFO - 'SHLVL': '1', 11:34:40 INFO - 'TERM': 'linux', 11:34:40 INFO - 'TMOUT': '86400', 11:34:40 INFO - 'USER': 'cltbld', 11:34:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:40 INFO - '_': '/tools/buildbot/bin/python'} 11:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:40 INFO - Downloading/unpacking blobuploader==1.2.4 11:34:40 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 11:34:40 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 11:34:40 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 11:34:40 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 11:34:40 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 11:34:40 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 11:34:42 INFO - Downloading blobuploader-1.2.4.tar.gz 11:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:34:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:34:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:43 INFO - Downloading docopt-0.6.1.tar.gz 11:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:34:43 INFO - Installing collected packages: blobuploader, requests, docopt 11:34:43 INFO - Running setup.py install for blobuploader 11:34:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:34:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:34:43 INFO - Running setup.py install for requests 11:34:43 INFO - Running setup.py install for docopt 11:34:43 INFO - Successfully installed blobuploader requests docopt 11:34:43 INFO - Cleaning up... 11:34:43 INFO - Return code: 0 11:34:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:43 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 0x7fea0b2e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, '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': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', '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 11:34:43 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 11:34:43 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 11:34:43 INFO - Using env: {'DISPLAY': ':0', 11:34:43 INFO - 'HOME': '/home/cltbld', 11:34:43 INFO - 'LANG': 'en_US.UTF-8', 11:34:43 INFO - 'LANGUAGE': 'en_US:en', 11:34:43 INFO - 'LOGNAME': 'cltbld', 11:34:43 INFO - 'MAIL': '/var/mail/cltbld', 11:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:43 INFO - 'MOZ_NO_REMOTE': '1', 11:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:43 INFO - 'NO_EM_RESTART': '1', 11:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:43 INFO - 'PWD': '/builds/slave/test', 11:34:43 INFO - 'SHELL': '/bin/bash', 11:34:43 INFO - 'SHLVL': '1', 11:34:43 INFO - 'TERM': 'linux', 11:34:43 INFO - 'TMOUT': '86400', 11:34:43 INFO - 'USER': 'cltbld', 11:34:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:43 INFO - '_': '/tools/buildbot/bin/python'} 11:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:44 INFO - Running setup.py (path:/tmp/pip-OInN_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:44 INFO - Running setup.py (path:/tmp/pip-k8JG7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:44 INFO - Running setup.py (path:/tmp/pip-jkMNAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:44 INFO - Running setup.py (path:/tmp/pip-GHALer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:44 INFO - Running setup.py (path:/tmp/pip-TSGcSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:44 INFO - Running setup.py (path:/tmp/pip-MB1QFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:44 INFO - Running setup.py (path:/tmp/pip-D8DA0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:44 INFO - Running setup.py (path:/tmp/pip-3mH1Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:44 INFO - Running setup.py (path:/tmp/pip-ti1rmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:44 INFO - Running setup.py (path:/tmp/pip-Xk0xBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:44 INFO - Running setup.py (path:/tmp/pip-ClkcZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:44 INFO - Running setup.py (path:/tmp/pip-3Hu5zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:45 INFO - Running setup.py (path:/tmp/pip-QancKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:45 INFO - Running setup.py (path:/tmp/pip-At5na2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:45 INFO - Running setup.py (path:/tmp/pip-thu2hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:45 INFO - Running setup.py (path:/tmp/pip-dWmtXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:45 INFO - Running setup.py (path:/tmp/pip-x2Kysd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:34:45 INFO - Running setup.py install for manifestparser 11:34:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:34:45 INFO - Running setup.py install for mozcrash 11:34:45 INFO - Running setup.py install for mozdebug 11:34:45 INFO - Running setup.py install for mozdevice 11:34:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:34:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:34:45 INFO - Running setup.py install for mozfile 11:34:45 INFO - Running setup.py install for mozhttpd 11:34:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Running setup.py install for mozinfo 11:34:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Running setup.py install for mozInstall 11:34:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Running setup.py install for mozleak 11:34:46 INFO - Running setup.py install for mozlog 11:34:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Running setup.py install for moznetwork 11:34:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Running setup.py install for mozprocess 11:34:46 INFO - Running setup.py install for mozprofile 11:34:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Running setup.py install for mozrunner 11:34:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:34:46 INFO - Running setup.py install for mozscreenshot 11:34:46 INFO - Running setup.py install for moztest 11:34:47 INFO - Running setup.py install for mozversion 11:34:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:34:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:34:47 INFO - Cleaning up... 11:34:47 INFO - Return code: 0 11:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:47 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 0x7fea0b2e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, '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': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', '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 11:34:47 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 11:34:47 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 11:34:47 INFO - Using env: {'DISPLAY': ':0', 11:34:47 INFO - 'HOME': '/home/cltbld', 11:34:47 INFO - 'LANG': 'en_US.UTF-8', 11:34:47 INFO - 'LANGUAGE': 'en_US:en', 11:34:47 INFO - 'LOGNAME': 'cltbld', 11:34:47 INFO - 'MAIL': '/var/mail/cltbld', 11:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:47 INFO - 'MOZ_NO_REMOTE': '1', 11:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:47 INFO - 'NO_EM_RESTART': '1', 11:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:47 INFO - 'PWD': '/builds/slave/test', 11:34:47 INFO - 'SHELL': '/bin/bash', 11:34:47 INFO - 'SHLVL': '1', 11:34:47 INFO - 'TERM': 'linux', 11:34:47 INFO - 'TMOUT': '86400', 11:34:47 INFO - 'USER': 'cltbld', 11:34:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:47 INFO - '_': '/tools/buildbot/bin/python'} 11:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:47 INFO - Running setup.py (path:/tmp/pip-EzQSms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:47 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)) 11:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:47 INFO - Running setup.py (path:/tmp/pip-HIFfwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:47 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)) 11:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:47 INFO - Running setup.py (path:/tmp/pip-LStl6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:47 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)) 11:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:47 INFO - Running setup.py (path:/tmp/pip-iCP7Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:47 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)) 11:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:47 INFO - Running setup.py (path:/tmp/pip-YOey2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:47 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)) 11:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:47 INFO - Running setup.py (path:/tmp/pip-2GEfvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:47 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)) 11:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:47 INFO - Running setup.py (path:/tmp/pip-thazhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:47 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)) 11:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:47 INFO - Running setup.py (path:/tmp/pip-Gp7wbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:48 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)) 11:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:48 INFO - Running setup.py (path:/tmp/pip-tarcaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:48 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)) 11:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:48 INFO - Running setup.py (path:/tmp/pip-77hUtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:48 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)) 11:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:48 INFO - Running setup.py (path:/tmp/pip-6YMYcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:48 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)) 11:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:48 INFO - Running setup.py (path:/tmp/pip-Y7cZK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:48 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)) 11:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:48 INFO - Running setup.py (path:/tmp/pip-8TrKHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:48 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)) 11:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:48 INFO - Running setup.py (path:/tmp/pip-5S79eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:48 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)) 11:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:48 INFO - Running setup.py (path:/tmp/pip-jCyA7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:48 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)) 11:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:48 INFO - Running setup.py (path:/tmp/pip-yQFw9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:48 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)) 11:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:48 INFO - Running setup.py (path:/tmp/pip-srHqH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:48 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)) 11:34:48 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)) 11:34:48 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)) 11:34:48 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)) 11:34:48 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)) 11:34:48 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)) 11:34:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:34:48 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 11:34:48 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 11:34:48 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 11:34:48 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 11:34:48 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 11:34:48 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 11:34:50 INFO - Downloading blessings-1.6.tar.gz 11:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:34:50 INFO - Installing collected packages: blessings 11:34:50 INFO - Running setup.py install for blessings 11:34:50 INFO - Successfully installed blessings 11:34:50 INFO - Cleaning up... 11:34:50 INFO - Return code: 0 11:34:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:50 INFO - Reading from file tmpfile_stdout 11:34:50 INFO - Current package versions: 11:34:50 INFO - argparse == 1.2.1 11:34:50 INFO - blessings == 1.6 11:34:50 INFO - blobuploader == 1.2.4 11:34:50 INFO - docopt == 0.6.1 11:34:50 INFO - manifestparser == 1.1 11:34:50 INFO - mozInstall == 1.12 11:34:50 INFO - mozcrash == 0.17 11:34:50 INFO - mozdebug == 0.1 11:34:50 INFO - mozdevice == 0.48 11:34:50 INFO - mozfile == 1.2 11:34:50 INFO - mozhttpd == 0.7 11:34:50 INFO - mozinfo == 0.9 11:34:50 INFO - mozleak == 0.1 11:34:50 INFO - mozlog == 3.2 11:34:50 INFO - moznetwork == 0.27 11:34:50 INFO - mozprocess == 0.22 11:34:50 INFO - mozprofile == 0.28 11:34:50 INFO - mozrunner == 6.11 11:34:50 INFO - mozscreenshot == 0.1 11:34:50 INFO - mozsystemmonitor == 0.3 11:34:50 INFO - moztest == 0.7 11:34:50 INFO - mozversion == 1.4 11:34:50 INFO - psutil == 3.1.1 11:34:50 INFO - requests == 1.2.3 11:34:50 INFO - wsgiref == 0.1.2 11:34:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34: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')]} 11:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34: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')]} 11:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:50 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 0x7fea0b2e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, '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': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', '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 11:34:50 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 11:34:50 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 11:34:50 INFO - Using env: {'DISPLAY': ':0', 11:34:50 INFO - 'HOME': '/home/cltbld', 11:34:50 INFO - 'LANG': 'en_US.UTF-8', 11:34:50 INFO - 'LANGUAGE': 'en_US:en', 11:34:50 INFO - 'LOGNAME': 'cltbld', 11:34:50 INFO - 'MAIL': '/var/mail/cltbld', 11:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:50 INFO - 'MOZ_NO_REMOTE': '1', 11:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:50 INFO - 'NO_EM_RESTART': '1', 11:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:50 INFO - 'PWD': '/builds/slave/test', 11:34:50 INFO - 'SHELL': '/bin/bash', 11:34:50 INFO - 'SHLVL': '1', 11:34:50 INFO - 'TERM': 'linux', 11:34:50 INFO - 'TMOUT': '86400', 11:34:50 INFO - 'USER': 'cltbld', 11:34:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:50 INFO - '_': '/tools/buildbot/bin/python'} 11:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:51 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)) 11:34:51 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)) 11:34:51 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)) 11:34:51 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)) 11:34:51 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)) 11:34:51 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)) 11:34:51 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)) 11:34:51 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)) 11:34:51 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)) 11:34:51 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)) 11:34:51 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)) 11:34:51 INFO - Cleaning up... 11:34:51 INFO - Return code: 0 11:34:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:34: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')]} 11:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34: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')]} 11:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:51 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 0x7fea0b2e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, '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': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', '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 11:34:51 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 11:34:51 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 11:34:51 INFO - Using env: {'DISPLAY': ':0', 11:34:51 INFO - 'HOME': '/home/cltbld', 11:34:51 INFO - 'LANG': 'en_US.UTF-8', 11:34:51 INFO - 'LANGUAGE': 'en_US:en', 11:34:51 INFO - 'LOGNAME': 'cltbld', 11:34:51 INFO - 'MAIL': '/var/mail/cltbld', 11:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:51 INFO - 'MOZ_NO_REMOTE': '1', 11:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:51 INFO - 'NO_EM_RESTART': '1', 11:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:51 INFO - 'PWD': '/builds/slave/test', 11:34:51 INFO - 'SHELL': '/bin/bash', 11:34:51 INFO - 'SHLVL': '1', 11:34:51 INFO - 'TERM': 'linux', 11:34:51 INFO - 'TMOUT': '86400', 11:34:51 INFO - 'USER': 'cltbld', 11:34:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:51 INFO - '_': '/tools/buildbot/bin/python'} 11:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:51 INFO - Downloading/unpacking jsonschema 11:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:34:53 INFO - Downloading/unpacking functools32 (from jsonschema) 11:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:53 INFO - Downloading functools32-3.2.3-2.tar.gz 11:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:34:53 INFO - warning: no files found matching '*.txt' 11:34:53 INFO - no previously-included directories found matching 'build' 11:34:53 INFO - no previously-included directories found matching 'dist' 11:34:53 INFO - no previously-included directories found matching '.git*' 11:34:53 INFO - Installing collected packages: jsonschema, functools32 11:34:53 INFO - Running setup.py install for functools32 11:34:53 INFO - warning: no files found matching '*.txt' 11:34:53 INFO - no previously-included directories found matching 'build' 11:34:53 INFO - no previously-included directories found matching 'dist' 11:34:53 INFO - no previously-included directories found matching '.git*' 11:34:53 INFO - Successfully installed jsonschema functools32 11:34:53 INFO - Cleaning up... 11:34:53 INFO - Return code: 0 11:34:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:34: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')]} 11:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34: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')]} 11:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:53 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 0x7fea0b2e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, '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': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', '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 11:34:53 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 11:34:53 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 11:34:53 INFO - Using env: {'DISPLAY': ':0', 11:34:53 INFO - 'HOME': '/home/cltbld', 11:34:53 INFO - 'LANG': 'en_US.UTF-8', 11:34:53 INFO - 'LANGUAGE': 'en_US:en', 11:34:53 INFO - 'LOGNAME': 'cltbld', 11:34:53 INFO - 'MAIL': '/var/mail/cltbld', 11:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:53 INFO - 'MOZ_NO_REMOTE': '1', 11:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:53 INFO - 'NO_EM_RESTART': '1', 11:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:53 INFO - 'PWD': '/builds/slave/test', 11:34:53 INFO - 'SHELL': '/bin/bash', 11:34:53 INFO - 'SHLVL': '1', 11:34:53 INFO - 'TERM': 'linux', 11:34:53 INFO - 'TMOUT': '86400', 11:34:53 INFO - 'USER': 'cltbld', 11:34:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:53 INFO - '_': '/tools/buildbot/bin/python'} 11:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:54 INFO - Downloading/unpacking flake8 11:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:34:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:34:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:34:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:34:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:34:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:34:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:34:56 INFO - no previously-included directories found matching 'docs/_build' 11:34:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:34:56 INFO - Running setup.py install for pep8 11:34:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:34:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:34:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:34:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:34:56 INFO - no previously-included directories found matching 'docs/_build' 11:34:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:34:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:34:56 INFO - Cleaning up... 11:34:56 INFO - Return code: 0 11:34:56 INFO - Running post-action listener: _resource_record_post_action 11:34:56 INFO - Running post-action listener: _start_resource_monitoring 11:34:56 INFO - Starting resource monitoring. 11:34:56 INFO - ##### 11:34:56 INFO - ##### Finished create-virtualenv step (success) 11:34:56 INFO - ##### 11:34:56 INFO - ##### 11:34:56 INFO - ##### Running install step. 11:34:56 INFO - ##### 11:34:56 INFO - Running pre-action listener: _resource_record_pre_action 11:34:56 INFO - Running main action method: install 11:34:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:57 INFO - Reading from file tmpfile_stdout 11:34:57 INFO - Detecting whether we're running mozinstall >=1.0... 11:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:34:57 INFO - Reading from file tmpfile_stdout 11:34:57 INFO - Output received: 11:34:57 INFO - Usage: mozinstall [options] installer 11:34:57 INFO - Options: 11:34:57 INFO - -h, --help show this help message and exit 11:34:57 INFO - -d DEST, --destination=DEST 11:34:57 INFO - Directory to install application into. [default: 11:34:57 INFO - "/builds/slave/test"] 11:34:57 INFO - --app=APP Application being installed. [default: firefox] 11:34:57 INFO - mkdir: /builds/slave/test/build/application 11:34:57 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'] 11:34:57 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 11:35:13 INFO - Reading from file tmpfile_stdout 11:35:13 INFO - Output received: 11:35:13 INFO - /builds/slave/test/build/application/firefox/firefox 11:35:13 INFO - Running post-action listener: _resource_record_post_action 11:35:13 INFO - ##### 11:35:13 INFO - ##### Finished install step (success) 11:35:13 INFO - ##### 11:35:13 INFO - ##### 11:35:13 INFO - ##### Running run-tests step. 11:35:13 INFO - ##### 11:35:13 INFO - Running pre-action listener: _resource_record_pre_action 11:35:13 INFO - Running main action method: run_tests 11:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:35:13 INFO - Python 2.7.3 11:35:13 INFO - Return code: 0 11:35:13 INFO - grabbing minidump binary from tooltool 11:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df09c0>, '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 0x1df18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:35:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:35:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:35:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:35:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:35:13 INFO - Return code: 0 11:35:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:35:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:35:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:35:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:35:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:35:14 INFO - Return code: 0 11:35:14 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/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:35:14 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/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 11:35:14 INFO - Using env: {'DISPLAY': ':0', 11:35:14 INFO - 'HOME': '/home/cltbld', 11:35:14 INFO - 'LANG': 'en_US.UTF-8', 11:35:14 INFO - 'LANGUAGE': 'en_US:en', 11:35:14 INFO - 'LOGNAME': 'cltbld', 11:35:14 INFO - 'MAIL': '/var/mail/cltbld', 11:35:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:35:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:14 INFO - 'MOZ_NO_REMOTE': '1', 11:35:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:14 INFO - 'NO_EM_RESTART': '1', 11:35:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:14 INFO - 'PWD': '/builds/slave/test', 11:35:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:35:14 INFO - 'SHELL': '/bin/bash', 11:35:14 INFO - 'SHLVL': '1', 11:35:14 INFO - 'TERM': 'linux', 11:35:14 INFO - 'TMOUT': '86400', 11:35:14 INFO - 'USER': 'cltbld', 11:35:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558', 11:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:14 INFO - '_': '/tools/buildbot/bin/python'} 11:35:14 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/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:35:14 INFO - mozversion application_buildid: 20160523083107 11:35:14 INFO - mozversion application_changeset: d55c8a642e3aae2913df508d513d83bfa39959fe 11:35:14 INFO - mozversion application_display_name: Nightly 11:35:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:35:14 INFO - mozversion application_name: Firefox 11:35:14 INFO - mozversion application_remotingname: firefox 11:35:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:35:14 INFO - mozversion application_vendor: Mozilla 11:35:14 INFO - mozversion application_version: 49.0a1 11:35:14 INFO - mozversion platform_buildid: 20160523083107 11:35:14 INFO - mozversion platform_changeset: d55c8a642e3aae2913df508d513d83bfa39959fe 11:35:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:35:14 INFO - mozversion platform_version: 49.0a1 11:35:14 INFO - using testdate: 1464028514 11:35:14 INFO - actual date: 1464028514 11:35:14 INFO - starting webserver on 'localhost:56070' 11:35:14 INFO - SUITE-START | Running 2 tests 11:35:14 INFO - TEST-START | dromaeo_css 11:35:14 INFO - operating with platform_type : linux_ 11:35:14 INFO - Initialising browser for dromaeo_css test... 11:35:15 INFO - TEST-INFO | started process 29954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRvQGld/profile http://localhost:56070/getInfo.html) 11:35:19 INFO - PROCESS | 29954 | __metrics Screen width/height:1600/1200 11:35:19 INFO - PROCESS | 29954 | colorDepth:24 11:35:19 INFO - PROCESS | 29954 | Browser inner width/height: 1024/697 11:35:19 INFO - PROCESS | 29954 | __metrics 11:35:20 ERROR - PROCESS | 29954 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:35:20 INFO - TEST-INFO | 29954: exit 0 11:35:20 INFO - Browser initialized. 11:35:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:35:20 INFO - TEST-INFO | started process 30035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRvQGld/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:32 INFO - PROCESS | 30035 | RSS: Main: 152240128 11:35:32 INFO - PROCESS | 30035 | 11:36:23 INFO - PROCESS | 30035 | 1464028583423 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] 11:38:31 INFO - PROCESS | 30035 | Cycle 1(1): loaded http://localhost:56070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56070/tests/dromaeo/cssquery-ext.html) 11:38:32 INFO - PROCESS | 30035 | RSS: Main: 256286720 11:38:32 INFO - PROCESS | 30035 | 11:41:34 INFO - PROCESS | 30035 | Cycle 1(1): loaded http://localhost:56070/tests/dromaeo/cssquery-ext.html (next: http://localhost:56070/tests/dromaeo/cssquery-jquery.html) 11:41:35 INFO - PROCESS | 30035 | RSS: Main: 239419392 11:41:35 INFO - PROCESS | 30035 | 11:44:37 INFO - PROCESS | 30035 | Cycle 1(1): loaded http://localhost:56070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56070/tests/dromaeo/cssquery-mootools.html) 11:44:37 INFO - PROCESS | 30035 | RSS: Main: 241086464 11:44:37 INFO - PROCESS | 30035 | 11:47:39 INFO - PROCESS | 30035 | Cycle 1(1): loaded http://localhost:56070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56070/tests/dromaeo/cssquery-prototype.html) 11:47:40 INFO - PROCESS | 30035 | RSS: Main: 234881024 11:47:40 INFO - PROCESS | 30035 | 11:50:42 INFO - PROCESS | 30035 | Cycle 1(1): loaded http://localhost:56070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56070/tests/dromaeo/cssquery-yui.html) 11:50:43 INFO - PROCESS | 30035 | RSS: Main: 218144768 11:50:43 INFO - PROCESS | 30035 | 11:53:46 INFO - PROCESS | 30035 | Cycle 1(1): loaded http://localhost:56070/tests/dromaeo/cssquery-yui.html (next: http://localhost:56070/tests/dromaeo/cssquery-dojo.html) 11:53:46 INFO - PROCESS | 30035 | RSS: Main: 271114240 11:53:46 INFO - PROCESS | 30035 | 11:53:46 INFO - PROCESS | 30035 | __start_tp_report 11:53:46 INFO - PROCESS | 30035 | _x_x_mozilla_page_load 11:53:46 INFO - PROCESS | 30035 | _x_x_mozilla_page_load_details 11:53:46 INFO - PROCESS | 30035 | |i|pagename|runs| 11:53:46 INFO - PROCESS | 30035 | |0;dojo.html;3114.3459873426577;3139.26227336576;3159.2733671255605;3166.160967343653;3196.824174670394;5321.627486075976;5322.4411436799155;5372.435894231108;5442.537384322332;5446.673199608022;5329.626926115174;5393.73031348433;5404.702741349224;5406.135018397057;5409.864753381157;4843.273508973656;4930.654854160211;4953.306537084811;4978.352814134158;5060.418051924021;4939.925901111486;4985.551300382965;5016.3227964224725;5024.723640199788;5039;4751.3348131261655;4795.952040479586;4828.0585285869265;4848;4861.73260470674;4838.129136755382;4853.563179313844;4867.756612169413;4870.415550133971;4904.4605093439695;4753;4839.249916262985;4842.903141937141;4877.731724755173;4931.3835770528685;5236.162214045735;5284.022455845681;5293.7353132343615;5392.0294347017525;5402.945970540283;5733.312002559678;5781.595288329819;5782.56630752691;5786.363500014995;5787.71061446926;5672.40439753824;5743.339515955635;5775.913361299584;5826.592138550303;5829.795957141479;5372.623916325859;5496.395396506381;5496.560275178016;5497.422770609109;5499.340079190482;6008.939910600838;6022.066579680157;6024.367441418675;6029.758809647565;6034.818955431344;5485.369182543979;5564.387917329091;5599.80400685974;5780.971095144581;5797.217375654317;5739.16782066598;5756.769729210869;5782.335031471434;5802.361740208574;5813.6221145625395;5674.602777805597;5704.11586204139;5707.229524014288;5732.942670573241;5735.340435849847;5513.641613295123;5734.369219385864;5736.168255602997;5788.594798364074;5796.275465566804;4433.1577000369825;4434.290513517822;4437.755923424178;4441.244988351988;4473;3953.545342285674;3965.325894597925;3971.6822654187595;3998.2203470323007;4026.2350153470748;5328.307320048369;5385.138377859524;5488.780448782084;5556.77772889088;5559.360673522516;5911.231539899785;5924.822255332347;5930.584859059824;5941.197938278364;6002.759889604455;5583.218349431083;5589.636673616202;5592.217089607459;5597.860053498695;5597.972010139923;4882.609391248691;4946.233333833262;4990.30135780991;5003.699778013258;5031.320771695774;6043.758249670052;6052.697365131726;6053.001254792998;6059.818205453844;6060.666663333559;5730.942690573041;5863.355030946593;5873.089671100986;5876.1773351731645;5878;5880;5901.675407852609;5939.910901336397;5973.701314934149;5981.910271345846;5659.943400565941;5688.914666279927;5692.373838877803;5693.345265294379;5706.714664266853;5667.914981275202;5682.886342273214;5735.197072409949;5806.535477161732;5818.981678206382;5674.177244299471;5775.364709881994;5780.132980052857;5782.508486778671;5811.418858114154;5757.481826635623;5762.481376676119;5766.135079738073;5766.192733017465;5772.365039845529;5411.404745478073;5498.642588231752;5540.667559946416;5677.318721753416;5681.346645135863;5729.656220626775;5760.078387458154;5765.91351129725;5774.0184168690585;5774.797882074107;5580.414056524007;5586.441355864381;5589.972050139723;5591.077472217039;5593.272874526286 11:53:46 INFO - PROCESS | 30035 | |1;ext.html;599.67018140023;641.1152609399029;642.8039447968374;645.4836131095124;653.3694984340111;32367.190820229505;35125.12187195321;35257.2948541029;45266.321005184946;46482.53517464824;45625.31562026572;46184.769076154655;46235.537644623546;46277.53722462774;46300.3054954176;8710.912890871105;8916.687915922912;8925.642974281021;8926.2412694921;8928.107189281052;8783.73648790534;8888.422252553562;8890.288776897833;8897.77755556113;8906.59920303588;8840.425372350808;8855.601497932608;8862.06948270432;8870.86693699595;8882.555872206396;8904.51025193614;8937.329700272505;8962.82074358509;8966.730998070101;8966.910330896706;8870.068642792543;8913.465192088495;8917.063708310663;8931.660250962343;8949.194572488508;42145.36781948273;42520.78739606313;42521.36217956733;42579;42625;3565.5008298838184;3652.7625704329134;3694.538182727159;3696.981515092434;3702.9444558331647;31892.840535797404;32514.674853251403;32629.673703262903;32670;32775.18062048444;4002.939955900664;4081.3265811141127;4114.0948991221885;4118.402831589433;4266.274733295348;348457;350122;350967;351596;353327;59820.401795982354;60903.39096608977;61089.38910610926;61193.69403152956;61249.69375153185;63724;64122.35877641164;64184;64261.67869160718;64354.678226608565;15776.526704198892;15917.204139792964;15933.840661593467;15958.521244362688;15960.840391595935;12181.086418518647;12354.135210535356;12366.44351004207;12370.319632420304;12370.75258494825;15491.767623485657;17895.552611184565;18010.90994545045;18028.2788688451;18106.63786724258;5514.338279406497;5534.584906132056;5563.415841336601;5685.857853553612;5728.856778580485;1004.7889943111882;1042.5412818359898;1057.8624778778862;1064.7284942339654;1105.4804242006244;32837.89526309211;32955;33080.83459582735;33198.668013319555;33276;1117.1621284036971;1162.738518455723;1169.1757311095657;1187.8693343732182;1204.4399354300292;17069.829301707072;17311.65376692459;17325.2203650836;17336.51987697685;17355.04547249888;507140;507807;508332;508727;509745;59602.40397596055;59916;59997.70001149966;60163;60209.39790602126;1276.540445439641;1379.2689874366401;1390.9026368154132;1413.3074793351184;1428.6356978970505;32197.51703724399;34027.14932126716;34068.65931340754;34174.487382688785;34177.48733769045;51322.74338628283;51660;51702;51819.740901295256;51833.74083129711;384110;384814;385466;385863;386379;36931.81534092312;41335.1732965345;42041.57958420377;42488.15023699571;42919.57080429156;45912.54087459216;48207.1075735457;48910.5108948906;49524.75237623789;49891;39425.80287098546;41484.58515414807;44743.776281118386;44813.551864482244;45166;41267.38098928458;41387.379189311585;41415.355459692015;41574.37638435365;42641;41964.37053444262;42705.57294427016;42755.786221068694;43172.78413607912;43533.12933741371;35915.28169436649;37019;37438.43842342422;38144.80927595344;38151.42772858354;28150.155495335173;28664.570031449963;28828.855855720587;28992.42015159727;29216.7078329214 11:53:46 INFO - PROCESS | 30035 | |2;jquery.html;371.90247006881185;374.9287635349282;388.60362430321055;393.9822707978141;397.47731732771405;14724.55826325212;16451.177441127955;18289.26842926283;19202;19253.807461925375;17302.56743581411;18654.720179197324;19057.714134287995;19090.522736931547;19939.601207975833;5597.860053498654;5628.212050312959;5659.462351076661;5666.829995100154;5709.0580054290995;5361.544268737162;5442.265294185294;5445.128779395298;5456.672599644015;5607.887842243153;5250.973745131269;5396.325459317585;5398.568114550826;5427.43011983742;5441.809536666217;5467.617266791326;5536.529395001429;5544.556435485151;5555.694436805974;5563.054280772279;4805.447373552016;4811.302361157613;4840.564349208588;4850.2724591311235;4850.927236091461;12472;12831.679208019874;13052.738945221043;13059.34703264833;13061.934690326487;2266.3654176830514;2276.3739971507966;2297.9655305170436;2564.1666458401096;2608.882600282992;9960.252981026451;10111.848322275171;10132.088112069949;10905.400202988832;13144.539941102015;1829.0945981738992;1865.7108148237046;1902.1535416739557;1926.3257859749117;1982.33591746765;80818.59590702067;82035.17964820335;82754.17245827525;83956.58021709853;84833.57583212106;9996.600135994624;10149.847752283722;10584.200685883417;10623;11399.202055856176;14482.420703171754;14705.852941470448;14749.262536873113;14792.556223313319;14810.925945370203;7424.183339832614;7706.229377062249;7748.946529169774;7804.063512378438;7881.487703299267;7110.25342339047;7133.857322853514;7203.459740519377;7222.349988501061;7533.322001019935;4420.336949457607;4506.752128632957;4513.435820522434;4529.411176547028;4672;1878.2393130782054;1881.2380985700813;1887.6979683250613;1895.914683839203;1944.348643204514;895.1853813030111;984.9359791613522;1000.3247807729754;1019.8521214423866;1040.635777477892;18805.529861753294;19084.236630534622;19158.71261931072;19325.4202373929;19445.416637500897;988.6391467114595;995.2436148527172;1007.1539906478594;1018.9082982531608;1023.4626820918928;10654.946725266323;10850;10880.401577913133;10915.56337746497;10929.617463388744;462879;469174;470880;472475;472483;85284;85466;85705.57147214224;86428;87410.56294718485;993.0913214408735;1014.8832884218409;1047.858539097212;1070.7911957168433;1074.3392813419691;16867;16929.32282708678;17195;17330.39343622967;17611.119444028005;29668.703312966594;31453.8427307862;40642.59357406506;41355.7932210337;42836.78581607072;56275.030373936715;56947.14579281231;57449.42550574441;57513.42486575248;57940.420595795185;7414.406847452083;7671.117821450604;7794.493357931717;8116.797080073045;8620.13798620133;9559.044095590385;12856.742865142458;13446.663833404244;13775.104618199784;14064.312282526162;6721.462283017445;9389.29580281468;12175.878241217475;12350.3824808761;12515.87484125147;11871;12114.878851211375;12186.75626487483;12388.876111238773;12469.937650312053;12337.814932776195;12374.505019799108;12452.937735311265;12484.063695223076;12845.550405735754;7682.116556595839;7779.611019448892;7828.178041305581;8103.1491693371345;8914.153155450222;11739.11956603241;12226.327551984727;12287.631371058882;12309.75380492403;12338.568150114703 11:53:46 INFO - PROCESS | 30035 | |3;mootools.html;1339.4976883668623;1493.7385957457445;1539.7998260226173;1721.4577408116443;1844.8062953389895;8383.538905360203;8693.739187824367;8723.040465548784;8953.507557084358;8954.46273223607;8748.125187481248;8946.955265223682;8951.820963580742;8956.731298061053;8965.417247878884;2081.5628717969244;2348.4833336665906;2410.9879450602766;2437.4515733959893;2453.288546321565;2433.5862903306393;2437.8537287762792;2448.8163387745903;2451.1421002649017;2451.9264422067276;2304.608216603173;2404.326788499214;2409.9518009639796;2410.783029527342;2416.311351264881;2048.3240530624857;2332.1371092695726;2388.820838437124;2391.3423808452812;2429.781319681237;2296.712910886139;2331.5453486570127;2339.0409931927998;2339.941501462477;2360.0205914545445;8963.10368963105;9031;9041.593128309241;9046.547672616409;9057.68298109563;5293.206019097128;5397.298351214317;5400.027994960906;5405.675659460406;5409.134538473825;3272.6072871255365;3339.5658564386717;3387.7459190560808;3437.5874895012757;3466.2027733621408;1012.9290949633529;1052.9420881851495;1054.0144964458257;1060.3690803971624;1067.3915867955268;12342.876571234263;12561.623151305384;12570.560030398892;12604;12631.052671049709;4833.73414462208;4847.636427267969;4959.355283813081;4983.90032199354;4999.250112483084;10579.206559508068;10583;10605.734856628646;10609.946950265354;10618;4965.4041515018425;5524.309461317335;5527.861803454865;5560.860978475571;5584;4986.750662466862;5108.59131269505;5111.361079865017;5133.8716532087;5145.3568303962;4045.211183819127;4063.329550624173;4143.854965076208;4326.437563116775;4341.327094300388;1295.3976400973593;1301.1997621462733;1311.4298062163714;1317.426919290112;1329.2755448280711;930.2465003347176;1009.5507499162949;1012.3268026762267;1023.5240613114937;1028.136365453008;5965.224520812353;6111.480524155497;6152.16945712332;6264;6422.4862011039;418.236717989664;422.99365509517384;424.762133205406;426.49460389438616;426.86980470956655;4193.832246710097;4204.285271503852;4279.679024073207;4290.013296941721;4336.783160841946;10941.179411544166;11157.944210278896;11201.271917325348;11243;11251.043661288719;10996.890031099587;11078.169137314733;11090.445477726082;11095.611653592247;11096.833547496793;7722.382209423345;8107.067687215927;8108.716194933149;8321.08468068512;8482.321414286842;5992.910106348321;6019.699015049143;6023.5181185505935;6053.303870055;6154.076888466766;10206.744831379276;10357.482125893524;10408.115310198415;10412.739681507719;10416.427096509764;10375.636852710119;10379.948100259753;10533.841992369968;10576.947115264375;10635;7322.707091716272;7812;7926.326262267541;7971.561564114029;8056.395770317366;8874.600642970952;8891.555422228992;8892.110788921314;8948.910510894808;8958.731238062868;7757.069151701832;7937.960310198412;7976.7208147714555;8054.677812887418;8130.796730081795;7794.181610930771;7881.645325960231;7953.363730901629;7966.088138846751;7969.6015199240965;6968.79093627192;7022.964885175541;7097.787066388017;7101.715931362688;7102.751403700846;4889.87775305606;5012.573931215888;5032.446430892525;5066.31604733371;5165.767540460613;5280.788768449219;5320.866978325573;5321.414644389037;5397.78408863641;5458.044842152528 11:53:46 INFO - PROCESS | 30035 | |4;prototype.html;316.30255287091956;317.807726325573;320.46322409963307;320.6328753577154;321.0656988164442;5250.816221432251;5343.599230057742;5344.599155063376;5350.224217488462;5361.812336568216;5297.205419187124;5319.228711836791;5333.399980005993;5338.252644629755;5361.865953351168;3908.159745654684;4011.077452185999;4130.91738165238;4159.334506478964;4174.5578836380755;4108.753474791507;4115.094679170577;4120.670346372283;4120.752754834704;4136.710430269883;4096.467459230296;4106.158237561308;4111.602055301197;4120.402541631462;4138.8344466221315;3905.3556163233034;3939.3893946438347;4127.360259159835;4130.442390277304;4132.6775431861815;3562.5546806649168;3566.696830769362;3605.387084195693;3615.6745892869767;3630.146915474861;5097.286379906816;5137.691738495665;5146.922796158061;5229.764660590283;5230.450802665741;4413.90339588696;4606.654500912445;4629.3750343703505;4671.392718946549;4696.1546921554445;5402.513773760341;5421.159720243369;5445.591580631429;5448.591355648342;5481.835544933659;3864.265789499986;3866.6906647468136;3877.235857684747;3893.201893611803;3914.080191155076;5551.1673249012565;5720.885582288331;5775.220345253421;5779.682117483537;5780.248567686216;3968.146848427602;3974.6621537169663;3992.461017762565;3994.1612261425425;3997.900052498711;4005.3177665380026;4019.6181362771076;4024.557298697141;4032.879013629537;4040.9797951010055;4410.448693913261;4622.630189584893;4665.6967297125575;4728.148933191989;4729.668923175344;5545;5559.249501317351;5602.411746766612;5611.186377975171;5624.437556244343;1373.5192682561024;1385.43197289113;1395.8623721666809;1399.3842709207916;1402.1306789790394;838.6958279874854;844.5566077809076;882.3823323673454;897.6947837735202;901.5266984833015;5276.287701160371;5358.303420555303;5370.892582148335;5374.462553744673;5378.731063446812;5666.603337766399;5676.0918253080135;5708.1723150143;5746.9425305747245;5758.539316854642;5220.582353411718;5376.327959005124;5381.9461805382225;5391.703456309862;5474.671519708831;3004.72957433832;3013.984930075336;3049.557814116941;3058.464768665475;3061.7703672224225;5878.911816322759;5940.881182376328;5944.316403613553;5963.850903727354;5981.282246130492;5613.354464236665;5843;5865.970670146622;5873.618214816023;5882.499987501024;5937.95140676466;5946.851328716817;5957.702114894325;5965.940340596539;5993.820185394532;5606.215129881902;5661.188419705654;5750.274917524809;5818.2436283282905;5833.9416605835095;5618.943810561842;5624.381318054929;5648.802291919763;5662.320521537277;5665.603407761417;5852;5904.025835737055;5921.911171332347;5936.1986131871645;5979.684469416721;3584.8632446609217;3659.853605855736;3672.3573374658795;3672.4307732301536;3675.577308609544;5090.49095090488;5097.241451699158;5115.360579927509;5136.486351364833;5207.71357575337;4932.136876046749;5015.699058056528;5028.823991160292;5051.797928082836;5079.568236699922;5051.393832740095;5224.111900976919;5596.076647353141;5621.690807005654;5634.971825140848;5301.204819277139;5523.6685798852195;5523.861903452445;5540.307461567304;5554.333479982428;5519.530839878495;5578.30271216098;5591.4688104629995;5605.355384130714;5623.88752224945;5442.591805614516;5447;5483.890322193613;5487.149491828773;5494 11:53:46 INFO - PROCESS | 30035 | |5;yui.html;763.2100775697158;781.5818537082662;781.8670825959587;819.8073452738607;849.0533055642958;13929.512467063654;14655;14711.70576588469;14724.19016954067;14738.484153054646;11467.36929468879;12652.683682907931;12682.112252142353;12683.873161268384;12713.491460341575;793.4247670438943;817.3338728935928;819.4509678515379;819.713100414853;820.4789958376414;808.7169490678245;814.8859159717615;815.0748899998515;816.930560902324;817.1868990354606;687.4603436302503;858.5578427110044;860.178529504325;860.6987554355957;861.7070196133313;831.2311112221171;851.1063383447417;851.4848516647401;853.2235665544325;854.8589482735372;618.5670030978333;621.3475850357107;621.4903778901303;621.7046902721216;622.3776223776224;12977;13007.479700812051;13014.86985130146;13028.088033837636;13036.283004434752;11798.823017654742;11964.760704785856;12086.395680216043;12105;12356.443960021821;11529.135314851335;11587.884121158764;11825.704357391134;11934.820977685342;12521.879628382967;4384.079343337903;4394.912101757947;4405.515393306734;4446.688731788776;4585.79363928624;57700.134497982144;57939.71030144864;58134.41865581332;58907.41092589105;59674;10689.625863094754;10735.141188704885;10870.72823179411;10985.890141098487;11202.215844890943;19839.900800495907;20037.198512059353;20064.89967550153;20095.799042009687;20111.29610463656;7663.425243106789;7677.769666910001;7796.493227940279;7804.414668899855;7849.882251766228;4376.956230437655;4377.280873858612;4385.6052955233545;4423.955760442419;4460.799264033127;3380.560527131506;3473.044912648991;3473.2185258316676;3478.5999610044664;3484.7909125452047;530.4006472685841;627.8304857688398;656.7143292667705;661.7419206509466;679.3206793206793;658.134553062721;726.46604745512;752.7892190186757;765.5368502056288;799.9400044996532;9883.950580247052;10002.49987500622;10285.845712314322;10294.794104118026;10298.742531436774;652.709544252803;658.7693711927282;672.0758956434902;673.9528233023641;716.5772194405326;4729.976350118227;4831.710097394168;4834.154023046023;4852.927206091911;4896.436909755424;72817;74445.62777186079;75505;75804.62097689476;76149.61925190338;65153.34846651568;65291.34708652948;66235;66837.33162668408;66962.33037669561;56551.15173272404;59790.70104649536;60993;61161.08258376217;61341.38658613446;9099.272058235192;9242.676506322246;9253.167214950687;9411.764705882133;9463.148316651534;38679;39105.217895641355;39221.6077839218;39407.802960986155;40622.39066414065;52701.7364913173;53863;54247.76150742715;54583;55122.72438637781;11375.43122843871;11620.477078531656;11805.114616403633;11825.881741182478;12106.636800895987;12394.793453153838;12603.432845522157;13168.934155329162;13656.453741850215;13687.178769273876;11902.583409580624;11978.820317695066;12034.037277017642;12415.689607759878;13259.535916242885;12379.9381003098;12906.419211135333;13187.53843615469;13274.668133296358;13290.800637990631;12583.45715700842;12775.808362874379;12794.296313702836;13207.207567545978;13213.207207567577;9945.651902183388;10432.582696692047;10704.89295107039;10725.195610329101;10969.616063437741;10228.744281393025;10913.345199288067;10929.508172132431;10994.28537145083;11019.669409917715 11:53:46 INFO - PROCESS | 30035 | __end_tp_report 11:53:46 INFO - PROCESS | 30035 | __start_cc_report 11:53:46 INFO - PROCESS | 30035 | _x_x_mozilla_cycle_collect,895 11:53:46 INFO - PROCESS | 30035 | __end_cc_report 11:53:46 INFO - PROCESS | 30035 | __startTimestamp1464029626641__endTimestamp 11:53:46 INFO - PROCESS | 30035 | 11:53:46 INFO - PROCESS | 30035 | ------- Summary: start ------- 11:53:46 INFO - PROCESS | 30035 | Number of tests: 6 11:53:46 INFO - PROCESS | 30035 | 11:53:46 INFO - PROCESS | 30035 | [#0] dojo.html Cycles:165 Average:5385.58 Median:5592.22 stddev:617.25 (11.0%) stddev-sans-first:592.87 11:53:46 INFO - PROCESS | 30035 | Values: 3114.3 3139.3 3159.3 3166.2 3196.8 5321.6 5322.4 5372.4 5442.5 5446.7 5329.6 5393.7 5404.7 5406.1 5409.9 4843.3 4930.7 4953.3 4978.4 5060.4 4939.9 4985.6 5016.3 5024.7 5039.0 4751.3 4796.0 4828.1 4848.0 4861.7 4838.1 4853.6 4867.8 4870.4 4904.5 4753.0 4839.2 4842.9 4877.7 4931.4 5236.2 5284.0 5293.7 5392.0 5402.9 5733.3 5781.6 5782.6 5786.4 5787.7 5672.4 5743.3 5775.9 5826.6 5829.8 5372.6 5496.4 5496.6 5497.4 5499.3 6008.9 6022.1 6024.4 6029.8 6034.8 5485.4 5564.4 5599.8 5781.0 5797.2 5739.2 5756.8 5782.3 5802.4 5813.6 5674.6 5704.1 5707.2 5732.9 5735.3 5513.6 5734.4 5736.2 5788.6 5796.3 4433.2 4434.3 4437.8 4441.2 4473.0 3953.5 3965.3 3971.7 3998.2 4026.2 5328.3 5385.1 5488.8 5556.8 5559.4 5911.2 5924.8 5930.6 5941.2 6002.8 5583.2 5589.6 5592.2 5597.9 5598.0 4882.6 4946.2 4990.3 5003.7 5031.3 6043.8 6052.7 6053.0 6059.8 6060.7 5730.9 5863.4 5873.1 5876.2 5878.0 5880.0 5901.7 5939.9 5973.7 5981.9 5659.9 5688.9 5692.4 5693.3 5706.7 5667.9 5682.9 5735.2 5806.5 5819.0 5674.2 5775.4 5780.1 5782.5 5811.4 5757.5 5762.5 5766.1 5766.2 5772.4 5411.4 5498.6 5540.7 5677.3 5681.3 5729.7 5760.1 5765.9 5774.0 5774.8 5580.4 5586.4 5590.0 5591.1 5593.3 11:53:46 INFO - PROCESS | 30035 | 11:53:46 INFO - PROCESS | 30035 | [#1] ext.html Cycles:180 Average:58790.80 Median:42002.98 stddev:111067.58 (264.4%) stddev-sans-first:111293.22 11:53:46 INFO - PROCESS | 30035 | Values: 599.7 641.1 642.8 645.5 653.4 32367.2 35125.1 35257.3 45266.3 46482.5 45625.3 46184.8 46235.5 46277.5 46300.3 8710.9 8916.7 8925.6 8926.2 8928.1 8783.7 8888.4 8890.3 8897.8 8906.6 8840.4 8855.6 8862.1 8870.9 8882.6 8904.5 8937.3 8962.8 8966.7 8966.9 8870.1 8913.5 8917.1 8931.7 8949.2 42145.4 42520.8 42521.4 42579.0 42625.0 3565.5 3652.8 3694.5 3697.0 3702.9 31892.8 32514.7 32629.7 32670.0 32775.2 4002.9 4081.3 4114.1 4118.4 4266.3 348457.0 350122.0 350967.0 351596.0 353327.0 59820.4 60903.4 61089.4 61193.7 61249.7 63724.0 64122.4 64184.0 64261.7 64354.7 15776.5 15917.2 15933.8 15958.5 15960.8 12181.1 12354.1 12366.4 12370.3 12370.8 15491.8 17895.6 18010.9 18028.3 18106.6 5514.3 5534.6 5563.4 5685.9 5728.9 1004.8 1042.5 1057.9 1064.7 1105.5 32837.9 32955.0 33080.8 33198.7 33276.0 1117.2 1162.7 1169.2 1187.9 1204.4 17069.8 17311.7 17325.2 17336.5 17355.0 507140.0 507807.0 508332.0 508727.0 509745.0 59602.4 59916.0 59997.7 60163.0 60209.4 1276.5 1379.3 1390.9 1413.3 1428.6 32197.5 34027.1 34068.7 34174.5 34177.5 51322.7 51660.0 51702.0 51819.7 51833.7 384110.0 384814.0 385466.0 385863.0 386379.0 36931.8 41335.2 42041.6 42488.2 42919.6 45912.5 48207.1 48910.5 49524.8 49891.0 39425.8 41484.6 44743.8 44813.6 45166.0 41267.4 41387.4 41415.4 41574.4 42641.0 41964.4 42705.6 42755.8 43172.8 43533.1 35915.3 37019.0 37438.4 38144.8 38151.4 28150.2 28664.6 28828.9 28992.4 29216.7 11:53:46 INFO - PROCESS | 30035 | 11:53:46 INFO - PROCESS | 30035 | [#2] jquery.html Cycles:180 Average:27714.90 Median:30561.27 stddev:77504.63 (253.6%) stddev-sans-first:77694.86 11:53:46 INFO - PROCESS | 30035 | Values: 371.9 374.9 388.6 394.0 397.5 14724.6 16451.2 18289.3 19202.0 19253.8 17302.6 18654.7 19057.7 19090.5 19939.6 5597.9 5628.2 5659.5 5666.8 5709.1 5361.5 5442.3 5445.1 5456.7 5607.9 5251.0 5396.3 5398.6 5427.4 5441.8 5467.6 5536.5 5544.6 5555.7 5563.1 4805.4 4811.3 4840.6 4850.3 4850.9 12472.0 12831.7 13052.7 13059.3 13061.9 2266.4 2276.4 2298.0 2564.2 2608.9 9960.3 10111.8 10132.1 10905.4 13144.5 1829.1 1865.7 1902.2 1926.3 1982.3 80818.6 82035.2 82754.2 83956.6 84833.6 9996.6 10149.8 10584.2 10623.0 11399.2 14482.4 14705.9 14749.3 14792.6 14810.9 7424.2 7706.2 7748.9 7804.1 7881.5 7110.3 7133.9 7203.5 7222.3 7533.3 4420.3 4506.8 4513.4 4529.4 4672.0 1878.2 1881.2 1887.7 1895.9 1944.3 895.2 984.9 1000.3 1019.9 1040.6 18805.5 19084.2 19158.7 19325.4 19445.4 988.6 995.2 1007.2 1018.9 1023.5 10654.9 10850.0 10880.4 10915.6 10929.6 462879.0 469174.0 470880.0 472475.0 472483.0 85284.0 85466.0 85705.6 86428.0 87410.6 993.1 1014.9 1047.9 1070.8 1074.3 16867.0 16929.3 17195.0 17330.4 17611.1 29668.7 31453.8 40642.6 41355.8 42836.8 56275.0 56947.1 57449.4 57513.4 57940.4 7414.4 7671.1 7794.5 8116.8 8620.1 9559.0 12856.7 13446.7 13775.1 14064.3 6721.5 9389.3 12175.9 12350.4 12515.9 11871.0 12114.9 12186.8 12388.9 12469.9 12337.8 12374.5 12452.9 12484.1 12845.6 7682.1 7779.6 7828.2 8103.1 8914.2 11739.1 12226.3 12287.6 12309.8 12338.6 11:53:46 INFO - PROCESS | 30035 | 11:53:46 INFO - PROCESS | 30035 | [#3] mootools.html Cycles:180 Average:5922.92 Median:4308.23 stddev:3389.75 (78.7%) stddev-sans-first:3381.76 11:53:46 INFO - PROCESS | 30035 | Values: 1339.5 1493.7 1539.8 1721.5 1844.8 8383.5 8693.7 8723.0 8953.5 8954.5 8748.1 8947.0 8951.8 8956.7 8965.4 2081.6 2348.5 2411.0 2437.5 2453.3 2433.6 2437.9 2448.8 2451.1 2451.9 2304.6 2404.3 2410.0 2410.8 2416.3 2048.3 2332.1 2388.8 2391.3 2429.8 2296.7 2331.5 2339.0 2339.9 2360.0 8963.1 9031.0 9041.6 9046.5 9057.7 5293.2 5397.3 5400.0 5405.7 5409.1 3272.6 3339.6 3387.7 3437.6 3466.2 1012.9 1052.9 1054.0 1060.4 1067.4 12342.9 12561.6 12570.6 12604.0 12631.1 4833.7 4847.6 4959.4 4983.9 4999.3 10579.2 10583.0 10605.7 10609.9 10618.0 4965.4 5524.3 5527.9 5560.9 5584.0 4986.8 5108.6 5111.4 5133.9 5145.4 4045.2 4063.3 4143.9 4326.4 4341.3 1295.4 1301.2 1311.4 1317.4 1329.3 930.2 1009.6 1012.3 1023.5 1028.1 5965.2 6111.5 6152.2 6264.0 6422.5 418.2 423.0 424.8 426.5 426.9 4193.8 4204.3 4279.7 4290.0 4336.8 10941.2 11157.9 11201.3 11243.0 11251.0 10996.9 11078.2 11090.4 11095.6 11096.8 7722.4 8107.1 8108.7 8321.1 8482.3 5992.9 6019.7 6023.5 6053.3 6154.1 10206.7 10357.5 10408.1 10412.7 10416.4 10375.6 10379.9 10533.8 10576.9 10635.0 7322.7 7812.0 7926.3 7971.6 8056.4 8874.6 8891.6 8892.1 8948.9 8958.7 7757.1 7938.0 7976.7 8054.7 8130.8 7794.2 7881.6 7953.4 7966.1 7969.6 6968.8 7023.0 7097.8 7101.7 7102.8 4889.9 5012.6 5032.4 5066.3 5165.8 5280.8 5320.9 5321.4 5397.8 5458.0 11:53:46 INFO - PROCESS | 30035 | 11:53:46 INFO - PROCESS | 30035 | [#4] prototype.html Cycles:180 Average:4625.07 Median:5299.21 stddev:1387.21 (26.2%) stddev-sans-first:1352.88 11:53:46 INFO - PROCESS | 30035 | Values: 316.3 317.8 320.5 320.6 321.1 5250.8 5343.6 5344.6 5350.2 5361.8 5297.2 5319.2 5333.4 5338.3 5361.9 3908.2 4011.1 4130.9 4159.3 4174.6 4108.8 4115.1 4120.7 4120.8 4136.7 4096.5 4106.2 4111.6 4120.4 4138.8 3905.4 3939.4 4127.4 4130.4 4132.7 3562.6 3566.7 3605.4 3615.7 3630.1 5097.3 5137.7 5146.9 5229.8 5230.5 4413.9 4606.7 4629.4 4671.4 4696.2 5402.5 5421.2 5445.6 5448.6 5481.8 3864.3 3866.7 3877.2 3893.2 3914.1 5551.2 5720.9 5775.2 5779.7 5780.2 3968.1 3974.7 3992.5 3994.2 3997.9 4005.3 4019.6 4024.6 4032.9 4041.0 4410.4 4622.6 4665.7 4728.1 4729.7 5545.0 5559.2 5602.4 5611.2 5624.4 1373.5 1385.4 1395.9 1399.4 1402.1 838.7 844.6 882.4 897.7 901.5 5276.3 5358.3 5370.9 5374.5 5378.7 5666.6 5676.1 5708.2 5746.9 5758.5 5220.6 5376.3 5381.9 5391.7 5474.7 3004.7 3014.0 3049.6 3058.5 3061.8 5878.9 5940.9 5944.3 5963.9 5981.3 5613.4 5843.0 5866.0 5873.6 5882.5 5938.0 5946.9 5957.7 5965.9 5993.8 5606.2 5661.2 5750.3 5818.2 5833.9 5618.9 5624.4 5648.8 5662.3 5665.6 5852.0 5904.0 5921.9 5936.2 5979.7 3584.9 3659.9 3672.4 3672.4 3675.6 5090.5 5097.2 5115.4 5136.5 5207.7 4932.1 5015.7 5028.8 5051.8 5079.6 5051.4 5224.1 5596.1 5621.7 5635.0 5301.2 5523.7 5523.9 5540.3 5554.3 5519.5 5578.3 5591.5 5605.4 5623.9 5442.6 5447.0 5483.9 5487.1 5494.0 11:53:46 INFO - PROCESS | 30035 | 11:53:46 INFO - PROCESS | 30035 | [#5] yui.html Cycles:180 Average:16206.55 Median:4453.74 stddev:20284.88 (455.5%) stddev-sans-first:20308.63 11:53:46 INFO - PROCESS | 30035 | Values: 763.2 781.6 781.9 819.8 849.1 13929.5 14655.0 14711.7 14724.2 14738.5 11467.4 12652.7 12682.1 12683.9 12713.5 793.4 817.3 819.5 819.7 820.5 808.7 814.9 815.1 816.9 817.2 687.5 858.6 860.2 860.7 861.7 831.2 851.1 851.5 853.2 854.9 618.6 621.3 621.5 621.7 622.4 12977.0 13007.5 13014.9 13028.1 13036.3 11798.8 11964.8 12086.4 12105.0 12356.4 11529.1 11587.9 11825.7 11934.8 12521.9 4384.1 4394.9 4405.5 4446.7 4585.8 57700.1 57939.7 58134.4 58907.4 59674.0 10689.6 10735.1 10870.7 10985.9 11202.2 19839.9 20037.2 20064.9 20095.8 20111.3 7663.4 7677.8 7796.5 7804.4 7849.9 4377.0 4377.3 4385.6 4424.0 4460.8 3380.6 3473.0 3473.2 3478.6 3484.8 530.4 627.8 656.7 661.7 679.3 658.1 726.5 752.8 765.5 799.9 9884.0 10002.5 10285.8 10294.8 10298.7 652.7 658.8 672.1 674.0 716.6 4730.0 4831.7 4834.2 4852.9 4896.4 72817.0 74445.6 75505.0 75804.6 76149.6 65153.3 65291.3 66235.0 66837.3 66962.3 56551.2 59790.7 60993.0 61161.1 61341.4 9099.3 9242.7 9253.2 9411.8 9463.1 38679.0 39105.2 39221.6 39407.8 40622.4 52701.7 53863.0 54247.8 54583.0 55122.7 11375.4 11620.5 11805.1 11825.9 12106.6 12394.8 12603.4 13168.9 13656.5 13687.2 11902.6 11978.8 12034.0 12415.7 13259.5 12379.9 12906.4 13187.5 13274.7 13290.8 12583.5 12775.8 12794.3 13207.2 13213.2 9945.7 10432.6 10704.9 10725.2 10969.6 10228.7 10913.3 10929.5 10994.3 11019.7 11:53:46 INFO - PROCESS | 30035 | -------- Summary: end -------- 11:53:46 INFO - PROCESS | 30035 | 11:53:47 INFO - TEST-INFO | 30035: exit 0 11:53:47 INFO - TEST-OK | dromaeo_css | took 1112428ms 11:53:47 INFO - TEST-START | kraken 11:53:47 INFO - operating with platform_type : linux_ 11:53:47 INFO - Initialising browser for kraken test... 11:53:47 INFO - TEST-INFO | started process 30220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL0ASYY/profile http://localhost:56070/getInfo.html) 11:53:51 INFO - PROCESS | 30220 | __metrics Screen width/height:1600/1200 11:53:51 INFO - PROCESS | 30220 | colorDepth:24 11:53:51 INFO - PROCESS | 30220 | Browser inner width/height: 1024/697 11:53:51 INFO - PROCESS | 30220 | __metrics 11:53:52 ERROR - PROCESS | 30220 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:53:53 INFO - TEST-INFO | 30220: exit 0 11:53:53 INFO - Browser initialized. 11:53:53 INFO - Running cycle 1/1 for kraken test... 11:53:53 INFO - TEST-INFO | started process 30302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL0ASYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:04 INFO - PROCESS | 30302 | RSS: Main: 152682496 11:54:04 INFO - PROCESS | 30302 | 11:54:07 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56070/tests/kraken/driver.html?testName=audio-beat-detection) 11:54:08 INFO - PROCESS | 30302 | RSS: Main: 209797120 11:54:08 INFO - PROCESS | 30302 | 11:54:11 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56070/tests/kraken/driver.html?testName=audio-dft) 11:54:11 INFO - PROCESS | 30302 | RSS: Main: 196980736 11:54:11 INFO - PROCESS | 30302 | 11:54:14 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56070/tests/kraken/driver.html?testName=audio-fft) 11:54:15 INFO - PROCESS | 30302 | RSS: Main: 265756672 11:54:15 INFO - PROCESS | 30302 | 11:54:17 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56070/tests/kraken/driver.html?testName=audio-oscillator) 11:54:18 INFO - PROCESS | 30302 | RSS: Main: 174309376 11:54:18 INFO - PROCESS | 30302 | 11:54:20 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:54:21 INFO - PROCESS | 30302 | RSS: Main: 178819072 11:54:21 INFO - PROCESS | 30302 | 11:54:24 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56070/tests/kraken/driver.html?testName=imaging-darkroom) 11:54:25 INFO - PROCESS | 30302 | RSS: Main: 215089152 11:54:25 INFO - PROCESS | 30302 | 11:54:28 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56070/tests/kraken/driver.html?testName=imaging-desaturate) 11:54:29 INFO - PROCESS | 30302 | RSS: Main: 213807104 11:54:29 INFO - PROCESS | 30302 | 11:54:32 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56070/tests/kraken/driver.html?testName=json-parse-financial) 11:54:32 INFO - PROCESS | 30302 | RSS: Main: 214585344 11:54:32 INFO - PROCESS | 30302 | 11:54:34 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:54:35 INFO - PROCESS | 30302 | RSS: Main: 201924608 11:54:35 INFO - PROCESS | 30302 | 11:54:36 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56070/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:54:37 INFO - PROCESS | 30302 | RSS: Main: 205287424 11:54:37 INFO - PROCESS | 30302 | 11:54:39 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:54:40 INFO - PROCESS | 30302 | RSS: Main: 216551424 11:54:40 INFO - PROCESS | 30302 | 11:54:42 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:54:43 INFO - PROCESS | 30302 | RSS: Main: 224382976 11:54:43 INFO - PROCESS | 30302 | 11:54:46 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:54:46 INFO - PROCESS | 30302 | RSS: Main: 222011392 11:54:46 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | Cycle 1(1): loaded http://localhost:56070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56070/tests/kraken/driver.html?testName=ai-astar) 11:54:48 INFO - PROCESS | 30302 | RSS: Main: 267984896 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | __start_tp_report 11:54:48 INFO - PROCESS | 30302 | _x_x_mozilla_page_load 11:54:48 INFO - PROCESS | 30302 | _x_x_mozilla_page_load_details 11:54:48 INFO - PROCESS | 30302 | |i|pagename|runs| 11:54:48 INFO - PROCESS | 30302 | |0;ai-astar;109;104;108;108;108;109;110;108;108;108 11:54:48 INFO - PROCESS | 30302 | |1;audio-beat-detection;153;126;133;203;126;127;159;131;174;126 11:54:48 INFO - PROCESS | 30302 | |2;audio-dft;161;162;162;162;160;161;162;163;165;160 11:54:48 INFO - PROCESS | 30302 | |3;audio-fft;74;76;75;148;76;76;75;75;119;75 11:54:48 INFO - PROCESS | 30302 | |4;audio-oscillator;94;93;165;94;93;92;125;92;93;125 11:54:48 INFO - PROCESS | 30302 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;116;116;117 11:54:48 INFO - PROCESS | 30302 | |6;imaging-darkroom;146;145;144;145;146;146;146;146;145;145 11:54:48 INFO - PROCESS | 30302 | |7;imaging-desaturate;94;95;94;95;95;95;95;95;95;94 11:54:48 INFO - PROCESS | 30302 | |8;json-parse-financial;55;57;56;56;57;56;55;108;54;54 11:54:48 INFO - PROCESS | 30302 | |9;json-stringify-tinderbox;60;61;61;61;62;60;62;61;62;62 11:54:48 INFO - PROCESS | 30302 | |10;stanford-crypto-aes;85;79;79;84;79;79;86;79;79;79 11:54:48 INFO - PROCESS | 30302 | |11;stanford-crypto-ccm;123;124;136;133;117;127;124;119;188;129 11:54:48 INFO - PROCESS | 30302 | |12;stanford-crypto-pbkdf2;157;158;160;159;159;161;163;159;161;162 11:54:48 INFO - PROCESS | 30302 | |13;stanford-crypto-sha256-iterative;62;61;64;63;62;64;61;68;61;61 11:54:48 INFO - PROCESS | 30302 | __end_tp_report 11:54:48 INFO - PROCESS | 30302 | __start_cc_report 11:54:48 INFO - PROCESS | 30302 | _x_x_mozilla_cycle_collect,1905 11:54:48 INFO - PROCESS | 30302 | __end_cc_report 11:54:48 INFO - PROCESS | 30302 | __startTimestamp1464029688878__endTimestamp 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | ------- Summary: start ------- 11:54:48 INFO - PROCESS | 30302 | Number of tests: 14 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.00 stddev:1.56 (1.4%) stddev-sans-first:1.62 11:54:48 INFO - PROCESS | 30302 | Values: 109.0 104.0 108.0 108.0 108.0 109.0 110.0 108.0 108.0 108.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:143.00 stddev:26.26 (18.4%) stddev-sans-first:27.72 11:54:48 INFO - PROCESS | 30302 | Values: 153.0 126.0 133.0 203.0 126.0 127.0 159.0 131.0 174.0 126.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.54 11:54:48 INFO - PROCESS | 30302 | Values: 161.0 162.0 162.0 162.0 160.0 161.0 162.0 163.0 165.0 160.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#3] audio-fft Cycles:10 Average:86.90 Median:75.00 stddev:25.50 (34.0%) stddev-sans-first:26.62 11:54:48 INFO - PROCESS | 30302 | Values: 74.0 76.0 75.0 148.0 76.0 76.0 75.0 75.0 119.0 75.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:24.46 (26.3%) stddev-sans-first:25.52 11:54:48 INFO - PROCESS | 30302 | Values: 94.0 93.0 165.0 94.0 93.0 92.0 125.0 92.0 93.0 125.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:54:48 INFO - PROCESS | 30302 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:54:48 INFO - PROCESS | 30302 | Values: 146.0 145.0 144.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:54:48 INFO - PROCESS | 30302 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:56.00 stddev:16.62 (29.7%) stddev-sans-first:17.49 11:54:48 INFO - PROCESS | 30302 | Values: 55.0 57.0 56.0 56.0 57.0 56.0 55.0 108.0 54.0 54.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 11:54:48 INFO - PROCESS | 30302 | Values: 60.0 61.0 61.0 61.0 62.0 60.0 62.0 61.0 62.0 62.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:79.00 stddev:2.94 (3.7%) stddev-sans-first:2.69 11:54:48 INFO - PROCESS | 30302 | Values: 85.0 79.0 79.0 84.0 79.0 79.0 86.0 79.0 79.0 79.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:128.00 stddev:20.52 (16.0%) stddev-sans-first:21.51 11:54:48 INFO - PROCESS | 30302 | Values: 123.0 124.0 136.0 133.0 117.0 127.0 124.0 119.0 188.0 129.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.50 stddev:1.85 (1.2%) stddev-sans-first:1.64 11:54:48 INFO - PROCESS | 30302 | Values: 157.0 158.0 160.0 159.0 159.0 161.0 163.0 159.0 161.0 162.0 11:54:48 INFO - PROCESS | 30302 | 11:54:48 INFO - PROCESS | 30302 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:2.21 (3.5%) stddev-sans-first:2.33 11:54:48 INFO - PROCESS | 30302 | Values: 62.0 61.0 64.0 63.0 62.0 64.0 61.0 68.0 61.0 61.0 11:54:48 INFO - PROCESS | 30302 | -------- Summary: end -------- 11:54:48 INFO - PROCESS | 30302 | 11:54:49 INFO - TEST-INFO | 30302: exit 0 11:54:49 INFO - TEST-OK | kraken | took 62509ms 11:54:49 INFO - SUITE-END | took 1174s 11:54:50 INFO - Completed test suite (00:19:35) 11:54:50 INFO - javascript benchmark 11:54:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.3459873426577, 3139.26227336576, 3159.2733671255605, 3166.160967343653, 3196.824174670394, 5321.627486075976, 5322.4411436799155, 5372.435894231108, 5442.537384322332, 5446.673199608022, 5329.626926115174, 5393.73031348433, 5404.702741349224, 5406.135018397057, 5409.864753381157, 4843.273508973656, 4930.654854160211, 4953.306537084811, 4978.352814134158, 5060.418051924021, 4939.925901111486, 4985.551300382965, 5016.3227964224725, 5024.723640199788, 5039.0, 4751.3348131261655, 4795.952040479586, 4828.0585285869265, 4848.0, 4861.73260470674, 4838.129136755382, 4853.563179313844, 4867.756612169413, 4870.415550133971, 4904.4605093439695, 4753.0, 4839.249916262985, 4842.903141937141, 4877.731724755173, 4931.3835770528685, 5236.162214045735, 5284.022455845681, 5293.7353132343615, 5392.0294347017525, 5402.945970540283, 5733.312002559678, 5781.595288329819, 5782.56630752691, 5786.363500014995, 5787.71061446926, 5672.40439753824, 5743.339515955635, 5775.913361299584, 5826.592138550303, 5829.795957141479, 5372.623916325859, 5496.395396506381, 5496.560275178016, 5497.422770609109, 5499.340079190482, 6008.939910600838, 6022.066579680157, 6024.367441418675, 6029.758809647565, 6034.818955431344, 5485.369182543979, 5564.387917329091, 5599.80400685974, 5780.971095144581, 5797.217375654317, 5739.16782066598, 5756.769729210869, 5782.335031471434, 5802.361740208574, 5813.6221145625395, 5674.602777805597, 5704.11586204139, 5707.229524014288, 5732.942670573241, 5735.340435849847, 5513.641613295123, 5734.369219385864, 5736.168255602997, 5788.594798364074, 5796.275465566804, 4433.1577000369825, 4434.290513517822, 4437.755923424178, 4441.244988351988, 4473.0, 3953.545342285674, 3965.325894597925, 3971.6822654187595, 3998.2203470323007, 4026.2350153470748, 5328.307320048369, 5385.138377859524, 5488.780448782084, 5556.77772889088, 5559.360673522516, 5911.231539899785, 5924.822255332347, 5930.584859059824, 5941.197938278364, 6002.759889604455, 5583.218349431083, 5589.636673616202, 5592.217089607459, 5597.860053498695, 5597.972010139923, 4882.609391248691, 4946.233333833262, 4990.30135780991, 5003.699778013258, 5031.320771695774, 6043.758249670052, 6052.697365131726, 6053.001254792998, 6059.818205453844, 6060.666663333559, 5730.942690573041, 5863.355030946593, 5873.089671100986, 5876.1773351731645, 5878.0, 5880.0, 5901.675407852609, 5939.910901336397, 5973.701314934149, 5981.910271345846, 5659.943400565941, 5688.914666279927, 5692.373838877803, 5693.345265294379, 5706.714664266853, 5667.914981275202, 5682.886342273214, 5735.197072409949, 5806.535477161732, 5818.981678206382, 5674.177244299471, 5775.364709881994, 5780.132980052857, 5782.508486778671, 5811.418858114154, 5757.481826635623, 5762.481376676119, 5766.135079738073, 5766.192733017465, 5772.365039845529, 5411.404745478073, 5498.642588231752, 5540.667559946416, 5677.318721753416, 5681.346645135863, 5729.656220626775, 5760.078387458154, 5765.91351129725, 5774.0184168690585, 5774.797882074107, 5580.414056524007, 5586.441355864381, 5589.972050139723, 5591.077472217039, 5593.272874526286], "value": 5343.868948169221, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.67018140023, 641.1152609399029, 642.8039447968374, 645.4836131095124, 653.3694984340111, 32367.190820229505, 35125.12187195321, 35257.2948541029, 45266.321005184946, 46482.53517464824, 45625.31562026572, 46184.769076154655, 46235.537644623546, 46277.53722462774, 46300.3054954176, 8710.912890871105, 8916.687915922912, 8925.642974281021, 8926.2412694921, 8928.107189281052, 8783.73648790534, 8888.422252553562, 8890.288776897833, 8897.77755556113, 8906.59920303588, 8840.425372350808, 8855.601497932608, 8862.06948270432, 8870.86693699595, 8882.555872206396, 8904.51025193614, 8937.329700272505, 8962.82074358509, 8966.730998070101, 8966.910330896706, 8870.068642792543, 8913.465192088495, 8917.063708310663, 8931.660250962343, 8949.194572488508, 42145.36781948273, 42520.78739606313, 42521.36217956733, 42579.0, 42625.0, 3565.5008298838184, 3652.7625704329134, 3694.538182727159, 3696.981515092434, 3702.9444558331647, 31892.840535797404, 32514.674853251403, 32629.673703262903, 32670.0, 32775.18062048444, 4002.939955900664, 4081.3265811141127, 4114.0948991221885, 4118.402831589433, 4266.274733295348, 348457.0, 350122.0, 350967.0, 351596.0, 353327.0, 59820.401795982354, 60903.39096608977, 61089.38910610926, 61193.69403152956, 61249.69375153185, 63724.0, 64122.35877641164, 64184.0, 64261.67869160718, 64354.678226608565, 15776.526704198892, 15917.204139792964, 15933.840661593467, 15958.521244362688, 15960.840391595935, 12181.086418518647, 12354.135210535356, 12366.44351004207, 12370.319632420304, 12370.75258494825, 15491.767623485657, 17895.552611184565, 18010.90994545045, 18028.2788688451, 18106.63786724258, 5514.338279406497, 5534.584906132056, 5563.415841336601, 5685.857853553612, 5728.856778580485, 1004.7889943111882, 1042.5412818359898, 1057.8624778778862, 1064.7284942339654, 1105.4804242006244, 32837.89526309211, 32955.0, 33080.83459582735, 33198.668013319555, 33276.0, 1117.1621284036971, 1162.738518455723, 1169.1757311095657, 1187.8693343732182, 1204.4399354300292, 17069.829301707072, 17311.65376692459, 17325.2203650836, 17336.51987697685, 17355.04547249888, 507140.0, 507807.0, 508332.0, 508727.0, 509745.0, 59602.40397596055, 59916.0, 59997.70001149966, 60163.0, 60209.39790602126, 1276.540445439641, 1379.2689874366401, 1390.9026368154132, 1413.3074793351184, 1428.6356978970505, 32197.51703724399, 34027.14932126716, 34068.65931340754, 34174.487382688785, 34177.48733769045, 51322.74338628283, 51660.0, 51702.0, 51819.740901295256, 51833.74083129711, 384110.0, 384814.0, 385466.0, 385863.0, 386379.0, 36931.81534092312, 41335.1732965345, 42041.57958420377, 42488.15023699571, 42919.57080429156, 45912.54087459216, 48207.1075735457, 48910.5108948906, 49524.75237623789, 49891.0, 39425.80287098546, 41484.58515414807, 44743.776281118386, 44813.551864482244, 45166.0, 41267.38098928458, 41387.379189311585, 41415.355459692015, 41574.37638435365, 42641.0, 41964.37053444262, 42705.57294427016, 42755.786221068694, 43172.78413607912, 43533.12933741371, 35915.28169436649, 37019.0, 37438.43842342422, 38144.80927595344, 38151.42772858354, 28150.155495335173, 28664.570031449963, 28828.855855720587, 28992.42015159727, 29216.7078329214], "value": 20287.260387982824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.90247006881185, 374.9287635349282, 388.60362430321055, 393.9822707978141, 397.47731732771405, 14724.55826325212, 16451.177441127955, 18289.26842926283, 19202.0, 19253.807461925375, 17302.56743581411, 18654.720179197324, 19057.714134287995, 19090.522736931547, 19939.601207975833, 5597.860053498654, 5628.212050312959, 5659.462351076661, 5666.829995100154, 5709.0580054290995, 5361.544268737162, 5442.265294185294, 5445.128779395298, 5456.672599644015, 5607.887842243153, 5250.973745131269, 5396.325459317585, 5398.568114550826, 5427.43011983742, 5441.809536666217, 5467.617266791326, 5536.529395001429, 5544.556435485151, 5555.694436805974, 5563.054280772279, 4805.447373552016, 4811.302361157613, 4840.564349208588, 4850.2724591311235, 4850.927236091461, 12472.0, 12831.679208019874, 13052.738945221043, 13059.34703264833, 13061.934690326487, 2266.3654176830514, 2276.3739971507966, 2297.9655305170436, 2564.1666458401096, 2608.882600282992, 9960.252981026451, 10111.848322275171, 10132.088112069949, 10905.400202988832, 13144.539941102015, 1829.0945981738992, 1865.7108148237046, 1902.1535416739557, 1926.3257859749117, 1982.33591746765, 80818.59590702067, 82035.17964820335, 82754.17245827525, 83956.58021709853, 84833.57583212106, 9996.600135994624, 10149.847752283722, 10584.200685883417, 10623.0, 11399.202055856176, 14482.420703171754, 14705.852941470448, 14749.262536873113, 14792.556223313319, 14810.925945370203, 7424.183339832614, 7706.229377062249, 7748.946529169774, 7804.063512378438, 7881.487703299267, 7110.25342339047, 7133.857322853514, 7203.459740519377, 7222.349988501061, 7533.322001019935, 4420.336949457607, 4506.752128632957, 4513.435820522434, 4529.411176547028, 4672.0, 1878.2393130782054, 1881.2380985700813, 1887.6979683250613, 1895.914683839203, 1944.348643204514, 895.1853813030111, 984.9359791613522, 1000.3247807729754, 1019.8521214423866, 1040.635777477892, 18805.529861753294, 19084.236630534622, 19158.71261931072, 19325.4202373929, 19445.416637500897, 988.6391467114595, 995.2436148527172, 1007.1539906478594, 1018.9082982531608, 1023.4626820918928, 10654.946725266323, 10850.0, 10880.401577913133, 10915.56337746497, 10929.617463388744, 462879.0, 469174.0, 470880.0, 472475.0, 472483.0, 85284.0, 85466.0, 85705.57147214224, 86428.0, 87410.56294718485, 993.0913214408735, 1014.8832884218409, 1047.858539097212, 1070.7911957168433, 1074.3392813419691, 16867.0, 16929.32282708678, 17195.0, 17330.39343622967, 17611.119444028005, 29668.703312966594, 31453.8427307862, 40642.59357406506, 41355.7932210337, 42836.78581607072, 56275.030373936715, 56947.14579281231, 57449.42550574441, 57513.42486575248, 57940.420595795185, 7414.406847452083, 7671.117821450604, 7794.493357931717, 8116.797080073045, 8620.13798620133, 9559.044095590385, 12856.742865142458, 13446.663833404244, 13775.104618199784, 14064.312282526162, 6721.462283017445, 9389.29580281468, 12175.878241217475, 12350.3824808761, 12515.87484125147, 11871.0, 12114.878851211375, 12186.75626487483, 12388.876111238773, 12469.937650312053, 12337.814932776195, 12374.505019799108, 12452.937735311265, 12484.063695223076, 12845.550405735754, 7682.116556595839, 7779.611019448892, 7828.178041305581, 8103.1491693371345, 8914.153155450222, 11739.11956603241, 12226.327551984727, 12287.631371058882, 12309.75380492403, 12338.568150114703], "value": 8833.15017471106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.4976883668623, 1493.7385957457445, 1539.7998260226173, 1721.4577408116443, 1844.8062953389895, 8383.538905360203, 8693.739187824367, 8723.040465548784, 8953.507557084358, 8954.46273223607, 8748.125187481248, 8946.955265223682, 8951.820963580742, 8956.731298061053, 8965.417247878884, 2081.5628717969244, 2348.4833336665906, 2410.9879450602766, 2437.4515733959893, 2453.288546321565, 2433.5862903306393, 2437.8537287762792, 2448.8163387745903, 2451.1421002649017, 2451.9264422067276, 2304.608216603173, 2404.326788499214, 2409.9518009639796, 2410.783029527342, 2416.311351264881, 2048.3240530624857, 2332.1371092695726, 2388.820838437124, 2391.3423808452812, 2429.781319681237, 2296.712910886139, 2331.5453486570127, 2339.0409931927998, 2339.941501462477, 2360.0205914545445, 8963.10368963105, 9031.0, 9041.593128309241, 9046.547672616409, 9057.68298109563, 5293.206019097128, 5397.298351214317, 5400.027994960906, 5405.675659460406, 5409.134538473825, 3272.6072871255365, 3339.5658564386717, 3387.7459190560808, 3437.5874895012757, 3466.2027733621408, 1012.9290949633529, 1052.9420881851495, 1054.0144964458257, 1060.3690803971624, 1067.3915867955268, 12342.876571234263, 12561.623151305384, 12570.560030398892, 12604.0, 12631.052671049709, 4833.73414462208, 4847.636427267969, 4959.355283813081, 4983.90032199354, 4999.250112483084, 10579.206559508068, 10583.0, 10605.734856628646, 10609.946950265354, 10618.0, 4965.4041515018425, 5524.309461317335, 5527.861803454865, 5560.860978475571, 5584.0, 4986.750662466862, 5108.59131269505, 5111.361079865017, 5133.8716532087, 5145.3568303962, 4045.211183819127, 4063.329550624173, 4143.854965076208, 4326.437563116775, 4341.327094300388, 1295.3976400973593, 1301.1997621462733, 1311.4298062163714, 1317.426919290112, 1329.2755448280711, 930.2465003347176, 1009.5507499162949, 1012.3268026762267, 1023.5240613114937, 1028.136365453008, 5965.224520812353, 6111.480524155497, 6152.16945712332, 6264.0, 6422.4862011039, 418.236717989664, 422.99365509517384, 424.762133205406, 426.49460389438616, 426.86980470956655, 4193.832246710097, 4204.285271503852, 4279.679024073207, 4290.013296941721, 4336.783160841946, 10941.179411544166, 11157.944210278896, 11201.271917325348, 11243.0, 11251.043661288719, 10996.890031099587, 11078.169137314733, 11090.445477726082, 11095.611653592247, 11096.833547496793, 7722.382209423345, 8107.067687215927, 8108.716194933149, 8321.08468068512, 8482.321414286842, 5992.910106348321, 6019.699015049143, 6023.5181185505935, 6053.303870055, 6154.076888466766, 10206.744831379276, 10357.482125893524, 10408.115310198415, 10412.739681507719, 10416.427096509764, 10375.636852710119, 10379.948100259753, 10533.841992369968, 10576.947115264375, 10635.0, 7322.707091716272, 7812.0, 7926.326262267541, 7971.561564114029, 8056.395770317366, 8874.600642970952, 8891.555422228992, 8892.110788921314, 8948.910510894808, 8958.731238062868, 7757.069151701832, 7937.960310198412, 7976.7208147714555, 8054.677812887418, 8130.796730081795, 7794.181610930771, 7881.645325960231, 7953.363730901629, 7966.088138846751, 7969.6015199240965, 6968.79093627192, 7022.964885175541, 7097.787066388017, 7101.715931362688, 7102.751403700846, 4889.87775305606, 5012.573931215888, 5032.446430892525, 5066.31604733371, 5165.767540460613, 5280.788768449219, 5320.866978325573, 5321.414644389037, 5397.78408863641, 5458.044842152528], "value": 4638.617573618845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.30255287091956, 317.807726325573, 320.46322409963307, 320.6328753577154, 321.0656988164442, 5250.816221432251, 5343.599230057742, 5344.599155063376, 5350.224217488462, 5361.812336568216, 5297.205419187124, 5319.228711836791, 5333.399980005993, 5338.252644629755, 5361.865953351168, 3908.159745654684, 4011.077452185999, 4130.91738165238, 4159.334506478964, 4174.5578836380755, 4108.753474791507, 4115.094679170577, 4120.670346372283, 4120.752754834704, 4136.710430269883, 4096.467459230296, 4106.158237561308, 4111.602055301197, 4120.402541631462, 4138.8344466221315, 3905.3556163233034, 3939.3893946438347, 4127.360259159835, 4130.442390277304, 4132.6775431861815, 3562.5546806649168, 3566.696830769362, 3605.387084195693, 3615.6745892869767, 3630.146915474861, 5097.286379906816, 5137.691738495665, 5146.922796158061, 5229.764660590283, 5230.450802665741, 4413.90339588696, 4606.654500912445, 4629.3750343703505, 4671.392718946549, 4696.1546921554445, 5402.513773760341, 5421.159720243369, 5445.591580631429, 5448.591355648342, 5481.835544933659, 3864.265789499986, 3866.6906647468136, 3877.235857684747, 3893.201893611803, 3914.080191155076, 5551.1673249012565, 5720.885582288331, 5775.220345253421, 5779.682117483537, 5780.248567686216, 3968.146848427602, 3974.6621537169663, 3992.461017762565, 3994.1612261425425, 3997.900052498711, 4005.3177665380026, 4019.6181362771076, 4024.557298697141, 4032.879013629537, 4040.9797951010055, 4410.448693913261, 4622.630189584893, 4665.6967297125575, 4728.148933191989, 4729.668923175344, 5545.0, 5559.249501317351, 5602.411746766612, 5611.186377975171, 5624.437556244343, 1373.5192682561024, 1385.43197289113, 1395.8623721666809, 1399.3842709207916, 1402.1306789790394, 838.6958279874854, 844.5566077809076, 882.3823323673454, 897.6947837735202, 901.5266984833015, 5276.287701160371, 5358.303420555303, 5370.892582148335, 5374.462553744673, 5378.731063446812, 5666.603337766399, 5676.0918253080135, 5708.1723150143, 5746.9425305747245, 5758.539316854642, 5220.582353411718, 5376.327959005124, 5381.9461805382225, 5391.703456309862, 5474.671519708831, 3004.72957433832, 3013.984930075336, 3049.557814116941, 3058.464768665475, 3061.7703672224225, 5878.911816322759, 5940.881182376328, 5944.316403613553, 5963.850903727354, 5981.282246130492, 5613.354464236665, 5843.0, 5865.970670146622, 5873.618214816023, 5882.499987501024, 5937.95140676466, 5946.851328716817, 5957.702114894325, 5965.940340596539, 5993.820185394532, 5606.215129881902, 5661.188419705654, 5750.274917524809, 5818.2436283282905, 5833.9416605835095, 5618.943810561842, 5624.381318054929, 5648.802291919763, 5662.320521537277, 5665.603407761417, 5852.0, 5904.025835737055, 5921.911171332347, 5936.1986131871645, 5979.684469416721, 3584.8632446609217, 3659.853605855736, 3672.3573374658795, 3672.4307732301536, 3675.577308609544, 5090.49095090488, 5097.241451699158, 5115.360579927509, 5136.486351364833, 5207.71357575337, 4932.136876046749, 5015.699058056528, 5028.823991160292, 5051.797928082836, 5079.568236699922, 5051.393832740095, 5224.111900976919, 5596.076647353141, 5621.690807005654, 5634.971825140848, 5301.204819277139, 5523.6685798852195, 5523.861903452445, 5540.307461567304, 5554.333479982428, 5519.530839878495, 5578.30271216098, 5591.4688104629995, 5605.355384130714, 5623.88752224945, 5442.591805614516, 5447.0, 5483.890322193613, 5487.149491828773, 5494.0], "value": 4176.467628223424, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.2100775697158, 781.5818537082662, 781.8670825959587, 819.8073452738607, 849.0533055642958, 13929.512467063654, 14655.0, 14711.70576588469, 14724.19016954067, 14738.484153054646, 11467.36929468879, 12652.683682907931, 12682.112252142353, 12683.873161268384, 12713.491460341575, 793.4247670438943, 817.3338728935928, 819.4509678515379, 819.713100414853, 820.4789958376414, 808.7169490678245, 814.8859159717615, 815.0748899998515, 816.930560902324, 817.1868990354606, 687.4603436302503, 858.5578427110044, 860.178529504325, 860.6987554355957, 861.7070196133313, 831.2311112221171, 851.1063383447417, 851.4848516647401, 853.2235665544325, 854.8589482735372, 618.5670030978333, 621.3475850357107, 621.4903778901303, 621.7046902721216, 622.3776223776224, 12977.0, 13007.479700812051, 13014.86985130146, 13028.088033837636, 13036.283004434752, 11798.823017654742, 11964.760704785856, 12086.395680216043, 12105.0, 12356.443960021821, 11529.135314851335, 11587.884121158764, 11825.704357391134, 11934.820977685342, 12521.879628382967, 4384.079343337903, 4394.912101757947, 4405.515393306734, 4446.688731788776, 4585.79363928624, 57700.134497982144, 57939.71030144864, 58134.41865581332, 58907.41092589105, 59674.0, 10689.625863094754, 10735.141188704885, 10870.72823179411, 10985.890141098487, 11202.215844890943, 19839.900800495907, 20037.198512059353, 20064.89967550153, 20095.799042009687, 20111.29610463656, 7663.425243106789, 7677.769666910001, 7796.493227940279, 7804.414668899855, 7849.882251766228, 4376.956230437655, 4377.280873858612, 4385.6052955233545, 4423.955760442419, 4460.799264033127, 3380.560527131506, 3473.044912648991, 3473.2185258316676, 3478.5999610044664, 3484.7909125452047, 530.4006472685841, 627.8304857688398, 656.7143292667705, 661.7419206509466, 679.3206793206793, 658.134553062721, 726.46604745512, 752.7892190186757, 765.5368502056288, 799.9400044996532, 9883.950580247052, 10002.49987500622, 10285.845712314322, 10294.794104118026, 10298.742531436774, 652.709544252803, 658.7693711927282, 672.0758956434902, 673.9528233023641, 716.5772194405326, 4729.976350118227, 4831.710097394168, 4834.154023046023, 4852.927206091911, 4896.436909755424, 72817.0, 74445.62777186079, 75505.0, 75804.62097689476, 76149.61925190338, 65153.34846651568, 65291.34708652948, 66235.0, 66837.33162668408, 66962.33037669561, 56551.15173272404, 59790.70104649536, 60993.0, 61161.08258376217, 61341.38658613446, 9099.272058235192, 9242.676506322246, 9253.167214950687, 9411.764705882133, 9463.148316651534, 38679.0, 39105.217895641355, 39221.6077839218, 39407.802960986155, 40622.39066414065, 52701.7364913173, 53863.0, 54247.76150742715, 54583.0, 55122.72438637781, 11375.43122843871, 11620.477078531656, 11805.114616403633, 11825.881741182478, 12106.636800895987, 12394.793453153838, 12603.432845522157, 13168.934155329162, 13656.453741850215, 13687.178769273876, 11902.583409580624, 11978.820317695066, 12034.037277017642, 12415.689607759878, 13259.535916242885, 12379.9381003098, 12906.419211135333, 13187.53843615469, 13274.668133296358, 13290.800637990631, 12583.45715700842, 12775.808362874379, 12794.296313702836, 13207.207567545978, 13213.207207567577, 9945.651902183388, 10432.582696692047, 10704.89295107039, 10725.195610329101, 10969.616063437741, 10228.744281393025, 10913.345199288067, 10929.508172132431, 10994.28537145083, 11019.669409917715], "value": 6918.881504306908, "unit": "score"}], "name": "dromaeo_css", "value": 7102.517108318566, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 108.0, 108.0, 108.0, 109.0, 110.0, 108.0, 108.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 133.0, 203.0, 126.0, 127.0, 159.0, 131.0, 174.0, 126.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 160.0, 161.0, 162.0, 163.0, 165.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 148.0, 76.0, 76.0, 75.0, 75.0, 119.0, 75.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 165.0, 94.0, 93.0, 92.0, 125.0, 92.0, 93.0, 125.0], "value": 106.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 144.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 56.0, 57.0, 56.0, 55.0, 108.0, 54.0, 54.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 60.0, 62.0, 61.0, 62.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 79.0, 84.0, 79.0, 79.0, 86.0, 79.0, 79.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 136.0, 133.0, 117.0, 127.0, 124.0, 119.0, 188.0, 129.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 160.0, 159.0, 159.0, 161.0, 163.0, 159.0, 161.0, 162.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 64.0, 63.0, 62.0, 64.0, 61.0, 68.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1523.1000000000001, "alertThreshold": 2.0}]} 11:54:50 INFO - Return code: 0 11:54:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:54:50 ERROR - # TBPL SUCCESS # 11:54:50 INFO - Running post-action listener: _resource_record_post_action 11:54:50 INFO - ##### 11:54:50 INFO - ##### Finished run-tests step (success) 11:54:50 INFO - ##### 11:54:50 INFO - Running post-run listener: _resource_record_post_run 11:54:50 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539201536; Read time: 8; Write time: 435952 11:54:50 INFO - TinderboxPrint: CPU usage
13.1% 11:54:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:54:50 INFO - TinderboxPrint: I/O write bytes / time
539,201,536 / 435,952 11:54:50 INFO - TinderboxPrint: CPU idle
8,269.2 (86.8%) 11:54:50 INFO - TinderboxPrint: CPU user
1,209.6 (12.7%) 11:54:50 INFO - TinderboxPrint: Swap in / out
0 / 0 11:54:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253501440; Read time: 0; Write time: 248480 11:54:50 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285622272; Read time: 8; Write time: 187472 11:54:50 INFO - Running post-run listener: _upload_blobber_files 11:54:50 INFO - Blob upload gear active. 11:54:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:54:50 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 11:54:50 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'] 11:54:50 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 11:54:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:54:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:54:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:52 INFO - (blobuploader) - INFO - Done attempting. 11:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:52 INFO - (blobuploader) - INFO - Done attempting. 11:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:54:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:57 INFO - (blobuploader) - INFO - Done attempting. 11:54:57 INFO - (blobuploader) - INFO - Iteration through files over. 11:54:57 INFO - Return code: 0 11:54:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:54:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:54:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9a2aa99bb1fbae79d557259c5fcf3f840209fc124b7a8b5e88cbd8757bbe217b3165fc7b7aec50f8b80b14e85f372eb75fb3b94817188a168c6e6dc81cef6c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87e13ad2cb600abe49d239e182d91651586de76b7253eb3ced30d8335fb80d54a7b16910631b47eed15c133e165afeaca1aa7b7319c28c4030f700251ab8d51d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c1173379f36cc9446fea215103fa51d5933484d6c40c1a4b4b8227ae43b435aac7c5e608f3d2c4fd7cf83757f1f6ae8400f36eb42834296422a24212b7b9e6a"} 11:54:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:54:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:54:57 INFO - Contents: 11:54:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9a2aa99bb1fbae79d557259c5fcf3f840209fc124b7a8b5e88cbd8757bbe217b3165fc7b7aec50f8b80b14e85f372eb75fb3b94817188a168c6e6dc81cef6c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87e13ad2cb600abe49d239e182d91651586de76b7253eb3ced30d8335fb80d54a7b16910631b47eed15c133e165afeaca1aa7b7319c28c4030f700251ab8d51d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c1173379f36cc9446fea215103fa51d5933484d6c40c1a4b4b8227ae43b435aac7c5e608f3d2c4fd7cf83757f1f6ae8400f36eb42834296422a24212b7b9e6a"} 11:54:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:54:57 INFO - Copying logs to upload dir... 11:54:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:54:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.891917 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-23 11:54:55.864742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:54:55.867949) ========= 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=41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558 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/f9a2aa99bb1fbae79d557259c5fcf3f840209fc124b7a8b5e88cbd8757bbe217b3165fc7b7aec50f8b80b14e85f372eb75fb3b94817188a168c6e6dc81cef6c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87e13ad2cb600abe49d239e182d91651586de76b7253eb3ced30d8335fb80d54a7b16910631b47eed15c133e165afeaca1aa7b7319c28c4030f700251ab8d51d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c1173379f36cc9446fea215103fa51d5933484d6c40c1a4b4b8227ae43b435aac7c5e608f3d2c4fd7cf83757f1f6ae8400f36eb42834296422a24212b7b9e6a"} build_url:https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/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/f9a2aa99bb1fbae79d557259c5fcf3f840209fc124b7a8b5e88cbd8757bbe217b3165fc7b7aec50f8b80b14e85f372eb75fb3b94817188a168c6e6dc81cef6c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87e13ad2cb600abe49d239e182d91651586de76b7253eb3ced30d8335fb80d54a7b16910631b47eed15c133e165afeaca1aa7b7319c28c4030f700251ab8d51d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c1173379f36cc9446fea215103fa51d5933484d6c40c1a4b4b8227ae43b435aac7c5e608f3d2c4fd7cf83757f1f6ae8400f36eb42834296422a24212b7b9e6a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:54:55.893068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:54:55.893408) ========= 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=41bf3e9aed84707956354da8000001c5-1464028450.780600-233605558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:54:55.979521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:54:55.980291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:54:55.981032) ========= ========= Total master_lag: 0.95 =========