builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1470249092.01 results: success (0) buildid: 20160803053003 builduid: 685189264f9e4774b275e984a2242583 revision: 2b687444223cbaa1f5727b4e8fff13177ab8ef0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:32.009570) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:32.010024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:32.010302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:32.047320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:32.047673) ========= 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=8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 11:31:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.4M=0s 2016-08-03 11:31:31 (51.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181195 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:32.262069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:32.262411) ========= 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=8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.110367 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:32.382400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:32.382869) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2b687444223cbaa1f5727b4e8fff13177ab8ef0d --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 2b687444223cbaa1f5727b4e8fff13177ab8ef0d --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=8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 11:31:32,145 truncating revision to first 12 chars 2016-08-03 11:31:32,145 Setting DEBUG logging. 2016-08-03 11:31:32,145 attempt 1/10 2016-08-03 11:31:32,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2b687444223c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 11:31:32,465 unpacking tar archive at: fx-team-2b687444223c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710785 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:33.107782) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:33.108211) ========= script_repo_revision: 2b687444223cbaa1f5727b4e8fff13177ab8ef0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:33.108711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:33.109000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 11:31:33.119615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-08-03 11:31:33.120031) ========= /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=8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:33 INFO - MultiFileLogger online at 20160803 11:31:33 in /builds/slave/test 11:31:33 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:31:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:33 INFO - {'append_to_log': False, 11:31:33 INFO - 'base_work_dir': '/builds/slave/test', 11:31:33 INFO - 'blob_upload_branch': 'Fx-Team', 11:31:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:33 INFO - 'branch': 'Fx-Team', 11:31:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:33 INFO - 'config_files': ('talos/linux_config.py',), 11:31:33 INFO - 'default_actions': ('clobber', 11:31:33 INFO - 'read-buildbot-config', 11:31:33 INFO - 'download-and-extract', 11:31:33 INFO - 'populate-webroot', 11:31:33 INFO - 'create-virtualenv', 11:31:33 INFO - 'install', 11:31:33 INFO - 'run-tests'), 11:31:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:33 INFO - 'download_minidump_stackwalk': True, 11:31:33 INFO - 'download_symbols': 'ondemand', 11:31:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:31:33 INFO - 'tooltool.py': '/tools/tooltool.py', 11:31:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:31:33 INFO - '/tools/misc-python/virtualenv.py')}, 11:31:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:33 INFO - 'installer_path': 'installer.exe', 11:31:33 INFO - 'log_level': 'info', 11:31:33 INFO - 'log_name': 'talos', 11:31:33 INFO - 'log_to_console': True, 11:31:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:33 INFO - 'opt_config_files': (), 11:31:33 INFO - 'pip_index': False, 11:31:33 INFO - 'sps_profile': False, 11:31:33 INFO - 'sps_profile_interval': 0, 11:31:33 INFO - 'suite': 'dromaeojs', 11:31:33 INFO - 'system_bits': '32', 11:31:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:33 INFO - 'title': 'talos-linux64-ix-038', 11:31:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:33 INFO - 'use_talos_json': True, 11:31:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:33 INFO - 'work_dir': 'build'} 11:31:33 INFO - [mozharness: 2016-08-03 18:31:33.090879Z] Running clobber step. 11:31:33 INFO - Running pre-action listener: _resource_record_pre_action 11:31:33 INFO - Running main action method: clobber 11:31:33 INFO - rmtree: /builds/slave/test/build 11:31:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:33 INFO - Running post-action listener: _resource_record_post_action 11:31:33 INFO - [mozharness: 2016-08-03 18:31:33.808873Z] Finished clobber step (success) 11:31:33 INFO - [mozharness: 2016-08-03 18:31:33.809004Z] Running read-buildbot-config step. 11:31:33 INFO - Running pre-action listener: _resource_record_pre_action 11:31:33 INFO - Running main action method: read_buildbot_config 11:31:33 INFO - Using buildbot properties: 11:31:33 INFO - { 11:31:33 INFO - "project": "", 11:31:33 INFO - "product": "firefox", 11:31:33 INFO - "script_repo_revision": "production", 11:31:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:31:33 INFO - "repository": "", 11:31:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:31:33 INFO - "buildid": "20160803053003", 11:31:33 INFO - "pgo_build": "True", 11:31:33 INFO - "basedir": "/builds/slave/test", 11:31:33 INFO - "buildnumber": 946, 11:31:33 INFO - "slavename": "talos-linux64-ix-038", 11:31:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:31:33 INFO - "platform": "ubuntu64_hw", 11:31:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:31:33 INFO - "branch": "fx-team", 11:31:33 INFO - "repo_path": "integration/fx-team", 11:31:33 INFO - "revision": "2b687444223cbaa1f5727b4e8fff13177ab8ef0d", 11:31:33 INFO - "stage_platform": "linux64-pgo", 11:31:33 INFO - "builduid": "685189264f9e4774b275e984a2242583", 11:31:33 INFO - "slavebuilddir": "test" 11:31:33 INFO - } 11:31:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:31:33 INFO - Running post-action listener: _resource_record_post_action 11:31:33 INFO - [mozharness: 2016-08-03 18:31:33.811411Z] Finished read-buildbot-config step (success) 11:31:33 INFO - [mozharness: 2016-08-03 18:31:33.811498Z] Running download-and-extract step. 11:31:33 INFO - Running pre-action listener: _resource_record_pre_action 11:31:33 INFO - Running main action method: download_and_extract 11:31:33 INFO - mkdir: /builds/slave/test/build/tests 11:31:33 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:31:33 INFO - https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:31:34 INFO - Downloaded 1361 bytes. 11:31:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:31:34 INFO - Using the following test package requirements: 11:31:34 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:31:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:31:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:31:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'jsshell-linux-x86_64.zip'], 11:31:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:31:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:31:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:31:34 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:31:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:31:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:31:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:31:34 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:31:34 INFO - https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:31:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:31:35 INFO - Downloaded 21810845 bytes. 11:31:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:31:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:31:36 INFO - Return code: 0 11:31:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:31:36 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:31:36 INFO - https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:31:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:31:39 INFO - Downloaded 21810845 bytes. 11:31:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:31:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:31:41 INFO - Return code: 0 11:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:41 INFO - https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:31:42 INFO - Downloaded 14413723 bytes. 11:31:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:31:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:31:43 INFO - Return code: 0 11:31: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:31:43 INFO - https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:31:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:31:44 INFO - Downloaded 59370101 bytes. 11:31:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:44 INFO - mkdir: /builds/slave/test/properties 11:31:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:44 INFO - Contents: 11:31:44 INFO - build_url:https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:45 INFO - Running post-action listener: _resource_record_post_action 11:31:45 INFO - Running post-action listener: set_extra_try_arguments 11:31:45 INFO - [mozharness: 2016-08-03 18:31:45.562704Z] Finished download-and-extract step (success) 11:31:45 INFO - [mozharness: 2016-08-03 18:31:45.562941Z] Running populate-webroot step. 11:31:45 INFO - Running pre-action listener: _resource_record_pre_action 11:31:45 INFO - Running main action method: populate_webroot 11:31:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:31:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:31:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:31:45 INFO - '--tppagecycles', 11:31:45 INFO - '7'], 11:31:45 INFO - 'tests': ['tsvgm']}}, 11:31:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:31:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:31:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:31:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:31:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:45 INFO - 'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:45 INFO - 'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['damp', 'tps']}, 11:31:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:45 INFO - 'tests': ['damp', 'tps']}, 11:31:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['dromaeo_dom']}, 11:31:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['basic_compositor_video']}, 11:31:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:31:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['a11yr', 11:31:45 INFO - 'ts_paint', 11:31:45 INFO - 'tpaint', 11:31:45 INFO - 'sessionrestore', 11:31:45 INFO - 'sessionrestore_no_auto_restore', 11:31:45 INFO - 'tabpaint']}, 11:31:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:31:45 INFO - 'ts_paint', 11:31:45 INFO - 'tpaint', 11:31:45 INFO - 'sessionrestore', 11:31:45 INFO - 'sessionrestore_no_auto_restore', 11:31:45 INFO - 'tabpaint']}, 11:31:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:31:45 INFO - 'ts_paint', 11:31:45 INFO - 'tpaint', 11:31:45 INFO - 'sessionrestore', 11:31:45 INFO - 'sessionrestore_no_auto_restore', 11:31:45 INFO - 'tabpaint']}, 11:31:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:31:45 INFO - 'ts_paint', 11:31:45 INFO - 'tpaint', 11:31:45 INFO - 'sessionrestore', 11:31:45 INFO - 'sessionrestore_no_auto_restore', 11:31:45 INFO - 'tabpaint']}, 11:31:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['a11yr', 11:31:45 INFO - 'ts_paint', 11:31:45 INFO - 'tpaint', 11:31:45 INFO - 'sessionrestore', 11:31:45 INFO - 'sessionrestore_no_auto_restore', 11:31:45 INFO - 'tabpaint']}, 11:31:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['a11yr', 11:31:45 INFO - 'ts_paint', 11:31:45 INFO - 'tpaint', 11:31:45 INFO - 'sessionrestore', 11:31:45 INFO - 'sessionrestore_no_auto_restore', 11:31:45 INFO - 'tabpaint']}, 11:31:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['tsvgx', 11:31:45 INFO - 'tsvgr_opacity', 11:31:45 INFO - 'tart', 11:31:45 INFO - 'tscrollx', 11:31:45 INFO - 'cart']}, 11:31:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:31:45 INFO - 'tsvgr_opacity', 11:31:45 INFO - 'tart', 11:31:45 INFO - 'tscrollx', 11:31:45 INFO - 'cart']}, 11:31:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:45 INFO - 'talos_options': ['--disable-e10s'], 11:31:45 INFO - 'tests': ['tp5o']}, 11:31:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:45 INFO - 'tests': ['tp5o']}, 11:31:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:45 INFO - 'talos_options': ['--disable-e10s', 11:31:45 INFO - '--xperf_path', 11:31:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:45 INFO - 'tests': ['tp5n']}, 11:31:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:45 INFO - 'talos_options': ['--xperf_path', 11:31:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:45 INFO - 'tests': ['tp5n']}}, 11:31:45 INFO - 'talos.zip': {'path': '', 11:31:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:31:45 INFO - Running post-action listener: _resource_record_post_action 11:31:45 INFO - [mozharness: 2016-08-03 18:31:45.582737Z] Finished populate-webroot step (success) 11:31:45 INFO - [mozharness: 2016-08-03 18:31:45.582824Z] Running create-virtualenv step. 11:31:45 INFO - Running pre-action listener: _resource_record_pre_action 11:31:45 INFO - Running main action method: create_virtualenv 11:31:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:45 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:31:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:31:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:45 INFO - Using real prefix '/usr' 11:31:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:57 INFO - Installing distribute.............................................................................................................................................................................................done. 11:31:59 INFO - Installing pip.................done. 11:31:59 INFO - Return code: 0 11:31:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:31:59 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:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:59 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:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:59 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 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:31:59 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:31:59 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:31:59 INFO - Using env: {'DISPLAY': ':0', 11:31:59 INFO - 'HOME': '/home/cltbld', 11:31:59 INFO - 'LANG': 'en_US.UTF-8', 11:31:59 INFO - 'LANGUAGE': 'en_US:en', 11:31:59 INFO - 'LOGNAME': 'cltbld', 11:31:59 INFO - 'MAIL': '/var/mail/cltbld', 11:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:59 INFO - 'MOZ_NO_REMOTE': '1', 11:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:59 INFO - 'NO_EM_RESTART': '1', 11:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:59 INFO - 'PWD': '/builds/slave/test', 11:31:59 INFO - 'SHELL': '/bin/bash', 11:31:59 INFO - 'SHLVL': '1', 11:31:59 INFO - 'TERM': 'linux', 11:31:59 INFO - 'TMOUT': '86400', 11:31:59 INFO - 'USER': 'cltbld', 11:31:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:59 INFO - '_': '/tools/buildbot/bin/python'} 11:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:00 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:32:00 INFO - Cleaning up... 11:32:00 INFO - Return code: 0 11:32:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:32:00 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:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:00 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:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:00 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 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:32:00 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:32:00 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:32:00 INFO - Using env: {'DISPLAY': ':0', 11:32:00 INFO - 'HOME': '/home/cltbld', 11:32:00 INFO - 'LANG': 'en_US.UTF-8', 11:32:00 INFO - 'LANGUAGE': 'en_US:en', 11:32:00 INFO - 'LOGNAME': 'cltbld', 11:32:00 INFO - 'MAIL': '/var/mail/cltbld', 11:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:00 INFO - 'MOZ_NO_REMOTE': '1', 11:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:00 INFO - 'NO_EM_RESTART': '1', 11:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:00 INFO - 'PWD': '/builds/slave/test', 11:32:00 INFO - 'SHELL': '/bin/bash', 11:32:00 INFO - 'SHLVL': '1', 11:32:00 INFO - 'TERM': 'linux', 11:32:00 INFO - 'TMOUT': '86400', 11:32:00 INFO - 'USER': 'cltbld', 11:32:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:00 INFO - '_': '/tools/buildbot/bin/python'} 11:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:00 INFO - Downloading/unpacking psutil>=3.1.1 11:32:00 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:32:00 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:32:00 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:32:00 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:32:00 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:32:00 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:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:02 INFO - Installing collected packages: psutil 11:32:02 INFO - Running setup.py install for psutil 11:32:02 INFO - building 'psutil._psutil_linux' extension 11:32:02 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:32:03 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:32:04 INFO - building 'psutil._psutil_posix' extension 11:32:04 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:32:04 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:32:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:04 INFO - Successfully installed psutil 11:32:04 INFO - Cleaning up... 11:32:04 INFO - Return code: 0 11:32:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:32:04 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:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:04 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:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:04 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 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:32:04 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:32:04 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:32:04 INFO - Using env: {'DISPLAY': ':0', 11:32:04 INFO - 'HOME': '/home/cltbld', 11:32:04 INFO - 'LANG': 'en_US.UTF-8', 11:32:04 INFO - 'LANGUAGE': 'en_US:en', 11:32:04 INFO - 'LOGNAME': 'cltbld', 11:32:04 INFO - 'MAIL': '/var/mail/cltbld', 11:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:04 INFO - 'MOZ_NO_REMOTE': '1', 11:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:04 INFO - 'NO_EM_RESTART': '1', 11:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:04 INFO - 'PWD': '/builds/slave/test', 11:32:04 INFO - 'SHELL': '/bin/bash', 11:32:04 INFO - 'SHLVL': '1', 11:32:04 INFO - 'TERM': 'linux', 11:32:04 INFO - 'TMOUT': '86400', 11:32:04 INFO - 'USER': 'cltbld', 11:32:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:04 INFO - '_': '/tools/buildbot/bin/python'} 11:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:32:04 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:32:04 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:32:04 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:32:04 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:32:04 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:32:04 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:32:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:32:06 INFO - Installing collected packages: mozsystemmonitor 11:32:06 INFO - Running setup.py install for mozsystemmonitor 11:32:06 INFO - Successfully installed mozsystemmonitor 11:32:06 INFO - Cleaning up... 11:32:06 INFO - Return code: 0 11:32:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:32:06 INFO - Using env: {'DISPLAY': ':0', 11:32:06 INFO - 'HOME': '/home/cltbld', 11:32:06 INFO - 'LANG': 'en_US.UTF-8', 11:32:06 INFO - 'LANGUAGE': 'en_US:en', 11:32:06 INFO - 'LOGNAME': 'cltbld', 11:32:06 INFO - 'MAIL': '/var/mail/cltbld', 11:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:06 INFO - 'MOZ_NO_REMOTE': '1', 11:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:06 INFO - 'NO_EM_RESTART': '1', 11:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:06 INFO - 'PWD': '/builds/slave/test', 11:32:06 INFO - 'SHELL': '/bin/bash', 11:32:06 INFO - 'SHLVL': '1', 11:32:06 INFO - 'TERM': 'linux', 11:32:06 INFO - 'TMOUT': '86400', 11:32:06 INFO - 'USER': 'cltbld', 11:32:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:06 INFO - '_': '/tools/buildbot/bin/python'} 11:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:06 INFO - Downloading/unpacking jsonschema==2.5.1 11:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:09 INFO - warning: no files found matching '*.txt' 11:32:09 INFO - no previously-included directories found matching 'build' 11:32:09 INFO - no previously-included directories found matching 'dist' 11:32:09 INFO - no previously-included directories found matching '.git*' 11:32:09 INFO - Installing collected packages: jsonschema, functools32 11:32:09 INFO - Running setup.py install for functools32 11:32:09 INFO - warning: no files found matching '*.txt' 11:32:09 INFO - no previously-included directories found matching 'build' 11:32:09 INFO - no previously-included directories found matching 'dist' 11:32:09 INFO - no previously-included directories found matching '.git*' 11:32:09 INFO - Successfully installed jsonschema functools32 11:32:09 INFO - Cleaning up... 11:32:09 INFO - Return code: 0 11:32:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:32:09 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:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:09 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:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:09 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:32:09 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:32:09 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 functools32==3.2.3-2 11:32:09 INFO - Using env: {'DISPLAY': ':0', 11:32:09 INFO - 'HOME': '/home/cltbld', 11:32:09 INFO - 'LANG': 'en_US.UTF-8', 11:32:09 INFO - 'LANGUAGE': 'en_US:en', 11:32:09 INFO - 'LOGNAME': 'cltbld', 11:32:09 INFO - 'MAIL': '/var/mail/cltbld', 11:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:09 INFO - 'MOZ_NO_REMOTE': '1', 11:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:09 INFO - 'NO_EM_RESTART': '1', 11:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:09 INFO - 'PWD': '/builds/slave/test', 11:32:09 INFO - 'SHELL': '/bin/bash', 11:32:09 INFO - 'SHLVL': '1', 11:32:09 INFO - 'TERM': 'linux', 11:32:09 INFO - 'TMOUT': '86400', 11:32:09 INFO - 'USER': 'cltbld', 11:32:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:09 INFO - '_': '/tools/buildbot/bin/python'} 11:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:32:09 INFO - Cleaning up... 11:32:09 INFO - Return code: 0 11:32:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:32:09 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:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:09 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:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:09 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 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:32:09 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:32:09 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:32:09 INFO - Using env: {'DISPLAY': ':0', 11:32:09 INFO - 'HOME': '/home/cltbld', 11:32:09 INFO - 'LANG': 'en_US.UTF-8', 11:32:09 INFO - 'LANGUAGE': 'en_US:en', 11:32:09 INFO - 'LOGNAME': 'cltbld', 11:32:09 INFO - 'MAIL': '/var/mail/cltbld', 11:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:09 INFO - 'MOZ_NO_REMOTE': '1', 11:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:09 INFO - 'NO_EM_RESTART': '1', 11:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:09 INFO - 'PWD': '/builds/slave/test', 11:32:09 INFO - 'SHELL': '/bin/bash', 11:32:09 INFO - 'SHLVL': '1', 11:32:09 INFO - 'TERM': 'linux', 11:32:09 INFO - 'TMOUT': '86400', 11:32:09 INFO - 'USER': 'cltbld', 11:32:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:09 INFO - '_': '/tools/buildbot/bin/python'} 11:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:09 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:09 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:32:09 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:32:09 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:32:09 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:32:09 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:32:09 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:32:11 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32:12 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:32:12 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:32:12 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:32:12 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:32:12 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:32:12 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:32:12 INFO - Downloading docopt-0.6.1.tar.gz 11:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:12 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:12 INFO - Running setup.py install for blobuploader 11:32:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:12 INFO - Running setup.py install for requests 11:32:12 INFO - Running setup.py install for docopt 11:32:12 INFO - Successfully installed blobuploader requests docopt 11:32:12 INFO - Cleaning up... 11:32:12 INFO - Return code: 0 11:32:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:12 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:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:12 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:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:12 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 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:32:12 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:32:12 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:32:12 INFO - Using env: {'DISPLAY': ':0', 11:32:12 INFO - 'HOME': '/home/cltbld', 11:32:12 INFO - 'LANG': 'en_US.UTF-8', 11:32:12 INFO - 'LANGUAGE': 'en_US:en', 11:32:12 INFO - 'LOGNAME': 'cltbld', 11:32:12 INFO - 'MAIL': '/var/mail/cltbld', 11:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:12 INFO - 'MOZ_NO_REMOTE': '1', 11:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:12 INFO - 'NO_EM_RESTART': '1', 11:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:12 INFO - 'PWD': '/builds/slave/test', 11:32:12 INFO - 'SHELL': '/bin/bash', 11:32:12 INFO - 'SHLVL': '1', 11:32:12 INFO - 'TERM': 'linux', 11:32:12 INFO - 'TMOUT': '86400', 11:32:12 INFO - 'USER': 'cltbld', 11:32:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:12 INFO - '_': '/tools/buildbot/bin/python'} 11:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:13 INFO - Running setup.py (path:/tmp/pip-6ChHPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:13 INFO - Running setup.py (path:/tmp/pip-hB_Tbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:13 INFO - Running setup.py (path:/tmp/pip-uDb4mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:13 INFO - Running setup.py (path:/tmp/pip-oIOmQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:13 INFO - Running setup.py (path:/tmp/pip-pdBavf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:13 INFO - Running setup.py (path:/tmp/pip-d0MxjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:13 INFO - Running setup.py (path:/tmp/pip-IAIUMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:13 INFO - Running setup.py (path:/tmp/pip-_a_Ubs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:13 INFO - Running setup.py (path:/tmp/pip-29D6Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:13 INFO - Running setup.py (path:/tmp/pip-1ybpth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:13 INFO - Running setup.py (path:/tmp/pip-iq6q46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:13 INFO - Running setup.py (path:/tmp/pip-l3sYuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:14 INFO - Running setup.py (path:/tmp/pip-JcQn1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:14 INFO - Running setup.py (path:/tmp/pip-6Rbxux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:14 INFO - Running setup.py (path:/tmp/pip-rmIaOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:14 INFO - Running setup.py (path:/tmp/pip-3MxzZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:14 INFO - Running setup.py (path:/tmp/pip-5og351-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:14 INFO - Running setup.py install for manifestparser 11:32:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Running setup.py install for mozcrash 11:32:14 INFO - Running setup.py install for mozdebug 11:32:14 INFO - Running setup.py install for mozdevice 11:32:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Running setup.py install for mozfile 11:32:14 INFO - Running setup.py install for mozhttpd 11:32:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Running setup.py install for mozinfo 11:32:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Running setup.py install for mozInstall 11:32:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Running setup.py install for mozleak 11:32:15 INFO - Running setup.py install for mozlog 11:32:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Running setup.py install for moznetwork 11:32:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Running setup.py install for mozprocess 11:32:15 INFO - Running setup.py install for mozprofile 11:32:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Running setup.py install for mozrunner 11:32:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:15 INFO - Running setup.py install for mozscreenshot 11:32:15 INFO - Running setup.py install for moztest 11:32:16 INFO - Running setup.py install for mozversion 11:32:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:16 INFO - Cleaning up... 11:32:16 INFO - Return code: 0 11:32:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:16 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 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:32:16 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:32:16 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:32:16 INFO - Using env: {'DISPLAY': ':0', 11:32:16 INFO - 'HOME': '/home/cltbld', 11:32:16 INFO - 'LANG': 'en_US.UTF-8', 11:32:16 INFO - 'LANGUAGE': 'en_US:en', 11:32:16 INFO - 'LOGNAME': 'cltbld', 11:32:16 INFO - 'MAIL': '/var/mail/cltbld', 11:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:16 INFO - 'MOZ_NO_REMOTE': '1', 11:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:16 INFO - 'NO_EM_RESTART': '1', 11:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:16 INFO - 'PWD': '/builds/slave/test', 11:32:16 INFO - 'SHELL': '/bin/bash', 11:32:16 INFO - 'SHLVL': '1', 11:32:16 INFO - 'TERM': 'linux', 11:32:16 INFO - 'TMOUT': '86400', 11:32:16 INFO - 'USER': 'cltbld', 11:32:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:16 INFO - '_': '/tools/buildbot/bin/python'} 11:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:16 INFO - Running setup.py (path:/tmp/pip-V3pEV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:16 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:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:16 INFO - Running setup.py (path:/tmp/pip-dgoX7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:16 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:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:16 INFO - Running setup.py (path:/tmp/pip-jK98IZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:16 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:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:16 INFO - Running setup.py (path:/tmp/pip-HWlBPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:16 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:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:16 INFO - Running setup.py (path:/tmp/pip-iGdj2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:16 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:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:16 INFO - Running setup.py (path:/tmp/pip-Ts3D_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:16 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:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:16 INFO - Running setup.py (path:/tmp/pip-3JYqju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:16 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:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:16 INFO - Running setup.py (path:/tmp/pip-eVxnwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:16 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:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:16 INFO - Running setup.py (path:/tmp/pip-lvRNKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:17 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:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:17 INFO - Running setup.py (path:/tmp/pip-cimYpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:17 INFO - Running setup.py (path:/tmp/pip-_raCw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:17 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:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:17 INFO - Running setup.py (path:/tmp/pip-OTDffB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:17 INFO - Running setup.py (path:/tmp/pip-l8q7AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:17 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:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:17 INFO - Running setup.py (path:/tmp/pip-1Umv4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:17 INFO - Running setup.py (path:/tmp/pip-DWpQqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:17 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:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:17 INFO - Running setup.py (path:/tmp/pip-AnPFZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:17 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:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:17 INFO - Running setup.py (path:/tmp/pip-Dx5EqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:17 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:32:17 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:32:17 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:32:17 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:32:17 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:32:17 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:32:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:17 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:32:17 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:32:17 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:32:17 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:32:17 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:32:17 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:32:20 INFO - Downloading blessings-1.6.tar.gz 11:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:20 INFO - Installing collected packages: blessings 11:32:20 INFO - Running setup.py install for blessings 11:32:20 INFO - Successfully installed blessings 11:32:20 INFO - Cleaning up... 11:32:20 INFO - Return code: 0 11:32:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:20 INFO - Reading from file tmpfile_stdout 11:32:20 INFO - Current package versions: 11:32:20 INFO - argparse == 1.2.1 11:32:20 INFO - blessings == 1.6 11:32:20 INFO - blobuploader == 1.2.4 11:32:20 INFO - docopt == 0.6.1 11:32:20 INFO - functools32 == 3.2.3-2 11:32:20 INFO - jsonschema == 2.5.1 11:32:20 INFO - manifestparser == 1.1 11:32:20 INFO - mozInstall == 1.12 11:32:20 INFO - mozcrash == 0.17 11:32:20 INFO - mozdebug == 0.1 11:32:20 INFO - mozdevice == 0.48 11:32:20 INFO - mozfile == 1.2 11:32:20 INFO - mozhttpd == 0.7 11:32:20 INFO - mozinfo == 0.9 11:32:20 INFO - mozleak == 0.1 11:32:20 INFO - mozlog == 3.3 11:32:20 INFO - moznetwork == 0.27 11:32:20 INFO - mozprocess == 0.23 11:32:20 INFO - mozprofile == 0.28 11:32:20 INFO - mozrunner == 6.12 11:32:20 INFO - mozscreenshot == 0.1 11:32:20 INFO - mozsystemmonitor == 0.3 11:32:20 INFO - moztest == 0.7 11:32:20 INFO - mozversion == 1.4 11:32:20 INFO - psutil == 3.1.1 11:32:20 INFO - requests == 1.2.3 11:32:20 INFO - wsgiref == 0.1.2 11:32:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:20 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 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:32:20 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:32:20 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:32:20 INFO - Using env: {'DISPLAY': ':0', 11:32:20 INFO - 'HOME': '/home/cltbld', 11:32:20 INFO - 'LANG': 'en_US.UTF-8', 11:32:20 INFO - 'LANGUAGE': 'en_US:en', 11:32:20 INFO - 'LOGNAME': 'cltbld', 11:32:20 INFO - 'MAIL': '/var/mail/cltbld', 11:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:20 INFO - 'MOZ_NO_REMOTE': '1', 11:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:20 INFO - 'NO_EM_RESTART': '1', 11:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:20 INFO - 'PWD': '/builds/slave/test', 11:32:20 INFO - 'SHELL': '/bin/bash', 11:32:20 INFO - 'SHLVL': '1', 11:32:20 INFO - 'TERM': 'linux', 11:32:20 INFO - 'TMOUT': '86400', 11:32:20 INFO - 'USER': 'cltbld', 11:32:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:20 INFO - '_': '/tools/buildbot/bin/python'} 11:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 INFO - Cleaning up... 11:32:21 INFO - Return code: 0 11:32:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, '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': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', '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:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:32:21 INFO - Using env: {'DISPLAY': ':0', 11:32:21 INFO - 'HOME': '/home/cltbld', 11:32:21 INFO - 'LANG': 'en_US.UTF-8', 11:32:21 INFO - 'LANGUAGE': 'en_US:en', 11:32:21 INFO - 'LOGNAME': 'cltbld', 11:32:21 INFO - 'MAIL': '/var/mail/cltbld', 11:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:21 INFO - 'MOZ_NO_REMOTE': '1', 11:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:21 INFO - 'NO_EM_RESTART': '1', 11:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:21 INFO - 'PWD': '/builds/slave/test', 11:32:21 INFO - 'SHELL': '/bin/bash', 11:32:21 INFO - 'SHLVL': '1', 11:32:21 INFO - 'TERM': 'linux', 11:32:21 INFO - 'TMOUT': '86400', 11:32:21 INFO - 'USER': 'cltbld', 11:32:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:21 INFO - '_': '/tools/buildbot/bin/python'} 11:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:21 INFO - Cleaning up... 11:32:21 INFO - Return code: 0 11:32:21 INFO - Running post-action listener: _resource_record_post_action 11:32:21 INFO - Running post-action listener: _start_resource_monitoring 11:32:21 INFO - Starting resource monitoring. 11:32:21 INFO - [mozharness: 2016-08-03 18:32:21.461919Z] Finished create-virtualenv step (success) 11:32:21 INFO - [mozharness: 2016-08-03 18:32:21.462882Z] Running install step. 11:32:21 INFO - Running pre-action listener: _resource_record_pre_action 11:32:21 INFO - Running main action method: install 11:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:21 INFO - Reading from file tmpfile_stdout 11:32:21 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:21 INFO - Reading from file tmpfile_stdout 11:32:21 INFO - Output received: 11:32:21 INFO - Usage: mozinstall [options] installer 11:32:21 INFO - Options: 11:32:21 INFO - -h, --help show this help message and exit 11:32:21 INFO - -d DEST, --destination=DEST 11:32:21 INFO - Directory to install application into. [default: 11:32:21 INFO - "/builds/slave/test"] 11:32:21 INFO - --app=APP Application being installed. [default: firefox] 11:32:21 INFO - mkdir: /builds/slave/test/build/application 11:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:32:38 INFO - Reading from file tmpfile_stdout 11:32:38 INFO - Output received: 11:32:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:38 INFO - Running post-action listener: _resource_record_post_action 11:32:38 INFO - [mozharness: 2016-08-03 18:32:38.622321Z] Finished install step (success) 11:32:38 INFO - [mozharness: 2016-08-03 18:32:38.622594Z] Running run-tests step. 11:32:38 INFO - Running pre-action listener: _resource_record_pre_action 11:32:38 INFO - Running main action method: run_tests 11:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:38 INFO - Python 2.7.3 11:32:38 INFO - Return code: 0 11:32:38 INFO - grabbing minidump binary from tooltool 11:32: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:32:38 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 0x24183b0>, '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 0x24192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:38 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:32:38 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:32:38 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:32:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:39 INFO - Return code: 0 11:32:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:39 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/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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:32:39 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/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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:32:39 INFO - Using env: {'DISPLAY': ':0', 11:32:39 INFO - 'HOME': '/home/cltbld', 11:32:39 INFO - 'LANG': 'en_US.UTF-8', 11:32:39 INFO - 'LANGUAGE': 'en_US:en', 11:32:39 INFO - 'LOGNAME': 'cltbld', 11:32:39 INFO - 'MAIL': '/var/mail/cltbld', 11:32:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:39 INFO - 'MOZ_NO_REMOTE': '1', 11:32:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:39 INFO - 'NO_EM_RESTART': '1', 11:32:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:39 INFO - 'PWD': '/builds/slave/test', 11:32:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:39 INFO - 'SHELL': '/bin/bash', 11:32:39 INFO - 'SHLVL': '1', 11:32:39 INFO - 'TERM': 'linux', 11:32:39 INFO - 'TMOUT': '86400', 11:32:39 INFO - 'USER': 'cltbld', 11:32:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098', 11:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:39 INFO - '_': '/tools/buildbot/bin/python'} 11:32:39 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/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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:32:39 INFO - mozversion application_buildid: 20160803053003 11:32:39 INFO - mozversion application_changeset: 2b687444223cbaa1f5727b4e8fff13177ab8ef0d 11:32:39 INFO - mozversion application_display_name: Nightly 11:32:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:39 INFO - mozversion application_name: Firefox 11:32:39 INFO - mozversion application_remotingname: firefox 11:32:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:32:39 INFO - mozversion application_vendor: Mozilla 11:32:39 INFO - mozversion application_version: 51.0a1 11:32:39 INFO - mozversion platform_buildid: 20160803053003 11:32:39 INFO - mozversion platform_changeset: 2b687444223cbaa1f5727b4e8fff13177ab8ef0d 11:32:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:32:39 INFO - mozversion platform_version: 51.0a1 11:32:39 INFO - using testdate: 1470249159 11:32:39 INFO - actual date: 1470249159 11:32:39 INFO - starting webserver on 'localhost:55424' 11:32:39 INFO - SUITE-START | Running 2 tests 11:32:39 INFO - TEST-START | dromaeo_css 11:32:39 INFO - operating with platform_type : linux_ 11:32:39 INFO - Initialising browser for dromaeo_css test... 11:32:39 INFO - TEST-INFO | started process 3292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20QhBa/profile http://localhost:55424/getInfo.html) 11:32:48 INFO - PROCESS | 3292 | __metrics Screen width/height:1600/1200 11:32:48 INFO - PROCESS | 3292 | colorDepth:24 11:32:48 INFO - PROCESS | 3292 | Browser inner width/height: 1024/697 11:32:48 INFO - PROCESS | 3292 | __metrics 11:32:49 INFO - PROCESS | 3292 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:32:49 INFO - PROCESS | 3292 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:50 INFO - TEST-INFO | 3292: exit 0 11:32:50 INFO - Browser initialized. 11:32:50 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:50 INFO - TEST-INFO | started process 3373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20QhBa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:02 INFO - PROCESS | 3373 | RSS: Main: 156360704 11:33:02 INFO - PROCESS | 3373 | 11:33:53 INFO - PROCESS | 3373 | 1470249233094 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:36:02 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55424/tests/dromaeo/cssquery-ext.html) 11:36:03 INFO - PROCESS | 3373 | RSS: Main: 268353536 11:36:03 INFO - PROCESS | 3373 | 11:39:06 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-ext.html (next: http://localhost:55424/tests/dromaeo/cssquery-jquery.html) 11:39:06 INFO - PROCESS | 3373 | RSS: Main: 248369152 11:39:06 INFO - PROCESS | 3373 | 11:42:08 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55424/tests/dromaeo/cssquery-mootools.html) 11:42:09 INFO - PROCESS | 3373 | RSS: Main: 185569280 11:42:09 INFO - PROCESS | 3373 | 11:45:11 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55424/tests/dromaeo/cssquery-prototype.html) 11:45:11 INFO - PROCESS | 3373 | RSS: Main: 226807808 11:45:11 INFO - PROCESS | 3373 | 11:48:14 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55424/tests/dromaeo/cssquery-yui.html) 11:48:15 INFO - PROCESS | 3373 | RSS: Main: 190447616 11:48:15 INFO - PROCESS | 3373 | 11:51:18 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-yui.html (next: http://localhost:55424/tests/dromaeo/cssquery-dojo.html) 11:51:18 INFO - PROCESS | 3373 | RSS: Main: 275480576 11:51:18 INFO - PROCESS | 3373 | 11:51:18 INFO - PROCESS | 3373 | __start_tp_report 11:51:18 INFO - PROCESS | 3373 | _x_x_mozilla_page_load 11:51:18 INFO - PROCESS | 3373 | _x_x_mozilla_page_load_details 11:51:18 INFO - PROCESS | 3373 | |i|pagename|runs| 11:51:18 INFO - PROCESS | 3373 | |0;dojo.html;3024.894128705495;3039.5744595756582;3069.631644202696;3073.5697002419656;3075.461794186017;5250.684958902469;5251.186066159742;5322.121849894763;5415.296011518502;5434.701091439969;5370.946290537094;5397.163439666848;5415.187721841726;5445.210444485557;5458.153986132156;4876.536729010738;4922.507749225085;4954;4981.950180498185;5149.382074151088;5044.344235249412;5052.823151189709;5064.088464076464;5076.720780357079;5080.822171224008;4813.278008298748;4829.106615276185;4836.685615435021;4892.363992680965;5075.543201111899;4903.117438861003;4905.190643543811;4916.06594746997;4973.5772459341;4999.650024498286;4937.086638971766;4953.331300274453;4954.108260513106;4978;5005.474425185376;5246.842594722127;5339.786408543654;5414.945850541483;5467.043267428224;5496.230527726121;5828.591998560102;5835.5915085944;5876.265466816648;5882.23530940975;5886.823395298148;5857.619254748428;5893.970530147321;5913.408659134096;5922.881542369171;5925.31858836235;5296;5362.195670649395;5403.540699040625;5416.052190866582;5498.560115190775;6001.669908155093;6003.6397816131175;6011.6693581853415;6012.7294271757;6037.335893051761;5739.971300143556;5772.509336706427;5779.450952159538;5780;5786;5537.2524709163745;5664.433556644302;5748.45389687979;5758.021136406821;5822.767089316465;5777.220075289866;5779.537636989031;5792.594518383757;5829.8251052468495;5843.444872737083;5733.426657334233;5771.0477771168125;5775.913361299584;5791.652500849962;5796.362400135981;4283.31466965284;4360.149770794665;4404.427424434867;4405.801738921692;4493.865184044484;3931.351327031065;3933.4296527003426;3973.543042550086;3975.3043217436834;3984.7011474139554;5455.072637651609;5456.099743542271;5458.208559758892;5458.317710286215;5459.235707001023;5671.631343962712;5733;5760.855978600569;5769.88460230793;5825.242718446575;5499.120140777456;5509.035918714209;5512.80705175317;5535.723213839292;5546.251256080458;4974.527419895104;4982.177940639826;4982.501749824988;4983.750812459362;5026;5889.146073819272;5949.405059494103;5981;6075.635461872302;6080.513558915276;5803.419658034331;5816.534677225727;5816.680082595498;5859.765609375577;5860.472557469848;6016.127661488972;6027.427394397525;6028.125921741235;6030.939690603038;6033.215681961317;5493.697846618475;5640.943590564042;5698.629589076862;5705.572082093777;5712.285964254468;5871.383504731942;5905.35041145465;5911.290645122613;5949.25634295713;5959.463648271676;5719.799807006902;5720.799772007959;5721.5136713379825;5723;5726.5418766499415;5518.392976772632;5604.243427137284;5619.49424551776;5695.45893140151;5708.714564271853;5614.157876318422;5628.85927851807;5632.915506267491;5659.405762394889;5673.687947162945;5706.743196556248;5716.399778023248;5749.683767392834;5765.336986246635;5768.682722450306;5272.578193744568;5344.5991550634635;5500.50495455411;5602.047651899105;5604.607677462538 11:51:18 INFO - PROCESS | 3373 | |1;ext.html;597.1490625858152;600.6576251536624;604.7822783797833;614.7264467312042;634.7873462390099;43455.34816977748;44347.55652443479;44628.55371446288;44663;48150.51849481504;44932;45409.77295113528;45429.318560221625;45461.090778184414;45489.7725511372;8952.91047089529;9073.909260907372;9086;9104.772380690469;9105.908940910605;8881.866771998426;8975.416597921147;8981.640734370618;8985.068210334777;8989.77525561863;8996.370254082216;9115.088491150898;9116.179543841054;9117.544122793866;9121.17909388155;8998.415103018282;9010.3242256831;9017.278617710568;9022.18800307969;9024.052474490183;8919;8964.8655270171;8978.281737460988;8992.8651070234;9027.638894444215;43094.13811723748;43341.56658433407;43449.13101737948;43476.56523434789;43528.56471435277;3443.362977849106;3964.8414063437717;4236.068065025689;4293;4372.978135109336;33864.83067584671;33930.83034584836;34015.489767653504;34116;34378.6562134378;4411.941134127786;4571.3143028545655;4613.492515823256;4700.976495117537;4709.058188362307;363324;365501;366064;366069;368035;59640.70179649161;59880.40119598836;59939.00304984821;59982.400175998555;60044;62029.37970620326;62317.688411557654;62342;62344;62346;15456.459023934332;15549.766753498707;15561.14413707257;15562.922185389001;15563.84436155624;13520.459181632625;13551.45794168242;13557.525486607921;13572.86427135716;13591.184528928296;12401.813972790234;15966.02431593082;16077.598060048593;16100.67798644044;16488.25802838875;5105.23869265103;6132.41742034506;6200.410960958701;6357.96821015892;6383.776567820104;1028.8662473878348;1028.9691309260734;1061.43358316058;1076.956921723138;1125.5070019905784;33035;33082.83458582692;33327.50008749871;34065.31869362648;34205.657943420745;1108.1744100645071;1113.832925061231;1123.752774389633;1140.5551834784442;1201.4473342262481;16426.178691065397;17069.829301707072;17299.56751081233;17363.47909562715;17394.826051739572;581228;583833;585757;586429;589297;58930.70534647299;58963.41036589665;58968.705156473945;58978.11532827011;59174.70412647909;1247.0958555047519;1301.271288078679;1364.9863501365057;1384.6746014686541;1393.6097892590092;32678.509822352207;33799.31003449867;34897.47653785246;34933.47599786056;35055.64944350524;51528.48471515387;52030;52056.21915671192;52085;52098.479015210876;330657;331168;331872;332302.0928116481;332794;28088.85955570209;29637.407251854413;29679.109626711233;30967.69032309648;31029.8448507756;49517;50866.23700644419;51539.22691159561;51932;52477.21284180664;38778.6122138775;42747.7862610685;43561;44160;45795;43325.30625065519;43594.56405435905;43608.12783744371;44718.77640611776;44844;42614.36078458764;43086;43266.56733432751;43374.78312608417;43563.34654980114;36239;38850.6114938847;39274;40131.799341003105;40210.19579608333;28528.42943141084;28810.590611153355;29399.11802645924;29406.852965735034;29458 11:51:18 INFO - PROCESS | 3373 | |2;jquery.html;366.3588719740454;382.59062802801014;388.10735308789776;392.21165457430567;414.21506245664466;17482.825171748278;19966.001699915;20015.299464518746;20176.293829715964;20212.292569760062;18509.259629614833;18602.627947441044;18827.152778124982;18975.14611842467;19160.233590656393;5625.1843482695185;5709.343425506068;5837.532997360222;5925.762969481216;5930.080837470199;5769.1923130761725;5788.5369170466265;5831.5626328025355;5835.0663893777;5838.065909454488;5601.747921343549;5779.653220806765;5797.217375654296;5803.564732645047;5830.242068531106;5800.738966746507;5829.88340233193;5841.445062719056;5844.590878638497;5847.181394604759;5169.0954083035695;5189.455107213726;5231.686098834082;5232.659877107976;5235.502627250406;24469.021239150414;24485.63271550928;24512.529248245162;24600.630990535155;24714.876425617756;2369.609014512603;2369.9526009479714;2374.0978428197345;2435.2450740270397;2439.1706819681394;14056.367463464168;14894.627634309229;15192.164430956293;15353.923230383889;15381.769273460906;1906.323255244396;1941.2332128809182;1946.347973428903;2011.4468521156798;2045.457953642286;89846.99999999935;90110.549447253;90228;90288.5485572568;92081.53959230227;11172.888271117185;11176.776464470666;11318.264312819805;11322.943385283186;11490.77018459643;15900.12549309799;15908.920455397649;15943.681126377407;15951.564359207727;15952.680946381239;8160.755177344689;8237.917620823835;8479.06730259671;8505.70230041958;8519.914800851911;7968.12350641429;8002.4798388105755;8007.119216886138;8211.466254693545;8339.24946754795;4791.353167322367;4864.426269494802;4891.945382939174;4922.212446008622;4980.800767969313;1975.4764987278384;1976.33792679454;1977.179470519747;2002.2691717522998;2031.827294679939;887.3611000079932;952.6856137474617;967.6951760195516;982.3909176310733;996.6461906023258;19070.52323691891;20663.793362066186;20711.378658640264;20886.686699699516;20922.163113475595;1015.5125539740966;1016.3850870223556;1025.1696126137851;1037.4397825174321;1068.7915856407926;10512;11532.931688946115;11578.189526733047;11668.358240296695;11762.35307058103;520362;521258;522387;524726;531887;58181.709091455115;60358;70344;82965.58517207376;87425.56287218523;1003.6687892995294;1011.6661501704419;1013.5489707080278;1013.878334599838;1030.525958059286;17780.46658600244;18053.458396248134;18650.81349186491;18672;19002.809971900104;45247.547524524336;45333;45565;46245.07509849851;46785.532144678116;57614.71192644178;58775;60928.69535652471;67630;68048;8524.318054555744;8619.612117454855;8646.956765216133;8688.52213128284;8700.825983480421;9235.722928312161;13122.671933201364;13850.86149138536;13872.583822485341;13942;12152;12365.567205147776;12536.261811523156;12614.55849045279;12973.610791676265;11855.466504007512;11957;12116.15186936906;12412.441440135035;12520.812187817372;12334.876651233373;12441.440135193758;12466.626001219978;12604.87395126037;12775.425105870445;8619.956900215459;8727.040025597053;8804.867926980973;8806.20744133031;9197.172254497127;8882.111788821067;11151.163662725166;12231.388430578614;12236.755264894475;12329.753404932031 11:51:18 INFO - PROCESS | 3373 | |3;mootools.html;1297.8637243089481;1461.7880407340936;1510.2071412508433;1632.8040635123787;1775.5117342730748;8368.372372072095;8735.519546424945;8774.4735315881;8986.550672466383;8987.59555819988;8815.471071735685;8933.910660893389;8938.86591701125;8942.508162051085;8946.507942063185;2405.8917348719306;2443.499082688045;2449.7917676997477;2453.815963802713;2454.325060608338;2388.7252965908883;2401;2459.2499287717237;2459.483508463225;2460.495598402323;2385.7494963028894;2406.242033759369;2421.33413311339;2430.562498750224;2443.535728211643;2364.4207169243646;2391.270662447953;2398.352444839892;2399.5320912422085;2401.591729406005;2355.0815182079004;2360.799332056777;2390.6414037894283;2391.9043238270447;2392.4138586046356;8727.825443491094;8800.383973121883;8906.955465222698;8920;8930.732078037669;5289.206619007141;5513.972430137864;5518.806841760559;5522.3649280332875;5524.116141417354;3638.0904773806546;3648.087978005499;3670.917079461565;3714.312852122339;3736.1406876418578;1214.5020541577999;1224.2287358963886;1225.154643296123;1253.4610117649406;1272.7072773262203;12286.13997020209;12356.382180891009;12384.442700078518;12396.876031239752;12415.44130514129;4471.642268618502;4669.299605059268;4753.714777113384;4775.498572649891;4783.990723895972;9868.309218354647;9868.851967220497;9871.901280987242;9873.901260987299;9874.60501579943;5273.762680679379;5302.787888484495;5309;5309.123994540934;5317.229001794718;4061.3501839706096;4326.913461730811;4470.955290447054;4965.950340496549;4967.751612419364;3904.824282907219;3941.8620348287673;3998.4202290668272;4036.9596304037173;4045.8786236412957;1210.431097384228;1230.4524486603555;1233.3771445420184;1234.7530493901256;1237.6348977051612;847.0724556610502;941.23759754599;954.0602506531061;966.6761634852263;975.9951200243953;6008.729607167688;6094.8171554853425;6107.633541987495;6122.448979591858;6230.6884655767935;483.4005832767413;483.95886349660674;485.42719590882393;492.3181393769583;496.39439883342266;4288.442502474721;4329.372241025034;4330.155619654201;4354.238008348526;4408;10949.781004380027;11192.944035279934;11262.774744505065;11290.153238507144;11299.096072314194;10566.682999510027;11028.724281893017;11061.059809916087;11249.550017999352;11369.658910232707;8189.26296633294;8311.459755115899;8367.748967531106;8379.078301386842;8392.748217553482;6272.212419460432;6364.840878978062;6433.517486188648;6473.352664733489;6605.471562275103;9948.104670579683;10220.642277520252;10239.641612543524;10285.845712314172;10365.689029329133;9434.48110353937;10542.420166890895;10559.524821382902;10560.577576896838;10571.735706607089;7820.921790782019;7980.8802867955865;8047.678092876454;8226.0540037894;8245.051819040647;8757.562121894007;8768.342374321825;8770.38607297483;8800.119988001405;8888.422252553823;7922.128565857866;7986.440949133505;8024.759257222293;8033.35733141359;8264.83470330602;7836.608169591384;7850.175731548334;7915.248051435105;7981.281684648409;8002.1997800219515;7051.471139664648;7086.362227399559;7135.714571417086;7136;7136.964315178391;5287.920681189862;5431.728413579226;5439.265699130567;5591.27313449249;5761;5406.75669594877;5434.375046869661;5484.1773733938635;5521.861953451035;5522.06124958766 11:51:18 INFO - PROCESS | 3373 | |4;prototype.html;320.90052083853993;331.5408159698817;337.7382528540382;337.8260195999061;340.67976102463666;5301.469853014697;5332.733363331832;5335.226392173133;5365.275687782153;5372.462753724625;5020.569137795729;5090.516400941905;5225.8954820903555;5239;5266.3943646480575;4114.7119701620895;4141.295979683446;4159.563245859179;4164.791760411982;4176.248275310458;4113.457453454955;4145.896352591194;4150.439690641755;4152.8131234094535;4176.707630465853;3910.47208626836;3943.4676318696897;4053.169100334439;4084.6732261419015;4111.424400583921;4084.4894388201474;4095.8156882940043;4102.323116685743;4106.8973275668195;4129.339305711072;3651.5758854046944;3655.25067361193;3656.1225305926387;3657.085728567858;3677.1358730698266;5006.3241462402475;5116.76974536143;5120.334356533627;5141;5141;4616.746078965655;4683.976580117078;4703.341532185496;4707.7881495332795;4735.905281894343;5430.83707488776;5434.538064264542;5434.972825135888;5459.235707001023;5459.426760190163;3760.868369607078;3914.6885793259294;3995.2608767377837;3996.1008773025837;4001.9399709004388;5631.042722737145;5633.380328163898;5655.915161272585;5672.631278966854;5684.857878552986;4027.81874815634;4032.899177520527;4036.5578824811155;4047.9595204048173;4083.571225021389;3952.505936757905;4149;4156.355764856452;4162.292410290258;4168.145530166309;4700.412448443944;4702.495201535544;4704.388429504143;4714.4106986626675;4736.8342108026745;5542.473465020817;5545.611807173459;5549.500544950974;5637.802676906289;5655.293088363955;1350.3990724127866;1412.9222892740997;1427.457566124866;1428.0931608428723;1438.4749566408186;879.1911441473859;905.4069584422214;907.7639813648499;911.968081117171;915.4187091197005;4633.443986721615;4658.836940707059;4674.719516828933;4713.222318317507;4724.6692731508465;4541.909161816745;4930.556249937523;4973.632251130968;4999.925001124986;5049.419316778544;4668.626509879202;4679.438467383868;4696.309328641686;4696.520596012245;4705.6470764692785;2582.4562805636433;2605.9315680570876;2615.9346016349364;2617.6727909011374;2661.627372167898;4824.469308376076;5142.665726727751;5145.202493613496;5146.253793199965;5175.223716442564;4997.30037794709;5005.299258103868;5035.6764535406455;5059.470264867567;5079.466656001066;5051.191809310492;5071.264666623319;5107.923381149286;5110.386753589593;5114.570578974957;4746.264329029006;4841.806327746851;4919.385076865392;4984.75076246179;4995.225740010304;4887.218045112765;4898.559129678203;4913.926291105708;4915.21356582945;4940.950590494049;5082.645454000342;5103.87240318995;5124.718140502308;5138.460461651623;5146.562542183956;3576.9821150894077;3683.318586061587;3706.4625629283064;3708.3695771718335;3713.962860371362;4920.753962301942;4959.60323174138;4960.255961605788;4962.404511458648;4985.850424487271;4786.104406833815;4813.470518243061;4830.758462076812;4856.39295088114;4875.585575226146;4544.977485019134;4796.328514008112;4827.324174615486;4833.347498087714;4870.488598697086;4769.57073863354;4774.761261936958;4782.234842425334;4786.630617844189;4792.880177995578;4838.7338696372035;4853.441854186673;4856.834359753563;4932.580730637936;4960.975195124146;4444.8444304449185;4736.455307639666;4776.904461910812;4793.400824896888;4819.421669399694 11:51:18 INFO - PROCESS | 3373 | |5;yui.html;710.5630037526919;748.8427430239649;756.7616200896717;782.0185666987936;801.5070731500127;15241.390344386225;15859.444919427822;16488.752668709963;16503.669926601477;16722.665546689088;14894.776578351333;14993.325300361483;15009.02441341312;15019.399224031025;15020.924895375509;664.7108507799098;822.5928165558042;835.4277320035765;838.3293365307729;838.4591938199858;685.2154283345566;696.3245651717825;696.8014115976947;795.6697970342329;827.8675411934062;876.1676407412951;883.2757139145903;883.2889523933231;883.6067949762358;883.7569668341193;876.8377850097688;879.8988116366636;880.3177537408495;881.0220655072897;881.4094556647062;508.11841455075415;518.5177784660265;520.4249304518528;639.4820195641545;640.8654182621655;14347.21090340031;14887;14972.47596334134;15332.463363782213;15472.226388680634;15099.54701358961;15576.532704018897;16301.021938683598;16506.75239871403;16889.577760555963;12088.456019479145;12401.62795116148;12721.173123746927;12995.956438689173;13300.667483312898;3806.5241844769403;3808.067023579213;3936.2914675358425;3939.1333906540804;3977.4630424892557;76625.61687191584;77066.61466692686;77845;78043.21956780473;78594;11329.43352832355;11438.199326047263;11460.94269528647;11602.70993225176;11752.23610465317;18359.541011474554;18411.355602554115;18449.446516604523;18452.446426607225;20816;8153.95923020393;8226.876596851052;8405.495670259805;8441.873371899426;8631.395802293904;4588.2888152336445;4693.24908014716;4739.3601863748645;4799.912475694541;4876.902461950741;3690.1881586051027;3807.638274363931;3839.155385815116;3851.9229615407535;3856.0359910022494;592.8369698332993;608.2640005593282;609.4271384898182;617.163743128064;621.6798348850346;713.5112447973155;735.213321745727;745.392505108335;763.3587786259569;769.3729610367533;9882.357646752938;10039.799204015879;10222.795544089076;10260.897391025994;10704.518296676668;630.686107027922;661.7022339947043;728.4645785347765;752.6613024139159;752.8945947567345;4931.918936035406;4996.125678006334;5104.9749086795955;5333.599980001438;5716.171155182476;69900.30099698938;119332.8400295985;125148.37425812813;128223;128732;62968;64714.35285647083;79806.6009669948;103300.48349758203;107003;93871;95409;97344;98804.5059774711;100392.4980375108;10245.334053286513;10423.635172768916;10618.20363472758;10744.247902646739;10785.460726963463;52111.218331724296;53165;53526.73236633792;53971.73014134904;54047.45952540424;49867.75066124791;65593.67203163954;69341.65329173523;70513;72131;12611.81082283748;13153.145045572008;13166.868331316564;13467.595972120853;13666.248356340098;14740.852591474377;15267.847321526642;15832.28754706018;15925.761113583074;15934.36262549485;14029.719405611626;14222.288885555474;14248.35882385316;14264.429422823387;14898.25508724581;13280.933595332348;13510.256935868621;13797.51708690191;14017.929910350384;14389.712205755617;13924.51264205748;14121.788173177205;14476.927615361856;14698.853011470177;15415.383384664488;11532.769344612892;11654.766904662029;11784.528618855149;11944.701382465508;12661.556845510362;10773.892261077603;11638.825417618911;11641.825372619249;11750.121971861989;11832 11:51:18 INFO - PROCESS | 3373 | __end_tp_report 11:51:18 INFO - PROCESS | 3373 | __start_cc_report 11:51:18 INFO - PROCESS | 3373 | _x_x_mozilla_cycle_collect,1002 11:51:18 INFO - PROCESS | 3373 | __end_cc_report 11:51:18 INFO - PROCESS | 3373 | __startTimestamp1470250278302__endTimestamp 11:51:18 INFO - PROCESS | 3373 | 11:51:18 INFO - PROCESS | 3373 | ------- Summary: start ------- 11:51:18 INFO - PROCESS | 3373 | Number of tests: 6 11:51:18 INFO - PROCESS | 3373 | 11:51:18 INFO - PROCESS | 3373 | [#0] dojo.html Cycles:165 Average:5392.67 Median:5604.24 stddev:627.91 (11.2%) stddev-sans-first:601.73 11:51:18 INFO - PROCESS | 3373 | Values: 3024.9 3039.6 3069.6 3073.6 3075.5 5250.7 5251.2 5322.1 5415.3 5434.7 5370.9 5397.2 5415.2 5445.2 5458.2 4876.5 4922.5 4954.0 4982.0 5149.4 5044.3 5052.8 5064.1 5076.7 5080.8 4813.3 4829.1 4836.7 4892.4 5075.5 4903.1 4905.2 4916.1 4973.6 4999.7 4937.1 4953.3 4954.1 4978.0 5005.5 5246.8 5339.8 5414.9 5467.0 5496.2 5828.6 5835.6 5876.3 5882.2 5886.8 5857.6 5894.0 5913.4 5922.9 5925.3 5296.0 5362.2 5403.5 5416.1 5498.6 6001.7 6003.6 6011.7 6012.7 6037.3 5740.0 5772.5 5779.5 5780.0 5786.0 5537.3 5664.4 5748.5 5758.0 5822.8 5777.2 5779.5 5792.6 5829.8 5843.4 5733.4 5771.0 5775.9 5791.7 5796.4 4283.3 4360.1 4404.4 4405.8 4493.9 3931.4 3933.4 3973.5 3975.3 3984.7 5455.1 5456.1 5458.2 5458.3 5459.2 5671.6 5733.0 5760.9 5769.9 5825.2 5499.1 5509.0 5512.8 5535.7 5546.3 4974.5 4982.2 4982.5 4983.8 5026.0 5889.1 5949.4 5981.0 6075.6 6080.5 5803.4 5816.5 5816.7 5859.8 5860.5 6016.1 6027.4 6028.1 6030.9 6033.2 5493.7 5640.9 5698.6 5705.6 5712.3 5871.4 5905.4 5911.3 5949.3 5959.5 5719.8 5720.8 5721.5 5723.0 5726.5 5518.4 5604.2 5619.5 5695.5 5708.7 5614.2 5628.9 5632.9 5659.4 5673.7 5706.7 5716.4 5749.7 5765.3 5768.7 5272.6 5344.6 5500.5 5602.0 5604.6 11:51:18 INFO - PROCESS | 3373 | 11:51:18 INFO - PROCESS | 3373 | [#1] ext.html Cycles:180 Average:59906.77 Median:43502.56 stddev:117390.30 (269.8%) stddev-sans-first:117635.15 11:51:18 INFO - PROCESS | 3373 | Values: 597.1 600.7 604.8 614.7 634.8 43455.3 44347.6 44628.6 44663.0 48150.5 44932.0 45409.8 45429.3 45461.1 45489.8 8952.9 9073.9 9086.0 9104.8 9105.9 8881.9 8975.4 8981.6 8985.1 8989.8 8996.4 9115.1 9116.2 9117.5 9121.2 8998.4 9010.3 9017.3 9022.2 9024.1 8919.0 8964.9 8978.3 8992.9 9027.6 43094.1 43341.6 43449.1 43476.6 43528.6 3443.4 3964.8 4236.1 4293.0 4373.0 33864.8 33930.8 34015.5 34116.0 34378.7 4411.9 4571.3 4613.5 4701.0 4709.1 363324.0 365501.0 366064.0 366069.0 368035.0 59640.7 59880.4 59939.0 59982.4 60044.0 62029.4 62317.7 62342.0 62344.0 62346.0 15456.5 15549.8 15561.1 15562.9 15563.8 13520.5 13551.5 13557.5 13572.9 13591.2 12401.8 15966.0 16077.6 16100.7 16488.3 5105.2 6132.4 6200.4 6358.0 6383.8 1028.9 1029.0 1061.4 1077.0 1125.5 33035.0 33082.8 33327.5 34065.3 34205.7 1108.2 1113.8 1123.8 1140.6 1201.4 16426.2 17069.8 17299.6 17363.5 17394.8 581228.0 583833.0 585757.0 586429.0 589297.0 58930.7 58963.4 58968.7 58978.1 59174.7 1247.1 1301.3 1365.0 1384.7 1393.6 32678.5 33799.3 34897.5 34933.5 35055.6 51528.5 52030.0 52056.2 52085.0 52098.5 330657.0 331168.0 331872.0 332302.1 332794.0 28088.9 29637.4 29679.1 30967.7 31029.8 49517.0 50866.2 51539.2 51932.0 52477.2 38778.6 42747.8 43561.0 44160.0 45795.0 43325.3 43594.6 43608.1 44718.8 44844.0 42614.4 43086.0 43266.6 43374.8 43563.3 36239.0 38850.6 39274.0 40131.8 40210.2 28528.4 28810.6 29399.1 29406.9 29458.0 11:51:18 INFO - PROCESS | 3373 | 11:51:18 INFO - PROCESS | 3373 | [#2] jquery.html Cycles:180 Average:30243.96 Median:24556.58 stddev:86103.52 (350.6%) stddev-sans-first:86315.84 11:51:18 INFO - PROCESS | 3373 | Values: 366.4 382.6 388.1 392.2 414.2 17482.8 19966.0 20015.3 20176.3 20212.3 18509.3 18602.6 18827.2 18975.1 19160.2 5625.2 5709.3 5837.5 5925.8 5930.1 5769.2 5788.5 5831.6 5835.1 5838.1 5601.7 5779.7 5797.2 5803.6 5830.2 5800.7 5829.9 5841.4 5844.6 5847.2 5169.1 5189.5 5231.7 5232.7 5235.5 24469.0 24485.6 24512.5 24600.6 24714.9 2369.6 2370.0 2374.1 2435.2 2439.2 14056.4 14894.6 15192.2 15353.9 15381.8 1906.3 1941.2 1946.3 2011.4 2045.5 89847.0 90110.5 90228.0 90288.5 92081.5 11172.9 11176.8 11318.3 11322.9 11490.8 15900.1 15908.9 15943.7 15951.6 15952.7 8160.8 8237.9 8479.1 8505.7 8519.9 7968.1 8002.5 8007.1 8211.5 8339.2 4791.4 4864.4 4891.9 4922.2 4980.8 1975.5 1976.3 1977.2 2002.3 2031.8 887.4 952.7 967.7 982.4 996.6 19070.5 20663.8 20711.4 20886.7 20922.2 1015.5 1016.4 1025.2 1037.4 1068.8 10512.0 11532.9 11578.2 11668.4 11762.4 520362.0 521258.0 522387.0 524726.0 531887.0 58181.7 60358.0 70344.0 82965.6 87425.6 1003.7 1011.7 1013.5 1013.9 1030.5 17780.5 18053.5 18650.8 18672.0 19002.8 45247.5 45333.0 45565.0 46245.1 46785.5 57614.7 58775.0 60928.7 67630.0 68048.0 8524.3 8619.6 8647.0 8688.5 8700.8 9235.7 13122.7 13850.9 13872.6 13942.0 12152.0 12365.6 12536.3 12614.6 12973.6 11855.5 11957.0 12116.2 12412.4 12520.8 12334.9 12441.4 12466.6 12604.9 12775.4 8620.0 8727.0 8804.9 8806.2 9197.2 8882.1 11151.2 12231.4 12236.8 12329.8 11:51:18 INFO - PROCESS | 3373 | 11:51:18 INFO - PROCESS | 3373 | [#3] mootools.html Cycles:180 Average:5913.55 Median:2731.17 stddev:3339.16 (122.3%) stddev-sans-first:3330.50 11:51:18 INFO - PROCESS | 3373 | Values: 1297.9 1461.8 1510.2 1632.8 1775.5 8368.4 8735.5 8774.5 8986.6 8987.6 8815.5 8933.9 8938.9 8942.5 8946.5 2405.9 2443.5 2449.8 2453.8 2454.3 2388.7 2401.0 2459.2 2459.5 2460.5 2385.7 2406.2 2421.3 2430.6 2443.5 2364.4 2391.3 2398.4 2399.5 2401.6 2355.1 2360.8 2390.6 2391.9 2392.4 8727.8 8800.4 8907.0 8920.0 8930.7 5289.2 5514.0 5518.8 5522.4 5524.1 3638.1 3648.1 3670.9 3714.3 3736.1 1214.5 1224.2 1225.2 1253.5 1272.7 12286.1 12356.4 12384.4 12396.9 12415.4 4471.6 4669.3 4753.7 4775.5 4784.0 9868.3 9868.9 9871.9 9873.9 9874.6 5273.8 5302.8 5309.0 5309.1 5317.2 4061.4 4326.9 4471.0 4966.0 4967.8 3904.8 3941.9 3998.4 4037.0 4045.9 1210.4 1230.5 1233.4 1234.8 1237.6 847.1 941.2 954.1 966.7 976.0 6008.7 6094.8 6107.6 6122.4 6230.7 483.4 484.0 485.4 492.3 496.4 4288.4 4329.4 4330.2 4354.2 4408.0 10949.8 11192.9 11262.8 11290.2 11299.1 10566.7 11028.7 11061.1 11249.6 11369.7 8189.3 8311.5 8367.7 8379.1 8392.7 6272.2 6364.8 6433.5 6473.4 6605.5 9948.1 10220.6 10239.6 10285.8 10365.7 9434.5 10542.4 10559.5 10560.6 10571.7 7820.9 7980.9 8047.7 8226.1 8245.1 8757.6 8768.3 8770.4 8800.1 8888.4 7922.1 7986.4 8024.8 8033.4 8264.8 7836.6 7850.2 7915.2 7981.3 8002.2 7051.5 7086.4 7135.7 7136.0 7137.0 5287.9 5431.7 5439.3 5591.3 5761.0 5406.8 5434.4 5484.2 5521.9 5522.1 11:51:18 INFO - PROCESS | 3373 | 11:51:18 INFO - PROCESS | 3373 | [#4] prototype.html Cycles:180 Average:4338.47 Median:4789.76 stddev:1215.20 (25.4%) stddev-sans-first:1180.60 11:51:18 INFO - PROCESS | 3373 | Values: 320.9 331.5 337.7 337.8 340.7 5301.5 5332.7 5335.2 5365.3 5372.5 5020.6 5090.5 5225.9 5239.0 5266.4 4114.7 4141.3 4159.6 4164.8 4176.2 4113.5 4145.9 4150.4 4152.8 4176.7 3910.5 3943.5 4053.2 4084.7 4111.4 4084.5 4095.8 4102.3 4106.9 4129.3 3651.6 3655.3 3656.1 3657.1 3677.1 5006.3 5116.8 5120.3 5141.0 5141.0 4616.7 4684.0 4703.3 4707.8 4735.9 5430.8 5434.5 5435.0 5459.2 5459.4 3760.9 3914.7 3995.3 3996.1 4001.9 5631.0 5633.4 5655.9 5672.6 5684.9 4027.8 4032.9 4036.6 4048.0 4083.6 3952.5 4149.0 4156.4 4162.3 4168.1 4700.4 4702.5 4704.4 4714.4 4736.8 5542.5 5545.6 5549.5 5637.8 5655.3 1350.4 1412.9 1427.5 1428.1 1438.5 879.2 905.4 907.8 912.0 915.4 4633.4 4658.8 4674.7 4713.2 4724.7 4541.9 4930.6 4973.6 4999.9 5049.4 4668.6 4679.4 4696.3 4696.5 4705.6 2582.5 2605.9 2615.9 2617.7 2661.6 4824.5 5142.7 5145.2 5146.3 5175.2 4997.3 5005.3 5035.7 5059.5 5079.5 5051.2 5071.3 5107.9 5110.4 5114.6 4746.3 4841.8 4919.4 4984.8 4995.2 4887.2 4898.6 4913.9 4915.2 4941.0 5082.6 5103.9 5124.7 5138.5 5146.6 3577.0 3683.3 3706.5 3708.4 3714.0 4920.8 4959.6 4960.3 4962.4 4985.9 4786.1 4813.5 4830.8 4856.4 4875.6 4545.0 4796.3 4827.3 4833.3 4870.5 4769.6 4774.8 4782.2 4786.6 4792.9 4838.7 4853.4 4856.8 4932.6 4961.0 4444.8 4736.5 4776.9 4793.4 4819.4 11:51:18 INFO - PROCESS | 3373 | 11:51:18 INFO - PROCESS | 3373 | [#5] yui.html Cycles:180 Average:20699.51 Median:3845.54 stddev:29631.31 (770.5%) stddev-sans-first:29676.42 11:51:18 INFO - PROCESS | 3373 | Values: 710.6 748.8 756.8 782.0 801.5 15241.4 15859.4 16488.8 16503.7 16722.7 14894.8 14993.3 15009.0 15019.4 15020.9 664.7 822.6 835.4 838.3 838.5 685.2 696.3 696.8 795.7 827.9 876.2 883.3 883.3 883.6 883.8 876.8 879.9 880.3 881.0 881.4 508.1 518.5 520.4 639.5 640.9 14347.2 14887.0 14972.5 15332.5 15472.2 15099.5 15576.5 16301.0 16506.8 16889.6 12088.5 12401.6 12721.2 12996.0 13300.7 3806.5 3808.1 3936.3 3939.1 3977.5 76625.6 77066.6 77845.0 78043.2 78594.0 11329.4 11438.2 11460.9 11602.7 11752.2 18359.5 18411.4 18449.4 18452.4 20816.0 8154.0 8226.9 8405.5 8441.9 8631.4 4588.3 4693.2 4739.4 4799.9 4876.9 3690.2 3807.6 3839.2 3851.9 3856.0 592.8 608.3 609.4 617.2 621.7 713.5 735.2 745.4 763.4 769.4 9882.4 10039.8 10222.8 10260.9 10704.5 630.7 661.7 728.5 752.7 752.9 4931.9 4996.1 5105.0 5333.6 5716.2 69900.3 119332.8 125148.4 128223.0 128732.0 62968.0 64714.4 79806.6 103300.5 107003.0 93871.0 95409.0 97344.0 98804.5 100392.5 10245.3 10423.6 10618.2 10744.2 10785.5 52111.2 53165.0 53526.7 53971.7 54047.5 49867.8 65593.7 69341.7 70513.0 72131.0 12611.8 13153.1 13166.9 13467.6 13666.2 14740.9 15267.8 15832.3 15925.8 15934.4 14029.7 14222.3 14248.4 14264.4 14898.3 13280.9 13510.3 13797.5 14017.9 14389.7 13924.5 14121.8 14476.9 14698.9 15415.4 11532.8 11654.8 11784.5 11944.7 12661.6 10773.9 11638.8 11641.8 11750.1 11832.0 11:51:18 INFO - PROCESS | 3373 | -------- Summary: end -------- 11:51:18 INFO - PROCESS | 3373 | 11:51:19 INFO - TEST-INFO | 3373: exit 0 11:51:19 INFO - TEST-OK | dromaeo_css | took 1119345ms 11:51:19 INFO - TEST-START | kraken 11:51:19 INFO - operating with platform_type : linux_ 11:51:19 INFO - Initialising browser for kraken test... 11:51:19 INFO - TEST-INFO | started process 3562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLmFF3C/profile http://localhost:55424/getInfo.html) 11:51:23 INFO - PROCESS | 3562 | __metrics Screen width/height:1600/1200 11:51:23 INFO - PROCESS | 3562 | colorDepth:24 11:51:23 INFO - PROCESS | 3562 | Browser inner width/height: 1024/697 11:51:23 INFO - PROCESS | 3562 | __metrics 11:51:24 INFO - PROCESS | 3562 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:51:24 INFO - PROCESS | 3562 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:51:25 INFO - TEST-INFO | 3562: exit 0 11:51:25 INFO - Browser initialized. 11:51:25 INFO - Running cycle 1/1 for kraken test... 11:51:25 INFO - TEST-INFO | started process 3639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLmFF3C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:37 INFO - PROCESS | 3639 | RSS: Main: 156700672 11:51:37 INFO - PROCESS | 3639 | 11:51:40 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55424/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:40 INFO - PROCESS | 3639 | RSS: Main: 213164032 11:51:40 INFO - PROCESS | 3639 | 11:51:43 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55424/tests/kraken/driver.html?testName=audio-dft) 11:51:44 INFO - PROCESS | 3639 | RSS: Main: 186638336 11:51:44 INFO - PROCESS | 3639 | 11:51:47 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55424/tests/kraken/driver.html?testName=audio-fft) 11:51:47 INFO - PROCESS | 3639 | RSS: Main: 269451264 11:51:47 INFO - PROCESS | 3639 | 11:51:49 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55424/tests/kraken/driver.html?testName=audio-oscillator) 11:51:50 INFO - PROCESS | 3639 | RSS: Main: 180072448 11:51:50 INFO - PROCESS | 3639 | 11:51:52 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:53 INFO - PROCESS | 3639 | RSS: Main: 184782848 11:51:53 INFO - PROCESS | 3639 | 11:51:56 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55424/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:56 INFO - PROCESS | 3639 | RSS: Main: 219684864 11:51:56 INFO - PROCESS | 3639 | 11:52:00 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55424/tests/kraken/driver.html?testName=imaging-desaturate) 11:52:00 INFO - PROCESS | 3639 | RSS: Main: 219664384 11:52:00 INFO - PROCESS | 3639 | 11:52:03 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55424/tests/kraken/driver.html?testName=json-parse-financial) 11:52:04 INFO - PROCESS | 3639 | RSS: Main: 219332608 11:52:04 INFO - PROCESS | 3639 | 11:52:05 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:06 INFO - PROCESS | 3639 | RSS: Main: 183640064 11:52:06 INFO - PROCESS | 3639 | 11:52:07 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:08 INFO - PROCESS | 3639 | RSS: Main: 189960192 11:52:09 INFO - PROCESS | 3639 | 11:52:10 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:11 INFO - PROCESS | 3639 | RSS: Main: 194641920 11:52:11 INFO - PROCESS | 3639 | 11:52:13 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:14 INFO - PROCESS | 3639 | RSS: Main: 189407232 11:52:14 INFO - PROCESS | 3639 | 11:52:18 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:19 INFO - PROCESS | 3639 | RSS: Main: 180768768 11:52:19 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55424/tests/kraken/driver.html?testName=ai-astar) 11:52:20 INFO - PROCESS | 3639 | RSS: Main: 236564480 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | __start_tp_report 11:52:20 INFO - PROCESS | 3639 | _x_x_mozilla_page_load 11:52:20 INFO - PROCESS | 3639 | _x_x_mozilla_page_load_details 11:52:20 INFO - PROCESS | 3639 | |i|pagename|runs| 11:52:20 INFO - PROCESS | 3639 | |0;ai-astar;101;112;110;110;110;111;110;111;109;110 11:52:20 INFO - PROCESS | 3639 | |1;audio-beat-detection;153;116;122;178;125;120;150;122;149;118 11:52:20 INFO - PROCESS | 3639 | |2;audio-dft;160;160;160;161;161;159;159;161;161;160 11:52:20 INFO - PROCESS | 3639 | |3;audio-fft;75;77;76;126;77;76;74;74;119;75 11:52:20 INFO - PROCESS | 3639 | |4;audio-oscillator;83;83;121;83;83;84;127;83;83;127 11:52:20 INFO - PROCESS | 3639 | |5;imaging-gaussian-blur;116;117;117;116;116;116;117;117;116;117 11:52:20 INFO - PROCESS | 3639 | |6;imaging-darkroom;146;146;145;146;145;146;146;145;145;145 11:52:20 INFO - PROCESS | 3639 | |7;imaging-desaturate;95;95;96;95;95;95;94;95;95;95 11:52:20 INFO - PROCESS | 3639 | |8;json-parse-financial;50;49;49;48;50;50;50;50;49;48 11:52:20 INFO - PROCESS | 3639 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;61;61;60 11:52:20 INFO - PROCESS | 3639 | |10;stanford-crypto-aes;75;76;75;75;75;75;75;74;75;75 11:52:20 INFO - PROCESS | 3639 | |11;stanford-crypto-ccm;132;122;122;121;123;126;127;127;158;132 11:52:20 INFO - PROCESS | 3639 | |12;stanford-crypto-pbkdf2;161;163;161;160;159;161;159;161;158;172 11:52:20 INFO - PROCESS | 3639 | |13;stanford-crypto-sha256-iterative;64;64;63;63;63;63;62;66;61;62 11:52:20 INFO - PROCESS | 3639 | __end_tp_report 11:52:20 INFO - PROCESS | 3639 | __start_cc_report 11:52:20 INFO - PROCESS | 3639 | _x_x_mozilla_cycle_collect,1642 11:52:20 INFO - PROCESS | 3639 | __end_cc_report 11:52:20 INFO - PROCESS | 3639 | __startTimestamp1470250340913__endTimestamp 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | ------- Summary: start ------- 11:52:20 INFO - PROCESS | 3639 | Number of tests: 14 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:0.87 11:52:20 INFO - PROCESS | 3639 | Values: 101.0 112.0 110.0 110.0 110.0 111.0 110.0 111.0 109.0 110.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:137.00 stddev:20.83 (15.2%) stddev-sans-first:21.09 11:52:20 INFO - PROCESS | 3639 | Values: 153.0 116.0 122.0 178.0 125.0 120.0 150.0 122.0 149.0 118.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 11:52:20 INFO - PROCESS | 3639 | Values: 160.0 160.0 160.0 161.0 161.0 159.0 159.0 161.0 161.0 160.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#3] audio-fft Cycles:10 Average:84.90 Median:75.50 stddev:19.91 (26.4%) stddev-sans-first:20.80 11:52:20 INFO - PROCESS | 3639 | Values: 75.0 77.0 76.0 126.0 77.0 76.0 74.0 74.0 119.0 75.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:83.00 stddev:20.29 (24.4%) stddev-sans-first:20.99 11:52:20 INFO - PROCESS | 3639 | Values: 83.0 83.0 121.0 83.0 83.0 84.0 127.0 83.0 83.0 127.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:52:20 INFO - PROCESS | 3639 | Values: 116.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:52:20 INFO - PROCESS | 3639 | Values: 146.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:52:20 INFO - PROCESS | 3639 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 11:52:20 INFO - PROCESS | 3639 | Values: 50.0 49.0 49.0 48.0 50.0 50.0 50.0 50.0 49.0 48.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 11:52:20 INFO - PROCESS | 3639 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 60.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 11:52:20 INFO - PROCESS | 3639 | Values: 75.0 76.0 75.0 75.0 75.0 75.0 75.0 74.0 75.0 75.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:127.00 stddev:10.92 (8.6%) stddev-sans-first:11.53 11:52:20 INFO - PROCESS | 3639 | Values: 132.0 122.0 122.0 121.0 123.0 126.0 127.0 127.0 158.0 132.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:161.00 stddev:3.95 (2.5%) stddev-sans-first:4.19 11:52:20 INFO - PROCESS | 3639 | Values: 161.0 163.0 161.0 160.0 159.0 161.0 159.0 161.0 158.0 172.0 11:52:20 INFO - PROCESS | 3639 | 11:52:20 INFO - PROCESS | 3639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.37 (2.2%) stddev-sans-first:1.41 11:52:20 INFO - PROCESS | 3639 | Values: 64.0 64.0 63.0 63.0 63.0 63.0 62.0 66.0 61.0 62.0 11:52:20 INFO - PROCESS | 3639 | -------- Summary: end -------- 11:52:20 INFO - PROCESS | 3639 | 11:52:21 INFO - TEST-INFO | 3639: exit 0 11:52:21 INFO - TEST-OK | kraken | took 62877ms 11:52:21 INFO - SUITE-END | took 1182s 11:52:22 INFO - Completed test suite (00:19:42) 11:52:22 INFO - javascript benchmark 11:52:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3024.894128705495, 3039.5744595756582, 3069.631644202696, 3073.5697002419656, 3075.461794186017, 5250.684958902469, 5251.186066159742, 5322.121849894763, 5415.296011518502, 5434.701091439969, 5370.946290537094, 5397.163439666848, 5415.187721841726, 5445.210444485557, 5458.153986132156, 4876.536729010738, 4922.507749225085, 4954.0, 4981.950180498185, 5149.382074151088, 5044.344235249412, 5052.823151189709, 5064.088464076464, 5076.720780357079, 5080.822171224008, 4813.278008298748, 4829.106615276185, 4836.685615435021, 4892.363992680965, 5075.543201111899, 4903.117438861003, 4905.190643543811, 4916.06594746997, 4973.5772459341, 4999.650024498286, 4937.086638971766, 4953.331300274453, 4954.108260513106, 4978.0, 5005.474425185376, 5246.842594722127, 5339.786408543654, 5414.945850541483, 5467.043267428224, 5496.230527726121, 5828.591998560102, 5835.5915085944, 5876.265466816648, 5882.23530940975, 5886.823395298148, 5857.619254748428, 5893.970530147321, 5913.408659134096, 5922.881542369171, 5925.31858836235, 5296.0, 5362.195670649395, 5403.540699040625, 5416.052190866582, 5498.560115190775, 6001.669908155093, 6003.6397816131175, 6011.6693581853415, 6012.7294271757, 6037.335893051761, 5739.971300143556, 5772.509336706427, 5779.450952159538, 5780.0, 5786.0, 5537.2524709163745, 5664.433556644302, 5748.45389687979, 5758.021136406821, 5822.767089316465, 5777.220075289866, 5779.537636989031, 5792.594518383757, 5829.8251052468495, 5843.444872737083, 5733.426657334233, 5771.0477771168125, 5775.913361299584, 5791.652500849962, 5796.362400135981, 4283.31466965284, 4360.149770794665, 4404.427424434867, 4405.801738921692, 4493.865184044484, 3931.351327031065, 3933.4296527003426, 3973.543042550086, 3975.3043217436834, 3984.7011474139554, 5455.072637651609, 5456.099743542271, 5458.208559758892, 5458.317710286215, 5459.235707001023, 5671.631343962712, 5733.0, 5760.855978600569, 5769.88460230793, 5825.242718446575, 5499.120140777456, 5509.035918714209, 5512.80705175317, 5535.723213839292, 5546.251256080458, 4974.527419895104, 4982.177940639826, 4982.501749824988, 4983.750812459362, 5026.0, 5889.146073819272, 5949.405059494103, 5981.0, 6075.635461872302, 6080.513558915276, 5803.419658034331, 5816.534677225727, 5816.680082595498, 5859.765609375577, 5860.472557469848, 6016.127661488972, 6027.427394397525, 6028.125921741235, 6030.939690603038, 6033.215681961317, 5493.697846618475, 5640.943590564042, 5698.629589076862, 5705.572082093777, 5712.285964254468, 5871.383504731942, 5905.35041145465, 5911.290645122613, 5949.25634295713, 5959.463648271676, 5719.799807006902, 5720.799772007959, 5721.5136713379825, 5723.0, 5726.5418766499415, 5518.392976772632, 5604.243427137284, 5619.49424551776, 5695.45893140151, 5708.714564271853, 5614.157876318422, 5628.85927851807, 5632.915506267491, 5659.405762394889, 5673.687947162945, 5706.743196556248, 5716.399778023248, 5749.683767392834, 5765.336986246635, 5768.682722450306, 5272.578193744568, 5344.5991550634635, 5500.50495455411, 5602.047651899105, 5604.607677462538], "value": 5348.79191626404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.1490625858152, 600.6576251536624, 604.7822783797833, 614.7264467312042, 634.7873462390099, 43455.34816977748, 44347.55652443479, 44628.55371446288, 44663.0, 48150.51849481504, 44932.0, 45409.77295113528, 45429.318560221625, 45461.090778184414, 45489.7725511372, 8952.91047089529, 9073.909260907372, 9086.0, 9104.772380690469, 9105.908940910605, 8881.866771998426, 8975.416597921147, 8981.640734370618, 8985.068210334777, 8989.77525561863, 8996.370254082216, 9115.088491150898, 9116.179543841054, 9117.544122793866, 9121.17909388155, 8998.415103018282, 9010.3242256831, 9017.278617710568, 9022.18800307969, 9024.052474490183, 8919.0, 8964.8655270171, 8978.281737460988, 8992.8651070234, 9027.638894444215, 43094.13811723748, 43341.56658433407, 43449.13101737948, 43476.56523434789, 43528.56471435277, 3443.362977849106, 3964.8414063437717, 4236.068065025689, 4293.0, 4372.978135109336, 33864.83067584671, 33930.83034584836, 34015.489767653504, 34116.0, 34378.6562134378, 4411.941134127786, 4571.3143028545655, 4613.492515823256, 4700.976495117537, 4709.058188362307, 363324.0, 365501.0, 366064.0, 366069.0, 368035.0, 59640.70179649161, 59880.40119598836, 59939.00304984821, 59982.400175998555, 60044.0, 62029.37970620326, 62317.688411557654, 62342.0, 62344.0, 62346.0, 15456.459023934332, 15549.766753498707, 15561.14413707257, 15562.922185389001, 15563.84436155624, 13520.459181632625, 13551.45794168242, 13557.525486607921, 13572.86427135716, 13591.184528928296, 12401.813972790234, 15966.02431593082, 16077.598060048593, 16100.67798644044, 16488.25802838875, 5105.23869265103, 6132.41742034506, 6200.410960958701, 6357.96821015892, 6383.776567820104, 1028.8662473878348, 1028.9691309260734, 1061.43358316058, 1076.956921723138, 1125.5070019905784, 33035.0, 33082.83458582692, 33327.50008749871, 34065.31869362648, 34205.657943420745, 1108.1744100645071, 1113.832925061231, 1123.752774389633, 1140.5551834784442, 1201.4473342262481, 16426.178691065397, 17069.829301707072, 17299.56751081233, 17363.47909562715, 17394.826051739572, 581228.0, 583833.0, 585757.0, 586429.0, 589297.0, 58930.70534647299, 58963.41036589665, 58968.705156473945, 58978.11532827011, 59174.70412647909, 1247.0958555047519, 1301.271288078679, 1364.9863501365057, 1384.6746014686541, 1393.6097892590092, 32678.509822352207, 33799.31003449867, 34897.47653785246, 34933.47599786056, 35055.64944350524, 51528.48471515387, 52030.0, 52056.21915671192, 52085.0, 52098.479015210876, 330657.0, 331168.0, 331872.0, 332302.0928116481, 332794.0, 28088.85955570209, 29637.407251854413, 29679.109626711233, 30967.69032309648, 31029.8448507756, 49517.0, 50866.23700644419, 51539.22691159561, 51932.0, 52477.21284180664, 38778.6122138775, 42747.7862610685, 43561.0, 44160.0, 45795.0, 43325.30625065519, 43594.56405435905, 43608.12783744371, 44718.77640611776, 44844.0, 42614.36078458764, 43086.0, 43266.56733432751, 43374.78312608417, 43563.34654980114, 36239.0, 38850.6114938847, 39274.0, 40131.799341003105, 40210.19579608333, 28528.42943141084, 28810.590611153355, 29399.11802645924, 29406.852965735034, 29458.0], "value": 20434.354971718287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3588719740454, 382.59062802801014, 388.10735308789776, 392.21165457430567, 414.21506245664466, 17482.825171748278, 19966.001699915, 20015.299464518746, 20176.293829715964, 20212.292569760062, 18509.259629614833, 18602.627947441044, 18827.152778124982, 18975.14611842467, 19160.233590656393, 5625.1843482695185, 5709.343425506068, 5837.532997360222, 5925.762969481216, 5930.080837470199, 5769.1923130761725, 5788.5369170466265, 5831.5626328025355, 5835.0663893777, 5838.065909454488, 5601.747921343549, 5779.653220806765, 5797.217375654296, 5803.564732645047, 5830.242068531106, 5800.738966746507, 5829.88340233193, 5841.445062719056, 5844.590878638497, 5847.181394604759, 5169.0954083035695, 5189.455107213726, 5231.686098834082, 5232.659877107976, 5235.502627250406, 24469.021239150414, 24485.63271550928, 24512.529248245162, 24600.630990535155, 24714.876425617756, 2369.609014512603, 2369.9526009479714, 2374.0978428197345, 2435.2450740270397, 2439.1706819681394, 14056.367463464168, 14894.627634309229, 15192.164430956293, 15353.923230383889, 15381.769273460906, 1906.323255244396, 1941.2332128809182, 1946.347973428903, 2011.4468521156798, 2045.457953642286, 89846.99999999935, 90110.549447253, 90228.0, 90288.5485572568, 92081.53959230227, 11172.888271117185, 11176.776464470666, 11318.264312819805, 11322.943385283186, 11490.77018459643, 15900.12549309799, 15908.920455397649, 15943.681126377407, 15951.564359207727, 15952.680946381239, 8160.755177344689, 8237.917620823835, 8479.06730259671, 8505.70230041958, 8519.914800851911, 7968.12350641429, 8002.4798388105755, 8007.119216886138, 8211.466254693545, 8339.24946754795, 4791.353167322367, 4864.426269494802, 4891.945382939174, 4922.212446008622, 4980.800767969313, 1975.4764987278384, 1976.33792679454, 1977.179470519747, 2002.2691717522998, 2031.827294679939, 887.3611000079932, 952.6856137474617, 967.6951760195516, 982.3909176310733, 996.6461906023258, 19070.52323691891, 20663.793362066186, 20711.378658640264, 20886.686699699516, 20922.163113475595, 1015.5125539740966, 1016.3850870223556, 1025.1696126137851, 1037.4397825174321, 1068.7915856407926, 10512.0, 11532.931688946115, 11578.189526733047, 11668.358240296695, 11762.35307058103, 520362.0, 521258.0, 522387.0, 524726.0, 531887.0, 58181.709091455115, 60358.0, 70344.0, 82965.58517207376, 87425.56287218523, 1003.6687892995294, 1011.6661501704419, 1013.5489707080278, 1013.878334599838, 1030.525958059286, 17780.46658600244, 18053.458396248134, 18650.81349186491, 18672.0, 19002.809971900104, 45247.547524524336, 45333.0, 45565.0, 46245.07509849851, 46785.532144678116, 57614.71192644178, 58775.0, 60928.69535652471, 67630.0, 68048.0, 8524.318054555744, 8619.612117454855, 8646.956765216133, 8688.52213128284, 8700.825983480421, 9235.722928312161, 13122.671933201364, 13850.86149138536, 13872.583822485341, 13942.0, 12152.0, 12365.567205147776, 12536.261811523156, 12614.55849045279, 12973.610791676265, 11855.466504007512, 11957.0, 12116.15186936906, 12412.441440135035, 12520.812187817372, 12334.876651233373, 12441.440135193758, 12466.626001219978, 12604.87395126037, 12775.425105870445, 8619.956900215459, 8727.040025597053, 8804.867926980973, 8806.20744133031, 9197.172254497127, 8882.111788821067, 11151.163662725166, 12231.388430578614, 12236.755264894475, 12329.753404932031], "value": 9499.607144480775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.8637243089481, 1461.7880407340936, 1510.2071412508433, 1632.8040635123787, 1775.5117342730748, 8368.372372072095, 8735.519546424945, 8774.4735315881, 8986.550672466383, 8987.59555819988, 8815.471071735685, 8933.910660893389, 8938.86591701125, 8942.508162051085, 8946.507942063185, 2405.8917348719306, 2443.499082688045, 2449.7917676997477, 2453.815963802713, 2454.325060608338, 2388.7252965908883, 2401.0, 2459.2499287717237, 2459.483508463225, 2460.495598402323, 2385.7494963028894, 2406.242033759369, 2421.33413311339, 2430.562498750224, 2443.535728211643, 2364.4207169243646, 2391.270662447953, 2398.352444839892, 2399.5320912422085, 2401.591729406005, 2355.0815182079004, 2360.799332056777, 2390.6414037894283, 2391.9043238270447, 2392.4138586046356, 8727.825443491094, 8800.383973121883, 8906.955465222698, 8920.0, 8930.732078037669, 5289.206619007141, 5513.972430137864, 5518.806841760559, 5522.3649280332875, 5524.116141417354, 3638.0904773806546, 3648.087978005499, 3670.917079461565, 3714.312852122339, 3736.1406876418578, 1214.5020541577999, 1224.2287358963886, 1225.154643296123, 1253.4610117649406, 1272.7072773262203, 12286.13997020209, 12356.382180891009, 12384.442700078518, 12396.876031239752, 12415.44130514129, 4471.642268618502, 4669.299605059268, 4753.714777113384, 4775.498572649891, 4783.990723895972, 9868.309218354647, 9868.851967220497, 9871.901280987242, 9873.901260987299, 9874.60501579943, 5273.762680679379, 5302.787888484495, 5309.0, 5309.123994540934, 5317.229001794718, 4061.3501839706096, 4326.913461730811, 4470.955290447054, 4965.950340496549, 4967.751612419364, 3904.824282907219, 3941.8620348287673, 3998.4202290668272, 4036.9596304037173, 4045.8786236412957, 1210.431097384228, 1230.4524486603555, 1233.3771445420184, 1234.7530493901256, 1237.6348977051612, 847.0724556610502, 941.23759754599, 954.0602506531061, 966.6761634852263, 975.9951200243953, 6008.729607167688, 6094.8171554853425, 6107.633541987495, 6122.448979591858, 6230.6884655767935, 483.4005832767413, 483.95886349660674, 485.42719590882393, 492.3181393769583, 496.39439883342266, 4288.442502474721, 4329.372241025034, 4330.155619654201, 4354.238008348526, 4408.0, 10949.781004380027, 11192.944035279934, 11262.774744505065, 11290.153238507144, 11299.096072314194, 10566.682999510027, 11028.724281893017, 11061.059809916087, 11249.550017999352, 11369.658910232707, 8189.26296633294, 8311.459755115899, 8367.748967531106, 8379.078301386842, 8392.748217553482, 6272.212419460432, 6364.840878978062, 6433.517486188648, 6473.352664733489, 6605.471562275103, 9948.104670579683, 10220.642277520252, 10239.641612543524, 10285.845712314172, 10365.689029329133, 9434.48110353937, 10542.420166890895, 10559.524821382902, 10560.577576896838, 10571.735706607089, 7820.921790782019, 7980.8802867955865, 8047.678092876454, 8226.0540037894, 8245.051819040647, 8757.562121894007, 8768.342374321825, 8770.38607297483, 8800.119988001405, 8888.422252553823, 7922.128565857866, 7986.440949133505, 8024.759257222293, 8033.35733141359, 8264.83470330602, 7836.608169591384, 7850.175731548334, 7915.248051435105, 7981.281684648409, 8002.1997800219515, 7051.471139664648, 7086.362227399559, 7135.714571417086, 7136.0, 7136.964315178391, 5287.920681189862, 5431.728413579226, 5439.265699130567, 5591.27313449249, 5761.0, 5406.75669594877, 5434.375046869661, 5484.1773733938635, 5521.861953451035, 5522.06124958766], "value": 4666.536758754314, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.90052083853993, 331.5408159698817, 337.7382528540382, 337.8260195999061, 340.67976102463666, 5301.469853014697, 5332.733363331832, 5335.226392173133, 5365.275687782153, 5372.462753724625, 5020.569137795729, 5090.516400941905, 5225.8954820903555, 5239.0, 5266.3943646480575, 4114.7119701620895, 4141.295979683446, 4159.563245859179, 4164.791760411982, 4176.248275310458, 4113.457453454955, 4145.896352591194, 4150.439690641755, 4152.8131234094535, 4176.707630465853, 3910.47208626836, 3943.4676318696897, 4053.169100334439, 4084.6732261419015, 4111.424400583921, 4084.4894388201474, 4095.8156882940043, 4102.323116685743, 4106.8973275668195, 4129.339305711072, 3651.5758854046944, 3655.25067361193, 3656.1225305926387, 3657.085728567858, 3677.1358730698266, 5006.3241462402475, 5116.76974536143, 5120.334356533627, 5141.0, 5141.0, 4616.746078965655, 4683.976580117078, 4703.341532185496, 4707.7881495332795, 4735.905281894343, 5430.83707488776, 5434.538064264542, 5434.972825135888, 5459.235707001023, 5459.426760190163, 3760.868369607078, 3914.6885793259294, 3995.2608767377837, 3996.1008773025837, 4001.9399709004388, 5631.042722737145, 5633.380328163898, 5655.915161272585, 5672.631278966854, 5684.857878552986, 4027.81874815634, 4032.899177520527, 4036.5578824811155, 4047.9595204048173, 4083.571225021389, 3952.505936757905, 4149.0, 4156.355764856452, 4162.292410290258, 4168.145530166309, 4700.412448443944, 4702.495201535544, 4704.388429504143, 4714.4106986626675, 4736.8342108026745, 5542.473465020817, 5545.611807173459, 5549.500544950974, 5637.802676906289, 5655.293088363955, 1350.3990724127866, 1412.9222892740997, 1427.457566124866, 1428.0931608428723, 1438.4749566408186, 879.1911441473859, 905.4069584422214, 907.7639813648499, 911.968081117171, 915.4187091197005, 4633.443986721615, 4658.836940707059, 4674.719516828933, 4713.222318317507, 4724.6692731508465, 4541.909161816745, 4930.556249937523, 4973.632251130968, 4999.925001124986, 5049.419316778544, 4668.626509879202, 4679.438467383868, 4696.309328641686, 4696.520596012245, 4705.6470764692785, 2582.4562805636433, 2605.9315680570876, 2615.9346016349364, 2617.6727909011374, 2661.627372167898, 4824.469308376076, 5142.665726727751, 5145.202493613496, 5146.253793199965, 5175.223716442564, 4997.30037794709, 5005.299258103868, 5035.6764535406455, 5059.470264867567, 5079.466656001066, 5051.191809310492, 5071.264666623319, 5107.923381149286, 5110.386753589593, 5114.570578974957, 4746.264329029006, 4841.806327746851, 4919.385076865392, 4984.75076246179, 4995.225740010304, 4887.218045112765, 4898.559129678203, 4913.926291105708, 4915.21356582945, 4940.950590494049, 5082.645454000342, 5103.87240318995, 5124.718140502308, 5138.460461651623, 5146.562542183956, 3576.9821150894077, 3683.318586061587, 3706.4625629283064, 3708.3695771718335, 3713.962860371362, 4920.753962301942, 4959.60323174138, 4960.255961605788, 4962.404511458648, 4985.850424487271, 4786.104406833815, 4813.470518243061, 4830.758462076812, 4856.39295088114, 4875.585575226146, 4544.977485019134, 4796.328514008112, 4827.324174615486, 4833.347498087714, 4870.488598697086, 4769.57073863354, 4774.761261936958, 4782.234842425334, 4786.630617844189, 4792.880177995578, 4838.7338696372035, 4853.441854186673, 4856.834359753563, 4932.580730637936, 4960.975195124146, 4444.8444304449185, 4736.455307639666, 4776.904461910812, 4793.400824896888, 4819.421669399694], "value": 3959.173861358292, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.5630037526919, 748.8427430239649, 756.7616200896717, 782.0185666987936, 801.5070731500127, 15241.390344386225, 15859.444919427822, 16488.752668709963, 16503.669926601477, 16722.665546689088, 14894.776578351333, 14993.325300361483, 15009.02441341312, 15019.399224031025, 15020.924895375509, 664.7108507799098, 822.5928165558042, 835.4277320035765, 838.3293365307729, 838.4591938199858, 685.2154283345566, 696.3245651717825, 696.8014115976947, 795.6697970342329, 827.8675411934062, 876.1676407412951, 883.2757139145903, 883.2889523933231, 883.6067949762358, 883.7569668341193, 876.8377850097688, 879.8988116366636, 880.3177537408495, 881.0220655072897, 881.4094556647062, 508.11841455075415, 518.5177784660265, 520.4249304518528, 639.4820195641545, 640.8654182621655, 14347.21090340031, 14887.0, 14972.47596334134, 15332.463363782213, 15472.226388680634, 15099.54701358961, 15576.532704018897, 16301.021938683598, 16506.75239871403, 16889.577760555963, 12088.456019479145, 12401.62795116148, 12721.173123746927, 12995.956438689173, 13300.667483312898, 3806.5241844769403, 3808.067023579213, 3936.2914675358425, 3939.1333906540804, 3977.4630424892557, 76625.61687191584, 77066.61466692686, 77845.0, 78043.21956780473, 78594.0, 11329.43352832355, 11438.199326047263, 11460.94269528647, 11602.70993225176, 11752.23610465317, 18359.541011474554, 18411.355602554115, 18449.446516604523, 18452.446426607225, 20816.0, 8153.95923020393, 8226.876596851052, 8405.495670259805, 8441.873371899426, 8631.395802293904, 4588.2888152336445, 4693.24908014716, 4739.3601863748645, 4799.912475694541, 4876.902461950741, 3690.1881586051027, 3807.638274363931, 3839.155385815116, 3851.9229615407535, 3856.0359910022494, 592.8369698332993, 608.2640005593282, 609.4271384898182, 617.163743128064, 621.6798348850346, 713.5112447973155, 735.213321745727, 745.392505108335, 763.3587786259569, 769.3729610367533, 9882.357646752938, 10039.799204015879, 10222.795544089076, 10260.897391025994, 10704.518296676668, 630.686107027922, 661.7022339947043, 728.4645785347765, 752.6613024139159, 752.8945947567345, 4931.918936035406, 4996.125678006334, 5104.9749086795955, 5333.599980001438, 5716.171155182476, 69900.30099698938, 119332.8400295985, 125148.37425812813, 128223.0, 128732.0, 62968.0, 64714.35285647083, 79806.6009669948, 103300.48349758203, 107003.0, 93871.0, 95409.0, 97344.0, 98804.5059774711, 100392.4980375108, 10245.334053286513, 10423.635172768916, 10618.20363472758, 10744.247902646739, 10785.460726963463, 52111.218331724296, 53165.0, 53526.73236633792, 53971.73014134904, 54047.45952540424, 49867.75066124791, 65593.67203163954, 69341.65329173523, 70513.0, 72131.0, 12611.81082283748, 13153.145045572008, 13166.868331316564, 13467.595972120853, 13666.248356340098, 14740.852591474377, 15267.847321526642, 15832.28754706018, 15925.761113583074, 15934.36262549485, 14029.719405611626, 14222.288885555474, 14248.35882385316, 14264.429422823387, 14898.25508724581, 13280.933595332348, 13510.256935868621, 13797.51708690191, 14017.929910350384, 14389.712205755617, 13924.51264205748, 14121.788173177205, 14476.927615361856, 14698.853011470177, 15415.383384664488, 11532.769344612892, 11654.766904662029, 11784.528618855149, 11944.701382465508, 12661.556845510362, 10773.892261077603, 11638.825417618911, 11641.825372619249, 11750.121971861989, 11832.0], "value": 7665.798534976611, "unit": "score"}], "name": "dromaeo_css", "value": 7265.318239887004, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0, 109.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 116.0, 122.0, 178.0, 125.0, 120.0, 150.0, 122.0, 149.0, 118.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 161.0, 159.0, 159.0, 161.0, 161.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 126.0, 77.0, 76.0, 74.0, 74.0, 119.0, 75.0], "value": 84.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 121.0, 83.0, 83.0, 84.0, 127.0, 83.0, 83.0, 127.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 48.0, 50.0, 50.0, 50.0, 50.0, 49.0, 48.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 75.0, 75.0, 75.0, 74.0, 75.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 122.0, 122.0, 121.0, 123.0, 126.0, 127.0, 127.0, 158.0, 132.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 160.0, 159.0, 161.0, 159.0, 161.0, 158.0, 172.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 62.0, 66.0, 61.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1481.3, "alertThreshold": 2.0}]} 11:52:22 INFO - Return code: 0 11:52:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:52:22 INFO - # TBPL SUCCESS # 11:52:22 INFO - Running post-action listener: _resource_record_post_action 11:52:22 INFO - [mozharness: 2016-08-03 18:52:22.196031Z] Finished run-tests step (success) 11:52:22 INFO - Running post-run listener: _resource_record_post_run 11:52:22 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7651328; Write bytes: 438362112; Read time: 2772; Write time: 951728 11:52:22 INFO - TinderboxPrint: CPU usage
13.2% 11:52:22 INFO - TinderboxPrint: I/O read bytes / time
7,651,328 / 2,772 11:52:22 INFO - TinderboxPrint: I/O write bytes / time
438,362,112 / 951,728 11:52:22 INFO - TinderboxPrint: CPU idle
8,314.4 (86.8%) 11:52:22 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 11:52:22 INFO - TinderboxPrint: Swap in / out
0 / 0 11:52:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 31326208; Read time: 0; Write time: 23824 11:52:22 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5595136; Write bytes: 362049536; Read time: 2064; Write time: 847300 11:52:22 INFO - Running post-run listener: _upload_blobber_files 11:52:22 INFO - Blob upload gear active. 11:52:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:22 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:52:22 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:52:22 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:52:23 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:52:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:52:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:23 INFO - (blobuploader) - INFO - Done attempting. 11:52:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:32 INFO - (blobuploader) - INFO - Done attempting. 11:52:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:52:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:52:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:33 INFO - (blobuploader) - INFO - Done attempting. 11:52:33 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:33 INFO - Return code: 0 11:52:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f70418ec118e134130c253de97fc1cc34cdffc469f660c6ad3a329ddfe6a9dc44d7bf8f353dc73a7a296649f0628cc751dec2d06c9c7cdfb04b7eaa9ed339c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2e6e69c20bb8c2640d645b51f04810afa9219cc6dd837f383ce4dbb4c01a932a8f4360c5a9d47e3414b11a3b269972be2dd79470dc857eebb541fc3019a9cbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94995d8897b93bc34b1d3808dcc2013ed5db7da7cbeb7b27a75da4af0b857c71397fc33ff405ef9b65af584c8ac59728edebec52ea39a038157cbd912d507961"} 11:52:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:33 INFO - Contents: 11:52:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f70418ec118e134130c253de97fc1cc34cdffc469f660c6ad3a329ddfe6a9dc44d7bf8f353dc73a7a296649f0628cc751dec2d06c9c7cdfb04b7eaa9ed339c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2e6e69c20bb8c2640d645b51f04810afa9219cc6dd837f383ce4dbb4c01a932a8f4360c5a9d47e3414b11a3b269972be2dd79470dc857eebb541fc3019a9cbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94995d8897b93bc34b1d3808dcc2013ed5db7da7cbeb7b27a75da4af0b857c71397fc33ff405ef9b65af584c8ac59728edebec52ea39a038157cbd912d507961"} 11:52:33 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:33 INFO - Copying logs to upload dir... 11:52:33 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.335644 ========= master_lag: -0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-08-03 11:52:33.118654) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 11:52:33.122474) ========= 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=8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098 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/3f70418ec118e134130c253de97fc1cc34cdffc469f660c6ad3a329ddfe6a9dc44d7bf8f353dc73a7a296649f0628cc751dec2d06c9c7cdfb04b7eaa9ed339c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2e6e69c20bb8c2640d645b51f04810afa9219cc6dd837f383ce4dbb4c01a932a8f4360c5a9d47e3414b11a3b269972be2dd79470dc857eebb541fc3019a9cbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94995d8897b93bc34b1d3808dcc2013ed5db7da7cbeb7b27a75da4af0b857c71397fc33ff405ef9b65af584c8ac59728edebec52ea39a038157cbd912d507961"} build_url:https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/DDjb0VZLSx6Irjjh0nqLSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f70418ec118e134130c253de97fc1cc34cdffc469f660c6ad3a329ddfe6a9dc44d7bf8f353dc73a7a296649f0628cc751dec2d06c9c7cdfb04b7eaa9ed339c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2e6e69c20bb8c2640d645b51f04810afa9219cc6dd837f383ce4dbb4c01a932a8f4360c5a9d47e3414b11a3b269972be2dd79470dc857eebb541fc3019a9cbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94995d8897b93bc34b1d3808dcc2013ed5db7da7cbeb7b27a75da4af0b857c71397fc33ff405ef9b65af584c8ac59728edebec52ea39a038157cbd912d507961"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 11:52:33.148176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:52:33.148505) ========= 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=8783db0840cc980e80bb0bd400000236-1470249090.188104-1764215098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 11:52:33.231545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 11:52:33.232010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 11:52:33.232470) ========= ========= Total master_lag: -0.19 =========