builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1470245291.21 results: success (0) buildid: 20160803100122 builduid: 42bfac1807914d42aba4f404a384bf63 revision: 41072825cb0d9bb0914bd211c54bd6dc51a917fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:11.215324) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:11.215796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:11.216094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:11.380306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:11.380701) ========= 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=4300f881736b422476174874000001bc-1470245290.856798-1186217821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 10:28:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-08-03 10:28:12 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:11.509695) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:11.510113) ========= 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=4300f881736b422476174874000001bc-1470245290.856798-1186217821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019210 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:11.559934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:11.560290) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 41072825cb0d9bb0914bd211c54bd6dc51a917fb --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 41072825cb0d9bb0914bd211c54bd6dc51a917fb --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=4300f881736b422476174874000001bc-1470245290.856798-1186217821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 10:28:12,248 truncating revision to first 12 chars 2016-08-03 10:28:12,249 Setting DEBUG logging. 2016-08-03 10:28:12,249 attempt 1/10 2016-08-03 10:28:12,249 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/41072825cb0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 10:28:12,584 unpacking tar archive at: fx-team-41072825cb0d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648083 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:12.224754) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:12.225214) ========= script_repo_revision: 41072825cb0d9bb0914bd211c54bd6dc51a917fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:12.225760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:12.226075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 10:28:12.236496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-03 10:28:12.236792) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1470245290.856798-1186217821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:28:13 INFO - MultiFileLogger online at 20160803 10:28:13 in /builds/slave/test 10:28:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:28:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:28:13 INFO - {'append_to_log': False, 10:28:13 INFO - 'base_work_dir': '/builds/slave/test', 10:28:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:28:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:28:13 INFO - 'branch': 'Fx-Team-Non-PGO', 10:28:13 INFO - 'buildbot_json_path': 'buildprops.json', 10:28:13 INFO - 'config_files': ('talos/linux_config.py',), 10:28:13 INFO - 'default_actions': ('clobber', 10:28:13 INFO - 'read-buildbot-config', 10:28:13 INFO - 'download-and-extract', 10:28:13 INFO - 'populate-webroot', 10:28:13 INFO - 'create-virtualenv', 10:28:13 INFO - 'install', 10:28:13 INFO - 'run-tests'), 10:28:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:28:13 INFO - 'download_minidump_stackwalk': True, 10:28:13 INFO - 'download_symbols': 'ondemand', 10:28:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:28:13 INFO - 'tooltool.py': '/tools/tooltool.py', 10:28:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:28:13 INFO - '/tools/misc-python/virtualenv.py')}, 10:28:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:28:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:28:13 INFO - 'installer_path': 'installer.exe', 10:28:13 INFO - 'log_level': 'info', 10:28:13 INFO - 'log_name': 'talos', 10:28:13 INFO - 'log_to_console': True, 10:28:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:28:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:28:13 INFO - 'opt_config_files': (), 10:28:13 INFO - 'pip_index': False, 10:28:13 INFO - 'sps_profile': False, 10:28:13 INFO - 'sps_profile_interval': 0, 10:28:13 INFO - 'suite': 'dromaeojs', 10:28:13 INFO - 'system_bits': '32', 10:28:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:28:13 INFO - 'title': 'talos-linux64-ix-045', 10:28:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:28:13 INFO - 'use_talos_json': True, 10:28:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:28:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:28:13 INFO - 'work_dir': 'build'} 10:28:13 INFO - [mozharness: 2016-08-03 17:28:13.018317Z] Running clobber step. 10:28:13 INFO - Running pre-action listener: _resource_record_pre_action 10:28:13 INFO - Running main action method: clobber 10:28:13 INFO - rmtree: /builds/slave/test/build 10:28:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:28:13 INFO - Running post-action listener: _resource_record_post_action 10:28:13 INFO - [mozharness: 2016-08-03 17:28:13.474833Z] Finished clobber step (success) 10:28:13 INFO - [mozharness: 2016-08-03 17:28:13.474935Z] Running read-buildbot-config step. 10:28:13 INFO - Running pre-action listener: _resource_record_pre_action 10:28:13 INFO - Running main action method: read_buildbot_config 10:28:13 INFO - Using buildbot properties: 10:28:13 INFO - { 10:28:13 INFO - "project": "", 10:28:13 INFO - "product": "firefox", 10:28:13 INFO - "script_repo_revision": "production", 10:28:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:28:13 INFO - "repository": "", 10:28:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:28:13 INFO - "buildid": "20160803100122", 10:28:13 INFO - "pgo_build": "False", 10:28:13 INFO - "basedir": "/builds/slave/test", 10:28:13 INFO - "buildnumber": 1846, 10:28:13 INFO - "slavename": "talos-linux64-ix-045", 10:28:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:28:13 INFO - "platform": "ubuntu64_hw", 10:28:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:28:13 INFO - "branch": "fx-team", 10:28:13 INFO - "repo_path": "integration/fx-team", 10:28:13 INFO - "revision": "41072825cb0d9bb0914bd211c54bd6dc51a917fb", 10:28:13 INFO - "stage_platform": "linux64", 10:28:13 INFO - "builduid": "42bfac1807914d42aba4f404a384bf63", 10:28:13 INFO - "slavebuilddir": "test" 10:28:13 INFO - } 10:28:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:28:13 INFO - Running post-action listener: _resource_record_post_action 10:28:13 INFO - [mozharness: 2016-08-03 17:28:13.477396Z] Finished read-buildbot-config step (success) 10:28:13 INFO - [mozharness: 2016-08-03 17:28:13.477485Z] Running download-and-extract step. 10:28:13 INFO - Running pre-action listener: _resource_record_pre_action 10:28:13 INFO - Running main action method: download_and_extract 10:28:13 INFO - mkdir: /builds/slave/test/build/tests 10:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:13 INFO - https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:28:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:28:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:28:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:14 INFO - Downloaded 1361 bytes. 10:28:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:28:14 INFO - Using the following test package requirements: 10:28:14 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:28:14 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:28:14 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:28:14 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:14 INFO - u'jsshell-linux-x86_64.zip'], 10:28:14 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:28:14 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:28:14 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:28:14 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:28:14 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:28:14 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:28:14 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:14 INFO - https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:28:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:28:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:28:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:15 INFO - Downloaded 20240759 bytes. 10:28:15 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'] 10:28:15 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 10:28:16 INFO - Return code: 0 10:28:16 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 10:28: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')]} 10:28:16 INFO - https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:28:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:28:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:28:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:17 INFO - Downloaded 20240759 bytes. 10:28:17 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'] 10:28:17 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 10:28:18 INFO - Return code: 0 10:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:18 INFO - https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:28:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:28:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:28:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:19 INFO - Downloaded 14413723 bytes. 10:28:19 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'] 10:28:19 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 10:28:19 INFO - Return code: 0 10:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:19 INFO - https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:28:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:28:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:28:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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 10:28:20 INFO - Downloaded 55632991 bytes. 10:28:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:28:20 INFO - mkdir: /builds/slave/test/properties 10:28:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:28:20 INFO - Writing to file /builds/slave/test/properties/build_url 10:28:20 INFO - Contents: 10:28:20 INFO - build_url:https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:28:21 INFO - Running post-action listener: _resource_record_post_action 10:28:21 INFO - Running post-action listener: set_extra_try_arguments 10:28:21 INFO - [mozharness: 2016-08-03 17:28:21.721729Z] Finished download-and-extract step (success) 10:28:21 INFO - [mozharness: 2016-08-03 17:28:21.721964Z] Running populate-webroot step. 10:28:21 INFO - Running pre-action listener: _resource_record_pre_action 10:28:21 INFO - Running main action method: populate_webroot 10:28:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:28:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:28:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:28:21 INFO - '--tppagecycles', 10:28:21 INFO - '7'], 10:28:21 INFO - 'tests': ['tsvgm']}}, 10:28:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:28:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:28:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:28:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:28:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:21 INFO - 'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:21 INFO - 'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['damp', 'tps']}, 10:28:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:21 INFO - 'tests': ['damp', 'tps']}, 10:28:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['dromaeo_dom']}, 10:28:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:28:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['basic_compositor_video']}, 10:28:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:28:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['a11yr', 10:28:21 INFO - 'ts_paint', 10:28:21 INFO - 'tpaint', 10:28:21 INFO - 'sessionrestore', 10:28:21 INFO - 'sessionrestore_no_auto_restore', 10:28:21 INFO - 'tabpaint']}, 10:28:21 INFO - 'other-e10s': {'tests': ['a11yr', 10:28:21 INFO - 'ts_paint', 10:28:21 INFO - 'tpaint', 10:28:21 INFO - 'sessionrestore', 10:28:21 INFO - 'sessionrestore_no_auto_restore', 10:28:21 INFO - 'tabpaint']}, 10:28:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:28:21 INFO - 'ts_paint', 10:28:21 INFO - 'tpaint', 10:28:21 INFO - 'sessionrestore', 10:28:21 INFO - 'sessionrestore_no_auto_restore', 10:28:21 INFO - 'tabpaint']}, 10:28:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:28:21 INFO - 'ts_paint', 10:28:21 INFO - 'tpaint', 10:28:21 INFO - 'sessionrestore', 10:28:21 INFO - 'sessionrestore_no_auto_restore', 10:28:21 INFO - 'tabpaint']}, 10:28:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['a11yr', 10:28:21 INFO - 'ts_paint', 10:28:21 INFO - 'tpaint', 10:28:21 INFO - 'sessionrestore', 10:28:21 INFO - 'sessionrestore_no_auto_restore', 10:28:21 INFO - 'tabpaint']}, 10:28:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['a11yr', 10:28:21 INFO - 'ts_paint', 10:28:21 INFO - 'tpaint', 10:28:21 INFO - 'sessionrestore', 10:28:21 INFO - 'sessionrestore_no_auto_restore', 10:28:21 INFO - 'tabpaint']}, 10:28:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['tsvgx', 10:28:21 INFO - 'tsvgr_opacity', 10:28:21 INFO - 'tart', 10:28:21 INFO - 'tscrollx', 10:28:21 INFO - 'cart']}, 10:28:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:28:21 INFO - 'tsvgr_opacity', 10:28:21 INFO - 'tart', 10:28:21 INFO - 'tscrollx', 10:28:21 INFO - 'cart']}, 10:28:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:21 INFO - 'talos_options': ['--disable-e10s'], 10:28:21 INFO - 'tests': ['tp5o']}, 10:28:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:21 INFO - 'tests': ['tp5o']}, 10:28:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:21 INFO - 'talos_options': ['--disable-e10s', 10:28:21 INFO - '--xperf_path', 10:28:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:21 INFO - 'tests': ['tp5n']}, 10:28:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:21 INFO - 'talos_options': ['--xperf_path', 10:28:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:21 INFO - 'tests': ['tp5n']}}, 10:28:21 INFO - 'talos.zip': {'path': '', 10:28:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:28:21 INFO - Running post-action listener: _resource_record_post_action 10:28:21 INFO - [mozharness: 2016-08-03 17:28:21.739934Z] Finished populate-webroot step (success) 10:28:21 INFO - [mozharness: 2016-08-03 17:28:21.740024Z] Running create-virtualenv step. 10:28:21 INFO - Running pre-action listener: _resource_record_pre_action 10:28:21 INFO - Running main action method: create_virtualenv 10:28:21 INFO - Creating virtualenv /builds/slave/test/build/venv 10:28:21 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 10:28:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:28:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:28:21 INFO - Using real prefix '/usr' 10:28:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:28:22 INFO - Installing distribute.............................................................................................................................................................................................done. 10:28:24 INFO - Installing pip.................done. 10:28:24 INFO - Return code: 0 10:28:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:24 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 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:24 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 10:28:24 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 10:28:24 INFO - Using env: {'DISPLAY': ':0', 10:28:24 INFO - 'HOME': '/home/cltbld', 10:28:24 INFO - 'LANG': 'en_US.UTF-8', 10:28:24 INFO - 'LANGUAGE': 'en_US:en', 10:28:24 INFO - 'LOGNAME': 'cltbld', 10:28:24 INFO - 'MAIL': '/var/mail/cltbld', 10:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:24 INFO - 'MOZ_NO_REMOTE': '1', 10:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:24 INFO - 'NO_EM_RESTART': '1', 10:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:24 INFO - 'PWD': '/builds/slave/test', 10:28:24 INFO - 'SHELL': '/bin/bash', 10:28:24 INFO - 'SHLVL': '1', 10:28:24 INFO - 'TERM': 'linux', 10:28:24 INFO - 'TMOUT': '86400', 10:28:24 INFO - 'USER': 'cltbld', 10:28:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:24 INFO - '_': '/tools/buildbot/bin/python'} 10:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:24 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 10:28:24 INFO - Cleaning up... 10:28:24 INFO - Return code: 0 10:28:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:24 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 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:24 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 10:28:24 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 10:28:24 INFO - Using env: {'DISPLAY': ':0', 10:28:24 INFO - 'HOME': '/home/cltbld', 10:28:24 INFO - 'LANG': 'en_US.UTF-8', 10:28:24 INFO - 'LANGUAGE': 'en_US:en', 10:28:24 INFO - 'LOGNAME': 'cltbld', 10:28:24 INFO - 'MAIL': '/var/mail/cltbld', 10:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:24 INFO - 'MOZ_NO_REMOTE': '1', 10:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:24 INFO - 'NO_EM_RESTART': '1', 10:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:24 INFO - 'PWD': '/builds/slave/test', 10:28:24 INFO - 'SHELL': '/bin/bash', 10:28:24 INFO - 'SHLVL': '1', 10:28:24 INFO - 'TERM': 'linux', 10:28:24 INFO - 'TMOUT': '86400', 10:28:24 INFO - 'USER': 'cltbld', 10:28:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:24 INFO - '_': '/tools/buildbot/bin/python'} 10:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:24 INFO - Downloading/unpacking psutil>=3.1.1 10:28:24 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 10:28:24 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 10:28:24 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 10:28:24 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 10:28:24 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 10:28:24 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 10:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:28:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:26 INFO - Installing collected packages: psutil 10:28:26 INFO - Running setup.py install for psutil 10:28:26 INFO - building 'psutil._psutil_linux' extension 10:28:26 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 10:28:26 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 10:28:27 INFO - building 'psutil._psutil_posix' extension 10:28:27 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 10:28:27 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 10:28:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:27 INFO - Successfully installed psutil 10:28:27 INFO - Cleaning up... 10:28:27 INFO - Return code: 0 10:28:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:28:27 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')]} 10:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:27 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')]} 10:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:27 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 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:27 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 10:28:27 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 10:28:27 INFO - Using env: {'DISPLAY': ':0', 10:28:27 INFO - 'HOME': '/home/cltbld', 10:28:27 INFO - 'LANG': 'en_US.UTF-8', 10:28:27 INFO - 'LANGUAGE': 'en_US:en', 10:28:27 INFO - 'LOGNAME': 'cltbld', 10:28:27 INFO - 'MAIL': '/var/mail/cltbld', 10:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:27 INFO - 'MOZ_NO_REMOTE': '1', 10:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:27 INFO - 'NO_EM_RESTART': '1', 10:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:27 INFO - 'PWD': '/builds/slave/test', 10:28:27 INFO - 'SHELL': '/bin/bash', 10:28:27 INFO - 'SHLVL': '1', 10:28:27 INFO - 'TERM': 'linux', 10:28:27 INFO - 'TMOUT': '86400', 10:28:27 INFO - 'USER': 'cltbld', 10:28:27 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:27 INFO - '_': '/tools/buildbot/bin/python'} 10:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:28:29 INFO - Installing collected packages: mozsystemmonitor 10:28:29 INFO - Running setup.py install for mozsystemmonitor 10:28:29 INFO - Successfully installed mozsystemmonitor 10:28:29 INFO - Cleaning up... 10:28:29 INFO - Return code: 0 10:28:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:29 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 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:29 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 10:28:29 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 10:28:29 INFO - Using env: {'DISPLAY': ':0', 10:28:29 INFO - 'HOME': '/home/cltbld', 10:28:29 INFO - 'LANG': 'en_US.UTF-8', 10:28:29 INFO - 'LANGUAGE': 'en_US:en', 10:28:29 INFO - 'LOGNAME': 'cltbld', 10:28:29 INFO - 'MAIL': '/var/mail/cltbld', 10:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:29 INFO - 'MOZ_NO_REMOTE': '1', 10:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:29 INFO - 'NO_EM_RESTART': '1', 10:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:29 INFO - 'PWD': '/builds/slave/test', 10:28:29 INFO - 'SHELL': '/bin/bash', 10:28:29 INFO - 'SHLVL': '1', 10:28:29 INFO - 'TERM': 'linux', 10:28:29 INFO - 'TMOUT': '86400', 10:28:29 INFO - 'USER': 'cltbld', 10:28:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:29 INFO - '_': '/tools/buildbot/bin/python'} 10:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:29 INFO - Downloading/unpacking jsonschema==2.5.1 10:28:29 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 10:28:29 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 10:28:29 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 10:28:29 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 10:28:29 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 10:28:29 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 10:28:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:28:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:28:31 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 10:28:31 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 10:28:31 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 10:28:31 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 10:28:31 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 10:28:31 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 10:28:31 INFO - Downloading functools32-3.2.3-2.tar.gz 10:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:28:32 INFO - warning: no files found matching '*.txt' 10:28:32 INFO - no previously-included directories found matching 'build' 10:28:32 INFO - no previously-included directories found matching 'dist' 10:28:32 INFO - no previously-included directories found matching '.git*' 10:28:32 INFO - Installing collected packages: jsonschema, functools32 10:28:32 INFO - Running setup.py install for functools32 10:28:32 INFO - warning: no files found matching '*.txt' 10:28:32 INFO - no previously-included directories found matching 'build' 10:28:32 INFO - no previously-included directories found matching 'dist' 10:28:32 INFO - no previously-included directories found matching '.git*' 10:28:32 INFO - Successfully installed jsonschema functools32 10:28:32 INFO - Cleaning up... 10:28:32 INFO - Return code: 0 10:28:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:28:32 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')]} 10:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:32 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')]} 10:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:32 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 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:32 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 10:28:32 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 10:28:32 INFO - Using env: {'DISPLAY': ':0', 10:28:32 INFO - 'HOME': '/home/cltbld', 10:28:32 INFO - 'LANG': 'en_US.UTF-8', 10:28:32 INFO - 'LANGUAGE': 'en_US:en', 10:28:32 INFO - 'LOGNAME': 'cltbld', 10:28:32 INFO - 'MAIL': '/var/mail/cltbld', 10:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:32 INFO - 'MOZ_NO_REMOTE': '1', 10:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:32 INFO - 'NO_EM_RESTART': '1', 10:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:32 INFO - 'PWD': '/builds/slave/test', 10:28:32 INFO - 'SHELL': '/bin/bash', 10:28:32 INFO - 'SHLVL': '1', 10:28:32 INFO - 'TERM': 'linux', 10:28:32 INFO - 'TMOUT': '86400', 10:28:32 INFO - 'USER': 'cltbld', 10:28:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:32 INFO - '_': '/tools/buildbot/bin/python'} 10:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:28:32 INFO - Cleaning up... 10:28:32 INFO - Return code: 0 10:28:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:28:32 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')]} 10:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:32 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')]} 10:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:32 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 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:32 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 10:28:32 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 10:28:32 INFO - Using env: {'DISPLAY': ':0', 10:28:32 INFO - 'HOME': '/home/cltbld', 10:28:32 INFO - 'LANG': 'en_US.UTF-8', 10:28:32 INFO - 'LANGUAGE': 'en_US:en', 10:28:32 INFO - 'LOGNAME': 'cltbld', 10:28:32 INFO - 'MAIL': '/var/mail/cltbld', 10:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:32 INFO - 'MOZ_NO_REMOTE': '1', 10:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:32 INFO - 'NO_EM_RESTART': '1', 10:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:32 INFO - 'PWD': '/builds/slave/test', 10:28:32 INFO - 'SHELL': '/bin/bash', 10:28:32 INFO - 'SHLVL': '1', 10:28:32 INFO - 'TERM': 'linux', 10:28:32 INFO - 'TMOUT': '86400', 10:28:32 INFO - 'USER': 'cltbld', 10:28:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:32 INFO - '_': '/tools/buildbot/bin/python'} 10:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:32 INFO - Downloading/unpacking blobuploader==1.2.4 10:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:34 INFO - Downloading blobuploader-1.2.4.tar.gz 10:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:28:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:28:34 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 10:28:34 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 10:28:34 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 10:28:34 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 10:28:34 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 10:28:34 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 10:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:28:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:35 INFO - Downloading docopt-0.6.1.tar.gz 10:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:28:35 INFO - Installing collected packages: blobuploader, requests, docopt 10:28:35 INFO - Running setup.py install for blobuploader 10:28:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:28:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:28:35 INFO - Running setup.py install for requests 10:28:35 INFO - Running setup.py install for docopt 10:28:35 INFO - Successfully installed blobuploader requests docopt 10:28:35 INFO - Cleaning up... 10:28:35 INFO - Return code: 0 10:28:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:35 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 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:35 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 10:28:35 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 10:28:35 INFO - Using env: {'DISPLAY': ':0', 10:28:35 INFO - 'HOME': '/home/cltbld', 10:28:35 INFO - 'LANG': 'en_US.UTF-8', 10:28:35 INFO - 'LANGUAGE': 'en_US:en', 10:28:35 INFO - 'LOGNAME': 'cltbld', 10:28:35 INFO - 'MAIL': '/var/mail/cltbld', 10:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:35 INFO - 'MOZ_NO_REMOTE': '1', 10:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:35 INFO - 'NO_EM_RESTART': '1', 10:28:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:35 INFO - 'PWD': '/builds/slave/test', 10:28:35 INFO - 'SHELL': '/bin/bash', 10:28:35 INFO - 'SHLVL': '1', 10:28:35 INFO - 'TERM': 'linux', 10:28:35 INFO - 'TMOUT': '86400', 10:28:35 INFO - 'USER': 'cltbld', 10:28:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:35 INFO - '_': '/tools/buildbot/bin/python'} 10:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:36 INFO - Running setup.py (path:/tmp/pip-AgAzjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:36 INFO - Running setup.py (path:/tmp/pip-VdY2gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:36 INFO - Running setup.py (path:/tmp/pip-Hap2L6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:36 INFO - Running setup.py (path:/tmp/pip-d_wkWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:36 INFO - Running setup.py (path:/tmp/pip-s5yUWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:36 INFO - Running setup.py (path:/tmp/pip-cr0u5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:36 INFO - Running setup.py (path:/tmp/pip-rkYx2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:36 INFO - Running setup.py (path:/tmp/pip-tBcRjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:36 INFO - Running setup.py (path:/tmp/pip-7sSifP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:36 INFO - Running setup.py (path:/tmp/pip-FKgcIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:36 INFO - Running setup.py (path:/tmp/pip-VDAlTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:36 INFO - Running setup.py (path:/tmp/pip-oQcBJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:37 INFO - Running setup.py (path:/tmp/pip-n8ay0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:37 INFO - Running setup.py (path:/tmp/pip-UXaySr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:37 INFO - Running setup.py (path:/tmp/pip-8swQrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:37 INFO - Running setup.py (path:/tmp/pip-8Oxcgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:37 INFO - Running setup.py (path:/tmp/pip-85X3i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:28:37 INFO - Running setup.py install for manifestparser 10:28:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:28:37 INFO - Running setup.py install for mozcrash 10:28:37 INFO - Running setup.py install for mozdebug 10:28:37 INFO - Running setup.py install for mozdevice 10:28:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:28:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:28:37 INFO - Running setup.py install for mozfile 10:28:37 INFO - Running setup.py install for mozhttpd 10:28:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:28:37 INFO - Running setup.py install for mozinfo 10:28:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Running setup.py install for mozInstall 10:28:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Running setup.py install for mozleak 10:28:38 INFO - Running setup.py install for mozlog 10:28:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Running setup.py install for moznetwork 10:28:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Running setup.py install for mozprocess 10:28:38 INFO - Running setup.py install for mozprofile 10:28:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Running setup.py install for mozrunner 10:28:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:28:38 INFO - Running setup.py install for mozscreenshot 10:28:38 INFO - Running setup.py install for moztest 10:28:39 INFO - Running setup.py install for mozversion 10:28:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:28:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:28:39 INFO - Cleaning up... 10:28:39 INFO - Return code: 0 10:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:39 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')]} 10:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:39 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')]} 10:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:39 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 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:39 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 10:28:39 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 10:28:39 INFO - Using env: {'DISPLAY': ':0', 10:28:39 INFO - 'HOME': '/home/cltbld', 10:28:39 INFO - 'LANG': 'en_US.UTF-8', 10:28:39 INFO - 'LANGUAGE': 'en_US:en', 10:28:39 INFO - 'LOGNAME': 'cltbld', 10:28:39 INFO - 'MAIL': '/var/mail/cltbld', 10:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:39 INFO - 'MOZ_NO_REMOTE': '1', 10:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:39 INFO - 'NO_EM_RESTART': '1', 10:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:39 INFO - 'PWD': '/builds/slave/test', 10:28:39 INFO - 'SHELL': '/bin/bash', 10:28:39 INFO - 'SHLVL': '1', 10:28:39 INFO - 'TERM': 'linux', 10:28:39 INFO - 'TMOUT': '86400', 10:28:39 INFO - 'USER': 'cltbld', 10:28:39 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:39 INFO - '_': '/tools/buildbot/bin/python'} 10:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:39 INFO - Running setup.py (path:/tmp/pip-OPtv14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:39 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)) 10:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:39 INFO - Running setup.py (path:/tmp/pip-fJBHS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:39 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)) 10:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:39 INFO - Running setup.py (path:/tmp/pip-TR27xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:39 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)) 10:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:39 INFO - Running setup.py (path:/tmp/pip-mgSMez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:39 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)) 10:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:39 INFO - Running setup.py (path:/tmp/pip-FsDLyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:39 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)) 10:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:39 INFO - Running setup.py (path:/tmp/pip-HlTcQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:39 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)) 10:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:39 INFO - Running setup.py (path:/tmp/pip-PeUx_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:39 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)) 10:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:39 INFO - Running setup.py (path:/tmp/pip-9xDWmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:39 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)) 10:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:39 INFO - Running setup.py (path:/tmp/pip-jef556-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:40 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)) 10:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:40 INFO - Running setup.py (path:/tmp/pip-dbKhFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:40 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)) 10:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:40 INFO - Running setup.py (path:/tmp/pip-FJjRzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:40 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)) 10:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:40 INFO - Running setup.py (path:/tmp/pip-pnxnlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:40 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)) 10:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:40 INFO - Running setup.py (path:/tmp/pip-wU2dv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:40 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)) 10:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:40 INFO - Running setup.py (path:/tmp/pip-jTH9gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:40 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)) 10:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:40 INFO - Running setup.py (path:/tmp/pip-B0iM5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:40 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)) 10:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:40 INFO - Running setup.py (path:/tmp/pip-zfUBZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:40 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)) 10:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:40 INFO - Running setup.py (path:/tmp/pip-tX1vZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:40 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)) 10:28:40 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)) 10:28:40 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)) 10:28:40 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)) 10:28:40 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)) 10:28:40 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)) 10:28:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:42 INFO - Downloading blessings-1.6.tar.gz 10:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:28:42 INFO - Installing collected packages: blessings 10:28:42 INFO - Running setup.py install for blessings 10:28:42 INFO - Successfully installed blessings 10:28:42 INFO - Cleaning up... 10:28:42 INFO - Return code: 0 10:28:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:28:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:42 INFO - Reading from file tmpfile_stdout 10:28:42 INFO - Current package versions: 10:28:42 INFO - argparse == 1.2.1 10:28:42 INFO - blessings == 1.6 10:28:42 INFO - blobuploader == 1.2.4 10:28:42 INFO - docopt == 0.6.1 10:28:42 INFO - functools32 == 3.2.3-2 10:28:42 INFO - jsonschema == 2.5.1 10:28:42 INFO - manifestparser == 1.1 10:28:42 INFO - mozInstall == 1.12 10:28:42 INFO - mozcrash == 0.17 10:28:42 INFO - mozdebug == 0.1 10:28:42 INFO - mozdevice == 0.48 10:28:42 INFO - mozfile == 1.2 10:28:42 INFO - mozhttpd == 0.7 10:28:42 INFO - mozinfo == 0.9 10:28:42 INFO - mozleak == 0.1 10:28:42 INFO - mozlog == 3.3 10:28:42 INFO - moznetwork == 0.27 10:28:42 INFO - mozprocess == 0.23 10:28:42 INFO - mozprofile == 0.28 10:28:42 INFO - mozrunner == 6.12 10:28:42 INFO - mozscreenshot == 0.1 10:28:42 INFO - mozsystemmonitor == 0.3 10:28:42 INFO - moztest == 0.7 10:28:42 INFO - mozversion == 1.4 10:28:42 INFO - psutil == 3.1.1 10:28:42 INFO - requests == 1.2.3 10:28:42 INFO - wsgiref == 0.1.2 10:28:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:42 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 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:42 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 10:28:42 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 10:28:42 INFO - Using env: {'DISPLAY': ':0', 10:28:42 INFO - 'HOME': '/home/cltbld', 10:28:42 INFO - 'LANG': 'en_US.UTF-8', 10:28:42 INFO - 'LANGUAGE': 'en_US:en', 10:28:42 INFO - 'LOGNAME': 'cltbld', 10:28:42 INFO - 'MAIL': '/var/mail/cltbld', 10:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:42 INFO - 'MOZ_NO_REMOTE': '1', 10:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:42 INFO - 'NO_EM_RESTART': '1', 10:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:42 INFO - 'PWD': '/builds/slave/test', 10:28:42 INFO - 'SHELL': '/bin/bash', 10:28:42 INFO - 'SHLVL': '1', 10:28:42 INFO - 'TERM': 'linux', 10:28:42 INFO - 'TMOUT': '86400', 10:28:42 INFO - 'USER': 'cltbld', 10:28:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:42 INFO - '_': '/tools/buildbot/bin/python'} 10:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:43 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)) 10:28:43 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)) 10:28:43 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)) 10:28:43 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)) 10:28:43 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)) 10:28:43 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)) 10:28:43 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)) 10:28:43 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)) 10:28:43 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)) 10:28:43 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)) 10:28:43 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)) 10:28:43 INFO - Cleaning up... 10:28:43 INFO - Return code: 0 10:28:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:28: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')]} 10:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28: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')]} 10:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2565180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, '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': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', '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 10:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:28:43 INFO - Using env: {'DISPLAY': ':0', 10:28:43 INFO - 'HOME': '/home/cltbld', 10:28:43 INFO - 'LANG': 'en_US.UTF-8', 10:28:43 INFO - 'LANGUAGE': 'en_US:en', 10:28:43 INFO - 'LOGNAME': 'cltbld', 10:28:43 INFO - 'MAIL': '/var/mail/cltbld', 10:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:43 INFO - 'MOZ_NO_REMOTE': '1', 10:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:43 INFO - 'NO_EM_RESTART': '1', 10:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:43 INFO - 'PWD': '/builds/slave/test', 10:28:43 INFO - 'SHELL': '/bin/bash', 10:28:43 INFO - 'SHLVL': '1', 10:28:43 INFO - 'TERM': 'linux', 10:28:43 INFO - 'TMOUT': '86400', 10:28:43 INFO - 'USER': 'cltbld', 10:28:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:43 INFO - '_': '/tools/buildbot/bin/python'} 10:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:28:43 INFO - Cleaning up... 10:28:43 INFO - Return code: 0 10:28:43 INFO - Running post-action listener: _resource_record_post_action 10:28:43 INFO - Running post-action listener: _start_resource_monitoring 10:28:43 INFO - Starting resource monitoring. 10:28:43 INFO - [mozharness: 2016-08-03 17:28:43.432232Z] Finished create-virtualenv step (success) 10:28:43 INFO - [mozharness: 2016-08-03 17:28:43.432673Z] Running install step. 10:28:43 INFO - Running pre-action listener: _resource_record_pre_action 10:28:43 INFO - Running main action method: install 10:28:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:43 INFO - Reading from file tmpfile_stdout 10:28:43 INFO - Detecting whether we're running mozinstall >=1.0... 10:28:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:28:43 INFO - Reading from file tmpfile_stdout 10:28:43 INFO - Output received: 10:28:43 INFO - Usage: mozinstall [options] installer 10:28:43 INFO - Options: 10:28:43 INFO - -h, --help show this help message and exit 10:28:43 INFO - -d DEST, --destination=DEST 10:28:43 INFO - Directory to install application into. [default: 10:28:43 INFO - "/builds/slave/test"] 10:28:43 INFO - --app=APP Application being installed. [default: firefox] 10:28:43 INFO - mkdir: /builds/slave/test/build/application 10:28:43 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'] 10:28:43 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 10:28:59 INFO - Reading from file tmpfile_stdout 10:28:59 INFO - Output received: 10:28:59 INFO - /builds/slave/test/build/application/firefox/firefox 10:28:59 INFO - Running post-action listener: _resource_record_post_action 10:28:59 INFO - [mozharness: 2016-08-03 17:28:59.742173Z] Finished install step (success) 10:28:59 INFO - [mozharness: 2016-08-03 17:28:59.742449Z] Running run-tests step. 10:28:59 INFO - Running pre-action listener: _resource_record_pre_action 10:28:59 INFO - Running main action method: run_tests 10:28:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:28:59 INFO - Python 2.7.3 10:28:59 INFO - Return code: 0 10:28:59 INFO - grabbing minidump binary from tooltool 10:28: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')]} 10:28:59 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 0x25633b0>, '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 0x25642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:28:59 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 10:28:59 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 10:28:59 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 10:28:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:28:59 INFO - Return code: 0 10:28:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:28:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:28:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:28:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:28:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:28:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 10:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 10:28:59 INFO - Using env: {'DISPLAY': ':0', 10:28:59 INFO - 'HOME': '/home/cltbld', 10:28:59 INFO - 'LANG': 'en_US.UTF-8', 10:28:59 INFO - 'LANGUAGE': 'en_US:en', 10:28:59 INFO - 'LOGNAME': 'cltbld', 10:28:59 INFO - 'MAIL': '/var/mail/cltbld', 10:28:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:28:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:59 INFO - 'MOZ_NO_REMOTE': '1', 10:28:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:59 INFO - 'NO_EM_RESTART': '1', 10:28:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:59 INFO - 'PWD': '/builds/slave/test', 10:28:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:28:59 INFO - 'SHELL': '/bin/bash', 10:28:59 INFO - 'SHLVL': '1', 10:28:59 INFO - 'TERM': 'linux', 10:28:59 INFO - 'TMOUT': '86400', 10:28:59 INFO - 'USER': 'cltbld', 10:28:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470245290.856798-1186217821', 10:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:59 INFO - '_': '/tools/buildbot/bin/python'} 10:28:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 10:29:00 INFO - mozversion application_buildid: 20160803100122 10:29:00 INFO - mozversion application_changeset: 41072825cb0d9bb0914bd211c54bd6dc51a917fb 10:29:00 INFO - mozversion application_display_name: Nightly 10:29:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:29:00 INFO - mozversion application_name: Firefox 10:29:00 INFO - mozversion application_remotingname: firefox 10:29:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:29:00 INFO - mozversion application_vendor: Mozilla 10:29:00 INFO - mozversion application_version: 51.0a1 10:29:00 INFO - mozversion platform_buildid: 20160803100122 10:29:00 INFO - mozversion platform_changeset: 41072825cb0d9bb0914bd211c54bd6dc51a917fb 10:29:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:29:00 INFO - mozversion platform_version: 51.0a1 10:29:00 INFO - using testdate: 1470245340 10:29:00 INFO - actual date: 1470245340 10:29:00 INFO - starting webserver on 'localhost:38776' 10:29:00 INFO - SUITE-START | Running 2 tests 10:29:00 INFO - TEST-START | dromaeo_css 10:29:00 INFO - operating with platform_type : linux_ 10:29:00 INFO - Initialising browser for dromaeo_css test... 10:29:00 INFO - TEST-INFO | started process 20453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVXz1nO/profile http://localhost:38776/getInfo.html) 10:29:04 INFO - PROCESS | 20453 | __metrics Screen width/height:1600/1200 10:29:04 INFO - PROCESS | 20453 | colorDepth:24 10:29:04 INFO - PROCESS | 20453 | Browser inner width/height: 1024/697 10:29:04 INFO - PROCESS | 20453 | __metrics 10:29:05 INFO - PROCESS | 20453 | 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" 10:29:05 INFO - PROCESS | 20453 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:29:05 INFO - PROCESS | 20453 | console.error: PushService: 10:29:05 INFO - PROCESS | 20453 | stateChangeProcessEnqueue: Error transitioning state 10:29:05 INFO - PROCESS | 20453 | UnknownError 10:29:06 INFO - TEST-INFO | 20453: exit 0 10:29:06 INFO - Browser initialized. 10:29:06 INFO - Running cycle 1/1 for dromaeo_css test... 10:29:06 INFO - TEST-INFO | started process 20532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVXz1nO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:18 INFO - PROCESS | 20532 | RSS: Main: 157249536 10:29:18 INFO - PROCESS | 20532 | 10:30:09 INFO - PROCESS | 20532 | 1470245409195 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] 10:32:22 INFO - PROCESS | 20532 | Cycle 1(1): loaded http://localhost:38776/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38776/tests/dromaeo/cssquery-ext.html) 10:32:23 INFO - PROCESS | 20532 | RSS: Main: 240504832 10:32:23 INFO - PROCESS | 20532 | 10:35:26 INFO - PROCESS | 20532 | Cycle 1(1): loaded http://localhost:38776/tests/dromaeo/cssquery-ext.html (next: http://localhost:38776/tests/dromaeo/cssquery-jquery.html) 10:35:26 INFO - PROCESS | 20532 | RSS: Main: 250531840 10:35:26 INFO - PROCESS | 20532 | 10:38:29 INFO - PROCESS | 20532 | Cycle 1(1): loaded http://localhost:38776/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38776/tests/dromaeo/cssquery-mootools.html) 10:38:29 INFO - PROCESS | 20532 | RSS: Main: 187908096 10:38:29 INFO - PROCESS | 20532 | 10:41:31 INFO - PROCESS | 20532 | Cycle 1(1): loaded http://localhost:38776/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38776/tests/dromaeo/cssquery-prototype.html) 10:41:32 INFO - PROCESS | 20532 | RSS: Main: 192163840 10:41:32 INFO - PROCESS | 20532 | 10:44:35 INFO - PROCESS | 20532 | Cycle 1(1): loaded http://localhost:38776/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38776/tests/dromaeo/cssquery-yui.html) 10:44:36 INFO - PROCESS | 20532 | RSS: Main: 190791680 10:44:36 INFO - PROCESS | 20532 | 10:47:39 INFO - PROCESS | 20532 | Cycle 1(1): loaded http://localhost:38776/tests/dromaeo/cssquery-yui.html (next: http://localhost:38776/tests/dromaeo/cssquery-dojo.html) 10:47:39 INFO - PROCESS | 20532 | RSS: Main: 273334272 10:47:39 INFO - PROCESS | 20532 | 10:47:39 INFO - PROCESS | 20532 | __start_tp_report 10:47:39 INFO - PROCESS | 20532 | _x_x_mozilla_page_load 10:47:39 INFO - PROCESS | 20532 | _x_x_mozilla_page_load_details 10:47:39 INFO - PROCESS | 20532 | |i|pagename|runs| 10:47:39 INFO - PROCESS | 20532 | |0;dojo.html;2682.2489702883177;2682.4500977299654;2714.8642567871602;2716.877740501676;2726.1821453563925;4700.929486057712;4776.140294746944;4809.639277054222;4928.260760885869;4948.925766113512;4825.2279635258365;4859.465458799529;4874.8537543873745;4932.186189278765;4947.356843610334;4410.140022695584;4448.911021779562;4479.977600112011;4492.505824359318;4577.977110114445;4386.078923426085;4542.068875880453;4554.544545545452;4556.54434556545;4609.400777898868;4343.305071188594;4400.361947517592;4474.418325617649;4529.682922195448;4546.863594092182;4383;4428.114377124588;4430.468343798732;4445.977770111129;4518.638508919278;4425.867223983286;4442.64458843295;4444.044530425974;4476.1271552047365;4480.395146655225;4718.551737584959;4865.221564549691;4865.586425153866;4900.779464924087;4914.36113305268;5163.457836927106;5194.948050519484;5207.4792520748;5225.111731005738;5249.47505249472;5283.577313814885;5286.5242128208265;5292.894142117136;5293.788248470057;5298.894022119574;4655.37152484417;4924.60603151747;4929.580985616263;4930.235813448921;4932.753362331869;5338.119210330329;5370.113931201387;5379.408265090837;5439.265699130567;5444;5162.74186290684;5204.713740744295;5208.192730126761;5211.218317252366;5215.843524694265;5259.65812222212;5260.868478287997;5265.420803711589;5310.7610157543;5311.920321195185;4966.925496117561;5141;5183.429822719498;5190.974045129826;5201.349831271091;5184.507471790174;5186.170212765939;5195.532402083831;5199.766010529535;5236.764345604457;4398.076403955141;4400.383946247528;4400.713953593006;4404.361367601679;4412.713173643703;3750.8499660013294;3780.281746468162;3813.3707938189887;3839.404892241651;3860.189360234326;4483.237849565582;4500.617447516932;4531.546845315508;4542.88642783933;4544.272916333371;5264.499872512105;5272.551833094153;5275.920861187085;5287.3126493556365;5290.470952904679;4333.631641310524;4391.429114215131;4426.159029784395;4506.909861802746;4538.341940418687;4635.119327327797;4641.466231383367;4654.813807447664;4669.95330046702;4680.789364478606;4910.656254062253;4914.926276105933;4917.237828136645;4919.385076865392;4959.70241785494;5036.748162591929;5199.48005199477;5224.190250511177;5236.423993360803;5289.7619607117;4912.901741965212;4941.604671626334;4945.50544945517;4972.676776009548;5003.3495645565845;5169.9143179932635;5174.870628234174;5187.221916712523;5189.662671926313;5216.739163041757;5003.899922001612;5094.898102037864;5213.973930130325;5226.790928362975;5232.084385232645;5004.4495105537635;5035.92446113316;5044.772985215747;5088.414832294334;5093.388793344822;4983.202687569971;5013.548780609763;5014.824481143142;5025.597952163891;5071.239314102914;4771.95228047729;4949.307097006494;4957.6281778866005;4965.1807451770055;4995.525425084611;5082.745862706924;5149.613778966517;5156.329677142097;5177.119889618699;5211.9478805212975;5020.397552293748;5027.346444962278;5031.371078615173;5038.244263360525;5083.339165908408 10:47:39 INFO - PROCESS | 20532 | |1;ext.html;561.9971900140499;562.3195932921163;584.9616929949342;584.9619774714644;596.7165596341736;38311.425328620055;40330.19339613206;40452.59547404525;44154.55845441545;44245.77877110618;39497;40187.39718904219;40270.59729402705;40364;40364.38542458305;7586.772396828104;7777;7789.688412463494;7791.142974272825;7795;7755.883661745078;7839.490433121829;7840.333571646417;7855.921440785604;7858.960705196495;7833.099193592753;7878.212178782133;7886.960565197166;7887.8422431551335;7888.645010974491;7791.961040194791;7833.960830195812;7835.0989636191425;7841.843163136762;7843.490173138756;7694.307512323918;7821.608919554;7833.255840695125;7834.020747406575;7844.843103137962;38236;38627.420588691195;38668.226635467414;38682.226355473016;38698.613013869784;3233.87064517419;3243.448613735647;3251.3822373748912;3350.2461946062185;3463.809490478023;28927.56608650872;29229.26926826825;29505.557416638767;29709.40581188386;29864.70135298641;3335.93328133436;3363.323802252527;3381.188514756441;3398.6941175294096;3440.397930362177;233692;234309;234507;235704;235972;51203.48796511987;51219.74390128026;51587.48412515827;51659;51836.740816296435;32869.3426131476;33427;33623;35737.46393804095;35825.64174358223;13373.93313033448;13656.590302290948;13664.863351366557;13668.863311366758;13671.974601904896;9705.854412183822;9813.705588832347;9814.969428210077;9823.607055717834;9826.508674566243;18208.635827283644;18322.450326490227;18400.631987360444;18419.171137298585;18446.538836529195;6682.732690692415;6747.527673062838;6807.625580593016;6821.2155602106395;6863.759768408082;820.4420993724325;906.2704522859161;919.5907821019582;951.8952915179325;963.7012526116927;28113.297167570567;28272.293192669935;28538.28654283618;28884.566731498624;29118.272043198667;931.5854444772011;942.6512190489562;945.2910317262053;965.16513216069;965.3001573859036;14973.251337433085;15501.612459688598;16240.918795405947;16989;17171.914140429468;382481;473735;482475;482986;733947;50392.49607503951;51020.74489627528;51127;51248.23127653088;51435.7428212864;1190.9020960857051;1215.3254943506438;1223.4494477485168;1229.7479016801535;1233.1552886272932;27313.590296145972;27840.582391263742;28468.85765571159;29079;29325;48575;49029.26456103232;49199;49253.26120108273;49294.75352623214;376992;379367;380680;381742;381925;39280.41079383869;39609;40206.79896600615;40230.1953960925;40544.79727601343;41599.168016640106;41853;42867.785661071495;43875;44317;33608.83195584006;36741.816290918374;37167.442488362154;37673.246535068596;37830.62169378271;36211.27577448489;36293.27413451769;36554;36727.08182295357;37415.064623384635;31334.216644584067;32218.83890580532;34206.82896585601;36019.459708103874;36629.26741465209;31551.684483154873;33453.33093338071;33804.492932605535;34007.82996085103;34037;25141.74858251394;25744.61383079218;25811.354716132246;25973.610395844455;26092.217233483025 10:47:39 INFO - PROCESS | 20532 | |2;jquery.html;334.5984818218139;356.2767581808929;364.99087522811936;365.83537408166325;390.11833256839554;12994.28531430771;16424.50726478206;16742.24659890305;17283.567910802238;18312.542186445346;15082.622934426618;15308.004979676312;15472.303746331414;15541.222938853069;15663.530094097167;4393.450818647669;4932.753362331896;5133.024725302199;5137.2037334213255;5180.808414064767;3656.3784156693428;3822.1591249924973;5025.472325405834;5415.675059496423;5656.519195868356;5733.799317023905;5741.511971482408;5744.540436765049;5746.310442746876;5747;5521.889562208753;5938.792142275043;5964.880702385972;5970.194023806774;6035.3059398169335;5122.154844450662;5272.551833094191;5275.551578115865;5277.973610131963;5282.234076058989;21073.894630526902;21236.681449778265;21266.25568105109;21342.253021144184;21358.893205534026;1894.384325094336;2010.507425680703;2061.3506745375157;2285.9428514287274;2491.377155711072;12917.483300667962;13374.598762037154;13400.463981440827;13616.455341786317;14030.579082627537;1721.4405318271486;1797.4607617714764;1818.1272988965238;1839.448165550343;1866.673332166879;65520.67239663771;68872.31127688709;69122;69759.65120174366;70301.64849175721;8810.515421651742;9082.818343633222;9090.681826136053;9095.772605684911;10149.543270552844;13014.804777928339;13015.47938082485;13025.609231723063;13666.11170273929;13687.863121368859;6737.764178253836;6958.338957799001;6974.232834388214;7003.614801185984;7009.0537777399395;6396.1045453636525;6428.871422571616;6437.420632143036;6603.141591593062;6630.270670226271;5901.616394934315;5948.196993405922;5964.105384192319;6027.186329845503;6068.696565171812;1546.6829299993474;1724.094850203628;1769.4691592522192;1794.1477798045823;1810.4568629411388;743.7508434674445;874.0647507167397;885.0972008551241;900.9189172974463;995.0845222395413;17230.396936107176;18098.457046288633;18299.359522416653;18307.54231144232;18612.44162675122;868.3183700794846;874.33113668044;878.4114643189079;885.3183049052323;898.1108702384723;10156.695299141038;10497.26519143668;10500.107490863362;10531.15750739939;10541.631042913461;370935;372480;383546;398758;401230;67170;69465.65267173632;69513.65243173752;69839.65080174567;71447;892.830362231174;907.3784457646533;928.4522131942186;930.8603709443638;932.4358762948455;11531.365774882463;15187;15717.764233536735;17073.231704573573;17103.504677557637;40089.59910400975;40361.59638403579;40737.79631101825;40918;41594;54559.33116507233;54905.72547137239;55189;55407.722961384934;56902.715486422305;7529.736459223901;7571.46999710015;7574.583397913168;7599.772006839804;7709.190534993745;11470.655880323604;11504.942475287904;11806.881931180578;11924.642260732191;12019.519219231133;9356.111169438893;9804.852927205955;9877.753056173653;9921.950390248003;10201.438920859424;10406.427646479517;10625.468726563795;10773.89226107729;10859.131269498579;11090.500927458444;9914.454704991294;10110.241731869992;10179.694609161737;10232.386056836614;10517.263791534519;7475.476716629783;7603.543787372775;7665.42509311815;7676.193999629959;7894.131645519104;9250.768730781785;9934.652287169914;10043.849342259726;10262.281640285108;10262.743431414274 10:47:39 INFO - PROCESS | 20532 | |3;mootools.html;1374.292239496659;1403.2702994442889;1475.137044828775;1668.0992264177344;1676.2708221923465;7307;7912.723054693072;7918.524888506694;7919.722809701661;7924;6607.636579988099;6762.763303284386;6765.830854228647;6987.30126987301;7739.342155916754;1873.054107675622;2075.3358925143884;2143.4641339665086;2150.5268840854988;2178.6949827024227;2198.2855571939185;2203.636399993999;2206.5476577301615;2207.9116835326568;2208.6686996950425;2103.842211834111;2208.293346129239;2209.933701988935;2210.9447263818374;2211.6240239159383;2115.0482282972725;2133.978660213409;2137.1665050630268;2137.4015275722822;2144.9678254826267;2094.979050209494;2118.5233322502313;2133.3066753305084;2136.2950226425396;2137.422895818136;7748.496347737436;7880.960595197044;7881.4877032993245;7887.369010479148;7894.526328420313;4222.387753775716;4310.956890431087;4343.1747967886;4344.304911214223;4345.1961387143165;2790.8465034423098;2872.1096460097438;2921.269682579355;2921.576371426131;2928.341123247252;881.7487016200353;893.7988952485704;894.9060348663427;898.5507246376811;908.42315129893;10317.329373590692;10420.739481512872;10438.425886576235;10446.164306855433;10462.058414742709;3807.600201978808;4018.3570628699854;4068.613481719232;4194.140201258735;4194.475690538683;8934.776630584158;8967.551622418852;8968.013518512958;8971.596278167499;8975.192232698957;4260.318349064197;4279.828806847691;4280.208161490134;4283.485981682218;4287.7641729705165;3806.1626442182674;3817.751846129993;3836.961630383716;3849.8845034649007;3851.287511810324;3564.3584154851856;3656.4149736042104;3674.0998455378603;3685.1339935115225;3690.9815450922574;1157.8190245949086;1168.696139003865;1180.167981572989;1184.9822252666218;1213.3811756004502;698.1761521404791;702.543346824558;757.0158793568339;820.5158956215741;834.9123342049119;5141;5189.662671926313;5203.505666961632;5250.842474725764;5314.12316967696;786.7364432914923;841.4824882697097;853.470848074198;854.6410507586828;900.1763386501278;3597.6042635310096;3613.2954073955325;3626.818659067089;3631.1829838286176;3666.211764470652;9172.12864777845;9675.467849268358;9693.70918872435;9717.222622190207;9721.319507634398;9359.812803743887;9636.46999415039;9637.277204209713;9714.854277185848;9737.951310243403;7268.927310726931;7334.89289208753;7412.18465968743;7415.85168296631;7420.072490938633;5319.38827034896;5341.145416733304;5365.114756065205;5383.488568585978;5422.29510163692;8753.080926502626;8892.599833007402;8892.64429422816;8927.33045021613;9006.189442950166;8446.957765211135;8638.697645582375;8873.378863479495;9147.86278205814;9172.954135229282;5983.910241346296;6469.320721324193;6538.1827271591055;6628.171478565179;6640.966795166187;7438.330550250504;7464.813379665552;7471.589062601392;7494.400447964041;7503.474756767192;6543.738250469928;6605.174353205849;6622.834429139118;6635.4359879410795;6874.140732408449;6464.644444555594;6498.155239818793;6517;6607.900881486686;6662.367075127855;6192.349803270772;6402.231732192166;6404.9039264412;6407.359264073555;6420.101185834081;4470.552944705503;4563.338315944103;4632.166210082218;4636.884077898079;4692.296155576691;4550.704204226715;4640.512746161605;4648.7443190624845;4684.1334353144775;4876.195427754381 10:47:39 INFO - PROCESS | 20532 | |4;prototype.html;276.67628874217166;284.54756936471006;287.5499842746103;289.7392346887801;293.1177156758158;4669.789859456324;4802.063597598461;4817.421909370876;4867.707937523746;4881.682690625107;4565.7444202844235;4700.6004489618335;4762.952370476303;4795.808167673289;4827.7586120694;3794.1083845296334;3807.333716599591;3808.447775072613;3823.9808800955957;3824.4836947012213;3561.394562924309;3627.727920405967;3807.676347510465;3830.923381532368;3831.1188426661884;3752.305823422662;3754.4556039374274;3756.948054544718;3758.191988722424;3784;3752.587215406303;3771.4348545353646;3776.6404094525947;3778.8866334009886;3793.791341476204;3319.850606722703;3323.6344002159744;3323.933521329584;3325.1687078230443;3325.933481330384;4576.267797152473;4683.859484215479;4687.742174180418;4728.66899317048;4764.4520880098535;4257.87226383209;4267.957320426818;4274.145170965789;4292.613664770154;4308.80610372534;4982.451930287665;4991.527499387653;5016.774245158977;5033.597312215014;5056.949430505685;3473.7915725056323;3632.273545290926;3633.2370202257557;3644.5444319460066;3651.963480365189;5228.294180285651;5247.737613119367;5251.343582052244;5254.238135470336;5256.6332753483985;3722.758020728644;3723.404255319136;3727.4036154215196;3732.2908647356917;3735.9626403735615;3658.2683463307444;3701.981490092532;3731.8134093295225;3819.598942111094;3823.044238940265;4257.531671516131;4275.294576394922;4275.722078064916;4277.272863613193;4297.67767417445;5012.67417617861;5020.899582008339;5024.673396229234;5033.748312584429;5085.440601533828;1252.6242127361754;1264.6585421936027;1284.5183056353867;1286.3246795432474;1296.5786119511008;877.3244601656688;883.3507372081515;901.193431878465;904.9819003620022;911.6444586611227;4398.3842262083335;4416.343871048357;4416.558344165558;4428.867133985986;4450.1989641864775;5111.693298402108;5112.156494178494;5132.384113906281;5148.871278218;5171.870703232449;4431.62331201845;4432.667549933768;4451.621612163002;4459.710118842265;4464.754438505914;2325.8023068039406;2410.349205714447;2428.9757102429103;2432.586460301753;2435.076289731128;4361.389405483234;4371.759553224603;4392.802323895432;4412.433586076961;4437.334399839985;4646.279826626878;4679.134360143385;4680.602148817388;4686.859394218179;4707.835225767081;4051.5745846685672;4323.221820072355;4339.82640694375;4352.608265256142;4361.5856493633055;4548.226801443696;4558.925688811649;4568.314752787109;4592.380028696217;4622.537746225351;4472.306792447176;4505.549445055468;4507.414036175276;4551.726896386227;4558.612517936012;4127.463429754112;4329.567043295645;4338.891527711706;4343.391925130421;4350;3360.243945112428;3390.525326454249;3402.1834759658;3410.9147271318416;3423.606285277225;4604.8388306409115;4607.7004994675235;4642.605378542727;4661.184292748823;5003.774830132726;4874.805007799649;5011.817495890064;5037.269595908646;5060.569851562658;5065.5816371414585;4997.800087996439;5025.874353141201;5028.798848046184;5035.482258870565;5038.647294689483;4740.928886066643;4949.653524253267;4977.800887964586;4996.200607902718;5018.498150185098;5031.974840125922;5043.672161309503;5047.217681259411;5047.697138171721;5060.544550990428;4946.233333833262;4954;5000.474950130184;5011.624128190328;5029.421616514148 10:47:39 INFO - PROCESS | 20532 | |5;yui.html;629.1694962649302;688.696973331734;693.6046453521495;699.8775214337492;707.1019804847843;12464.81302780458;13407.731845363087;13412.932935335322;13423.530176443826;13446.260455674934;13663.385147668354;13853.099548529364;13860.861391386083;13862.237576933265;13870.653233669163;628.7013668507468;747.55146911853;767.6238643064886;768.9884651730229;785.6464590934074;780.5940910726418;790.5651891459703;790.8853216283635;791.9247671471201;792.2869417524216;838.0948575538404;840.6889450903175;841.1168273313027;842.7640260726976;843.0515669871395;661.3948237362807;799.7400844725488;805.524740403165;837.3970741066422;837.694241601814;608.2305883057935;608.9451949324538;608.9939100608982;609.5245708347496;609.576344440614;12459.19015264014;12488.12583119182;12517.93741031289;12520.186187897849;12524.248545087325;12465.252084874937;13120.343982800821;13510.594682159453;13544.93227533856;13831.861681383258;11867.58463453775;12050.276983381025;12094.818577721342;12178.330191839445;12496.437660305217;4105.774182419966;4132.896677583054;4152.418661387408;4160.5007399112;4337.522872484024;65285;67553;69350.30649693489;70017.29982700158;70491;9800.11798938099;10215.7446063849;10410.323328983592;10551.736206594896;10603.575856965635;17494.912525437547;17673.558161046076;17727.29090836378;17734.556636084202;17737.645247094984;6586.571872828346;6628.933710662832;6668.733250670016;6833.111695479556;6997.230304666483;3745.3258413485833;3775.188334508039;3842.7502212356108;3885.261800257942;3913.8238779255003;2753.3942532642786;2866.2834291427143;3123.5002399616405;3281.5898012748407;3310.708823558814;536.3992328592002;536.7987004873172;544.0560627311611;547.9315085614298;549.8185598752402;492.6009931955128;542.0135353656308;551.9843487982132;563.9492445679908;587.6444750925629;7699.153093159748;8057.798555036171;8221.671133154727;8549.871751923725;8584.570771461402;482.5729229631731;515.7550163672225;520.3599572525738;537.3981141121968;566.9489745922805;3709.573399059089;3871.1870507193244;3987.6610488108836;4109;4170.562090980464;73350;95273;97301;99208;100406;84771.5761421189;87920.56039719889;91453;91572.54213729022;92654;76031;77384;77697.99999999886;78310.6084469574;78606;7225.819354516179;7334.926650733424;7369.373603243785;7538.886916696144;7617.809554760954;45881;46600.7669961648;47635;47832.76083619559;48214.517854821;37887.62112378951;67851;68123.65938170278;68800.31199687939;69196;10168.593256269667;10198.541065651914;10430.582776688847;10691.732706682084;11044.558217671203;10716.767571729351;10785.784284314426;11222.326660400402;11243.212975091665;11302.152338574804;10787.730306742395;10998.890011099787;11174.385408802595;11259.155563332946;11271.79753510599;10635.734106647396;10996.835047474455;11048.834267485834;11179.10567154642;11324.150688698215;10483.21375896826;10780.730481738019;10816.08063314627;10990.285631433931;11113.277636953571;8923.910760892308;9268.629254829732;9399.906000939904;9885.060919212663;9944.751381215527;8380.748577542683;9214.815703685754;9514.666986655433;9558.665446709332;9708.515832020039 10:47:39 INFO - PROCESS | 20532 | __end_tp_report 10:47:39 INFO - PROCESS | 20532 | __start_cc_report 10:47:39 INFO - PROCESS | 20532 | _x_x_mozilla_cycle_collect,1041 10:47:39 INFO - PROCESS | 20532 | __end_cc_report 10:47:39 INFO - PROCESS | 20532 | __startTimestamp1470246459301__endTimestamp 10:47:39 INFO - PROCESS | 20532 | 10:47:39 INFO - PROCESS | 20532 | ------- Summary: start ------- 10:47:39 INFO - PROCESS | 20532 | Number of tests: 6 10:47:39 INFO - PROCESS | 20532 | 10:47:39 INFO - PROCESS | 20532 | [#0] dojo.html Cycles:165 Average:4816.82 Median:4948.93 stddev:519.20 (10.5%) stddev-sans-first:493.05 10:47:39 INFO - PROCESS | 20532 | Values: 2682.2 2682.5 2714.9 2716.9 2726.2 4700.9 4776.1 4809.6 4928.3 4948.9 4825.2 4859.5 4874.9 4932.2 4947.4 4410.1 4448.9 4480.0 4492.5 4578.0 4386.1 4542.1 4554.5 4556.5 4609.4 4343.3 4400.4 4474.4 4529.7 4546.9 4383.0 4428.1 4430.5 4446.0 4518.6 4425.9 4442.6 4444.0 4476.1 4480.4 4718.6 4865.2 4865.6 4900.8 4914.4 5163.5 5194.9 5207.5 5225.1 5249.5 5283.6 5286.5 5292.9 5293.8 5298.9 4655.4 4924.6 4929.6 4930.2 4932.8 5338.1 5370.1 5379.4 5439.3 5444.0 5162.7 5204.7 5208.2 5211.2 5215.8 5259.7 5260.9 5265.4 5310.8 5311.9 4966.9 5141.0 5183.4 5191.0 5201.3 5184.5 5186.2 5195.5 5199.8 5236.8 4398.1 4400.4 4400.7 4404.4 4412.7 3750.8 3780.3 3813.4 3839.4 3860.2 4483.2 4500.6 4531.5 4542.9 4544.3 5264.5 5272.6 5275.9 5287.3 5290.5 4333.6 4391.4 4426.2 4506.9 4538.3 4635.1 4641.5 4654.8 4670.0 4680.8 4910.7 4914.9 4917.2 4919.4 4959.7 5036.7 5199.5 5224.2 5236.4 5289.8 4912.9 4941.6 4945.5 4972.7 5003.3 5169.9 5174.9 5187.2 5189.7 5216.7 5003.9 5094.9 5214.0 5226.8 5232.1 5004.4 5035.9 5044.8 5088.4 5093.4 4983.2 5013.5 5014.8 5025.6 5071.2 4772.0 4949.3 4957.6 4965.2 4995.5 5082.7 5149.6 5156.3 5177.1 5211.9 5020.4 5027.3 5031.4 5038.2 5083.3 10:47:39 INFO - PROCESS | 20532 | 10:47:39 INFO - PROCESS | 20532 | [#1] ext.html Cycles:180 Average:52282.26 Median:38690.42 stddev:106077.39 (274.2%) stddev-sans-first:106303.88 10:47:39 INFO - PROCESS | 20532 | Values: 562.0 562.3 585.0 585.0 596.7 38311.4 40330.2 40452.6 44154.6 44245.8 39497.0 40187.4 40270.6 40364.0 40364.4 7586.8 7777.0 7789.7 7791.1 7795.0 7755.9 7839.5 7840.3 7855.9 7859.0 7833.1 7878.2 7887.0 7887.8 7888.6 7792.0 7834.0 7835.1 7841.8 7843.5 7694.3 7821.6 7833.3 7834.0 7844.8 38236.0 38627.4 38668.2 38682.2 38698.6 3233.9 3243.4 3251.4 3350.2 3463.8 28927.6 29229.3 29505.6 29709.4 29864.7 3335.9 3363.3 3381.2 3398.7 3440.4 233692.0 234309.0 234507.0 235704.0 235972.0 51203.5 51219.7 51587.5 51659.0 51836.7 32869.3 33427.0 33623.0 35737.5 35825.6 13373.9 13656.6 13664.9 13668.9 13672.0 9705.9 9813.7 9815.0 9823.6 9826.5 18208.6 18322.5 18400.6 18419.2 18446.5 6682.7 6747.5 6807.6 6821.2 6863.8 820.4 906.3 919.6 951.9 963.7 28113.3 28272.3 28538.3 28884.6 29118.3 931.6 942.7 945.3 965.2 965.3 14973.3 15501.6 16240.9 16989.0 17171.9 382481.0 473735.0 482475.0 482986.0 733947.0 50392.5 51020.7 51127.0 51248.2 51435.7 1190.9 1215.3 1223.4 1229.7 1233.2 27313.6 27840.6 28468.9 29079.0 29325.0 48575.0 49029.3 49199.0 49253.3 49294.8 376992.0 379367.0 380680.0 381742.0 381925.0 39280.4 39609.0 40206.8 40230.2 40544.8 41599.2 41853.0 42867.8 43875.0 44317.0 33608.8 36741.8 37167.4 37673.2 37830.6 36211.3 36293.3 36554.0 36727.1 37415.1 31334.2 32218.8 34206.8 36019.5 36629.3 31551.7 33453.3 33804.5 34007.8 34037.0 25141.7 25744.6 25811.4 25973.6 26092.2 10:47:39 INFO - PROCESS | 20532 | 10:47:39 INFO - PROCESS | 20532 | [#2] jquery.html Cycles:180 Average:24306.69 Median:22993.73 stddev:63583.39 (276.5%) stddev-sans-first:63736.28 10:47:39 INFO - PROCESS | 20532 | Values: 334.6 356.3 365.0 365.8 390.1 12994.3 16424.5 16742.2 17283.6 18312.5 15082.6 15308.0 15472.3 15541.2 15663.5 4393.5 4932.8 5133.0 5137.2 5180.8 3656.4 3822.2 5025.5 5415.7 5656.5 5733.8 5741.5 5744.5 5746.3 5747.0 5521.9 5938.8 5964.9 5970.2 6035.3 5122.2 5272.6 5275.6 5278.0 5282.2 21073.9 21236.7 21266.3 21342.3 21358.9 1894.4 2010.5 2061.4 2285.9 2491.4 12917.5 13374.6 13400.5 13616.5 14030.6 1721.4 1797.5 1818.1 1839.4 1866.7 65520.7 68872.3 69122.0 69759.7 70301.6 8810.5 9082.8 9090.7 9095.8 10149.5 13014.8 13015.5 13025.6 13666.1 13687.9 6737.8 6958.3 6974.2 7003.6 7009.1 6396.1 6428.9 6437.4 6603.1 6630.3 5901.6 5948.2 5964.1 6027.2 6068.7 1546.7 1724.1 1769.5 1794.1 1810.5 743.8 874.1 885.1 900.9 995.1 17230.4 18098.5 18299.4 18307.5 18612.4 868.3 874.3 878.4 885.3 898.1 10156.7 10497.3 10500.1 10531.2 10541.6 370935.0 372480.0 383546.0 398758.0 401230.0 67170.0 69465.7 69513.7 69839.7 71447.0 892.8 907.4 928.5 930.9 932.4 11531.4 15187.0 15717.8 17073.2 17103.5 40089.6 40361.6 40737.8 40918.0 41594.0 54559.3 54905.7 55189.0 55407.7 56902.7 7529.7 7571.5 7574.6 7599.8 7709.2 11470.7 11504.9 11806.9 11924.6 12019.5 9356.1 9804.9 9877.8 9922.0 10201.4 10406.4 10625.5 10773.9 10859.1 11090.5 9914.5 10110.2 10179.7 10232.4 10517.3 7475.5 7603.5 7665.4 7676.2 7894.1 9250.8 9934.7 10043.8 10262.3 10262.7 10:47:39 INFO - PROCESS | 20532 | 10:47:39 INFO - PROCESS | 20532 | [#3] mootools.html Cycles:180 Average:5063.77 Median:5330.27 stddev:2846.05 (53.4%) stddev-sans-first:2840.53 10:47:39 INFO - PROCESS | 20532 | Values: 1374.3 1403.3 1475.1 1668.1 1676.3 7307.0 7912.7 7918.5 7919.7 7924.0 6607.6 6762.8 6765.8 6987.3 7739.3 1873.1 2075.3 2143.5 2150.5 2178.7 2198.3 2203.6 2206.5 2207.9 2208.7 2103.8 2208.3 2209.9 2210.9 2211.6 2115.0 2134.0 2137.2 2137.4 2145.0 2095.0 2118.5 2133.3 2136.3 2137.4 7748.5 7881.0 7881.5 7887.4 7894.5 4222.4 4311.0 4343.2 4344.3 4345.2 2790.8 2872.1 2921.3 2921.6 2928.3 881.7 893.8 894.9 898.6 908.4 10317.3 10420.7 10438.4 10446.2 10462.1 3807.6 4018.4 4068.6 4194.1 4194.5 8934.8 8967.6 8968.0 8971.6 8975.2 4260.3 4279.8 4280.2 4283.5 4287.8 3806.2 3817.8 3837.0 3849.9 3851.3 3564.4 3656.4 3674.1 3685.1 3691.0 1157.8 1168.7 1180.2 1185.0 1213.4 698.2 702.5 757.0 820.5 834.9 5141.0 5189.7 5203.5 5250.8 5314.1 786.7 841.5 853.5 854.6 900.2 3597.6 3613.3 3626.8 3631.2 3666.2 9172.1 9675.5 9693.7 9717.2 9721.3 9359.8 9636.5 9637.3 9714.9 9738.0 7268.9 7334.9 7412.2 7415.9 7420.1 5319.4 5341.1 5365.1 5383.5 5422.3 8753.1 8892.6 8892.6 8927.3 9006.2 8447.0 8638.7 8873.4 9147.9 9173.0 5983.9 6469.3 6538.2 6628.2 6641.0 7438.3 7464.8 7471.6 7494.4 7503.5 6543.7 6605.2 6622.8 6635.4 6874.1 6464.6 6498.2 6517.0 6607.9 6662.4 6192.3 6402.2 6404.9 6407.4 6420.1 4470.6 4563.3 4632.2 4636.9 4692.3 4550.7 4640.5 4648.7 4684.1 4876.2 10:47:39 INFO - PROCESS | 20532 | 10:47:39 INFO - PROCESS | 20532 | [#4] prototype.html Cycles:180 Average:4063.99 Median:4443.77 stddev:1166.63 (26.3%) stddev-sans-first:1134.75 10:47:39 INFO - PROCESS | 20532 | Values: 276.7 284.5 287.5 289.7 293.1 4669.8 4802.1 4817.4 4867.7 4881.7 4565.7 4700.6 4763.0 4795.8 4827.8 3794.1 3807.3 3808.4 3824.0 3824.5 3561.4 3627.7 3807.7 3830.9 3831.1 3752.3 3754.5 3756.9 3758.2 3784.0 3752.6 3771.4 3776.6 3778.9 3793.8 3319.9 3323.6 3323.9 3325.2 3325.9 4576.3 4683.9 4687.7 4728.7 4764.5 4257.9 4268.0 4274.1 4292.6 4308.8 4982.5 4991.5 5016.8 5033.6 5056.9 3473.8 3632.3 3633.2 3644.5 3652.0 5228.3 5247.7 5251.3 5254.2 5256.6 3722.8 3723.4 3727.4 3732.3 3736.0 3658.3 3702.0 3731.8 3819.6 3823.0 4257.5 4275.3 4275.7 4277.3 4297.7 5012.7 5020.9 5024.7 5033.7 5085.4 1252.6 1264.7 1284.5 1286.3 1296.6 877.3 883.4 901.2 905.0 911.6 4398.4 4416.3 4416.6 4428.9 4450.2 5111.7 5112.2 5132.4 5148.9 5171.9 4431.6 4432.7 4451.6 4459.7 4464.8 2325.8 2410.3 2429.0 2432.6 2435.1 4361.4 4371.8 4392.8 4412.4 4437.3 4646.3 4679.1 4680.6 4686.9 4707.8 4051.6 4323.2 4339.8 4352.6 4361.6 4548.2 4558.9 4568.3 4592.4 4622.5 4472.3 4505.5 4507.4 4551.7 4558.6 4127.5 4329.6 4338.9 4343.4 4350.0 3360.2 3390.5 3402.2 3410.9 3423.6 4604.8 4607.7 4642.6 4661.2 5003.8 4874.8 5011.8 5037.3 5060.6 5065.6 4997.8 5025.9 5028.8 5035.5 5038.6 4740.9 4949.7 4977.8 4996.2 5018.5 5032.0 5043.7 5047.2 5047.7 5060.5 4946.2 4954.0 5000.5 5011.6 5029.4 10:47:39 INFO - PROCESS | 20532 | 10:47:39 INFO - PROCESS | 20532 | [#5] yui.html Cycles:180 Average:18008.27 Median:536.60 stddev:26111.62 (4866.1%) stddev-sans-first:26152.26 10:47:39 INFO - PROCESS | 20532 | Values: 629.2 688.7 693.6 699.9 707.1 12464.8 13407.7 13412.9 13423.5 13446.3 13663.4 13853.1 13860.9 13862.2 13870.7 628.7 747.6 767.6 769.0 785.6 780.6 790.6 790.9 791.9 792.3 838.1 840.7 841.1 842.8 843.1 661.4 799.7 805.5 837.4 837.7 608.2 608.9 609.0 609.5 609.6 12459.2 12488.1 12517.9 12520.2 12524.2 12465.3 13120.3 13510.6 13544.9 13831.9 11867.6 12050.3 12094.8 12178.3 12496.4 4105.8 4132.9 4152.4 4160.5 4337.5 65285.0 67553.0 69350.3 70017.3 70491.0 9800.1 10215.7 10410.3 10551.7 10603.6 17494.9 17673.6 17727.3 17734.6 17737.6 6586.6 6628.9 6668.7 6833.1 6997.2 3745.3 3775.2 3842.8 3885.3 3913.8 2753.4 2866.3 3123.5 3281.6 3310.7 536.4 536.8 544.1 547.9 549.8 492.6 542.0 552.0 563.9 587.6 7699.2 8057.8 8221.7 8549.9 8584.6 482.6 515.8 520.4 537.4 566.9 3709.6 3871.2 3987.7 4109.0 4170.6 73350.0 95273.0 97301.0 99208.0 100406.0 84771.6 87920.6 91453.0 91572.5 92654.0 76031.0 77384.0 77698.0 78310.6 78606.0 7225.8 7334.9 7369.4 7538.9 7617.8 45881.0 46600.8 47635.0 47832.8 48214.5 37887.6 67851.0 68123.7 68800.3 69196.0 10168.6 10198.5 10430.6 10691.7 11044.6 10716.8 10785.8 11222.3 11243.2 11302.2 10787.7 10998.9 11174.4 11259.2 11271.8 10635.7 10996.8 11048.8 11179.1 11324.2 10483.2 10780.7 10816.1 10990.3 11113.3 8923.9 9268.6 9399.9 9885.1 9944.8 8380.7 9214.8 9514.7 9558.7 9708.5 10:47:39 INFO - PROCESS | 20532 | -------- Summary: end -------- 10:47:39 INFO - PROCESS | 20532 | 10:47:40 INFO - TEST-INFO | 20532: exit 0 10:47:40 INFO - TEST-OK | dromaeo_css | took 1120155ms 10:47:40 INFO - TEST-START | kraken 10:47:40 INFO - operating with platform_type : linux_ 10:47:40 INFO - Initialising browser for kraken test... 10:47:40 INFO - TEST-INFO | started process 20721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6KjZCv/profile http://localhost:38776/getInfo.html) 10:47:44 INFO - PROCESS | 20721 | __metrics Screen width/height:1600/1200 10:47:44 INFO - PROCESS | 20721 | colorDepth:24 10:47:44 INFO - PROCESS | 20721 | Browser inner width/height: 1024/697 10:47:44 INFO - PROCESS | 20721 | __metrics 10:47:45 INFO - PROCESS | 20721 | 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" 10:47:45 INFO - PROCESS | 20721 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:46 INFO - TEST-INFO | 20721: exit 0 10:47:46 INFO - Browser initialized. 10:47:46 INFO - Running cycle 1/1 for kraken test... 10:47:46 INFO - TEST-INFO | started process 20801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6KjZCv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:58 INFO - PROCESS | 20801 | RSS: Main: 158158848 10:47:58 INFO - PROCESS | 20801 | 10:48:01 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38776/tests/kraken/driver.html?testName=audio-beat-detection) 10:48:02 INFO - PROCESS | 20801 | RSS: Main: 214372352 10:48:02 INFO - PROCESS | 20801 | 10:48:04 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38776/tests/kraken/driver.html?testName=audio-dft) 10:48:05 INFO - PROCESS | 20801 | RSS: Main: 192585728 10:48:05 INFO - PROCESS | 20801 | 10:48:08 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38776/tests/kraken/driver.html?testName=audio-fft) 10:48:09 INFO - PROCESS | 20801 | RSS: Main: 272277504 10:48:09 INFO - PROCESS | 20801 | 10:48:11 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38776/tests/kraken/driver.html?testName=audio-oscillator) 10:48:12 INFO - PROCESS | 20801 | RSS: Main: 180957184 10:48:12 INFO - PROCESS | 20801 | 10:48:14 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38776/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:48:14 INFO - PROCESS | 20801 | RSS: Main: 185049088 10:48:14 INFO - PROCESS | 20801 | 10:48:18 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38776/tests/kraken/driver.html?testName=imaging-darkroom) 10:48:18 INFO - PROCESS | 20801 | RSS: Main: 221954048 10:48:18 INFO - PROCESS | 20801 | 10:48:22 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38776/tests/kraken/driver.html?testName=imaging-desaturate) 10:48:22 INFO - PROCESS | 20801 | RSS: Main: 221138944 10:48:22 INFO - PROCESS | 20801 | 10:48:25 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38776/tests/kraken/driver.html?testName=json-parse-financial) 10:48:26 INFO - PROCESS | 20801 | RSS: Main: 220676096 10:48:26 INFO - PROCESS | 20801 | 10:48:28 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38776/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:48:28 INFO - PROCESS | 20801 | RSS: Main: 185446400 10:48:28 INFO - PROCESS | 20801 | 10:48:30 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38776/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:48:31 INFO - PROCESS | 20801 | RSS: Main: 191451136 10:48:31 INFO - PROCESS | 20801 | 10:48:33 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38776/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:48:34 INFO - PROCESS | 20801 | RSS: Main: 195723264 10:48:34 INFO - PROCESS | 20801 | 10:48:36 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:48:37 INFO - PROCESS | 20801 | RSS: Main: 191016960 10:48:37 INFO - PROCESS | 20801 | 10:48:40 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:48:40 INFO - PROCESS | 20801 | RSS: Main: 193974272 10:48:40 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:38776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38776/tests/kraken/driver.html?testName=ai-astar) 10:48:42 INFO - PROCESS | 20801 | RSS: Main: 245198848 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | __start_tp_report 10:48:42 INFO - PROCESS | 20801 | _x_x_mozilla_page_load 10:48:42 INFO - PROCESS | 20801 | _x_x_mozilla_page_load_details 10:48:42 INFO - PROCESS | 20801 | |i|pagename|runs| 10:48:42 INFO - PROCESS | 20801 | |0;ai-astar;105;113;114;115;114;114;114;113;114;116 10:48:42 INFO - PROCESS | 20801 | |1;audio-beat-detection;145;124;123;186;124;125;155;120;167;123 10:48:42 INFO - PROCESS | 20801 | |2;audio-dft;161;163;160;163;160;161;163;161;161;161 10:48:42 INFO - PROCESS | 20801 | |3;audio-fft;76;76;75;130;75;78;75;75;98;76 10:48:42 INFO - PROCESS | 20801 | |4;audio-oscillator;86;85;111;86;85;86;121;85;85;125 10:48:42 INFO - PROCESS | 20801 | |5;imaging-gaussian-blur;117;116;118;116;116;117;116;117;117;117 10:48:42 INFO - PROCESS | 20801 | |6;imaging-darkroom;146;146;147;146;146;145;146;145;146;146 10:48:42 INFO - PROCESS | 20801 | |7;imaging-desaturate;95;95;95;95;95;95;94;97;95;95 10:48:42 INFO - PROCESS | 20801 | |8;json-parse-financial;65;65;66;63;63;63;64;65;65;66 10:48:42 INFO - PROCESS | 20801 | |9;json-stringify-tinderbox;64;65;64;65;65;65;65;66;66;65 10:48:42 INFO - PROCESS | 20801 | |10;stanford-crypto-aes;79;79;79;89;88;89;90;79;79;82 10:48:42 INFO - PROCESS | 20801 | |11;stanford-crypto-ccm;132;133;149;127;131;128;131;129;165;141 10:48:42 INFO - PROCESS | 20801 | |12;stanford-crypto-pbkdf2;165;166;162;171;165;168;165;165;171;174 10:48:42 INFO - PROCESS | 20801 | |13;stanford-crypto-sha256-iterative;67;68;71;68;67;73;67;67;66;65 10:48:42 INFO - PROCESS | 20801 | __end_tp_report 10:48:42 INFO - PROCESS | 20801 | __start_cc_report 10:48:42 INFO - PROCESS | 20801 | _x_x_mozilla_cycle_collect,1971 10:48:42 INFO - PROCESS | 20801 | __end_cc_report 10:48:42 INFO - PROCESS | 20801 | __startTimestamp1470246522944__endTimestamp 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | ------- Summary: start ------- 10:48:42 INFO - PROCESS | 20801 | Number of tests: 14 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:3.01 (2.6%) stddev-sans-first:0.93 10:48:42 INFO - PROCESS | 20801 | Values: 105.0 113.0 114.0 115.0 114.0 114.0 114.0 113.0 114.0 116.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:135.00 stddev:23.10 (17.1%) stddev-sans-first:24.41 10:48:42 INFO - PROCESS | 20801 | Values: 145.0 124.0 123.0 186.0 124.0 125.0 155.0 120.0 167.0 123.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 10:48:42 INFO - PROCESS | 20801 | Values: 161.0 163.0 160.0 163.0 160.0 161.0 163.0 161.0 161.0 161.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:17.83 (23.5%) stddev-sans-first:18.71 10:48:42 INFO - PROCESS | 20801 | Values: 76.0 76.0 75.0 130.0 75.0 78.0 75.0 75.0 98.0 76.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.00 stddev:16.57 (19.5%) stddev-sans-first:17.22 10:48:42 INFO - PROCESS | 20801 | Values: 86.0 85.0 111.0 86.0 85.0 86.0 121.0 85.0 85.0 125.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:48:42 INFO - PROCESS | 20801 | Values: 117.0 116.0 118.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:48:42 INFO - PROCESS | 20801 | Values: 146.0 146.0 147.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 10:48:42 INFO - PROCESS | 20801 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 97.0 95.0 95.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 10:48:42 INFO - PROCESS | 20801 | Values: 65.0 65.0 66.0 63.0 63.0 63.0 64.0 65.0 65.0 66.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 10:48:42 INFO - PROCESS | 20801 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 65.0 66.0 66.0 65.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:85.00 stddev:5.01 (5.9%) stddev-sans-first:5.07 10:48:42 INFO - PROCESS | 20801 | Values: 79.0 79.0 79.0 89.0 88.0 89.0 90.0 79.0 79.0 82.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:132.50 stddev:12.02 (9.1%) stddev-sans-first:12.63 10:48:42 INFO - PROCESS | 20801 | Values: 132.0 133.0 149.0 127.0 131.0 128.0 131.0 129.0 165.0 141.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.00 stddev:3.71 (2.2%) stddev-sans-first:3.84 10:48:42 INFO - PROCESS | 20801 | Values: 165.0 166.0 162.0 171.0 165.0 168.0 165.0 165.0 171.0 174.0 10:48:42 INFO - PROCESS | 20801 | 10:48:42 INFO - PROCESS | 20801 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:2.38 (3.5%) stddev-sans-first:2.50 10:48:42 INFO - PROCESS | 20801 | Values: 67.0 68.0 71.0 68.0 67.0 73.0 67.0 67.0 66.0 65.0 10:48:42 INFO - PROCESS | 20801 | -------- Summary: end -------- 10:48:42 INFO - PROCESS | 20801 | 10:48:43 INFO - TEST-INFO | 20801: exit 0 10:48:44 INFO - TEST-OK | kraken | took 63851ms 10:48:44 INFO - SUITE-END | took 1184s 10:48:44 INFO - Completed test suite (00:19:44) 10:48:44 INFO - javascript benchmark 10:48:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2682.2489702883177, 2682.4500977299654, 2714.8642567871602, 2716.877740501676, 2726.1821453563925, 4700.929486057712, 4776.140294746944, 4809.639277054222, 4928.260760885869, 4948.925766113512, 4825.2279635258365, 4859.465458799529, 4874.8537543873745, 4932.186189278765, 4947.356843610334, 4410.140022695584, 4448.911021779562, 4479.977600112011, 4492.505824359318, 4577.977110114445, 4386.078923426085, 4542.068875880453, 4554.544545545452, 4556.54434556545, 4609.400777898868, 4343.305071188594, 4400.361947517592, 4474.418325617649, 4529.682922195448, 4546.863594092182, 4383.0, 4428.114377124588, 4430.468343798732, 4445.977770111129, 4518.638508919278, 4425.867223983286, 4442.64458843295, 4444.044530425974, 4476.1271552047365, 4480.395146655225, 4718.551737584959, 4865.221564549691, 4865.586425153866, 4900.779464924087, 4914.36113305268, 5163.457836927106, 5194.948050519484, 5207.4792520748, 5225.111731005738, 5249.47505249472, 5283.577313814885, 5286.5242128208265, 5292.894142117136, 5293.788248470057, 5298.894022119574, 4655.37152484417, 4924.60603151747, 4929.580985616263, 4930.235813448921, 4932.753362331869, 5338.119210330329, 5370.113931201387, 5379.408265090837, 5439.265699130567, 5444.0, 5162.74186290684, 5204.713740744295, 5208.192730126761, 5211.218317252366, 5215.843524694265, 5259.65812222212, 5260.868478287997, 5265.420803711589, 5310.7610157543, 5311.920321195185, 4966.925496117561, 5141.0, 5183.429822719498, 5190.974045129826, 5201.349831271091, 5184.507471790174, 5186.170212765939, 5195.532402083831, 5199.766010529535, 5236.764345604457, 4398.076403955141, 4400.383946247528, 4400.713953593006, 4404.361367601679, 4412.713173643703, 3750.8499660013294, 3780.281746468162, 3813.3707938189887, 3839.404892241651, 3860.189360234326, 4483.237849565582, 4500.617447516932, 4531.546845315508, 4542.88642783933, 4544.272916333371, 5264.499872512105, 5272.551833094153, 5275.920861187085, 5287.3126493556365, 5290.470952904679, 4333.631641310524, 4391.429114215131, 4426.159029784395, 4506.909861802746, 4538.341940418687, 4635.119327327797, 4641.466231383367, 4654.813807447664, 4669.95330046702, 4680.789364478606, 4910.656254062253, 4914.926276105933, 4917.237828136645, 4919.385076865392, 4959.70241785494, 5036.748162591929, 5199.48005199477, 5224.190250511177, 5236.423993360803, 5289.7619607117, 4912.901741965212, 4941.604671626334, 4945.50544945517, 4972.676776009548, 5003.3495645565845, 5169.9143179932635, 5174.870628234174, 5187.221916712523, 5189.662671926313, 5216.739163041757, 5003.899922001612, 5094.898102037864, 5213.973930130325, 5226.790928362975, 5232.084385232645, 5004.4495105537635, 5035.92446113316, 5044.772985215747, 5088.414832294334, 5093.388793344822, 4983.202687569971, 5013.548780609763, 5014.824481143142, 5025.597952163891, 5071.239314102914, 4771.95228047729, 4949.307097006494, 4957.6281778866005, 4965.1807451770055, 4995.525425084611, 5082.745862706924, 5149.613778966517, 5156.329677142097, 5177.119889618699, 5211.9478805212975, 5020.397552293748, 5027.346444962278, 5031.371078615173, 5038.244263360525, 5083.339165908408], "value": 4782.9055580416425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9971900140499, 562.3195932921163, 584.9616929949342, 584.9619774714644, 596.7165596341736, 38311.425328620055, 40330.19339613206, 40452.59547404525, 44154.55845441545, 44245.77877110618, 39497.0, 40187.39718904219, 40270.59729402705, 40364.0, 40364.38542458305, 7586.772396828104, 7777.0, 7789.688412463494, 7791.142974272825, 7795.0, 7755.883661745078, 7839.490433121829, 7840.333571646417, 7855.921440785604, 7858.960705196495, 7833.099193592753, 7878.212178782133, 7886.960565197166, 7887.8422431551335, 7888.645010974491, 7791.961040194791, 7833.960830195812, 7835.0989636191425, 7841.843163136762, 7843.490173138756, 7694.307512323918, 7821.608919554, 7833.255840695125, 7834.020747406575, 7844.843103137962, 38236.0, 38627.420588691195, 38668.226635467414, 38682.226355473016, 38698.613013869784, 3233.87064517419, 3243.448613735647, 3251.3822373748912, 3350.2461946062185, 3463.809490478023, 28927.56608650872, 29229.26926826825, 29505.557416638767, 29709.40581188386, 29864.70135298641, 3335.93328133436, 3363.323802252527, 3381.188514756441, 3398.6941175294096, 3440.397930362177, 233692.0, 234309.0, 234507.0, 235704.0, 235972.0, 51203.48796511987, 51219.74390128026, 51587.48412515827, 51659.0, 51836.740816296435, 32869.3426131476, 33427.0, 33623.0, 35737.46393804095, 35825.64174358223, 13373.93313033448, 13656.590302290948, 13664.863351366557, 13668.863311366758, 13671.974601904896, 9705.854412183822, 9813.705588832347, 9814.969428210077, 9823.607055717834, 9826.508674566243, 18208.635827283644, 18322.450326490227, 18400.631987360444, 18419.171137298585, 18446.538836529195, 6682.732690692415, 6747.527673062838, 6807.625580593016, 6821.2155602106395, 6863.759768408082, 820.4420993724325, 906.2704522859161, 919.5907821019582, 951.8952915179325, 963.7012526116927, 28113.297167570567, 28272.293192669935, 28538.28654283618, 28884.566731498624, 29118.272043198667, 931.5854444772011, 942.6512190489562, 945.2910317262053, 965.16513216069, 965.3001573859036, 14973.251337433085, 15501.612459688598, 16240.918795405947, 16989.0, 17171.914140429468, 382481.0, 473735.0, 482475.0, 482986.0, 733947.0, 50392.49607503951, 51020.74489627528, 51127.0, 51248.23127653088, 51435.7428212864, 1190.9020960857051, 1215.3254943506438, 1223.4494477485168, 1229.7479016801535, 1233.1552886272932, 27313.590296145972, 27840.582391263742, 28468.85765571159, 29079.0, 29325.0, 48575.0, 49029.26456103232, 49199.0, 49253.26120108273, 49294.75352623214, 376992.0, 379367.0, 380680.0, 381742.0, 381925.0, 39280.41079383869, 39609.0, 40206.79896600615, 40230.1953960925, 40544.79727601343, 41599.168016640106, 41853.0, 42867.785661071495, 43875.0, 44317.0, 33608.83195584006, 36741.816290918374, 37167.442488362154, 37673.246535068596, 37830.62169378271, 36211.27577448489, 36293.27413451769, 36554.0, 36727.08182295357, 37415.064623384635, 31334.216644584067, 32218.83890580532, 34206.82896585601, 36019.459708103874, 36629.26741465209, 31551.684483154873, 33453.33093338071, 33804.492932605535, 34007.82996085103, 34037.0, 25141.74858251394, 25744.61383079218, 25811.354716132246, 25973.610395844455, 26092.217233483025], "value": 17841.444891318934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5984818218139, 356.2767581808929, 364.99087522811936, 365.83537408166325, 390.11833256839554, 12994.28531430771, 16424.50726478206, 16742.24659890305, 17283.567910802238, 18312.542186445346, 15082.622934426618, 15308.004979676312, 15472.303746331414, 15541.222938853069, 15663.530094097167, 4393.450818647669, 4932.753362331896, 5133.024725302199, 5137.2037334213255, 5180.808414064767, 3656.3784156693428, 3822.1591249924973, 5025.472325405834, 5415.675059496423, 5656.519195868356, 5733.799317023905, 5741.511971482408, 5744.540436765049, 5746.310442746876, 5747.0, 5521.889562208753, 5938.792142275043, 5964.880702385972, 5970.194023806774, 6035.3059398169335, 5122.154844450662, 5272.551833094191, 5275.551578115865, 5277.973610131963, 5282.234076058989, 21073.894630526902, 21236.681449778265, 21266.25568105109, 21342.253021144184, 21358.893205534026, 1894.384325094336, 2010.507425680703, 2061.3506745375157, 2285.9428514287274, 2491.377155711072, 12917.483300667962, 13374.598762037154, 13400.463981440827, 13616.455341786317, 14030.579082627537, 1721.4405318271486, 1797.4607617714764, 1818.1272988965238, 1839.448165550343, 1866.673332166879, 65520.67239663771, 68872.31127688709, 69122.0, 69759.65120174366, 70301.64849175721, 8810.515421651742, 9082.818343633222, 9090.681826136053, 9095.772605684911, 10149.543270552844, 13014.804777928339, 13015.47938082485, 13025.609231723063, 13666.11170273929, 13687.863121368859, 6737.764178253836, 6958.338957799001, 6974.232834388214, 7003.614801185984, 7009.0537777399395, 6396.1045453636525, 6428.871422571616, 6437.420632143036, 6603.141591593062, 6630.270670226271, 5901.616394934315, 5948.196993405922, 5964.105384192319, 6027.186329845503, 6068.696565171812, 1546.6829299993474, 1724.094850203628, 1769.4691592522192, 1794.1477798045823, 1810.4568629411388, 743.7508434674445, 874.0647507167397, 885.0972008551241, 900.9189172974463, 995.0845222395413, 17230.396936107176, 18098.457046288633, 18299.359522416653, 18307.54231144232, 18612.44162675122, 868.3183700794846, 874.33113668044, 878.4114643189079, 885.3183049052323, 898.1108702384723, 10156.695299141038, 10497.26519143668, 10500.107490863362, 10531.15750739939, 10541.631042913461, 370935.0, 372480.0, 383546.0, 398758.0, 401230.0, 67170.0, 69465.65267173632, 69513.65243173752, 69839.65080174567, 71447.0, 892.830362231174, 907.3784457646533, 928.4522131942186, 930.8603709443638, 932.4358762948455, 11531.365774882463, 15187.0, 15717.764233536735, 17073.231704573573, 17103.504677557637, 40089.59910400975, 40361.59638403579, 40737.79631101825, 40918.0, 41594.0, 54559.33116507233, 54905.72547137239, 55189.0, 55407.722961384934, 56902.715486422305, 7529.736459223901, 7571.46999710015, 7574.583397913168, 7599.772006839804, 7709.190534993745, 11470.655880323604, 11504.942475287904, 11806.881931180578, 11924.642260732191, 12019.519219231133, 9356.111169438893, 9804.852927205955, 9877.753056173653, 9921.950390248003, 10201.438920859424, 10406.427646479517, 10625.468726563795, 10773.89226107729, 10859.131269498579, 11090.500927458444, 9914.454704991294, 10110.241731869992, 10179.694609161737, 10232.386056836614, 10517.263791534519, 7475.476716629783, 7603.543787372775, 7665.42509311815, 7676.193999629959, 7894.131645519104, 9250.768730781785, 9934.652287169914, 10043.849342259726, 10262.281640285108, 10262.743431414274], "value": 8351.0921512358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.292239496659, 1403.2702994442889, 1475.137044828775, 1668.0992264177344, 1676.2708221923465, 7307.0, 7912.723054693072, 7918.524888506694, 7919.722809701661, 7924.0, 6607.636579988099, 6762.763303284386, 6765.830854228647, 6987.30126987301, 7739.342155916754, 1873.054107675622, 2075.3358925143884, 2143.4641339665086, 2150.5268840854988, 2178.6949827024227, 2198.2855571939185, 2203.636399993999, 2206.5476577301615, 2207.9116835326568, 2208.6686996950425, 2103.842211834111, 2208.293346129239, 2209.933701988935, 2210.9447263818374, 2211.6240239159383, 2115.0482282972725, 2133.978660213409, 2137.1665050630268, 2137.4015275722822, 2144.9678254826267, 2094.979050209494, 2118.5233322502313, 2133.3066753305084, 2136.2950226425396, 2137.422895818136, 7748.496347737436, 7880.960595197044, 7881.4877032993245, 7887.369010479148, 7894.526328420313, 4222.387753775716, 4310.956890431087, 4343.1747967886, 4344.304911214223, 4345.1961387143165, 2790.8465034423098, 2872.1096460097438, 2921.269682579355, 2921.576371426131, 2928.341123247252, 881.7487016200353, 893.7988952485704, 894.9060348663427, 898.5507246376811, 908.42315129893, 10317.329373590692, 10420.739481512872, 10438.425886576235, 10446.164306855433, 10462.058414742709, 3807.600201978808, 4018.3570628699854, 4068.613481719232, 4194.140201258735, 4194.475690538683, 8934.776630584158, 8967.551622418852, 8968.013518512958, 8971.596278167499, 8975.192232698957, 4260.318349064197, 4279.828806847691, 4280.208161490134, 4283.485981682218, 4287.7641729705165, 3806.1626442182674, 3817.751846129993, 3836.961630383716, 3849.8845034649007, 3851.287511810324, 3564.3584154851856, 3656.4149736042104, 3674.0998455378603, 3685.1339935115225, 3690.9815450922574, 1157.8190245949086, 1168.696139003865, 1180.167981572989, 1184.9822252666218, 1213.3811756004502, 698.1761521404791, 702.543346824558, 757.0158793568339, 820.5158956215741, 834.9123342049119, 5141.0, 5189.662671926313, 5203.505666961632, 5250.842474725764, 5314.12316967696, 786.7364432914923, 841.4824882697097, 853.470848074198, 854.6410507586828, 900.1763386501278, 3597.6042635310096, 3613.2954073955325, 3626.818659067089, 3631.1829838286176, 3666.211764470652, 9172.12864777845, 9675.467849268358, 9693.70918872435, 9717.222622190207, 9721.319507634398, 9359.812803743887, 9636.46999415039, 9637.277204209713, 9714.854277185848, 9737.951310243403, 7268.927310726931, 7334.89289208753, 7412.18465968743, 7415.85168296631, 7420.072490938633, 5319.38827034896, 5341.145416733304, 5365.114756065205, 5383.488568585978, 5422.29510163692, 8753.080926502626, 8892.599833007402, 8892.64429422816, 8927.33045021613, 9006.189442950166, 8446.957765211135, 8638.697645582375, 8873.378863479495, 9147.86278205814, 9172.954135229282, 5983.910241346296, 6469.320721324193, 6538.1827271591055, 6628.171478565179, 6640.966795166187, 7438.330550250504, 7464.813379665552, 7471.589062601392, 7494.400447964041, 7503.474756767192, 6543.738250469928, 6605.174353205849, 6622.834429139118, 6635.4359879410795, 6874.140732408449, 6464.644444555594, 6498.155239818793, 6517.0, 6607.900881486686, 6662.367075127855, 6192.349803270772, 6402.231732192166, 6404.9039264412, 6407.359264073555, 6420.101185834081, 4470.552944705503, 4563.338315944103, 4632.166210082218, 4636.884077898079, 4692.296155576691, 4550.704204226715, 4640.512746161605, 4648.7443190624845, 4684.1334353144775, 4876.195427754381], "value": 4072.177780852602, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.67628874217166, 284.54756936471006, 287.5499842746103, 289.7392346887801, 293.1177156758158, 4669.789859456324, 4802.063597598461, 4817.421909370876, 4867.707937523746, 4881.682690625107, 4565.7444202844235, 4700.6004489618335, 4762.952370476303, 4795.808167673289, 4827.7586120694, 3794.1083845296334, 3807.333716599591, 3808.447775072613, 3823.9808800955957, 3824.4836947012213, 3561.394562924309, 3627.727920405967, 3807.676347510465, 3830.923381532368, 3831.1188426661884, 3752.305823422662, 3754.4556039374274, 3756.948054544718, 3758.191988722424, 3784.0, 3752.587215406303, 3771.4348545353646, 3776.6404094525947, 3778.8866334009886, 3793.791341476204, 3319.850606722703, 3323.6344002159744, 3323.933521329584, 3325.1687078230443, 3325.933481330384, 4576.267797152473, 4683.859484215479, 4687.742174180418, 4728.66899317048, 4764.4520880098535, 4257.87226383209, 4267.957320426818, 4274.145170965789, 4292.613664770154, 4308.80610372534, 4982.451930287665, 4991.527499387653, 5016.774245158977, 5033.597312215014, 5056.949430505685, 3473.7915725056323, 3632.273545290926, 3633.2370202257557, 3644.5444319460066, 3651.963480365189, 5228.294180285651, 5247.737613119367, 5251.343582052244, 5254.238135470336, 5256.6332753483985, 3722.758020728644, 3723.404255319136, 3727.4036154215196, 3732.2908647356917, 3735.9626403735615, 3658.2683463307444, 3701.981490092532, 3731.8134093295225, 3819.598942111094, 3823.044238940265, 4257.531671516131, 4275.294576394922, 4275.722078064916, 4277.272863613193, 4297.67767417445, 5012.67417617861, 5020.899582008339, 5024.673396229234, 5033.748312584429, 5085.440601533828, 1252.6242127361754, 1264.6585421936027, 1284.5183056353867, 1286.3246795432474, 1296.5786119511008, 877.3244601656688, 883.3507372081515, 901.193431878465, 904.9819003620022, 911.6444586611227, 4398.3842262083335, 4416.343871048357, 4416.558344165558, 4428.867133985986, 4450.1989641864775, 5111.693298402108, 5112.156494178494, 5132.384113906281, 5148.871278218, 5171.870703232449, 4431.62331201845, 4432.667549933768, 4451.621612163002, 4459.710118842265, 4464.754438505914, 2325.8023068039406, 2410.349205714447, 2428.9757102429103, 2432.586460301753, 2435.076289731128, 4361.389405483234, 4371.759553224603, 4392.802323895432, 4412.433586076961, 4437.334399839985, 4646.279826626878, 4679.134360143385, 4680.602148817388, 4686.859394218179, 4707.835225767081, 4051.5745846685672, 4323.221820072355, 4339.82640694375, 4352.608265256142, 4361.5856493633055, 4548.226801443696, 4558.925688811649, 4568.314752787109, 4592.380028696217, 4622.537746225351, 4472.306792447176, 4505.549445055468, 4507.414036175276, 4551.726896386227, 4558.612517936012, 4127.463429754112, 4329.567043295645, 4338.891527711706, 4343.391925130421, 4350.0, 3360.243945112428, 3390.525326454249, 3402.1834759658, 3410.9147271318416, 3423.606285277225, 4604.8388306409115, 4607.7004994675235, 4642.605378542727, 4661.184292748823, 5003.774830132726, 4874.805007799649, 5011.817495890064, 5037.269595908646, 5060.569851562658, 5065.5816371414585, 4997.800087996439, 5025.874353141201, 5028.798848046184, 5035.482258870565, 5038.647294689483, 4740.928886066643, 4949.653524253267, 4977.800887964586, 4996.200607902718, 5018.498150185098, 5031.974840125922, 5043.672161309503, 5047.217681259411, 5047.697138171721, 5060.544550990428, 4946.233333833262, 4954.0, 5000.474950130184, 5011.624128190328, 5029.421616514148], "value": 3695.852024030948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.1694962649302, 688.696973331734, 693.6046453521495, 699.8775214337492, 707.1019804847843, 12464.81302780458, 13407.731845363087, 13412.932935335322, 13423.530176443826, 13446.260455674934, 13663.385147668354, 13853.099548529364, 13860.861391386083, 13862.237576933265, 13870.653233669163, 628.7013668507468, 747.55146911853, 767.6238643064886, 768.9884651730229, 785.6464590934074, 780.5940910726418, 790.5651891459703, 790.8853216283635, 791.9247671471201, 792.2869417524216, 838.0948575538404, 840.6889450903175, 841.1168273313027, 842.7640260726976, 843.0515669871395, 661.3948237362807, 799.7400844725488, 805.524740403165, 837.3970741066422, 837.694241601814, 608.2305883057935, 608.9451949324538, 608.9939100608982, 609.5245708347496, 609.576344440614, 12459.19015264014, 12488.12583119182, 12517.93741031289, 12520.186187897849, 12524.248545087325, 12465.252084874937, 13120.343982800821, 13510.594682159453, 13544.93227533856, 13831.861681383258, 11867.58463453775, 12050.276983381025, 12094.818577721342, 12178.330191839445, 12496.437660305217, 4105.774182419966, 4132.896677583054, 4152.418661387408, 4160.5007399112, 4337.522872484024, 65285.0, 67553.0, 69350.30649693489, 70017.29982700158, 70491.0, 9800.11798938099, 10215.7446063849, 10410.323328983592, 10551.736206594896, 10603.575856965635, 17494.912525437547, 17673.558161046076, 17727.29090836378, 17734.556636084202, 17737.645247094984, 6586.571872828346, 6628.933710662832, 6668.733250670016, 6833.111695479556, 6997.230304666483, 3745.3258413485833, 3775.188334508039, 3842.7502212356108, 3885.261800257942, 3913.8238779255003, 2753.3942532642786, 2866.2834291427143, 3123.5002399616405, 3281.5898012748407, 3310.708823558814, 536.3992328592002, 536.7987004873172, 544.0560627311611, 547.9315085614298, 549.8185598752402, 492.6009931955128, 542.0135353656308, 551.9843487982132, 563.9492445679908, 587.6444750925629, 7699.153093159748, 8057.798555036171, 8221.671133154727, 8549.871751923725, 8584.570771461402, 482.5729229631731, 515.7550163672225, 520.3599572525738, 537.3981141121968, 566.9489745922805, 3709.573399059089, 3871.1870507193244, 3987.6610488108836, 4109.0, 4170.562090980464, 73350.0, 95273.0, 97301.0, 99208.0, 100406.0, 84771.5761421189, 87920.56039719889, 91453.0, 91572.54213729022, 92654.0, 76031.0, 77384.0, 77697.99999999886, 78310.6084469574, 78606.0, 7225.819354516179, 7334.926650733424, 7369.373603243785, 7538.886916696144, 7617.809554760954, 45881.0, 46600.7669961648, 47635.0, 47832.76083619559, 48214.517854821, 37887.62112378951, 67851.0, 68123.65938170278, 68800.31199687939, 69196.0, 10168.593256269667, 10198.541065651914, 10430.582776688847, 10691.732706682084, 11044.558217671203, 10716.767571729351, 10785.784284314426, 11222.326660400402, 11243.212975091665, 11302.152338574804, 10787.730306742395, 10998.890011099787, 11174.385408802595, 11259.155563332946, 11271.79753510599, 10635.734106647396, 10996.835047474455, 11048.834267485834, 11179.10567154642, 11324.150688698215, 10483.21375896826, 10780.730481738019, 10816.08063314627, 10990.285631433931, 11113.277636953571, 8923.910760892308, 9268.629254829732, 9399.906000939904, 9885.060919212663, 9944.751381215527, 8380.748577542683, 9214.815703685754, 9514.666986655433, 9558.665446709332, 9708.515832020039], "value": 6550.6204479671405, "unit": "score"}], "name": "dromaeo_css", "value": 6423.772198731094, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 116.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 123.0, 186.0, 124.0, 125.0, 155.0, 120.0, 167.0, 123.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 163.0, 160.0, 161.0, 163.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 130.0, 75.0, 78.0, 75.0, 75.0, 98.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 111.0, 86.0, 85.0, 86.0, 121.0, 85.0, 85.0, 125.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 97.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 63.0, 63.0, 63.0, 64.0, 65.0, 65.0, 66.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 89.0, 88.0, 89.0, 90.0, 79.0, 79.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 149.0, 127.0, 131.0, 128.0, 131.0, 129.0, 165.0, 141.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 162.0, 171.0, 165.0, 168.0, 165.0, 165.0, 171.0, 174.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 68.0, 67.0, 73.0, 67.0, 67.0, 66.0, 65.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1534.9, "alertThreshold": 2.0}]} 10:48:44 INFO - Return code: 0 10:48:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:48:44 INFO - # TBPL SUCCESS # 10:48:44 INFO - Running post-action listener: _resource_record_post_action 10:48:44 INFO - [mozharness: 2016-08-03 17:48:44.234364Z] Finished run-tests step (success) 10:48:44 INFO - Running post-run listener: _resource_record_post_run 10:48:44 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 16384; Write bytes: 532557824; Read time: 116; Write time: 350580 10:48:44 INFO - TinderboxPrint: CPU usage
13.0% 10:48:44 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 116 10:48:44 INFO - TinderboxPrint: I/O write bytes / time
532,557,824 / 350,580 10:48:44 INFO - TinderboxPrint: CPU idle
8,327.6 (86.9%) 10:48:44 INFO - TinderboxPrint: CPU user
1,205.5 (12.6%) 10:48:44 INFO - TinderboxPrint: Swap in / out
0 / 0 10:48:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248791040; Read time: 0; Write time: 193412 10:48:44 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 283766784; Read time: 100; Write time: 157168 10:48:44 INFO - Running post-run listener: _upload_blobber_files 10:48:44 INFO - Blob upload gear active. 10:48:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:48:44 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 10:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:48:45 INFO - (blobuploader) - INFO - Open directory for files ... 10:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:46 INFO - (blobuploader) - INFO - Done attempting. 10:48:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:48:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:48:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:51 INFO - (blobuploader) - INFO - Done attempting. 10:48:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:48:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:52 INFO - (blobuploader) - INFO - Done attempting. 10:48:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:48:52 INFO - Return code: 0 10:48:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:48:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:48:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c18493a38141ec3798dcc212a9fed1e0e56721c73af16e47071516989406d1092fd2fe46c6c7ad2697fbdf99bbe049a19b40e5b5fb76bab6741022a3a567592f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c779c7b92bc8af1dd771d50b8c75b464d42d494d9e097344999ed98a7e977e3e4632985f185e3b8f304cc4b0e0d4cef55d173f550654644c1457bbeaffa669", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c09073f11c9b86bdc9cdc81f16f4a342fefb7e0bac305bb887bbbfa35fc89c255c51fceecabf5dbcb53acd42a309c984867b629a6c87c2972965c4f1e7728944"} 10:48:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:48:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:48:52 INFO - Contents: 10:48:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c18493a38141ec3798dcc212a9fed1e0e56721c73af16e47071516989406d1092fd2fe46c6c7ad2697fbdf99bbe049a19b40e5b5fb76bab6741022a3a567592f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c779c7b92bc8af1dd771d50b8c75b464d42d494d9e097344999ed98a7e977e3e4632985f185e3b8f304cc4b0e0d4cef55d173f550654644c1457bbeaffa669", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c09073f11c9b86bdc9cdc81f16f4a342fefb7e0bac305bb887bbbfa35fc89c255c51fceecabf5dbcb53acd42a309c984867b629a6c87c2972965c4f1e7728944"} 10:48:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:48:52 INFO - Copying logs to upload dir... 10:48:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:48:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.385168 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-03 10:48:51.637993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 10:48:51.641411) ========= 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=4300f881736b422476174874000001bc-1470245290.856798-1186217821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c18493a38141ec3798dcc212a9fed1e0e56721c73af16e47071516989406d1092fd2fe46c6c7ad2697fbdf99bbe049a19b40e5b5fb76bab6741022a3a567592f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c779c7b92bc8af1dd771d50b8c75b464d42d494d9e097344999ed98a7e977e3e4632985f185e3b8f304cc4b0e0d4cef55d173f550654644c1457bbeaffa669", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c09073f11c9b86bdc9cdc81f16f4a342fefb7e0bac305bb887bbbfa35fc89c255c51fceecabf5dbcb53acd42a309c984867b629a6c87c2972965c4f1e7728944"} build_url:https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/X_XIsl5SQgyDq0MWA8RtSw/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-Non-PGO/sha512/c18493a38141ec3798dcc212a9fed1e0e56721c73af16e47071516989406d1092fd2fe46c6c7ad2697fbdf99bbe049a19b40e5b5fb76bab6741022a3a567592f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c779c7b92bc8af1dd771d50b8c75b464d42d494d9e097344999ed98a7e977e3e4632985f185e3b8f304cc4b0e0d4cef55d173f550654644c1457bbeaffa669", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c09073f11c9b86bdc9cdc81f16f4a342fefb7e0bac305bb887bbbfa35fc89c255c51fceecabf5dbcb53acd42a309c984867b629a6c87c2972965c4f1e7728944"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 10:48:51.667308) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:48:51.667643) ========= 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=4300f881736b422476174874000001bc-1470245290.856798-1186217821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:48:51.750253) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 10:48:51.750755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 10:48:51.751278) ========= ========= Total master_lag: 0.17 =========